Apps dont print / wrong filters applied?

allesquarks allesquarks at gmx.de
Wed Feb 22 10:09:50 PST 2012 

Hello,

Im running a Suse 12.1 and wanted to use our network printers in the office. Yast and cups testpages work fine. Also printing via lpr, however printing from any (GUI) application doesn't work. In the cups webinterface the jobs are scheduled but the job remains at "connected to printer" and the canon printer keeps blinking in the state receiving forever...
Since the raw data are printed I think it is a filter problem. Below I attached logs of a print job from an application and afterwards from lpr. I don't know if its important but though I print an image pdftops is applied as a filter (But printing pdf's doesn't work as well).

Any help would be gladly appreciated
allesquarks


D [22/Feb/2012:18:40:14 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [22/Feb/2012:18:40:14 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [22/Feb/2012:18:40:14 +0100] cupsdReadClient: 16 POST / HTTP/1.1
D [22/Feb/2012:18:40:14 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [22/Feb/2012:18:40:14 +0100] cupsdAuthorize: No authentication data provided.
D [22/Feb/2012:18:40:14 +0100] cupsdReadClient: 16 1.1 CUPS-Get-Default 1
D [22/Feb/2012:18:40:14 +0100] CUPS-Get-Default
D [22/Feb/2012:18:40:14 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [22/Feb/2012:18:40:14 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [22/Feb/2012:18:40:14 +0100] cupsdReadClient: 16 POST /printers/canon_iR_2870 HTTP/1.1
D [22/Feb/2012:18:40:14 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [22/Feb/2012:18:40:14 +0100] cupsdAuthorize: No authentication data provided.
D [22/Feb/2012:18:40:14 +0100] cupsdReadClient: 16 1.1 Create-Job 1
D [22/Feb/2012:18:40:14 +0100] Create-Job ipp://localhost:631/printers/canon_iR_2870
D [22/Feb/2012:18:40:14 +0100] cupsdMarkDirty(----J-)
D [22/Feb/2012:18:40:14 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients"
D [22/Feb/2012:18:40:14 +0100] add_job: requesting-user-name="raphael"
D [22/Feb/2012:18:40:14 +0100] Adding default job-sheets values "none,none"...
I [22/Feb/2012:18:40:14 +0100] [Job 27] Adding start banner page "none".
D [22/Feb/2012:18:40:14 +0100] Discarding unused job-created event...
I [22/Feb/2012:18:40:14 +0100] [Job 27] Queued on "canon_iR_2870" by "raphael".
D [22/Feb/2012:18:40:14 +0100] Returning IPP successful-ok for Create-Job (ipp://localhost:631/printers/canon_iR_2870) from localhost
D [22/Feb/2012:18:40:14 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [22/Feb/2012:18:40:14 +0100] cupsdReadClient: 16 POST /printers/canon_iR_2870 HTTP/1.1
D [22/Feb/2012:18:40:14 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [22/Feb/2012:18:40:14 +0100] cupsdAuthorize: No authentication data provided.
D [22/Feb/2012:18:40:14 +0100] cupsdReadClient: 16 1.1 Send-Document 1
D [22/Feb/2012:18:40:14 +0100] Send-Document ipp://localhost:631/printers/canon_iR_2870
D [22/Feb/2012:18:40:14 +0100] cupsdIsAuthorized: requesting-user-name="raphael"
D [22/Feb/2012:18:40:14 +0100] [Job 27] Auto-typing file...
D [22/Feb/2012:18:40:14 +0100] [Job 27] Request file type is application/pdf.
D [22/Feb/2012:18:40:14 +0100] cupsdMarkDirty(----J-)
D [22/Feb/2012:18:40:14 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [22/Feb/2012:18:40:14 +0100] [Job 27] File of type application/pdf queued by "raphael".
I [22/Feb/2012:18:40:14 +0100] [Job 27] Adding end banner page "none".
D [22/Feb/2012:18:40:14 +0100] cupsdMarkDirty(----J-)
D [22/Feb/2012:18:40:14 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [22/Feb/2012:18:40:14 +0100] cupsdMarkDirty(----J-)
D [22/Feb/2012:18:40:14 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [22/Feb/2012:18:40:14 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [22/Feb/2012:18:40:14 +0100] Discarding unused printer-state-changed event...
D [22/Feb/2012:18:40:14 +0100] [Job 27] job-sheets=none,none
D [22/Feb/2012:18:40:14 +0100] [Job 27] argv[0]="canon_iR_2870"
D [22/Feb/2012:18:40:14 +0100] [Job 27] argv[1]="27"
D [22/Feb/2012:18:40:14 +0100] [Job 27] argv[2]="raphael"
D [22/Feb/2012:18:40:14 +0100] [Job 27] argv[3]="praktikum002.jpg"
D [22/Feb/2012:18:40:14 +0100] [Job 27] argv[4]="1"
D [22/Feb/2012:18:40:14 +0100] [Job 27] argv[5]="media=A4 Collate job-uuid=urn:uuid:27773f61-8ad6-3eeb-41fa-5f43549ee455 job-originating-host-name=localhost time-at-creation=1329932414 time-at-processing=1329932414 AP_D_InputSlot= PageSize=A4"
D [22/Feb/2012:18:40:14 +0100] [Job 27] argv[6]="/var/spool/cups/d00027-001"
D [22/Feb/2012:18:40:14 +0100] [Job 27] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [22/Feb/2012:18:40:14 +0100] [Job 27] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [22/Feb/2012:18:40:14 +0100] [Job 27] envp[2]="CUPS_DOCROOT=/usr/share/cups/webcontent"
D [22/Feb/2012:18:40:14 +0100] [Job 27] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [22/Feb/2012:18:40:14 +0100] [Job 27] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [22/Feb/2012:18:40:14 +0100] [Job 27] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [22/Feb/2012:18:40:14 +0100] [Job 27] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [22/Feb/2012:18:40:14 +0100] [Job 27] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [22/Feb/2012:18:40:14 +0100] [Job 27] envp[8]="HOME=/var/spool/cups/tmp"
D [22/Feb/2012:18:40:14 +0100] [Job 27] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [22/Feb/2012:18:40:14 +0100] [Job 27] envp[10]="SERVER_ADMIN=root at Schleppi-Linux"
D [22/Feb/2012:18:40:14 +0100] [Job 27] envp[11]="SOFTWARE=CUPS/1.5.0"
D [22/Feb/2012:18:40:14 +0100] [Job 27] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [22/Feb/2012:18:40:14 +0100] [Job 27] envp[13]="USER=root"
D [22/Feb/2012:18:40:14 +0100] [Job 27] envp[14]="CUPS_SERVER=/var/run/cups/cups.sock"
D [22/Feb/2012:18:40:14 +0100] [Job 27] envp[15]="CUPS_ENCRYPTION=IfRequested"
D [22/Feb/2012:18:40:14 +0100] [Job 27] envp[16]="IPP_PORT=631"
D [22/Feb/2012:18:40:14 +0100] [Job 27] envp[17]="CHARSET=utf-8"
D [22/Feb/2012:18:40:14 +0100] [Job 27] envp[18]="LANG=de_DE.UTF-8"
D [22/Feb/2012:18:40:14 +0100] [Job 27] envp[19]="PPD=/etc/cups/ppd/canon_iR_2870.ppd"
D [22/Feb/2012:18:40:14 +0100] [Job 27] envp[20]="RIP_MAX_CACHE=128m"
D [22/Feb/2012:18:40:14 +0100] [Job 27] envp[21]="CONTENT_TYPE=application/pdf"
D [22/Feb/2012:18:40:14 +0100] [Job 27] envp[22]="DEVICE_URI=socket://141.20.41.86:9100"
D [22/Feb/2012:18:40:14 +0100] [Job 27] envp[23]="PRINTER_INFO=Canon iR2270/iR2870 UFR II ver.2.1"
D [22/Feb/2012:18:40:14 +0100] [Job 27] envp[24]="PRINTER_LOCATION="
D [22/Feb/2012:18:40:14 +0100] [Job 27] envp[25]="PRINTER=canon_iR_2870"
D [22/Feb/2012:18:40:14 +0100] [Job 27] envp[26]="PRINTER_STATE_REASONS=none"
D [22/Feb/2012:18:40:14 +0100] [Job 27] envp[27]="CUPS_FILETYPE=document"
D [22/Feb/2012:18:40:14 +0100] [Job 27] envp[28]="FINAL_CONTENT_TYPE=printer/canon_iR_2870"
D [22/Feb/2012:18:40:14 +0100] [Job 27] envp[29]="AUTH_I****"
I [22/Feb/2012:18:40:14 +0100] [Job 27] Started filter /usr/lib/cups/filter/pdftops (PID 28228)
I [22/Feb/2012:18:40:14 +0100] [Job 27] Started filter /usr/lib/cups/filter/pstoufr2cpca (PID 28229)
I [22/Feb/2012:18:40:14 +0100] [Job 27] Started backend /usr/lib/cups/backend/socket (PID 28230)
D [22/Feb/2012:18:40:14 +0100] Discarding unused job-state-changed event...
D [22/Feb/2012:18:40:14 +0100] Returning IPP successful-ok for Send-Document (ipp://localhost:631/printers/canon_iR_2870) from localhost
D [22/Feb/2012:18:40:14 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients and dirty files"
D [22/Feb/2012:18:40:14 +0100] [Job 27] pstoufr2cpca start.
D [22/Feb/2012:18:40:14 +0100] [Job 27] STATE: +connecting-to-device
D [22/Feb/2012:18:40:14 +0100] [Job 27] Looking up "141.20.41.86"...
D [22/Feb/2012:18:40:14 +0100] Discarding unused printer-state-changed event...
D [22/Feb/2012:18:40:14 +0100] [Job 27] Started filter pdftops (PID 28231)
D [22/Feb/2012:18:40:14 +0100] [Job 27] Started filter pstops (PID 28232)
D [22/Feb/2012:18:40:14 +0100] [Job 27] ATTR: marker-colors=#000000,none
D [22/Feb/2012:18:40:14 +0100] cupsdMarkDirty(P-----)
D [22/Feb/2012:18:40:14 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Printing jobs and dirty files"
D [22/Feb/2012:18:40:14 +0100] [Job 27] ATTR: marker-names="Black Toner","Waste Toner"
D [22/Feb/2012:18:40:14 +0100] cupsdMarkDirty(P-----)
D [22/Feb/2012:18:40:14 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [22/Feb/2012:18:40:14 +0100] [Job 27] ATTR: marker-types=toner,wasteToner
D [22/Feb/2012:18:40:14 +0100] cupsdMarkDirty(P-----)
D [22/Feb/2012:18:40:14 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [22/Feb/2012:18:40:14 +0100] [Job 27] ATTR: marker-levels=100,100
D [22/Feb/2012:18:40:14 +0100] cupsdMarkDirty(P-----)
D [22/Feb/2012:18:40:14 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [22/Feb/2012:18:40:14 +0100] [Job 27] new_supply_state=0, change_state=ffff
D [22/Feb/2012:18:40:14 +0100] Discarding unused printer-state-changed event...
D [22/Feb/2012:18:40:14 +0100] [Job 27] STATE: -developer-low-report
D [22/Feb/2012:18:40:14 +0100] [Job 27] STATE: -developer-empty-warning
D [22/Feb/2012:18:40:14 +0100] [Job 27] STATE: -marker-supply-low-report
D [22/Feb/2012:18:40:14 +0100] [Job 27] STATE: -marker-supply-empty-warning
D [22/Feb/2012:18:40:14 +0100] [Job 27] STATE: -opc-near-eol-report
D [22/Feb/2012:18:40:14 +0100] [Job 27] STATE: -opc-life-over-warning
D [22/Feb/2012:18:40:14 +0100] [Job 27] STATE: -toner-low-report
D [22/Feb/2012:18:40:14 +0100] [Job 27] STATE: -toner-empty-warning
D [22/Feb/2012:18:40:14 +0100] [Job 27] Page = 595x842; 14,14 to 581,828
D [22/Feb/2012:18:40:14 +0100] [Job 27] slow_collate=0, slow_duplex=0, slow_order=0
D [22/Feb/2012:18:40:14 +0100] [Job 27] Before copy_comments - %!PS-Adobe-3.0
D [22/Feb/2012:18:40:14 +0100] [Job 27] %!PS-Adobe-3.0
D [22/Feb/2012:18:40:14 +0100] [Job 27] % Produced by poppler pdftops version: 0.18.0 (http://poppler.freedesktop.org)
D [22/Feb/2012:18:40:14 +0100] [Job 27] %%Creator:
D [22/Feb/2012:18:40:14 +0100] [Job 27] %%LanguageLevel: 3
D [22/Feb/2012:18:40:14 +0100] [Job 27] %%DocumentSuppliedResources: (atend)
D [22/Feb/2012:18:40:14 +0100] [Job 27] %%DocumentMedia: plain 595 842 0 () ()
D [22/Feb/2012:18:40:14 +0100] [Job 27] %%BoundingBox: 0 0 595 842
D [22/Feb/2012:18:40:14 +0100] [Job 27] %%Pages: 1
D [22/Feb/2012:18:40:14 +0100] [Job 27] %%EndComments
D [22/Feb/2012:18:40:14 +0100] [Job 27] Before copy_prolog - %%BeginDefaults
D [22/Feb/2012:18:40:14 +0100] [Job 27] Before copy_setup - %%BeginSetup
D [22/Feb/2012:18:40:14 +0100] [Job 27] Before page loop - %%Page: 1 1
D [22/Feb/2012:18:40:14 +0100] [Job 27] Copying page 1...
D [22/Feb/2012:18:40:14 +0100] [Job 27] pagew = 566.9, pagel = 813.5
D [22/Feb/2012:18:40:14 +0100] [Job 27] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842
D [22/Feb/2012:18:40:14 +0100] [Job 27] PageLeft = 14.2, PageRight = 581.1
D [22/Feb/2012:18:40:14 +0100] [Job 27] PageTop = 827.8, PageBottom = 14.3
D [22/Feb/2012:18:40:14 +0100] [Job 27] PageWidth = 595.0, PageLength = 842.0
D [22/Feb/2012:18:40:14 +0100] [Job 27] new_state=0, change_state=ffff
D [22/Feb/2012:18:40:14 +0100] [Job 27] STATE: -media-low-report
D [22/Feb/2012:18:40:14 +0100] [Job 27] STATE: -media-empty-warning
D [22/Feb/2012:18:40:14 +0100] [Job 27] STATE: -door-open-report
D [22/Feb/2012:18:40:14 +0100] [Job 27] STATE: -media-jam-warning
D [22/Feb/2012:18:40:14 +0100] [Job 27] STATE: -input-tray-missing-warning
D [22/Feb/2012:18:40:14 +0100] [Job 27] STATE: -output-tray-missing-warning
D [22/Feb/2012:18:40:14 +0100] [Job 27] STATE: -marker-supply-missing-warning
D [22/Feb/2012:18:40:14 +0100] [Job 27] STATE: -output-area-almost-full-report
D [22/Feb/2012:18:40:14 +0100] [Job 27] STATE: -output-area-full-warning
D [22/Feb/2012:18:40:14 +0100] [Job 27] backendWaitLoop(snmp_fd=5, addr=0x7fd343afb938, side_cb=0x7fd3438f0020)
D [22/Feb/2012:18:40:14 +0100] [Job 27] opvpOpenPrinter(463)
D [22/Feb/2012:18:40:14 +0100] [Job 27] CStubOpenPrinter(397)
D [22/Feb/2012:18:40:14 +0100] [Job 27] opvpOpenPrinter(463)
D [22/Feb/2012:18:40:14 +0100] [Job 27] CStubOpenPrinter(397)
D [22/Feb/2012:18:40:14 +0100] [Job 27] Connecting to 141.20.41.86:9100
I [22/Feb/2012:18:40:14 +0100] [Job 27] Connecting to printer.
D [22/Feb/2012:18:40:14 +0100] [Job 27] Set job-printer-state-message to "Connecting to printer.", current level=INFO
D [22/Feb/2012:18:40:14 +0100] Discarding unused job-progress event...
D [22/Feb/2012:18:40:14 +0100] Discarding unused printer-state-changed event...
D [22/Feb/2012:18:40:14 +0100] [Job 27] STATE: -connecting-to-device
D [22/Feb/2012:18:40:14 +0100] Discarding unused printer-state-changed event...
I [22/Feb/2012:18:40:14 +0100] [Job 27] Connected to printer.
D [22/Feb/2012:18:40:14 +0100] [Job 27] Set job-printer-state-message to "Connected to printer.", current level=INFO
D [22/Feb/2012:18:40:14 +0100] [Job 27] Connected to 141.20.41.86:9100...
D [22/Feb/2012:18:40:14 +0100] [Job 27] backendRunLoop(print_fd=0, device_fd=6, snmp_fd=5, addr=0x7fd343afb938, use_bc=1, side_cb=0x7fd3438f0020)
D [22/Feb/2012:18:40:14 +0100] Discarding unused job-progress event...
D [22/Feb/2012:18:40:14 +0100] Discarding unused printer-state-changed event...
D [22/Feb/2012:18:40:15 +0100] cupsdReadClient: 15 WAITING Closing on EOF
D [22/Feb/2012:18:40:15 +0100] cupsdCloseClient: 15
D [22/Feb/2012:18:40:15 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Dirty files"
D [22/Feb/2012:18:40:15 +0100] cupsdReadClient: 14 WAITING Closing on EOF
D [22/Feb/2012:18:40:15 +0100] cupsdCloseClient: 14
D [22/Feb/2012:18:40:15 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [22/Feb/2012:18:40:15 +0100] cupsdReadClient: 13 WAITING Closing on EOF
D [22/Feb/2012:18:40:15 +0100] cupsdCloseClient: 13
D [22/Feb/2012:18:40:15 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [22/Feb/2012:18:40:19 +0100] [Job 27] ATTR: marker-levels=100,100
D [22/Feb/2012:18:40:19 +0100] cupsdMarkDirty(P-----)
D [22/Feb/2012:18:40:19 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [22/Feb/2012:18:40:19 +0100] [Job 27] new_supply_state=0, change_state=0
D [22/Feb/2012:18:40:19 +0100] Discarding unused printer-state-changed event...
D [22/Feb/2012:18:40:19 +0100] [Job 27] new_state=0, change_state=0
D [22/Feb/2012:18:40:24 +0100] [Job 27] ATTR: marker-levels=100,100
D [22/Feb/2012:18:40:24 +0100] cupsdMarkDirty(P-----)
D [22/Feb/2012:18:40:24 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [22/Feb/2012:18:40:24 +0100] [Job 27] new_supply_state=0, change_state=0
D [22/Feb/2012:18:40:24 +0100] Discarding unused printer-state-changed event...
D [22/Feb/2012:18:40:24 +0100] [Job 27] new_state=0, change_state=0
D [22/Feb/2012:18:40:29 +0100] [Job 27] ATTR: marker-levels=100,100
D [22/Feb/2012:18:40:29 +0100] cupsdMarkDirty(P-----)
D [22/Feb/2012:18:40:29 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [22/Feb/2012:18:40:29 +0100] [Job 27] new_supply_state=0, change_state=0
D [22/Feb/2012:18:40:29 +0100] Discarding unused printer-state-changed event...
D [22/Feb/2012:18:40:29 +0100] [Job 27] new_state=0, change_state=0
D [22/Feb/2012:18:40:34 +0100] [Job 27] ATTR: marker-levels=100,100
D [22/Feb/2012:18:40:34 +0100] cupsdMarkDirty(P-----)
D [22/Feb/2012:18:40:34 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [22/Feb/2012:18:40:34 +0100] [Job 27] new_supply_state=0, change_state=0
D [22/Feb/2012:18:40:34 +0100] Discarding unused printer-state-changed event...
D [22/Feb/2012:18:40:34 +0100] [Job 27] new_state=0, change_state=0
D [22/Feb/2012:18:40:39 +0100] [Job 27] ATTR: marker-levels=100,100
D [22/Feb/2012:18:40:39 +0100] cupsdMarkDirty(P-----)
D [22/Feb/2012:18:40:39 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [22/Feb/2012:18:40:39 +0100] [Job 27] new_supply_state=0, change_state=0
D [22/Feb/2012:18:40:39 +0100] Discarding unused printer-state-changed event...
D [22/Feb/2012:18:40:39 +0100] [Job 27] new_state=0, change_state=0
I [22/Feb/2012:18:40:44 +0100] Saving printers.conf...
I [22/Feb/2012:18:40:44 +0100] Saving job.cache...
D [22/Feb/2012:18:40:44 +0100] cupsdSetBusyState: newbusy="Printing jobs", busy="Printing jobs and dirty files"
D [22/Feb/2012:18:40:44 +0100] Report: clients=1
D [22/Feb/2012:18:40:44 +0100] Report: jobs=22
D [22/Feb/2012:18:40:44 +0100] Report: jobs-active=1
D [22/Feb/2012:18:40:44 +0100] Report: printers=2
D [22/Feb/2012:18:40:44 +0100] Report: printers-implicit=0
D [22/Feb/2012:18:40:44 +0100] Report: stringpool-string-count=44451
D [22/Feb/2012:18:40:44 +0100] Report: stringpool-alloc-bytes=13960
D [22/Feb/2012:18:40:44 +0100] Report: stringpool-total-bytes=837648
D [22/Feb/2012:18:40:44 +0100] [Job 27] ATTR: marker-levels=100,100
D [22/Feb/2012:18:40:44 +0100] cupsdMarkDirty(P-----)
D [22/Feb/2012:18:40:44 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs"
D [22/Feb/2012:18:40:44 +0100] [Job 27] new_supply_state=0, change_state=0
D [22/Feb/2012:18:40:44 +0100] [Job 27] new_state=0, change_state=0
D [22/Feb/2012:18:40:44 +0100] Discarding unused printer-state-changed event...
D [22/Feb/2012:18:40:49 +0100] [Job 27] ATTR: marker-levels=100,100
D [22/Feb/2012:18:40:49 +0100] cupsdMarkDirty(P-----)
D [22/Feb/2012:18:40:49 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [22/Feb/2012:18:40:49 +0100] [Job 27] new_supply_state=0, change_state=0
D [22/Feb/2012:18:40:49 +0100] Discarding unused printer-state-changed event...
D [22/Feb/2012:18:40:49 +0100] [Job 27] new_state=0, change_state=0
D [22/Feb/2012:18:40:54 +0100] [Job 27] ATTR: marker-levels=100,100
D [22/Feb/2012:18:40:54 +0100] cupsdMarkDirty(P-----)
D [22/Feb/2012:18:40:54 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [22/Feb/2012:18:40:54 +0100] [Job 27] new_supply_state=0, change_state=0
D [22/Feb/2012:18:40:54 +0100] Discarding unused printer-state-changed event...
D [22/Feb/2012:18:40:54 +0100] [Job 27] new_state=0, change_state=0
D [22/Feb/2012:18:40:59 +0100] [Job 27] ATTR: marker-levels=100,100
D [22/Feb/2012:18:40:59 +0100] cupsdMarkDirty(P-----)
D [22/Feb/2012:18:40:59 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [22/Feb/2012:18:40:59 +0100] [Job 27] new_supply_state=0, change_state=0
D [22/Feb/2012:18:40:59 +0100] Discarding unused printer-state-changed event...
D [22/Feb/2012:18:40:59 +0100] [Job 27] new_state=0, change_state=0
D [22/Feb/2012:18:41:04 +0100] [Job 27] ATTR: marker-levels=100,100
D [22/Feb/2012:18:41:04 +0100] cupsdMarkDirty(P-----)
D [22/Feb/2012:18:41:04 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [22/Feb/2012:18:41:04 +0100] [Job 27] new_supply_state=0, change_state=0
D [22/Feb/2012:18:41:04 +0100] Discarding unused printer-state-changed event...
D [22/Feb/2012:18:41:04 +0100] [Job 27] new_state=0, change_state=0















cupsdReadClient: 14 GET /jobs/ HTTP/1.1
D [22/Feb/2012:18:48:42 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Printing jobs and dirty files"
D [22/Feb/2012:18:48:42 +0100] cupsdAuthorize: Authorized as raphael using Basic
D [22/Feb/2012:18:48:42 +0100] [CGI] argv[0] = "/usr/lib/cups/cgi-bin/jobs.cgi"
D [22/Feb/2012:18:48:42 +0100] [CGI] envp[0] = "CUPS_CACHEDIR=/var/cache/cups"
D [22/Feb/2012:18:48:42 +0100] [CGI] envp[1] = "CUPS_DATADIR=/usr/share/cups"
D [22/Feb/2012:18:48:42 +0100] [CGI] envp[2] = "CUPS_DOCROOT=/usr/share/cups/webcontent"
D [22/Feb/2012:18:48:42 +0100] [CGI] envp[3] = "CUPS_FONTPATH=/usr/share/cups/fonts"
D [22/Feb/2012:18:48:42 +0100] [CGI] envp[4] = "CUPS_REQUESTROOT=/var/spool/cups"
D [22/Feb/2012:18:48:42 +0100] [CGI] envp[5] = "CUPS_SERVERBIN=/usr/lib/cups"
D [22/Feb/2012:18:48:42 +0100] [CGI] envp[6] = "CUPS_SERVERROOT=/etc/cups"
D [22/Feb/2012:18:48:42 +0100] [CGI] envp[7] = "CUPS_STATEDIR=/var/run/cups"
D [22/Feb/2012:18:48:42 +0100] [CGI] envp[8] = "HOME=/var/spool/cups/tmp"
D [22/Feb/2012:18:48:42 +0100] [CGI] envp[9] = "PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [22/Feb/2012:18:48:42 +0100] [CGI] envp[10] = "SERVER_ADMIN=root at Schleppi-Linux"
D [22/Feb/2012:18:48:42 +0100] [CGI] envp[11] = "SOFTWARE=CUPS/1.5.0"
D [22/Feb/2012:18:48:42 +0100] [CGI] envp[12] = "TMPDIR=/var/spool/cups/tmp"
D [22/Feb/2012:18:48:42 +0100] [CGI] envp[13] = "USER=root"
D [22/Feb/2012:18:48:42 +0100] [CGI] envp[14] = "CUPS_SERVER=/var/run/cups/cups.sock"
D [22/Feb/2012:18:48:42 +0100] [CGI] envp[15] = "CUPS_ENCRYPTION=IfRequested"
D [22/Feb/2012:18:48:42 +0100] [CGI] envp[16] = "IPP_PORT=631"
D [22/Feb/2012:18:48:42 +0100] [CGI] envp[17] = "AUTH_TYPE=Basic"
D [22/Feb/2012:18:48:42 +0100] [CGI] envp[18] = "LANG=de_DE.UTF8"
D [22/Feb/2012:18:48:42 +0100] [CGI] envp[19] = "REDIRECT_STATUS=1"
D [22/Feb/2012:18:48:42 +0100] [CGI] envp[20] = "GATEWAY_INTERFACE=CGI/1.1"
D [22/Feb/2012:18:48:42 +0100] [CGI] envp[21] = "SERVER_NAME=localhost"
D [22/Feb/2012:18:48:42 +0100] [CGI] envp[22] = "SERVER_PORT=631"
D [22/Feb/2012:18:48:42 +0100] [CGI] envp[23] = "REMOTE_ADDR=[v1.::1]"
D [22/Feb/2012:18:48:42 +0100] [CGI] envp[24] = "REMOTE_HOST=localhost"
D [22/Feb/2012:18:48:42 +0100] [CGI] envp[25] = "SCRIPT_NAME=/jobs/"
D [22/Feb/2012:18:48:42 +0100] [CGI] envp[26] = "SCRIPT_FILENAME=/usr/share/cups/webcontent/jobs/"
D [22/Feb/2012:18:48:42 +0100] [CGI] envp[27] = "REMOTE_USER=raphael"
D [22/Feb/2012:18:48:42 +0100] [CGI] envp[28] = "SERVER_PROTOCOL=HTTP/1.1"
D [22/Feb/2012:18:48:42 +0100] [CGI] envp[29] = "HTTP_COOKIE=org.cups.sid=40c8901491376893f87b4eb7f54b0bd4"
D [22/Feb/2012:18:48:42 +0100] [CGI] envp[30] = "HTTP_USER_AGENT=Mozilla/5.0 (X11; Linux x86_64; rv:10.0.1) Gecko/20100101 Firefox/10.0.1"
D [22/Feb/2012:18:48:42 +0100] [CGI] envp[31] = "REQUEST_METHOD=GET"
D [22/Feb/2012:18:48:42 +0100] [CGI] envp[32] = "QUERY_STRING="
D [22/Feb/2012:18:48:42 +0100] [CGI] Started /usr/lib/cups/cgi-bin/jobs.cgi (PID 28484)
I [22/Feb/2012:18:48:42 +0100] Started "/usr/lib/cups/cgi-bin/jobs.cgi" (pid=28484)
D [22/Feb/2012:18:48:42 +0100] cupsdSendCommand: 14 file=15
D [22/Feb/2012:18:48:42 +0100] [CGI] org.cups.sid cookie is "40c8901491376893f87b4eb7f54b0bd4"
D [22/Feb/2012:18:48:42 +0100] cupsdAcceptClient: 16 from localhost (Domain)
D [22/Feb/2012:18:48:42 +0100] Script header: Content-Type: text/html;charset=utf-8
D [22/Feb/2012:18:48:42 +0100] Script header:
D [22/Feb/2012:18:48:42 +0100] cupsdReadClient: 16 POST / HTTP/1.1
D [22/Feb/2012:18:48:42 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [22/Feb/2012:18:48:42 +0100] cupsdAuthorize: No authentication data provided.
D [22/Feb/2012:18:48:42 +0100] cupsdReadClient: 16 1.1 Get-Jobs 1
D [22/Feb/2012:18:48:42 +0100] Get-Jobs ipp://localhost/
D [22/Feb/2012:18:48:42 +0100] Returning IPP successful-ok for Get-Jobs (ipp://localhost/) from localhost
D [22/Feb/2012:18:48:42 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [22/Feb/2012:18:48:42 +0100] cupsdReadClient: 16 WAITING Closing on EOF
D [22/Feb/2012:18:48:42 +0100] cupsdCloseClient: 16
D [22/Feb/2012:18:48:42 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [22/Feb/2012:18:48:42 +0100] PID 28484 (/usr/lib/cups/cgi-bin/jobs.cgi) exited with no errors.
D [22/Feb/2012:18:48:42 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [22/Feb/2012:18:48:42 +0100] cupsdReadClient: 14 GET /cups.css HTTP/1.1
D [22/Feb/2012:18:48:42 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [22/Feb/2012:18:48:42 +0100] cupsdAuthorize: Authorized as raphael using Basic
D [22/Feb/2012:18:48:42 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [22/Feb/2012:18:48:42 +0100] cupsdAcceptClient: 15 from localhost:631 (IPv6)
D [22/Feb/2012:18:48:42 +0100] cupsdAcceptClient: 16 from localhost:631 (IPv6)
D [22/Feb/2012:18:48:42 +0100] cupsdReadClient: 15 GET /images/left.gif HTTP/1.1
D [22/Feb/2012:18:48:42 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [22/Feb/2012:18:48:42 +0100] cupsdAuthorize: Authorized as raphael using Basic
D [22/Feb/2012:18:48:42 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [22/Feb/2012:18:48:42 +0100] cupsdReadClient: 16 GET /images/right.gif HTTP/1.1
D [22/Feb/2012:18:48:42 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [22/Feb/2012:18:48:42 +0100] cupsdAuthorize: Authorized as raphael using Basic
D [22/Feb/2012:18:48:42 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [22/Feb/2012:18:48:42 +0100] cupsdReadClient: 14 GET /images/unsel.gif HTTP/1.1
D [22/Feb/2012:18:48:42 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [22/Feb/2012:18:48:42 +0100] cupsdAuthorize: Authorized as raphael using Basic
D [22/Feb/2012:18:48:42 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [22/Feb/2012:18:48:42 +0100] cupsdReadClient: 15 GET /images/sel.gif HTTP/1.1
D [22/Feb/2012:18:48:42 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [22/Feb/2012:18:48:42 +0100] cupsdAuthorize: Authorized as raphael using Basic
D [22/Feb/2012:18:48:42 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
I [22/Feb/2012:18:48:43 +0100] Saving printers.conf...
I [22/Feb/2012:18:48:43 +0100] Saving job.cache...
D [22/Feb/2012:18:48:43 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Dirty files"
D [22/Feb/2012:18:48:49 +0100] cupsdAcceptClient: 18 from localhost (Domain)
D [22/Feb/2012:18:48:49 +0100] cupsdReadClient: 18 POST / HTTP/1.1
D [22/Feb/2012:18:48:49 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [22/Feb/2012:18:48:49 +0100] cupsdAuthorize: No authentication data provided.
D [22/Feb/2012:18:48:49 +0100] cupsdReadClient: 18 1.1 Get-Printer-Attributes 1
D [22/Feb/2012:18:48:49 +0100] Get-Printer-Attributes ipp://localhost:631/printers/canon_iR_2870
D [22/Feb/2012:18:48:49 +0100] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost:631/printers/canon_iR_2870) from localhost
D [22/Feb/2012:18:48:49 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [22/Feb/2012:18:48:49 +0100] cupsdReadClient: 18 POST /printers/canon_iR_2870 HTTP/1.1
D [22/Feb/2012:18:48:49 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [22/Feb/2012:18:48:49 +0100] cupsdAuthorize: No authentication data provided.
D [22/Feb/2012:18:48:49 +0100] cupsdReadClient: 18 1.1 Create-Job 1
D [22/Feb/2012:18:48:49 +0100] Create-Job ipp://localhost:631/printers/canon_iR_2870
D [22/Feb/2012:18:48:49 +0100] cupsdMarkDirty(----J-)
D [22/Feb/2012:18:48:49 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients"
D [22/Feb/2012:18:48:49 +0100] add_job: requesting-user-name="raphael"
I [22/Feb/2012:18:48:49 +0100] [Job 30] Adding start banner page "none".
D [22/Feb/2012:18:48:49 +0100] Discarding unused job-created event...
I [22/Feb/2012:18:48:49 +0100] [Job 30] Queued on "canon_iR_2870" by "raphael".
D [22/Feb/2012:18:48:49 +0100] Returning IPP successful-ok for Create-Job (ipp://localhost:631/printers/canon_iR_2870) from localhost
D [22/Feb/2012:18:48:49 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
D [22/Feb/2012:18:48:49 +0100] cupsdReadClient: 18 POST /printers/canon_iR_2870 HTTP/1.1
D [22/Feb/2012:18:48:49 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [22/Feb/2012:18:48:49 +0100] cupsdAuthorize: No authentication data provided.
D [22/Feb/2012:18:48:49 +0100] cupsdReadClient: 18 1.1 Send-Document 1
D [22/Feb/2012:18:48:49 +0100] Send-Document ipp://localhost:631/printers/canon_iR_2870
D [22/Feb/2012:18:48:49 +0100] cupsdIsAuthorized: requesting-user-name="raphael"
D [22/Feb/2012:18:48:49 +0100] [Job 30] Auto-typing file...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Request file type is image/jpeg.
D [22/Feb/2012:18:48:49 +0100] cupsdMarkDirty(----J-)
D [22/Feb/2012:18:48:49 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [22/Feb/2012:18:48:49 +0100] [Job 30] File of type image/jpeg queued by "raphael".
I [22/Feb/2012:18:48:49 +0100] [Job 30] Adding end banner page "none".
D [22/Feb/2012:18:48:49 +0100] cupsdMarkDirty(----J-)
D [22/Feb/2012:18:48:49 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [22/Feb/2012:18:48:49 +0100] cupsdMarkDirty(----J-)
D [22/Feb/2012:18:48:49 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [22/Feb/2012:18:48:49 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [22/Feb/2012:18:48:49 +0100] Discarding unused printer-state-changed event...
D [22/Feb/2012:18:48:49 +0100] [Job 30] job-sheets=none,none
D [22/Feb/2012:18:48:49 +0100] [Job 30] argv[0]="canon_iR_2870"
D [22/Feb/2012:18:48:49 +0100] [Job 30] argv[1]="30"
D [22/Feb/2012:18:48:49 +0100] [Job 30] argv[2]="raphael"
D [22/Feb/2012:18:48:49 +0100] [Job 30] argv[3]="praktikum003.jpg"
D [22/Feb/2012:18:48:49 +0100] [Job 30] argv[4]="1"
D [22/Feb/2012:18:48:49 +0100] [Job 30] argv[5]="finishings=3 fit-to-page number-up=1 job-uuid=urn:uuid:b8d055b8-1dbc-385a-4f52-cda0b1dc5ccc job-originating-host-name=localhost time-at-creation=1329932929 time-at-processing=1329932929 AP_D_InputSlot="
D [22/Feb/2012:18:48:49 +0100] [Job 30] argv[6]="/var/spool/cups/d00030-001"
D [22/Feb/2012:18:48:49 +0100] [Job 30] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [22/Feb/2012:18:48:49 +0100] [Job 30] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [22/Feb/2012:18:48:49 +0100] [Job 30] envp[2]="CUPS_DOCROOT=/usr/share/cups/webcontent"
D [22/Feb/2012:18:48:49 +0100] [Job 30] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [22/Feb/2012:18:48:49 +0100] [Job 30] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [22/Feb/2012:18:48:49 +0100] [Job 30] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [22/Feb/2012:18:48:49 +0100] [Job 30] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [22/Feb/2012:18:48:49 +0100] [Job 30] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [22/Feb/2012:18:48:49 +0100] [Job 30] envp[8]="HOME=/var/spool/cups/tmp"
D [22/Feb/2012:18:48:49 +0100] [Job 30] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [22/Feb/2012:18:48:49 +0100] [Job 30] envp[10]="SERVER_ADMIN=root at Schleppi-Linux"
D [22/Feb/2012:18:48:49 +0100] [Job 30] envp[11]="SOFTWARE=CUPS/1.5.0"
D [22/Feb/2012:18:48:49 +0100] [Job 30] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [22/Feb/2012:18:48:49 +0100] [Job 30] envp[13]="USER=root"
D [22/Feb/2012:18:48:49 +0100] [Job 30] envp[14]="CUPS_SERVER=/var/run/cups/cups.sock"
D [22/Feb/2012:18:48:49 +0100] [Job 30] envp[15]="CUPS_ENCRYPTION=IfRequested"
D [22/Feb/2012:18:48:49 +0100] [Job 30] envp[16]="IPP_PORT=631"
D [22/Feb/2012:18:48:49 +0100] [Job 30] envp[17]="CHARSET=utf-8"
D [22/Feb/2012:18:48:49 +0100] [Job 30] envp[18]="LANG=de_DE.UTF-8"
D [22/Feb/2012:18:48:49 +0100] [Job 30] envp[19]="PPD=/etc/cups/ppd/canon_iR_2870.ppd"
D [22/Feb/2012:18:48:49 +0100] [Job 30] envp[20]="RIP_MAX_CACHE=128m"
D [22/Feb/2012:18:48:49 +0100] [Job 30] envp[21]="CONTENT_TYPE=image/jpeg"
D [22/Feb/2012:18:48:49 +0100] [Job 30] envp[22]="DEVICE_URI=socket://141.20.41.86:9100"
D [22/Feb/2012:18:48:49 +0100] [Job 30] envp[23]="PRINTER_INFO=Canon iR2270/iR2870 UFR II ver.2.1"
D [22/Feb/2012:18:48:49 +0100] [Job 30] envp[24]="PRINTER_LOCATION="
D [22/Feb/2012:18:48:49 +0100] [Job 30] envp[25]="PRINTER=canon_iR_2870"
D [22/Feb/2012:18:48:49 +0100] [Job 30] envp[26]="PRINTER_STATE_REASONS=none"
D [22/Feb/2012:18:48:49 +0100] [Job 30] envp[27]="CUPS_FILETYPE=document"
D [22/Feb/2012:18:48:49 +0100] [Job 30] envp[28]="FINAL_CONTENT_TYPE=printer/canon_iR_2870"
D [22/Feb/2012:18:48:49 +0100] [Job 30] envp[29]="AUTH_I****"
I [22/Feb/2012:18:48:49 +0100] [Job 30] Started filter /usr/lib/cups/filter/imagetops (PID 28486)
I [22/Feb/2012:18:48:49 +0100] [Job 30] Started filter /usr/lib/cups/filter/pstoufr2cpca (PID 28487)
I [22/Feb/2012:18:48:49 +0100] [Job 30] Started backend /usr/lib/cups/backend/socket (PID 28488)
D [22/Feb/2012:18:48:49 +0100] Discarding unused job-state-changed event...
D [22/Feb/2012:18:48:49 +0100] Returning IPP successful-ok for Send-Document (ipp://localhost:631/printers/canon_iR_2870) from localhost
D [22/Feb/2012:18:48:49 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients and dirty files"
D [22/Feb/2012:18:48:49 +0100] cupsdReadClient: 18 WAITING Closing on EOF
D [22/Feb/2012:18:48:49 +0100] cupsdCloseClient: 18
D [22/Feb/2012:18:48:49 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [22/Feb/2012:18:48:49 +0100] [Job 30] pstoufr2cpca start.
D [22/Feb/2012:18:48:49 +0100] [Job 30] STATE: +connecting-to-device
D [22/Feb/2012:18:48:49 +0100] [Job 30] Looking up "141.20.41.86"...
D [22/Feb/2012:18:48:49 +0100] Discarding unused printer-state-changed event...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Page = 595x842; 14,14 to 581,828
D [22/Feb/2012:18:48:49 +0100] [Job 30] num_components = 3
D [22/Feb/2012:18:48:49 +0100] [Job 30] jpeg_color_space = JCS_YCbCr
D [22/Feb/2012:18:48:49 +0100] [Job 30] Converting image to RGB...
D [22/Feb/2012:18:48:49 +0100] [Job 30] JPEG image 1653x2338x3, 200x200 PPI
D [22/Feb/2012:18:48:49 +0100] [Job 30] ATTR: marker-colors=#000000,none
D [22/Feb/2012:18:48:49 +0100] cupsdMarkDirty(P-----)
D [22/Feb/2012:18:48:49 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Printing jobs and dirty files"
D [22/Feb/2012:18:48:49 +0100] [Job 30] ATTR: marker-names="Black Toner","Waste Toner"
D [22/Feb/2012:18:48:49 +0100] cupsdMarkDirty(P-----)
D [22/Feb/2012:18:48:49 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [22/Feb/2012:18:48:49 +0100] [Job 30] ATTR: marker-types=toner,wasteToner
D [22/Feb/2012:18:48:49 +0100] cupsdMarkDirty(P-----)
D [22/Feb/2012:18:48:49 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [22/Feb/2012:18:48:49 +0100] [Job 30] ATTR: marker-levels=100,100
D [22/Feb/2012:18:48:49 +0100] cupsdMarkDirty(P-----)
D [22/Feb/2012:18:48:49 +0100] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [22/Feb/2012:18:48:49 +0100] Discarding unused printer-state-changed event...
D [22/Feb/2012:18:48:49 +0100] [Job 30] new_supply_state=0, change_state=ffff
D [22/Feb/2012:18:48:49 +0100] [Job 30] STATE: -developer-low-report
D [22/Feb/2012:18:48:49 +0100] [Job 30] STATE: -developer-empty-warning
D [22/Feb/2012:18:48:49 +0100] [Job 30] STATE: -marker-supply-low-report
D [22/Feb/2012:18:48:49 +0100] [Job 30] STATE: -marker-supply-empty-warning
D [22/Feb/2012:18:48:49 +0100] [Job 30] STATE: -opc-near-eol-report
D [22/Feb/2012:18:48:49 +0100] [Job 30] STATE: -opc-life-over-warning
D [22/Feb/2012:18:48:49 +0100] [Job 30] STATE: -toner-low-report
D [22/Feb/2012:18:48:49 +0100] [Job 30] STATE: -toner-empty-warning
D [22/Feb/2012:18:48:49 +0100] [Job 30] new_state=0, change_state=ffff
D [22/Feb/2012:18:48:49 +0100] [Job 30] STATE: -media-low-report
D [22/Feb/2012:18:48:49 +0100] [Job 30] STATE: -media-empty-warning
D [22/Feb/2012:18:48:49 +0100] [Job 30] STATE: -door-open-report
D [22/Feb/2012:18:48:49 +0100] [Job 30] STATE: -media-jam-warning
D [22/Feb/2012:18:48:49 +0100] [Job 30] STATE: -input-tray-missing-warning
D [22/Feb/2012:18:48:49 +0100] [Job 30] STATE: -output-tray-missing-warning
D [22/Feb/2012:18:48:49 +0100] [Job 30] STATE: -marker-supply-missing-warning
D [22/Feb/2012:18:48:49 +0100] [Job 30] STATE: -output-area-almost-full-report
D [22/Feb/2012:18:48:49 +0100] [Job 30] STATE: -output-area-full-warning
D [22/Feb/2012:18:48:49 +0100] [Job 30] backendWaitLoop(snmp_fd=5, addr=0x7fd3c29e8938, side_cb=0x7fd3c27dd020)
D [22/Feb/2012:18:48:49 +0100] [Job 30] Before scaling: xppi=0, yppi=0, zoom=1.00
D [22/Feb/2012:18:48:49 +0100] [Job 30] Before scaling: xprint=7.9, yprint=11.3
D [22/Feb/2012:18:48:49 +0100] [Job 30] cupsImageGetXPPI(img) = 200, cupsImageGetYPPI(img) = 200, aspect = 1.000000
D [22/Feb/2012:18:48:49 +0100] [Job 30] Portrait size is 7.87 x 11.14 inches
D [22/Feb/2012:18:48:49 +0100] [Job 30] Landscape size is 5.57 x 7.87 inches
D [22/Feb/2012:18:48:49 +0100] [Job 30] Auto orientation...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Using portrait orientation...
D [22/Feb/2012:18:48:49 +0100] [Job 30] xpages = 1x7.87in, ypages = 1x11.14in
D [22/Feb/2012:18:48:49 +0100] [Job 30] XPosition=0, YPosition=0, Orientation=0
D [22/Feb/2012:18:48:49 +0100] [Job 30] xprint=8, yprint=11
D [22/Feb/2012:18:48:49 +0100] [Job 30] PageLeft=14, PageRight=581, PageWidth=595
D [22/Feb/2012:18:48:49 +0100] [Job 30] PageBottom=14, PageTop=828, PageLength=842
D [22/Feb/2012:18:48:49 +0100] [Job 30] left=14.17, top=821.99
I [22/Feb/2012:18:48:49 +0100] [Job 30] Printing page 1.
D [22/Feb/2012:18:48:49 +0100] [Job 30] Set job-printer-state-message to "Printing page 1.", current level=INFO
D [22/Feb/2012:18:48:49 +0100] Discarding unused job-progress event...
D [22/Feb/2012:18:48:49 +0100] Discarding unused printer-state-changed event...
D [22/Feb/2012:18:48:49 +0100] [Job 30] opvpOpenPrinter(463)
D [22/Feb/2012:18:48:49 +0100] [Job 30] CStubOpenPrinter(397)
D [22/Feb/2012:18:48:49 +0100] [Job 30] opvpOpenPrinter(463)
D [22/Feb/2012:18:48:49 +0100] [Job 30] CStubOpenPrinter(397)
D [22/Feb/2012:18:48:49 +0100] [Job 30] Connecting to 141.20.41.86:9100
I [22/Feb/2012:18:48:49 +0100] [Job 30] Connecting to printer.
D [22/Feb/2012:18:48:49 +0100] [Job 30] Set job-printer-state-message to "Connecting to printer.", current level=INFO
D [22/Feb/2012:18:48:49 +0100] Discarding unused job-progress event...
D [22/Feb/2012:18:48:49 +0100] Discarding unused printer-state-changed event...
D [22/Feb/2012:18:48:49 +0100] [Job 30] STATE: -connecting-to-device
D [22/Feb/2012:18:48:49 +0100] Discarding unused printer-state-changed event...
I [22/Feb/2012:18:48:49 +0100] [Job 30] Connected to printer.
D [22/Feb/2012:18:48:49 +0100] [Job 30] Set job-printer-state-message to "Connected to printer.", current level=INFO
D [22/Feb/2012:18:48:49 +0100] [Job 30] Connected to 141.20.41.86:9100...
D [22/Feb/2012:18:48:49 +0100] [Job 30] backendRunLoop(print_fd=0, device_fd=6, snmp_fd=5, addr=0x7fd3c29e8938, use_bc=1, side_cb=0x7fd3c27dd020)
D [22/Feb/2012:18:48:49 +0100] Discarding unused job-progress event...
D [22/Feb/2012:18:48:49 +0100] Discarding unused printer-state-changed event...
D [22/Feb/2012:18:48:49 +0100] PID 28486 (/usr/lib/cups/filter/imagetops) exited with no errors.
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] ATTR: marker-levels=100,100
D [22/Feb/2012:18:48:49 +0100] cupsdMarkDirty(P-----)
D [22/Feb/2012:18:48:49 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Dirty files"
D [22/Feb/2012:18:48:49 +0100] [Job 30] new_supply_state=0, change_state=0
D [22/Feb/2012:18:48:49 +0100] Discarding unused printer-state-changed event...
D [22/Feb/2012:18:48:49 +0100] [Job 30] new_state=0, change_state=0
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:49 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] PID 28487 (/usr/lib/cups/filter/pstoufr2cpca) exited with no errors.
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 8192 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Read 775 bytes of print data...
D [22/Feb/2012:18:48:50 +0100] [Job 30] Wrote 775 bytes of print data...
I [22/Feb/2012:18:48:50 +0100] [Job 30] Waiting for printer to finish.
D [22/Feb/2012:18:48:50 +0100] [Job 30] Set job-printer-state-message to "Waiting for printer to finish.", current level=INFO
D [22/Feb/2012:18:48:50 +0100] Discarding unused job-progress event...
D [22/Feb/2012:18:48:50 +0100] Discarding unused printer-state-changed event...
D [22/Feb/2012:18:48:50 +0100] [Job 30] ATTR: marker-levels=100,100
D [22/Feb/2012:18:48:50 +0100] cupsdMarkDirty(P-----)
D [22/Feb/2012:18:48:50 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [22/Feb/2012:18:48:50 +0100] [Job 30] new_supply_state=0, change_state=0
D [22/Feb/2012:18:48:50 +0100] Discarding unused printer-state-changed event...
D [22/Feb/2012:18:48:50 +0100] [Job 30] new_state=0, change_state=0
I [22/Feb/2012:18:48:50 +0100] [Job 30] Ready to print.
D [22/Feb/2012:18:48:50 +0100] [Job 30] Set job-printer-state-message to "Ready to print.", current level=INFO
D [22/Feb/2012:18:48:50 +0100] Discarding unused job-progress event...
D [22/Feb/2012:18:48:50 +0100] Discarding unused printer-state-changed event...
D [22/Feb/2012:18:48:50 +0100] PID 28488 (/usr/lib/cups/backend/socket) exited with no errors.
D [22/Feb/2012:18:48:50 +0100] Discarding unused job-completed event...
I [22/Feb/2012:18:48:50 +0100] [Job 30] Job completed.
D [22/Feb/2012:18:48:50 +0100] cupsdMarkDirty(----J-)
D [22/Feb/2012:18:48:50 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [22/Feb/2012:18:48:50 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [22/Feb/2012:18:48:50 +0100] Discarding unused printer-state-changed event...
D [22/Feb/2012:18:48:51 +0100] [Job 30] Unloading...

More information about the cups mailing list