[01/Mar/2012:21:39:53 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2012:21:39:53 +0100] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [01/Mar/2012:21:39:53 +0100] CUPS-Get-Printers
D [01/Mar/2012:21:39:53 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [01/Mar/2012:21:39:53 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [01/Mar/2012:21:39:53 +0100] cupsdReadClient: 13 WAITING Closing on EOF
D [01/Mar/2012:21:39:53 +0100] cupsdCloseClient: 13
D [01/Mar/2012:21:39:53 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [01/Mar/2012:21:39:53 +0100] cupsdAcceptClient: 13 from localhost (Domain)
D [01/Mar/2012:21:39:53 +0100] cupsdReadClient: 13 POST /printers/HP_6315 HTTP/1.1
D [01/Mar/2012:21:39:53 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [01/Mar/2012:21:39:53 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2012:21:39:53 +0100] cupsdReadClient: 13 1.1 Print-Job 1
D [01/Mar/2012:21:39:53 +0100] Print-Job ipp://localhost:631/printers/HP_6315
D [01/Mar/2012:21:39:53 +0100] [Job ???] Auto-typing file...
I [01/Mar/2012:21:39:53 +0100] [Job ???] Request file type is application/pdf.
D [01/Mar/2012:21:39:53 +0100] cupsdMarkDirty(----J-)
D [01/Mar/2012:21:39:53 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients"
D [01/Mar/2012:21:39:53 +0100] add_job: requesting-user-name="internet"
I [01/Mar/2012:21:39:53 +0100] [Job 57] Adding start banner page "none".
D [01/Mar/2012:21:39:53 +0100] Discarding unused job-created event...
D [01/Mar/2012:21:39:53 +0100] cupsdMarkDirty(----J-)
D [01/Mar/2012:21:39:53 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
I [01/Mar/2012:21:39:53 +0100] [Job 57] Adding end banner page "none".
I [01/Mar/2012:21:39:53 +0100] [Job 57] File of type application/pdf queued by "internet".
D [01/Mar/2012:21:39:53 +0100] [Job 57] hold_until=0
I [01/Mar/2012:21:39:53 +0100] [Job 57] Queued on "HP_6315" by "internet".
D [01/Mar/2012:21:39:53 +0100] cupsdMarkDirty(----J-)
D [01/Mar/2012:21:39:53 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [01/Mar/2012:21:39:53 +0100] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [01/Mar/2012:21:39:53 +0100] Discarding unused printer-state-changed event...
D [01/Mar/2012:21:39:53 +0100] [Job 57] job-sheets=none,none
D [01/Mar/2012:21:39:53 +0100] [Job 57] argv[0]="HP_6315"
D [01/Mar/2012:21:39:53 +0100] [Job 57] argv[1]="57"
D [01/Mar/2012:21:39:53 +0100] [Job 57] argv[2]="internet"
D [01/Mar/2012:21:39:53 +0100] [Job 57] argv[3]="file.pdf"
D [01/Mar/2012:21:39:53 +0100] [Job 57] argv[4]="1"
D [01/Mar/2012:21:39:53 +0100] [Job 57] argv[5]="InputSlot=Default number-up=1 Quality=FromPrintoutMode PageSize=A4 PrintoutMode=Normal DryTime=Zero Duplex=None job-uuid=urn:uuid:4410ef90-0b4b-3fe0-4fe5-456eee7308b5 job-originating-host-name=localhost time-at-creation=1330634393 time-at-processing=1330634393"
D [01/Mar/2012:21:39:53 +0100] [Job 57] argv[6]="/var/spool/cups/d00057-001"
D [01/Mar/2012:21:39:53 +0100] [Job 57] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [01/Mar/2012:21:39:53 +0100] [Job 57] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [01/Mar/2012:21:39:53 +0100] [Job 57] envp[2]="CUPS_DOCROOT=/usr/share/cups/webcontent"
D [01/Mar/2012:21:39:53 +0100] [Job 57] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [01/Mar/2012:21:39:53 +0100] [Job 57] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [01/Mar/2012:21:39:53 +0100] [Job 57] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [01/Mar/2012:21:39:53 +0100] [Job 57] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [01/Mar/2012:21:39:53 +0100] [Job 57] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [01/Mar/2012:21:39:53 +0100] [Job 57] envp[8]="HOME=/var/spool/cups/tmp"
D [01/Mar/2012:21:39:53 +0100] [Job 57] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [01/Mar/2012:21:39:53 +0100] [Job 57] envp[10]="SERVER_ADMIN=root@host"
D [01/Mar/2012:21:39:53 +0100] [Job 57] envp[11]="SOFTWARE=CUPS/1.5.0"
D [01/Mar/2012:21:39:53 +0100] [Job 57] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [01/Mar/2012:21:39:53 +0100] [Job 57] envp[13]="USER=root"
D [01/Mar/2012:21:39:53 +0100] [Job 57] envp[14]="CUPS_SERVER=/var/run/cups/cups.sock"
D [01/Mar/2012:21:39:53 +0100] [Job 57] envp[15]="CUPS_ENCRYPTION=IfRequested"
D [01/Mar/2012:21:39:53 +0100] [Job 57] envp[16]="IPP_PORT=631"
D [01/Mar/2012:21:39:53 +0100] [Job 57] envp[17]="CHARSET=utf-8"
D [01/Mar/2012:21:39:53 +0100] [Job 57] envp[18]="LANG=de_DE.UTF-8"
D [01/Mar/2012:21:39:53 +0100] [Job 57] envp[19]="PPD=/etc/cups/ppd/HP_6315.ppd"
D [01/Mar/2012:21:39:53 +0100] [Job 57] envp[20]="RIP_MAX_CACHE=128m"
D [01/Mar/2012:21:39:53 +0100] [Job 57] envp[21]="CONTENT_TYPE=application/pdf"
D [01/Mar/2012:21:39:53 +0100] [Job 57] envp[22]="DEVICE_URI=hp:/usb/Officejet_6300_series?serial=CN689CF0Q204M4"
D [01/Mar/2012:21:39:53 +0100] [Job 57] envp[23]="PRINTER_INFO=All_in_One"
D [01/Mar/2012:21:39:53 +0100] [Job 57] envp[24]="PRINTER_LOCATION=im_Büro"
D [01/Mar/2012:21:39:53 +0100] [Job 57] envp[25]="PRINTER=HP_6315"
D [01/Mar/2012:21:39:53 +0100] [Job 57] envp[26]="PRINTER_STATE_REASONS=marker-supply-low-warning"
D [01/Mar/2012:21:39:53 +0100] [Job 57] envp[27]="CUPS_FILETYPE=document"
D [01/Mar/2012:21:39:53 +0100] [Job 57] envp[28]="FINAL_CONTENT_TYPE=printer/HP_6315"
D [01/Mar/2012:21:39:53 +0100] [Job 57] envp[29]="AUTH_I****"
I [01/Mar/2012:21:39:53 +0100] [Job 57] Started filter /usr/lib/cups/filter/pdftops (PID 20717)
I [01/Mar/2012:21:39:53 +0100] [Job 57] Started filter /usr/lib/cups/filter/foomatic-rip (PID 20718)
I [01/Mar/2012:21:39:53 +0100] [Job 57] Started backend /usr/lib/cups/backend/hp (PID 20719)
D [01/Mar/2012:21:39:53 +0100] Discarding unused job-state-changed event...
D [01/Mar/2012:21:39:53 +0100] Returning IPP successful-ok for Print-Job (ipp://localhost:631/printers/HP_6315) from localhost
D [01/Mar/2012:21:39:53 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients and dirty files"
D [01/Mar/2012:21:39:53 +0100] cupsdReadClient: 13 WAITING Closing on EOF
D [01/Mar/2012:21:39:53 +0100] cupsdCloseClient: 13
D [01/Mar/2012:21:39:53 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [01/Mar/2012:21:39:53 +0100] [Job 57] Getting input from file 
D [01/Mar/2012:21:39:53 +0100] [Job 57] foomatic-rip version 4.0.9.241 running...
D [01/Mar/2012:21:39:53 +0100] [Job 57] Parsing PPD file ...
D [01/Mar/2012:21:39:53 +0100] [Job 57] Added option ColorSpace
D [01/Mar/2012:21:39:53 +0100] [Job 57] Added option Resolution
D [01/Mar/2012:21:39:53 +0100] [Job 57] Added option PageSize
D [01/Mar/2012:21:39:53 +0100] [Job 57] Added option Model
D [01/Mar/2012:21:39:53 +0100] [Job 57] Added option PrintoutMode
D [01/Mar/2012:21:39:53 +0100] [Job 57] Added option InputSlot
D [01/Mar/2012:21:39:53 +0100] [Job 57] Added option Duplex
D [01/Mar/2012:21:39:53 +0100] [Job 57] Added option DryTime
D [01/Mar/2012:21:39:53 +0100] [Job 57] Added option Quality
D [01/Mar/2012:21:39:53 +0100] [Job 57] Added option ImageableArea
D [01/Mar/2012:21:39:53 +0100] [Job 57] Added option PaperDimension
D [01/Mar/2012:21:39:53 +0100] [Job 57] Added option Font
D [01/Mar/2012:21:39:53 +0100] [Job 57] 
D [01/Mar/2012:21:39:53 +0100] [Job 57] Parameter Summary
D [01/Mar/2012:21:39:53 +0100] [Job 57] -----------------
D [01/Mar/2012:21:39:53 +0100] [Job 57] 
D [01/Mar/2012:21:39:53 +0100] [Job 57] Spooler: cups
D [01/Mar/2012:21:39:53 +0100] [Job 57] Printer: HP_6315
D [01/Mar/2012:21:39:53 +0100] [Job 57] Shell: /bin/bash
D [01/Mar/2012:21:39:53 +0100] [Job 57] PPD file: /etc/cups/ppd/HP_6315.ppd
D [01/Mar/2012:21:39:53 +0100] [Job 57] ATTR file: 
D [01/Mar/2012:21:39:53 +0100] [Job 57] Printer model: HP Officejet 6300 Series hpijs, 3.12.2
D [01/Mar/2012:21:39:53 +0100] [Job 57] Job title: file.pdf
D [01/Mar/2012:21:39:53 +0100] [Job 57] File(s) to be printed:
D [01/Mar/2012:21:39:53 +0100] [Job 57] <STDIN>
D [01/Mar/2012:21:39:53 +0100] [Job 57] 
D [01/Mar/2012:21:39:53 +0100] [Job 57] Ghostscript extra search path ('GS_LIB'): /usr/share/cups/fonts
D [01/Mar/2012:21:39:53 +0100] [Job 57] Printing system options:
D [01/Mar/2012:21:39:53 +0100] [Job 57] Pondering option 'number-up=1'
D [01/Mar/2012:21:39:53 +0100] [Job 57] Unknown option number-up=1.
D [01/Mar/2012:21:39:53 +0100] [Job 57] Pondering option 'job-uuid=urn:uuid:4410ef90-0b4b-3fe0-4fe5-456eee7308b5'
D [01/Mar/2012:21:39:53 +0100] [Job 57] Unknown option job-uuid=urn:uuid:4410ef90-0b4b-3fe0-4fe5-456eee7308b5.
D [01/Mar/2012:21:39:53 +0100] [Job 57] Pondering option 'job-originating-host-name=localhost'
D [01/Mar/2012:21:39:53 +0100] [Job 57] Unknown option job-originating-host-name=localhost.
D [01/Mar/2012:21:39:53 +0100] [Job 57] Pondering option 'time-at-creation=1330634393'
D [01/Mar/2012:21:39:53 +0100] [Job 57] Unknown option time-at-creation=1330634393.
D [01/Mar/2012:21:39:53 +0100] [Job 57] Pondering option 'time-at-processing=1330634393'
D [01/Mar/2012:21:39:53 +0100] [Job 57] Unknown option time-at-processing=1330634393.
D [01/Mar/2012:21:39:53 +0100] [Job 57] Options from the PPD file:
D [01/Mar/2012:21:39:53 +0100] [Job 57] Pondering option 'InputSlot=Default'
D [01/Mar/2012:21:39:53 +0100] [Job 57] Pondering option 'Quality=FromPrintoutMode'
D [01/Mar/2012:21:39:53 +0100] [Job 57] Pondering option 'PageSize=A4'
D [01/Mar/2012:21:39:53 +0100] [Job 57] Pondering option 'PrintoutMode=Normal'
D [01/Mar/2012:21:39:53 +0100] [Job 57] Pondering option 'DryTime=Zero'
D [01/Mar/2012:21:39:53 +0100] [Job 57] Pondering option 'Duplex=None'
D [01/Mar/2012:21:39:53 +0100] [Job 57] 
D [01/Mar/2012:21:39:53 +0100] [Job 57] ================================================
D [01/Mar/2012:21:39:53 +0100] [Job 57] 
D [01/Mar/2012:21:39:53 +0100] [Job 57] File: <STDIN>
D [01/Mar/2012:21:39:53 +0100] [Job 57] 
D [01/Mar/2012:21:39:53 +0100] [Job 57] ================================================
D [01/Mar/2012:21:39:53 +0100] [Job 57] 
D [01/Mar/2012:21:39:53 +0100] [Job 57] Started filter pdftops (PID 20721)
D [01/Mar/2012:21:39:53 +0100] [Job 57] Started filter pstops (PID 20722)
D [01/Mar/2012:21:39:53 +0100] [Job 57] Page = 595x842; 10,36 to 585,833
D [01/Mar/2012:21:39:53 +0100] [Job 57] slow_collate=0, slow_duplex=0, slow_order=0
D [01/Mar/2012:21:39:53 +0100] [Job 57] Before copy_comments - %!PS-Adobe-3.0
D [01/Mar/2012:21:39:53 +0100] [Job 57] %!PS-Adobe-3.0
D [01/Mar/2012:21:39:53 +0100] [Job 57] % Produced by poppler pdftops version: 0.18.0 (http://poppler.freedesktop.org)
D [01/Mar/2012:21:39:53 +0100] [Job 57] %%Creator: cairo 1.10.2 (http://cairographics.org)
D [01/Mar/2012:21:39:53 +0100] [Job 57] %%LanguageLevel: 3
D [01/Mar/2012:21:39:53 +0100] [Job 57] %%DocumentSuppliedResources: (atend)
D [01/Mar/2012:21:39:53 +0100] [Job 57] %%DocumentMedia: plain 596 842 0 () ()
D [01/Mar/2012:21:39:53 +0100] [Job 57] %%BoundingBox: 0 0 596 842
D [01/Mar/2012:21:39:53 +0100] [Job 57] %%Pages: 1
D [01/Mar/2012:21:39:53 +0100] [Job 57] %%EndComments
D [01/Mar/2012:21:39:53 +0100] [Job 57] Before copy_prolog - %%BeginDefaults
D [01/Mar/2012:21:39:53 +0100] [Job 57] Filetype: PostScript
D [01/Mar/2012:21:39:53 +0100] [Job 57] Reading PostScript input ...
D [01/Mar/2012:21:39:53 +0100] [Job 57] --> This document is DSC-conforming!
D [01/Mar/2012:21:39:53 +0100] [Job 57] Found %RBINumCopies: 1
D [01/Mar/2012:21:39:53 +0100] [Job 57] 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 [01/Mar/2012:21:39:53 +0100] [Job 57] 
D [01/Mar/2012:21:39:53 +0100] [Job 57] -----------
D [01/Mar/2012:21:39:53 +0100] [Job 57] Found: %%BeginProlog
D [01/Mar/2012:21:39:53 +0100] [Job 57] Before copy_setup - %%BeginSetup
D [01/Mar/2012:21:39:53 +0100] [Job 57] Found: %%EndProlog
D [01/Mar/2012:21:39:53 +0100] [Job 57] 
D [01/Mar/2012:21:39:53 +0100] [Job 57] -----------
D [01/Mar/2012:21:39:53 +0100] [Job 57] Found: %%BeginSetup
D [01/Mar/2012:21:39:53 +0100] [Job 57] Found: %%BeginFeature: *PageSize A4
D [01/Mar/2012:21:39:53 +0100] [Job 57] Option: PageSize=A4
D [01/Mar/2012:21:39:53 +0100] [Job 57] Setting option
D [01/Mar/2012:21:39:53 +0100] [Job 57] Found: %% FoomaticRIPOptionSetting: PageSize=A4
D [01/Mar/2012:21:39:53 +0100] [Job 57] Option: PageSize=A4
D [01/Mar/2012:21:39:53 +0100] [Job 57] Setting option
D [01/Mar/2012:21:39:53 +0100] [Job 57] Found: %%BeginFeature: *PrintoutMode Normal
D [01/Mar/2012:21:39:53 +0100] [Job 57] Option: PrintoutMode=Normal
D [01/Mar/2012:21:39:53 +0100] [Job 57] Setting option
D [01/Mar/2012:21:39:53 +0100] [Job 57] Found: %% FoomaticRIPOptionSetting: PrintoutMode=Normal
D [01/Mar/2012:21:39:53 +0100] [Job 57] Option: PrintoutMode=Normal
D [01/Mar/2012:21:39:53 +0100] [Job 57] Setting option
D [01/Mar/2012:21:39:53 +0100] [Job 57] Found: %%BeginFeature: *InputSlot Default
D [01/Mar/2012:21:39:53 +0100] [Job 57] Option: InputSlot=Default
D [01/Mar/2012:21:39:53 +0100] [Job 57] Setting option
D [01/Mar/2012:21:39:53 +0100] [Job 57] Found: %% FoomaticRIPOptionSetting: InputSlot=Default
D [01/Mar/2012:21:39:53 +0100] [Job 57] Option: InputSlot=Default
D [01/Mar/2012:21:39:53 +0100] [Job 57] Setting option
D [01/Mar/2012:21:39:53 +0100] [Job 57] Found: %%BeginFeature: *Quality FromPrintoutMode
D [01/Mar/2012:21:39:53 +0100] [Job 57] Option: Quality=FromPrintoutMode
D [01/Mar/2012:21:39:53 +0100] [Job 57] Setting option
D [01/Mar/2012:21:39:53 +0100] [Job 57] Found: %% FoomaticRIPOptionSetting: Quality=@PrintoutMode
D [01/Mar/2012:21:39:53 +0100] [Job 57] Option: Quality=FromPrintoutMode
D [01/Mar/2012:21:39:53 +0100] [Job 57] Setting option
D [01/Mar/2012:21:39:53 +0100] [Job 57] Found: %%BeginFeature: *DryTime Zero
D [01/Mar/2012:21:39:53 +0100] [Job 57] Option: DryTime=Zero
D [01/Mar/2012:21:39:53 +0100] [Job 57] Setting option
D [01/Mar/2012:21:39:53 +0100] [Job 57] Found: %% FoomaticRIPOptionSetting: DryTime=Zero
D [01/Mar/2012:21:39:53 +0100] [Job 57] Option: DryTime=Zero
D [01/Mar/2012:21:39:53 +0100] [Job 57] Setting option
D [01/Mar/2012:21:39:53 +0100] [Job 57] Found: %%BeginFeature: *Duplex None
D [01/Mar/2012:21:39:53 +0100] [Job 57] Option: Duplex=None
D [01/Mar/2012:21:39:53 +0100] [Job 57] Setting option
D [01/Mar/2012:21:39:53 +0100] [Job 57] Found: %% FoomaticRIPOptionSetting: Duplex=None
D [01/Mar/2012:21:39:53 +0100] [Job 57] Option: Duplex=None
D [01/Mar/2012:21:39:53 +0100] [Job 57] Setting option
D [01/Mar/2012:21:39:54 +0100] [Job 57] Before page loop - %%Page: 1 1
D [01/Mar/2012:21:39:54 +0100] [Job 57] Copying page 1...
D [01/Mar/2012:21:39:54 +0100] [Job 57] pagew = 575.6, pagel = 797.0
D [01/Mar/2012:21:39:54 +0100] [Job 57] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842
D [01/Mar/2012:21:39:54 +0100] [Job 57] PageLeft = 9.7, PageRight = 585.3
D [01/Mar/2012:21:39:54 +0100] [Job 57] PageTop = 833.0, PageBottom = 36.0
D [01/Mar/2012:21:39:54 +0100] [Job 57] PageWidth = 595.0, PageLength = 842.0
D [01/Mar/2012:21:39:54 +0100] [Job 57] Found: %%EndSetup
D [01/Mar/2012:21:39:54 +0100] [Job 57] Inserting PostScript code for CUPS' page accounting
D [01/Mar/2012:21:39:54 +0100] [Job 57] 
D [01/Mar/2012:21:39:54 +0100] [Job 57] -----------
D [01/Mar/2012:21:39:54 +0100] [Job 57] New page: %%Page: 1 1
D [01/Mar/2012:21:39:54 +0100] [Job 57] 
D [01/Mar/2012:21:39:54 +0100] [Job 57] Found: %%BeginPageSetup
D [01/Mar/2012:21:39:54 +0100] [Job 57] Inserting option code into "PageSetup" section.
D [01/Mar/2012:21:39:54 +0100] [Job 57] Wrote 1 pages...
D [01/Mar/2012:21:39:54 +0100] [Job 57] PID 20721 (pdftops) exited with no errors.
D [01/Mar/2012:21:39:54 +0100] [Job 57] PID 20722 (pstops) exited with no errors.
D [01/Mar/2012:21:39:54 +0100] PID 20717 (/usr/lib/cups/filter/pdftops) exited with no errors.
D [01/Mar/2012:21:39:54 +0100] [Job 57] Flushing FIFO.
D [01/Mar/2012:21:39:54 +0100] [Job 57] 
D [01/Mar/2012:21:39:54 +0100] [Job 57] Starting renderer with command: "gs -sstdout=%stderr  -dBATCH -dPARANOIDSAFER -dQUIET -dNOPAUSE -sDEVICE=ijs -sIjsServer=hpijs -dDEVICEWIDTHPOINTS=595 -dDEVICEHEIGHTPOINTS=842 -sDeviceManufacturer="HEWLETT-PACKARD" -sDeviceModel="deskjet 5600" -dDuplex=false -r300 -sIjsParams=Quality:Quality=0,Quality:ColorMode=2,Quality:MediaType=0,Quality:PenSet=2,PS:MediaPosition=7 -dIjsUseOutputFD -sOutputFile=%stdout -_"
D [01/Mar/2012:21:39:54 +0100] [Job 57] Starting process "kid3" (generation 1)
D [01/Mar/2012:21:39:54 +0100] [Job 57] Starting process "kid4" (generation 2)
D [01/Mar/2012:21:39:54 +0100] [Job 57] Starting process "renderer" (generation 2)
D [01/Mar/2012:21:39:54 +0100] [Job 57] JCL: %-12345X@PJL
D [01/Mar/2012:21:39:54 +0100] [Job 57] <job data> 
D [01/Mar/2012:21:39:54 +0100] [Job 57] 
D [01/Mar/2012:21:39:54 +0100] [Job 57] 
D [01/Mar/2012:21:39:54 +0100] [Job 57] Closing renderer
D [01/Mar/2012:21:39:54 +0100] [Job 57] PAGE: 1 1
D [01/Mar/2012:21:39:54 +0100] Discarding unused job-progress event...
D [01/Mar/2012:21:39:54 +0100] [Job 57] STATE: +connecting-to-device
D [01/Mar/2012:21:39:54 +0100] Discarding unused printer-state-changed event...
D [01/Mar/2012:21:39:54 +0100] [Job 57] STATE: -connecting-to-device
D [01/Mar/2012:21:39:54 +0100] [Job 57] STATE: -media-empty-error,media-jam-error,hplip.plugin-error,cover-open-error,toner-empty-error,other
D [01/Mar/2012:21:39:54 +0100] Discarding unused printer-state-changed event...
D [01/Mar/2012:21:40:06 +0100] [Job 57] renderer exited with status 0
D [01/Mar/2012:21:40:07 +0100] [Job 57] kid4 exited with status 0
D [01/Mar/2012:21:40:07 +0100] [Job 57] kid3 finished
D [01/Mar/2012:21:40:07 +0100] [Job 57] kid3 exited with status 0
D [01/Mar/2012:21:40:07 +0100] [Job 57] 
D [01/Mar/2012:21:40:07 +0100] [Job 57] Closing foomatic-rip.
D [01/Mar/2012:21:40:07 +0100] PID 20718 (/usr/lib/cups/filter/foomatic-rip) exited with no errors.
I [01/Mar/2012:21:40:14 +0100] [Job 57] ready to print
D [01/Mar/2012:21:40:14 +0100] [Job 57] Set job-printer-state-message to "ready to print", current level=INFO
D [01/Mar/2012:21:40:14 +0100] Discarding unused job-progress event...
D [01/Mar/2012:21:40:14 +0100] Discarding unused printer-state-changed event...
D [01/Mar/2012:21:40:14 +0100] PID 20719 (/usr/lib/cups/backend/hp) exited with no errors.
D [01/Mar/2012:21:40:14 +0100] Discarding unused job-completed event...
I [01/Mar/2012:21:40:14 +0100] [Job 57] Job completed.
D [01/Mar/2012:21:40:14 +0100] cupsdMarkDirty(----J-)
D [01/Mar/2012:21:40:14 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [01/Mar/2012:21:40:14 +0100] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
D [01/Mar/2012:21:40:14 +0100] Discarding unused printer-state-changed event...
D [01/Mar/2012:21:40:15 +0100] [Job 57] Unloading...
I [01/Mar/2012:21:40:24 +0100] Saving job.cache...
D [01/Mar/2012:21:40:24 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Printing jobs and dirty files"
D [01/Mar/2012:21:40:24 +0100] Report: clients=0
D [01/Mar/2012:21:40:24 +0100] Report: jobs=16
D [01/Mar/2012:21:40:24 +0100] Report: jobs-active=0
D [01/Mar/2012:21:40:24 +0100] Report: printers=1
D [01/Mar/2012:21:40:24 +0100] Report: printers-implicit=0
D [01/Mar/2012:21:40:24 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:21:40:24 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:21:40:24 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:21:40:46 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:21:40:46 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:21:40:46 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:21:40:46 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:21:41:48 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:21:41:48 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:21:41:48 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:21:41:48 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:21:41:48 +0100] Report: clients=0
D [01/Mar/2012:21:41:48 +0100] Report: jobs=16
D [01/Mar/2012:21:41:48 +0100] Report: jobs-active=0
D [01/Mar/2012:21:41:48 +0100] Report: printers=1
D [01/Mar/2012:21:41:48 +0100] Report: printers-implicit=0
D [01/Mar/2012:21:41:48 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:21:41:48 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:21:41:48 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:21:42:50 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:21:42:50 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:21:42:50 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:21:42:50 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:21:42:50 +0100] Report: clients=0
D [01/Mar/2012:21:42:50 +0100] Report: jobs=16
D [01/Mar/2012:21:42:50 +0100] Report: jobs-active=0
D [01/Mar/2012:21:42:50 +0100] Report: printers=1
D [01/Mar/2012:21:42:50 +0100] Report: printers-implicit=0
D [01/Mar/2012:21:42:50 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:21:42:50 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:21:42:50 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:21:43:52 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:21:43:52 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:21:43:52 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:21:43:52 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:21:43:52 +0100] Report: clients=0
D [01/Mar/2012:21:43:52 +0100] Report: jobs=16
D [01/Mar/2012:21:43:52 +0100] Report: jobs-active=0
D [01/Mar/2012:21:43:52 +0100] Report: printers=1
D [01/Mar/2012:21:43:52 +0100] Report: printers-implicit=0
D [01/Mar/2012:21:43:52 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:21:43:52 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:21:43:52 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:21:44:54 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:21:44:54 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:21:44:54 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:21:44:54 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:21:44:54 +0100] Report: clients=0
D [01/Mar/2012:21:44:54 +0100] Report: jobs=16
D [01/Mar/2012:21:44:54 +0100] Report: jobs-active=0
D [01/Mar/2012:21:44:54 +0100] Report: printers=1
D [01/Mar/2012:21:44:54 +0100] Report: printers-implicit=0
D [01/Mar/2012:21:44:54 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:21:44:54 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:21:44:54 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:21:45:56 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:21:45:56 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:21:45:56 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:21:45:56 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:21:45:56 +0100] Report: clients=0
D [01/Mar/2012:21:45:56 +0100] Report: jobs=16
D [01/Mar/2012:21:45:56 +0100] Report: jobs-active=0
D [01/Mar/2012:21:45:56 +0100] Report: printers=1
D [01/Mar/2012:21:45:56 +0100] Report: printers-implicit=0
D [01/Mar/2012:21:45:56 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:21:45:56 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:21:45:56 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:21:46:59 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:21:46:59 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:21:46:59 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:21:46:59 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:21:46:59 +0100] Report: clients=0
D [01/Mar/2012:21:46:59 +0100] Report: jobs=16
D [01/Mar/2012:21:46:59 +0100] Report: jobs-active=0
D [01/Mar/2012:21:46:59 +0100] Report: printers=1
D [01/Mar/2012:21:46:59 +0100] Report: printers-implicit=0
D [01/Mar/2012:21:46:59 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:21:46:59 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:21:46:59 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:21:48:01 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:21:48:01 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:21:48:01 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:21:48:01 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:21:48:01 +0100] Report: clients=0
D [01/Mar/2012:21:48:01 +0100] Report: jobs=16
D [01/Mar/2012:21:48:01 +0100] Report: jobs-active=0
D [01/Mar/2012:21:48:01 +0100] Report: printers=1
D [01/Mar/2012:21:48:01 +0100] Report: printers-implicit=0
D [01/Mar/2012:21:48:01 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:21:48:01 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:21:48:01 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:21:49:03 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:21:49:03 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:21:49:03 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:21:49:03 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:21:49:03 +0100] Report: clients=0
D [01/Mar/2012:21:49:03 +0100] Report: jobs=16
D [01/Mar/2012:21:49:03 +0100] Report: jobs-active=0
D [01/Mar/2012:21:49:03 +0100] Report: printers=1
D [01/Mar/2012:21:49:03 +0100] Report: printers-implicit=0
D [01/Mar/2012:21:49:03 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:21:49:03 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:21:49:03 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:21:50:05 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:21:50:05 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:21:50:05 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:21:50:05 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:21:50:05 +0100] Report: clients=0
D [01/Mar/2012:21:50:05 +0100] Report: jobs=16
D [01/Mar/2012:21:50:05 +0100] Report: jobs-active=0
D [01/Mar/2012:21:50:05 +0100] Report: printers=1
D [01/Mar/2012:21:50:05 +0100] Report: printers-implicit=0
D [01/Mar/2012:21:50:05 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:21:50:05 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:21:50:05 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:21:51:07 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:21:51:07 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:21:51:07 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:21:51:07 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:21:51:07 +0100] Report: clients=0
D [01/Mar/2012:21:51:07 +0100] Report: jobs=16
D [01/Mar/2012:21:51:07 +0100] Report: jobs-active=0
D [01/Mar/2012:21:51:07 +0100] Report: printers=1
D [01/Mar/2012:21:51:07 +0100] Report: printers-implicit=0
D [01/Mar/2012:21:51:07 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:21:51:07 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:21:51:07 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:21:52:09 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:21:52:09 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:21:52:09 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:21:52:09 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:21:52:09 +0100] Report: clients=0
D [01/Mar/2012:21:52:09 +0100] Report: jobs=16
D [01/Mar/2012:21:52:09 +0100] Report: jobs-active=0
D [01/Mar/2012:21:52:09 +0100] Report: printers=1
D [01/Mar/2012:21:52:09 +0100] Report: printers-implicit=0
D [01/Mar/2012:21:52:09 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:21:52:09 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:21:52:09 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:21:53:11 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:21:53:11 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:21:53:11 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:21:53:11 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:21:53:11 +0100] Report: clients=0
D [01/Mar/2012:21:53:11 +0100] Report: jobs=16
D [01/Mar/2012:21:53:11 +0100] Report: jobs-active=0
D [01/Mar/2012:21:53:11 +0100] Report: printers=1
D [01/Mar/2012:21:53:11 +0100] Report: printers-implicit=0
D [01/Mar/2012:21:53:11 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:21:53:11 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:21:53:11 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:21:54:13 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:21:54:13 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:21:54:13 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:21:54:13 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:21:54:13 +0100] Report: clients=0
D [01/Mar/2012:21:54:13 +0100] Report: jobs=16
D [01/Mar/2012:21:54:13 +0100] Report: jobs-active=0
D [01/Mar/2012:21:54:13 +0100] Report: printers=1
D [01/Mar/2012:21:54:13 +0100] Report: printers-implicit=0
D [01/Mar/2012:21:54:13 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:21:54:13 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:21:54:13 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:21:55:15 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:21:55:15 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:21:55:15 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:21:55:15 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:21:55:15 +0100] Report: clients=0
D [01/Mar/2012:21:55:15 +0100] Report: jobs=16
D [01/Mar/2012:21:55:15 +0100] Report: jobs-active=0
D [01/Mar/2012:21:55:15 +0100] Report: printers=1
D [01/Mar/2012:21:55:15 +0100] Report: printers-implicit=0
D [01/Mar/2012:21:55:15 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:21:55:15 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:21:55:15 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:21:56:17 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:21:56:17 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:21:56:17 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:21:56:17 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:21:56:17 +0100] Report: clients=0
D [01/Mar/2012:21:56:17 +0100] Report: jobs=16
D [01/Mar/2012:21:56:17 +0100] Report: jobs-active=0
D [01/Mar/2012:21:56:17 +0100] Report: printers=1
D [01/Mar/2012:21:56:17 +0100] Report: printers-implicit=0
D [01/Mar/2012:21:56:17 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:21:56:17 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:21:56:17 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:21:57:19 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:21:57:19 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:21:57:19 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:21:57:19 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:21:57:19 +0100] Report: clients=0
D [01/Mar/2012:21:57:19 +0100] Report: jobs=16
D [01/Mar/2012:21:57:19 +0100] Report: jobs-active=0
D [01/Mar/2012:21:57:19 +0100] Report: printers=1
D [01/Mar/2012:21:57:19 +0100] Report: printers-implicit=0
D [01/Mar/2012:21:57:19 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:21:57:19 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:21:57:19 +0100] Report: stringpool-total-bytes=54856
I [01/Mar/2012:21:57:52 +0100] Scheduler shutting down normally.
D [01/Mar/2012:21:57:52 +0100] Discarding unused server-stopped event...
D [01/Mar/2012:21:57:52 +0100] cupsdDeregisterPrinter(p=0xb7816520(HP_6315), removeit=1)
I [01/Mar/2012:21:57:52 +0100] Saving job.cache...
I [01/Mar/2012:22:22:09 +0100] Listening to 0.0.0.0:631 (IPv4)
I [01/Mar/2012:22:22:09 +0100] Listening to [v1.::]:631 (IPv6)
I [01/Mar/2012:22:22:09 +0100] Listening to /var/run/cups/cups.sock (Domain)
W [01/Mar/2012:22:22:09 +0100] No limit for Validate-Job defined in policy allowallforanybody and no suitable template found.
W [01/Mar/2012:22:22:09 +0100] No limit for Cancel-Jobs defined in policy allowallforanybody and no suitable template found.
W [01/Mar/2012:22:22:09 +0100] No limit for Cancel-My-Jobs defined in policy allowallforanybody and no suitable template found.
W [01/Mar/2012:22:22:09 +0100] No limit for Close-Job defined in policy allowallforanybody and no suitable template found.
W [01/Mar/2012:22:22:09 +0100] No limit for CUPS-Get-Document defined in policy allowallforanybody and no suitable template found.
W [01/Mar/2012:22:22:09 +0100] No JobPrivateAccess defined in policy allowallforanybody - using defaults.
W [01/Mar/2012:22:22:09 +0100] No JobPrivateValues defined in policy allowallforanybody - using defaults.
W [01/Mar/2012:22:22:09 +0100] No SubscriptionPrivateAccess defined in policy allowallforanybody - using defaults.
W [01/Mar/2012:22:22:09 +0100] No SubscriptionPrivateValues defined in policy allowallforanybody - using defaults.
I [01/Mar/2012:22:22:09 +0100] Remote access is enabled.
D [01/Mar/2012:22:22:09 +0100] Added auto ServerAlias host
I [01/Mar/2012:22:22:09 +0100] Loaded configuration file "/etc/cups/cupsd.conf"
D [01/Mar/2012:22:22:09 +0100] Creating missing directory "/var/run/cups"
D [01/Mar/2012:22:22:09 +0100] Repairing ownership of "/var/run/cups"
D [01/Mar/2012:22:22:09 +0100] Repairing access permissions of "/var/run/cups"
D [01/Mar/2012:22:22:09 +0100] Creating missing directory "/var/run/cups/certs"
D [01/Mar/2012:22:22:09 +0100] Repairing ownership of "/var/run/cups/certs"
D [01/Mar/2012:22:22:09 +0100] Repairing access permissions of "/var/run/cups/certs"
I [01/Mar/2012:22:22:09 +0100] Using default TempDir of /var/spool/cups/tmp...
I [01/Mar/2012:22:22:09 +0100] Configured for up to 100 clients.
I [01/Mar/2012:22:22:09 +0100] Allowing up to 100 client connections per host.
I [01/Mar/2012:22:22:09 +0100] Full reload is required.
I [01/Mar/2012:22:22:09 +0100] Loaded MIME database from "/usr/share/cups/mime" and "/etc/cups": 35 types, 46 filters...
D [01/Mar/2012:22:22:09 +0100] Loading printer HP_6315...
D [01/Mar/2012:22:22:09 +0100] load_ppd: Loading /var/cache/cups/HP_6315.data...
D [01/Mar/2012:22:22:09 +0100] cupsdRegisterPrinter(p=0xb7859520(HP_6315))
I [01/Mar/2012:22:22:09 +0100] Loading job cache file "/var/cache/cups/job.cache"...
D [01/Mar/2012:22:22:09 +0100] [Job 42] Loading from cache...
D [01/Mar/2012:22:22:09 +0100] [Job 43] Loading from cache...
D [01/Mar/2012:22:22:09 +0100] [Job 44] Loading from cache...
D [01/Mar/2012:22:22:09 +0100] [Job 45] Loading from cache...
D [01/Mar/2012:22:22:09 +0100] [Job 46] Loading from cache...
D [01/Mar/2012:22:22:09 +0100] [Job 47] Loading from cache...
D [01/Mar/2012:22:22:09 +0100] [Job 48] Loading from cache...
D [01/Mar/2012:22:22:09 +0100] [Job 49] Loading from cache...
D [01/Mar/2012:22:22:09 +0100] [Job 50] Loading from cache...
D [01/Mar/2012:22:22:09 +0100] [Job 51] Loading from cache...
D [01/Mar/2012:22:22:09 +0100] [Job 52] Loading from cache...
D [01/Mar/2012:22:22:09 +0100] [Job 53] Loading from cache...
D [01/Mar/2012:22:22:09 +0100] [Job 54] Loading from cache...
D [01/Mar/2012:22:22:09 +0100] [Job 55] Loading from cache...
D [01/Mar/2012:22:22:09 +0100] [Job 56] Loading from cache...
D [01/Mar/2012:22:22:09 +0100] [Job 57] Loading from cache...
I [01/Mar/2012:22:22:09 +0100] Full reload complete.
D [01/Mar/2012:22:22:09 +0100] cupsdCleanFiles(path="/var/spool/cups/tmp", pattern="(null)")
I [01/Mar/2012:22:22:09 +0100] Cleaning out old files in "/var/spool/cups/tmp"...
D [01/Mar/2012:22:22:09 +0100] cupsdCleanFiles(path="/var/cache/cups", pattern="*.ipp")
I [01/Mar/2012:22:22:09 +0100] Cleaning out old files in "/var/cache/cups"...
I [01/Mar/2012:22:22:09 +0100] Listening to 0.0.0.0:631 on fd 7...
I [01/Mar/2012:22:22:09 +0100] Listening to [v1.::]:631 on fd 8...
I [01/Mar/2012:22:22:09 +0100] Listening to /var/run/cups/cups.sock:631 on fd 9...
I [01/Mar/2012:22:22:09 +0100] Resuming new connection processing...
D [01/Mar/2012:22:22:09 +0100] cupsdRegisterPrinter(p=0xb7859520(HP_6315))
D [01/Mar/2012:22:22:09 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [01/Mar/2012:22:22:09 +0100] Discarding unused server-started event...
D [01/Mar/2012:22:22:10 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:22:10 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:22:10 +0100] Report: clients=0
D [01/Mar/2012:22:22:10 +0100] Report: jobs=16
D [01/Mar/2012:22:22:10 +0100] Report: jobs-active=0
D [01/Mar/2012:22:22:10 +0100] Report: printers=1
D [01/Mar/2012:22:22:10 +0100] Report: printers-implicit=0
D [01/Mar/2012:22:22:10 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:22:22:10 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:22:22:10 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:22:22:55 +0100] cupsdAcceptClient: 13 from localhost:631 (IPv6)
D [01/Mar/2012:22:22:55 +0100] cupsdReadClient: 13 POST / HTTP/1.1
D [01/Mar/2012:22:22:55 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [01/Mar/2012:22:22:55 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2012:22:22:55 +0100] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [01/Mar/2012:22:22:55 +0100] CUPS-Get-Printers
D [01/Mar/2012:22:22:55 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [01/Mar/2012:22:22:55 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [01/Mar/2012:22:22:55 +0100] cupsdReadClient: 13 POST / HTTP/1.1
D [01/Mar/2012:22:22:55 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [01/Mar/2012:22:22:55 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2012:22:22:55 +0100] cupsdReadClient: 13 1.1 CUPS-Get-Default 1
D [01/Mar/2012:22:22:55 +0100] CUPS-Get-Default
D [01/Mar/2012:22:22:55 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [01/Mar/2012:22:22:55 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [01/Mar/2012:22:22:55 +0100] cupsdReadClient: 13 POST / HTTP/1.1
D [01/Mar/2012:22:22:55 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [01/Mar/2012:22:22:55 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2012:22:22:55 +0100] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [01/Mar/2012:22:22:55 +0100] CUPS-Get-Printers
D [01/Mar/2012:22:22:55 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [01/Mar/2012:22:22:55 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [01/Mar/2012:22:22:55 +0100] cupsdReadClient: 13 WAITING Closing on EOF
D [01/Mar/2012:22:22:55 +0100] cupsdCloseClient: 13
D [01/Mar/2012:22:22:55 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [01/Mar/2012:22:23:04 +0100] cupsdAcceptClient: 13 from localhost (Domain)
D [01/Mar/2012:22:23:04 +0100] cupsdReadClient: 13 POST / HTTP/1.1
D [01/Mar/2012:22:23:04 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [01/Mar/2012:22:23:04 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2012:22:23:04 +0100] cupsdReadClient: 13 1.1 CUPS-Get-Printers 1
D [01/Mar/2012:22:23:04 +0100] CUPS-Get-Printers
D [01/Mar/2012:22:23:04 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [01/Mar/2012:22:23:04 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [01/Mar/2012:22:23:10 +0100] cupsdAcceptClient: 14 from localhost (Domain)
D [01/Mar/2012:22:23:10 +0100] Report: clients=2
D [01/Mar/2012:22:23:10 +0100] Report: jobs=16
D [01/Mar/2012:22:23:10 +0100] Report: jobs-active=0
D [01/Mar/2012:22:23:10 +0100] Report: printers=1
D [01/Mar/2012:22:23:10 +0100] Report: printers-implicit=0
D [01/Mar/2012:22:23:10 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:22:23:10 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:22:23:10 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:22:23:10 +0100] cupsdReadClient: 14 POST / HTTP/1.1
D [01/Mar/2012:22:23:10 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [01/Mar/2012:22:23:10 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2012:22:23:10 +0100] cupsdReadClient: 14 1.1 CUPS-Get-Printers 1
D [01/Mar/2012:22:23:10 +0100] CUPS-Get-Printers
D [01/Mar/2012:22:23:10 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [01/Mar/2012:22:23:10 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [01/Mar/2012:22:23:12 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:23:12 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:22:23:12 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:23:12 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:22:24:14 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:24:14 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:22:24:14 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:24:14 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:22:24:14 +0100] Report: clients=2
D [01/Mar/2012:22:24:14 +0100] Report: jobs=16
D [01/Mar/2012:22:24:14 +0100] Report: jobs-active=0
D [01/Mar/2012:22:24:14 +0100] Report: printers=1
D [01/Mar/2012:22:24:14 +0100] Report: printers-implicit=0
D [01/Mar/2012:22:24:14 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:22:24:14 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:22:24:14 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:22:24:43 +0100] cupsdAcceptClient: 15 from localhost:631 (IPv6)
D [01/Mar/2012:22:24:43 +0100] cupsdReadClient: 15 GET / HTTP/1.1
D [01/Mar/2012:22:24:43 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [01/Mar/2012:22:24:43 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2012:22:24:43 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [01/Mar/2012:22:24:43 +0100] cupsdReadClient: 15 GET /cups.css HTTP/1.1
D [01/Mar/2012:22:24:43 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [01/Mar/2012:22:24:43 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2012:22:24:43 +0100] cupsdAcceptClient: 17 from localhost:631 (IPv6)
D [01/Mar/2012:22:24:43 +0100] cupsdAcceptClient: 18 from localhost:631 (IPv6)
D [01/Mar/2012:22:24:43 +0100] cupsdReadClient: 17 GET /images/left.gif HTTP/1.1
D [01/Mar/2012:22:24:43 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [01/Mar/2012:22:24:43 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2012:22:24:43 +0100] cupsdAcceptClient: 20 from localhost:631 (IPv6)
D [01/Mar/2012:22:24:43 +0100] cupsdReadClient: 18 GET /images/right.gif HTTP/1.1
D [01/Mar/2012:22:24:43 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [01/Mar/2012:22:24:43 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2012:22:24:43 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [01/Mar/2012:22:24:43 +0100] cupsdReadClient: 20 GET /images/cups-icon.png HTTP/1.1
D [01/Mar/2012:22:24:43 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [01/Mar/2012:22:24:43 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2012:22:24:43 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [01/Mar/2012:22:24:43 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [01/Mar/2012:22:24:43 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [01/Mar/2012:22:24:43 +0100] cupsdReadClient: 15 GET /images/sel.gif HTTP/1.1
D [01/Mar/2012:22:24:43 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [01/Mar/2012:22:24:43 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2012:22:24:43 +0100] cupsdReadClient: 20 GET /images/unsel.gif HTTP/1.1
D [01/Mar/2012:22:24:43 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [01/Mar/2012:22:24:43 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2012:22:24:43 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [01/Mar/2012:22:24:43 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [01/Mar/2012:22:24:55 +0100] cupsdReadClient: 15 GET /jobs/ HTTP/1.1
D [01/Mar/2012:22:24:55 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [01/Mar/2012:22:24:55 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2012:22:24:55 +0100] [CGI] argv[0] = "/usr/lib/cups/cgi-bin/jobs.cgi"
D [01/Mar/2012:22:24:55 +0100] [CGI] envp[0] = "CUPS_CACHEDIR=/var/cache/cups"
D [01/Mar/2012:22:24:55 +0100] [CGI] envp[1] = "CUPS_DATADIR=/usr/share/cups"
D [01/Mar/2012:22:24:55 +0100] [CGI] envp[2] = "CUPS_DOCROOT=/usr/share/cups/webcontent"
D [01/Mar/2012:22:24:55 +0100] [CGI] envp[3] = "CUPS_FONTPATH=/usr/share/cups/fonts"
D [01/Mar/2012:22:24:55 +0100] [CGI] envp[4] = "CUPS_REQUESTROOT=/var/spool/cups"
D [01/Mar/2012:22:24:55 +0100] [CGI] envp[5] = "CUPS_SERVERBIN=/usr/lib/cups"
D [01/Mar/2012:22:24:55 +0100] [CGI] envp[6] = "CUPS_SERVERROOT=/etc/cups"
D [01/Mar/2012:22:24:55 +0100] [CGI] envp[7] = "CUPS_STATEDIR=/var/run/cups"
D [01/Mar/2012:22:24:55 +0100] [CGI] envp[8] = "HOME=/var/spool/cups/tmp"
D [01/Mar/2012:22:24:55 +0100] [CGI] envp[9] = "PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [01/Mar/2012:22:24:55 +0100] [CGI] envp[10] = "SERVER_ADMIN=root@host"
D [01/Mar/2012:22:24:55 +0100] [CGI] envp[11] = "SOFTWARE=CUPS/1.5.0"
D [01/Mar/2012:22:24:55 +0100] [CGI] envp[12] = "TMPDIR=/var/spool/cups/tmp"
D [01/Mar/2012:22:24:55 +0100] [CGI] envp[13] = "USER=root"
D [01/Mar/2012:22:24:55 +0100] [CGI] envp[14] = "CUPS_SERVER=/var/run/cups/cups.sock"
D [01/Mar/2012:22:24:55 +0100] [CGI] envp[15] = "CUPS_ENCRYPTION=IfRequested"
D [01/Mar/2012:22:24:55 +0100] [CGI] envp[16] = "IPP_PORT=631"
D [01/Mar/2012:22:24:55 +0100] [CGI] envp[17] = "LANG=de_DE.UTF8"
D [01/Mar/2012:22:24:55 +0100] [CGI] envp[18] = "REDIRECT_STATUS=1"
D [01/Mar/2012:22:24:55 +0100] [CGI] envp[19] = "GATEWAY_INTERFACE=CGI/1.1"
D [01/Mar/2012:22:24:55 +0100] [CGI] envp[20] = "SERVER_NAME=localhost"
D [01/Mar/2012:22:24:55 +0100] [CGI] envp[21] = "SERVER_PORT=631"
D [01/Mar/2012:22:24:55 +0100] [CGI] envp[22] = "REMOTE_ADDR=[v1.::1]"
D [01/Mar/2012:22:24:55 +0100] [CGI] envp[23] = "REMOTE_HOST=localhost"
D [01/Mar/2012:22:24:55 +0100] [CGI] envp[24] = "SCRIPT_NAME=/jobs/"
D [01/Mar/2012:22:24:55 +0100] [CGI] envp[25] = "SCRIPT_FILENAME=/usr/share/cups/webcontent/jobs/"
D [01/Mar/2012:22:24:55 +0100] [CGI] envp[26] = "SERVER_PROTOCOL=HTTP/1.1"
D [01/Mar/2012:22:24:55 +0100] [CGI] envp[27] = "HTTP_USER_AGENT=Mozilla/5.0 (X11; Linux i686; rv:10.0.2) Gecko/20100101 Firefox/10.0.2"
D [01/Mar/2012:22:24:55 +0100] [CGI] envp[28] = "HTTP_REFERER=http://localhost:631/"
D [01/Mar/2012:22:24:55 +0100] [CGI] envp[29] = "REQUEST_METHOD=GET"
D [01/Mar/2012:22:24:55 +0100] [CGI] envp[30] = "QUERY_STRING="
D [01/Mar/2012:22:24:55 +0100] [CGI] Started /usr/lib/cups/cgi-bin/jobs.cgi (PID 4059)
I [01/Mar/2012:22:24:55 +0100] Started "/usr/lib/cups/cgi-bin/jobs.cgi" (pid=4059)
D [01/Mar/2012:22:24:55 +0100] cupsdSendCommand: 15 file=16
D [01/Mar/2012:22:24:55 +0100] [CGI] org.cups.sid cookie not found, initializing!
D [01/Mar/2012:22:24:55 +0100] [CGI] org.cups.sid cookie is "4fbda4d4a64cddf774a514258c20996b"
D [01/Mar/2012:22:24:55 +0100] cupsdAcceptClient: 19 from localhost (Domain)
D [01/Mar/2012:22:24:55 +0100] Script header: Set-Cookie: org.cups.sid=4fbda4d4a64cddf774a514258c20996b;; path=/;
D [01/Mar/2012:22:24:55 +0100] Script header: Content-Type: text/html;charset=utf-8
D [01/Mar/2012:22:24:55 +0100] Script header: 
D [01/Mar/2012:22:24:55 +0100] cupsdReadClient: 19 POST / HTTP/1.1
D [01/Mar/2012:22:24:55 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [01/Mar/2012:22:24:55 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2012:22:24:55 +0100] cupsdReadClient: 19 1.1 Get-Jobs 1
D [01/Mar/2012:22:24:55 +0100] Get-Jobs ipp://localhost/
D [01/Mar/2012:22:24:55 +0100] Returning IPP successful-ok for Get-Jobs (ipp://localhost/) from localhost
D [01/Mar/2012:22:24:55 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [01/Mar/2012:22:24:55 +0100] cupsdReadClient: 19 WAITING Closing on EOF
D [01/Mar/2012:22:24:55 +0100] cupsdCloseClient: 19
D [01/Mar/2012:22:24:55 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [01/Mar/2012:22:24:55 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [01/Mar/2012:22:24:55 +0100] PID 4059 (/usr/lib/cups/cgi-bin/jobs.cgi) exited with no errors.
D [01/Mar/2012:22:24:57 +0100] cupsdReadClient: 15 GET /printers/ HTTP/1.1
D [01/Mar/2012:22:24:57 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [01/Mar/2012:22:24:57 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2012:22:24:57 +0100] [CGI] argv[0] = "/usr/lib/cups/cgi-bin/printers.cgi"
D [01/Mar/2012:22:24:57 +0100] [CGI] envp[0] = "CUPS_CACHEDIR=/var/cache/cups"
D [01/Mar/2012:22:24:57 +0100] [CGI] envp[1] = "CUPS_DATADIR=/usr/share/cups"
D [01/Mar/2012:22:24:57 +0100] [CGI] envp[2] = "CUPS_DOCROOT=/usr/share/cups/webcontent"
D [01/Mar/2012:22:24:57 +0100] [CGI] envp[3] = "CUPS_FONTPATH=/usr/share/cups/fonts"
D [01/Mar/2012:22:24:57 +0100] [CGI] envp[4] = "CUPS_REQUESTROOT=/var/spool/cups"
D [01/Mar/2012:22:24:57 +0100] [CGI] envp[5] = "CUPS_SERVERBIN=/usr/lib/cups"
D [01/Mar/2012:22:24:57 +0100] [CGI] envp[6] = "CUPS_SERVERROOT=/etc/cups"
D [01/Mar/2012:22:24:57 +0100] [CGI] envp[7] = "CUPS_STATEDIR=/var/run/cups"
D [01/Mar/2012:22:24:57 +0100] [CGI] envp[8] = "HOME=/var/spool/cups/tmp"
D [01/Mar/2012:22:24:57 +0100] [CGI] envp[9] = "PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [01/Mar/2012:22:24:57 +0100] [CGI] envp[10] = "SERVER_ADMIN=root@host"
D [01/Mar/2012:22:24:57 +0100] [CGI] envp[11] = "SOFTWARE=CUPS/1.5.0"
D [01/Mar/2012:22:24:57 +0100] [CGI] envp[12] = "TMPDIR=/var/spool/cups/tmp"
D [01/Mar/2012:22:24:57 +0100] [CGI] envp[13] = "USER=root"
D [01/Mar/2012:22:24:57 +0100] [CGI] envp[14] = "CUPS_SERVER=/var/run/cups/cups.sock"
D [01/Mar/2012:22:24:57 +0100] [CGI] envp[15] = "CUPS_ENCRYPTION=IfRequested"
D [01/Mar/2012:22:24:57 +0100] [CGI] envp[16] = "IPP_PORT=631"
D [01/Mar/2012:22:24:57 +0100] [CGI] envp[17] = "LANG=de_DE.UTF8"
D [01/Mar/2012:22:24:57 +0100] [CGI] envp[18] = "REDIRECT_STATUS=1"
D [01/Mar/2012:22:24:57 +0100] [CGI] envp[19] = "GATEWAY_INTERFACE=CGI/1.1"
D [01/Mar/2012:22:24:57 +0100] [CGI] envp[20] = "SERVER_NAME=localhost"
D [01/Mar/2012:22:24:57 +0100] [CGI] envp[21] = "SERVER_PORT=631"
D [01/Mar/2012:22:24:57 +0100] [CGI] envp[22] = "REMOTE_ADDR=[v1.::1]"
D [01/Mar/2012:22:24:57 +0100] [CGI] envp[23] = "REMOTE_HOST=localhost"
D [01/Mar/2012:22:24:57 +0100] [CGI] envp[24] = "SCRIPT_NAME=/printers/"
D [01/Mar/2012:22:24:57 +0100] [CGI] envp[25] = "SCRIPT_FILENAME=/usr/share/cups/webcontent/printers/"
D [01/Mar/2012:22:24:57 +0100] [CGI] envp[26] = "SERVER_PROTOCOL=HTTP/1.1"
D [01/Mar/2012:22:24:57 +0100] [CGI] envp[27] = "HTTP_COOKIE=org.cups.sid=4fbda4d4a64cddf774a514258c20996b"
D [01/Mar/2012:22:24:57 +0100] [CGI] envp[28] = "HTTP_USER_AGENT=Mozilla/5.0 (X11; Linux i686; rv:10.0.2) Gecko/20100101 Firefox/10.0.2"
D [01/Mar/2012:22:24:57 +0100] [CGI] envp[29] = "HTTP_REFERER=http://localhost:631/jobs/"
D [01/Mar/2012:22:24:57 +0100] [CGI] envp[30] = "REQUEST_METHOD=GET"
D [01/Mar/2012:22:24:57 +0100] [CGI] envp[31] = "QUERY_STRING="
D [01/Mar/2012:22:24:57 +0100] [CGI] Started /usr/lib/cups/cgi-bin/printers.cgi (PID 4060)
I [01/Mar/2012:22:24:57 +0100] Started "/usr/lib/cups/cgi-bin/printers.cgi" (pid=4060)
D [01/Mar/2012:22:24:57 +0100] cupsdSendCommand: 15 file=16
D [01/Mar/2012:22:24:57 +0100] [CGI] org.cups.sid cookie is "4fbda4d4a64cddf774a514258c20996b"
D [01/Mar/2012:22:24:57 +0100] cupsdAcceptClient: 19 from localhost (Domain)
D [01/Mar/2012:22:24:57 +0100] cupsdReadClient: 19 POST / HTTP/1.1
D [01/Mar/2012:22:24:57 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [01/Mar/2012:22:24:57 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2012:22:24:57 +0100] cupsdReadClient: 19 1.1 CUPS-Get-Default 1
D [01/Mar/2012:22:24:57 +0100] CUPS-Get-Default
D [01/Mar/2012:22:24:57 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [01/Mar/2012:22:24:57 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [01/Mar/2012:22:24:57 +0100] [CGI] show_all_printers(http=0xb77f3a58, user="(null)")
D [01/Mar/2012:22:24:57 +0100] Script header: Content-Type: text/html;charset=utf-8
D [01/Mar/2012:22:24:57 +0100] Script header: 
D [01/Mar/2012:22:24:57 +0100] cupsdReadClient: 19 POST / HTTP/1.1
D [01/Mar/2012:22:24:57 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [01/Mar/2012:22:24:57 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2012:22:24:57 +0100] cupsdReadClient: 19 1.1 CUPS-Get-Printers 1
D [01/Mar/2012:22:24:57 +0100] CUPS-Get-Printers
D [01/Mar/2012:22:24:57 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [01/Mar/2012:22:24:57 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [01/Mar/2012:22:24:57 +0100] cupsdReadClient: 19 WAITING Closing on EOF
D [01/Mar/2012:22:24:57 +0100] cupsdCloseClient: 19
D [01/Mar/2012:22:24:57 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [01/Mar/2012:22:24:57 +0100] PID 4060 (/usr/lib/cups/cgi-bin/printers.cgi) exited with no errors.
D [01/Mar/2012:22:24:57 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [01/Mar/2012:22:24:58 +0100] cupsdReadClient: 15 GET /printers/HP_6315 HTTP/1.1
D [01/Mar/2012:22:24:58 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [01/Mar/2012:22:24:58 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2012:22:24:58 +0100] [CGI] argv[0] = "/usr/lib/cups/cgi-bin/printers.cgi"
D [01/Mar/2012:22:24:58 +0100] [CGI] envp[0] = "CUPS_CACHEDIR=/var/cache/cups"
D [01/Mar/2012:22:24:58 +0100] [CGI] envp[1] = "CUPS_DATADIR=/usr/share/cups"
D [01/Mar/2012:22:24:58 +0100] [CGI] envp[2] = "CUPS_DOCROOT=/usr/share/cups/webcontent"
D [01/Mar/2012:22:24:58 +0100] [CGI] envp[3] = "CUPS_FONTPATH=/usr/share/cups/fonts"
D [01/Mar/2012:22:24:58 +0100] [CGI] envp[4] = "CUPS_REQUESTROOT=/var/spool/cups"
D [01/Mar/2012:22:24:58 +0100] [CGI] envp[5] = "CUPS_SERVERBIN=/usr/lib/cups"
D [01/Mar/2012:22:24:58 +0100] [CGI] envp[6] = "CUPS_SERVERROOT=/etc/cups"
D [01/Mar/2012:22:24:58 +0100] [CGI] envp[7] = "CUPS_STATEDIR=/var/run/cups"
D [01/Mar/2012:22:24:58 +0100] [CGI] envp[8] = "HOME=/var/spool/cups/tmp"
D [01/Mar/2012:22:24:58 +0100] [CGI] envp[9] = "PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [01/Mar/2012:22:24:58 +0100] [CGI] envp[10] = "SERVER_ADMIN=root@host"
D [01/Mar/2012:22:24:58 +0100] [CGI] envp[11] = "SOFTWARE=CUPS/1.5.0"
D [01/Mar/2012:22:24:58 +0100] [CGI] envp[12] = "TMPDIR=/var/spool/cups/tmp"
D [01/Mar/2012:22:24:58 +0100] [CGI] envp[13] = "USER=root"
D [01/Mar/2012:22:24:58 +0100] [CGI] envp[14] = "CUPS_SERVER=/var/run/cups/cups.sock"
D [01/Mar/2012:22:24:58 +0100] [CGI] envp[15] = "CUPS_ENCRYPTION=IfRequested"
D [01/Mar/2012:22:24:58 +0100] [CGI] envp[16] = "IPP_PORT=631"
D [01/Mar/2012:22:24:58 +0100] [CGI] envp[17] = "LANG=de_DE.UTF8"
D [01/Mar/2012:22:24:58 +0100] [CGI] envp[18] = "REDIRECT_STATUS=1"
D [01/Mar/2012:22:24:58 +0100] [CGI] envp[19] = "GATEWAY_INTERFACE=CGI/1.1"
D [01/Mar/2012:22:24:58 +0100] [CGI] envp[20] = "SERVER_NAME=localhost"
D [01/Mar/2012:22:24:58 +0100] [CGI] envp[21] = "SERVER_PORT=631"
D [01/Mar/2012:22:24:58 +0100] [CGI] envp[22] = "REMOTE_ADDR=[v1.::1]"
D [01/Mar/2012:22:24:58 +0100] [CGI] envp[23] = "REMOTE_HOST=localhost"
D [01/Mar/2012:22:24:58 +0100] [CGI] envp[24] = "SCRIPT_NAME=/printers/HP_6315"
D [01/Mar/2012:22:24:58 +0100] [CGI] envp[25] = "SCRIPT_FILENAME=/usr/share/cups/webcontent/printers/HP_6315"
D [01/Mar/2012:22:24:58 +0100] [CGI] envp[26] = "PATH_INFO=/HP_6315"
D [01/Mar/2012:22:24:58 +0100] [CGI] envp[27] = "SERVER_PROTOCOL=HTTP/1.1"
D [01/Mar/2012:22:24:58 +0100] [CGI] envp[28] = "HTTP_COOKIE=org.cups.sid=4fbda4d4a64cddf774a514258c20996b"
D [01/Mar/2012:22:24:58 +0100] [CGI] envp[29] = "HTTP_USER_AGENT=Mozilla/5.0 (X11; Linux i686; rv:10.0.2) Gecko/20100101 Firefox/10.0.2"
D [01/Mar/2012:22:24:58 +0100] [CGI] envp[30] = "HTTP_REFERER=http://localhost:631/printers/"
D [01/Mar/2012:22:24:58 +0100] [CGI] envp[31] = "REQUEST_METHOD=GET"
D [01/Mar/2012:22:24:58 +0100] [CGI] envp[32] = "QUERY_STRING="
D [01/Mar/2012:22:24:58 +0100] [CGI] Started /usr/lib/cups/cgi-bin/printers.cgi (PID 4062)
I [01/Mar/2012:22:24:58 +0100] Started "/usr/lib/cups/cgi-bin/printers.cgi" (pid=4062)
D [01/Mar/2012:22:24:58 +0100] cupsdSendCommand: 15 file=16
D [01/Mar/2012:22:24:58 +0100] [CGI] org.cups.sid cookie is "4fbda4d4a64cddf774a514258c20996b"
D [01/Mar/2012:22:24:58 +0100] cupsdAcceptClient: 19 from localhost (Domain)
D [01/Mar/2012:22:24:58 +0100] cupsdReadClient: 19 POST / HTTP/1.1
D [01/Mar/2012:22:24:58 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [01/Mar/2012:22:24:58 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2012:22:24:58 +0100] cupsdReadClient: 19 1.1 CUPS-Get-Default 1
D [01/Mar/2012:22:24:58 +0100] CUPS-Get-Default
D [01/Mar/2012:22:24:58 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [01/Mar/2012:22:24:58 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [01/Mar/2012:22:24:58 +0100] [CGI] show_printer(http=0xb77aea98, printer="HP_6315")
D [01/Mar/2012:22:24:58 +0100] cupsdReadClient: 19 POST / HTTP/1.1
D [01/Mar/2012:22:24:58 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [01/Mar/2012:22:24:58 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2012:22:24:58 +0100] cupsdReadClient: 19 1.1 Get-Printer-Attributes 1
D [01/Mar/2012:22:24:58 +0100] Get-Printer-Attributes ipp://localhost/printers/HP_6315
D [01/Mar/2012:22:24:58 +0100] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/HP_6315) from localhost
D [01/Mar/2012:22:24:58 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [01/Mar/2012:22:24:58 +0100] Script header: Content-Type: text/html;charset=utf-8
D [01/Mar/2012:22:24:58 +0100] Script header: 
D [01/Mar/2012:22:24:58 +0100] [CGI] Regular expression ".*Clean.*"
D [01/Mar/2012:22:24:58 +0100] [CGI] matches[0].rm_so=0
D [01/Mar/2012:22:24:58 +0100] [CGI] matches[1].rm_so=-1
D [01/Mar/2012:22:24:58 +0100] [CGI] Regular expression ".*PrintSelfTestPage.*"
D [01/Mar/2012:22:24:58 +0100] [CGI] matches[0].rm_so=0
D [01/Mar/2012:22:24:58 +0100] [CGI] matches[1].rm_so=-1
D [01/Mar/2012:22:24:58 +0100] cupsdReadClient: 19 POST / HTTP/1.1
D [01/Mar/2012:22:24:58 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [01/Mar/2012:22:24:58 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2012:22:24:58 +0100] cupsdReadClient: 19 1.1 Get-Jobs 1
D [01/Mar/2012:22:24:58 +0100] Get-Jobs ipp://localhost:631/printers/HP_6315
D [01/Mar/2012:22:24:58 +0100] Returning IPP successful-ok for Get-Jobs (ipp://localhost:631/printers/HP_6315) from localhost
D [01/Mar/2012:22:24:58 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [01/Mar/2012:22:24:58 +0100] cupsdReadClient: 19 WAITING Closing on EOF
D [01/Mar/2012:22:24:58 +0100] cupsdCloseClient: 19
D [01/Mar/2012:22:24:58 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [01/Mar/2012:22:24:58 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [01/Mar/2012:22:24:58 +0100] PID 4062 (/usr/lib/cups/cgi-bin/printers.cgi) exited with no errors.
D [01/Mar/2012:22:25:11 +0100] cupsdReadClient: 15 GET /help/ HTTP/1.1
D [01/Mar/2012:22:25:11 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [01/Mar/2012:22:25:11 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2012:22:25:11 +0100] [CGI] argv[0] = "/usr/lib/cups/cgi-bin/help.cgi"
D [01/Mar/2012:22:25:11 +0100] [CGI] envp[0] = "CUPS_CACHEDIR=/var/cache/cups"
D [01/Mar/2012:22:25:11 +0100] [CGI] envp[1] = "CUPS_DATADIR=/usr/share/cups"
D [01/Mar/2012:22:25:11 +0100] [CGI] envp[2] = "CUPS_DOCROOT=/usr/share/cups/webcontent"
D [01/Mar/2012:22:25:11 +0100] [CGI] envp[3] = "CUPS_FONTPATH=/usr/share/cups/fonts"
D [01/Mar/2012:22:25:11 +0100] [CGI] envp[4] = "CUPS_REQUESTROOT=/var/spool/cups"
D [01/Mar/2012:22:25:11 +0100] [CGI] envp[5] = "CUPS_SERVERBIN=/usr/lib/cups"
D [01/Mar/2012:22:25:11 +0100] [CGI] envp[6] = "CUPS_SERVERROOT=/etc/cups"
D [01/Mar/2012:22:25:11 +0100] [CGI] envp[7] = "CUPS_STATEDIR=/var/run/cups"
D [01/Mar/2012:22:25:11 +0100] [CGI] envp[8] = "HOME=/var/spool/cups/tmp"
D [01/Mar/2012:22:25:11 +0100] [CGI] envp[9] = "PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [01/Mar/2012:22:25:11 +0100] [CGI] envp[10] = "SERVER_ADMIN=root@host"
D [01/Mar/2012:22:25:11 +0100] [CGI] envp[11] = "SOFTWARE=CUPS/1.5.0"
D [01/Mar/2012:22:25:11 +0100] [CGI] envp[12] = "TMPDIR=/var/spool/cups/tmp"
D [01/Mar/2012:22:25:11 +0100] [CGI] envp[13] = "USER=root"
D [01/Mar/2012:22:25:11 +0100] [CGI] envp[14] = "CUPS_SERVER=/var/run/cups/cups.sock"
D [01/Mar/2012:22:25:11 +0100] [CGI] envp[15] = "CUPS_ENCRYPTION=IfRequested"
D [01/Mar/2012:22:25:11 +0100] [CGI] envp[16] = "IPP_PORT=631"
D [01/Mar/2012:22:25:11 +0100] [CGI] envp[17] = "LANG=de_DE.UTF8"
D [01/Mar/2012:22:25:11 +0100] [CGI] envp[18] = "REDIRECT_STATUS=1"
D [01/Mar/2012:22:25:11 +0100] [CGI] envp[19] = "GATEWAY_INTERFACE=CGI/1.1"
D [01/Mar/2012:22:25:11 +0100] [CGI] envp[20] = "SERVER_NAME=localhost"
D [01/Mar/2012:22:25:11 +0100] [CGI] envp[21] = "SERVER_PORT=631"
D [01/Mar/2012:22:25:11 +0100] [CGI] envp[22] = "REMOTE_ADDR=[v1.::1]"
D [01/Mar/2012:22:25:11 +0100] [CGI] envp[23] = "REMOTE_HOST=localhost"
D [01/Mar/2012:22:25:11 +0100] [CGI] envp[24] = "SCRIPT_NAME=/help/"
D [01/Mar/2012:22:25:11 +0100] [CGI] envp[25] = "SCRIPT_FILENAME=/usr/share/cups/webcontent/help/"
D [01/Mar/2012:22:25:11 +0100] [CGI] envp[26] = "SERVER_PROTOCOL=HTTP/1.1"
D [01/Mar/2012:22:25:11 +0100] [CGI] envp[27] = "HTTP_COOKIE=org.cups.sid=4fbda4d4a64cddf774a514258c20996b"
D [01/Mar/2012:22:25:11 +0100] [CGI] envp[28] = "HTTP_USER_AGENT=Mozilla/5.0 (X11; Linux i686; rv:10.0.2) Gecko/20100101 Firefox/10.0.2"
D [01/Mar/2012:22:25:11 +0100] [CGI] envp[29] = "HTTP_REFERER=http://localhost:631/printers/HP_6315"
D [01/Mar/2012:22:25:11 +0100] [CGI] envp[30] = "REQUEST_METHOD=GET"
D [01/Mar/2012:22:25:11 +0100] [CGI] envp[31] = "QUERY_STRING="
D [01/Mar/2012:22:25:11 +0100] [CGI] Started /usr/lib/cups/cgi-bin/help.cgi (PID 4077)
I [01/Mar/2012:22:25:11 +0100] Started "/usr/lib/cups/cgi-bin/help.cgi" (pid=4077)
D [01/Mar/2012:22:25:11 +0100] cupsdSendCommand: 15 file=16
D [01/Mar/2012:22:25:11 +0100] [CGI] org.cups.sid cookie is "4fbda4d4a64cddf774a514258c20996b"
D [01/Mar/2012:22:25:11 +0100] [CGI] helpLoadIndex(filename="/var/cache/cups/help.index", directory="/usr/share/cups/webcontent/help")
D [01/Mar/2012:22:25:11 +0100] [CGI] 1740 nodes in help index...
D [01/Mar/2012:22:25:11 +0100] [CGI] argv[0]="/usr/lib/cups/cgi-bin/help.cgi"
D [01/Mar/2012:22:25:11 +0100] Script header: Content-Type: text/html;charset=utf-8
D [01/Mar/2012:22:25:11 +0100] Script header: 
D [01/Mar/2012:22:25:11 +0100] [CGI] query="(null)", topic="(null)"
D [01/Mar/2012:22:25:11 +0100] PID 4077 (/usr/lib/cups/cgi-bin/help.cgi) exited with no errors.
D [01/Mar/2012:22:25:11 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [01/Mar/2012:22:25:13 +0100] cupsdReadClient: 18 WAITING Closing on EOF
D [01/Mar/2012:22:25:13 +0100] cupsdCloseClient: 18
D [01/Mar/2012:22:25:13 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [01/Mar/2012:22:25:13 +0100] cupsdReadClient: 20 WAITING Closing on EOF
D [01/Mar/2012:22:25:13 +0100] cupsdCloseClient: 20
D [01/Mar/2012:22:25:13 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [01/Mar/2012:22:25:13 +0100] cupsdReadClient: 17 WAITING Closing on EOF
D [01/Mar/2012:22:25:13 +0100] cupsdCloseClient: 17
D [01/Mar/2012:22:25:13 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [01/Mar/2012:22:25:14 +0100] Report: clients=3
D [01/Mar/2012:22:25:14 +0100] Report: jobs=16
D [01/Mar/2012:22:25:14 +0100] Report: jobs-active=0
D [01/Mar/2012:22:25:14 +0100] Report: printers=1
D [01/Mar/2012:22:25:14 +0100] Report: printers-implicit=0
D [01/Mar/2012:22:25:14 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:22:25:14 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:22:25:14 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:22:25:16 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:25:16 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:22:25:16 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:25:16 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:22:25:41 +0100] cupsdReadClient: 15 WAITING Closing on EOF
D [01/Mar/2012:22:25:41 +0100] cupsdCloseClient: 15
D [01/Mar/2012:22:25:41 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [01/Mar/2012:22:26:18 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:26:18 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:22:26:18 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:26:18 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:22:26:18 +0100] Report: clients=2
D [01/Mar/2012:22:26:18 +0100] Report: jobs=16
D [01/Mar/2012:22:26:18 +0100] Report: jobs-active=0
D [01/Mar/2012:22:26:18 +0100] Report: printers=1
D [01/Mar/2012:22:26:18 +0100] Report: printers-implicit=0
D [01/Mar/2012:22:26:18 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:22:26:18 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:22:26:18 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:22:27:20 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:27:20 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:22:27:20 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:27:20 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:22:27:20 +0100] Report: clients=2
D [01/Mar/2012:22:27:20 +0100] Report: jobs=16
D [01/Mar/2012:22:27:20 +0100] Report: jobs-active=0
D [01/Mar/2012:22:27:20 +0100] Report: printers=1
D [01/Mar/2012:22:27:20 +0100] Report: printers-implicit=0
D [01/Mar/2012:22:27:20 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:22:27:20 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:22:27:20 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:22:28:05 +0100] Closing client 13 after 300 seconds of inactivity...
D [01/Mar/2012:22:28:05 +0100] cupsdCloseClient: 13
D [01/Mar/2012:22:28:05 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [01/Mar/2012:22:28:11 +0100] Closing client 14 after 300 seconds of inactivity...
D [01/Mar/2012:22:28:11 +0100] cupsdCloseClient: 14
D [01/Mar/2012:22:28:11 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [01/Mar/2012:22:28:22 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:28:22 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:22:28:22 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:28:22 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:22:28:22 +0100] Report: clients=0
D [01/Mar/2012:22:28:22 +0100] Report: jobs=16
D [01/Mar/2012:22:28:22 +0100] Report: jobs-active=0
D [01/Mar/2012:22:28:22 +0100] Report: printers=1
D [01/Mar/2012:22:28:22 +0100] Report: printers-implicit=0
D [01/Mar/2012:22:28:22 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:22:28:22 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:22:28:22 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:22:29:24 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:29:24 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:22:29:24 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:29:24 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:22:29:24 +0100] Report: clients=0
D [01/Mar/2012:22:29:24 +0100] Report: jobs=16
D [01/Mar/2012:22:29:24 +0100] Report: jobs-active=0
D [01/Mar/2012:22:29:24 +0100] Report: printers=1
D [01/Mar/2012:22:29:24 +0100] Report: printers-implicit=0
D [01/Mar/2012:22:29:24 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:22:29:24 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:22:29:24 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:22:30:26 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:30:26 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:22:30:26 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:30:26 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:22:30:26 +0100] Report: clients=0
D [01/Mar/2012:22:30:26 +0100] Report: jobs=16
D [01/Mar/2012:22:30:26 +0100] Report: jobs-active=0
D [01/Mar/2012:22:30:26 +0100] Report: printers=1
D [01/Mar/2012:22:30:26 +0100] Report: printers-implicit=0
D [01/Mar/2012:22:30:26 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:22:30:26 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:22:30:26 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:22:31:28 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:31:28 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:22:31:28 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:31:28 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:22:31:28 +0100] Report: clients=0
D [01/Mar/2012:22:31:28 +0100] Report: jobs=16
D [01/Mar/2012:22:31:28 +0100] Report: jobs-active=0
D [01/Mar/2012:22:31:28 +0100] Report: printers=1
D [01/Mar/2012:22:31:28 +0100] Report: printers-implicit=0
D [01/Mar/2012:22:31:28 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:22:31:28 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:22:31:28 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:22:32:30 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:32:30 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:22:32:30 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:32:30 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:22:32:30 +0100] Report: clients=0
D [01/Mar/2012:22:32:30 +0100] Report: jobs=16
D [01/Mar/2012:22:32:30 +0100] Report: jobs-active=0
D [01/Mar/2012:22:32:30 +0100] Report: printers=1
D [01/Mar/2012:22:32:30 +0100] Report: printers-implicit=0
D [01/Mar/2012:22:32:30 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:22:32:30 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:22:32:30 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:22:33:32 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:33:32 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:22:33:32 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:33:32 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:22:33:32 +0100] Report: clients=0
D [01/Mar/2012:22:33:32 +0100] Report: jobs=16
D [01/Mar/2012:22:33:32 +0100] Report: jobs-active=0
D [01/Mar/2012:22:33:32 +0100] Report: printers=1
D [01/Mar/2012:22:33:32 +0100] Report: printers-implicit=0
D [01/Mar/2012:22:33:32 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:22:33:32 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:22:33:32 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:22:34:34 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:34:34 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:22:34:34 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:34:34 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:22:34:34 +0100] Report: clients=0
D [01/Mar/2012:22:34:34 +0100] Report: jobs=16
D [01/Mar/2012:22:34:34 +0100] Report: jobs-active=0
D [01/Mar/2012:22:34:34 +0100] Report: printers=1
D [01/Mar/2012:22:34:34 +0100] Report: printers-implicit=0
D [01/Mar/2012:22:34:34 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:22:34:34 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:22:34:34 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:22:35:36 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:35:36 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:22:35:36 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:35:36 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:22:35:36 +0100] Report: clients=0
D [01/Mar/2012:22:35:36 +0100] Report: jobs=16
D [01/Mar/2012:22:35:36 +0100] Report: jobs-active=0
D [01/Mar/2012:22:35:36 +0100] Report: printers=1
D [01/Mar/2012:22:35:36 +0100] Report: printers-implicit=0
D [01/Mar/2012:22:35:36 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:22:35:36 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:22:35:36 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:22:36:38 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:36:38 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:22:36:38 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:36:38 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:22:36:38 +0100] Report: clients=0
D [01/Mar/2012:22:36:38 +0100] Report: jobs=16
D [01/Mar/2012:22:36:38 +0100] Report: jobs-active=0
D [01/Mar/2012:22:36:38 +0100] Report: printers=1
D [01/Mar/2012:22:36:38 +0100] Report: printers-implicit=0
D [01/Mar/2012:22:36:38 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:22:36:38 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:22:36:38 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:22:37:40 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:37:40 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:22:37:40 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:37:40 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:22:37:40 +0100] Report: clients=0
D [01/Mar/2012:22:37:40 +0100] Report: jobs=16
D [01/Mar/2012:22:37:40 +0100] Report: jobs-active=0
D [01/Mar/2012:22:37:40 +0100] Report: printers=1
D [01/Mar/2012:22:37:40 +0100] Report: printers-implicit=0
D [01/Mar/2012:22:37:40 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:22:37:40 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:22:37:40 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:22:38:42 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:38:42 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:22:38:42 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:38:42 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:22:38:42 +0100] Report: clients=0
D [01/Mar/2012:22:38:42 +0100] Report: jobs=16
D [01/Mar/2012:22:38:42 +0100] Report: jobs-active=0
D [01/Mar/2012:22:38:42 +0100] Report: printers=1
D [01/Mar/2012:22:38:42 +0100] Report: printers-implicit=0
D [01/Mar/2012:22:38:42 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:22:38:42 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:22:38:42 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:22:39:05 +0100] cupsdAcceptClient: 13 from localhost:631 (IPv6)
D [01/Mar/2012:22:39:05 +0100] cupsdReadClient: 13 GET /printers/ HTTP/1.1
D [01/Mar/2012:22:39:05 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [01/Mar/2012:22:39:05 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2012:22:39:05 +0100] [CGI] argv[0] = "/usr/lib/cups/cgi-bin/printers.cgi"
D [01/Mar/2012:22:39:05 +0100] [CGI] envp[0] = "CUPS_CACHEDIR=/var/cache/cups"
D [01/Mar/2012:22:39:05 +0100] [CGI] envp[1] = "CUPS_DATADIR=/usr/share/cups"
D [01/Mar/2012:22:39:05 +0100] [CGI] envp[2] = "CUPS_DOCROOT=/usr/share/cups/webcontent"
D [01/Mar/2012:22:39:05 +0100] [CGI] envp[3] = "CUPS_FONTPATH=/usr/share/cups/fonts"
D [01/Mar/2012:22:39:05 +0100] [CGI] envp[4] = "CUPS_REQUESTROOT=/var/spool/cups"
D [01/Mar/2012:22:39:05 +0100] [CGI] envp[5] = "CUPS_SERVERBIN=/usr/lib/cups"
D [01/Mar/2012:22:39:05 +0100] [CGI] envp[6] = "CUPS_SERVERROOT=/etc/cups"
D [01/Mar/2012:22:39:05 +0100] [CGI] envp[7] = "CUPS_STATEDIR=/var/run/cups"
D [01/Mar/2012:22:39:05 +0100] [CGI] envp[8] = "HOME=/var/spool/cups/tmp"
D [01/Mar/2012:22:39:05 +0100] [CGI] envp[9] = "PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [01/Mar/2012:22:39:05 +0100] [CGI] envp[10] = "SERVER_ADMIN=root@host"
D [01/Mar/2012:22:39:05 +0100] [CGI] envp[11] = "SOFTWARE=CUPS/1.5.0"
D [01/Mar/2012:22:39:05 +0100] [CGI] envp[12] = "TMPDIR=/var/spool/cups/tmp"
D [01/Mar/2012:22:39:05 +0100] [CGI] envp[13] = "USER=root"
D [01/Mar/2012:22:39:05 +0100] [CGI] envp[14] = "CUPS_SERVER=/var/run/cups/cups.sock"
D [01/Mar/2012:22:39:05 +0100] [CGI] envp[15] = "CUPS_ENCRYPTION=IfRequested"
D [01/Mar/2012:22:39:05 +0100] [CGI] envp[16] = "IPP_PORT=631"
D [01/Mar/2012:22:39:05 +0100] [CGI] envp[17] = "LANG=de_DE.UTF8"
D [01/Mar/2012:22:39:05 +0100] [CGI] envp[18] = "REDIRECT_STATUS=1"
D [01/Mar/2012:22:39:05 +0100] [CGI] envp[19] = "GATEWAY_INTERFACE=CGI/1.1"
D [01/Mar/2012:22:39:05 +0100] [CGI] envp[20] = "SERVER_NAME=localhost"
D [01/Mar/2012:22:39:05 +0100] [CGI] envp[21] = "SERVER_PORT=631"
D [01/Mar/2012:22:39:05 +0100] [CGI] envp[22] = "REMOTE_ADDR=[v1.::1]"
D [01/Mar/2012:22:39:05 +0100] [CGI] envp[23] = "REMOTE_HOST=localhost"
D [01/Mar/2012:22:39:05 +0100] [CGI] envp[24] = "SCRIPT_NAME=/printers/"
D [01/Mar/2012:22:39:05 +0100] [CGI] envp[25] = "SCRIPT_FILENAME=/usr/share/cups/webcontent/printers/"
D [01/Mar/2012:22:39:05 +0100] [CGI] envp[26] = "SERVER_PROTOCOL=HTTP/1.1"
D [01/Mar/2012:22:39:05 +0100] [CGI] envp[27] = "HTTP_COOKIE=org.cups.sid=4fbda4d4a64cddf774a514258c20996b"
D [01/Mar/2012:22:39:05 +0100] [CGI] envp[28] = "HTTP_USER_AGENT=Mozilla/5.0 (X11; Linux i686; rv:10.0.2) Gecko/20100101 Firefox/10.0.2"
D [01/Mar/2012:22:39:05 +0100] [CGI] envp[29] = "HTTP_REFERER=http://localhost:631/"
D [01/Mar/2012:22:39:05 +0100] [CGI] envp[30] = "REQUEST_METHOD=GET"
D [01/Mar/2012:22:39:05 +0100] [CGI] envp[31] = "QUERY_STRING="
D [01/Mar/2012:22:39:05 +0100] [CGI] Started /usr/lib/cups/cgi-bin/printers.cgi (PID 5096)
I [01/Mar/2012:22:39:05 +0100] Started "/usr/lib/cups/cgi-bin/printers.cgi" (pid=5096)
D [01/Mar/2012:22:39:05 +0100] cupsdSendCommand: 13 file=14
D [01/Mar/2012:22:39:05 +0100] [CGI] org.cups.sid cookie is "4fbda4d4a64cddf774a514258c20996b"
D [01/Mar/2012:22:39:05 +0100] cupsdAcceptClient: 15 from localhost (Domain)
D [01/Mar/2012:22:39:05 +0100] cupsdReadClient: 15 POST / HTTP/1.1
D [01/Mar/2012:22:39:05 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [01/Mar/2012:22:39:05 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2012:22:39:05 +0100] cupsdReadClient: 15 1.1 CUPS-Get-Default 1
D [01/Mar/2012:22:39:05 +0100] CUPS-Get-Default
D [01/Mar/2012:22:39:05 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [01/Mar/2012:22:39:05 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [01/Mar/2012:22:39:05 +0100] [CGI] show_all_printers(http=0xb78d6a58, user="(null)")
D [01/Mar/2012:22:39:05 +0100] Script header: Content-Type: text/html;charset=utf-8
D [01/Mar/2012:22:39:05 +0100] Script header: 
D [01/Mar/2012:22:39:05 +0100] cupsdReadClient: 15 POST / HTTP/1.1
D [01/Mar/2012:22:39:05 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [01/Mar/2012:22:39:05 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2012:22:39:05 +0100] cupsdReadClient: 15 1.1 CUPS-Get-Printers 1
D [01/Mar/2012:22:39:05 +0100] CUPS-Get-Printers
D [01/Mar/2012:22:39:05 +0100] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [01/Mar/2012:22:39:05 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [01/Mar/2012:22:39:05 +0100] cupsdReadClient: 15 WAITING Closing on EOF
D [01/Mar/2012:22:39:05 +0100] cupsdCloseClient: 15
D [01/Mar/2012:22:39:05 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [01/Mar/2012:22:39:05 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [01/Mar/2012:22:39:05 +0100] PID 5096 (/usr/lib/cups/cgi-bin/printers.cgi) exited with no errors.
D [01/Mar/2012:22:39:07 +0100] cupsdReadClient: 13 GET /printers/HP_6315 HTTP/1.1
D [01/Mar/2012:22:39:07 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [01/Mar/2012:22:39:07 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2012:22:39:07 +0100] [CGI] argv[0] = "/usr/lib/cups/cgi-bin/printers.cgi"
D [01/Mar/2012:22:39:07 +0100] [CGI] envp[0] = "CUPS_CACHEDIR=/var/cache/cups"
D [01/Mar/2012:22:39:07 +0100] [CGI] envp[1] = "CUPS_DATADIR=/usr/share/cups"
D [01/Mar/2012:22:39:07 +0100] [CGI] envp[2] = "CUPS_DOCROOT=/usr/share/cups/webcontent"
D [01/Mar/2012:22:39:07 +0100] [CGI] envp[3] = "CUPS_FONTPATH=/usr/share/cups/fonts"
D [01/Mar/2012:22:39:07 +0100] [CGI] envp[4] = "CUPS_REQUESTROOT=/var/spool/cups"
D [01/Mar/2012:22:39:07 +0100] [CGI] envp[5] = "CUPS_SERVERBIN=/usr/lib/cups"
D [01/Mar/2012:22:39:07 +0100] [CGI] envp[6] = "CUPS_SERVERROOT=/etc/cups"
D [01/Mar/2012:22:39:07 +0100] [CGI] envp[7] = "CUPS_STATEDIR=/var/run/cups"
D [01/Mar/2012:22:39:07 +0100] [CGI] envp[8] = "HOME=/var/spool/cups/tmp"
D [01/Mar/2012:22:39:07 +0100] [CGI] envp[9] = "PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [01/Mar/2012:22:39:07 +0100] [CGI] envp[10] = "SERVER_ADMIN=root@host"
D [01/Mar/2012:22:39:07 +0100] [CGI] envp[11] = "SOFTWARE=CUPS/1.5.0"
D [01/Mar/2012:22:39:07 +0100] [CGI] envp[12] = "TMPDIR=/var/spool/cups/tmp"
D [01/Mar/2012:22:39:07 +0100] [CGI] envp[13] = "USER=root"
D [01/Mar/2012:22:39:07 +0100] [CGI] envp[14] = "CUPS_SERVER=/var/run/cups/cups.sock"
D [01/Mar/2012:22:39:07 +0100] [CGI] envp[15] = "CUPS_ENCRYPTION=IfRequested"
D [01/Mar/2012:22:39:07 +0100] [CGI] envp[16] = "IPP_PORT=631"
D [01/Mar/2012:22:39:07 +0100] [CGI] envp[17] = "LANG=de_DE.UTF8"
D [01/Mar/2012:22:39:07 +0100] [CGI] envp[18] = "REDIRECT_STATUS=1"
D [01/Mar/2012:22:39:07 +0100] [CGI] envp[19] = "GATEWAY_INTERFACE=CGI/1.1"
D [01/Mar/2012:22:39:07 +0100] [CGI] envp[20] = "SERVER_NAME=localhost"
D [01/Mar/2012:22:39:07 +0100] [CGI] envp[21] = "SERVER_PORT=631"
D [01/Mar/2012:22:39:07 +0100] [CGI] envp[22] = "REMOTE_ADDR=[v1.::1]"
D [01/Mar/2012:22:39:07 +0100] [CGI] envp[23] = "REMOTE_HOST=localhost"
D [01/Mar/2012:22:39:07 +0100] [CGI] envp[24] = "SCRIPT_NAME=/printers/HP_6315"
D [01/Mar/2012:22:39:07 +0100] [CGI] envp[25] = "SCRIPT_FILENAME=/usr/share/cups/webcontent/printers/HP_6315"
D [01/Mar/2012:22:39:07 +0100] [CGI] envp[26] = "PATH_INFO=/HP_6315"
D [01/Mar/2012:22:39:07 +0100] [CGI] envp[27] = "SERVER_PROTOCOL=HTTP/1.1"
D [01/Mar/2012:22:39:07 +0100] [CGI] envp[28] = "HTTP_COOKIE=org.cups.sid=4fbda4d4a64cddf774a514258c20996b"
D [01/Mar/2012:22:39:07 +0100] [CGI] envp[29] = "HTTP_USER_AGENT=Mozilla/5.0 (X11; Linux i686; rv:10.0.2) Gecko/20100101 Firefox/10.0.2"
D [01/Mar/2012:22:39:07 +0100] [CGI] envp[30] = "HTTP_REFERER=http://localhost:631/printers/"
D [01/Mar/2012:22:39:07 +0100] [CGI] envp[31] = "REQUEST_METHOD=GET"
D [01/Mar/2012:22:39:07 +0100] [CGI] envp[32] = "QUERY_STRING="
D [01/Mar/2012:22:39:07 +0100] [CGI] Started /usr/lib/cups/cgi-bin/printers.cgi (PID 5098)
I [01/Mar/2012:22:39:07 +0100] Started "/usr/lib/cups/cgi-bin/printers.cgi" (pid=5098)
D [01/Mar/2012:22:39:07 +0100] cupsdSendCommand: 13 file=14
D [01/Mar/2012:22:39:07 +0100] [CGI] org.cups.sid cookie is "4fbda4d4a64cddf774a514258c20996b"
D [01/Mar/2012:22:39:07 +0100] cupsdAcceptClient: 15 from localhost (Domain)
D [01/Mar/2012:22:39:07 +0100] cupsdReadClient: 15 POST / HTTP/1.1
D [01/Mar/2012:22:39:07 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [01/Mar/2012:22:39:07 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2012:22:39:07 +0100] cupsdReadClient: 15 1.1 CUPS-Get-Default 1
D [01/Mar/2012:22:39:07 +0100] CUPS-Get-Default
D [01/Mar/2012:22:39:07 +0100] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost
D [01/Mar/2012:22:39:07 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [01/Mar/2012:22:39:07 +0100] [CGI] show_printer(http=0xb78dba98, printer="HP_6315")
D [01/Mar/2012:22:39:07 +0100] cupsdReadClient: 15 POST / HTTP/1.1
D [01/Mar/2012:22:39:07 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [01/Mar/2012:22:39:07 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2012:22:39:07 +0100] cupsdReadClient: 15 1.1 Get-Printer-Attributes 1
D [01/Mar/2012:22:39:07 +0100] Get-Printer-Attributes ipp://localhost/printers/HP_6315
D [01/Mar/2012:22:39:07 +0100] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/HP_6315) from localhost
D [01/Mar/2012:22:39:07 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [01/Mar/2012:22:39:07 +0100] Script header: Content-Type: text/html;charset=utf-8
D [01/Mar/2012:22:39:07 +0100] Script header: 
D [01/Mar/2012:22:39:07 +0100] [CGI] Regular expression ".*Clean.*"
D [01/Mar/2012:22:39:07 +0100] [CGI] matches[0].rm_so=0
D [01/Mar/2012:22:39:07 +0100] [CGI] matches[1].rm_so=-1
D [01/Mar/2012:22:39:07 +0100] [CGI] Regular expression ".*PrintSelfTestPage.*"
D [01/Mar/2012:22:39:07 +0100] [CGI] matches[0].rm_so=0
D [01/Mar/2012:22:39:07 +0100] [CGI] matches[1].rm_so=-1
D [01/Mar/2012:22:39:07 +0100] cupsdReadClient: 15 POST / HTTP/1.1
D [01/Mar/2012:22:39:07 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [01/Mar/2012:22:39:07 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2012:22:39:07 +0100] cupsdReadClient: 15 1.1 Get-Jobs 1
D [01/Mar/2012:22:39:07 +0100] Get-Jobs ipp://localhost:631/printers/HP_6315
D [01/Mar/2012:22:39:07 +0100] Returning IPP successful-ok for Get-Jobs (ipp://localhost:631/printers/HP_6315) from localhost
D [01/Mar/2012:22:39:07 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [01/Mar/2012:22:39:07 +0100] cupsdReadClient: 15 WAITING Closing on EOF
D [01/Mar/2012:22:39:07 +0100] cupsdCloseClient: 15
D [01/Mar/2012:22:39:07 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [01/Mar/2012:22:39:07 +0100] PID 5098 (/usr/lib/cups/cgi-bin/printers.cgi) exited with no errors.
D [01/Mar/2012:22:39:07 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [01/Mar/2012:22:39:20 +0100] cupsdReadClient: 13 GET /admin HTTP/1.1
D [01/Mar/2012:22:39:20 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [01/Mar/2012:22:39:20 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2012:22:39:20 +0100] [CGI] argv[0] = "/usr/lib/cups/cgi-bin/admin.cgi"
D [01/Mar/2012:22:39:20 +0100] [CGI] envp[0] = "CUPS_CACHEDIR=/var/cache/cups"
D [01/Mar/2012:22:39:20 +0100] [CGI] envp[1] = "CUPS_DATADIR=/usr/share/cups"
D [01/Mar/2012:22:39:20 +0100] [CGI] envp[2] = "CUPS_DOCROOT=/usr/share/cups/webcontent"
D [01/Mar/2012:22:39:20 +0100] [CGI] envp[3] = "CUPS_FONTPATH=/usr/share/cups/fonts"
D [01/Mar/2012:22:39:20 +0100] [CGI] envp[4] = "CUPS_REQUESTROOT=/var/spool/cups"
D [01/Mar/2012:22:39:20 +0100] [CGI] envp[5] = "CUPS_SERVERBIN=/usr/lib/cups"
D [01/Mar/2012:22:39:20 +0100] [CGI] envp[6] = "CUPS_SERVERROOT=/etc/cups"
D [01/Mar/2012:22:39:20 +0100] [CGI] envp[7] = "CUPS_STATEDIR=/var/run/cups"
D [01/Mar/2012:22:39:20 +0100] [CGI] envp[8] = "HOME=/var/spool/cups/tmp"
D [01/Mar/2012:22:39:20 +0100] [CGI] envp[9] = "PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [01/Mar/2012:22:39:20 +0100] [CGI] envp[10] = "SERVER_ADMIN=root@host"
D [01/Mar/2012:22:39:20 +0100] [CGI] envp[11] = "SOFTWARE=CUPS/1.5.0"
D [01/Mar/2012:22:39:20 +0100] [CGI] envp[12] = "TMPDIR=/var/spool/cups/tmp"
D [01/Mar/2012:22:39:20 +0100] [CGI] envp[13] = "USER=root"
D [01/Mar/2012:22:39:20 +0100] [CGI] envp[14] = "CUPS_SERVER=/var/run/cups/cups.sock"
D [01/Mar/2012:22:39:20 +0100] [CGI] envp[15] = "CUPS_ENCRYPTION=IfRequested"
D [01/Mar/2012:22:39:20 +0100] [CGI] envp[16] = "IPP_PORT=631"
D [01/Mar/2012:22:39:20 +0100] [CGI] envp[17] = "LANG=de_DE.UTF8"
D [01/Mar/2012:22:39:20 +0100] [CGI] envp[18] = "REDIRECT_STATUS=1"
D [01/Mar/2012:22:39:20 +0100] [CGI] envp[19] = "GATEWAY_INTERFACE=CGI/1.1"
D [01/Mar/2012:22:39:20 +0100] [CGI] envp[20] = "SERVER_NAME=localhost"
D [01/Mar/2012:22:39:20 +0100] [CGI] envp[21] = "SERVER_PORT=631"
D [01/Mar/2012:22:39:20 +0100] [CGI] envp[22] = "REMOTE_ADDR=[v1.::1]"
D [01/Mar/2012:22:39:20 +0100] [CGI] envp[23] = "REMOTE_HOST=localhost"
D [01/Mar/2012:22:39:20 +0100] [CGI] envp[24] = "SCRIPT_NAME=/admin"
D [01/Mar/2012:22:39:20 +0100] [CGI] envp[25] = "SCRIPT_FILENAME=/usr/share/cups/webcontent/admin"
D [01/Mar/2012:22:39:20 +0100] [CGI] envp[26] = "SERVER_PROTOCOL=HTTP/1.1"
D [01/Mar/2012:22:39:20 +0100] [CGI] envp[27] = "HTTP_COOKIE=org.cups.sid=4fbda4d4a64cddf774a514258c20996b"
D [01/Mar/2012:22:39:20 +0100] [CGI] envp[28] = "HTTP_USER_AGENT=Mozilla/5.0 (X11; Linux i686; rv:10.0.2) Gecko/20100101 Firefox/10.0.2"
D [01/Mar/2012:22:39:20 +0100] [CGI] envp[29] = "HTTP_REFERER=http://localhost:631/printers/HP_6315"
D [01/Mar/2012:22:39:20 +0100] [CGI] envp[30] = "REQUEST_METHOD=GET"
D [01/Mar/2012:22:39:20 +0100] [CGI] envp[31] = "QUERY_STRING="
D [01/Mar/2012:22:39:20 +0100] [CGI] Started /usr/lib/cups/cgi-bin/admin.cgi (PID 5112)
I [01/Mar/2012:22:39:20 +0100] Started "/usr/lib/cups/cgi-bin/admin.cgi" (pid=5112)
D [01/Mar/2012:22:39:20 +0100] cupsdSendCommand: 13 file=14
D [01/Mar/2012:22:39:20 +0100] [CGI] admin.cgi started...
D [01/Mar/2012:22:39:20 +0100] cupsdAcceptClient: 15 from localhost (Domain)
D [01/Mar/2012:22:39:20 +0100] [CGI] http=0xb778a148
D [01/Mar/2012:22:39:20 +0100] [CGI] org.cups.sid cookie is "4fbda4d4a64cddf774a514258c20996b"
D [01/Mar/2012:22:39:20 +0100] [CGI] No form data, showing main menu...
D [01/Mar/2012:22:39:20 +0100] [CGI] /usr/share/cups/drivers/pscript5.dll: Datei oder Verzeichnis nicht gefunden
D [01/Mar/2012:22:39:20 +0100] cupsdReadClient: 15 POST / HTTP/1.1
D [01/Mar/2012:22:39:20 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [01/Mar/2012:22:39:20 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2012:22:39:20 +0100] cupsdReadClient: 15 1.1 Get-Subscriptions 1
D [01/Mar/2012:22:39:20 +0100] Get-Subscriptions ipp://localhost/
D [01/Mar/2012:22:39:20 +0100] Get-Subscriptions client-error-not-found: No subscriptions found.
D [01/Mar/2012:22:39:20 +0100] Returning IPP client-error-not-found for Get-Subscriptions (ipp://localhost/) from localhost
D [01/Mar/2012:22:39:20 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [01/Mar/2012:22:39:20 +0100] Script header: Content-Type: text/html;charset=utf-8
D [01/Mar/2012:22:39:20 +0100] Script header: 
D [01/Mar/2012:22:39:20 +0100] cupsdReadClient: 15 WAITING Closing on EOF
D [01/Mar/2012:22:39:20 +0100] cupsdCloseClient: 15
D [01/Mar/2012:22:39:20 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [01/Mar/2012:22:39:20 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [01/Mar/2012:22:39:20 +0100] PID 5112 (/usr/lib/cups/cgi-bin/admin.cgi) exited with no errors.
D [01/Mar/2012:22:39:23 +0100] cupsdReadClient: 13 GET /admin/log/error_log HTTP/1.1
D [01/Mar/2012:22:39:23 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [01/Mar/2012:22:39:23 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2012:22:39:23 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [01/Mar/2012:22:39:24 +0100] cupsdReadClient: 13 GET /favicon.ico HTTP/1.1
D [01/Mar/2012:22:39:24 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [01/Mar/2012:22:39:24 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2012:22:39:24 +0100] cupsdReadClient: 13 Closing because Keep-Alive disabled
D [01/Mar/2012:22:39:24 +0100] cupsdCloseClient: 13
D [01/Mar/2012:22:39:24 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [01/Mar/2012:22:39:24 +0100] cupsdAcceptClient: 13 from localhost:631 (IPv6)
D [01/Mar/2012:22:39:24 +0100] cupsdReadClient: 13 GET /favicon.ico HTTP/1.1
D [01/Mar/2012:22:39:24 +0100] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [01/Mar/2012:22:39:24 +0100] cupsdAuthorize: No authentication data provided.
D [01/Mar/2012:22:39:24 +0100] cupsdReadClient: 13 Closing because Keep-Alive disabled
D [01/Mar/2012:22:39:24 +0100] cupsdCloseClient: 13
D [01/Mar/2012:22:39:24 +0100] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [01/Mar/2012:22:39:44 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:39:44 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:22:39:44 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:39:44 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:22:39:44 +0100] Report: clients=0
D [01/Mar/2012:22:39:44 +0100] Report: jobs=16
D [01/Mar/2012:22:39:44 +0100] Report: jobs-active=0
D [01/Mar/2012:22:39:44 +0100] Report: printers=1
D [01/Mar/2012:22:39:44 +0100] Report: printers-implicit=0
D [01/Mar/2012:22:39:44 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:22:39:44 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:22:39:44 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:22:40:46 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:40:46 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:22:40:46 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:40:46 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:22:40:46 +0100] Report: clients=0
D [01/Mar/2012:22:40:46 +0100] Report: jobs=16
D [01/Mar/2012:22:40:46 +0100] Report: jobs-active=0
D [01/Mar/2012:22:40:46 +0100] Report: printers=1
D [01/Mar/2012:22:40:46 +0100] Report: printers-implicit=0
D [01/Mar/2012:22:40:46 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:22:40:46 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:22:40:46 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:22:41:48 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:41:48 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:22:41:48 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:41:48 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:22:41:48 +0100] Report: clients=0
D [01/Mar/2012:22:41:48 +0100] Report: jobs=16
D [01/Mar/2012:22:41:48 +0100] Report: jobs-active=0
D [01/Mar/2012:22:41:48 +0100] Report: printers=1
D [01/Mar/2012:22:41:48 +0100] Report: printers-implicit=0
D [01/Mar/2012:22:41:48 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:22:41:48 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:22:41:48 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:22:42:50 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:42:50 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:22:42:50 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:42:50 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:22:42:50 +0100] Report: clients=0
D [01/Mar/2012:22:42:50 +0100] Report: jobs=16
D [01/Mar/2012:22:42:50 +0100] Report: jobs-active=0
D [01/Mar/2012:22:42:50 +0100] Report: printers=1
D [01/Mar/2012:22:42:50 +0100] Report: printers-implicit=0
D [01/Mar/2012:22:42:50 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:22:42:50 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:22:42:50 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:22:43:52 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:43:52 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:22:43:52 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:43:52 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:22:43:52 +0100] Report: clients=0
D [01/Mar/2012:22:43:52 +0100] Report: jobs=16
D [01/Mar/2012:22:43:52 +0100] Report: jobs-active=0
D [01/Mar/2012:22:43:52 +0100] Report: printers=1
D [01/Mar/2012:22:43:52 +0100] Report: printers-implicit=0
D [01/Mar/2012:22:43:52 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:22:43:52 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:22:43:52 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:22:44:54 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:44:54 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:22:44:54 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:44:54 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:22:44:54 +0100] Report: clients=0
D [01/Mar/2012:22:44:54 +0100] Report: jobs=16
D [01/Mar/2012:22:44:54 +0100] Report: jobs-active=0
D [01/Mar/2012:22:44:54 +0100] Report: printers=1
D [01/Mar/2012:22:44:54 +0100] Report: printers-implicit=0
D [01/Mar/2012:22:44:54 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:22:44:54 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:22:44:54 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:22:45:56 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:45:56 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:22:45:56 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:45:56 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:22:45:56 +0100] Report: clients=0
D [01/Mar/2012:22:45:56 +0100] Report: jobs=16
D [01/Mar/2012:22:45:56 +0100] Report: jobs-active=0
D [01/Mar/2012:22:45:56 +0100] Report: printers=1
D [01/Mar/2012:22:45:56 +0100] Report: printers-implicit=0
D [01/Mar/2012:22:45:56 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:22:45:56 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:22:45:56 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:22:46:58 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:46:58 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:22:46:58 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:46:58 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:22:46:58 +0100] Report: clients=0
D [01/Mar/2012:22:46:58 +0100] Report: jobs=16
D [01/Mar/2012:22:46:58 +0100] Report: jobs-active=0
D [01/Mar/2012:22:46:58 +0100] Report: printers=1
D [01/Mar/2012:22:46:58 +0100] Report: printers-implicit=0
D [01/Mar/2012:22:46:58 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:22:46:58 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:22:46:58 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:22:48:00 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:48:00 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:22:48:00 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:48:00 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:22:48:00 +0100] Report: clients=0
D [01/Mar/2012:22:48:00 +0100] Report: jobs=16
D [01/Mar/2012:22:48:00 +0100] Report: jobs-active=0
D [01/Mar/2012:22:48:00 +0100] Report: printers=1
D [01/Mar/2012:22:48:00 +0100] Report: printers-implicit=0
D [01/Mar/2012:22:48:00 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:22:48:00 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:22:48:00 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:22:49:02 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:49:02 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:22:49:02 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:49:02 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:22:49:02 +0100] Report: clients=0
D [01/Mar/2012:22:49:02 +0100] Report: jobs=16
D [01/Mar/2012:22:49:02 +0100] Report: jobs-active=0
D [01/Mar/2012:22:49:02 +0100] Report: printers=1
D [01/Mar/2012:22:49:02 +0100] Report: printers-implicit=0
D [01/Mar/2012:22:49:02 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:22:49:02 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:22:49:02 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:22:50:04 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:50:04 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:22:50:04 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:50:04 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:22:50:04 +0100] Report: clients=0
D [01/Mar/2012:22:50:04 +0100] Report: jobs=16
D [01/Mar/2012:22:50:04 +0100] Report: jobs-active=0
D [01/Mar/2012:22:50:04 +0100] Report: printers=1
D [01/Mar/2012:22:50:04 +0100] Report: printers-implicit=0
D [01/Mar/2012:22:50:04 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:22:50:04 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:22:50:04 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:22:51:06 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:51:06 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:22:51:06 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:51:06 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:22:51:06 +0100] Report: clients=0
D [01/Mar/2012:22:51:06 +0100] Report: jobs=16
D [01/Mar/2012:22:51:06 +0100] Report: jobs-active=0
D [01/Mar/2012:22:51:06 +0100] Report: printers=1
D [01/Mar/2012:22:51:06 +0100] Report: printers-implicit=0
D [01/Mar/2012:22:51:06 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:22:51:06 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:22:51:06 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:22:52:08 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:52:08 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:22:52:08 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:52:08 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:22:52:08 +0100] Report: clients=0
D [01/Mar/2012:22:52:08 +0100] Report: jobs=16
D [01/Mar/2012:22:52:08 +0100] Report: jobs-active=0
D [01/Mar/2012:22:52:08 +0100] Report: printers=1
D [01/Mar/2012:22:52:08 +0100] Report: printers-implicit=0
D [01/Mar/2012:22:52:08 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:22:52:08 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:22:52:08 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:22:53:10 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:53:10 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:22:53:10 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:53:10 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:22:53:10 +0100] Report: clients=0
D [01/Mar/2012:22:53:10 +0100] Report: jobs=16
D [01/Mar/2012:22:53:10 +0100] Report: jobs-active=0
D [01/Mar/2012:22:53:10 +0100] Report: printers=1
D [01/Mar/2012:22:53:10 +0100] Report: printers-implicit=0
D [01/Mar/2012:22:53:10 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:22:53:10 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:22:53:10 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:22:54:12 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:54:12 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:22:54:12 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:54:12 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:22:54:12 +0100] Report: clients=0
D [01/Mar/2012:22:54:12 +0100] Report: jobs=16
D [01/Mar/2012:22:54:12 +0100] Report: jobs-active=0
D [01/Mar/2012:22:54:12 +0100] Report: printers=1
D [01/Mar/2012:22:54:12 +0100] Report: printers-implicit=0
D [01/Mar/2012:22:54:12 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:22:54:12 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:22:54:12 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:22:55:14 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:55:14 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:22:55:14 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:55:14 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:22:55:14 +0100] Report: clients=0
D [01/Mar/2012:22:55:14 +0100] Report: jobs=16
D [01/Mar/2012:22:55:14 +0100] Report: jobs-active=0
D [01/Mar/2012:22:55:14 +0100] Report: printers=1
D [01/Mar/2012:22:55:14 +0100] Report: printers-implicit=0
D [01/Mar/2012:22:55:14 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:22:55:14 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:22:55:14 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:22:56:17 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:56:17 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:22:56:17 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:56:17 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:22:56:17 +0100] Report: clients=0
D [01/Mar/2012:22:56:17 +0100] Report: jobs=16
D [01/Mar/2012:22:56:17 +0100] Report: jobs-active=0
D [01/Mar/2012:22:56:17 +0100] Report: printers=1
D [01/Mar/2012:22:56:17 +0100] Report: printers-implicit=0
D [01/Mar/2012:22:56:17 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:22:56:17 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:22:56:17 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:22:57:19 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:57:19 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:22:57:19 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:57:19 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:22:57:19 +0100] Report: clients=0
D [01/Mar/2012:22:57:19 +0100] Report: jobs=16
D [01/Mar/2012:22:57:19 +0100] Report: jobs-active=0
D [01/Mar/2012:22:57:19 +0100] Report: printers=1
D [01/Mar/2012:22:57:19 +0100] Report: printers-implicit=0
D [01/Mar/2012:22:57:19 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:22:57:19 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:22:57:19 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:22:58:21 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:58:21 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:22:58:21 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:58:21 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:22:58:21 +0100] Report: clients=0
D [01/Mar/2012:22:58:21 +0100] Report: jobs=16
D [01/Mar/2012:22:58:21 +0100] Report: jobs-active=0
D [01/Mar/2012:22:58:21 +0100] Report: printers=1
D [01/Mar/2012:22:58:21 +0100] Report: printers-implicit=0
D [01/Mar/2012:22:58:21 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:22:58:21 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:22:58:21 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:22:59:23 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:59:23 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:22:59:23 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:22:59:23 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:22:59:23 +0100] Report: clients=0
D [01/Mar/2012:22:59:23 +0100] Report: jobs=16
D [01/Mar/2012:22:59:23 +0100] Report: jobs-active=0
D [01/Mar/2012:22:59:23 +0100] Report: printers=1
D [01/Mar/2012:22:59:23 +0100] Report: printers-implicit=0
D [01/Mar/2012:22:59:23 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:22:59:23 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:22:59:23 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:23:00:25 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:00:25 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:23:00:25 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:00:25 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:23:00:25 +0100] Report: clients=0
D [01/Mar/2012:23:00:25 +0100] Report: jobs=16
D [01/Mar/2012:23:00:25 +0100] Report: jobs-active=0
D [01/Mar/2012:23:00:25 +0100] Report: printers=1
D [01/Mar/2012:23:00:25 +0100] Report: printers-implicit=0
D [01/Mar/2012:23:00:25 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:23:00:25 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:23:00:25 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:23:01:27 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:01:27 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:23:01:27 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:01:27 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:23:01:27 +0100] Report: clients=0
D [01/Mar/2012:23:01:27 +0100] Report: jobs=16
D [01/Mar/2012:23:01:27 +0100] Report: jobs-active=0
D [01/Mar/2012:23:01:27 +0100] Report: printers=1
D [01/Mar/2012:23:01:27 +0100] Report: printers-implicit=0
D [01/Mar/2012:23:01:27 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:23:01:27 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:23:01:27 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:23:02:29 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:02:29 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:23:02:29 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:02:29 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:23:02:29 +0100] Report: clients=0
D [01/Mar/2012:23:02:29 +0100] Report: jobs=16
D [01/Mar/2012:23:02:29 +0100] Report: jobs-active=0
D [01/Mar/2012:23:02:29 +0100] Report: printers=1
D [01/Mar/2012:23:02:29 +0100] Report: printers-implicit=0
D [01/Mar/2012:23:02:29 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:23:02:29 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:23:02:29 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:23:03:31 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:03:31 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:23:03:31 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:03:31 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:23:03:31 +0100] Report: clients=0
D [01/Mar/2012:23:03:31 +0100] Report: jobs=16
D [01/Mar/2012:23:03:31 +0100] Report: jobs-active=0
D [01/Mar/2012:23:03:31 +0100] Report: printers=1
D [01/Mar/2012:23:03:31 +0100] Report: printers-implicit=0
D [01/Mar/2012:23:03:31 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:23:03:31 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:23:03:31 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:23:04:33 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:04:33 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:23:04:33 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:04:33 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:23:04:33 +0100] Report: clients=0
D [01/Mar/2012:23:04:33 +0100] Report: jobs=16
D [01/Mar/2012:23:04:33 +0100] Report: jobs-active=0
D [01/Mar/2012:23:04:33 +0100] Report: printers=1
D [01/Mar/2012:23:04:33 +0100] Report: printers-implicit=0
D [01/Mar/2012:23:04:33 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:23:04:33 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:23:04:33 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:23:05:35 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:05:35 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:23:05:35 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:05:35 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:23:05:35 +0100] Report: clients=0
D [01/Mar/2012:23:05:35 +0100] Report: jobs=16
D [01/Mar/2012:23:05:35 +0100] Report: jobs-active=0
D [01/Mar/2012:23:05:35 +0100] Report: printers=1
D [01/Mar/2012:23:05:35 +0100] Report: printers-implicit=0
D [01/Mar/2012:23:05:35 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:23:05:35 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:23:05:35 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:23:06:37 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:06:37 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:23:06:37 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:06:37 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:23:06:37 +0100] Report: clients=0
D [01/Mar/2012:23:06:37 +0100] Report: jobs=16
D [01/Mar/2012:23:06:37 +0100] Report: jobs-active=0
D [01/Mar/2012:23:06:37 +0100] Report: printers=1
D [01/Mar/2012:23:06:37 +0100] Report: printers-implicit=0
D [01/Mar/2012:23:06:37 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:23:06:37 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:23:06:37 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:23:07:39 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:07:39 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:23:07:39 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:07:39 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:23:07:39 +0100] Report: clients=0
D [01/Mar/2012:23:07:39 +0100] Report: jobs=16
D [01/Mar/2012:23:07:39 +0100] Report: jobs-active=0
D [01/Mar/2012:23:07:39 +0100] Report: printers=1
D [01/Mar/2012:23:07:39 +0100] Report: printers-implicit=0
D [01/Mar/2012:23:07:39 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:23:07:39 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:23:07:39 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:23:08:41 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:08:41 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:23:08:41 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:08:41 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:23:08:41 +0100] Report: clients=0
D [01/Mar/2012:23:08:41 +0100] Report: jobs=16
D [01/Mar/2012:23:08:41 +0100] Report: jobs-active=0
D [01/Mar/2012:23:08:41 +0100] Report: printers=1
D [01/Mar/2012:23:08:41 +0100] Report: printers-implicit=0
D [01/Mar/2012:23:08:41 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:23:08:41 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:23:08:41 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:23:09:43 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:09:43 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:23:09:43 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:09:43 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:23:09:43 +0100] Report: clients=0
D [01/Mar/2012:23:09:43 +0100] Report: jobs=16
D [01/Mar/2012:23:09:43 +0100] Report: jobs-active=0
D [01/Mar/2012:23:09:43 +0100] Report: printers=1
D [01/Mar/2012:23:09:43 +0100] Report: printers-implicit=0
D [01/Mar/2012:23:09:43 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:23:09:43 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:23:09:43 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:23:10:45 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:10:45 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:23:10:45 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:10:45 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:23:10:45 +0100] Report: clients=0
D [01/Mar/2012:23:10:45 +0100] Report: jobs=16
D [01/Mar/2012:23:10:45 +0100] Report: jobs-active=0
D [01/Mar/2012:23:10:45 +0100] Report: printers=1
D [01/Mar/2012:23:10:45 +0100] Report: printers-implicit=0
D [01/Mar/2012:23:10:45 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:23:10:45 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:23:10:45 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:23:11:47 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:11:47 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:23:11:47 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:11:47 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:23:11:47 +0100] Report: clients=0
D [01/Mar/2012:23:11:47 +0100] Report: jobs=16
D [01/Mar/2012:23:11:47 +0100] Report: jobs-active=0
D [01/Mar/2012:23:11:47 +0100] Report: printers=1
D [01/Mar/2012:23:11:47 +0100] Report: printers-implicit=0
D [01/Mar/2012:23:11:47 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:23:11:47 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:23:11:47 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:23:12:49 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:12:49 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:23:12:49 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:12:49 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:23:12:49 +0100] Report: clients=0
D [01/Mar/2012:23:12:49 +0100] Report: jobs=16
D [01/Mar/2012:23:12:49 +0100] Report: jobs-active=0
D [01/Mar/2012:23:12:49 +0100] Report: printers=1
D [01/Mar/2012:23:12:49 +0100] Report: printers-implicit=0
D [01/Mar/2012:23:12:49 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:23:12:49 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:23:12:49 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:23:13:51 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:13:51 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:23:13:51 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:13:51 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:23:13:51 +0100] Report: clients=0
D [01/Mar/2012:23:13:51 +0100] Report: jobs=16
D [01/Mar/2012:23:13:51 +0100] Report: jobs-active=0
D [01/Mar/2012:23:13:51 +0100] Report: printers=1
D [01/Mar/2012:23:13:51 +0100] Report: printers-implicit=0
D [01/Mar/2012:23:13:51 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:23:13:51 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:23:13:51 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:23:14:53 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:14:53 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:23:14:53 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:14:53 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:23:14:53 +0100] Report: clients=0
D [01/Mar/2012:23:14:53 +0100] Report: jobs=16
D [01/Mar/2012:23:14:53 +0100] Report: jobs-active=0
D [01/Mar/2012:23:14:53 +0100] Report: printers=1
D [01/Mar/2012:23:14:53 +0100] Report: printers-implicit=0
D [01/Mar/2012:23:14:53 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:23:14:53 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:23:14:53 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:23:15:56 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:15:56 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:23:15:56 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:15:56 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:23:15:56 +0100] Report: clients=0
D [01/Mar/2012:23:15:56 +0100] Report: jobs=16
D [01/Mar/2012:23:15:56 +0100] Report: jobs-active=0
D [01/Mar/2012:23:15:56 +0100] Report: printers=1
D [01/Mar/2012:23:15:56 +0100] Report: printers-implicit=0
D [01/Mar/2012:23:15:56 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:23:15:56 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:23:15:56 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:23:16:58 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:16:58 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:23:16:58 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:16:58 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:23:16:58 +0100] Report: clients=0
D [01/Mar/2012:23:16:58 +0100] Report: jobs=16
D [01/Mar/2012:23:16:58 +0100] Report: jobs-active=0
D [01/Mar/2012:23:16:58 +0100] Report: printers=1
D [01/Mar/2012:23:16:58 +0100] Report: printers-implicit=0
D [01/Mar/2012:23:16:58 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:23:16:58 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:23:16:58 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:23:18:00 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:18:00 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:23:18:00 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:18:00 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:23:18:00 +0100] Report: clients=0
D [01/Mar/2012:23:18:00 +0100] Report: jobs=16
D [01/Mar/2012:23:18:00 +0100] Report: jobs-active=0
D [01/Mar/2012:23:18:00 +0100] Report: printers=1
D [01/Mar/2012:23:18:00 +0100] Report: printers-implicit=0
D [01/Mar/2012:23:18:00 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:23:18:00 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:23:18:00 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:23:19:02 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:19:02 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:23:19:02 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:19:02 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:23:19:02 +0100] Report: clients=0
D [01/Mar/2012:23:19:02 +0100] Report: jobs=16
D [01/Mar/2012:23:19:02 +0100] Report: jobs-active=0
D [01/Mar/2012:23:19:02 +0100] Report: printers=1
D [01/Mar/2012:23:19:02 +0100] Report: printers-implicit=0
D [01/Mar/2012:23:19:02 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:23:19:02 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:23:19:02 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:23:20:04 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:20:04 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:23:20:04 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:20:04 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:23:20:04 +0100] Report: clients=0
D [01/Mar/2012:23:20:04 +0100] Report: jobs=16
D [01/Mar/2012:23:20:04 +0100] Report: jobs-active=0
D [01/Mar/2012:23:20:04 +0100] Report: printers=1
D [01/Mar/2012:23:20:04 +0100] Report: printers-implicit=0
D [01/Mar/2012:23:20:04 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:23:20:04 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:23:20:04 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:23:21:06 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:21:06 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:23:21:06 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:21:06 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:23:21:06 +0100] Report: clients=0
D [01/Mar/2012:23:21:06 +0100] Report: jobs=16
D [01/Mar/2012:23:21:06 +0100] Report: jobs-active=0
D [01/Mar/2012:23:21:06 +0100] Report: printers=1
D [01/Mar/2012:23:21:06 +0100] Report: printers-implicit=0
D [01/Mar/2012:23:21:06 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:23:21:06 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:23:21:06 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:23:22:08 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:22:08 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:23:22:08 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:22:08 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:23:22:08 +0100] Report: clients=0
D [01/Mar/2012:23:22:08 +0100] Report: jobs=16
D [01/Mar/2012:23:22:08 +0100] Report: jobs-active=0
D [01/Mar/2012:23:22:08 +0100] Report: printers=1
D [01/Mar/2012:23:22:08 +0100] Report: printers-implicit=0
D [01/Mar/2012:23:22:08 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:23:22:08 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:23:22:08 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:23:23:10 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:23:10 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:23:23:10 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:23:10 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:23:23:10 +0100] Report: clients=0
D [01/Mar/2012:23:23:10 +0100] Report: jobs=16
D [01/Mar/2012:23:23:10 +0100] Report: jobs-active=0
D [01/Mar/2012:23:23:10 +0100] Report: printers=1
D [01/Mar/2012:23:23:10 +0100] Report: printers-implicit=0
D [01/Mar/2012:23:23:10 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:23:23:10 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:23:23:10 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:23:24:12 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:24:12 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:23:24:12 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:24:12 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:23:24:12 +0100] Report: clients=0
D [01/Mar/2012:23:24:12 +0100] Report: jobs=16
D [01/Mar/2012:23:24:12 +0100] Report: jobs-active=0
D [01/Mar/2012:23:24:12 +0100] Report: printers=1
D [01/Mar/2012:23:24:12 +0100] Report: printers-implicit=0
D [01/Mar/2012:23:24:12 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:23:24:12 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:23:24:12 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:23:25:14 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:25:14 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:23:25:14 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:25:14 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:23:25:14 +0100] Report: clients=0
D [01/Mar/2012:23:25:14 +0100] Report: jobs=16
D [01/Mar/2012:23:25:14 +0100] Report: jobs-active=0
D [01/Mar/2012:23:25:14 +0100] Report: printers=1
D [01/Mar/2012:23:25:14 +0100] Report: printers-implicit=0
D [01/Mar/2012:23:25:14 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:23:25:14 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:23:25:14 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:23:26:16 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:26:16 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:23:26:16 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:26:16 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:23:26:16 +0100] Report: clients=0
D [01/Mar/2012:23:26:16 +0100] Report: jobs=16
D [01/Mar/2012:23:26:16 +0100] Report: jobs-active=0
D [01/Mar/2012:23:26:16 +0100] Report: printers=1
D [01/Mar/2012:23:26:16 +0100] Report: printers-implicit=0
D [01/Mar/2012:23:26:16 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:23:26:16 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:23:26:16 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:23:27:18 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:27:18 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:23:27:18 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:27:18 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:23:27:18 +0100] Report: clients=0
D [01/Mar/2012:23:27:18 +0100] Report: jobs=16
D [01/Mar/2012:23:27:18 +0100] Report: jobs-active=0
D [01/Mar/2012:23:27:18 +0100] Report: printers=1
D [01/Mar/2012:23:27:18 +0100] Report: printers-implicit=0
D [01/Mar/2012:23:27:18 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:23:27:18 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:23:27:18 +0100] Report: stringpool-total-bytes=54856
D [01/Mar/2012:23:28:20 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:28:20 +0100] cupsdNetIFUpdate: "eth0" = 192.168.2.100:631
D [01/Mar/2012:23:28:20 +0100] cupsdNetIFUpdate: "lo" = localhost:631
D [01/Mar/2012:23:28:20 +0100] cupsdNetIFUpdate: "eth0" = [v1.fe80::219:66ff:fe5f:5255+eth0]:631
D [01/Mar/2012:23:28:20 +0100] Report: clients=0
D [01/Mar/2012:23:28:20 +0100] Report: jobs=16
D [01/Mar/2012:23:28:20 +0100] Report: jobs-active=0
D [01/Mar/2012:23:28:20 +0100] Report: printers=1
D [01/Mar/2012:23:28:20 +0100] Report: printers-implicit=0
D [01/Mar/2012:23:28:20 +0100] Report: stringpool-string-count=2886
D [01/Mar/2012:23:28:20 +0100] Report: stringpool-alloc-bytes=9328
D [01/Mar/2012:23:28:20 +0100] Report: stringpool-total-bytes=54856