[cups] CUPS error logs

Thu Mar 1 05:21:36 PST 2018

I was finally able to replicate the printing error yesterday with an iMac running 10.12.6 to a SawGrass Virtuoso SG800 printer. Printing from Photoshop 2018.

I pulled the CUPS error logs, and I have pasted what I think are the relevant sections below. I highlighted what looks like something of possible concern in red.

The printer fed the paper, and then did not print. The paper stayed half-way in the printer and I had to manually pull it out. There was no error message on the printer LCD screen. It seemed to think the job was complete. No error in the Mac printer queue UI either.

If someone can assist me in taking a look at these logs I’d appreciate it. I’m not 100% sure what the purpose of this is list is, or how many people are on it. So I apologize if this list is not the place for this type of request. I’d really like to understand CUPS logs and I thought this might be a good place to start.

THIS LOOKS LIKE START OF PRINT JOB

D [28/Feb/2018:10:56:40 -0500] [Client 312] Server address is "/private/var/run/cupsd".
D [28/Feb/2018:10:56:40 -0500] [Client 312] Accepted from localhost (Domain Adobe Photoshop CC 2018[1798])
D [28/Feb/2018:10:56:40 -0500] [Client 312] Waiting for request.
D [28/Feb/2018:10:56:40 -0500] [Client 312] POST /printers/SAWGRASS_SG800 HTTP/1.1
D [28/Feb/2018:10:56:40 -0500] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Feb/2018:10:56:40 -0500] [Client 312] Read: status=200
D [28/Feb/2018:10:56:40 -0500] [Client 312] No authentication data provided.
D [28/Feb/2018:10:56:40 -0500] [Client 312] Read: status=100
D [28/Feb/2018:10:56:40 -0500] [Client 312] Read: status=100
D [28/Feb/2018:10:56:40 -0500] [Client 312] Read: status=100
D [28/Feb/2018:10:56:40 -0500] [Client 312] Read: status=100
D [28/Feb/2018:10:56:40 -0500] [Client 312] Read: status=100
D [28/Feb/2018:10:56:40 -0500] [Client 312] Read: status=100
D [28/Feb/2018:10:56:40 -0500] [Client 312] Read: status=100
D [28/Feb/2018:10:56:40 -0500] [Client 312] Read: status=100
D [28/Feb/2018:10:56:40 -0500] [Client 312] Read: status=100
D [28/Feb/2018:10:56:40 -0500] [Client 312] Read: status=100
D [28/Feb/2018:10:56:40 -0500] [Client 312] Read: status=100
D [28/Feb/2018:10:56:40 -0500] [Client 312] Read: status=100
D [28/Feb/2018:10:56:40 -0500] [Client 312] 2.0 Create-Job 197
D [28/Feb/2018:10:56:40 -0500] Create-Job ipp://localhost:631/printers/SAWGRASS_SG800
D [28/Feb/2018:10:56:40 -0500] cupsdMarkDirty(---J-)
D [28/Feb/2018:10:56:40 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients"
D [28/Feb/2018:10:56:40 -0500] add_job: requesting-user-name="h224users"
I [28/Feb/2018:10:56:40 -0500] [Job 127] Adding start banner page "none".
D [28/Feb/2018:10:56:40 -0500] Discarding unused job-created event...
I [28/Feb/2018:10:56:40 -0500] [Job 127] Queued on "SAWGRASS_SG800" by "h224users".
D [28/Feb/2018:10:56:40 -0500] [Client 312] Returning IPP successful-ok for Create-Job (ipp://localhost:631/printers/SAWGRASS_SG800) from localhost
D [28/Feb/2018:10:56:40 -0500] [Client 312] Content-Length: 201
D [28/Feb/2018:10:56:40 -0500] [Client 312] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [28/Feb/2018:10:56:40 -0500] [Client 312] con->http=0x7fa73c854e00
D [28/Feb/2018:10:56:40 -0500] [Client 312] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=201, response=0x7fa73e821740(IPP_STATE_IDLE), pipe_pid=0, file=-1
D [28/Feb/2018:10:56:40 -0500] [Client 312] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [28/Feb/2018:10:56:40 -0500] [Client 312] bytes=0, http_state=0, data_remaining=201
D [28/Feb/2018:10:56:40 -0500] [Client 312] Flushing write buffer.
D [28/Feb/2018:10:56:40 -0500] [Client 312] New state is HTTP_STATE_WAITING
D [28/Feb/2018:10:56:40 -0500] [Client 312] Waiting for request.
D [28/Feb/2018:10:56:40 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [28/Feb/2018:10:56:40 -0500] [Client 312] POST /printers/SAWGRASS_SG800 HTTP/1.1
D [28/Feb/2018:10:56:40 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [28/Feb/2018:10:56:40 -0500] [Client 312] Read: status=200
D [28/Feb/2018:10:56:40 -0500] [Client 312] No authentication data provided.
D [28/Feb/2018:10:56:40 -0500] [Client 312] 2.0 Send-Document 198
D [28/Feb/2018:10:56:41 -0500] [Client 312] Read: status=100
D [28/Feb/2018:10:56:41 -0500] [Client 312] Read: status=100
D [28/Feb/2018:10:56:41 -0500] [Client 312] Read: status=100
D [28/Feb/2018:10:56:41 -0500] [Client 312] Read: status=100
D [28/Feb/2018:10:56:41 -0500] [Client 312] Read: status=100
D [28/Feb/2018:10:56:41 -0500] [Client 312] Read: status=100
D [28/Feb/2018:10:56:41 -0500] [Client 312] Read: status=100
D [28/Feb/2018:10:56:41 -0500] [Client 312] Read: status=100
D [28/Feb/2018:10:56:41 -0500] [Client 312] Read: status=100
D [28/Feb/2018:10:56:41 -0500] [Client 312] Read: status=100
D [28/Feb/2018:10:56:41 -0500] [Client 312] Read: status=100
D [28/Feb/2018:10:56:41 -0500] [Client 312] Read: status=100
D [28/Feb/2018:10:56:41 -0500] [Client 312] Read: status=100
D [28/Feb/2018:10:56:41 -0500] [Client 312] Read: status=100
D [28/Feb/2018:10:56:41 -0500] [Client 312] Read: status=100
D [28/Feb/2018:10:56:41 -0500] [Client 312] Read: status=100
D [28/Feb/2018:10:56:41 -0500] [Client 312] Read: status=100
D [28/Feb/2018:10:56:41 -0500] [Client 312] Read: status=100
D [28/Feb/2018:10:56:41 -0500] [Client 312] Read: status=100
D [28/Feb/2018:10:56:41 -0500] [Client 312] Read: status=100
D [28/Feb/2018:10:56:41 -0500] [Client 312] Read: status=100
D [28/Feb/2018:10:56:42 -0500] Send-Document ipp://localhost:631/printers/SAWGRASS_SG800
D [28/Feb/2018:10:56:42 -0500] cupsdIsAuthorized: requesting-user-name="h224users"
D [28/Feb/2018:10:56:42 -0500] cupsdMarkDirty(---J-)
D [28/Feb/2018:10:56:42 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [28/Feb/2018:10:56:42 -0500] [Job 127] File of type application/pdf queued by "h224users".
D [28/Feb/2018:10:56:42 -0500] cupsdMarkDirty(---J-)
D [28/Feb/2018:10:56:42 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [28/Feb/2018:10:56:42 -0500] [Client 312] Returning IPP successful-ok for Send-Document (ipp://localhost:631/printers/SAWGRASS_SG800) from localhost
D [28/Feb/2018:10:56:42 -0500] [Client 312] Content-Length: 179
D [28/Feb/2018:10:56:42 -0500] [Client 312] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [28/Feb/2018:10:56:42 -0500] [Client 312] con->http=0x7fa73c854e00
D [28/Feb/2018:10:56:42 -0500] [Client 312] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=179, response=0x7fa73e821740(IPP_STATE_DATA), pipe_pid=0, file=-1
D [28/Feb/2018:10:56:42 -0500] [Client 312] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [28/Feb/2018:10:56:42 -0500] [Client 312] bytes=0, http_state=0, data_remaining=179
D [28/Feb/2018:10:56:42 -0500] [Client 312] Flushing write buffer.
D [28/Feb/2018:10:56:42 -0500] [Client 312] New state is HTTP_STATE_WAITING
D [28/Feb/2018:10:56:42 -0500] [Client 312] Waiting for request.
D [28/Feb/2018:10:56:42 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [28/Feb/2018:10:56:42 -0500] [Client 312] POST / HTTP/1.1
D [28/Feb/2018:10:56:42 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [28/Feb/2018:10:56:42 -0500] [Client 312] Read: status=200
D [28/Feb/2018:10:56:42 -0500] [Client 312] No authentication data provided.
D [28/Feb/2018:10:56:42 -0500] [Client 312] 2.0 Set-Job-Attributes 199
D [28/Feb/2018:10:56:42 -0500] Set-Job-Attributes ipp://localhost/jobs/127
D [28/Feb/2018:10:56:42 -0500] cupsdIsAuthorized: requesting-user-name="h224users"
D [28/Feb/2018:10:56:42 -0500] [Job 127] Setting job-hold-until to no-hold
D [28/Feb/2018:10:56:42 -0500] Discarding unused job-state-changed event...
I [28/Feb/2018:10:56:42 -0500] [Job 127] Job released by user.
D [28/Feb/2018:10:56:42 -0500] cupsdMarkDirty(---J-)
D [28/Feb/2018:10:56:42 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [28/Feb/2018:10:56:42 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [28/Feb/2018:10:56:42 -0500] cupsdMarkDirty(---J-)
D [28/Feb/2018:10:56:42 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [28/Feb/2018:10:56:42 -0500] Discarding unused job-state-changed event...
D [28/Feb/2018:10:56:42 -0500] Discarding unused job-config-changed event...
D [28/Feb/2018:10:56:42 -0500] [Job 127] time-at-processing=1519833402
D [28/Feb/2018:10:56:42 -0500] cupsdMarkDirty(---J-)
D [28/Feb/2018:10:56:42 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [28/Feb/2018:10:56:42 -0500] Asserting NetworkClientActive.
D [28/Feb/2018:10:56:42 -0500] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [28/Feb/2018:10:56:42 -0500] Discarding unused printer-state-changed event...
D [28/Feb/2018:10:56:42 -0500] [Job 127] 2 filters for job:
D [28/Feb/2018:10:56:42 -0500] [Job 127] cgpdftoraster (application/pdf to application/vnd.cups-raster, cost 100)
D [28/Feb/2018:10:56:42 -0500] [Job 127] /Library/Printers/SAWGRASS/Filters/rastertorpcr2h30.app/Contents/MacOS/rastertorpcr2h30 (application/vnd.cups-raster to printer/SAWGRASS_SG800, cost 0)
D [28/Feb/2018:10:56:42 -0500] [Job 127] job-sheets=none
D [28/Feb/2018:10:56:42 -0500] [Job 127] argv[0]="SAWGRASS_SG800"
D [28/Feb/2018:10:56:42 -0500] [Job 127] argv[1]="127"
D [28/Feb/2018:10:56:42 -0500] [Job 127] argv[2]="h224users"
D [28/Feb/2018:10:56:42 -0500] [Job 127] argv[3]="bird-logo.pdf"
D [28/Feb/2018:10:56:42 -0500] [Job 127] argv[4]="1"
D [28/Feb/2018:10:56:42 -0500] [Job 127] argv[5]="AP_ColorMatchingMode=AP_ApplicationColorMatching AP_D_InputSlot= noBookletBinding..b. BookletType..n.=0 nocollate com.apple.print.DocumentTicket.PMSpoolFormat=application/pdf com.apple.print.JobInfo.PMApplicationName=Photoshop\\ CC com.apple.print.JobInfo.PMJobName=bird-logo.pdf com.apple.print.JobInfo.PMJobOwner=H224Users com.apple.print.PageToPaperMappingAllowScalingUp..b. com.apple.print.PageToPaperMappingMediaName=Custom.936.00x1368.00 com.apple.print.PageToPaperMappingType..n.=1 com.apple.print.preset.PaperInfo..d.paperInfo..d.com.apple.print.PageFormat.PMAdjustedPageRect..a.0..n.=0 com.apple.print.preset.PaperInfo..d.paperInfo..d.com.apple.print.PageFormat.PMAdjustedPageRect..a.1..n.=0 com.apple.print.preset.PaperInfo..d.paperInfo..d.com.apple.print.PageFormat.PMAdjustedPageRect..a.2..n.=1310 com.apple.print.preset.PaperInfo..d.paperInfo..d.com.apple.print.PageFormat.PMAdjustedPageRect..a.3..n.=900 com.apple.print.preset.PaperInfo..d.paperInfo..d.com.apple.print.PageFormat.PMAdjustedPaperRect..a.0..n.=-18 com.apple.print.preset.PaperInfo..d.paperInfo..d.com.apple.print.PageFormat.PMAdjustedPaperRect..a.1..n.=-18 com.apple.print.preset.PaperInfo..d.paperInfo..d.com.apple.print.PageFormat.PMAdjustedPaperRect..a.2..n.=1350 com.apple.print.preset.PaperInfo..d.paperInfo..d.com.apple.print.PageFormat.PMAdjustedPaperRect..a.3..n.=918 com.apple.print.preset.PaperInfo..d.paperInfo..d.com.apple.print.PaperInfo.PMCustomPaper..b. com.apple.print.preset.PaperInfo..d.paperInfo..d.com.apple.print.PaperInfo.PMPaperName=Reveal-s\\ 13x19 com.apple.print.preset.PaperInfo..d.paperInfo..d.com.apple.print.PaperInfo.PMUnadjustedPageRect..a.0..n.=0 com.apple.print.preset.PaperInfo..d.paperInfo..d.com.apple.print.PaperInfo.PMUnadjustedPageRect..a.1..n.=0 com.apple.print.preset.PaperInfo..d.paperInfo..d.com.apple.print.PaperInfo.PMUnadjustedPageRect..a.2..n.=1310 com.apple.print.preset.PaperInfo..d.paperInfo..d.com.apple.print.PaperInfo.PMUnadjustedPageRect..a.3..n.=900 com.apple.print.preset.PaperInfo..d.paperInfo..d.com.apple.print.PaperInfo.PMUnadjustedPaperRect..a.0..n.=-18 com.apple.print.preset.PaperInfo..d.paperInfo..d.com.apple.print.PaperInfo.PMUnadjustedPaperRect..a.1..n.=-18 com.apple.print.preset.PaperInfo..d.paperInfo..d.com.apple.print.PaperInfo.PMUnadjustedPaperRect..a.2..n.=1350 com.apple.print.preset.PaperInfo..d.paperInfo..d.com.apple.print.PaperInfo.PMUnadjustedPaperRect..a.3..n.=918 com.apple.print.preset.PaperInfo..d.paperInfo..d.com.apple.print.PaperInfo.ppd.PMPaperName=Reveal-s\\ 13x19 com.apple.print.preset.PaperInfo..d.paperInfo..d.com.apple.print.ticket.type=com.apple.print.PaperInfoTicket com.apple.print.PrinterInfo.PMColorDeviceID..n.=7237 com.apple.print.PrintSettings.PMColorSpaceModel..n.=2 com.apple.print.PrintSettings.PMCopies..n.=1 com.apple.print.PrintSettings.PMCopyCollate..b. com.apple.print.PrintSettings.PMDestinationType..n.=1 com.apple.print.PrintSettings.PMFirstPage..n.=1 com.apple.print.PrintSettings.PMLastPage..n.=2147483647 com.apple.print.PrintSettings.PMLayoutColumns..n.=1 com.apple.print.PrintSettings.PMLayoutRows..n.=1 com.apple.print.PrintSettings.PMPageRange..a.0..n.=1 com.apple.print.PrintSettings.PMPageRange..a.1..n.=2147483647 DestinationPrinterID=SAWGRASS_SG800 media=Custom.935.43x1368.00 nomirror noMirrorPrint PaperInfoIsSuggested..b. pserrorhandler-requested=standard RIColorProfile=None RIHalftone=ED RIPrintQuality=InkjetPlainPaper.Normal RIUserCodeCustomValue= job-uuid=urn:uuid:cbf77877-14ae-350a-45c6-869ed392e581 job-originating-host-name=localhost date-time-at-creation= date-time-at-processing= time-at-creation=1519833400 time-at-processing=1519833402 document-name-supplied=bird-logo.pdf job-impressions=1 com.apple.print.PrintSettings.PMTotalSidesImaged..n.=1 sides=one-sided Duplex=None com.apple.print.PrintSettings.PMTotalBeginPages..n.=1 PageSize=Custom.935x1368"
D [28/Feb/2018:10:56:42 -0500] [Job 127] argv[6]="/private/var/spool/cups/d00127-001"
D [28/Feb/2018:10:56:42 -0500] [Job 127] envp[0]="<CFProcessPath>"
D [28/Feb/2018:10:56:42 -0500] [Job 127] envp[1]="CUPS_CACHEDIR=/private/var/spool/cups/cache"
D [28/Feb/2018:10:56:42 -0500] [Job 127] envp[2]="CUPS_DATADIR=/usr/share/cups"
D [28/Feb/2018:10:56:42 -0500] [Job 127] envp[3]="CUPS_DOCROOT=/usr/share/doc/cups"
D [28/Feb/2018:10:56:42 -0500] [Job 127] envp[4]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [28/Feb/2018:10:56:42 -0500] [Job 127] envp[5]="CUPS_REQUESTROOT=/private/var/spool/cups"
D [28/Feb/2018:10:56:42 -0500] [Job 127] envp[6]="CUPS_SERVERBIN=/usr/libexec/cups"
D [28/Feb/2018:10:56:42 -0500] [Job 127] envp[7]="CUPS_SERVERROOT=/private/etc/cups"
D [28/Feb/2018:10:56:42 -0500] [Job 127] envp[8]="CUPS_STATEDIR=/private/etc/cups"
D [28/Feb/2018:10:56:42 -0500] [Job 127] envp[9]="HOME=/private/var/spool/cups/tmp"
D [28/Feb/2018:10:56:42 -0500] [Job 127] envp[10]="PATH=/usr/libexec/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [28/Feb/2018:10:56:42 -0500] [Job 127] envp[11]="SERVER_ADMIN=root at HBH224X25SLW"
D [28/Feb/2018:10:56:42 -0500] [Job 127] envp[12]="SOFTWARE=CUPS/2.2.0"
D [28/Feb/2018:10:56:42 -0500] [Job 127] envp[13]="TMPDIR=/private/var/spool/cups/tmp"
D [28/Feb/2018:10:56:42 -0500] [Job 127] envp[14]="USER=root"
D [28/Feb/2018:10:56:42 -0500] [Job 127] envp[15]="CUPS_MAX_MESSAGE=2047"
D [28/Feb/2018:10:56:42 -0500] [Job 127] envp[16]="CUPS_SERVER=/private/var/run/cupsd"
D [28/Feb/2018:10:56:42 -0500] [Job 127] envp[17]="CUPS_ENCRYPTION=IfRequested"
D [28/Feb/2018:10:56:42 -0500] [Job 127] envp[18]="IPP_PORT=631"
D [28/Feb/2018:10:56:42 -0500] [Job 127] envp[19]="CHARSET=utf-8"
D [28/Feb/2018:10:56:42 -0500] [Job 127] envp[20]="LANG=en_US.UTF-8"
D [28/Feb/2018:10:56:42 -0500] [Job 127] envp[21]="APPLE_LANGUAGE=en-US"
D [28/Feb/2018:10:56:42 -0500] [Job 127] envp[22]="PPD=/private/etc/cups/ppd/SAWGRASS_SG800.ppd"
D [28/Feb/2018:10:56:42 -0500] [Job 127] envp[23]="RIP_MAX_CACHE=128m"
D [28/Feb/2018:10:56:42 -0500] [Job 127] envp[24]="CONTENT_TYPE=application/pdf"
D [28/Feb/2018:10:56:42 -0500] [Job 127] envp[25]="DEVICE_URI=usb://SAWGRASS/SG800?serial=R736A815188"
D [28/Feb/2018:10:56:42 -0500] [Job 127] envp[26]="PRINTER_INFO=SAWGRASS SG800"
D [28/Feb/2018:10:56:42 -0500] [Job 127] envp[27]="PRINTER_LOCATION=HBH224X25SLW"
D [28/Feb/2018:10:56:42 -0500] [Job 127] envp[28]="PRINTER=SAWGRASS_SG800"
D [28/Feb/2018:10:56:42 -0500] [Job 127] envp[29]="PRINTER_STATE_REASONS=none"
D [28/Feb/2018:10:56:42 -0500] [Job 127] envp[30]="CUPS_FILETYPE=document"
D [28/Feb/2018:10:56:42 -0500] [Job 127] envp[31]="FINAL_CONTENT_TYPE=application/vnd.cups-raster"
D [28/Feb/2018:10:56:42 -0500] [Job 127] envp[32]="AUTH_I****"
I [28/Feb/2018:10:56:42 -0500] [Job 127] Started filter /usr/libexec/cups/filter/cgpdftoraster (PID 8974)
I [28/Feb/2018:10:56:42 -0500] [Job 127] Started filter /Library/Printers/SAWGRASS/Filters/rastertorpcr2h30.app/Contents/MacOS/rastertorpcr2h30 (PID 8975)
I [28/Feb/2018:10:56:42 -0500] [Job 127] Started backend /usr/libexec/cups/backend/usb (PID 8976)
D [28/Feb/2018:10:56:42 -0500] Discarding unused job-state-changed event...
D [28/Feb/2018:10:56:42 -0500] [Client 312] Returning IPP successful-ok for Set-Job-Attributes (ipp://localhost/jobs/127) from localhost
D [28/Feb/2018:10:56:42 -0500] [Client 312] Content-Length: 75
D [28/Feb/2018:10:56:42 -0500] [Client 312] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [28/Feb/2018:10:56:42 -0500] [Client 312] con->http=0x7fa73c854e00
D [28/Feb/2018:10:56:42 -0500] [Client 312] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=75, response=0x7fa73e829eb0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [28/Feb/2018:10:56:42 -0500] [Client 312] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [28/Feb/2018:10:56:42 -0500] [Client 312] bytes=0, http_state=0, data_remaining=75
D [28/Feb/2018:10:56:42 -0500] [Client 312] Flushing write buffer.
D [28/Feb/2018:10:56:42 -0500] [Client 312] New state is HTTP_STATE_WAITING
D [28/Feb/2018:10:56:42 -0500] [Client 312] Waiting for request.
D [28/Feb/2018:10:56:42 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients and dirty files"
D [28/Feb/2018:10:56:42 -0500] [Client 312] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [28/Feb/2018:10:56:42 -0500] [Client 312] Closing connection.
D [28/Feb/2018:10:56:42 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [28/Feb/2018:10:56:42 -0500] [Client 311] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [28/Feb/2018:10:56:42 -0500] [Client 311] Closing connection.
D [28/Feb/2018:10:56:42 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [28/Feb/2018:10:56:42 -0500] [Job 127] usb: AppleLanguages=\"en-US\"
D [28/Feb/2018:10:56:42 -0500] [Job 127] STATE: +connecting-to-device
D [28/Feb/2018:10:56:42 -0500] cupsdMarkDirty(---J-)
D [28/Feb/2018:10:56:42 -0500] cupsdSetBusyState: newbusy="Dirty files", busy="Printing jobs and dirty files"
D [28/Feb/2018:10:56:42 -0500] [Job 127] Looking for \'SAWGRASS SG800\'
D [28/Feb/2018:10:56:42 -0500] Discarding unused printer-state-changed event...
D [28/Feb/2018:10:56:43 -0500] [Job 127] Opening connection
D [28/Feb/2018:10:56:43 -0500] [Job 127] load_classdriver(/System/Library/Printers/Libraries/USBGenericPrintingClass.plugin) (kr:0x00000000)
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -connecting-to-device
D [28/Feb/2018:10:56:43 -0500] cupsdMarkDirty(---J-)
D [28/Feb/2018:10:56:43 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Dirty files"
D [28/Feb/2018:10:56:43 -0500] Discarding unused printer-state-changed event...
D [28/Feb/2018:10:56:43 -0500] [Job 127] Sending data to printer.
D [28/Feb/2018:10:56:43 -0500] cupsdMarkDirty(---J-)
D [28/Feb/2018:10:56:43 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [28/Feb/2018:10:56:43 -0500] [Job 127] Set job-printer-state-message to "Sending data to printer.", current level=INFO
D [28/Feb/2018:10:56:43 -0500] Discarding unused job-progress event...
D [28/Feb/2018:10:56:43 -0500] Discarding unused printer-state-changed event...
D [28/Feb/2018:10:56:43 -0500] [Job 127] cgpdftoraster: \"/private/var/spool/cups/d00127-001\" has 1 pages.
D [28/Feb/2018:10:56:43 -0500] [Job 127] cgpdftoraster: opened PPD file \"/private/etc/cups/ppd/SAWGRASS_SG800.ppd\"...
D [28/Feb/2018:10:56:43 -0500] [Job 127] cgpdftoraster: PreferredRotation = -90
D [28/Feb/2018:10:56:43 -0500] [Job 127] cupsPageSize=[935 1368], cupsImagingBBox=[12 12 923 1356]
D [28/Feb/2018:10:56:43 -0500] [Job 127] cgpdftoraster: width=935, length=1368, top=12, bottom=12, left=12, right=12
D [28/Feb/2018:10:56:43 -0500] [Job 127] cupsWidth=7592, cupsHeight=11200
D [28/Feb/2018:10:56:43 -0500] [Job 127] cgpdftoraster: languageLevel = 3, mediaBox.size.width = 935, mediaBox.size.height = 1368
D [28/Feb/2018:10:56:43 -0500] [Job 127] cgpdftoraster: colorspace = 1, bitsPerColor = 8
D [28/Feb/2018:10:56:43 -0500] [Job 127] cgpdftoraster: band width = 7592, bytesPerRow = 30368, band height = 4419, height = 11200
D [28/Feb/2018:10:56:43 -0500] [Job 127] cgpdftoraster: context width = 7592, height = 4419, bitsPerComponent = 8, bitsPerPixel = 32, bytesPerRow = 30368, bitmapInfo = 5, resolution = (600.000000, 600.000000)
D [28/Feb/2018:10:56:43 -0500] [Job 127] HWResolution = [ 600 600 ]
D [28/Feb/2018:10:56:43 -0500] [Job 127] ImagingBoundingBox = [ 12 12 923 1356 ]
D [28/Feb/2018:10:56:43 -0500] [Job 127] Margins = [ 12 12 ]
D [28/Feb/2018:10:56:43 -0500] [Job 127] PageSize = [ 935 1368 ]
D [28/Feb/2018:10:56:43 -0500] [Job 127] cupsWidth = 7592
D [28/Feb/2018:10:56:43 -0500] [Job 127] cupsHeight = 11200
D [28/Feb/2018:10:56:43 -0500] [Job 127] cupsBitsPerColor = 8
D [28/Feb/2018:10:56:43 -0500] [Job 127] cupsBitsPerPixel = 24
D [28/Feb/2018:10:56:43 -0500] [Job 127] cupsBytesPerLine = 22776
D [28/Feb/2018:10:56:43 -0500] [Job 127] band = {0, 813.72; 935, 530.28}
D [28/Feb/2018:10:56:43 -0500] [Job 127] Erasing band to white...
D [28/Feb/2018:10:56:43 -0500] [Job 127] EraseContext [0 0 7592 22400]
D [28/Feb/2018:10:56:43 -0500] [Job 127] Status monitor started
D [28/Feb/2018:10:56:43 -0500] [Job 127] CUPS_SC_CMD_GET_DEVICE_ID received from driver...
D [28/Feb/2018:10:56:43 -0500] [Job 127] Returning CUPS_SC_STATUS_OK with 135 bytes (SERN:R736A815188;MFG:SAWGRASS;CMD:PJL,ICP;MDL:SG800;STS:10001,0;CLS:PRINTER;DES:SAWGRASS SG800;CID:;RIJ:223/71,70,67,68;REX:41;MIB:100;)...
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.10004-report
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.10007-report
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.10042-report
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.10046-report
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.50108-report
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.30136-warning
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.30021-warning
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.10032-report
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.10072-report
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.10073-report
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.10074-report
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.10075-report
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.30626-warning
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.10044-report
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.10045-report
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.10002-report
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.41200-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.41300-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.41400-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.41100-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.46200-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.46300-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.46400-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.46100-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.47200-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.47300-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.47400-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.47100-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.48200-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.48300-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.48400-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.48100-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.45000-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.40940-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.30013-warning
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.30014-warning
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.30015-warning
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.40012-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.40013-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.40014-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.40015-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.40002-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.40003-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.40004-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.40005-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.42904-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.40205-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.40101-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.40172-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.40173-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.40174-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.40175-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.40200-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.40204-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.40211-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.40212-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.40931-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.40260-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.42901-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.42902-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.42908-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.42903-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.42906-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.42905-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.42907-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.42012-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.42000-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.42019-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.42013-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.42999-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.42001-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.42014-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.42008-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.40011-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.40030-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.40159-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.40904-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.40905-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.40800-error
D [28/Feb/2018:10:56:43 -0500] [Job 127] STATE: -com.ricoh.10033-report
D [28/Feb/2018:10:56:43 -0500] [Job 127] ATTR: marker-colors=#000000,#00ffff,#ff00ff,#ffff00,none
D [28/Feb/2018:10:56:43 -0500] cupsdMarkDirty(P----)
D [28/Feb/2018:10:56:43 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [28/Feb/2018:10:56:43 -0500] [Job 127] ATTR: marker-names=\"0\",\"1\",\"2\",\"3\",\"4\"
D [28/Feb/2018:10:56:43 -0500] cupsdMarkDirty(P----)
D [28/Feb/2018:10:56:43 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [28/Feb/2018:10:56:43 -0500] [Job 127] ATTR: marker-types=ink,ink,ink,ink,wasteInk
D [28/Feb/2018:10:56:43 -0500] cupsdMarkDirty(P----)
D [28/Feb/2018:10:56:43 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [28/Feb/2018:10:56:43 -0500] [Job 127] ATTR: marker-levels=71,70,67,68,59
D [28/Feb/2018:10:56:43 -0500] cupsdMarkDirty(P----)
D [28/Feb/2018:10:56:43 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [28/Feb/2018:10:56:43 -0500] Discarding unused printer-state-changed event...
D [28/Feb/2018:10:56:43 -0500] [Job 127] Job started
D [28/Feb/2018:10:56:43 -0500] [Job 127] *RIRGBRatio InkjetPlainPaper.F.O.A.A = 100
D [28/Feb/2018:10:56:43 -0500] [Job 127] *RILimitRatio InkjetPlainPaper.F.O = 100
D [28/Feb/2018:10:56:43 -0500] [Job 127] *RIGMModeID InkjetPlainPaper.S.600dpi.1.P = 431
D [28/Feb/2018:10:56:43 -0500] [Job 127] Page #1 started
D [28/Feb/2018:10:56:43 -0500] [Job 127] PAGE: 1 1
D [28/Feb/2018:10:56:43 -0500] cupsdMarkDirty(---J-)
D [28/Feb/2018:10:56:43 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [28/Feb/2018:10:56:43 -0500] cupsdMarkDirty(---J-)
D [28/Feb/2018:10:56:43 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [28/Feb/2018:10:56:43 -0500] Discarding unused job-progress event...
D [28/Feb/2018:10:56:43 -0500] [Job 127] displayList=0x0
D [28/Feb/2018:10:56:43 -0500] [Job 127] drawSheet(c=0x7fa5c9d0cd50, document=0x7fa5c9c0e100, pageNum=1, mediaBox=[0 0 935 1368], band=[0 813.72 935 530.28], nup=0x0, pageMap=0x0, fitToPage=0, preTransformP=0x0, rotation=0)
D [28/Feb/2018:10:56:43 -0500] [Job 127] Drawing unscaled page.
D [28/Feb/2018:10:56:43 -0500] [Job 127] docMediaBox=[0 0 936 1368]
D [28/Feb/2018:10:56:43 -0500] [Job 127] scaled rect=[0 0 936 1368]
D [28/Feb/2018:10:56:44 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [28/Feb/2018:10:56:44 -0500] [Job 127] band = {0, 283.44; 935, 530.28}
D [28/Feb/2018:10:56:44 -0500] [Job 127] Erasing band to white...
D [28/Feb/2018:10:56:44 -0500] [Job 127] EraseContext [0 0 7592 22400]
D [28/Feb/2018:10:56:44 -0500] [Job 127] displayList=0x0
D [28/Feb/2018:10:56:44 -0500] [Job 127] drawSheet(c=0x7fa5c9d0cd50, document=0x7fa5c9c0e100, pageNum=1, mediaBox=[0 0 935 1368], band=[0 283.44 935 530.28], nup=0x0, pageMap=0x0, fitToPage=0, preTransformP=0x0, rotation=0)
D [28/Feb/2018:10:56:44 -0500] [Job 127] Drawing unscaled page.
D [28/Feb/2018:10:56:44 -0500] [Job 127] docMediaBox=[0 0 936 1368]
D [28/Feb/2018:10:56:44 -0500] [Job 127] scaled rect=[0 0 936 1368]
D [28/Feb/2018:10:56:46 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:46 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:46 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:46 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:46 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:46 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:46 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:46 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:46 -0500] [Job 127] band = {0, -246.84; 935, 283.44}
D [28/Feb/2018:10:56:46 -0500] [Job 127] Erasing band to white...
D [28/Feb/2018:10:56:46 -0500] [Job 127] EraseContext [0 0 7592 22400]
D [28/Feb/2018:10:56:46 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:46 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:46 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:46 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:46 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:46 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:46 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:46 -0500] [Job 127] displayList=0x0
D [28/Feb/2018:10:56:46 -0500] [Job 127] drawSheet(c=0x7fa5c9d0cd50, document=0x7fa5c9c0e100, pageNum=1, mediaBox=[0 0 935 1368], band=[0 -246.84 935 283.44], nup=0x0, pageMap=0x0, fitToPage=0, preTransformP=0x0, rotation=0)
D [28/Feb/2018:10:56:46 -0500] [Job 127] Drawing unscaled page.
D [28/Feb/2018:10:56:46 -0500] [Job 127] docMediaBox=[0 0 936 1368]
D [28/Feb/2018:10:56:46 -0500] [Job 127] scaled rect=[0 0 936 1368]
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] cgpdftoraster: bytes written for side 1 = 255091200, err = 0
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Page #1 finished
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] PID 8974 (/usr/libexec/cups/filter/cgpdftoraster) exited with no errors.
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 8192 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Read 604 bytes of print data...
D [28/Feb/2018:10:56:47 -0500] [Job 127] Wrote 604 bytes of print data...
D [28/Feb/2018:10:56:48 -0500] [Job 127] Read 512 bytes of back-channel data...
D [28/Feb/2018:10:56:48 -0500] [Job 127] Read 59 bytes of print data...
D [28/Feb/2018:10:56:48 -0500] [Job 127] Read 132 bytes of back-channel data...
D [28/Feb/2018:10:56:48 -0500] [Job 127] Wrote 59 bytes of print data...
D [28/Feb/2018:10:56:48 -0500] [Job 127] Read 25 bytes of back-channel data...
D [28/Feb/2018:10:56:48 -0500] [Job 127] Read 59 bytes of print data...
D [28/Feb/2018:10:56:48 -0500] [Job 127] Wrote 59 bytes of print data...
D [28/Feb/2018:10:56:48 -0500] [Job 127] Read 25 bytes of back-channel data...
D [28/Feb/2018:10:56:48 -0500] [Job 127] Read 59 bytes of print data...
D [28/Feb/2018:10:56:48 -0500] [Job 127] Wrote 59 bytes of print data...
D [28/Feb/2018:10:56:48 -0500] [Job 127] Read 25 bytes of back-channel data...
D [28/Feb/2018:10:56:48 -0500] [Job 127] Read 59 bytes of print data...
D [28/Feb/2018:10:56:48 -0500] [Job 127] Wrote 59 bytes of print data...
D [28/Feb/2018:10:56:48 -0500] [Job 127] Read 25 bytes of back-channel data...
D [28/Feb/2018:10:56:48 -0500] [Job 127] Waiting for status monitor to stop
D [28/Feb/2018:10:56:48 -0500] [Job 127] Status monitor stopped
D [28/Feb/2018:10:56:48 -0500] [Job 127] Job finished
D [28/Feb/2018:10:56:48 -0500] [Job 127] Sent 811848 bytes...
D [28/Feb/2018:10:56:48 -0500] [Job 127] STATE: +cups-waiting-for-job-completed
D [28/Feb/2018:10:56:48 -0500] cupsdMarkDirty(P----)
D [28/Feb/2018:10:56:48 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [28/Feb/2018:10:56:48 -0500] cupsdMarkDirty(--p--)
D [28/Feb/2018:10:56:48 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [28/Feb/2018:10:56:48 -0500] cupsdMarkDirty(---J-)
D [28/Feb/2018:10:56:48 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [28/Feb/2018:10:56:48 -0500] Discarding unused printer-state-changed event...
D [28/Feb/2018:10:56:48 -0500] [Job 127] Waiting for read thread to exit...
D [28/Feb/2018:10:56:48 -0500] [Client 327] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [28/Feb/2018:10:56:48 -0500] [Client 327] Closing connection.
D [28/Feb/2018:10:56:48 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [28/Feb/2018:10:56:48 -0500] [Job 127] PID 8975 (/Library/Printers/SAWGRASS/Filters/rastertorpcr2h30.app/Contents/MacOS/rastertorpcr2h30) exited with no errors
D [28/Feb/2018:10:56:48 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [28/Feb/2018:10:56:55 -0500] [Job 127] Read thread still active, aborting the pending read...
D [28/Feb/2018:10:56:55 -0500] [Job 127] Got USB return aborted during read
D [28/Feb/2018:10:56:55 -0500] [Job 127] PID 8976 (/usr/libexec/cups/backend/usb) exited with no errors.
D [28/Feb/2018:10:56:55 -0500] cupsdMarkDirty(P----)
D [28/Feb/2018:10:56:55 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [28/Feb/2018:10:56:55 -0500] cupsdMarkDirty(--p--)
D [28/Feb/2018:10:56:55 -0500] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [28/Feb/2018:10:56:55 -0500] [Job 127] time-at-completed=1519833415
D [28/Feb/2018:10:56:55 -0500] Discarding unused job-completed event...
I [28/Feb/2018:10:56:55 -0500] [Job 127] Job completed.

THIS APPEARS TO BE THE END OF THE PRINT JOB

Thank you

To unsubscribe: email unsubscribe at hacc.edu with sender email address and subject. This email and any files attached from HACC, Central Pennsylvania's Community College are confidential and intended solely for use by the individual or entity to whom addressed. If you have received this email in error please notify postmaster at hacc.edu This message may contain confidential information and is intended only for the individual named. If you are not the named addressee do not disseminate, distribute or copy this e-mail. Please notify the sender immediately by e-mail if you have received this e-mail by mistake and delete from your system. If you are not the intended recipient you are notified that disclosing, copying, distributing or taking any action in reliance on the contents of this information is strictly prohibited.