I [18/Jul/2011:17:01:45 +0100] [Job 141] Adding start banner page "none".
D [18/Jul/2011:17:01:45 +0100] Discarding unused job-created event...
I [18/Jul/2011:17:01:45 +0100] [Job 141] Queued on "Samsung_ML-2550" by "john".
D [18/Jul/2011:17:01:45 +0100] Returning IPP successful-ok for Create-Job (ipp://localhost:631/printers/Samsung_ML-2550) from localhost
D [18/Jul/2011:17:01:45 +0100] cupsdSetBusyState: Dirty files
D [18/Jul/2011:17:01:45 +0100] cupsdReadClient: 13 POST /printers/Samsung_ML-2550 HTTP/1.1
D [18/Jul/2011:17:01:45 +0100] cupsdSetBusyState: Active clients and dirty files
D [18/Jul/2011:17:01:45 +0100] cupsdAuthorize: No authentication data provided.
D [18/Jul/2011:17:01:45 +0100] cupsdReadClient: 13 1.1 Send-Document 1
D [18/Jul/2011:17:01:45 +0100] Send-Document ipp://localhost:631/printers/Samsung_ML-2550
D [18/Jul/2011:17:01:45 +0100] cupsdIsAuthorized: requesting-user-name="john"
D [18/Jul/2011:17:01:45 +0100] [Job 141] Auto-typing file...
D [18/Jul/2011:17:01:45 +0100] [Job 141] Request file type is application/postscript.
D [18/Jul/2011:17:01:45 +0100] cupsdMarkDirty(----J-)
I [18/Jul/2011:17:01:45 +0100] [Job 141] File of type application/postscript queued by "john".
I [18/Jul/2011:17:01:45 +0100] [Job 141] Adding end banner page "none".
D [18/Jul/2011:17:01:45 +0100] cupsdMarkDirty(----J-)
D [18/Jul/2011:17:01:45 +0100] cupsdMarkDirty(----J-)
D [18/Jul/2011:17:01:45 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [18/Jul/2011:17:01:45 +0100] Discarding unused printer-state-changed event...
D [18/Jul/2011:17:01:45 +0100] [Job 141] job-sheets=none,none
D [18/Jul/2011:17:01:45 +0100] [Job 141] argv[0]="Samsung_ML-2550"
D [18/Jul/2011:17:01:45 +0100] [Job 141] argv[1]="141"
D [18/Jul/2011:17:01:45 +0100] [Job 141] argv[2]="john"
D [18/Jul/2011:17:01:45 +0100] [Job 141] argv[3]="One to One 1107"
D [18/Jul/2011:17:01:45 +0100] [Job 141] argv[4]="1"
D [18/Jul/2011:17:01:45 +0100] [Job 141] argv[5]="Duplex=DuplexTumble PageSize=A4 job-uuid=urn:uuid:1a14f49c-a0ec-3e7c-4d5c-cf9f333a0a84 job-originating-host-name=localhost time-at-creation=1311004905 time-at-processing=1311004905 AP_D_InputSlot="
D [18/Jul/2011:17:01:45 +0100] [Job 141] argv[6]="/var/spool/cups/d00141-001"
D [18/Jul/2011:17:01:45 +0100] [Job 141] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [18/Jul/2011:17:01:45 +0100] [Job 141] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [18/Jul/2011:17:01:45 +0100] [Job 141] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root"
D [18/Jul/2011:17:01:45 +0100] [Job 141] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [18/Jul/2011:17:01:45 +0100] [Job 141] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [18/Jul/2011:17:01:45 +0100] [Job 141] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [18/Jul/2011:17:01:45 +0100] [Job 141] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [18/Jul/2011:17:01:45 +0100] [Job 141] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [18/Jul/2011:17:01:45 +0100] [Job 141] envp[8]="HOME=/var/spool/cups/tmp"
D [18/Jul/2011:17:01:45 +0100] [Job 141] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [18/Jul/2011:17:01:45 +0100] [Job 141] envp[10]="SERVER_ADMIN=root@johnwtwind"
D [18/Jul/2011:17:01:45 +0100] [Job 141] envp[11]="SOFTWARE=CUPS/1.4.6"
D [18/Jul/2011:17:01:45 +0100] [Job 141] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [18/Jul/2011:17:01:45 +0100] [Job 141] envp[13]="TZ=Europe/London"
D [18/Jul/2011:17:01:45 +0100] [Job 141] envp[14]="USER=root"
D [18/Jul/2011:17:01:45 +0100] [Job 141] envp[15]="CUPS_SERVER=/var/run/cups/cups.sock"
D [18/Jul/2011:17:01:45 +0100] [Job 141] envp[16]="CUPS_ENCRYPTION=IfRequested"
D [18/Jul/2011:17:01:45 +0100] [Job 141] envp[17]="IPP_PORT=631"
D [18/Jul/2011:17:01:45 +0100] [Job 141] envp[18]="CHARSET=utf-8"
D [18/Jul/2011:17:01:45 +0100] [Job 141] envp[19]="LANG=en_GB.UTF-8"
D [18/Jul/2011:17:01:45 +0100] [Job 141] envp[20]="PPD=/etc/cups/ppd/Samsung_ML-2550.ppd"
D [18/Jul/2011:17:01:45 +0100] [Job 141] envp[21]="RIP_MAX_CACHE=auto"
D [18/Jul/2011:17:01:45 +0100] [Job 141] envp[22]="CONTENT_TYPE=application/postscript"
D [18/Jul/2011:17:01:45 +0100] [Job 141] envp[23]="DEVICE_URI=usb://Samsung/ML-2550?serial=2M37B1EL200162Y."
D [18/Jul/2011:17:01:45 +0100] [Job 141] envp[24]="PRINTER_INFO=Samsung ML-2550"
D [18/Jul/2011:17:01:45 +0100] [Job 141] envp[25]="PRINTER_LOCATION=Office"
D [18/Jul/2011:17:01:45 +0100] [Job 141] envp[26]="PRINTER=Samsung_ML-2550"
D [18/Jul/2011:17:01:45 +0100] [Job 141] envp[27]="CUPS_FILETYPE=document"
D [18/Jul/2011:17:01:45 +0100] [Job 141] envp[28]="FINAL_CONTENT_TYPE=application/vnd.cups-postscript"
I [18/Jul/2011:17:01:45 +0100] [Job 141] Started filter /usr/lib/cups/filter/pstops (PID 7280)
I [18/Jul/2011:17:01:45 +0100] [Job 141] Started backend /usr/lib/cups/backend/usb (PID 7281)
D [18/Jul/2011:17:01:45 +0100] Discarding unused job-state-changed event...
D [18/Jul/2011:17:01:45 +0100] Returning IPP successful-ok for Send-Document (ipp://localhost:631/printers/Samsung_ML-2550) from localhost
D [18/Jul/2011:17:01:45 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [18/Jul/2011:17:01:45 +0100] [Job 141] print_device
D [18/Jul/2011:17:01:45 +0100] [Job 141] usb_find_busses=5
D [18/Jul/2011:17:01:45 +0100] [Job 141] usb_find_devices=19
D [18/Jul/2011:17:01:45 +0100] [Job 141] STATE: +connecting-to-device
D [18/Jul/2011:17:01:45 +0100] Discarding unused printer-state-changed event...
D [18/Jul/2011:17:01:45 +0100] [Job 141] STATE: -connecting-to-device
D [18/Jul/2011:17:01:45 +0100] Discarding unused printer-state-changed event...
D [18/Jul/2011:17:01:45 +0100] [Job 141] Page = 595x842; 18,36 to 577,806
D [18/Jul/2011:17:01:45 +0100] [Job 141] slow_collate=0, slow_duplex=0, slow_order=0
D [18/Jul/2011:17:01:45 +0100] [Job 141] Before copy_comments - %!PS-Adobe-3.0
D [18/Jul/2011:17:01:45 +0100] [Job 141] %!PS-Adobe-3.0
D [18/Jul/2011:17:01:45 +0100] [Job 141] %%BoundingBox: (atend)
D [18/Jul/2011:17:01:45 +0100] [Job 141] %%Creator: (LibreOffice 3.3)
D [18/Jul/2011:17:01:45 +0100] [Job 141] %%For: (john)
D [18/Jul/2011:17:01:45 +0100] [Job 141] %%CreationDate: (Mon Jul 18 17:01:44 2011)
D [18/Jul/2011:17:01:45 +0100] [Job 141] %%Title: (One to One 1107)
D [18/Jul/2011:17:01:45 +0100] [Job 141] %%LanguageLevel: 2
D [18/Jul/2011:17:01:45 +0100] [Job 141] %%DocumentData: Clean7Bit
D [18/Jul/2011:17:01:45 +0100] [Job 141] %%Pages: (atend)
D [18/Jul/2011:17:01:45 +0100] [Job 141] %%Orientation: (atend)
D [18/Jul/2011:17:01:45 +0100] [Job 141] %%PageOrder: Ascend
D [18/Jul/2011:17:01:45 +0100] [Job 141] %%EndComments
D [18/Jul/2011:17:01:45 +0100] [Job 141] Before copy_prolog - %%BeginProlog
D [18/Jul/2011:17:01:45 +0100] [Job 141] Before copy_setup - %%BeginSetup
D [18/Jul/2011:17:01:53 +0100] [Job 141] Before page loop - %%Page: 1 1
D [18/Jul/2011:17:01:53 +0100] [Job 141] Copying page 1...
D [18/Jul/2011:17:01:53 +0100] [Job 141] PAGE: 1 1
D [18/Jul/2011:17:01:53 +0100] Discarding unused job-progress event...
D [18/Jul/2011:17:01:53 +0100] [Job 141] pagew = 559.0, pagel = 770.0
D [18/Jul/2011:17:01:53 +0100] [Job 141] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842
D [18/Jul/2011:17:01:53 +0100] [Job 141] PageLeft = 18.0, PageRight = 577.0
D [18/Jul/2011:17:01:53 +0100] [Job 141] PageTop = 806.0, PageBottom = 36.0
D [18/Jul/2011:17:01:53 +0100] [Job 141] PageWidth = 595.0, PageLength = 842.0
D [18/Jul/2011:17:01:55 +0100] [Job 141] Copying page 2...
D [18/Jul/2011:17:01:55 +0100] [Job 141] PAGE: 2 1
D [18/Jul/2011:17:01:55 +0100] Discarding unused job-progress event...
D [18/Jul/2011:17:01:55 +0100] [Job 141] pagew = 559.0, pagel = 770.0
D [18/Jul/2011:17:01:55 +0100] [Job 141] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842
D [18/Jul/2011:17:01:55 +0100] [Job 141] PageLeft = 18.0, PageRight = 577.0
D [18/Jul/2011:17:01:55 +0100] [Job 141] PageTop = 806.0, PageBottom = 36.0
D [18/Jul/2011:17:01:55 +0100] [Job 141] PageWidth = 595.0, PageLength = 842.0
D [18/Jul/2011:17:01:55 +0100] [Job 141] Copying page 3...
D [18/Jul/2011:17:01:55 +0100] [Job 141] PAGE: 3 1
D [18/Jul/2011:17:01:55 +0100] Discarding unused job-progress event...
D [18/Jul/2011:17:01:55 +0100] [Job 141] pagew = 559.0, pagel = 770.0
D [18/Jul/2011:17:01:55 +0100] [Job 141] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842
D [18/Jul/2011:17:01:55 +0100] [Job 141] PageLeft = 18.0, PageRight = 577.0
D [18/Jul/2011:17:01:55 +0100] [Job 141] PageTop = 806.0, PageBottom = 36.0
D [18/Jul/2011:17:01:55 +0100] [Job 141] PageWidth = 595.0, PageLength = 842.0
D [18/Jul/2011:17:01:55 +0100] [Job 141] Copying page 4...
D [18/Jul/2011:17:01:55 +0100] [Job 141] PAGE: 4 1
D [18/Jul/2011:17:01:55 +0100] Discarding unused job-progress event...
D [18/Jul/2011:17:01:55 +0100] [Job 141] pagew = 559.0, pagel = 770.0
D [18/Jul/2011:17:01:55 +0100] [Job 141] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842
D [18/Jul/2011:17:01:55 +0100] [Job 141] PageLeft = 18.0, PageRight = 577.0
D [18/Jul/2011:17:01:55 +0100] [Job 141] PageTop = 806.0, PageBottom = 36.0
D [18/Jul/2011:17:01:55 +0100] [Job 141] PageWidth = 595.0, PageLength = 842.0
D [18/Jul/2011:17:01:55 +0100] [Job 141] Copying page 5...
D [18/Jul/2011:17:01:55 +0100] [Job 141] PAGE: 5 1
D [18/Jul/2011:17:01:55 +0100] Discarding unused job-progress event...
D [18/Jul/2011:17:01:55 +0100] [Job 141] pagew = 559.0, pagel = 770.0
D [18/Jul/2011:17:01:55 +0100] [Job 141] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842
D [18/Jul/2011:17:01:55 +0100] [Job 141] PageLeft = 18.0, PageRight = 577.0
D [18/Jul/2011:17:01:55 +0100] [Job 141] PageTop = 806.0, PageBottom = 36.0
D [18/Jul/2011:17:01:55 +0100] [Job 141] PageWidth = 595.0, PageLength = 842.0
D [18/Jul/2011:17:01:57 +0100] [Job 141] Copying page 6...
D [18/Jul/2011:17:01:57 +0100] [Job 141] PAGE: 6 1
D [18/Jul/2011:17:01:57 +0100] Discarding unused job-progress event...
D [18/Jul/2011:17:01:57 +0100] [Job 141] pagew = 559.0, pagel = 770.0
D [18/Jul/2011:17:01:57 +0100] [Job 141] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842
D [18/Jul/2011:17:01:57 +0100] [Job 141] PageLeft = 18.0, PageRight = 577.0
D [18/Jul/2011:17:01:57 +0100] [Job 141] PageTop = 806.0, PageBottom = 36.0
D [18/Jul/2011:17:01:57 +0100] [Job 141] PageWidth = 595.0, PageLength = 842.0
D [18/Jul/2011:17:01:58 +0100] [Job 141] Copying page 7...
D [18/Jul/2011:17:01:58 +0100] [Job 141] PAGE: 7 1
D [18/Jul/2011:17:01:58 +0100] Discarding unused job-progress event...
D [18/Jul/2011:17:01:58 +0100] [Job 141] pagew = 559.0, pagel = 770.0
D [18/Jul/2011:17:01:58 +0100] [Job 141] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842
D [18/Jul/2011:17:01:58 +0100] [Job 141] PageLeft = 18.0, PageRight = 577.0
D [18/Jul/2011:17:01:58 +0100] [Job 141] PageTop = 806.0, PageBottom = 36.0
D [18/Jul/2011:17:01:58 +0100] [Job 141] PageWidth = 595.0, PageLength = 842.0
D [18/Jul/2011:17:01:59 +0100] [Job 141] Copying page 8...
D [18/Jul/2011:17:01:59 +0100] [Job 141] PAGE: 8 1
D [18/Jul/2011:17:01:59 +0100] Discarding unused job-progress event...
D [18/Jul/2011:17:01:59 +0100] [Job 141] pagew = 559.0, pagel = 770.0
D [18/Jul/2011:17:01:59 +0100] [Job 141] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842
D [18/Jul/2011:17:01:59 +0100] [Job 141] PageLeft = 18.0, PageRight = 577.0
D [18/Jul/2011:17:01:59 +0100] [Job 141] PageTop = 806.0, PageBottom = 36.0
D [18/Jul/2011:17:01:59 +0100] [Job 141] PageWidth = 595.0, PageLength = 842.0
D [18/Jul/2011:17:02:01 +0100] [Job 141] Copying page 9...
D [18/Jul/2011:17:02:01 +0100] [Job 141] PAGE: 9 1
D [18/Jul/2011:17:02:01 +0100] Discarding unused job-progress event...
D [18/Jul/2011:17:02:01 +0100] [Job 141] pagew = 559.0, pagel = 770.0
D [18/Jul/2011:17:02:01 +0100] [Job 141] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842
D [18/Jul/2011:17:02:01 +0100] [Job 141] PageLeft = 18.0, PageRight = 577.0
D [18/Jul/2011:17:02:01 +0100] [Job 141] PageTop = 806.0, PageBottom = 36.0
D [18/Jul/2011:17:02:01 +0100] [Job 141] PageWidth = 595.0, PageLength = 842.0
D [18/Jul/2011:17:02:01 +0100] [Job 141] Copying page 10...
D [18/Jul/2011:17:02:01 +0100] [Job 141] PAGE: 10 1
D [18/Jul/2011:17:02:01 +0100] Discarding unused job-progress event...
D [18/Jul/2011:17:02:01 +0100] [Job 141] pagew = 559.0, pagel = 770.0
D [18/Jul/2011:17:02:01 +0100] [Job 141] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842
D [18/Jul/2011:17:02:01 +0100] [Job 141] PageLeft = 18.0, PageRight = 577.0
D [18/Jul/2011:17:02:01 +0100] [Job 141] PageTop = 806.0, PageBottom = 36.0
D [18/Jul/2011:17:02:01 +0100] [Job 141] PageWidth = 595.0, PageLength = 842.0
D [18/Jul/2011:17:02:03 +0100] [Job 141] Wrote 10 pages...
D [18/Jul/2011:17:02:03 +0100] PID 7280 (/usr/lib/cups/filter/pstops) exited with no errors.
I [18/Jul/2011:17:02:16 +0100] Saving job cache file "/var/cache/cups/job.cache"...
D [18/Jul/2011:17:02:16 +0100] cupsdSetBusyState: Printing jobs
D [18/Jul/2011:17:02:37 +0100] Report: clients=1
D [18/Jul/2011:17:02:37 +0100] Report: jobs=118
D [18/Jul/2011:17:02:37 +0100] Report: jobs-active=1
D [18/Jul/2011:17:02:37 +0100] Report: printers=1
D [18/Jul/2011:17:02:37 +0100] Report: printers-implicit=0
D [18/Jul/2011:17:02:37 +0100] Report: stringpool-string-count=4183
D [18/Jul/2011:17:02:37 +0100] Report: stringpool-alloc-bytes=11008
D [18/Jul/2011:17:02:37 +0100] Report: stringpool-total-bytes=78352
D [18/Jul/2011:17:02:37 +0100] PID 7281 (/usr/lib/cups/backend/usb) exited with no errors.
D [18/Jul/2011:17:02:37 +0100] Discarding unused job-completed event...
I [18/Jul/2011:17:02:37 +0100] [Job 141] Job completed.
D [18/Jul/2011:17:02:37 +0100] cupsdMarkDirty(----J-)
D [18/Jul/2011:17:02:37 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [18/Jul/2011:17:02:37 +0100] Discarding unused printer-state-changed event...
D [18/Jul/2011:17:02:38 +0100] [Job 141] Unloading...