D [15/Oct/2014:14:40:53 +0200] cupsdSetBusyState: newbusy="Not busy", busy="Not busy" D [15/Oct/2014:14:41:36 +0200] cupsdAcceptClient: 13 from localhost (Domain) D [15/Oct/2014:14:41:36 +0200] Report: clients=1 D [15/Oct/2014:14:41:36 +0200] Report: jobs=0 D [15/Oct/2014:14:41:36 +0200] Report: jobs-active=0 D [15/Oct/2014:14:41:36 +0200] Report: printers=1 D [15/Oct/2014:14:41:36 +0200] Report: printers-implicit=0 D [15/Oct/2014:14:41:36 +0200] Report: stringpool-string-count=1032 D [15/Oct/2014:14:41:36 +0200] Report: stringpool-alloc-bytes=10032 D [15/Oct/2014:14:41:36 +0200] Report: stringpool-total-bytes=20832 D [15/Oct/2014:14:41:36 +0200] cupsdReadClient: 13 POST /printers/psc_1100 HTTP/1.1 D [15/Oct/2014:14:41:36 +0200] cupsdSetBusyState: newbusy="Active clients", busy="Not busy" D [15/Oct/2014:14:41:36 +0200] cupsdAuthorize: No authentication data provided. D [15/Oct/2014:14:41:36 +0200] cupsdReadClient: 13 1.1 Create-Job 1 D [15/Oct/2014:14:41:36 +0200] Create-Job ipp://localhost:631/printers/psc_1100 D [15/Oct/2014:14:41:36 +0200] cupsdMarkDirty(----J-) D [15/Oct/2014:14:41:36 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients" D [15/Oct/2014:14:41:36 +0200] add_job: requesting-user-name="kurtwelly" D [15/Oct/2014:14:41:36 +0200] Adding default job-sheets values "none,none"... I [15/Oct/2014:14:41:36 +0200] [Job 53] Adding start banner page "none". D [15/Oct/2014:14:41:36 +0200] Discarding unused job-created event... I [15/Oct/2014:14:41:36 +0200] [Job 53] Queued on "psc_1100" by "kurtwelly". D [15/Oct/2014:14:41:36 +0200] Returning IPP successful-ok for Create-Job (ipp://localhost:631/printers/psc_1100) from localhost D [15/Oct/2014:14:41:36 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" D [15/Oct/2014:14:41:36 +0200] cupsdReadClient: 13 POST /printers/psc_1100 HTTP/1.1 D [15/Oct/2014:14:41:36 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" D [15/Oct/2014:14:41:36 +0200] cupsdAuthorize: No authentication data provided. D [15/Oct/2014:14:41:36 +0200] cupsdReadClient: 13 1.1 Send-Document 1 D [15/Oct/2014:14:41:36 +0200] Send-Document ipp://localhost:631/printers/psc_1100 D [15/Oct/2014:14:41:36 +0200] cupsdIsAuthorized: requesting-user-name="kurtwelly" D [15/Oct/2014:14:41:36 +0200] [Job 53] Auto-typing file... D [15/Oct/2014:14:41:36 +0200] [Job 53] Request file type is application/pdf. D [15/Oct/2014:14:41:36 +0200] cupsdMarkDirty(----J-) D [15/Oct/2014:14:41:36 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" I [15/Oct/2014:14:41:36 +0200] [Job 53] File of type application/pdf queued by "kurtwelly". I [15/Oct/2014:14:41:36 +0200] [Job 53] Adding end banner page "none". D [15/Oct/2014:14:41:36 +0200] cupsdMarkDirty(----J-) D [15/Oct/2014:14:41:36 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [15/Oct/2014:14:41:36 +0200] cupsdMarkDirty(----J-) D [15/Oct/2014:14:41:36 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [15/Oct/2014:14:41:36 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" D [15/Oct/2014:14:41:36 +0200] Discarding unused printer-state-changed event... D [15/Oct/2014:14:41:36 +0200] [Job 53] job-sheets=none,none D [15/Oct/2014:14:41:36 +0200] [Job 53] argv[0]="psc_1100" D [15/Oct/2014:14:41:36 +0200] [Job 53] argv[1]="53" D [15/Oct/2014:14:41:36 +0200] [Job 53] argv[2]="kurtwelly" D [15/Oct/2014:14:41:36 +0200] [Job 53] argv[3]="Unbenannt1" D [15/Oct/2014:14:41:36 +0200] [Job 53] argv[4]="1" D [15/Oct/2014:14:41:36 +0200] [Job 53] argv[5]="PageSize=A4 PrintoutMode=Draft.Gray Quality=300DraftGrayscaleK job-uuid=urn:uuid:f34cce03-4e5e-3349-42be-2cbec45e26ba job-originating-host-name=localhost time-at-creation=1413376896 time-at-processing=1413376896" D [15/Oct/2014:14:41:36 +0200] [Job 53] argv[6]="/var/spool/cups/d00053-001" D [15/Oct/2014:14:41:36 +0200] [Job 53] envp[0]="CUPS_CACHEDIR=/var/cache/cups" D [15/Oct/2014:14:41:36 +0200] [Job 53] envp[1]="CUPS_DATADIR=/usr/share/cups" D [15/Oct/2014:14:41:36 +0200] [Job 53] envp[2]="CUPS_DOCROOT=/usr/share/cups/webcontent" D [15/Oct/2014:14:41:36 +0200] [Job 53] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts" D [15/Oct/2014:14:41:36 +0200] [Job 53] envp[4]="CUPS_REQUESTROOT=/var/spool/cups" D [15/Oct/2014:14:41:36 +0200] [Job 53] envp[5]="CUPS_SERVERBIN=/usr/lib/cups" D [15/Oct/2014:14:41:36 +0200] [Job 53] envp[6]="CUPS_SERVERROOT=/etc/cups" D [15/Oct/2014:14:41:36 +0200] [Job 53] envp[7]="CUPS_STATEDIR=/var/run/cups" D [15/Oct/2014:14:41:36 +0200] [Job 53] envp[8]="HOME=/var/spool/cups/tmp" D [15/Oct/2014:14:41:36 +0200] [Job 53] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin" D [15/Oct/2014:14:41:36 +0200] [Job 53] envp[10]="SERVER_ADMIN=root@linux-b5l1.site" D [15/Oct/2014:14:41:36 +0200] [Job 53] envp[11]="SOFTWARE=CUPS/1.5.4" D [15/Oct/2014:14:41:36 +0200] [Job 53] envp[12]="TMPDIR=/var/spool/cups/tmp" D [15/Oct/2014:14:41:36 +0200] [Job 53] envp[13]="USER=root" D [15/Oct/2014:14:41:36 +0200] [Job 53] envp[14]="CUPS_MAX_MESSAGE=2047" D [15/Oct/2014:14:41:36 +0200] [Job 53] envp[15]="CUPS_SERVER=/var/run/cups/cups.sock" D [15/Oct/2014:14:41:36 +0200] [Job 53] envp[16]="CUPS_ENCRYPTION=IfRequested" D [15/Oct/2014:14:41:36 +0200] [Job 53] envp[17]="IPP_PORT=631" D [15/Oct/2014:14:41:36 +0200] [Job 53] envp[18]="CHARSET=utf-8" D [15/Oct/2014:14:41:36 +0200] [Job 53] envp[19]="LANG=de_DE.UTF-8" D [15/Oct/2014:14:41:36 +0200] [Job 53] envp[20]="PPD=/etc/cups/ppd/psc_1100.ppd" D [15/Oct/2014:14:41:36 +0200] [Job 53] envp[21]="RIP_MAX_CACHE=128m" D [15/Oct/2014:14:41:36 +0200] [Job 53] envp[22]="CONTENT_TYPE=application/pdf" D [15/Oct/2014:14:41:36 +0200] [Job 53] envp[23]="DEVICE_URI=hp:/usb/psc_1100_series?serial=HU41VGP24NB0" D [15/Oct/2014:14:41:36 +0200] [Job 53] envp[24]="PRINTER_INFO=HP PSC 1100 Series hpijs, 3.14.6" D [15/Oct/2014:14:41:36 +0200] [Job 53] envp[25]="PRINTER_LOCATION=" D [15/Oct/2014:14:41:36 +0200] [Job 53] envp[26]="PRINTER=psc_1100" D [15/Oct/2014:14:41:36 +0200] [Job 53] envp[27]="PRINTER_STATE_REASONS=none" D [15/Oct/2014:14:41:36 +0200] [Job 53] envp[28]="CUPS_FILETYPE=document" D [15/Oct/2014:14:41:36 +0200] [Job 53] envp[29]="FINAL_CONTENT_TYPE=printer/psc_1100" D [15/Oct/2014:14:41:36 +0200] [Job 53] envp[30]="AUTH_I****" I [15/Oct/2014:14:41:36 +0200] [Job 53] Started filter /usr/lib/cups/filter/pdftops (PID 4072) I [15/Oct/2014:14:41:36 +0200] [Job 53] Started filter /usr/lib/cups/filter/foomatic-rip (PID 4073) I [15/Oct/2014:14:41:36 +0200] [Job 53] Started backend /usr/lib/cups/backend/hp (PID 4074) D [15/Oct/2014:14:41:36 +0200] Discarding unused job-state-changed event... D [15/Oct/2014:14:41:36 +0200] Returning IPP successful-ok for Send-Document (ipp://localhost:631/printers/psc_1100) from localhost D [15/Oct/2014:14:41:36 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients and dirty files" D [15/Oct/2014:14:41:36 +0200] [Job 53] Getting input from file D [15/Oct/2014:14:41:36 +0200] [Job 53] foomatic-rip version 4.0.12.246 running... D [15/Oct/2014:14:41:36 +0200] [Job 53] Parsing PPD file ... D [15/Oct/2014:14:41:36 +0200] [Job 53] Added option ColorSpace D [15/Oct/2014:14:41:36 +0200] [Job 53] Added option Resolution D [15/Oct/2014:14:41:36 +0200] [Job 53] Added option PageSize D [15/Oct/2014:14:41:36 +0200] [Job 53] Added option Model D [15/Oct/2014:14:41:36 +0200] [Job 53] Added option PrintoutMode D [15/Oct/2014:14:41:36 +0200] [Job 53] Added option Quality D [15/Oct/2014:14:41:36 +0200] [Job 53] Added option ImageableArea D [15/Oct/2014:14:41:36 +0200] [Job 53] Added option PaperDimension D [15/Oct/2014:14:41:36 +0200] [Job 53] Added option Font D [15/Oct/2014:14:41:36 +0200] [Job 53] D [15/Oct/2014:14:41:36 +0200] [Job 53] Parameter Summary D [15/Oct/2014:14:41:36 +0200] [Job 53] ----------------- D [15/Oct/2014:14:41:36 +0200] [Job 53] D [15/Oct/2014:14:41:36 +0200] [Job 53] Spooler: cups D [15/Oct/2014:14:41:36 +0200] [Job 53] Printer: psc_1100 D [15/Oct/2014:14:41:36 +0200] [Job 53] Shell: /bin/bash D [15/Oct/2014:14:41:36 +0200] [Job 53] PPD file: /etc/cups/ppd/psc_1100.ppd D [15/Oct/2014:14:41:36 +0200] [Job 53] ATTR file: D [15/Oct/2014:14:41:36 +0200] [Job 53] Printer model: HP PSC 1100 Series hpijs, 3.14.6 D [15/Oct/2014:14:41:36 +0200] [Job 53] Job title: Unbenannt1 D [15/Oct/2014:14:41:36 +0200] [Job 53] File(s) to be printed: D [15/Oct/2014:14:41:36 +0200] [Job 53] D [15/Oct/2014:14:41:36 +0200] [Job 53] D [15/Oct/2014:14:41:36 +0200] [Job 53] Ghostscript extra search path ('GS_LIB'): /usr/share/cups/fonts D [15/Oct/2014:14:41:36 +0200] [Job 53] Printing system options: D [15/Oct/2014:14:41:36 +0200] [Job 53] Pondering option 'job-uuid=urn:uuid:f34cce03-4e5e-3349-42be-2cbec45e26ba' D [15/Oct/2014:14:41:36 +0200] [Job 53] Unknown option job-uuid=urn:uuid:f34cce03-4e5e-3349-42be-2cbec45e26ba. D [15/Oct/2014:14:41:36 +0200] [Job 53] Pondering option 'job-originating-host-name=localhost' D [15/Oct/2014:14:41:36 +0200] [Job 53] Unknown option job-originating-host-name=localhost. D [15/Oct/2014:14:41:36 +0200] [Job 53] Pondering option 'time-at-creation=1413376896' D [15/Oct/2014:14:41:36 +0200] [Job 53] Unknown option time-at-creation=1413376896. D [15/Oct/2014:14:41:36 +0200] [Job 53] Pondering option 'time-at-processing=1413376896' D [15/Oct/2014:14:41:36 +0200] [Job 53] Unknown option time-at-processing=1413376896. D [15/Oct/2014:14:41:36 +0200] [Job 53] Options from the PPD file: D [15/Oct/2014:14:41:36 +0200] [Job 53] Pondering option 'PageSize=A4' D [15/Oct/2014:14:41:36 +0200] [Job 53] Pondering option 'PrintoutMode=Draft.Gray' D [15/Oct/2014:14:41:36 +0200] [Job 53] Pondering option 'Quality=300DraftGrayscaleK' D [15/Oct/2014:14:41:36 +0200] [Job 53] D [15/Oct/2014:14:41:36 +0200] [Job 53] ================================================ D [15/Oct/2014:14:41:36 +0200] [Job 53] D [15/Oct/2014:14:41:36 +0200] [Job 53] File: D [15/Oct/2014:14:41:36 +0200] [Job 53] D [15/Oct/2014:14:41:36 +0200] [Job 53] ================================================ D [15/Oct/2014:14:41:36 +0200] [Job 53] D [15/Oct/2014:14:41:36 +0200] [Job 53] Started filter pdftops (PID 4075) D [15/Oct/2014:14:41:36 +0200] [Job 53] Started filter pstops (PID 4076) D [15/Oct/2014:14:41:36 +0200] cupsdAcceptClient: 17 from localhost (Domain) D [15/Oct/2014:14:41:36 +0200] cupsdReadClient: 17 POST / HTTP/1.1 D [15/Oct/2014:14:41:36 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [15/Oct/2014:14:41:36 +0200] cupsdAuthorize: No authentication data provided. D [15/Oct/2014:14:41:36 +0200] cupsdReadClient: 17 1.1 CUPS-Get-Printers 1 D [15/Oct/2014:14:41:36 +0200] CUPS-Get-Printers D [15/Oct/2014:14:41:36 +0200] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost D [15/Oct/2014:14:41:36 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [15/Oct/2014:14:41:36 +0200] cupsdAcceptClient: 19 from localhost (Domain) D [15/Oct/2014:14:41:36 +0200] cupsdReadClient: 19 POST / HTTP/1.1 D [15/Oct/2014:14:41:36 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [15/Oct/2014:14:41:36 +0200] cupsdAuthorize: No authentication data provided. D [15/Oct/2014:14:41:36 +0200] cupsdReadClient: 19 1.1 CUPS-Get-Default 1 D [15/Oct/2014:14:41:36 +0200] CUPS-Get-Default D [15/Oct/2014:14:41:36 +0200] CUPS-Get-Default client-error-not-found: No default printer. D [15/Oct/2014:14:41:36 +0200] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost D [15/Oct/2014:14:41:36 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [15/Oct/2014:14:41:36 +0200] cupsdReadClient: 17 POST / HTTP/1.1 D [15/Oct/2014:14:41:36 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [15/Oct/2014:14:41:36 +0200] cupsdAuthorize: No authentication data provided. D [15/Oct/2014:14:41:36 +0200] cupsdReadClient: 17 1.1 CUPS-Get-Printers 1 D [15/Oct/2014:14:41:36 +0200] CUPS-Get-Printers D [15/Oct/2014:14:41:36 +0200] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost D [15/Oct/2014:14:41:36 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [15/Oct/2014:14:41:36 +0200] cupsdReadClient: 19 POST / HTTP/1.1 D [15/Oct/2014:14:41:36 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" D [15/Oct/2014:14:41:36 +0200] cupsdAuthorize: No authentication data provided. D [15/Oct/2014:14:41:36 +0200] cupsdReadClient: 19 1.1 Get-Jobs 1 D [15/Oct/2014:14:41:36 +0200] Get-Jobs ipp://localhost/ D [15/Oct/2014:14:41:36 +0200] Returning IPP successful-ok for Get-Jobs (ipp://localhost/) from localhost D [15/Oct/2014:14:41:36 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" D [15/Oct/2014:14:41:36 +0200] [Job 53] Page = 595x842; 10,36 to 585,833 D [15/Oct/2014:14:41:36 +0200] [Job 53] slow_collate=0, slow_duplex=0, slow_order=0 D [15/Oct/2014:14:41:36 +0200] [Job 53] Before copy_comments - %!PS-Adobe-3.0 D [15/Oct/2014:14:41:36 +0200] [Job 53] %!PS-Adobe-3.0 D [15/Oct/2014:14:41:36 +0200] [Job 53] %Produced by poppler pdftops version: 0.24.3 (http://poppler.freedesktop.org) D [15/Oct/2014:14:41:36 +0200] [Job 53] %%Creator: LibreOffice 4.1.6.2 D [15/Oct/2014:14:41:36 +0200] [Job 53] %%LanguageLevel: 3 D [15/Oct/2014:14:41:36 +0200] [Job 53] %%DocumentSuppliedResources: (atend) D [15/Oct/2014:14:41:36 +0200] [Job 53] %%DocumentMedia: 595x842 595 842 0 () () D [15/Oct/2014:14:41:36 +0200] [Job 53] %%BoundingBox: 0 0 595 842 D [15/Oct/2014:14:41:36 +0200] [Job 53] %%Pages: 1 D [15/Oct/2014:14:41:36 +0200] [Job 53] %%EndComments D [15/Oct/2014:14:41:36 +0200] [Job 53] Before copy_prolog - %%BeginProlog D [15/Oct/2014:14:41:36 +0200] [Job 53] Filetype: PostScript D [15/Oct/2014:14:41:36 +0200] [Job 53] Reading PostScript input ... D [15/Oct/2014:14:41:36 +0200] [Job 53] --> This document is DSC-conforming! D [15/Oct/2014:14:41:36 +0200] [Job 53] Found %RBINumCopies: 1 D [15/Oct/2014:14:41:36 +0200] [Job 53] D [15/Oct/2014:14:41:36 +0200] [Job 53] ----------- D [15/Oct/2014:14:41:36 +0200] [Job 53] Found: %%BeginProlog D [15/Oct/2014:14:41:36 +0200] [Job 53] Before copy_setup - %%BeginSetup D [15/Oct/2014:14:41:36 +0200] [Job 53] Found: %%EndProlog D [15/Oct/2014:14:41:36 +0200] [Job 53] D [15/Oct/2014:14:41:36 +0200] [Job 53] ----------- D [15/Oct/2014:14:41:36 +0200] [Job 53] Found: %%BeginSetup D [15/Oct/2014:14:41:36 +0200] [Job 53] Found: %%BeginFeature: *PageSize A4 D [15/Oct/2014:14:41:36 +0200] [Job 53] Option: PageSize=A4 D [15/Oct/2014:14:41:36 +0200] [Job 53] Setting option D [15/Oct/2014:14:41:36 +0200] [Job 53] Found: %% FoomaticRIPOptionSetting: PageSize=A4 D [15/Oct/2014:14:41:36 +0200] [Job 53] Option: PageSize=A4 D [15/Oct/2014:14:41:36 +0200] [Job 53] Setting option D [15/Oct/2014:14:41:36 +0200] [Job 53] Found: %%BeginFeature: *PrintoutMode Draft.Gray D [15/Oct/2014:14:41:36 +0200] [Job 53] Option: PrintoutMode=Draft.Gray D [15/Oct/2014:14:41:36 +0200] [Job 53] Setting option D [15/Oct/2014:14:41:36 +0200] [Job 53] Found: %% FoomaticRIPOptionSetting: PrintoutMode=Draft.Gray D [15/Oct/2014:14:41:36 +0200] [Job 53] Option: PrintoutMode=Draft.Gray D [15/Oct/2014:14:41:36 +0200] [Job 53] Setting option D [15/Oct/2014:14:41:36 +0200] [Job 53] Found: %%BeginFeature: *Quality 300DraftGrayscaleK D [15/Oct/2014:14:41:36 +0200] [Job 53] Option: Quality=300DraftGrayscaleK D [15/Oct/2014:14:41:36 +0200] [Job 53] Setting option D [15/Oct/2014:14:41:36 +0200] [Job 53] Found: %% FoomaticRIPOptionSetting: Quality=300DraftGrayscaleK D [15/Oct/2014:14:41:36 +0200] [Job 53] Option: Quality=300DraftGrayscaleK D [15/Oct/2014:14:41:36 +0200] [Job 53] Setting option D [15/Oct/2014:14:41:36 +0200] [Job 53] Before page loop - %%Page: 1 1 D [15/Oct/2014:14:41:36 +0200] [Job 53] Copying page 1... D [15/Oct/2014:14:41:36 +0200] [Job 53] pagew = 575.6, pagel = 797.0 D [15/Oct/2014:14:41:36 +0200] [Job 53] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842 D [15/Oct/2014:14:41:36 +0200] [Job 53] PageLeft = 9.7, PageRight = 585.3 D [15/Oct/2014:14:41:36 +0200] [Job 53] PageTop = 833.0, PageBottom = 36.0 D [15/Oct/2014:14:41:36 +0200] [Job 53] PageWidth = 595.0, PageLength = 842.0 D [15/Oct/2014:14:41:36 +0200] [Job 53] Found: %%EndSetup D [15/Oct/2014:14:41:36 +0200] [Job 53] Inserting PostScript code for CUPS' page accounting D [15/Oct/2014:14:41:36 +0200] [Job 53] D [15/Oct/2014:14:41:36 +0200] [Job 53] ----------- D [15/Oct/2014:14:41:36 +0200] [Job 53] New page: %%Page: 1 1 D [15/Oct/2014:14:41:36 +0200] [Job 53] PID 4075 (pdftops) exited with no errors. D [15/Oct/2014:14:41:36 +0200] [Job 53] D [15/Oct/2014:14:41:36 +0200] [Job 53] Found: %%BeginPageSetup D [15/Oct/2014:14:41:36 +0200] [Job 53] Inserting option code into "PageSetup" section. D [15/Oct/2014:14:41:36 +0200] [Job 53] Wrote 1 pages... D [15/Oct/2014:14:41:36 +0200] [Job 53] PID 4076 (pstops) exited with no errors. D [15/Oct/2014:14:41:36 +0200] [Job 53] Flushing FIFO. D [15/Oct/2014:14:41:36 +0200] PID 4072 (/usr/lib/cups/filter/pdftops) exited with no errors. D [15/Oct/2014:14:41:36 +0200] [Job 53] D [15/Oct/2014:14:41:36 +0200] [Job 53] Starting renderer with command: "gs -sstdout=%stderr -dBATCH -dPARANOIDSAFER -dQUIET -dNOPAUSE -sDEVICE=ijs -sIjsServer=hpijs -dDEVICEWIDTHPOINTS=595 -dDEVICEHEIGHTPOINTS=842 -sDeviceManufacturer="HEWLETT-PACKARD" -sDeviceModel="deskjet 3320" -r300 -sIjsParams=Quality:Quality=1,Quality:ColorMode=0,Quality:MediaType=0,Quality:PenSet=0 -dIjsUseOutputFD -sOutputFile=%stdout -_" D [15/Oct/2014:14:41:36 +0200] [Job 53] Starting process "kid3" (generation 1) D [15/Oct/2014:14:41:36 +0200] [Job 53] D [15/Oct/2014:14:41:36 +0200] [Job 53] Closing renderer D [15/Oct/2014:14:41:36 +0200] [Job 53] Starting process "kid4" (generation 2) D [15/Oct/2014:14:41:36 +0200] [Job 53] Starting process "renderer" (generation 2) D [15/Oct/2014:14:41:36 +0200] [Job 53] JCL: #%-12345X@PJL D [15/Oct/2014:14:41:36 +0200] [Job 53] D [15/Oct/2014:14:41:36 +0200] [Job 53] D [15/Oct/2014:14:41:36 +0200] [Job 53] PAGE: 1 1 D [15/Oct/2014:14:41:36 +0200] Discarding unused job-progress event... D [15/Oct/2014:14:41:36 +0200] [Job 53] renderer exited with status 0 D [15/Oct/2014:14:41:36 +0200] [Job 53] STATE: +connecting-to-device D [15/Oct/2014:14:41:36 +0200] Discarding unused printer-state-changed event... D [15/Oct/2014:14:41:36 +0200] [Job 53] kid4 exited with status 0 D [15/Oct/2014:14:41:36 +0200] [Job 53] kid3 finished D [15/Oct/2014:14:41:36 +0200] [Job 53] kid3 exited with status 0 D [15/Oct/2014:14:41:36 +0200] [Job 53] D [15/Oct/2014:14:41:36 +0200] [Job 53] Closing foomatic-rip. D [15/Oct/2014:14:41:36 +0200] PID 4073 (/usr/lib/cups/filter/foomatic-rip) exited with no errors. D [15/Oct/2014:14:41:36 +0200] [Job 53] prnt/backend/hp.c 808: ERROR: open device failed stat=12: hp:/usb/psc_1100_series?serial=HU41VGP24NB0 D [15/Oct/2014:14:41:36 +0200] PID 4074 (/usr/lib/cups/backend/hp) stopped with status 1. I [15/Oct/2014:14:41:36 +0200] [Job 53] Backend returned status 1 (failed) D [15/Oct/2014:14:41:36 +0200] Discarding unused job-state-changed event... I [15/Oct/2014:14:41:36 +0200] [Job 53] Printer stopped due to backend errors; please consult the error_log file for details. D [15/Oct/2014:14:41:36 +0200] cupsdMarkDirty(----J-) D [15/Oct/2014:14:41:36 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [15/Oct/2014:14:41:36 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [15/Oct/2014:14:41:36 +0200] Discarding unused printer-stopped event... D [15/Oct/2014:14:41:36 +0200] cupsdMarkDirty(P-----) D [15/Oct/2014:14:41:36 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [15/Oct/2014:14:41:36 +0200] cupsdRegisterPrinter(p=0x7effc6ec2370(psc_1100)) D [15/Oct/2014:14:41:36 +0200] cupsdMarkDirty(P-----) D [15/Oct/2014:14:41:36 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [15/Oct/2014:14:41:36 +0200] cupsdReadClient: 17 POST / HTTP/1.1 D [15/Oct/2014:14:41:36 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Printing jobs and dirty files" D [15/Oct/2014:14:41:36 +0200] cupsdAuthorize: No authentication data provided. D [15/Oct/2014:14:41:36 +0200] cupsdReadClient: 17 1.1 CUPS-Get-Printers 1 D [15/Oct/2014:14:41:36 +0200] CUPS-Get-Printers D [15/Oct/2014:14:41:36 +0200] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost D [15/Oct/2014:14:41:36 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" D [15/Oct/2014:14:41:36 +0200] cupsdReadClient: 19 POST / HTTP/1.1 D [15/Oct/2014:14:41:36 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" D [15/Oct/2014:14:41:36 +0200] cupsdAuthorize: No authentication data provided. D [15/Oct/2014:14:41:36 +0200] cupsdReadClient: 19 1.1 CUPS-Get-Default 1 D [15/Oct/2014:14:41:36 +0200] CUPS-Get-Default D [15/Oct/2014:14:41:36 +0200] CUPS-Get-Default client-error-not-found: No default printer. D [15/Oct/2014:14:41:36 +0200] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost D [15/Oct/2014:14:41:36 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" D [15/Oct/2014:14:41:36 +0200] cupsdReadClient: 17 POST / HTTP/1.1 D [15/Oct/2014:14:41:36 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" D [15/Oct/2014:14:41:36 +0200] cupsdAuthorize: No authentication data provided. D [15/Oct/2014:14:41:36 +0200] cupsdReadClient: 17 1.1 CUPS-Get-Printers 1 D [15/Oct/2014:14:41:36 +0200] CUPS-Get-Printers D [15/Oct/2014:14:41:36 +0200] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost D [15/Oct/2014:14:41:36 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" D [15/Oct/2014:14:41:36 +0200] cupsdReadClient: 19 POST / HTTP/1.1 D [15/Oct/2014:14:41:36 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" D [15/Oct/2014:14:41:36 +0200] cupsdAuthorize: No authentication data provided. D [15/Oct/2014:14:41:36 +0200] cupsdReadClient: 19 1.1 Get-Jobs 1 D [15/Oct/2014:14:41:36 +0200] Get-Jobs ipp://localhost/ D [15/Oct/2014:14:41:36 +0200] Returning IPP successful-ok for Get-Jobs (ipp://localhost/) from localhost D [15/Oct/2014:14:41:36 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" I [15/Oct/2014:14:42:07 +0200] Saving printers.conf... I [15/Oct/2014:14:42:08 +0200] Saving job.cache... D [15/Oct/2014:14:42:08 +0200] cupsdSetBusyState: newbusy="Not busy", busy="Dirty files" D [15/Oct/2014:14:42:41 +0200] Report: clients=3 D [15/Oct/2014:14:42:41 +0200] Report: jobs=1 D [15/Oct/2014:14:42:41 +0200] Report: jobs-active=1 D [15/Oct/2014:14:42:41 +0200] Report: printers=1 D [15/Oct/2014:14:42:41 +0200] Report: printers-implicit=0 D [15/Oct/2014:14:42:41 +0200] Report: stringpool-string-count=1076 D [15/Oct/2014:14:42:41 +0200] Report: stringpool-alloc-bytes=10936 D [15/Oct/2014:14:42:41 +0200] Report: stringpool-total-bytes=21688 D [15/Oct/2014:14:43:47 +0200] Report: clients=3 D [15/Oct/2014:14:43:47 +0200] Report: jobs=1 D [15/Oct/2014:14:43:47 +0200] Report: jobs-active=1 D [15/Oct/2014:14:43:47 +0200] Report: printers=1 D [15/Oct/2014:14:43:47 +0200] Report: printers-implicit=0 D [15/Oct/2014:14:43:47 +0200] Report: stringpool-string-count=1076 D [15/Oct/2014:14:43:47 +0200] Report: stringpool-alloc-bytes=10936 D [15/Oct/2014:14:43:47 +0200] Report: stringpool-total-bytes=21688