[cups.general] Jobs going to Stopped - Cups Restart the Only Resort

[Michael Sweet]

LPD is not a reliable protocol. If the printer in question supports IPP or socket printing, use that instead.

On Nov 3, 2010, at 8:01 PM, Anurag wrote:

> Dear Cups Team,
> 
> We are facing a problem whereby the label printer stops printing when multiple print requests are received in a short span of time.
> 
> In my tests, i sent around 80 Labels to print to the printer within a span of 20 seconds. This volume is pretty low for the Warehouse Operations and it is important that the printing works without any problems in such a scenario. Any help in this regard would be highly appreciated.
> 
> In my tests, the job number 7357 was the one that got stuck. All other jobs following the job 7357 went to pending status.
> 
> After waiting on job 7357, the printer finally decided to Stop the job and the job went to Stopped status. At this stage, the printer status is shown as "/usr/lib/cups/backend/lpd Failed". The only way to print the remaining labels is to restart the printer again.
> 
> I have uploaded the complete error_log at http://pastebin.com/2i7V7SZ7
> 
> Here are some of the lines from the error_log that are relevant to job 7357, It seems to have failed exactly after 5 minutes of job submission.
> 
> I [03/Nov/2010:23:06:58 -0300] [Job 7357] Adding start banner page "none".
> D [03/Nov/2010:23:06:58 -0300] Discarding unused job-created event...
> I [03/Nov/2010:23:06:58 -0300] [Job 7357] Adding job file of type text/plain.
> I [03/Nov/2010:23:06:58 -0300] [Job 7357] Adding end banner page "none".
> I [03/Nov/2010:23:06:58 -0300] [Job 7357] Queued on "concepcion_115" by "lgfadm".
> D [03/Nov/2010:23:06:58 -0300] [Job 7357] hold_until = 0
> D [03/Nov/2010:23:06:58 -0300] cupsdProcessIPPRequest: 13 status_code=0 (successful-ok)
> D [03/Nov/2010:23:06:58 -0300] cupsdCloseClient: 13
> D [03/Nov/2010:23:06:59 -0300] cupsdAcceptClient: skipping getpeercon()
> D [03/Nov/2010:23:06:59 -0300] cupsdAcceptClient: 13 from localhost (Domain)
> D [03/Nov/2010:23:06:59 -0300] [Job 7352] Unloading...
> D [03/Nov/2010:23:06:59 -0300] [Job 7353] Unloading...
> D [03/Nov/2010:23:06:59 -0300] [Job 7354] Unloading...
> D [03/Nov/2010:23:06:59 -0300] [Job 7355] Unloading...
> D [03/Nov/2010:23:06:59 -0300] cupsdReadClient: 13 POST / HTTP/1.1
> . 
> . 
> . 
> D [03/Nov/2010:23:07:01 -0300] Discarding unused printer-state-changed event...
> D [03/Nov/2010:23:07:01 -0300] Discarding unused printer-state-changed event...
> D [03/Nov/2010:23:07:01 -0300] [Job 7357] Connected to 10.8.25.115:515 (IPv4) (local port 994)...
> D [03/Nov/2010:23:07:01 -0300] [Job 7357] lpd_command 02 lp-cd-esp-115-P1
> D [03/Nov/2010:23:07:01 -0300] [Job 7357] Sending command string (18 bytes)...
> D [03/Nov/2010:23:07:01 -0300] [Job 7357] Reading command status...
> . 
> . 
> . 
> W [03/Nov/2010:23:12:01 -0300] [Job 7357] Remote host did not respond with command status byte after 300 seconds!
> D [03/Nov/2010:23:12:01 -0300] Discarding unused printer-state-changed event...
> D [03/Nov/2010:23:12:01 -0300] [Job 7357] lpd_command returning 4
> E [03/Nov/2010:23:12:01 -0300] PID 19148 (/usr/lib/cups/backend/lpd) stopped with status 1!
> D [03/Nov/2010:23:12:01 -0300] [Job 7357] File 0 is complete.
> I [03/Nov/2010:23:12:01 -0300] [Job 7357] Backend returned status 1 (failed)
> D [03/Nov/2010:23:12:01 -0300] Discarding unused printer-state-changed event...
> D [03/Nov/2010:23:12:01 -0300] Discarding unused printer-stopped event...
> I [03/Nov/2010:23:12:01 -0300] Saving printers.conf...
> D [03/Nov/2010:23:12:01 -0300] Discarding unused job-stopped event...
> D [03/Nov/2010:23:12:02 -0300] [Job 7357] Unloading...
> D [03/Nov/2010:23:12:02 -0300] Report: clients=1
> D [03/Nov/2010:23:12:02 -0300] Report: jobs=196
> 
> 
> The last line in page_log is as follows
> 	concepcion_115 lgfadm 7357 [03/Nov/2010:23:07:01 -0300] 1 1 - localhost
> 
> The printer is using lpd as indicated below and also shown are the printer options
> 	device for concepcion_115: lpd://10.8.25.115/lp-cd-esp-115-P1
> 
> [lgfadm at L573P] /home/lgfadm :\>lpoptions -pconcepcion_115
> finishings=3 copies=1 job-hold-until=no-hold job-priority=50 number-up=1 auth-info-required=none job-sheets=none,none printer-info='Concepcion 115' printer-is-accepting-jobs=1 printer-is-shared=1 printer-location=Concepcion printer-make-and-model='Local Raw Printer' printer-state=5 printer-state-change-time=1288836721 printer-state-reasons=paused printer-type=4
> 
> Please guide.
> 
> Regards,
> Anurag
> _______________________________________________
> cups mailing list
> cups at easysw.com
> http://lists.easysw.com/mailman/listinfo/cups

________________________________________________________________________
Michael Sweet, Senior Printing System Engineer, PWG Chair