[cups.general] Print Job fails with weird debug info...

Daniel Costello danielc at clinedavis.com
Thu May 20 19:28:52 PDT 2004


Hello all,

I have run into a problem trying to print a MS Word file on a HP 9000 
that everything else prints to fine, including other multi page Word 
docs.  This word file has grids inside it to make tables.  I'm assuming 
this is the reason why it is not printing.  Below is an excerpt of the 
debug2 information:

d [20/May/2004:22:16:44 -0400] AcceptClient(0x10048920) 0 NumClients = 0
D [20/May/2004:22:16:44 -0400] AcceptClient() 3 from localhost:631.
d [20/May/2004:22:16:44 -0400] AcceptClient: Adding fd 3 to InputSet...
d [20/May/2004:22:16:44 -0400] ReadClient() 3, used=0
D [20/May/2004:22:16:44 -0400] ReadClient() 3 POST / HTTP/1.1
d [20/May/2004:22:16:44 -0400] decode_auth(0x301e5008): Authorization 
string = ""
d [20/May/2004:22:16:44 -0400] decode_auth() 3 username=""
d [20/May/2004:22:16:44 -0400] IsAuthorized: con->uri = "/"
d [20/May/2004:22:16:44 -0400] FindBest: uri = "/"...
d [20/May/2004:22:16:44 -0400] FindBest: Location / Limit 7f
d [20/May/2004:22:16:44 -0400] FindBest: Location /printer/name Limit 7f
d [20/May/2004:22:16:44 -0400] FindBest: best = "/"
d [20/May/2004:22:16:44 -0400] IsAuthorized: auth = 0, satisfy=0...
d [20/May/2004:22:16:44 -0400] POST /
d [20/May/2004:22:16:44 -0400] CONTENT_TYPE = application/ipp
d [20/May/2004:22:16:44 -0400] ReadClient() 3 con->data_encoding = 
length, con->data_remaining = 283, con->file = 0
d [20/May/2004:22:16:44 -0400] ProcessIPPRequest(0x301e5008[3]): 
operation_id = 000a
d [20/May/2004:22:16:44 -0400] get_jobs(0x301e5008[3], 
ipp://localhost/printers/8East_Hypnos_HP9000)
d [20/May/2004:22:16:44 -0400] get_jobs: job->id = 26972
d [20/May/2004:22:16:44 -0400] get_jobs: job->id = 26973

....  About 80 more lines of "get_jobs: Job->id=26xxx"

d [20/May/2004:22:16:44 -0400] get_jobs: job->id = 27469
d [20/May/2004:22:16:44 -0400] get_jobs: job->id = 27470
D [20/May/2004:22:16:44 -0400] ProcessIPPRequest: 3 status_code=0
d [20/May/2004:22:16:44 -0400] WriteClient: Removing fd 3 from 
OutputSet...
d [20/May/2004:22:16:44 -0400] ReadClient() 3, used=0
D [20/May/2004:22:16:44 -0400] ReadClient() 3 POST / HTTP/1.1
d [20/May/2004:22:16:44 -0400] decode_auth(0x301e5008): Authorization 
string = ""
d [20/May/2004:22:16:44 -0400] decode_auth() 3 username=""
d [20/May/2004:22:16:44 -0400] IsAuthorized: con->uri = "/"
d [20/May/2004:22:16:44 -0400] FindBest: uri = "/"...
d [20/May/2004:22:16:44 -0400] FindBest: Location / Limit 7f
d [20/May/2004:22:16:44 -0400] FindBest: Location /printer/name Limit 7f
d [20/May/2004:22:16:44 -0400] FindBest: best = "/"
d [20/May/2004:22:16:44 -0400] IsAuthorized: auth = 0, satisfy=0...
d [20/May/2004:22:16:44 -0400] POST /
d [20/May/2004:22:16:44 -0400] CONTENT_TYPE = application/ipp
d [20/May/2004:22:16:44 -0400] ReadClient() 3 con->data_encoding = 
length, con->data_remaining = 204, con->file = 0
d [20/May/2004:22:16:44 -0400] ProcessIPPRequest(0x301e5008[3]): 
operation_id = 000b
d [20/May/2004:22:16:44 -0400] get_printer_attrs(0x301e5008[3], 
ipp://localhost/printers/8East_Hypnos_HP9000)
d [20/May/2004:22:16:44 -0400] add_printer_state_reasons(0x301e5008[3], 
0x100769a0[8East_Hypnos_HP9000])
d [20/May/2004:22:16:44 -0400] add_queued_job_count(0x301e5008[3], 
0x100769a0[8East_Hypnos_HP9000])
d [20/May/2004:22:16:44 -0400] copy_attrs(0x100bc528, 0x1006efd8, 
(nil), 0)
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x1006f000[printer-uri-supported,4,45])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x1006f0c0[uri-authentication-supported,4,44])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x1006a448[uri-security-supported,4,44])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x1006a4a0[printer-name,4,42])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x10079258[printer-location,4,41])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x10079298[printer-info,4,41])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x100792f0[printer-more-info,4,45])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x10079368[pdl-override-supported,4,44])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x100688e8[ipp-versions-supported,4,44])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x1006a660[operations-supported,4,23])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x1006a7e0[multiple-document-jobs-supported,4,22])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x10068958[multiple-operation-time-out,4,21])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x100689a0[multiple-document-handling-supported,4,44])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x1006f170[charset-configured,4,47])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x1006f1c0[charset-supported,4,47])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x100749c8[natural-language-configured,4,48])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x10074a28[generated-natural-language-supported,4,48])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x10074a98[document-format-default,4,49])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x10074b00[document-format-supported,4,80000049])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x10074cb0[compression-supported,4,44])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x10074d08[job-priority-supported,4,21])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x10074d50[job-priority-default,4,21])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x10074d98[copies-supported,4,33])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x10074dd8[copies-default,4,21])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x10074e18[page-ranges-supported,4,22])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x10074e60[number-up-supported,4,21])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x10074ed8[number-up-default,4,21])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x10074f18[orientation-requested-supported,4,23])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x10074f88[orientation-requested-default,4,23])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x10074fd8[job-quota-period,4,21])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x10075018[job-k-limit,4,21])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x10075050[job-page-limit,4,21])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x10075090[job-sheets-supported,4,42])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x10078110[job-sheets-default,4,42])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x10078178[device-uri,4,45])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x1006be10[color-supported,4,22])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x1006bfe8[pages-per-minute,4,21])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x1006ba70[printer-make-and-model,4,41])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x1006bb18[media-supported,4,44])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x100782d8[media-default,4,44])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x10063198[output-bin-supported,4,44])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x10063268[sides-supported,4,44])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x10078328[sides-default,4,44])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x10078660[finishings-supported,4,23])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x10062bd8[finishings-default,4,23])
d [20/May/2004:22:16:44 -0400] copy_attribute(0x100bc528, 
0x10062d08[printer-type,4,23])
D [20/May/2004:22:16:44 -0400] ProcessIPPRequest: 3 status_code=0
d [20/May/2004:22:16:44 -0400] WriteClient: Removing fd 3 from 
OutputSet...
d [20/May/2004:22:16:44 -0400] ReadClient() 3, used=0
D [20/May/2004:22:16:44 -0400] CloseClient() 3
d [20/May/2004:22:16:44 -0400] CloseClient: Removing fd 3 from InputSet 
and OutputSet...
d [20/May/2004:22:16:47 -0400] AcceptClient(0x10048920) 0 NumClients = 0
D [20/May/2004:22:16:47 -0400] AcceptClient() 3 from localhost:631.
d [20/May/2004:22:16:47 -0400] AcceptClient: Adding fd 3 to InputSet...
d [20/May/2004:22:16:47 -0400] ReadClient() 3, used=0
D [20/May/2004:22:16:47 -0400] ReadClient() 3 POST / HTTP/1.1
d [20/May/2004:22:16:47 -0400] decode_auth(0x301e5008): Authorization 
string = ""
d [20/May/2004:22:16:47 -0400] decode_auth() 3 username=""
d [20/May/2004:22:16:47 -0400] IsAuthorized: con->uri = "/"
d [20/May/2004:22:16:47 -0400] FindBest: uri = "/"...
d [20/May/2004:22:16:47 -0400] FindBest: Location / Limit 7f
d [20/May/2004:22:16:47 -0400] FindBest: Location /printer/name Limit 7f
d [20/May/2004:22:16:47 -0400] FindBest: best = "/"
d [20/May/2004:22:16:47 -0400] IsAuthorized: auth = 0, satisfy=0...
d [20/May/2004:22:16:47 -0400] POST /
d [20/May/2004:22:16:47 -0400] CONTENT_TYPE = application/ipp
d [20/May/2004:22:16:47 -0400] ReadClient() 3 con->data_encoding = 
length, con->data_remaining = 176, con->file = 0
d [20/May/2004:22:16:47 -0400] ProcessIPPRequest(0x301e5008[3]): 
operation_id = 000b
d [20/May/2004:22:16:47 -0400] get_printer_attrs(0x301e5008[3], 
ipp://localhost/printers/8East_Hypnos_HP9000)
d [20/May/2004:22:16:47 -0400] add_printer_state_reasons(0x301e5008[3], 
0x100769a0[8East_Hypnos_HP9000])
d [20/May/2004:22:16:47 -0400] add_queued_job_count(0x301e5008[3], 
0x100769a0[8East_Hypnos_HP9000])
d [20/May/2004:22:16:47 -0400] copy_attrs(0x102e4900, 0x1006efd8, 
(nil), 0)
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x1006f000[printer-uri-supported,4,45])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x1006f0c0[uri-authentication-supported,4,44])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x1006a448[uri-security-supported,4,44])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x1006a4a0[printer-name,4,42])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x10079258[printer-location,4,41])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x10079298[printer-info,4,41])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x100792f0[printer-more-info,4,45])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x10079368[pdl-override-supported,4,44])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x100688e8[ipp-versions-supported,4,44])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x1006a660[operations-supported,4,23])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x1006a7e0[multiple-document-jobs-supported,4,22])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x10068958[multiple-operation-time-out,4,21])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x100689a0[multiple-document-handling-supported,4,44])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x1006f170[charset-configured,4,47])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x1006f1c0[charset-supported,4,47])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x100749c8[natural-language-configured,4,48])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x10074a28[generated-natural-language-supported,4,48])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x10074a98[document-format-default,4,49])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x10074b00[document-format-supported,4,80000049])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x10074cb0[compression-supported,4,44])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x10074d08[job-priority-supported,4,21])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x10074d50[job-priority-default,4,21])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x10074d98[copies-supported,4,33])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x10074dd8[copies-default,4,21])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x10074e18[page-ranges-supported,4,22])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x10074e60[number-up-supported,4,21])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x10074ed8[number-up-default,4,21])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x10074f18[orientation-requested-supported,4,23])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x10074f88[orientation-requested-default,4,23])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x10074fd8[job-quota-period,4,21])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x10075018[job-k-limit,4,21])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x10075050[job-page-limit,4,21])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x10075090[job-sheets-supported,4,42])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x10078110[job-sheets-default,4,42])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x10078178[device-uri,4,45])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x1006be10[color-supported,4,22])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x1006bfe8[pages-per-minute,4,21])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x1006ba70[printer-make-and-model,4,41])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x1006bb18[media-supported,4,44])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x100782d8[media-default,4,44])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x10063198[output-bin-supported,4,44])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x10063268[sides-supported,4,44])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x10078328[sides-default,4,44])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x10078660[finishings-supported,4,23])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x10062bd8[finishings-default,4,23])
d [20/May/2004:22:16:47 -0400] copy_attribute(0x102e4900, 
0x10062d08[printer-type,4,23])
D [20/May/2004:22:16:47 -0400] ProcessIPPRequest: 3 status_code=0
d [20/May/2004:22:16:47 -0400] WriteClient: Removing fd 3 from 
OutputSet...
d [20/May/2004:22:16:47 -0400] ReadClient() 3, used=0
D [20/May/2004:22:16:47 -0400] CloseClient() 3
d [20/May/2004:22:16:47 -0400] CloseClient: Removing fd 3 from InputSet 
and OutputSet...
d [20/May/2004:22:16:47 -0400] AcceptClient(0x10048920) 0 NumClients = 0
D [20/May/2004:22:16:47 -0400] AcceptClient() 3 from localhost:631.
d [20/May/2004:22:16:47 -0400] AcceptClient: Adding fd 3 to InputSet...
d [20/May/2004:22:16:47 -0400] ReadClient() 3, used=0
D [20/May/2004:22:16:47 -0400] ReadClient() 3 POST / HTTP/1.1
d [20/May/2004:22:16:47 -0400] decode_auth(0x301e5008): Authorization 
string = ""
d [20/May/2004:22:16:47 -0400] decode_auth() 3 username=""
d [20/May/2004:22:16:47 -0400] IsAuthorized: con->uri = "/"
d [20/May/2004:22:16:47 -0400] FindBest: uri = "/"...
d [20/May/2004:22:16:47 -0400] FindBest: Location / Limit 7f
d [20/May/2004:22:16:47 -0400] FindBest: Location /printer/name Limit 7f
d [20/May/2004:22:16:47 -0400] FindBest: best = "/"
d [20/May/2004:22:16:47 -0400] IsAuthorized: auth = 0, satisfy=0...
d [20/May/2004:22:16:47 -0400] POST /
d [20/May/2004:22:16:47 -0400] CONTENT_TYPE = application/ipp
d [20/May/2004:22:16:47 -0400] ReadClient() 3 con->data_encoding = 
length, con->data_remaining = 283, con->file = 0
d [20/May/2004:22:16:47 -0400] ProcessIPPRequest(0x301e5008[3]): 
operation_id = 000a
d [20/May/2004:22:16:47 -0400] get_jobs(0x301e5008[3], 
ipp://localhost/printers/8West_Plutus_HP5000)
d [20/May/2004:22:16:47 -0400] get_jobs: job->id = 26972
d [20/May/2004:22:16:47 -0400] get_jobs: job->id = 26973

....  About 80 more lines of "get_jobs: Job->id=26xxx"

It repeats this pattern about 5 times getting the jobs of other printer 
queues on the server, such as Plutus.  Hypnos, the first queue 
mentioned is the trouble queue I'm writing about.

Can anyone make any sense out of this at all?  I certainly cant.
Any help would be appreciated.

Here is the rest of the pertanant info:
cups-1.1.17-13.3
cups-libs-1.1.17-13.3
samba-common-2.2.8-1.3.0a
samba-client-2.2.8-1.3.0a
samba-2.2.8-1.3.0a
foomatic-2.0.2-15.1
ghostscript-7.05-32.1
ghostscript-fonts-5.50-7

This server is setup to provide and download drivers to Windows client 
machines setup through smb.  This is all working correctly.

Regards,
Daniel

(PS- Sorry about long post, but I wanted to include everything I could.)


-- 
Cline, Davis & Mann
220 East 42nd Street
NYC, NY 10017
(212) 907-4300
(212) 450-2961 direct
___
Privileged/Confidential Information may be contained in this
message.  If you are not the addressee indicated in this message
(or responsible for delivery of the message to such person), you
may not copy or deliver this message to anyone.  In such case,
you should destroy this message and kindly notify the sender
by reply e-mail.  Please advise immediately if you or your
employer do not consent to Internet e-mail of this kind.  
Opinions, conclusions, and other information in this message
that do not relate to the official business of CDM shall
be understood as neither given nor endorsed by it.
  
  




More information about the cups mailing list