Login
[x]
Log in using an account from:
Fedora Account System
Red Hat Associate
Red Hat Customer
Or login using a Red Hat Bugzilla account
Forgot Password
Login:
Hide Forgot
Create an Account
Red Hat Bugzilla – Attachment 915438 Details for
Bug 811307
CUPS does not print when firewalld is running
[?]
New
Simple Search
Advanced Search
My Links
Browse
Requests
Reports
Current State
Search
Tabular reports
Graphical reports
Duplicates
Other Reports
User Changes
Plotly Reports
Bug Status
Bug Severity
Non-Defaults
|
Product Dashboard
Help
Page Help!
Bug Writing Guidelines
What's new
Browser Support Policy
5.0.4.rh83 Release notes
FAQ
Guides index
User guide
Web Services
Contact
Legal
This site requires JavaScript to be enabled to function correctly, please enable it.
Comment
comment_4587568.txt (text/plain), 126.38 KB, created by
cblaauw
on 2012-04-11 20:29:33 UTC
(
hide
)
Description:
Comment
Filename:
MIME Type:
Creator:
cblaauw
Created:
2012-04-11 20:29:33 UTC
Size:
126.38 KB
patch
obsolete
>outout of printing troubleshooter: > >D [11/Apr/2012:22:27:25 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [11/Apr/2012:22:27:25 +0200] cupsdReadClient: 18 POST / HTTP/1.1 >D [11/Apr/2012:22:27:25 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [11/Apr/2012:22:27:25 +0200] cupsdAuthorize: No authentication data provided. >D [11/Apr/2012:22:27:25 +0200] cupsdReadClient: 18 1.1 Get-Jobs 1 >D [11/Apr/2012:22:27:25 +0200] Get-Jobs ipp://localhost/printers/ >D [11/Apr/2012:22:27:25 +0200] Returning IPP successful-ok for Get-Jobs (ipp://localhost/printers/) from localhost >D [11/Apr/2012:22:27:25 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [11/Apr/2012:22:27:25 +0200] cupsdReadClient: 18 POST / HTTP/1.1 >D [11/Apr/2012:22:27:25 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [11/Apr/2012:22:27:25 +0200] cupsdAuthorize: No authentication data provided. >D [11/Apr/2012:22:27:25 +0200] cupsdReadClient: 18 1.1 Get-Jobs 1 >D [11/Apr/2012:22:27:25 +0200] Get-Jobs ipp://localhost/printers/ >D [11/Apr/2012:22:27:25 +0200] [Job 1] Loading attributes... >D [11/Apr/2012:22:27:25 +0200] [Job 2] Loading attributes... >D [11/Apr/2012:22:27:25 +0200] [Job 3] Loading attributes... >D [11/Apr/2012:22:27:25 +0200] [Job 4] Loading attributes... >D [11/Apr/2012:22:27:25 +0200] [Job 5] Loading attributes... >D [11/Apr/2012:22:27:25 +0200] [Job 6] Loading attributes... >D [11/Apr/2012:22:27:25 +0200] [Job 7] Loading attributes... >D [11/Apr/2012:22:27:25 +0200] Returning IPP successful-ok for Get-Jobs (ipp://localhost/printers/) from localhost >D [11/Apr/2012:22:27:25 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [11/Apr/2012:22:27:25 +0200] cupsdReadClient: 18 POST / HTTP/1.1 >D [11/Apr/2012:22:27:25 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [11/Apr/2012:22:27:25 +0200] cupsdAuthorize: No authentication data provided. >D [11/Apr/2012:22:27:25 +0200] cupsdReadClient: 18 1.1 Create-Printer-Subscription 1 >D [11/Apr/2012:22:27:25 +0200] Create-Printer-Subscription / >D [11/Apr/2012:22:27:25 +0200] cupsdCreateSubscription(con=0x7f074fa923e0(18), uri="/") >D [11/Apr/2012:22:27:25 +0200] pullmethod="ippget" >D [11/Apr/2012:22:27:25 +0200] notify-lease-duration=86400 >D [11/Apr/2012:22:27:25 +0200] notify-time-interval=0 >D [11/Apr/2012:22:27:25 +0200] cupsdAddSubscription(mask=17800, dest=(nil)(), job=(nil)(0), uri="(null)") >D [11/Apr/2012:22:27:25 +0200] Added subscription #73 for server. >D [11/Apr/2012:22:27:25 +0200] cupsdMarkDirty(-----S) >D [11/Apr/2012:22:27:25 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >D [11/Apr/2012:22:27:25 +0200] Returning IPP successful-ok for Create-Printer-Subscription (/) from localhost >D [11/Apr/2012:22:27:25 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [11/Apr/2012:22:27:26 +0200] cupsdAcceptClient: skipping getpeercon() >D [11/Apr/2012:22:27:26 +0200] cupsdAcceptClient: 19 from localhost (Domain) >D [11/Apr/2012:22:27:26 +0200] cupsdReadClient: 19 POST / HTTP/1.1 >D [11/Apr/2012:22:27:26 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [11/Apr/2012:22:27:26 +0200] cupsdAuthorize: No authentication data provided. >D [11/Apr/2012:22:27:26 +0200] cupsdReadClient: 19 1.1 Get-Notifications 1 >D [11/Apr/2012:22:27:26 +0200] Get-Notifications / >D [11/Apr/2012:22:27:26 +0200] cupsdIsAuthorized: requesting-user-name="carsten" >D [11/Apr/2012:22:27:26 +0200] Returning IPP successful-ok for Get-Notifications (/) from localhost >D [11/Apr/2012:22:27:26 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [11/Apr/2012:22:27:26 +0200] cupsdReadClient: 19 WAITING Closing on EOF >D [11/Apr/2012:22:27:26 +0200] cupsdCloseClient: 19 >D [11/Apr/2012:22:27:26 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" >D [11/Apr/2012:22:27:26 +0200] cupsdReadClient: 18 POST / HTTP/1.1 >D [11/Apr/2012:22:27:26 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [11/Apr/2012:22:27:26 +0200] cupsdAuthorize: No authentication data provided. >D [11/Apr/2012:22:27:26 +0200] cupsdReadClient: 18 1.1 Get-Notifications 1 >D [11/Apr/2012:22:27:26 +0200] Get-Notifications / >D [11/Apr/2012:22:27:26 +0200] cupsdIsAuthorized: requesting-user-name="carsten" >D [11/Apr/2012:22:27:26 +0200] Returning IPP successful-ok for Get-Notifications (/) from localhost >D [11/Apr/2012:22:27:26 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [11/Apr/2012:22:27:30 +0200] cupsdAcceptClient: skipping getpeercon() >D [11/Apr/2012:22:27:30 +0200] cupsdAcceptClient: 19 from localhost (Domain) >D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 19 POST /printers/Officejet-4500-G510g-m HTTP/1.1 >D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [11/Apr/2012:22:27:30 +0200] cupsdAuthorize: No authentication data provided. >D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 19 1.1 Print-Job 1 >D [11/Apr/2012:22:27:30 +0200] Print-Job ipp://localhost/printers/Officejet-4500-G510g-m >D [11/Apr/2012:22:27:30 +0200] [Job ???] Auto-typing file... >I [11/Apr/2012:22:27:30 +0200] [Job ???] Request file type is application/vnd.cups-banner. >D [11/Apr/2012:22:27:30 +0200] add_job: setting context of job to UNKNOWN SL >D [11/Apr/2012:22:27:30 +0200] cupsdMarkDirty(----J-) >D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >D [11/Apr/2012:22:27:30 +0200] add_job: requesting-user-name="carsten" >D [11/Apr/2012:22:27:30 +0200] Adding default job-sheets values "none,none"... >I [11/Apr/2012:22:27:30 +0200] [Job 8] Adding start banner page "none". >D [11/Apr/2012:22:27:30 +0200] Notifier dbus started - PID = 13504 >D [11/Apr/2012:22:27:30 +0200] cupsdMarkDirty(-----S) >D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >D [11/Apr/2012:22:27:30 +0200] cupsdMarkDirty(----J-) >D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >I [11/Apr/2012:22:27:30 +0200] [Job 8] Adding end banner page "none". >I [11/Apr/2012:22:27:30 +0200] [Job 8] File of type application/vnd.cups-banner queued by "carsten". >D [11/Apr/2012:22:27:30 +0200] [Job 8] hold_until=0 >I [11/Apr/2012:22:27:30 +0200] [Job 8] Queued on "Officejet-4500-G510g-m" by "carsten". >D [11/Apr/2012:22:27:30 +0200] cupsdMarkDirty(----J-) >D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >D [11/Apr/2012:22:27:30 +0200] cupsdMarkDirty(-----S) >D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >D [11/Apr/2012:22:27:30 +0200] [Job 8] job-sheets=none,none >D [11/Apr/2012:22:27:30 +0200] [Job 8] argv[0]="Officejet-4500-G510g-m" >D [11/Apr/2012:22:27:30 +0200] [Job 8] argv[1]="8" >D [11/Apr/2012:22:27:30 +0200] [Job 8] argv[2]="carsten" >D [11/Apr/2012:22:27:30 +0200] [Job 8] argv[3]="Test Page" >D [11/Apr/2012:22:27:30 +0200] [Job 8] argv[4]="1" >D [11/Apr/2012:22:27:30 +0200] [Job 8] argv[5]="job-uuid=urn:uuid:95de8fc5-dbbb-365a-5b88-5e23547a9de1 PageSize=A4.FB job-originating-host-name=localhost time-at-creation=1334176050 time-at-processing=1334176050 AP_D_InputSlot=" >D [11/Apr/2012:22:27:30 +0200] [Job 8] argv[6]="/var/spool/cups/d00008-001" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[0]="CUPS_CACHEDIR=/var/cache/cups" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[1]="CUPS_DATADIR=/usr/share/cups" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[2]="CUPS_DOCROOT=/usr/share/cups/www" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[4]="CUPS_REQUESTROOT=/var/spool/cups" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[5]="CUPS_SERVERBIN=/usr/lib/cups" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[6]="CUPS_SERVERROOT=/etc/cups" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[7]="CUPS_STATEDIR=/var/run/cups" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[8]="HOME=/var/spool/cups/tmp" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[9]="PATH=/usr/lib/cups/filter:/usr/lib64/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[10]="SERVER_ADMIN=root@m7" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[11]="SOFTWARE=CUPS/1.5.2" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[12]="TMPDIR=/var/spool/cups/tmp" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[13]="USER=root" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[14]="CUPS_SERVER=/var/run/cups/cups.sock" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[15]="CUPS_ENCRYPTION=IfRequested" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[16]="IPP_PORT=631" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[17]="CHARSET=utf-8" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[18]="LANG=de_DE.UTF-8" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[19]="PPD=/etc/cups/ppd/Officejet-4500-G510g-m.ppd" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[20]="RIP_MAX_CACHE=128m" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[21]="CONTENT_TYPE=application/vnd.cups-banner" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[22]="DEVICE_URI=dnssd://Officejet%204500%20G510g-m%20%5B697EF2%5D._pdl-datastream._tcp.local/" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[23]="PRINTER_INFO=Officejet 4500 G510g-m [697EF2]" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[24]="PRINTER_LOCATION=" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[25]="PRINTER=Officejet-4500-G510g-m" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[26]="PRINTER_STATE_REASONS=none" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[27]="CUPS_FILETYPE=document" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[28]="FINAL_CONTENT_TYPE=printer/Officejet-4500-G510g-m" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[29]="AUTH_I****" >I [11/Apr/2012:22:27:30 +0200] [Job 8] Started filter /usr/lib/cups/filter/bannertops (PID 13505) >I [11/Apr/2012:22:27:30 +0200] [Job 8] Started filter /usr/lib/cups/filter/pstops (PID 13506) >I [11/Apr/2012:22:27:30 +0200] [Job 8] Started filter /usr/lib/cups/filter/gstoraster (PID 13507) >I [11/Apr/2012:22:27:30 +0200] [Job 8] Started filter /usr/lib/cups/filter/hpcups (PID 13508) >I [11/Apr/2012:22:27:30 +0200] [Job 8] Started backend /usr/lib/cups/backend/dnssd (PID 13509) >D [11/Apr/2012:22:27:30 +0200] cupsdMarkDirty(-----S) >D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients and dirty files" >D [11/Apr/2012:22:27:30 +0200] Returning IPP successful-ok for Print-Job (ipp://localhost/printers/Officejet-4500-G510g-m) from localhost >D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [11/Apr/2012:22:27:30 +0200] [Notifier] state=3 >D [11/Apr/2012:22:27:30 +0200] [Notifier] Connected to D-BUS >D [11/Apr/2012:22:27:30 +0200] [Notifier] JobCreated >D [11/Apr/2012:22:27:30 +0200] [Notifier] state=3 >D [11/Apr/2012:22:27:30 +0200] [Notifier] PrinterStateChanged >D [11/Apr/2012:22:27:30 +0200] [Notifier] state=3 >D [11/Apr/2012:22:27:30 +0200] [Notifier] JobState >D [11/Apr/2012:22:27:30 +0200] cupsdAcceptClient: skipping getpeercon() >D [11/Apr/2012:22:27:30 +0200] cupsdAcceptClient: 24 from localhost (Domain) >D [11/Apr/2012:22:27:30 +0200] [Job 8] Resolving "Officejet 4500 G510g-m [697EF2]._pdl-datastream._tcp.local"... >D [11/Apr/2012:22:27:30 +0200] [Job 8] STATE: +connecting-to-device >D [11/Apr/2012:22:27:30 +0200] [Job 8] Resolving "Officejet 4500 G510g-m [697EF2]", regtype="_pdl-datastream._tcp", domain="local."... >D [11/Apr/2012:22:27:30 +0200] cupsdMarkDirty(-----S) >D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Printing jobs and dirty files" >D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 24 POST / HTTP/1.1 >D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [11/Apr/2012:22:27:30 +0200] cupsdAuthorize: No authentication data provided. >D [11/Apr/2012:22:27:30 +0200] cupsdAcceptClient: skipping getpeercon() >D [11/Apr/2012:22:27:30 +0200] cupsdAcceptClient: 25 from localhost (Domain) >D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 25 POST / HTTP/1.1 >D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >D [11/Apr/2012:22:27:30 +0200] cupsdAuthorize: No authentication data provided. >D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 24 1.1 Get-Job-Attributes 1 >D [11/Apr/2012:22:27:30 +0200] Get-Job-Attributes ipp://localhost/jobs/8 >D [11/Apr/2012:22:27:30 +0200] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/8) from localhost >D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 25 1.1 Get-Job-Attributes 1 >D [11/Apr/2012:22:27:30 +0200] Get-Job-Attributes ipp://localhost/jobs/8 >D [11/Apr/2012:22:27:30 +0200] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/8) from localhost >D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >D [11/Apr/2012:22:27:30 +0200] cupsdAcceptClient: skipping getpeercon() >D [11/Apr/2012:22:27:30 +0200] cupsdAcceptClient: 26 from localhost (Domain) >D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 26 POST / HTTP/1.1 >D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >D [11/Apr/2012:22:27:30 +0200] cupsdAuthorize: No authentication data provided. >D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 26 1.1 Get-Job-Attributes 1 >D [11/Apr/2012:22:27:30 +0200] Get-Job-Attributes ipp://localhost/jobs/8 >D [11/Apr/2012:22:27:30 +0200] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/8) from localhost >D [11/Apr/2012:22:27:30 +0200] cupsdAcceptClient: skipping getpeercon() >D [11/Apr/2012:22:27:30 +0200] cupsdAcceptClient: 27 from localhost (Domain) >D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 27 POST / HTTP/1.1 >D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >D [11/Apr/2012:22:27:30 +0200] cupsdAuthorize: No authentication data provided. >D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files" >D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 27 1.1 Get-Job-Attributes 1 >D [11/Apr/2012:22:27:30 +0200] Get-Job-Attributes ipp://localhost/jobs/8 >D [11/Apr/2012:22:27:30 +0200] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/8) from localhost >D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [11/Apr/2012:22:27:30 +0200] [Notifier] state=3 >D [11/Apr/2012:22:27:30 +0200] [Notifier] PrinterStateChanged >D [11/Apr/2012:22:27:30 +0200] [Job 8] STATE: -marker-supply-low-warning >D [11/Apr/2012:22:27:30 +0200] cupsdAcceptClient: skipping getpeercon() >D [11/Apr/2012:22:27:30 +0200] cupsdAcceptClient: 28 from localhost (Domain) >D [11/Apr/2012:22:27:30 +0200] [Job 8] load_banner(filename="/var/spool/cups/d00008-001") >D [11/Apr/2012:22:27:30 +0200] [Job 8] 1 #CUPS-BANNER >D [11/Apr/2012:22:27:30 +0200] [Job 8] 2 Show printer-name printer-info printer-location printer-make-and-model printer-driver-name printer-driver-version paper-size imageable-area >D [11/Apr/2012:22:27:30 +0200] [Job 8] 3 Header Printer Test Page >D [11/Apr/2012:22:27:30 +0200] [Job 8] 4 Footer Printer Test Page >D [11/Apr/2012:22:27:30 +0200] [Job 8] 5 Notice CUPS 1.5.2. >D [11/Apr/2012:22:27:30 +0200] [Job 8] 6 Image images/cups.png >D [11/Apr/2012:22:27:30 +0200] [Job 8] 7 Image images/color-wheel.png >D [11/Apr/2012:22:27:30 +0200] [Job 8] Page = 611x852; 0,0 to 611,852 >D [11/Apr/2012:22:27:30 +0200] [Job 8] Page = 611x852; 0,0 to 611,852 >D [11/Apr/2012:22:27:30 +0200] [Job 8] slow_collate=0, slow_duplex=0, slow_order=0 >D [11/Apr/2012:22:27:30 +0200] [Job 8] Before copy_comments - %!PS-Adobe-3.0 >D [11/Apr/2012:22:27:30 +0200] [Job 8] %!PS-Adobe-3.0 >D [11/Apr/2012:22:27:30 +0200] [Job 8] %%BoundingBox: 0 0 611 852 >D [11/Apr/2012:22:27:30 +0200] [Job 8] %cupsRotation: 0 >D [11/Apr/2012:22:27:30 +0200] [Job 8] %%Creator: bannertops/CUPS v1.5.2 >D [11/Apr/2012:22:27:30 +0200] [Job 8] %%CreationDate: Mi 11 Apr 2012 22:27:30 CEST >D [11/Apr/2012:22:27:30 +0200] [Job 8] %%LanguageLevel: 2 >D [11/Apr/2012:22:27:30 +0200] [Job 8] %%DocumentData: Clean7Bit >D [11/Apr/2012:22:27:30 +0200] [Job 8] %%Title: (Test Page) >D [11/Apr/2012:22:27:30 +0200] [Job 8] %%For: (carsten) >D [11/Apr/2012:22:27:30 +0200] [Job 8] %%Pages: 1 >D [11/Apr/2012:22:27:30 +0200] [Job 8] %%DocumentSuppliedResources: font Monospace >D [11/Apr/2012:22:27:30 +0200] [Job 8] %%+ font Monospace-Bold >D [11/Apr/2012:22:27:30 +0200] [Job 8] %%+ font Monospace-BoldOblique >D [11/Apr/2012:22:27:30 +0200] [Job 8] %%+ font Monospace-Oblique >D [11/Apr/2012:22:27:30 +0200] [Job 8] %%EndComments >D [11/Apr/2012:22:27:30 +0200] [Job 8] Before copy_prolog - %%BeginProlog >D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 28 POST / HTTP/1.1 >D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [11/Apr/2012:22:27:30 +0200] cupsdAuthorize: No authentication data provided. >D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 28 1.1 CUPS-Get-Printers 1 >D [11/Apr/2012:22:27:30 +0200] CUPS-Get-Printers >D [11/Apr/2012:22:27:30 +0200] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost >D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 28 POST / HTTP/1.1 >D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [11/Apr/2012:22:27:30 +0200] cupsdAuthorize: No authentication data provided. >D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 28 1.1 CUPS-Get-Default 1 >D [11/Apr/2012:22:27:30 +0200] CUPS-Get-Default >D [11/Apr/2012:22:27:30 +0200] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost >D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [11/Apr/2012:22:27:30 +0200] [Job 8] PNG image: 128x128x8, color_type=6 (RGB+ALPHA) >D [11/Apr/2012:22:27:30 +0200] [Job 8] PNG image: 192x128x8, color_type=2 (RGB) >D [11/Apr/2012:22:27:30 +0200] [Job 8] Before copy_setup - %%Page: coverpage 1 >D [11/Apr/2012:22:27:30 +0200] [Job 8] Before page loop - %%Page: coverpage 1 >D [11/Apr/2012:22:27:30 +0200] [Job 8] Copying page 1... >D [11/Apr/2012:22:27:30 +0200] [Job 8] pagew = 611.0, pagel = 852.0 >D [11/Apr/2012:22:27:30 +0200] [Job 8] bboxx = 0, bboxy = 0, bboxw = 610, bboxl = 852 >D [11/Apr/2012:22:27:30 +0200] [Job 8] PageLeft = 0.0, PageRight = 611.0 >D [11/Apr/2012:22:27:30 +0200] [Job 8] PageTop = 852.0, PageBottom = 0.0 >D [11/Apr/2012:22:27:30 +0200] [Job 8] PageWidth = 611.0, PageLength = 852.0 >D [11/Apr/2012:22:27:30 +0200] PID 13505 (/usr/lib/cups/filter/bannertops) exited with no errors. >D [11/Apr/2012:22:27:30 +0200] [Job 8] Wrote 1 pages... >D [11/Apr/2012:22:27:30 +0200] PID 13506 (/usr/lib/cups/filter/pstops) exited with no errors. >D [11/Apr/2012:22:27:30 +0200] [Job 8] PPD uses qualifier 'RGB.Plain.' >D [11/Apr/2012:22:27:30 +0200] [Job 8] Calling FindDeviceById(Officejet-4500-G510g-m) >D [11/Apr/2012:22:27:30 +0200] [Job 8] Failed to send: org.freedesktop.ColorManager.Failed:device id 'Officejet-4500-G510g-m' does not exists >D [11/Apr/2012:22:27:30 +0200] [Job 8] Failed to get profile filename! >I [11/Apr/2012:22:27:30 +0200] [Job 8] no profiles specified in PPD >D [11/Apr/2012:22:27:30 +0200] [Job 8] Set job-printer-state-message to "no profiles specified in PPD", current level=INFO >D [11/Apr/2012:22:27:30 +0200] cupsdMarkDirty(-----S) >D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" >D [11/Apr/2012:22:27:30 +0200] cupsdMarkDirty(-----S) >D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" >D [11/Apr/2012:22:27:30 +0200] [Job 8] Ghostscript command line: /usr/bin/gs -dQUIET -dPARANOIDSAFER -dNOPAUSE -dBATCH -dNOINTERPOLATE -dNOMEDIAATTRS -sDEVICE=cups -sstdout=%stderr -sOutputFile=%stdout -I/usr/share/cups/fonts -c -f -_ >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[0]="CUPS_CACHEDIR=/var/cache/cups" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[1]="CUPS_DATADIR=/usr/share/cups" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[2]="CUPS_DOCROOT=/usr/share/cups/www" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[4]="CUPS_REQUESTROOT=/var/spool/cups" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[5]="CUPS_SERVERBIN=/usr/lib/cups" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[6]="CUPS_SERVERROOT=/etc/cups" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[7]="CUPS_STATEDIR=/var/run/cups" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[8]="HOME=/var/spool/cups/tmp" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[9]="PATH=/usr/lib/cups/filter:/usr/lib64/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[10]="SERVER_ADMIN=root@m7" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[11]="SOFTWARE=CUPS/1.5.2" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[12]="TMPDIR=/var/spool/cups/tmp" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[13]="USER=root" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[14]="CUPS_SERVER=/var/run/cups/cups.sock" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[15]="CUPS_ENCRYPTION=IfRequested" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[16]="IPP_PORT=631" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[17]="CHARSET=utf-8" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[18]="LANG=de_DE.UTF-8" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[19]="PPD=/etc/cups/ppd/Officejet-4500-G510g-m.ppd" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[20]="RIP_MAX_CACHE=128m" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[21]="CONTENT_TYPE=application/vnd.cups-banner" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[22]="DEVICE_URI=dnssd://Officejet%204500%20G510g-m%20%5B697EF2%5D._pdl-datastream._tcp.local/" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[23]="PRINTER_INFO=Officejet 4500 G510g-m [697EF2]" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[24]="PRINTER_LOCATION=" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[25]="PRINTER=Officejet-4500-G510g-m" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[26]="PRINTER_STATE_REASONS=none" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[27]="CUPS_FILETYPE=document" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[28]="FINAL_CONTENT_TYPE=printer/Officejet-4500-G510g-m" >D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[29]="AUTH_INFO_REQUIRED=none" >D [11/Apr/2012:22:27:30 +0200] [Notifier] state=3 >D [11/Apr/2012:22:27:30 +0200] [Notifier] PrinterStateChanged >D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 28 POST / HTTP/1.1 >D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [11/Apr/2012:22:27:30 +0200] cupsdAuthorize: No authentication data provided. >D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 28 1.1 CUPS-Get-Printers 1 >D [11/Apr/2012:22:27:30 +0200] CUPS-Get-Printers >D [11/Apr/2012:22:27:30 +0200] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost >D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 28 POST / HTTP/1.1 >D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [11/Apr/2012:22:27:30 +0200] cupsdAuthorize: No authentication data provided. >D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 28 1.1 CUPS-Get-Default 1 >D [11/Apr/2012:22:27:30 +0200] CUPS-Get-Default >D [11/Apr/2012:22:27:30 +0200] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost >D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >I [11/Apr/2012:22:27:30 +0200] [Job 8] Start rendering... >D [11/Apr/2012:22:27:30 +0200] [Job 8] Set job-printer-state-message to "Start rendering...", current level=INFO >I [11/Apr/2012:22:27:30 +0200] [Job 8] Processing page 1... >D [11/Apr/2012:22:27:30 +0200] [Job 8] Set job-printer-state-message to "Processing page 1...", current level=INFO >D [11/Apr/2012:22:27:30 +0200] cupsdMarkDirty(-----S) >D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" >D [11/Apr/2012:22:27:30 +0200] cupsdMarkDirty(-----S) >D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" >D [11/Apr/2012:22:27:30 +0200] [Notifier] state=3 >D [11/Apr/2012:22:27:30 +0200] [Notifier] PrinterStateChanged >D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 28 POST / HTTP/1.1 >D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [11/Apr/2012:22:27:30 +0200] cupsdAuthorize: No authentication data provided. >D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 28 1.1 CUPS-Get-Printers 1 >D [11/Apr/2012:22:27:30 +0200] CUPS-Get-Printers >D [11/Apr/2012:22:27:30 +0200] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost >D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 28 POST / HTTP/1.1 >D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [11/Apr/2012:22:27:30 +0200] cupsdAuthorize: No authentication data provided. >D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 28 1.1 CUPS-Get-Default 1 >D [11/Apr/2012:22:27:30 +0200] CUPS-Get-Default >D [11/Apr/2012:22:27:30 +0200] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost >D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [11/Apr/2012:22:27:31 +0200] cupsdAcceptClient: skipping getpeercon() >D [11/Apr/2012:22:27:31 +0200] cupsdAcceptClient: 29 from localhost (Domain) >D [11/Apr/2012:22:27:31 +0200] cupsdReadClient: 29 POST / HTTP/1.1 >D [11/Apr/2012:22:27:31 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [11/Apr/2012:22:27:31 +0200] cupsdAuthorize: No authentication data provided. >D [11/Apr/2012:22:27:31 +0200] cupsdReadClient: 29 1.1 Get-Notifications 1 >D [11/Apr/2012:22:27:31 +0200] Get-Notifications / >D [11/Apr/2012:22:27:31 +0200] cupsdIsAuthorized: requesting-user-name="carsten" >D [11/Apr/2012:22:27:31 +0200] Returning IPP successful-ok for Get-Notifications (/) from localhost >D [11/Apr/2012:22:27:31 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [11/Apr/2012:22:27:31 +0200] cupsdAcceptClient: skipping getpeercon() >D [11/Apr/2012:22:27:31 +0200] cupsdAcceptClient: 30 from localhost (Domain) >D [11/Apr/2012:22:27:31 +0200] cupsdReadClient: 19 WAITING Closing on EOF >D [11/Apr/2012:22:27:31 +0200] cupsdCloseClient: 19 >D [11/Apr/2012:22:27:31 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" >D [11/Apr/2012:22:27:31 +0200] cupsdReadClient: 29 WAITING Closing on EOF >D [11/Apr/2012:22:27:31 +0200] cupsdCloseClient: 29 >D [11/Apr/2012:22:27:31 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" >D [11/Apr/2012:22:27:31 +0200] cupsdReadClient: 18 POST / HTTP/1.1 >D [11/Apr/2012:22:27:31 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [11/Apr/2012:22:27:31 +0200] cupsdAuthorize: No authentication data provided. >D [11/Apr/2012:22:27:31 +0200] cupsdReadClient: 18 1.1 Get-Notifications 1 >D [11/Apr/2012:22:27:31 +0200] Get-Notifications / >D [11/Apr/2012:22:27:31 +0200] cupsdIsAuthorized: requesting-user-name="carsten" >D [11/Apr/2012:22:27:31 +0200] Returning IPP successful-ok for Get-Notifications (/) from localhost >D [11/Apr/2012:22:27:31 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [11/Apr/2012:22:27:31 +0200] cupsdAcceptClient: skipping getpeercon() >D [11/Apr/2012:22:27:31 +0200] cupsdAcceptClient: 19 from localhost (Domain) >D [11/Apr/2012:22:27:31 +0200] cupsdReadClient: 19 POST / HTTP/1.1 >D [11/Apr/2012:22:27:31 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [11/Apr/2012:22:27:31 +0200] cupsdAuthorize: No authentication data provided. >D [11/Apr/2012:22:27:31 +0200] cupsdReadClient: 19 1.1 CUPS-Get-Printers 1 >D [11/Apr/2012:22:27:31 +0200] CUPS-Get-Printers >D [11/Apr/2012:22:27:31 +0200] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost >D [11/Apr/2012:22:27:31 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [11/Apr/2012:22:27:31 +0200] cupsdReadClient: 19 POST / HTTP/1.1 >D [11/Apr/2012:22:27:31 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [11/Apr/2012:22:27:31 +0200] cupsdAuthorize: No authentication data provided. >D [11/Apr/2012:22:27:31 +0200] cupsdReadClient: 19 1.1 CUPS-Get-Classes 1 >D [11/Apr/2012:22:27:31 +0200] CUPS-Get-Classes >D [11/Apr/2012:22:27:31 +0200] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost >D [11/Apr/2012:22:27:31 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [11/Apr/2012:22:27:31 +0200] cupsdReadClient: 19 POST / HTTP/1.1 >D [11/Apr/2012:22:27:31 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files" >D [11/Apr/2012:22:27:31 +0200] cupsdAuthorize: No authentication data provided. >D [11/Apr/2012:22:27:31 +0200] cupsdReadClient: 19 1.1 CUPS-Get-Default 1 >D [11/Apr/2012:22:27:31 +0200] CUPS-Get-Default >D [11/Apr/2012:22:27:31 +0200] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost >D [11/Apr/2012:22:27:31 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files" >D [11/Apr/2012:22:27:31 +0200] [Job 8] PAGE: 1 1 >D [11/Apr/2012:22:27:31 +0200] cupsdMarkDirty(-----S) >D [11/Apr/2012:22:27:31 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files" >D [11/Apr/2012:22:27:35 +0200] [Job 8] Unable to resolve URI >D [11/Apr/2012:22:27:35 +0200] [Job 8] STATE: -connecting-to-device,offline-report >D [11/Apr/2012:22:27:35 +0200] cupsdMarkDirty(-----S) >D [11/Apr/2012:22:27:35 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Dirty files" >D [11/Apr/2012:22:27:35 +0200] [Notifier] state=3 >D [11/Apr/2012:22:27:35 +0200] [Notifier] PrinterStateChanged >E [11/Apr/2012:22:27:35 +0200] [Job 8] Unable to find printer. >D [11/Apr/2012:22:27:35 +0200] [Job 8] Set job-printer-state-message to "Unable to find printer.", current level=ERROR >I [11/Apr/2012:22:27:35 +0200] [Job 8] Unable to locate printer. >D [11/Apr/2012:22:27:35 +0200] cupsdMarkDirty(-----S) >D [11/Apr/2012:22:27:35 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [11/Apr/2012:22:27:35 +0200] cupsdMarkDirty(-----S) >D [11/Apr/2012:22:27:35 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [11/Apr/2012:22:27:35 +0200] cupsdReadClient: 28 POST / HTTP/1.1 >D [11/Apr/2012:22:27:35 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [11/Apr/2012:22:27:35 +0200] cupsdAuthorize: No authentication data provided. >D [11/Apr/2012:22:27:35 +0200] cupsdReadClient: 28 1.1 CUPS-Get-Printers 1 >D [11/Apr/2012:22:27:35 +0200] CUPS-Get-Printers >D [11/Apr/2012:22:27:35 +0200] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost >D [11/Apr/2012:22:27:35 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [11/Apr/2012:22:27:35 +0200] [Notifier] state=3 >D [11/Apr/2012:22:27:35 +0200] [Notifier] PrinterStateChanged >D [11/Apr/2012:22:27:35 +0200] cupsdReadClient: 28 POST / HTTP/1.1 >D [11/Apr/2012:22:27:35 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [11/Apr/2012:22:27:35 +0200] cupsdAuthorize: No authentication data provided. >D [11/Apr/2012:22:27:35 +0200] cupsdReadClient: 28 1.1 CUPS-Get-Default 1 >D [11/Apr/2012:22:27:35 +0200] CUPS-Get-Default >D [11/Apr/2012:22:27:35 +0200] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost >D [11/Apr/2012:22:27:35 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [11/Apr/2012:22:27:35 +0200] cupsdReadClient: 28 POST / HTTP/1.1 >D [11/Apr/2012:22:27:35 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [11/Apr/2012:22:27:35 +0200] cupsdAuthorize: No authentication data provided. >D [11/Apr/2012:22:27:35 +0200] cupsdReadClient: 28 1.1 CUPS-Get-Printers 1 >D [11/Apr/2012:22:27:35 +0200] CUPS-Get-Printers >D [11/Apr/2012:22:27:35 +0200] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost >D [11/Apr/2012:22:27:35 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [11/Apr/2012:22:27:35 +0200] cupsdReadClient: 28 POST / HTTP/1.1 >D [11/Apr/2012:22:27:35 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [11/Apr/2012:22:27:35 +0200] cupsdAuthorize: No authentication data provided. >D [11/Apr/2012:22:27:35 +0200] cupsdReadClient: 28 1.1 CUPS-Get-Default 1 >D [11/Apr/2012:22:27:35 +0200] CUPS-Get-Default >D [11/Apr/2012:22:27:35 +0200] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost >D [11/Apr/2012:22:27:35 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [11/Apr/2012:22:27:35 +0200] cupsdAcceptClient: skipping getpeercon() >D [11/Apr/2012:22:27:35 +0200] cupsdAcceptClient: 29 from localhost (Domain) >D [11/Apr/2012:22:27:35 +0200] cupsdReadClient: 29 POST / HTTP/1.1 >D [11/Apr/2012:22:27:35 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [11/Apr/2012:22:27:35 +0200] cupsdAuthorize: No authentication data provided. >D [11/Apr/2012:22:27:35 +0200] cupsdReadClient: 29 1.1 Get-Notifications 1 >D [11/Apr/2012:22:27:35 +0200] Get-Notifications / >D [11/Apr/2012:22:27:35 +0200] cupsdIsAuthorized: requesting-user-name="carsten" >D [11/Apr/2012:22:27:35 +0200] Returning IPP successful-ok for Get-Notifications (/) from localhost >D [11/Apr/2012:22:27:35 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [11/Apr/2012:22:27:35 +0200] cupsdReadClient: 29 WAITING Closing on EOF >D [11/Apr/2012:22:27:35 +0200] cupsdCloseClient: 29 >D [11/Apr/2012:22:27:35 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [11/Apr/2012:22:27:35 +0200] cupsdReadClient: 18 POST / HTTP/1.1 >D [11/Apr/2012:22:27:35 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [11/Apr/2012:22:27:35 +0200] cupsdAuthorize: No authentication data provided. >D [11/Apr/2012:22:27:35 +0200] cupsdReadClient: 18 1.1 Get-Notifications 1 >D [11/Apr/2012:22:27:35 +0200] Get-Notifications / >D [11/Apr/2012:22:27:35 +0200] cupsdIsAuthorized: requesting-user-name="carsten" >D [11/Apr/2012:22:27:35 +0200] Returning IPP successful-ok for Get-Notifications (/) from localhost >D [11/Apr/2012:22:27:35 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [11/Apr/2012:22:27:36 +0200] cupsdReadClient: 19 POST / HTTP/1.1 >D [11/Apr/2012:22:27:36 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [11/Apr/2012:22:27:36 +0200] cupsdAuthorize: No authentication data provided. >D [11/Apr/2012:22:27:36 +0200] cupsdReadClient: 19 1.1 CUPS-Get-Printers 1 >D [11/Apr/2012:22:27:36 +0200] CUPS-Get-Printers >D [11/Apr/2012:22:27:36 +0200] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost >D [11/Apr/2012:22:27:36 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [11/Apr/2012:22:27:36 +0200] cupsdReadClient: 19 POST / HTTP/1.1 >D [11/Apr/2012:22:27:36 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [11/Apr/2012:22:27:36 +0200] cupsdAuthorize: No authentication data provided. >D [11/Apr/2012:22:27:36 +0200] cupsdReadClient: 19 1.1 CUPS-Get-Classes 1 >D [11/Apr/2012:22:27:36 +0200] CUPS-Get-Classes >D [11/Apr/2012:22:27:36 +0200] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost >D [11/Apr/2012:22:27:36 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [11/Apr/2012:22:27:36 +0200] cupsdReadClient: 19 POST / HTTP/1.1 >D [11/Apr/2012:22:27:36 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [11/Apr/2012:22:27:36 +0200] cupsdAuthorize: No authentication data provided. >D [11/Apr/2012:22:27:36 +0200] cupsdReadClient: 19 1.1 CUPS-Get-Default 1 >D [11/Apr/2012:22:27:36 +0200] CUPS-Get-Default >D [11/Apr/2012:22:27:36 +0200] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost >D [11/Apr/2012:22:27:36 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [11/Apr/2012:22:27:41 +0200] cupsdReadClient: 18 POST / HTTP/1.1 >D [11/Apr/2012:22:27:41 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [11/Apr/2012:22:27:41 +0200] cupsdAuthorize: No authentication data provided. >D [11/Apr/2012:22:27:41 +0200] cupsdReadClient: 18 1.1 Get-Job-Attributes 1 >D [11/Apr/2012:22:27:41 +0200] Get-Job-Attributes ipp://localhost/jobs/8 >D [11/Apr/2012:22:27:41 +0200] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/8) from localhost >D [11/Apr/2012:22:27:41 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [11/Apr/2012:22:27:41 +0200] cupsdReadClient: 18 POST / HTTP/1.1 >D [11/Apr/2012:22:27:41 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [11/Apr/2012:22:27:41 +0200] cupsdAuthorize: No authentication data provided. >D [11/Apr/2012:22:27:41 +0200] cupsdReadClient: 18 1.1 Cancel-Subscription 1 >D [11/Apr/2012:22:27:41 +0200] Cancel-Subscription / >D [11/Apr/2012:22:27:41 +0200] cupsdIsAuthorized: requesting-user-name="carsten" >D [11/Apr/2012:22:27:41 +0200] cupsdMarkDirty(-----S) >D [11/Apr/2012:22:27:41 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files" >D [11/Apr/2012:22:27:41 +0200] Returning IPP successful-ok for Cancel-Subscription (/) from localhost >D [11/Apr/2012:22:27:41 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [11/Apr/2012:22:27:41 +0200] cupsdReadClient: 16 PUT /admin/conf/cupsd.conf HTTP/1.1 >D [11/Apr/2012:22:27:41 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files" >D [11/Apr/2012:22:27:41 +0200] cupsdAuthorize: Authorized as root using PeerCred >D [11/Apr/2012:22:27:41 +0200] cupsdIsAuthorized: username="root" >I [11/Apr/2012:22:27:41 +0200] Installing config file "/etc/cups/cupsd.conf"... >D [11/Apr/2012:22:27:41 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files" >D [11/Apr/2012:22:27:41 +0200] cupsdCloseClient: 16 >D [11/Apr/2012:22:27:41 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [11/Apr/2012:22:27:41 +0200] cupsdCloseClient: 18 >D [11/Apr/2012:22:27:41 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [11/Apr/2012:22:27:41 +0200] cupsdCloseClient: 24 >D [11/Apr/2012:22:27:41 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [11/Apr/2012:22:27:41 +0200] cupsdCloseClient: 25 >D [11/Apr/2012:22:27:41 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [11/Apr/2012:22:27:41 +0200] cupsdCloseClient: 26 >D [11/Apr/2012:22:27:41 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [11/Apr/2012:22:27:41 +0200] cupsdCloseClient: 27 >D [11/Apr/2012:22:27:41 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [11/Apr/2012:22:27:41 +0200] cupsdCloseClient: 28 >D [11/Apr/2012:22:27:41 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [11/Apr/2012:22:27:41 +0200] cupsdCloseClient: 30 >D [11/Apr/2012:22:27:41 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [11/Apr/2012:22:27:41 +0200] cupsdCloseClient: 19 >D [11/Apr/2012:22:27:41 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" >D [11/Apr/2012:22:27:41 +0200] cupsdDeregisterPrinter(p=0x7f074fa1bfe0(Officejet-4500-G510g-m), removeit=1) >I [11/Apr/2012:22:27:41 +0200] Generating printcap /etc/printcap... >I [11/Apr/2012:22:27:41 +0200] Saving job.cache... >I [11/Apr/2012:22:27:41 +0200] Saving subscriptions.conf... >D [11/Apr/2012:22:27:41 +0200] cupsdSetBusyState: newbusy="Printing jobs", busy="Printing jobs and dirty files" >W [11/Apr/2012:22:27:42 +0200] failed to CreateProfile: org.freedesktop.ColorManager.AlreadyExists:profile id 'Officejet-4500-G510g-m-Gray..' already exists >W [11/Apr/2012:22:27:42 +0200] failed to CreateProfile: org.freedesktop.ColorManager.AlreadyExists:profile id 'Officejet-4500-G510g-m-RGB..' already exists >W [11/Apr/2012:22:27:42 +0200] failed to CreateDevice: org.freedesktop.ColorManager.AlreadyExists:device id 'cups-Officejet-4500-G510g-m' already exists > >Page 1 (Scheduler not running?): >{'cups_connection_failure': False} >Page 2 (Is local server publishing?): >{'local_server_exporting_printers': False} >Page 3 (Choose printer): >{'cups_dest': <cups.Dest Officejet-4500-G510g-m (default)>, > 'cups_instance': None, > 'cups_queue': 'Officejet-4500-G510g-m', > 'cups_queue_listed': True} >Page 4 (Check printer sanity): >{'cups_device_uri_scheme': u'dnssd', > 'cups_printer_dict': {'device-uri': u'dnssd://Officejet%204500%20G510g-m%20%5B697EF2%5D._pdl-datastream._tcp.local/', > 'printer-info': u'Officejet 4500 G510g-m [697EF2]', > 'printer-is-shared': True, > 'printer-location': u'', > 'printer-make-and-model': u'HP Officejet 4500 g510g-m, hpcups 3.12.2', > 'printer-state': 3, > 'printer-state-message': u'', > 'printer-state-reasons': [u'none'], > 'printer-type': 167948, > 'printer-uri-supported': u'ipp://localhost:631/printers/Officejet-4500-G510g-m'}, > 'cups_printer_remote': False, > 'is_cups_class': False, > 'local_cups_queue_attributes': {'PageSize-default': u'A4.FB', > 'auth-info-required': u'none', > 'charset-configured': u'utf-8', > 'charset-supported': [u'us-ascii', u'utf-8'], > 'color-supported': True, > 'compression-supported': [u'none', u'gzip'], > 'copies-default': 1, > 'copies-supported': (1, 9999), > 'cups-version': u'1.5.2', > 'device-uri': u'dnssd://Officejet%204500%20G510g-m%20%5B697EF2%5D._pdl-datastream._tcp.local/', > 'document-format-default': u'application/octet-stream', > 'document-format-supported': [u'application/octet-stream', > u'application/pdf', > u'application/postscript', > u'application/vnd.cups-banner', > u'application/vnd.cups-pdf', > u'application/vnd.cups-postscript', > u'application/vnd.cups-raster', > u'application/vnd.cups-raw', > u'application/x-cshell', > u'application/x-csource', > u'application/x-perl', > u'application/x-shell', > u'image/gif', > u'image/jpeg', > u'image/png', > u'image/tiff', > u'image/x-bitmap', > u'image/x-photocd', > u'image/x-portable-anymap', > u'image/x-portable-bitmap', > u'image/x-portable-graymap', > u'image/x-portable-pixmap', > u'image/x-sgi-rgb', > u'image/x-sun-raster', > u'image/x-xbitmap', > u'image/x-xpixmap', > u'text/css', > u'text/html', > u'text/plain'], > 'finishings-default': 3, > 'finishings-supported': [3], > 'generated-natural-language-supported': [u'de-de'], > 'ipp-versions-supported': [u'1.0', > u'1.1', > u'2.0', > u'2.1'], > 'ippget-event-life': 15, > 'job-creation-attributes-supported': [u'copies', > u'finishings', > u'ipp-attribute-fidelity', > u'job-hold-until', > u'job-name', > u'job-priority', > u'job-sheets', > u'media', > u'media-col', > u'multiple-document-handling', > u'number-up', > u'output-bin', > u'output-mode', > u'orientation-requested', > u'page-ranges', > u'print-quality', > u'printer-resolution', > u'sides'], > 'job-hold-until-default': u'no-hold', > 'job-hold-until-supported': [u'no-hold', > u'indefinite', > u'day-time', > u'evening', > u'night', > u'second-shift', > u'third-shift', > u'weekend'], > 'job-ids-supported': True, > 'job-k-limit': 0, > 'job-k-octets-supported': (0, 20907056), > 'job-page-limit': 0, > 'job-priority-default': 50, > 'job-priority-supported': [100], > 'job-quota-period': 0, > 'job-settable-attributes-supported': [u'copies', > u'finishings', > u'job-hold-until', > u'job-name', > u'job-priority', > u'media', > u'media-col', > u'multiple-document-handling', > u'number-up', > u'output-bin', > u'output-mode', > u'orientation-requested', > u'page-ranges', > u'print-quality', > u'printer-resolution', > u'sides'], > 'job-sheets-default': (u'none', u'none'), > 'job-sheets-supported': [u'none', > u'classified', > u'confidential', > u'secret', > u'standard', > u'topsecret', > u'unclassified'], > 'jpeg-k-octets-supported': (0, 20907056), > 'jpeg-x-dimension-supported': (0, 65535), > 'jpeg-y-dimension-supported': (1, 65535), > 'marker-change-time': 1334075092, > 'marker-colors': [u'none', > u'none', > u'none', > u'none', > u'none', > u'none', > u'none', > u'none'], > 'marker-levels': [-1, > -1, > -1, > -1, > -1, > -1, > -1, > -1], > 'marker-names': [u'black ink cartridge', > u'tri-color ink cartridge', > u'black ink cartridge', > u'black ink cartridge', > u'tri-color ink cartridge', > u'black ink cartridge', > u'black ink cartridge', > u'black ink cartridge'], > 'marker-types': [u'ink', > u'ink', > u'ink', > u'other', > u'ink', > u'ink', > u'ink', > u'ink'], > 'media-bottom-margin-supported': [317, > 0, > 1430], > 'media-col-supported': [u'media-bottom-margin', > u'media-left-margin', > u'media-right-margin', > u'media-size', > u'media-source', > u'media-top-margin', > u'media-type'], > 'media-default': u'iso_a4_210x297mm', > 'media-left-margin-supported': [317, 0], > 'media-right-margin-supported': [317, 0], > 'media-source-supported': [u'auto', u'main'], > 'media-supported': [u'oe_card3x5_3x5in', > u'oe_card4x6_4.25x6.25in', > u'oe_photo-l_3.5x5in', > u'om_photo-l-fb_93.39x130.65mm', > u'oe_photo4x6_4x6in', > u'om_photo4x6-fb_107.08x156.05mm', > u'iso_a6_105x148mm', > u'om_a6-fb_109.39x151.73mm', > u'om_hv_101.09x180.08mm', > u'om_hv-fb_106.57x183.74mm', > u'om_cabinet_119.88x165.1mm', > u'om_cabinet-fb_124.38x168.75mm', > u'oe_photo5x7_5x7in', > u'om_photo5x7-fb_131.51x181.45mm', > u'oe_card5x8_5x8in', > u'iso_a5_148x210mm', > u'om_a5-fb_153.56x213.71mm', > u'jis_b5_182x257mm', > u'om_b5-fb_181.5x253.59mm', > u'na_executive_7.25x10.5in', > u'na_govt-letter_8x10in', > u'om_8x10-fb_207.94x257.65mm', > u'na_letter_8.5x11in', > u'om_letter-fb_221.38x283.05mm', > u'iso_a4_210x297mm', > u'om_a4-fb_215.54x300.58mm', > u'na_legal_8.5x14in', > u'om_env-a2_110.99x146.05mm', > u'iso_c6_114x162mm', > u'na_monarch_3.875x7.5in', > u'iso_dl_110x220mm', > u'na_number-10_4.125x9.5in', > u'iso_c5_162x229mm', > u'om_env6_92.2x165.1mm', > u'om_env-card_111.12x152.4mm', > u'om_hagaki_100.07x148.08mm', > u'om_hagaki-fb_104.57x151.73mm', > u'om_oufuku_199.89x148.08mm', > u'om_jb5_182.11x257.04mm', > u'om_jb5-fb_187.6x260.7mm', > u'jpn_chou3_120x235mm', > u'jpn_chou4_90x205mm', > u'custom_min_3x4in', > u'custom_max_8.5x30in'], > 'media-top-margin-supported': [317, 0], > 'media-type-supported': [u'stationery', > u'photographic-glossy', > u'transparency'], > 'multiple-document-handling-supported': [u'separate-documents-uncollated-copies', > u'separate-documents-collated-copies'], > 'multiple-document-jobs-supported': True, > 'multiple-operation-time-out': 300, > 'natural-language-configured': u'de-de', > 'notify-attributes-supported': [u'printer-state-change-time', > u'notify-lease-expiration-time', > u'notify-subscriber-user-name'], > 'notify-events-default': [u'job-completed'], > 'notify-events-supported': [u'job-completed', > u'job-config-changed', > u'job-created', > u'job-progress', > u'job-state-changed', > u'job-stopped', > u'printer-added', > u'printer-changed', > u'printer-config-changed', > u'printer-deleted', > u'printer-finishings-changed', > u'printer-media-changed', > u'printer-modified', > u'printer-restarted', > u'printer-shutdown', > u'printer-state-changed', > u'printer-stopped', > u'server-audit', > u'server-restarted', > u'server-started', > u'server-stopped'], > 'notify-lease-duration-default': 86400, > 'notify-lease-duration-supported': (0, > 2147483647), > 'notify-max-events-supported': [100], > 'notify-pull-method-supported': [u'ippget'], > 'notify-schemes-supported': [u'dbus', > u'mailto', > u'rss'], > 'number-up-default': 1, > 'number-up-supported': [1, 2, 4, 6, 9, 16], > 'operations-supported': [2, > 4, > 5, > 6, > 8, > 9, > 10, > 11, > 12, > 13, > 14, > 16, > 17, > 18, > 19, > 20, > 21, > 22, > 23, > 24, > 25, > 26, > 27, > 28, > 34, > 35, > 37, > 38, > 56, > 57, > 59, > 16385, > 16386, > 16387, > 16388, > 16389, > 16390, > 16391, > 16392, > 16393, > 16394, > 16395, > 16396, > 16397, > 16398, > 16399, > 16423], > 'orientation-requested-default': None, > 'orientation-requested-supported': [3, > 4, > 5, > 6], > 'output-bin-default': u'face-down', > 'output-bin-supported': [u'face-down'], > 'output-mode-default': u'color', > 'output-mode-supported': [u'monochrome', > u'color'], > 'page-ranges-supported': True, > 'pages-per-minute': 1, > 'pages-per-minute-color': 1, > 'pdf-k-octets-supported': (0, 20907056), > 'pdf-versions-supported': [u'adobe-1.2', > u'adobe-1.3', > u'adobe-1.4', > u'adobe-1.5', > u'adobe-1.6', > u'adobe-1.7', > u'iso-19005-1_2005', > u'iso-32000-1_2008', > u'pwg-5102.3'], > 'pdl-override-supported': [u'attempted'], > 'port-monitor': u'none', > 'port-monitor-supported': [u'none'], > 'print-color-mode-default': u'color', > 'print-color-mode-supported': [u'monochrome', > u'color'], > 'print-quality-default': 4, > 'print-quality-supported': [4, 5], > 'printer-commands': u'none', > 'printer-current-time': '(IPP_TAG_DATE)', > 'printer-dns-sd-name': None, > 'printer-error-policy': u'stop-printer', > 'printer-error-policy-supported': [u'abort-job', > u'retry-current-job', > u'retry-job', > u'stop-printer'], > 'printer-icons': u'http://localhost:631/icons/Officejet-4500-G510g-m.png', > 'printer-info': u'Officejet 4500 G510g-m [697EF2]', > 'printer-is-accepting-jobs': True, > 'printer-is-shared': True, > 'printer-location': u'', > 'printer-make-and-model': u'HP Officejet 4500 g510g-m, hpcups 3.12.2', > 'printer-more-info': u'http://localhost:631/printers/Officejet-4500-G510g-m', > 'printer-name': u'Officejet-4500-G510g-m', > 'printer-op-policy': u'default', > 'printer-op-policy-supported': [u'authenticated', > u'default'], > 'printer-resolution-default': (300, 300, 3), > 'printer-resolution-supported': [(300, > 300, > 3)], > 'printer-settable-attributes-supported': [u'printer-info', > u'printer-location'], > 'printer-state': 3, > 'printer-state-change-time': 1334075092, > 'printer-state-message': u'', > 'printer-state-reasons': [u'none'], > 'printer-type': 167948, > 'printer-up-time': 1334176010, > 'printer-uri-supported': [u'ipp://localhost:631/printers/Officejet-4500-G510g-m'], > 'printer-uuid': u'urn:uuid:560700c9-06c6-3ec9-4eed-e0fad0ad0f1f', > 'queued-job-count': 0, > 'server-is-sharing-printers': False, > 'sides-default': u'one-sided', > 'sides-supported': [u'one-sided'], > 'uri-authentication-supported': [u'requesting-user-name'], > 'uri-security-supported': [u'none'], > 'which-jobs-supported': [u'completed', > u'not-completed', > u'aborted', > u'all', > u'canceled', > u'pending', > u'pending-held', > u'processing', > u'processing-stopped']}} >Page 5 (Check PPD sanity): >{'cups_printer_ppd_defaults': {u'General': {u'ColorModel': u'RGB', > u'InputSlot': u'Auto', > u'MediaType': u'Plain', > u'OutputMode': u'Normal', > u'PageRegion': u'A4', > u'PageSize': u'A4'}}, > 'cups_printer_ppd_valid': True, > 'missing_pkgs_and_exes': ([], [])} >Page 6 (Local or remote?): >{'printer_is_remote': False} >Page 7 (Verify packages): >{'packages_verification': {'cups': ['..?...... /etc/cups/cupsd.conf.default', > '.M....... c /etc/cups/subscriptions.conf', > '..?...... /usr/lib/cups/backend/dnssd', > '..?...... /usr/lib/cups/backend/ipp', > '..?...... /usr/lib/cups/backend/lpd', > '..?...... /usr/lib/cups/backend/serial', > 'missing /var/spool/cups/tmp (Permission denied)'], > 'foomatic': ['package foomatic is not installed'], > 'gutenprint': [], > 'hpijs': [], > 'hplip': ['..?...... /usr/lib/cups/backend/hpfax'], > 'system-config-printer': []}} >Page 8 (Error log checkpoint): >{'cups_server_settings': {'BrowseLocalProtocols': 'CUPS dnssd', > 'DefaultAuthType': 'Basic', > 'JobPrivateAccess': 'default', > 'JobPrivateValues': 'default', > 'MaxLogSize': '0', > 'SubscriptionPrivateAccess': 'default', > 'SubscriptionPrivateValues': 'default', > 'SystemGroup': 'sys root', > 'WebInterface': 'Yes', > '_debug_logging': '0', > '_remote_admin': '0', > '_remote_any': '0', > '_remote_printers': '1', > '_share_printers': '0', > '_user_cancel_any': '0'}, > 'error_log_checkpoint': 23196, > 'error_log_debug_logging_set': True} >Page 9 (Print test page): >{'test_page_attempted': '11/Apr/2012:22:27:30 +0000', > 'test_page_job_id': [8], > 'test_page_job_status': [(True, > 8, > 'Officejet-4500-G510g-m', > 'Test Page', > 'Ausf\xc3\xbchrung l\xc3\xa4uft', > {'PageSize': u'A4.FB', > 'attributes-charset': u'utf-8', > 'attributes-natural-language': u'de-de', > 'document-count': 1, > 'document-format': u'application/vnd.cups-banner', > 'job-hold-until': u'no-hold', > 'job-id': 8, > 'job-k-octets': 1, > 'job-media-progress': 0, > 'job-media-sheets-completed': 1, > 'job-more-info': u'http://localhost:631/jobs/8', > 'job-printer-state-message': u'Unable to find printer.', > 'job-printer-state-reasons': [u'none'], > 'job-printer-up-time': 1334176061, > 'job-printer-uri': u'ipp://localhost:631/printers/Officejet-4500-G510g-m', > 'job-priority': 50, > 'job-sheets': [u'none', u'none'], > 'job-state': 5, > 'job-state-reasons': u'job-printing', > 'job-uri': u'ipp://localhost:631/jobs/8', > 'job-uuid': u'urn:uuid:95de8fc5-dbbb-365a-5b88-5e23547a9de1', > 'printer-uri': u'ipp://localhost/printers/Officejet-4500-G510g-m', > 'time-at-completed': None, > 'time-at-creation': 1334176050, > 'time-at-processing': 1334176050})], > 'test_page_successful': False} >Page 10 (Error log fetch): >{'error_log': ['D [11/Apr/2012:22:27:25 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [11/Apr/2012:22:27:25 +0200] cupsdReadClient: 18 POST / HTTP/1.1', > 'D [11/Apr/2012:22:27:25 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [11/Apr/2012:22:27:25 +0200] cupsdAuthorize: No authentication data provided.', > 'D [11/Apr/2012:22:27:25 +0200] cupsdReadClient: 18 1.1 Get-Jobs 1', > 'D [11/Apr/2012:22:27:25 +0200] Get-Jobs ipp://localhost/printers/', > 'D [11/Apr/2012:22:27:25 +0200] Returning IPP successful-ok for Get-Jobs (ipp://localhost/printers/) from localhost', > 'D [11/Apr/2012:22:27:25 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [11/Apr/2012:22:27:25 +0200] cupsdReadClient: 18 POST / HTTP/1.1', > 'D [11/Apr/2012:22:27:25 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [11/Apr/2012:22:27:25 +0200] cupsdAuthorize: No authentication data provided.', > 'D [11/Apr/2012:22:27:25 +0200] cupsdReadClient: 18 1.1 Get-Jobs 1', > 'D [11/Apr/2012:22:27:25 +0200] Get-Jobs ipp://localhost/printers/', > 'D [11/Apr/2012:22:27:25 +0200] [Job 1] Loading attributes...', > 'D [11/Apr/2012:22:27:25 +0200] [Job 2] Loading attributes...', > 'D [11/Apr/2012:22:27:25 +0200] [Job 3] Loading attributes...', > 'D [11/Apr/2012:22:27:25 +0200] [Job 4] Loading attributes...', > 'D [11/Apr/2012:22:27:25 +0200] [Job 5] Loading attributes...', > 'D [11/Apr/2012:22:27:25 +0200] [Job 6] Loading attributes...', > 'D [11/Apr/2012:22:27:25 +0200] [Job 7] Loading attributes...', > 'D [11/Apr/2012:22:27:25 +0200] Returning IPP successful-ok for Get-Jobs (ipp://localhost/printers/) from localhost', > 'D [11/Apr/2012:22:27:25 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [11/Apr/2012:22:27:25 +0200] cupsdReadClient: 18 POST / HTTP/1.1', > 'D [11/Apr/2012:22:27:25 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [11/Apr/2012:22:27:25 +0200] cupsdAuthorize: No authentication data provided.', > 'D [11/Apr/2012:22:27:25 +0200] cupsdReadClient: 18 1.1 Create-Printer-Subscription 1', > 'D [11/Apr/2012:22:27:25 +0200] Create-Printer-Subscription /', > 'D [11/Apr/2012:22:27:25 +0200] cupsdCreateSubscription(con=0x7f074fa923e0(18), uri="/")', > 'D [11/Apr/2012:22:27:25 +0200] pullmethod="ippget"', > 'D [11/Apr/2012:22:27:25 +0200] notify-lease-duration=86400', > 'D [11/Apr/2012:22:27:25 +0200] notify-time-interval=0', > 'D [11/Apr/2012:22:27:25 +0200] cupsdAddSubscription(mask=17800, dest=(nil)(), job=(nil)(0), uri="(null)")', > 'D [11/Apr/2012:22:27:25 +0200] Added subscription #73 for server.', > 'D [11/Apr/2012:22:27:25 +0200] cupsdMarkDirty(-----S)', > 'D [11/Apr/2012:22:27:25 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"', > 'D [11/Apr/2012:22:27:25 +0200] Returning IPP successful-ok for Create-Printer-Subscription (/) from localhost', > 'D [11/Apr/2012:22:27:25 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [11/Apr/2012:22:27:26 +0200] cupsdAcceptClient: skipping getpeercon()', > 'D [11/Apr/2012:22:27:26 +0200] cupsdAcceptClient: 19 from localhost (Domain)', > 'D [11/Apr/2012:22:27:26 +0200] cupsdReadClient: 19 POST / HTTP/1.1', > 'D [11/Apr/2012:22:27:26 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [11/Apr/2012:22:27:26 +0200] cupsdAuthorize: No authentication data provided.', > 'D [11/Apr/2012:22:27:26 +0200] cupsdReadClient: 19 1.1 Get-Notifications 1', > 'D [11/Apr/2012:22:27:26 +0200] Get-Notifications /', > 'D [11/Apr/2012:22:27:26 +0200] cupsdIsAuthorized: requesting-user-name="carsten"', > 'D [11/Apr/2012:22:27:26 +0200] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [11/Apr/2012:22:27:26 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [11/Apr/2012:22:27:26 +0200] cupsdReadClient: 19 WAITING Closing on EOF', > 'D [11/Apr/2012:22:27:26 +0200] cupsdCloseClient: 19', > 'D [11/Apr/2012:22:27:26 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"', > 'D [11/Apr/2012:22:27:26 +0200] cupsdReadClient: 18 POST / HTTP/1.1', > 'D [11/Apr/2012:22:27:26 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [11/Apr/2012:22:27:26 +0200] cupsdAuthorize: No authentication data provided.', > 'D [11/Apr/2012:22:27:26 +0200] cupsdReadClient: 18 1.1 Get-Notifications 1', > 'D [11/Apr/2012:22:27:26 +0200] Get-Notifications /', > 'D [11/Apr/2012:22:27:26 +0200] cupsdIsAuthorized: requesting-user-name="carsten"', > 'D [11/Apr/2012:22:27:26 +0200] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [11/Apr/2012:22:27:26 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [11/Apr/2012:22:27:30 +0200] cupsdAcceptClient: skipping getpeercon()', > 'D [11/Apr/2012:22:27:30 +0200] cupsdAcceptClient: 19 from localhost (Domain)', > 'D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 19 POST /printers/Officejet-4500-G510g-m HTTP/1.1', > 'D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [11/Apr/2012:22:27:30 +0200] cupsdAuthorize: No authentication data provided.', > 'D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 19 1.1 Print-Job 1', > 'D [11/Apr/2012:22:27:30 +0200] Print-Job ipp://localhost/printers/Officejet-4500-G510g-m', > 'D [11/Apr/2012:22:27:30 +0200] [Job ???] Auto-typing file...', > 'I [11/Apr/2012:22:27:30 +0200] [Job ???] Request file type is application/vnd.cups-banner.', > 'D [11/Apr/2012:22:27:30 +0200] add_job: setting context of job to UNKNOWN SL', > 'D [11/Apr/2012:22:27:30 +0200] cupsdMarkDirty(----J-)', > 'D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"', > 'D [11/Apr/2012:22:27:30 +0200] add_job: requesting-user-name="carsten"', > 'D [11/Apr/2012:22:27:30 +0200] Adding default job-sheets values "none,none"...', > 'I [11/Apr/2012:22:27:30 +0200] [Job 8] Adding start banner page "none".', > 'D [11/Apr/2012:22:27:30 +0200] Notifier dbus started - PID = 13504', > 'D [11/Apr/2012:22:27:30 +0200] cupsdMarkDirty(-----S)', > 'D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"', > 'D [11/Apr/2012:22:27:30 +0200] cupsdMarkDirty(----J-)', > 'D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"', > 'I [11/Apr/2012:22:27:30 +0200] [Job 8] Adding end banner page "none".', > 'I [11/Apr/2012:22:27:30 +0200] [Job 8] File of type application/vnd.cups-banner queued by "carsten".', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] hold_until=0', > 'I [11/Apr/2012:22:27:30 +0200] [Job 8] Queued on "Officejet-4500-G510g-m" by "carsten".', > 'D [11/Apr/2012:22:27:30 +0200] cupsdMarkDirty(----J-)', > 'D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"', > 'D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"', > 'D [11/Apr/2012:22:27:30 +0200] cupsdMarkDirty(-----S)', > 'D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] job-sheets=none,none', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] argv[0]="Officejet-4500-G510g-m"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] argv[1]="8"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] argv[2]="carsten"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] argv[3]="Test Page"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] argv[4]="1"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] argv[5]="job-uuid=urn:uuid:95de8fc5-dbbb-365a-5b88-5e23547a9de1 PageSize=A4.FB job-originating-host-name=localhost time-at-creation=1334176050 time-at-processing=1334176050 AP_D_InputSlot="', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] argv[6]="/var/spool/cups/d00008-001"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[0]="CUPS_CACHEDIR=/var/cache/cups"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[1]="CUPS_DATADIR=/usr/share/cups"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[2]="CUPS_DOCROOT=/usr/share/cups/www"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[6]="CUPS_SERVERROOT=/etc/cups"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[7]="CUPS_STATEDIR=/var/run/cups"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[8]="HOME=/var/spool/cups/tmp"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[9]="PATH=/usr/lib/cups/filter:/usr/lib64/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[10]="SERVER_ADMIN=root@m7"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[11]="SOFTWARE=CUPS/1.5.2"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[12]="TMPDIR=/var/spool/cups/tmp"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[13]="USER=root"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[14]="CUPS_SERVER=/var/run/cups/cups.sock"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[15]="CUPS_ENCRYPTION=IfRequested"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[16]="IPP_PORT=631"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[17]="CHARSET=utf-8"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[18]="LANG=de_DE.UTF-8"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[19]="PPD=/etc/cups/ppd/Officejet-4500-G510g-m.ppd"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[20]="RIP_MAX_CACHE=128m"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[21]="CONTENT_TYPE=application/vnd.cups-banner"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[22]="DEVICE_URI=dnssd://Officejet%204500%20G510g-m%20%5B697EF2%5D._pdl-datastream._tcp.local/"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[23]="PRINTER_INFO=Officejet 4500 G510g-m [697EF2]"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[24]="PRINTER_LOCATION="', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[25]="PRINTER=Officejet-4500-G510g-m"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[26]="PRINTER_STATE_REASONS=none"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[27]="CUPS_FILETYPE=document"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[28]="FINAL_CONTENT_TYPE=printer/Officejet-4500-G510g-m"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[29]="AUTH_I****"', > 'I [11/Apr/2012:22:27:30 +0200] [Job 8] Started filter /usr/lib/cups/filter/bannertops (PID 13505)', > 'I [11/Apr/2012:22:27:30 +0200] [Job 8] Started filter /usr/lib/cups/filter/pstops (PID 13506)', > 'I [11/Apr/2012:22:27:30 +0200] [Job 8] Started filter /usr/lib/cups/filter/gstoraster (PID 13507)', > 'I [11/Apr/2012:22:27:30 +0200] [Job 8] Started filter /usr/lib/cups/filter/hpcups (PID 13508)', > 'I [11/Apr/2012:22:27:30 +0200] [Job 8] Started backend /usr/lib/cups/backend/dnssd (PID 13509)', > 'D [11/Apr/2012:22:27:30 +0200] cupsdMarkDirty(-----S)', > 'D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients and dirty files"', > 'D [11/Apr/2012:22:27:30 +0200] Returning IPP successful-ok for Print-Job (ipp://localhost/printers/Officejet-4500-G510g-m) from localhost', > 'D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [11/Apr/2012:22:27:30 +0200] [Notifier] state=3', > 'D [11/Apr/2012:22:27:30 +0200] [Notifier] Connected to D-BUS', > 'D [11/Apr/2012:22:27:30 +0200] [Notifier] JobCreated', > 'D [11/Apr/2012:22:27:30 +0200] [Notifier] state=3', > 'D [11/Apr/2012:22:27:30 +0200] [Notifier] PrinterStateChanged', > 'D [11/Apr/2012:22:27:30 +0200] [Notifier] state=3', > 'D [11/Apr/2012:22:27:30 +0200] [Notifier] JobState', > 'D [11/Apr/2012:22:27:30 +0200] cupsdAcceptClient: skipping getpeercon()', > 'D [11/Apr/2012:22:27:30 +0200] cupsdAcceptClient: 24 from localhost (Domain)', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] Resolving "Officejet 4500 G510g-m [697EF2]._pdl-datastream._tcp.local"...', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] STATE: +connecting-to-device', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] Resolving "Officejet 4500 G510g-m [697EF2]", regtype="_pdl-datastream._tcp", domain="local."...', > 'D [11/Apr/2012:22:27:30 +0200] cupsdMarkDirty(-----S)', > 'D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Printing jobs and dirty files"', > 'D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 24 POST / HTTP/1.1', > 'D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [11/Apr/2012:22:27:30 +0200] cupsdAuthorize: No authentication data provided.', > 'D [11/Apr/2012:22:27:30 +0200] cupsdAcceptClient: skipping getpeercon()', > 'D [11/Apr/2012:22:27:30 +0200] cupsdAcceptClient: 25 from localhost (Domain)', > 'D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 25 POST / HTTP/1.1', > 'D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"', > 'D [11/Apr/2012:22:27:30 +0200] cupsdAuthorize: No authentication data provided.', > 'D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 24 1.1 Get-Job-Attributes 1', > 'D [11/Apr/2012:22:27:30 +0200] Get-Job-Attributes ipp://localhost/jobs/8', > 'D [11/Apr/2012:22:27:30 +0200] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/8) from localhost', > 'D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 25 1.1 Get-Job-Attributes 1', > 'D [11/Apr/2012:22:27:30 +0200] Get-Job-Attributes ipp://localhost/jobs/8', > 'D [11/Apr/2012:22:27:30 +0200] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/8) from localhost', > 'D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"', > 'D [11/Apr/2012:22:27:30 +0200] cupsdAcceptClient: skipping getpeercon()', > 'D [11/Apr/2012:22:27:30 +0200] cupsdAcceptClient: 26 from localhost (Domain)', > 'D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 26 POST / HTTP/1.1', > 'D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"', > 'D [11/Apr/2012:22:27:30 +0200] cupsdAuthorize: No authentication data provided.', > 'D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"', > 'D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 26 1.1 Get-Job-Attributes 1', > 'D [11/Apr/2012:22:27:30 +0200] Get-Job-Attributes ipp://localhost/jobs/8', > 'D [11/Apr/2012:22:27:30 +0200] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/8) from localhost', > 'D [11/Apr/2012:22:27:30 +0200] cupsdAcceptClient: skipping getpeercon()', > 'D [11/Apr/2012:22:27:30 +0200] cupsdAcceptClient: 27 from localhost (Domain)', > 'D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 27 POST / HTTP/1.1', > 'D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"', > 'D [11/Apr/2012:22:27:30 +0200] cupsdAuthorize: No authentication data provided.', > 'D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"', > 'D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 27 1.1 Get-Job-Attributes 1', > 'D [11/Apr/2012:22:27:30 +0200] Get-Job-Attributes ipp://localhost/jobs/8', > 'D [11/Apr/2012:22:27:30 +0200] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/8) from localhost', > 'D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [11/Apr/2012:22:27:30 +0200] [Notifier] state=3', > 'D [11/Apr/2012:22:27:30 +0200] [Notifier] PrinterStateChanged', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] STATE: -marker-supply-low-warning', > 'D [11/Apr/2012:22:27:30 +0200] cupsdAcceptClient: skipping getpeercon()', > 'D [11/Apr/2012:22:27:30 +0200] cupsdAcceptClient: 28 from localhost (Domain)', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] load_banner(filename="/var/spool/cups/d00008-001")', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] 1 #CUPS-BANNER', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] 2 Show printer-name printer-info printer-location printer-make-and-model printer-driver-name printer-driver-version paper-size imageable-area', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] 3 Header Printer Test Page', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] 4 Footer Printer Test Page', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] 5 Notice CUPS 1.5.2.', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] 6 Image images/cups.png', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] 7 Image images/color-wheel.png', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] Page = 611x852; 0,0 to 611,852', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] Page = 611x852; 0,0 to 611,852', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] slow_collate=0, slow_duplex=0, slow_order=0', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] Before copy_comments - %!PS-Adobe-3.0', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] %!PS-Adobe-3.0', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] %%BoundingBox: 0 0 611 852', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] %cupsRotation: 0', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] %%Creator: bannertops/CUPS v1.5.2', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] %%CreationDate: Mi 11 Apr 2012 22:27:30 CEST', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] %%LanguageLevel: 2', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] %%DocumentData: Clean7Bit', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] %%Title: (Test Page)', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] %%For: (carsten)', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] %%Pages: 1', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] %%DocumentSuppliedResources: font Monospace', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] %%+ font Monospace-Bold', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] %%+ font Monospace-BoldOblique', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] %%+ font Monospace-Oblique', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] %%EndComments', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] Before copy_prolog - %%BeginProlog', > 'D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 28 POST / HTTP/1.1', > 'D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [11/Apr/2012:22:27:30 +0200] cupsdAuthorize: No authentication data provided.', > 'D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 28 1.1 CUPS-Get-Printers 1', > 'D [11/Apr/2012:22:27:30 +0200] CUPS-Get-Printers', > 'D [11/Apr/2012:22:27:30 +0200] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost', > 'D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 28 POST / HTTP/1.1', > 'D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [11/Apr/2012:22:27:30 +0200] cupsdAuthorize: No authentication data provided.', > 'D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 28 1.1 CUPS-Get-Default 1', > 'D [11/Apr/2012:22:27:30 +0200] CUPS-Get-Default', > 'D [11/Apr/2012:22:27:30 +0200] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost', > 'D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] PNG image: 128x128x8, color_type=6 (RGB+ALPHA)', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] PNG image: 192x128x8, color_type=2 (RGB)', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] Before copy_setup - %%Page: coverpage 1', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] Before page loop - %%Page: coverpage 1', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] Copying page 1...', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] pagew = 611.0, pagel = 852.0', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] bboxx = 0, bboxy = 0, bboxw = 610, bboxl = 852', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] PageLeft = 0.0, PageRight = 611.0', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] PageTop = 852.0, PageBottom = 0.0', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] PageWidth = 611.0, PageLength = 852.0', > 'D [11/Apr/2012:22:27:30 +0200] PID 13505 (/usr/lib/cups/filter/bannertops) exited with no errors.', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] Wrote 1 pages...', > 'D [11/Apr/2012:22:27:30 +0200] PID 13506 (/usr/lib/cups/filter/pstops) exited with no errors.', > "D [11/Apr/2012:22:27:30 +0200] [Job 8] PPD uses qualifier 'RGB.Plain.'", > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] Calling FindDeviceById(Officejet-4500-G510g-m)', > "D [11/Apr/2012:22:27:30 +0200] [Job 8] Failed to send: org.freedesktop.ColorManager.Failed:device id 'Officejet-4500-G510g-m' does not exists", > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] Failed to get profile filename!', > 'I [11/Apr/2012:22:27:30 +0200] [Job 8] no profiles specified in PPD', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] Set job-printer-state-message to "no profiles specified in PPD", current level=INFO', > 'D [11/Apr/2012:22:27:30 +0200] cupsdMarkDirty(-----S)', > 'D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"', > 'D [11/Apr/2012:22:27:30 +0200] cupsdMarkDirty(-----S)', > 'D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] Ghostscript command line: /usr/bin/gs -dQUIET -dPARANOIDSAFER -dNOPAUSE -dBATCH -dNOINTERPOLATE -dNOMEDIAATTRS -sDEVICE=cups -sstdout=%stderr -sOutputFile=%stdout -I/usr/share/cups/fonts -c -f -_', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[0]="CUPS_CACHEDIR=/var/cache/cups"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[1]="CUPS_DATADIR=/usr/share/cups"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[2]="CUPS_DOCROOT=/usr/share/cups/www"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[6]="CUPS_SERVERROOT=/etc/cups"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[7]="CUPS_STATEDIR=/var/run/cups"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[8]="HOME=/var/spool/cups/tmp"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[9]="PATH=/usr/lib/cups/filter:/usr/lib64/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[10]="SERVER_ADMIN=root@m7"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[11]="SOFTWARE=CUPS/1.5.2"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[12]="TMPDIR=/var/spool/cups/tmp"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[13]="USER=root"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[14]="CUPS_SERVER=/var/run/cups/cups.sock"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[15]="CUPS_ENCRYPTION=IfRequested"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[16]="IPP_PORT=631"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[17]="CHARSET=utf-8"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[18]="LANG=de_DE.UTF-8"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[19]="PPD=/etc/cups/ppd/Officejet-4500-G510g-m.ppd"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[20]="RIP_MAX_CACHE=128m"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[21]="CONTENT_TYPE=application/vnd.cups-banner"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[22]="DEVICE_URI=dnssd://Officejet%204500%20G510g-m%20%5B697EF2%5D._pdl-datastream._tcp.local/"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[23]="PRINTER_INFO=Officejet 4500 G510g-m [697EF2]"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[24]="PRINTER_LOCATION="', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[25]="PRINTER=Officejet-4500-G510g-m"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[26]="PRINTER_STATE_REASONS=none"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[27]="CUPS_FILETYPE=document"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[28]="FINAL_CONTENT_TYPE=printer/Officejet-4500-G510g-m"', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] envp[29]="AUTH_INFO_REQUIRED=none"', > 'D [11/Apr/2012:22:27:30 +0200] [Notifier] state=3', > 'D [11/Apr/2012:22:27:30 +0200] [Notifier] PrinterStateChanged', > 'D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 28 POST / HTTP/1.1', > 'D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [11/Apr/2012:22:27:30 +0200] cupsdAuthorize: No authentication data provided.', > 'D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 28 1.1 CUPS-Get-Printers 1', > 'D [11/Apr/2012:22:27:30 +0200] CUPS-Get-Printers', > 'D [11/Apr/2012:22:27:30 +0200] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost', > 'D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 28 POST / HTTP/1.1', > 'D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [11/Apr/2012:22:27:30 +0200] cupsdAuthorize: No authentication data provided.', > 'D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 28 1.1 CUPS-Get-Default 1', > 'D [11/Apr/2012:22:27:30 +0200] CUPS-Get-Default', > 'D [11/Apr/2012:22:27:30 +0200] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost', > 'D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'I [11/Apr/2012:22:27:30 +0200] [Job 8] Start rendering...', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] Set job-printer-state-message to "Start rendering...", current level=INFO', > 'I [11/Apr/2012:22:27:30 +0200] [Job 8] Processing page 1...', > 'D [11/Apr/2012:22:27:30 +0200] [Job 8] Set job-printer-state-message to "Processing page 1...", current level=INFO', > 'D [11/Apr/2012:22:27:30 +0200] cupsdMarkDirty(-----S)', > 'D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"', > 'D [11/Apr/2012:22:27:30 +0200] cupsdMarkDirty(-----S)', > 'D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"', > 'D [11/Apr/2012:22:27:30 +0200] [Notifier] state=3', > 'D [11/Apr/2012:22:27:30 +0200] [Notifier] PrinterStateChanged', > 'D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 28 POST / HTTP/1.1', > 'D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [11/Apr/2012:22:27:30 +0200] cupsdAuthorize: No authentication data provided.', > 'D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 28 1.1 CUPS-Get-Printers 1', > 'D [11/Apr/2012:22:27:30 +0200] CUPS-Get-Printers', > 'D [11/Apr/2012:22:27:30 +0200] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost', > 'D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 28 POST / HTTP/1.1', > 'D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [11/Apr/2012:22:27:30 +0200] cupsdAuthorize: No authentication data provided.', > 'D [11/Apr/2012:22:27:30 +0200] cupsdReadClient: 28 1.1 CUPS-Get-Default 1', > 'D [11/Apr/2012:22:27:30 +0200] CUPS-Get-Default', > 'D [11/Apr/2012:22:27:30 +0200] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost', > 'D [11/Apr/2012:22:27:30 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [11/Apr/2012:22:27:31 +0200] cupsdAcceptClient: skipping getpeercon()', > 'D [11/Apr/2012:22:27:31 +0200] cupsdAcceptClient: 29 from localhost (Domain)', > 'D [11/Apr/2012:22:27:31 +0200] cupsdReadClient: 29 POST / HTTP/1.1', > 'D [11/Apr/2012:22:27:31 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [11/Apr/2012:22:27:31 +0200] cupsdAuthorize: No authentication data provided.', > 'D [11/Apr/2012:22:27:31 +0200] cupsdReadClient: 29 1.1 Get-Notifications 1', > 'D [11/Apr/2012:22:27:31 +0200] Get-Notifications /', > 'D [11/Apr/2012:22:27:31 +0200] cupsdIsAuthorized: requesting-user-name="carsten"', > 'D [11/Apr/2012:22:27:31 +0200] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [11/Apr/2012:22:27:31 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [11/Apr/2012:22:27:31 +0200] cupsdAcceptClient: skipping getpeercon()', > 'D [11/Apr/2012:22:27:31 +0200] cupsdAcceptClient: 30 from localhost (Domain)', > 'D [11/Apr/2012:22:27:31 +0200] cupsdReadClient: 19 WAITING Closing on EOF', > 'D [11/Apr/2012:22:27:31 +0200] cupsdCloseClient: 19', > 'D [11/Apr/2012:22:27:31 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"', > 'D [11/Apr/2012:22:27:31 +0200] cupsdReadClient: 29 WAITING Closing on EOF', > 'D [11/Apr/2012:22:27:31 +0200] cupsdCloseClient: 29', > 'D [11/Apr/2012:22:27:31 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"', > 'D [11/Apr/2012:22:27:31 +0200] cupsdReadClient: 18 POST / HTTP/1.1', > 'D [11/Apr/2012:22:27:31 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [11/Apr/2012:22:27:31 +0200] cupsdAuthorize: No authentication data provided.', > 'D [11/Apr/2012:22:27:31 +0200] cupsdReadClient: 18 1.1 Get-Notifications 1', > 'D [11/Apr/2012:22:27:31 +0200] Get-Notifications /', > 'D [11/Apr/2012:22:27:31 +0200] cupsdIsAuthorized: requesting-user-name="carsten"', > 'D [11/Apr/2012:22:27:31 +0200] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [11/Apr/2012:22:27:31 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [11/Apr/2012:22:27:31 +0200] cupsdAcceptClient: skipping getpeercon()', > 'D [11/Apr/2012:22:27:31 +0200] cupsdAcceptClient: 19 from localhost (Domain)', > 'D [11/Apr/2012:22:27:31 +0200] cupsdReadClient: 19 POST / HTTP/1.1', > 'D [11/Apr/2012:22:27:31 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [11/Apr/2012:22:27:31 +0200] cupsdAuthorize: No authentication data provided.', > 'D [11/Apr/2012:22:27:31 +0200] cupsdReadClient: 19 1.1 CUPS-Get-Printers 1', > 'D [11/Apr/2012:22:27:31 +0200] CUPS-Get-Printers', > 'D [11/Apr/2012:22:27:31 +0200] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost', > 'D [11/Apr/2012:22:27:31 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [11/Apr/2012:22:27:31 +0200] cupsdReadClient: 19 POST / HTTP/1.1', > 'D [11/Apr/2012:22:27:31 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [11/Apr/2012:22:27:31 +0200] cupsdAuthorize: No authentication data provided.', > 'D [11/Apr/2012:22:27:31 +0200] cupsdReadClient: 19 1.1 CUPS-Get-Classes 1', > 'D [11/Apr/2012:22:27:31 +0200] CUPS-Get-Classes', > 'D [11/Apr/2012:22:27:31 +0200] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost', > 'D [11/Apr/2012:22:27:31 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [11/Apr/2012:22:27:31 +0200] cupsdReadClient: 19 POST / HTTP/1.1', > 'D [11/Apr/2012:22:27:31 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"', > 'D [11/Apr/2012:22:27:31 +0200] cupsdAuthorize: No authentication data provided.', > 'D [11/Apr/2012:22:27:31 +0200] cupsdReadClient: 19 1.1 CUPS-Get-Default 1', > 'D [11/Apr/2012:22:27:31 +0200] CUPS-Get-Default', > 'D [11/Apr/2012:22:27:31 +0200] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost', > 'D [11/Apr/2012:22:27:31 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"', > 'D [11/Apr/2012:22:27:31 +0200] [Job 8] PAGE: 1 1', > 'D [11/Apr/2012:22:27:31 +0200] cupsdMarkDirty(-----S)', > 'D [11/Apr/2012:22:27:31 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"', > 'D [11/Apr/2012:22:27:35 +0200] [Job 8] Unable to resolve URI', > 'D [11/Apr/2012:22:27:35 +0200] [Job 8] STATE: -connecting-to-device,offline-report', > 'D [11/Apr/2012:22:27:35 +0200] cupsdMarkDirty(-----S)', > 'D [11/Apr/2012:22:27:35 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Dirty files"', > 'D [11/Apr/2012:22:27:35 +0200] [Notifier] state=3', > 'D [11/Apr/2012:22:27:35 +0200] [Notifier] PrinterStateChanged', > 'E [11/Apr/2012:22:27:35 +0200] [Job 8] Unable to find printer.', > 'D [11/Apr/2012:22:27:35 +0200] [Job 8] Set job-printer-state-message to "Unable to find printer.", current level=ERROR', > 'I [11/Apr/2012:22:27:35 +0200] [Job 8] Unable to locate printer.', > 'D [11/Apr/2012:22:27:35 +0200] cupsdMarkDirty(-----S)', > 'D [11/Apr/2012:22:27:35 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [11/Apr/2012:22:27:35 +0200] cupsdMarkDirty(-----S)', > 'D [11/Apr/2012:22:27:35 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [11/Apr/2012:22:27:35 +0200] cupsdReadClient: 28 POST / HTTP/1.1', > 'D [11/Apr/2012:22:27:35 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [11/Apr/2012:22:27:35 +0200] cupsdAuthorize: No authentication data provided.', > 'D [11/Apr/2012:22:27:35 +0200] cupsdReadClient: 28 1.1 CUPS-Get-Printers 1', > 'D [11/Apr/2012:22:27:35 +0200] CUPS-Get-Printers', > 'D [11/Apr/2012:22:27:35 +0200] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost', > 'D [11/Apr/2012:22:27:35 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [11/Apr/2012:22:27:35 +0200] [Notifier] state=3', > 'D [11/Apr/2012:22:27:35 +0200] [Notifier] PrinterStateChanged', > 'D [11/Apr/2012:22:27:35 +0200] cupsdReadClient: 28 POST / HTTP/1.1', > 'D [11/Apr/2012:22:27:35 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [11/Apr/2012:22:27:35 +0200] cupsdAuthorize: No authentication data provided.', > 'D [11/Apr/2012:22:27:35 +0200] cupsdReadClient: 28 1.1 CUPS-Get-Default 1', > 'D [11/Apr/2012:22:27:35 +0200] CUPS-Get-Default', > 'D [11/Apr/2012:22:27:35 +0200] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost', > 'D [11/Apr/2012:22:27:35 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [11/Apr/2012:22:27:35 +0200] cupsdReadClient: 28 POST / HTTP/1.1', > 'D [11/Apr/2012:22:27:35 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [11/Apr/2012:22:27:35 +0200] cupsdAuthorize: No authentication data provided.', > 'D [11/Apr/2012:22:27:35 +0200] cupsdReadClient: 28 1.1 CUPS-Get-Printers 1', > 'D [11/Apr/2012:22:27:35 +0200] CUPS-Get-Printers', > 'D [11/Apr/2012:22:27:35 +0200] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost', > 'D [11/Apr/2012:22:27:35 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [11/Apr/2012:22:27:35 +0200] cupsdReadClient: 28 POST / HTTP/1.1', > 'D [11/Apr/2012:22:27:35 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [11/Apr/2012:22:27:35 +0200] cupsdAuthorize: No authentication data provided.', > 'D [11/Apr/2012:22:27:35 +0200] cupsdReadClient: 28 1.1 CUPS-Get-Default 1', > 'D [11/Apr/2012:22:27:35 +0200] CUPS-Get-Default', > 'D [11/Apr/2012:22:27:35 +0200] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost', > 'D [11/Apr/2012:22:27:35 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [11/Apr/2012:22:27:35 +0200] cupsdAcceptClient: skipping getpeercon()', > 'D [11/Apr/2012:22:27:35 +0200] cupsdAcceptClient: 29 from localhost (Domain)', > 'D [11/Apr/2012:22:27:35 +0200] cupsdReadClient: 29 POST / HTTP/1.1', > 'D [11/Apr/2012:22:27:35 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [11/Apr/2012:22:27:35 +0200] cupsdAuthorize: No authentication data provided.', > 'D [11/Apr/2012:22:27:35 +0200] cupsdReadClient: 29 1.1 Get-Notifications 1', > 'D [11/Apr/2012:22:27:35 +0200] Get-Notifications /', > 'D [11/Apr/2012:22:27:35 +0200] cupsdIsAuthorized: requesting-user-name="carsten"', > 'D [11/Apr/2012:22:27:35 +0200] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [11/Apr/2012:22:27:35 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [11/Apr/2012:22:27:35 +0200] cupsdReadClient: 29 WAITING Closing on EOF', > 'D [11/Apr/2012:22:27:35 +0200] cupsdCloseClient: 29', > 'D [11/Apr/2012:22:27:35 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [11/Apr/2012:22:27:35 +0200] cupsdReadClient: 18 POST / HTTP/1.1', > 'D [11/Apr/2012:22:27:35 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [11/Apr/2012:22:27:35 +0200] cupsdAuthorize: No authentication data provided.', > 'D [11/Apr/2012:22:27:35 +0200] cupsdReadClient: 18 1.1 Get-Notifications 1', > 'D [11/Apr/2012:22:27:35 +0200] Get-Notifications /', > 'D [11/Apr/2012:22:27:35 +0200] cupsdIsAuthorized: requesting-user-name="carsten"', > 'D [11/Apr/2012:22:27:35 +0200] Returning IPP successful-ok for Get-Notifications (/) from localhost', > 'D [11/Apr/2012:22:27:35 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [11/Apr/2012:22:27:36 +0200] cupsdReadClient: 19 POST / HTTP/1.1', > 'D [11/Apr/2012:22:27:36 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [11/Apr/2012:22:27:36 +0200] cupsdAuthorize: No authentication data provided.', > 'D [11/Apr/2012:22:27:36 +0200] cupsdReadClient: 19 1.1 CUPS-Get-Printers 1', > 'D [11/Apr/2012:22:27:36 +0200] CUPS-Get-Printers', > 'D [11/Apr/2012:22:27:36 +0200] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost', > 'D [11/Apr/2012:22:27:36 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [11/Apr/2012:22:27:36 +0200] cupsdReadClient: 19 POST / HTTP/1.1', > 'D [11/Apr/2012:22:27:36 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [11/Apr/2012:22:27:36 +0200] cupsdAuthorize: No authentication data provided.', > 'D [11/Apr/2012:22:27:36 +0200] cupsdReadClient: 19 1.1 CUPS-Get-Classes 1', > 'D [11/Apr/2012:22:27:36 +0200] CUPS-Get-Classes', > 'D [11/Apr/2012:22:27:36 +0200] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost', > 'D [11/Apr/2012:22:27:36 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [11/Apr/2012:22:27:36 +0200] cupsdReadClient: 19 POST / HTTP/1.1', > 'D [11/Apr/2012:22:27:36 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [11/Apr/2012:22:27:36 +0200] cupsdAuthorize: No authentication data provided.', > 'D [11/Apr/2012:22:27:36 +0200] cupsdReadClient: 19 1.1 CUPS-Get-Default 1', > 'D [11/Apr/2012:22:27:36 +0200] CUPS-Get-Default', > 'D [11/Apr/2012:22:27:36 +0200] Returning IPP successful-ok for CUPS-Get-Default (no URI) from localhost', > 'D [11/Apr/2012:22:27:36 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [11/Apr/2012:22:27:41 +0200] cupsdReadClient: 18 POST / HTTP/1.1', > 'D [11/Apr/2012:22:27:41 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [11/Apr/2012:22:27:41 +0200] cupsdAuthorize: No authentication data provided.', > 'D [11/Apr/2012:22:27:41 +0200] cupsdReadClient: 18 1.1 Get-Job-Attributes 1', > 'D [11/Apr/2012:22:27:41 +0200] Get-Job-Attributes ipp://localhost/jobs/8', > 'D [11/Apr/2012:22:27:41 +0200] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/8) from localhost', > 'D [11/Apr/2012:22:27:41 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [11/Apr/2012:22:27:41 +0200] cupsdReadClient: 18 POST / HTTP/1.1', > 'D [11/Apr/2012:22:27:41 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [11/Apr/2012:22:27:41 +0200] cupsdAuthorize: No authentication data provided.', > 'D [11/Apr/2012:22:27:41 +0200] cupsdReadClient: 18 1.1 Cancel-Subscription 1', > 'D [11/Apr/2012:22:27:41 +0200] Cancel-Subscription /', > 'D [11/Apr/2012:22:27:41 +0200] cupsdIsAuthorized: requesting-user-name="carsten"', > 'D [11/Apr/2012:22:27:41 +0200] cupsdMarkDirty(-----S)', > 'D [11/Apr/2012:22:27:41 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [11/Apr/2012:22:27:41 +0200] Returning IPP successful-ok for Cancel-Subscription (/) from localhost', > 'D [11/Apr/2012:22:27:41 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [11/Apr/2012:22:27:41 +0200] cupsdReadClient: 16 PUT /admin/conf/cupsd.conf HTTP/1.1', > 'D [11/Apr/2012:22:27:41 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"', > 'D [11/Apr/2012:22:27:41 +0200] cupsdAuthorize: Authorized as root using PeerCred', > 'D [11/Apr/2012:22:27:41 +0200] cupsdIsAuthorized: username="root"', > 'I [11/Apr/2012:22:27:41 +0200] Installing config file "/etc/cups/cupsd.conf"...', > 'D [11/Apr/2012:22:27:41 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"', > 'D [11/Apr/2012:22:27:41 +0200] cupsdCloseClient: 16', > 'D [11/Apr/2012:22:27:41 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [11/Apr/2012:22:27:41 +0200] cupsdCloseClient: 18', > 'D [11/Apr/2012:22:27:41 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [11/Apr/2012:22:27:41 +0200] cupsdCloseClient: 24', > 'D [11/Apr/2012:22:27:41 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [11/Apr/2012:22:27:41 +0200] cupsdCloseClient: 25', > 'D [11/Apr/2012:22:27:41 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [11/Apr/2012:22:27:41 +0200] cupsdCloseClient: 26', > 'D [11/Apr/2012:22:27:41 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [11/Apr/2012:22:27:41 +0200] cupsdCloseClient: 27', > 'D [11/Apr/2012:22:27:41 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [11/Apr/2012:22:27:41 +0200] cupsdCloseClient: 28', > 'D [11/Apr/2012:22:27:41 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [11/Apr/2012:22:27:41 +0200] cupsdCloseClient: 30', > 'D [11/Apr/2012:22:27:41 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [11/Apr/2012:22:27:41 +0200] cupsdCloseClient: 19', > 'D [11/Apr/2012:22:27:41 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"', > 'D [11/Apr/2012:22:27:41 +0200] cupsdDeregisterPrinter(p=0x7f074fa1bfe0(Officejet-4500-G510g-m), removeit=1)', > 'I [11/Apr/2012:22:27:41 +0200] Generating printcap /etc/printcap...', > 'I [11/Apr/2012:22:27:41 +0200] Saving job.cache...', > 'I [11/Apr/2012:22:27:41 +0200] Saving subscriptions.conf...', > 'D [11/Apr/2012:22:27:41 +0200] cupsdSetBusyState: newbusy="Printing jobs", busy="Printing jobs and dirty files"', > "W [11/Apr/2012:22:27:42 +0200] failed to CreateProfile: org.freedesktop.ColorManager.AlreadyExists:profile id 'Officejet-4500-G510g-m-Gray..' already exists", > "W [11/Apr/2012:22:27:42 +0200] failed to CreateProfile: org.freedesktop.ColorManager.AlreadyExists:profile id 'Officejet-4500-G510g-m-RGB..' already exists", > "W [11/Apr/2012:22:27:42 +0200] failed to CreateDevice: org.freedesktop.ColorManager.AlreadyExists:device id 'cups-Officejet-4500-G510g-m' already exists"], > 'error_log_debug_logging_unset': True} >Page 11 (Printer state reasons): >{'printer-state-message': u'Unable to locate printer.', > 'printer-state-reasons': [u'none']} >Page 12 (Locale issues): >{'job_page_size': u'A4.FB', > 'printer_page_size': u'A4', > 'system_locale_lang': 'de_DE', > 'user_locale_ctype': 'de_DE', > 'user_locale_messages': 'de_DE'}
You cannot view the attachment while viewing its details because your browser does not support IFRAMEs.
View the attachment on a separate page
.
View Attachment As Raw
Actions:
View
Attachments on
bug 811307
: 915438