The troubleshooting says this:
D [23/Jan/2012:21:13:38 +0100] cupsdSetBusyState: Dirty files
D [23/Jan/2012:21:13:38 +0100] cupsdReadClient: 13 POST / HTTP/1.1
D [23/Jan/2012:21:13:38 +0100] cupsdSetBusyState: Active clients and dirty files
D [23/Jan/2012:21:13:38 +0100] cupsdAuthorize: No authentication data provided.
D [23/Jan/2012:21:13:38 +0100] cupsdReadClient: 13 1.1 Get-Jobs 1
D [23/Jan/2012:21:13:38 +0100] Get-Jobs
ipp://localhost/printers/D [23/Jan/2012:21:13:39 +0100] [Job 62] Loading attributes...
D [23/Jan/2012:21:13:39 +0100] Returning IPP successful-ok for Get-Jobs (
ipp://localhost/printers/) from localhost
D [23/Jan/2012:21:13:39 +0100] cupsdSetBusyState: Dirty files
D [23/Jan/2012:21:13:39 +0100] cupsdReadClient: 13 POST / HTTP/1.1
D [23/Jan/2012:21:13:39 +0100] cupsdSetBusyState: Active clients and dirty files
D [23/Jan/2012:21:13:39 +0100] cupsdAuthorize: No authentication data provided.
D [23/Jan/2012:21:13:39 +0100] cupsdReadClient: 13 1.1 Get-Jobs 1
D [23/Jan/2012:21:13:39 +0100] Get-Jobs
ipp://localhost/printers/D [23/Jan/2012:21:13:39 +0100] [Job 58] Loading attributes...
D [23/Jan/2012:21:13:39 +0100] [Job 60] Loading attributes...
D [23/Jan/2012:21:13:39 +0100] [Job 61] Loading attributes...
D [23/Jan/2012:21:13:39 +0100] Returning IPP successful-ok for Get-Jobs (
ipp://localhost/printers/) from localhost
D [23/Jan/2012:21:13:39 +0100] cupsdSetBusyState: Dirty files
D [23/Jan/2012:21:13:39 +0100] cupsdReadClient: 13 POST / HTTP/1.1
D [23/Jan/2012:21:13:39 +0100] cupsdSetBusyState: Active clients and dirty files
D [23/Jan/2012:21:13:39 +0100] cupsdAuthorize: No authentication data provided.
D [23/Jan/2012:21:13:39 +0100] cupsdReadClient: 13 1.1 Create-Printer-Subscription 1
D [23/Jan/2012:21:13:39 +0100] Create-Printer-Subscription /
D [23/Jan/2012:21:13:39 +0100] cupsdCreateSubscription(con=0x2292e2a8(13), uri="/")
D [23/Jan/2012:21:13:39 +0100] pullmethod="ippget"
D [23/Jan/2012:21:13:39 +0100] notify-lease-duration=86400
D [23/Jan/2012:21:13:39 +0100] notify-time-interval=0
D [23/Jan/2012:21:13:39 +0100] cupsdAddSubscription(mask=17800, dest=(nil)(), job=(nil)(0), uri="(null)")
D [23/Jan/2012:21:13:39 +0100] Added subscription 123 for server
D [23/Jan/2012:21:13:39 +0100] cupsdMarkDirty(-----S)
D [23/Jan/2012:21:13:39 +0100] Returning IPP successful-ok for Create-Printer-Subscription (/) from localhost
D [23/Jan/2012:21:13:39 +0100] cupsdSetBusyState: Dirty files
D [23/Jan/2012:21:13:40 +0100] cupsdReadClient: 13 POST / HTTP/1.1
D [23/Jan/2012:21:13:40 +0100] cupsdSetBusyState: Active clients and dirty files
D [23/Jan/2012:21:13:40 +0100] cupsdAuthorize: No authentication data provided.
D [23/Jan/2012:21:13:40 +0100] cupsdReadClient: 13 1.1 Get-Notifications 1
D [23/Jan/2012:21:13:40 +0100] Get-Notifications /
D [23/Jan/2012:21:13:40 +0100] cupsdIsAuthorized: requesting-user-name="phil"
D [23/Jan/2012:21:13:40 +0100] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [23/Jan/2012:21:13:40 +0100] cupsdSetBusyState: Dirty files
D [23/Jan/2012:21:13:43 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [23/Jan/2012:21:13:43 +0100] cupsdNetIFUpdate: "wlan0" = 192.168.178.21:631
D [23/Jan/2012:21:13:43 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [23/Jan/2012:21:13:43 +0100] cupsdNetIFUpdate: "wlan0" = [v1.fe80::213:2ff:fe0d:99c1+wlan0]:631
I [23/Jan/2012:21:13:54 +0100] Generating printcap /var/run/cups/printcap...
I [23/Jan/2012:21:13:54 +0100] Saving subscriptions.conf...
D [23/Jan/2012:21:13:54 +0100] cupsdSetBusyState: Not busy
D [23/Jan/2012:21:14:04 +0100] cupsdAcceptClient: 14 from localhost (Domain)
D [23/Jan/2012:21:14:04 +0100] cupsdReadClient: 14 POST /printers/HP-LaserJet-1018 HTTP/1.1
D [23/Jan/2012:21:14:04 +0100] cupsdSetBusyState: Active clients
D [23/Jan/2012:21:14:04 +0100] cupsdAuthorize: No authentication data provided.
D [23/Jan/2012:21:14:04 +0100] cupsdReadClient: 14 1.1 Print-Job 1
D [23/Jan/2012:21:14:04 +0100] Print-Job
ipp://localhost/printers/HP-LaserJet-1018D [23/Jan/2012:21:14:04 +0100] [Job ???] Auto-typing file...
I [23/Jan/2012:21:14:04 +0100] [Job ???] Request file type is application/vnd.cups-banner.
D [23/Jan/2012:21:14:04 +0100] cupsdMarkDirty(----J-)
D [23/Jan/2012:21:14:04 +0100] cupsdSetBusyState: Active clients and dirty files
D [23/Jan/2012:21:14:04 +0100] add_job: requesting-user-name="phil"
D [23/Jan/2012:21:14:04 +0100] Adding default job-sheets values "none,none"...
I [23/Jan/2012:21:14:04 +0100] [Job 63] Adding start banner page "none".
D [23/Jan/2012:21:14:04 +0100] cupsdMarkDirty(-----S)
D [23/Jan/2012:21:14:04 +0100] cupsdMarkDirty(----J-)
I [23/Jan/2012:21:14:04 +0100] [Job 63] Adding end banner page "none".
I [23/Jan/2012:21:14:04 +0100] [Job 63] File of type application/vnd.cups-banner queued by "phil".
D [23/Jan/2012:21:14:04 +0100] [Job 63] hold_until=0
I [23/Jan/2012:21:14:04 +0100] [Job 63] Queued on "HP-LaserJet-1018" by "phil".
D [23/Jan/2012:21:14:04 +0100] cupsdMarkDirty(----J-)
D [23/Jan/2012:21:14:04 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [23/Jan/2012:21:14:04 +0100] cupsdMarkDirty(-----S)
D [23/Jan/2012:21:14:04 +0100] [Job 63] job-sheets=none,none
D [23/Jan/2012:21:14:04 +0100] [Job 63] argv[0]="HP-LaserJet-1018"
D [23/Jan/2012:21:14:04 +0100] [Job 63] argv[1]="63"
D [23/Jan/2012:21:14:04 +0100] [Job 63] argv[2]="phil"
D [23/Jan/2012:21:14:04 +0100] [Job 63] argv[3]="Test Page"
D [23/Jan/2012:21:14:04 +0100] [Job 63] argv[4]="1"
D [23/Jan/2012:21:14:04 +0100] [Job 63] argv[5]="job-uuid=urn:uuid:136e23bc-ff32-3e56-4c05-c2ace640acf9 job-originating-host-name=localhost time-at-creation=1327349644 time-at-processing=1327349644 AP_D_InputSlot="
D [23/Jan/2012:21:14:04 +0100] [Job 63] argv[6]="/var/spool/cups/d00063-001"
D [23/Jan/2012:21:14:04 +0100] [Job 63] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [23/Jan/2012:21:14:04 +0100] [Job 63] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [23/Jan/2012:21:14:04 +0100] [Job 63] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root"
D [23/Jan/2012:21:14:04 +0100] [Job 63] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [23/Jan/2012:21:14:04 +0100] [Job 63] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [23/Jan/2012:21:14:04 +0100] [Job 63] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [23/Jan/2012:21:14:04 +0100] [Job 63] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [23/Jan/2012:21:14:04 +0100] [Job 63] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [23/Jan/2012:21:14:04 +0100] [Job 63] envp[8]="HOME=/var/spool/cups/tmp"
D [23/Jan/2012:21:14:04 +0100] [Job 63] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [23/Jan/2012:21:14:04 +0100] [Job 63] envp[10]="SERVER_ADMIN=root@phil-VGN-FE11H"
D [23/Jan/2012:21:14:04 +0100] [Job 63] envp[11]="SOFTWARE=CUPS/1.4.6"
D [23/Jan/2012:21:14:04 +0100] [Job 63] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [23/Jan/2012:21:14:04 +0100] [Job 63] envp[13]="USER=root"
D [23/Jan/2012:21:14:04 +0100] [Job 63] envp[14]="CUPS_SERVER=/var/run/cups/cups.sock"
D [23/Jan/2012:21:14:04 +0100] [Job 63] envp[15]="CUPS_ENCRYPTION=IfRequested"
D [23/Jan/2012:21:14:04 +0100] [Job 63] envp[16]="IPP_PORT=631"
D [23/Jan/2012:21:14:04 +0100] [Job 63] envp[17]="CHARSET=utf-8"
D [23/Jan/2012:21:14:04 +0100] [Job 63] envp[18]="LANG=de_DE.UTF-8"
D [23/Jan/2012:21:14:04 +0100] [Job 63] envp[19]="PPD=/etc/cups/ppd/HP-LaserJet-1018.ppd"
D [23/Jan/2012:21:14:04 +0100] [Job 63] envp[20]="RIP_MAX_CACHE=auto"
D [23/Jan/2012:21:14:04 +0100] [Job 63] envp[21]="CONTENT_TYPE=application/vnd.cups-banner"
D [23/Jan/2012:21:14:04 +0100] [Job 63] envp[22]="DEVICE_URI=hp:/usb/HP_LaserJet_1018?serial=KP1ZGBS"
D [23/Jan/2012:21:14:04 +0100] [Job 63] envp[23]="PRINTER_INFO=Hewlett-Packard HP LaserJet 1018"
D [23/Jan/2012:21:14:04 +0100] [Job 63] envp[24]="PRINTER_LOCATION=phil-VGN-FE11H"
D [23/Jan/2012:21:14:04 +0100] [Job 63] envp[25]="PRINTER=HP-LaserJet-1018"
D [23/Jan/2012:21:14:04 +0100] [Job 63] envp[26]="CUPS_FILETYPE=document"
D [23/Jan/2012:21:14:04 +0100] [Job 63] envp[27]="FINAL_CONTENT_TYPE=printer/HP-LaserJet-1018"
I [23/Jan/2012:21:14:04 +0100] [Job 63] Started filter /usr/lib/cups/filter/bannertops (PID 5840)
I [23/Jan/2012:21:14:04 +0100] [Job 63] Started filter /usr/lib/cups/filter/pstopdf (PID 5841)
I [23/Jan/2012:21:14:04 +0100] [Job 63] Started filter /usr/lib/cups/filter/pdftopdf (PID 5842)
I [23/Jan/2012:21:14:04 +0100] [Job 63] Started filter /usr/lib/cups/filter/foomatic-rip (PID 5843)
I [23/Jan/2012:21:14:04 +0100] [Job 63] Started backend /usr/lib/cups/backend/hp (PID 5844)
D [23/Jan/2012:21:14:04 +0100] cupsdMarkDirty(-----S)
D [23/Jan/2012:21:14:04 +0100] Returning IPP successful-ok for Print-Job (
ipp://localhost/printers/HP-LaserJet-1018) from localhost
D [23/Jan/2012:21:14:04 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [23/Jan/2012:21:14:04 +0100] [Job 63] pstopdf 5 args: 63 phil Test Page 1 job-uuid=urn:uuid:136e23bc-ff32-3e56-4c05-c2ace640acf9 job-originating-host-name=localhost time-at-creation=1327349644 time-at-processing=1327349644 AP_D_InputSlot=
D [23/Jan/2012:21:14:04 +0100] [Job 63] PPD: /etc/cups/ppd/HP-LaserJet-1018.ppd
D [23/Jan/2012:21:14:04 +0100] [Job 63] load_banner(filename="/var/spool/cups/d00063-001")
D [23/Jan/2012:21:14:04 +0100] [Job 63] Page = 595x842; 11,11 to 584,831
D [23/Jan/2012:21:14:04 +0100] cupsdAcceptClient: 18 from localhost (Domain)
D [23/Jan/2012:21:14:04 +0100] cupsdReadClient: 18 POST / HTTP/1.1
D [23/Jan/2012:21:14:04 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [23/Jan/2012:21:14:04 +0100] cupsdAuthorize: No authentication data provided.
D [23/Jan/2012:21:14:04 +0100] cupsdReadClient: 18 1.1 Get-Notifications 1
D [23/Jan/2012:21:14:04 +0100] Get-Notifications /
D [23/Jan/2012:21:14:04 +0100] cupsdIsAuthorized: requesting-user-name="phil"
D [23/Jan/2012:21:14:04 +0100] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [23/Jan/2012:21:14:04 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [23/Jan/2012:21:14:04 +0100] cupsdAcceptClient: 19 from localhost (Domain)
D [23/Jan/2012:21:14:04 +0100] cupsdReadClient: 19 POST / HTTP/1.1
D [23/Jan/2012:21:14:04 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [23/Jan/2012:21:14:04 +0100] cupsdAuthorize: No authentication data provided.
D [23/Jan/2012:21:14:04 +0100] cupsdReadClient: 19 1.1 Get-Notifications 1
D [23/Jan/2012:21:14:04 +0100] Get-Notifications /
D [23/Jan/2012:21:14:04 +0100] cupsdIsAuthorized: requesting-user-name="phil"
D [23/Jan/2012:21:14:04 +0100] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [23/Jan/2012:21:14:04 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [23/Jan/2012:21:14:04 +0100] cupsdReadClient: 19 POST / HTTP/1.1
D [23/Jan/2012:21:14:04 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [23/Jan/2012:21:14:04 +0100] cupsdAuthorize: No authentication data provided.
D [23/Jan/2012:21:14:04 +0100] cupsdReadClient: 19 1.1 Get-Job-Attributes 1
D [23/Jan/2012:21:14:04 +0100] Get-Job-Attributes
ipp://localhost/jobs/63D [23/Jan/2012:21:14:04 +0100] Returning IPP successful-ok for Get-Job-Attributes (
ipp://localhost/jobs/63) from localhost
D [23/Jan/2012:21:14:04 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [23/Jan/2012:21:14:04 +0100] cupsdAcceptClient: 20 from localhost (Domain)
D [23/Jan/2012:21:14:04 +0100] cupsdReadClient: 20 POST / HTTP/1.1
D [23/Jan/2012:21:14:04 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [23/Jan/2012:21:14:04 +0100] cupsdAuthorize: No authentication data provided.
D [23/Jan/2012:21:14:04 +0100] cupsdReadClient: 20 1.1 Get-Printer-Attributes 1
D [23/Jan/2012:21:14:04 +0100] Get-Printer-Attributes
ipp://phil-VGN-FE11H:631/printers/HP-LaserJet-1018D [23/Jan/2012:21:14:04 +0100] Returning IPP successful-ok for Get-Printer-Attributes (
ipp://phil-VGN-FE11H:631/printers/HP-LaserJet-1018) from localhost
D [23/Jan/2012:21:14:04 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [23/Jan/2012:21:14:04 +0100] cupsdReadClient: 20 WAITING Closing on EOF
D [23/Jan/2012:21:14:04 +0100] cupsdCloseClient: 20
D [23/Jan/2012:21:14:04 +0100] cupsdAcceptClient: 20 from localhost (Domain)
D [23/Jan/2012:21:14:04 +0100] cupsdReadClient: 20 POST / HTTP/1.1
D [23/Jan/2012:21:14:04 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [23/Jan/2012:21:14:04 +0100] cupsdAuthorize: No authentication data provided.
D [23/Jan/2012:21:14:04 +0100] cupsdReadClient: 20 1.1 Get-Job-Attributes 1
D [23/Jan/2012:21:14:04 +0100] Get-Job-Attributes
ipp://localhost/jobs/63D [23/Jan/2012:21:14:04 +0100] Returning IPP successful-ok for Get-Job-Attributes (
ipp://localhost/jobs/63) from localhost
D [23/Jan/2012:21:14:04 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [23/Jan/2012:21:14:04 +0100] cupsdReadClient: 20 WAITING Closing on EOF
D [23/Jan/2012:21:14:04 +0100] cupsdCloseClient: 20
D [23/Jan/2012:21:14:04 +0100] cupsdReadClient: 13 POST / HTTP/1.1
D [23/Jan/2012:21:14:04 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [23/Jan/2012:21:14:04 +0100] cupsdAuthorize: No authentication data provided.
D [23/Jan/2012:21:14:04 +0100] cupsdReadClient: 13 1.1 Get-Notifications 1
D [23/Jan/2012:21:14:04 +0100] Get-Notifications /
D [23/Jan/2012:21:14:04 +0100] cupsdIsAuthorized: requesting-user-name="phil"
D [23/Jan/2012:21:14:04 +0100] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [23/Jan/2012:21:14:04 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [23/Jan/2012:21:14:04 +0100] [Job 63] Getting input from file
D [23/Jan/2012:21:14:04 +0100] [Job 63] foomatic-rip version 4.0.7.235 running...
D [23/Jan/2012:21:14:04 +0100] [Job 63] Parsing PPD file ...
D [23/Jan/2012:21:14:04 +0100] [Job 63] Added option PageSize
D [23/Jan/2012:21:14:04 +0100] [Job 63] Added option Quality
D [23/Jan/2012:21:14:04 +0100] [Job 63] Added option Resolution
D [23/Jan/2012:21:14:04 +0100] [Job 63] Added option ImageableArea
D [23/Jan/2012:21:14:04 +0100] [Job 63] Added option PaperDimension
D [23/Jan/2012:21:14:04 +0100] [Job 63] Added option InputSlot
D [23/Jan/2012:21:14:04 +0100] [Job 63] Added option MediaType
D [23/Jan/2012:21:14:04 +0100] [Job 63] Added option Density
D [23/Jan/2012:21:14:04 +0100] [Job 63] Added option Copies
D [23/Jan/2012:21:14:04 +0100] [Job 63] Added option halftone
D [23/Jan/2012:21:14:04 +0100] [Job 63] Added option NupOrient
D [23/Jan/2012:21:14:04 +0100] [Job 63] Added option NupPages
D [23/Jan/2012:21:14:04 +0100] [Job 63] Added option Font
D [23/Jan/2012:21:14:04 +0100] [Job 63]
D [23/Jan/2012:21:14:04 +0100] [Job 63] Parameter Summary
D [23/Jan/2012:21:14:04 +0100] [Job 63] -----------------
D [23/Jan/2012:21:14:04 +0100] [Job 63]
D [23/Jan/2012:21:14:04 +0100] [Job 63] Spooler: cups
D [23/Jan/2012:21:14:04 +0100] [Job 63] Printer: HP-LaserJet-1018
D [23/Jan/2012:21:14:04 +0100] [Job 63] Shell: /bin/bash
D [23/Jan/2012:21:14:04 +0100] [Job 63] PPD file: /etc/cups/ppd/HP-LaserJet-1018.ppd
D [23/Jan/2012:21:14:04 +0100] [Job 63] ATTR file:
D [23/Jan/2012:21:14:04 +0100] [Job 63] Printer model: HP LaserJet 1018 Foomatic/foo2zjs-z1 (recommended)
D [23/Jan/2012:21:14:04 +0100] [Job 63] Job title: Test Page
D [23/Jan/2012:21:14:04 +0100] [Job 63] File(s) to be printed:
D [23/Jan/2012:21:14:04 +0100] [Job 63] <STDIN>
D [23/Jan/2012:21:14:04 +0100] [Job 63]
D [23/Jan/2012:21:14:04 +0100] [Job 63] Ghostscript extra search path ('GS_LIB'): /usr/share/cups/fonts
D [23/Jan/2012:21:14:04 +0100] [Job 63] Printing system options:
D [23/Jan/2012:21:14:04 +0100] [Job 63] Pondering option 'job-uuid=urn:uuid:136e23bc-ff32-3e56-4c05-c2ace640acf9'
D [23/Jan/2012:21:14:04 +0100] [Job 63] Unknown option job-uuid=urn:uuid:136e23bc-ff32-3e56-4c05-c2ace640acf9.
D [23/Jan/2012:21:14:04 +0100] [Job 63] Pondering option 'job-originating-host-name=localhost'
D [23/Jan/2012:21:14:04 +0100] [Job 63] Unknown option job-originating-host-name=localhost.
D [23/Jan/2012:21:14:04 +0100] [Job 63] Pondering option 'time-at-creation=1327349644'
D [23/Jan/2012:21:14:04 +0100] [Job 63] Unknown option time-at-creation=1327349644.
D [23/Jan/2012:21:14:04 +0100] [Job 63] Pondering option 'time-at-processing=1327349644'
D [23/Jan/2012:21:14:04 +0100] [Job 63] Unknown option time-at-processing=1327349644.
D [23/Jan/2012:21:14:04 +0100] [Job 63] Pondering option 'AP_D_InputSlot='
D [23/Jan/2012:21:14:04 +0100] [Job 63] Unknown option AP_D_InputSlot=.
D [23/Jan/2012:21:14:04 +0100] [Job 63] Options from the PPD file:
D [23/Jan/2012:21:14:04 +0100] [Job 63]
D [23/Jan/2012:21:14:04 +0100] [Job 63] ================================================
D [23/Jan/2012:21:14:04 +0100] [Job 63]
D [23/Jan/2012:21:14:04 +0100] [Job 63] File: <STDIN>
D [23/Jan/2012:21:14:04 +0100] [Job 63]
D [23/Jan/2012:21:14:04 +0100] [Job 63] ================================================
D [23/Jan/2012:21:14:04 +0100] [Job 63]
D [23/Jan/2012:21:14:04 +0100] cupsdReadClient: 18 WAITING Closing on EOF
D [23/Jan/2012:21:14:04 +0100] cupsdCloseClient: 18
D [23/Jan/2012:21:14:04 +0100] cupsdAcceptClient: 18 from localhost (Domain)
D [23/Jan/2012:21:14:04 +0100] cupsdReadClient: 18 POST / HTTP/1.1
D [23/Jan/2012:21:14:04 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [23/Jan/2012:21:14:04 +0100] cupsdAuthorize: No authentication data provided.
D [23/Jan/2012:21:14:04 +0100] cupsdReadClient: 18 1.1 Get-Job-Attributes 1
D [23/Jan/2012:21:14:04 +0100] Get-Job-Attributes
ipp://localhost/jobs/63D [23/Jan/2012:21:14:04 +0100] Returning IPP successful-ok for Get-Job-Attributes (
ipp://localhost/jobs/63) from localhost
D [23/Jan/2012:21:14:04 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [23/Jan/2012:21:14:04 +0100] cupsdReadClient: 18 WAITING Closing on EOF
D [23/Jan/2012:21:14:04 +0100] cupsdCloseClient: 18
D [23/Jan/2012:21:14:04 +0100] cupsdAcceptClient: 18 from localhost (Domain)
D [23/Jan/2012:21:14:04 +0100] cupsdReadClient: 18 POST / HTTP/1.1
D [23/Jan/2012:21:14:04 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [23/Jan/2012:21:14:04 +0100] cupsdAuthorize: No authentication data provided.
D [23/Jan/2012:21:14:04 +0100] cupsdReadClient: 18 1.1 Get-Job-Attributes 1
D [23/Jan/2012:21:14:04 +0100] Get-Job-Attributes
ipp://localhost/jobs/63D [23/Jan/2012:21:14:04 +0100] Returning IPP successful-ok for Get-Job-Attributes (
ipp://localhost/jobs/63) from localhost
D [23/Jan/2012:21:14:04 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [23/Jan/2012:21:14:04 +0100] cupsdReadClient: 18 WAITING Closing on EOF
D [23/Jan/2012:21:14:04 +0100] cupsdCloseClient: 18
D [23/Jan/2012:21:14:04 +0100] cupsdReadClient: 19 WAITING Closing on EOF
D [23/Jan/2012:21:14:04 +0100] cupsdCloseClient: 19
D [23/Jan/2012:21:14:05 +0100] [Job 63] PNG image: 128x128x8, color_type=6 (RGB+ALPHA)
D [23/Jan/2012:21:14:05 +0100] [Job 63] PNG image: 192x128x8, color_type=2 (RGB)
D [23/Jan/2012:21:14:05 +0100] PID 5840 (/usr/lib/cups/filter/bannertops) exited with no errors.
D [23/Jan/2012:21:14:05 +0100] cupsdAcceptClient: 18 from localhost (Domain)
D [23/Jan/2012:21:14:05 +0100] cupsdReadClient: 18 POST / HTTP/1.1
D [23/Jan/2012:21:14:05 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [23/Jan/2012:21:14:05 +0100] cupsdAuthorize: No authentication data provided.
D [23/Jan/2012:21:14:05 +0100] [Job 63] Resolution: 1200x600
D [23/Jan/2012:21:14:05 +0100] cupsdReadClient: 18 1.1 CUPS-Get-Printers 1
D [23/Jan/2012:21:14:05 +0100] CUPS-Get-Printers
D [23/Jan/2012:21:14:05 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Jan/2012:21:14:05 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [23/Jan/2012:21:14:05 +0100] cupsdReadClient: 18 POST / HTTP/1.1
D [23/Jan/2012:21:14:05 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [23/Jan/2012:21:14:05 +0100] cupsdAuthorize: No authentication data provided.
D [23/Jan/2012:21:14:05 +0100] cupsdReadClient: 18 1.1 CUPS-Get-Classes 1
D [23/Jan/2012:21:14:05 +0100] CUPS-Get-Classes
D [23/Jan/2012:21:14:05 +0100] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost
D [23/Jan/2012:21:14:05 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [23/Jan/2012:21:14:05 +0100] cupsdReadClient: 18 POST / HTTP/1.1
D [23/Jan/2012:21:14:05 +0100] cupsdSetBusyState: Active clients, printing jobs, and dirty files
D [23/Jan/2012:21:14:05 +0100] cupsdAuthorize: No authentication data provided.
D [23/Jan/2012:21:14:05 +0100] cupsdReadClient: 18 1.1 CUPS-Get-Default 1
D [23/Jan/2012:21:14:05 +0100] CUPS-Get-Default
D [23/Jan/2012:21:14:05 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Jan/2012:21:14:05 +0100] cupsdSetBusyState: Printing jobs and dirty files
D [23/Jan/2012:21:14:05 +0100] [Job 63] Page size: A4
D [23/Jan/2012:21:14:05 +0100] [Job 63] Width: 595, height: 842, absolute margins: 11.34, 11.34, 583.66, 830.66
D [23/Jan/2012:21:14:05 +0100] [Job 63] Relative margins: 11.34, 11.34, 11.34, 11.34
D [23/Jan/2012:21:14:05 +0100] [Job 63] PPD options: -r600 -dDEVICEWIDTHPOINTS=595 -dDEVICEHEIGHTPOINTS=842
D [23/Jan/2012:21:14:05 +0100] [Job 63] PostScript to be injected:
D [23/Jan/2012:21:14:05 +0100] [Job 63] Running cat | /usr/bin/gs -q -dNOPAUSE -dBATCH -sDEVICE=pdfwrite -dCompatibilityLevel=1.3 -dAutoRotatePages=/None -dAutoFilterColorImages=false -dNOPLATFONTS -dPARANOIDSAFER -sstdout=%stderr -dColorImageFilter=/FlateEncode -dPDFSETTINGS=/printer -dColorConversionStrategy=/LeaveColorUnchanged -dDoNumCopies -r600 -dDEVICEWIDTHPOINTS=595 -dDEVICEHEIGHTPOINTS=842 -sOutputFile=- -c .setpdfwrite -f -
D [23/Jan/2012:21:14:07 +0100] PID 5841 (/usr/lib/cups/filter/pstopdf) exited with no errors.
D [23/Jan/2012:21:14:07 +0100] [Job 63] Filetype: PDF
D [23/Jan/2012:21:14:07 +0100] [Job 63] Driver does not understand PDF input, converting to PostScript
D [23/Jan/2012:21:14:07 +0100] [Job 63] Storing temporary files in /var/spool/cups/tmp
D [23/Jan/2012:21:14:07 +0100] PID 5842 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
D [23/Jan/2012:21:14:07 +0100] [Job 63] Starting process "pdf-to-ps" (generation 1)
D [23/Jan/2012:21:14:07 +0100] [Job 63] Filetype: PostScript
D [23/Jan/2012:21:14:07 +0100] [Job 63] Reading PostScript input ...
D [23/Jan/2012:21:14:07 +0100] [Job 63] --> This document is DSC-conforming!
D [23/Jan/2012:21:14:07 +0100] [Job 63] Job claims to be DSC-conforming, but "%%BeginProlog" was missing before first line with another"%%BeginProlog" comment (is this a TeX/LaTeX/dvips-generated PostScript file?). Assuming start of "Prolog" here.
D [23/Jan/2012:21:14:07 +0100] [Job 63] Inserting option code into "Prolog" section.
D [23/Jan/2012:21:14:07 +0100] [Job 63]
D [23/Jan/2012:21:14:07 +0100] [Job 63] -----------
D [23/Jan/2012:21:14:07 +0100] [Job 63] Found: %%BeginProlog
D [23/Jan/2012:21:14:07 +0100] [Job 63] Found: %%EndProlog
D [23/Jan/2012:21:14:07 +0100] [Job 63]
D [23/Jan/2012:21:14:07 +0100] [Job 63] -----------
D [23/Jan/2012:21:14:07 +0100] [Job 63] Found: %%BeginSetup
D [23/Jan/2012:21:14:07 +0100] [Job 63] Found: %%EndSetup
D [23/Jan/2012:21:14:07 +0100] [Job 63] Inserting PostScript code for CUPS' page accounting
D [23/Jan/2012:21:14:07 +0100] [Job 63] Inserting option code into "Setup" section.
D [23/Jan/2012:21:14:07 +0100] [Job 63]
D [23/Jan/2012:21:14:07 +0100] [Job 63] -----------
D [23/Jan/2012:21:14:07 +0100] [Job 63] New page: %%Page: 1 1
D [23/Jan/2012:21:14:07 +0100] [Job 63]
D [23/Jan/2012:21:14:07 +0100] [Job 63] Found: %%BeginPageSetup
D [23/Jan/2012:21:14:07 +0100] [Job 63] Inserting option code into "PageSetup" section.
D [23/Jan/2012:21:14:07 +0100] [Job 63] Flushing FIFO.
D [23/Jan/2012:21:14:07 +0100] [Job 63]
D [23/Jan/2012:21:14:07 +0100] [Job 63] Starting renderer with command: "foo2zjs-wrapper -z1 -P -L0 -r1200x600 -p9 -T3 -m1 -s7 -n1 "
D [23/Jan/2012:21:14:07 +0100] [Job 63] Starting process "kid3" (generation 1)
D [23/Jan/2012:21:14:07 +0100] [Job 63]
D [23/Jan/2012:21:14:07 +0100] [Job 63] Closing renderer
D [23/Jan/2012:21:14:07 +0100] [Job 63] Starting process "kid4" (generation 2)
D [23/Jan/2012:21:14:07 +0100] [Job 63] Starting process "renderer" (generation 2)
D [23/Jan/2012:21:14:07 +0100] [Job 63] JCL: %-12345X@PJL
D [23/Jan/2012:21:14:07 +0100] [Job 63] <job data>
D [23/Jan/2012:21:14:07 +0100] [Job 63]
D [23/Jan/2012:21:14:07 +0100] [Job 63] /bin/bash: foo2zjs-wrapper: command not found
D [23/Jan/2012:21:14:07 +0100] [Job 63] renderer exited with status 127
D [23/Jan/2012:21:14:07 +0100] [Job 63] kid3 exited with status 1
D [23/Jan/2012:21:14:07 +0100] [Job 63] Process is dying with "Error closing renderer
D [23/Jan/2012:21:14:07 +0100] [Job 63] ", exit stat 1
D [23/Jan/2012:21:14:07 +0100] [Job 63] Cleaning up...
D [23/Jan/2012:21:14:07 +0100] [Job 63] Killing pdf-to-ps
D [23/Jan/2012:21:14:15 +0100] [Job 63] prnt/backend/hp.c 839: ERROR: null print job total=0
D [23/Jan/2012:21:14:15 +0100] PID 5843 (/usr/lib/cups/filter/foomatic-rip) stopped with status 1!
D [23/Jan/2012:21:14:15 +0100] PID 5844 (/usr/lib/cups/backend/hp) exited with no errors.
D [23/Jan/2012:21:14:15 +0100] cupsdMarkDirty(-----S)
E [23/Jan/2012:21:14:15 +0100] [Job 63] Job stopped due to filter errors; please consult the error_log file for details.
D [23/Jan/2012:21:14:15 +0100] cupsdMarkDirty(----J-)
D [23/Jan/2012:21:14:15 +0100] cupsdMarkDirty(-----S)
D [23/Jan/2012:21:14:15 +0100] cupsdAcceptClient: 17 from localhost (Domain)
D [23/Jan/2012:21:14:15 +0100] cupsdReadClient: 17 POST / HTTP/1.1
D [23/Jan/2012:21:14:15 +0100] cupsdSetBusyState: Active clients and dirty files
D [23/Jan/2012:21:14:15 +0100] cupsdAuthorize: No authentication data provided.
D [23/Jan/2012:21:14:15 +0100] cupsdAcceptClient: 19 from localhost (Domain)
D [23/Jan/2012:21:14:15 +0100] cupsdReadClient: 19 POST / HTTP/1.1
D [23/Jan/2012:21:14:15 +0100] cupsdAuthorize: No authentication data provided.
D [23/Jan/2012:21:14:15 +0100] cupsdReadClient: 17 1.1 Get-Notifications 1
D [23/Jan/2012:21:14:15 +0100] Get-Notifications /
D [23/Jan/2012:21:14:15 +0100] cupsdIsAuthorized: requesting-user-name="phil"
D [23/Jan/2012:21:14:15 +0100] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [23/Jan/2012:21:14:15 +0100] cupsdReadClient: 19 1.1 Get-Notifications 1
D [23/Jan/2012:21:14:15 +0100] Get-Notifications /
D [23/Jan/2012:21:14:15 +0100] cupsdIsAuthorized: requesting-user-name="phil"
D [23/Jan/2012:21:14:15 +0100] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [23/Jan/2012:21:14:15 +0100] cupsdSetBusyState: Dirty files
D [23/Jan/2012:21:14:15 +0100] cupsdAcceptClient: 20 from localhost (Domain)
D [23/Jan/2012:21:14:15 +0100] cupsdReadClient: 20 POST / HTTP/1.1
D [23/Jan/2012:21:14:15 +0100] cupsdSetBusyState: Active clients and dirty files
D [23/Jan/2012:21:14:15 +0100] cupsdAuthorize: No authentication data provided.
D [23/Jan/2012:21:14:15 +0100] cupsdReadClient: 17 WAITING Closing on EOF
D [23/Jan/2012:21:14:15 +0100] cupsdCloseClient: 17
D [23/Jan/2012:21:14:15 +0100] cupsdReadClient: 20 1.1 Get-Job-Attributes 1
D [23/Jan/2012:21:14:15 +0100] Get-Job-Attributes
ipp://localhost/jobs/63D [23/Jan/2012:21:14:15 +0100] Returning IPP successful-ok for Get-Job-Attributes (
ipp://localhost/jobs/63) from localhost
D [23/Jan/2012:21:14:15 +0100] cupsdSetBusyState: Dirty files
D [23/Jan/2012:21:14:15 +0100] cupsdAcceptClient: 17 from localhost (Domain)
D [23/Jan/2012:21:14:15 +0100] cupsdReadClient: 17 POST / HTTP/1.1
D [23/Jan/2012:21:14:15 +0100] cupsdSetBusyState: Active clients and dirty files
D [23/Jan/2012:21:14:15 +0100] cupsdAuthorize: No authentication data provided.
D [23/Jan/2012:21:14:15 +0100] cupsdReadClient: 17 1.1 Get-Printer-Attributes 1
D [23/Jan/2012:21:14:15 +0100] Get-Printer-Attributes
ipp://phil-VGN-FE11H:631/printers/HP-LaserJet-1018D [23/Jan/2012:21:14:15 +0100] Returning IPP successful-ok for Get-Printer-Attributes (
ipp://phil-VGN-FE11H:631/printers/HP-LaserJet-1018) from localhost
D [23/Jan/2012:21:14:15 +0100] cupsdSetBusyState: Dirty files
D [23/Jan/2012:21:14:15 +0100] cupsdReadClient: 17 POST / HTTP/1.1
D [23/Jan/2012:21:14:15 +0100] cupsdSetBusyState: Active clients and dirty files
D [23/Jan/2012:21:14:15 +0100] cupsdAuthorize: No authentication data provided.
D [23/Jan/2012:21:14:15 +0100] cupsdReadClient: 17 1.1 Get-Job-Attributes 1
D [23/Jan/2012:21:14:15 +0100] Get-Job-Attributes
ipp://localhost/jobs/63D [23/Jan/2012:21:14:15 +0100] Returning IPP successful-ok for Get-Job-Attributes (
ipp://localhost/jobs/63) from localhost
D [23/Jan/2012:21:14:15 +0100] cupsdSetBusyState: Dirty files
D [23/Jan/2012:21:14:15 +0100] cupsdReadClient: 20 WAITING Closing on EOF
D [23/Jan/2012:21:14:15 +0100] cupsdCloseClient: 20
D [23/Jan/2012:21:14:15 +0100] cupsdReadClient: 13 POST / HTTP/1.1
D [23/Jan/2012:21:14:15 +0100] cupsdSetBusyState: Active clients and dirty files
D [23/Jan/2012:21:14:15 +0100] cupsdAuthorize: No authentication data provided.
D [23/Jan/2012:21:14:15 +0100] cupsdReadClient: 13 1.1 Get-Notifications 1
D [23/Jan/2012:21:14:15 +0100] Get-Notifications /
D [23/Jan/2012:21:14:15 +0100] cupsdIsAuthorized: requesting-user-name="phil"
D [23/Jan/2012:21:14:15 +0100] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [23/Jan/2012:21:14:15 +0100] cupsdSetBusyState: Dirty files
D [23/Jan/2012:21:14:15 +0100] cupsdReadClient: 19 WAITING Closing on EOF
D [23/Jan/2012:21:14:15 +0100] cupsdCloseClient: 19
D [23/Jan/2012:21:14:15 +0100] cupsdReadClient: 18 POST / HTTP/1.1
D [23/Jan/2012:21:14:15 +0100] cupsdSetBusyState: Active clients and dirty files
D [23/Jan/2012:21:14:15 +0100] cupsdAuthorize: No authentication data provided.
D [23/Jan/2012:21:14:15 +0100] cupsdReadClient: 18 1.1 CUPS-Get-Printers 1
D [23/Jan/2012:21:14:15 +0100] CUPS-Get-Printers
D [23/Jan/2012:21:14:15 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [23/Jan/2012:21:14:15 +0100] cupsdSetBusyState: Dirty files
D [23/Jan/2012:21:14:15 +0100] cupsdReadClient: 18 POST / HTTP/1.1
D [23/Jan/2012:21:14:15 +0100] cupsdSetBusyState: Active clients and dirty files
D [23/Jan/2012:21:14:15 +0100] cupsdAuthorize: No authentication data provided.
D [23/Jan/2012:21:14:15 +0100] cupsdReadClient: 18 1.1 CUPS-Get-Classes 1
D [23/Jan/2012:21:14:15 +0100] CUPS-Get-Classes
D [23/Jan/2012:21:14:15 +0100] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost
D [23/Jan/2012:21:14:15 +0100] cupsdSetBusyState: Dirty files
D [23/Jan/2012:21:14:15 +0100] cupsdReadClient: 18 POST / HTTP/1.1
D [23/Jan/2012:21:14:15 +0100] cupsdSetBusyState: Active clients and dirty files
D [23/Jan/2012:21:14:15 +0100] cupsdAuthorize: No authentication data provided.
D [23/Jan/2012:21:14:15 +0100] cupsdReadClient: 18 1.1 CUPS-Get-Default 1
D [23/Jan/2012:21:14:15 +0100] CUPS-Get-Default
D [23/Jan/2012:21:14:15 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [23/Jan/2012:21:14:15 +0100] cupsdSetBusyState: Dirty files
D [23/Jan/2012:21:14:16 +0100] [Job 63] Unloading...
D [23/Jan/2012:21:14:34 +0100] cupsdReadClient: 13 POST / HTTP/1.1
D [23/Jan/2012:21:14:34 +0100] cupsdSetBusyState: Active clients and dirty files
D [23/Jan/2012:21:14:34 +0100] cupsdAuthorize: No authentication data provided.
I [23/Jan/2012:21:14:34 +0100] Saving job cache file "/var/cache/cups/job.cache"...
I [23/Jan/2012:21:14:34 +0100] Saving subscriptions.conf...
D [23/Jan/2012:21:14:34 +0100] cupsdSetBusyState: Active clients
D [23/Jan/2012:21:14:34 +0100] Report: clients=4
D [23/Jan/2012:21:14:34 +0100] Report: jobs=5
D [23/Jan/2012:21:14:34 +0100] Report: jobs-active=2
D [23/Jan/2012:21:14:34 +0100] Report: printers=1
D [23/Jan/2012:21:14:34 +0100] Report: printers-implicit=0
D [23/Jan/2012:21:14:34 +0100] Report: stringpool-string-count=14276
D [23/Jan/2012:21:14:34 +0100] Report: stringpool-alloc-bytes=10504
D [23/Jan/2012:21:14:34 +0100] Report: stringpool-total-bytes=262624
D [23/Jan/2012:21:14:34 +0100] cupsdReadClient: 13 1.1 Get-Job-Attributes 1
D [23/Jan/2012:21:14:34 +0100] Get-Job-Attributes
ipp://localhost/jobs/62D [23/Jan/2012:21:14:34 +0100] Returning IPP successful-ok for Get-Job-Attributes (
ipp://localhost/jobs/62) from localhost
D [23/Jan/2012:21:14:34 +0100] cupsdSetBusyState: Not busy
D [23/Jan/2012:21:14:34 +0100] cupsdReadClient: 13 POST / HTTP/1.1
D [23/Jan/2012:21:14:34 +0100] cupsdSetBusyState: Active clients
D [23/Jan/2012:21:14:34 +0100] cupsdAuthorize: No authentication data provided.
D [23/Jan/2012:21:14:34 +0100] cupsdReadClient: 13 1.1 Get-Job-Attributes 1
D [23/Jan/2012:21:14:34 +0100] Get-Job-Attributes
ipp://localhost/jobs/63D [23/Jan/2012:21:14:34 +0100] [Job 63] Loading attributes...
D [23/Jan/2012:21:14:34 +0100] Returning IPP successful-ok for Get-Job-Attributes (
ipp://localhost/jobs/63) from localhost
D [23/Jan/2012:21:14:34 +0100] cupsdSetBusyState: Not busy
D [23/Jan/2012:21:14:34 +0100] cupsdReadClient: 13 POST / HTTP/1.1
D [23/Jan/2012:21:14:34 +0100] cupsdSetBusyState: Active clients
D [23/Jan/2012:21:14:34 +0100] cupsdAuthorize: No authentication data provided.
D [23/Jan/2012:21:14:34 +0100] cupsdReadClient: 13 1.1 Cancel-Subscription 1
D [23/Jan/2012:21:14:34 +0100] Cancel-Subscription /
D [23/Jan/2012:21:14:34 +0100] cupsdIsAuthorized: requesting-user-name="phil"
D [23/Jan/2012:21:14:34 +0100] cupsdMarkDirty(-----S)
D [23/Jan/2012:21:14:34 +0100] cupsdSetBusyState: Active clients and dirty files
D [23/Jan/2012:21:14:34 +0100] Returning IPP successful-ok for Cancel-Subscription (/) from localhost
D [23/Jan/2012:21:14:34 +0100] cupsdSetBusyState: Dirty files
D [23/Jan/2012:21:14:34 +0100] cupsdReadClient: 13 PUT /admin/conf/cupsd.conf HTTP/1.1
D [23/Jan/2012:21:14:34 +0100] cupsdSetBusyState: Active clients and dirty files
D [23/Jan/2012:21:14:34 +0100] cupsdAuthorize: No authentication data provided.
D [23/Jan/2012:21:14:34 +0100] cupsdIsAuthorized: username=""
D [23/Jan/2012:21:14:34 +0100] cupsdSendHeader: 13 WWW-Authenticate: Basic realm="CUPS", trc="y"
D [23/Jan/2012:21:14:34 +0100] cupsdCloseClient: 13
D [23/Jan/2012:21:14:34 +0100] cupsdSetBusyState: Dirty files
D [23/Jan/2012:21:14:34 +0100] cupsdAcceptClient: 13 from localhost (Domain)
D [23/Jan/2012:21:14:34 +0100] cupsdReadClient: 13 PUT /admin/conf/cupsd.conf HTTP/1.1
D [23/Jan/2012:21:14:34 +0100] cupsdSetBusyState: Active clients and dirty files
D [23/Jan/2012:21:14:34 +0100] cupsdAuthorize: Authorized as phil using PeerCred
D [23/Jan/2012:21:14:34 +0100] cupsdIsAuthorized: username="phil"
I [23/Jan/2012:21:14:34 +0100] Installing config file "/etc/cups/cupsd.conf"...
D [23/Jan/2012:21:14:34 +0100] cupsdSetBusyState: Dirty files
D [23/Jan/2012:21:14:34 +0100] cupsdCloseClient: 14
D [23/Jan/2012:21:14:34 +0100] cupsdCloseClient: 18
D [23/Jan/2012:21:14:34 +0100] cupsdCloseClient: 17
D [23/Jan/2012:21:14:34 +0100] cupsdCloseClient: 13
D [23/Jan/2012:21:14:34 +0100] cupsdDeregisterPrinter(p=0x2286ebb0(HP-LaserJet-1018), removeit=1)
I [23/Jan/2012:21:14:34 +0100] Saving subscriptions.conf...
D [23/Jan/2012:21:14:34 +0100] cupsdSetBusyState: Not busy
E [23/Jan/2012:21:14:34 +0100] Failed to update TXT record for Hewlett-Packard HP LaserJet 1018 @ phil-VGN-FE11H: -2