Attachment 576916 Details for Bug 810007 – error_log when in debug mode

error_log when in debug mode

error_log (text/plain), 44.40 KB, created by Gianluca Cecchi on 2012-04-11 23:41:38 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Gianluca Cecchi

Created: 2012-04-11 23:41:38 UTC

Size: 44.40 KB

patch

obsolete

>D [12/Apr/2012:01:24:25 +0200] cupsdReadClient: 16 WAITING Closing on EOF
>D [12/Apr/2012:01:24:25 +0200] cupsdCloseClient: 16
>D [12/Apr/2012:01:24:25 +0200] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
>D [12/Apr/2012:01:24:25 +0200] Avahi client started
>D [12/Apr/2012:01:24:27 +0200] cupsdAcceptClient: skipping getpeercon()
>D [12/Apr/2012:01:24:27 +0200] cupsdAcceptClient: 17 from localhost:631 (IPv6)
>D [12/Apr/2012:01:24:27 +0200] cupsdReadClient: 17 POST /printers/ccc3 HTTP/1.1
>D [12/Apr/2012:01:24:27 +0200] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
>D [12/Apr/2012:01:24:27 +0200] cupsdAuthorize: Authorized as root using Basic
>D [12/Apr/2012:01:24:27 +0200] [CGI] argv[0] = "/usr/lib/cups/cgi-bin/printers.cgi"
>D [12/Apr/2012:01:24:27 +0200] [CGI] envp[0] = "CUPS_CACHEDIR=/var/cache/cups"
>D [12/Apr/2012:01:24:27 +0200] [CGI] envp[1] = "CUPS_DATADIR=/usr/share/cups"
>D [12/Apr/2012:01:24:27 +0200] [CGI] envp[2] = "CUPS_DOCROOT=/usr/share/cups/www"
>D [12/Apr/2012:01:24:27 +0200] [CGI] envp[3] = "CUPS_FONTPATH=/usr/share/cups/fonts"
>D [12/Apr/2012:01:24:27 +0200] [CGI] envp[4] = "CUPS_REQUESTROOT=/var/spool/cups"
>D [12/Apr/2012:01:24:27 +0200] [CGI] envp[5] = "CUPS_SERVERBIN=/usr/lib/cups"
>D [12/Apr/2012:01:24:27 +0200] [CGI] envp[6] = "CUPS_SERVERROOT=/etc/cups"
>D [12/Apr/2012:01:24:27 +0200] [CGI] envp[7] = "CUPS_STATEDIR=/var/run/cups"
>D [12/Apr/2012:01:24:27 +0200] [CGI] envp[8] = "HOME=/var/spool/cups/tmp"
>D [12/Apr/2012:01:24:27 +0200] [CGI] envp[9] = "PATH=/usr/lib/cups/filter:/usr/lib64/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
>D [12/Apr/2012:01:24:27 +0200] [CGI] envp[10] = "SERVER_ADMIN=root@mypc"
>D [12/Apr/2012:01:24:27 +0200] [CGI] envp[11] = "SOFTWARE=CUPS/1.5.2"
>D [12/Apr/2012:01:24:27 +0200] [CGI] envp[12] = "TMPDIR=/var/spool/cups/tmp"
>D [12/Apr/2012:01:24:27 +0200] [CGI] envp[13] = "USER=root"
>D [12/Apr/2012:01:24:27 +0200] [CGI] envp[14] = "CUPS_SERVER=/var/run/cups/cups.sock"
>D [12/Apr/2012:01:24:27 +0200] [CGI] envp[15] = "CUPS_ENCRYPTION=IfRequested"
>D [12/Apr/2012:01:24:27 +0200] [CGI] envp[16] = "IPP_PORT=631"
>D [12/Apr/2012:01:24:27 +0200] [CGI] envp[17] = "AUTH_TYPE=Basic"
>D [12/Apr/2012:01:24:27 +0200] [CGI] envp[18] = "LANG=en_US.UTF8"
>D [12/Apr/2012:01:24:27 +0200] [CGI] envp[19] = "REDIRECT_STATUS=1"
>D [12/Apr/2012:01:24:27 +0200] [CGI] envp[20] = "GATEWAY_INTERFACE=CGI/1.1"
>D [12/Apr/2012:01:24:27 +0200] [CGI] envp[21] = "SERVER_NAME=localhost"
>D [12/Apr/2012:01:24:27 +0200] [CGI] envp[22] = "SERVER_PORT=631"
>D [12/Apr/2012:01:24:27 +0200] [CGI] envp[23] = "REMOTE_ADDR=[v1.::1]"
>D [12/Apr/2012:01:24:27 +0200] [CGI] envp[24] = "REMOTE_HOST=localhost"
>D [12/Apr/2012:01:24:27 +0200] [CGI] envp[25] = "SCRIPT_NAME=/printers/ccc3"
>D [12/Apr/2012:01:24:27 +0200] [CGI] envp[26] = "SCRIPT_FILENAME=/usr/share/cups/www/printers/ccc3"
>D [12/Apr/2012:01:24:27 +0200] [CGI] envp[27] = "PATH_INFO=/ccc3"
>D [12/Apr/2012:01:24:27 +0200] [CGI] envp[28] = "REMOTE_USER=root"
>D [12/Apr/2012:01:24:27 +0200] [CGI] envp[29] = "SERVER_PROTOCOL=HTTP/1.1"
>D [12/Apr/2012:01:24:27 +0200] [CGI] envp[30] = "HTTP_COOKIE=org.cups.sid=b545ab5ead0b18efc1fd9b66d86609d6"
>D [12/Apr/2012:01:24:27 +0200] [CGI] envp[31] = "HTTP_USER_AGENT=Mozilla/5.0 (X11; Linux x86_64; rv:11.0) Gecko/20100101 Firefox/11.0"
>D [12/Apr/2012:01:24:27 +0200] [CGI] envp[32] = "HTTP_REFERER=http://localhost:631/printers/ccc3"
>D [12/Apr/2012:01:24:27 +0200] [CGI] envp[33] = "REQUEST_METHOD=POST"
>D [12/Apr/2012:01:24:27 +0200] [CGI] envp[34] = "CONTENT_LENGTH=64"
>D [12/Apr/2012:01:24:27 +0200] [CGI] envp[35] = "CONTENT_TYPE=application/x-www-form-urlencoded"
>D [12/Apr/2012:01:24:27 +0200] [CGI] Started /usr/lib/cups/cgi-bin/printers.cgi (PID 6418)
>I [12/Apr/2012:01:24:27 +0200] Started "/usr/lib/cups/cgi-bin/printers.cgi" (pid=6418)
>D [12/Apr/2012:01:24:27 +0200] cupsdSendCommand: 17 file=19
>D [12/Apr/2012:01:24:27 +0200] [CGI] org.cups.sid cookie is "b545ab5ead0b18efc1fd9b66d86609d6"
>D [12/Apr/2012:01:24:27 +0200] cupsdAcceptClient: skipping getpeercon()
>D [12/Apr/2012:01:24:27 +0200] cupsdAcceptClient: 18 from localhost (Domain)
>D [12/Apr/2012:01:24:27 +0200] cupsdReadClient: 18 POST /printers/ccc3 HTTP/1.1
>D [12/Apr/2012:01:24:27 +0200] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
>D [12/Apr/2012:01:24:27 +0200] cupsdAuthorize: No authentication data provided.
>D [12/Apr/2012:01:24:27 +0200] cupsdReadClient: 18 1.1 Print-Job 1
>D [12/Apr/2012:01:24:27 +0200] Print-Job ipp://localhost:631/printers/ccc3
>D [12/Apr/2012:01:24:27 +0200] [Job ???] Auto-typing file...
>I [12/Apr/2012:01:24:27 +0200] [Job ???] Request file type is application/vnd.cups-banner.
>D [12/Apr/2012:01:24:27 +0200] cupsdIsAuthorized: username=""
>D [12/Apr/2012:01:24:27 +0200] Returning HTTP Unauthorized for Print-Job (ipp://localhost:631/printers/ccc3) from localhost
>D [12/Apr/2012:01:24:27 +0200] cupsdSendHeader: 18 WWW-Authenticate: Basic realm="CUPS"
>D [12/Apr/2012:01:24:27 +0200] cupsdReadClient: 18 WAITING Closing on EOF
>D [12/Apr/2012:01:24:27 +0200] cupsdCloseClient: 18
>D [12/Apr/2012:01:24:27 +0200] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
>D [12/Apr/2012:01:24:27 +0200] cupsdAcceptClient: skipping getpeercon()
>D [12/Apr/2012:01:24:27 +0200] cupsdAcceptClient: 18 from localhost (Domain)
>D [12/Apr/2012:01:24:27 +0200] cupsdAcceptClient: skipping getpeercon()
>D [12/Apr/2012:01:24:27 +0200] cupsdAcceptClient: 20 from localhost (Domain)
>D [12/Apr/2012:01:24:27 +0200] cupsdReadClient: 18 WAITING Closing on EOF
>D [12/Apr/2012:01:24:27 +0200] cupsdCloseClient: 18
>D [12/Apr/2012:01:24:27 +0200] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
>D [12/Apr/2012:01:24:27 +0200] cupsdReadClient: 20 POST /printers/ccc3 HTTP/1.1
>D [12/Apr/2012:01:24:27 +0200] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
>D [12/Apr/2012:01:24:27 +0200] cupsdAuthorize: Authorized as root using Local
>D [12/Apr/2012:01:24:27 +0200] cupsdReadClient: 20 1.1 Print-Job 1
>D [12/Apr/2012:01:24:27 +0200] Print-Job ipp://localhost:631/printers/ccc3
>D [12/Apr/2012:01:24:27 +0200] [Job ???] Auto-typing file...
>I [12/Apr/2012:01:24:27 +0200] [Job ???] Request file type is application/vnd.cups-banner.
>D [12/Apr/2012:01:24:27 +0200] cupsdIsAuthorized: username="root"
>D [12/Apr/2012:01:24:27 +0200] add_job: setting context of job to UNKNOWN SL
>D [12/Apr/2012:01:24:27 +0200] cupsdMarkDirty(----J-)
>D [12/Apr/2012:01:24:27 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients"
>D [12/Apr/2012:01:24:27 +0200] Adding default job-sheets values "none,none"...
>I [12/Apr/2012:01:24:27 +0200] [Job 38] Adding start banner page "none".
>D [12/Apr/2012:01:24:27 +0200] Notifier dbus started - PID = 6419
>D [12/Apr/2012:01:24:27 +0200] cupsdMarkDirty(-----S)
>D [12/Apr/2012:01:24:27 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
>D [12/Apr/2012:01:24:27 +0200] cupsdMarkDirty(----J-)
>D [12/Apr/2012:01:24:27 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
>I [12/Apr/2012:01:24:27 +0200] [Job 38] Adding end banner page "none".
>I [12/Apr/2012:01:24:27 +0200] [Job 38] File of type application/vnd.cups-banner queued by "root".
>D [12/Apr/2012:01:24:27 +0200] [Job 38] hold_until=0
>I [12/Apr/2012:01:24:27 +0200] [Job 38] Queued on "ccc3" by "root".
>D [12/Apr/2012:01:24:27 +0200] cupsdMarkDirty(----J-)
>D [12/Apr/2012:01:24:27 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
>D [12/Apr/2012:01:24:27 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
>D [12/Apr/2012:01:24:27 +0200] cupsdMarkDirty(-----S)
>D [12/Apr/2012:01:24:27 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
>D [12/Apr/2012:01:24:27 +0200] [Job 38] job-sheets=none,none
>D [12/Apr/2012:01:24:27 +0200] [Job 38] argv[0]="ccc3"
>D [12/Apr/2012:01:24:27 +0200] [Job 38] argv[1]="38"
>D [12/Apr/2012:01:24:27 +0200] [Job 38] argv[2]="root"
>D [12/Apr/2012:01:24:27 +0200] [Job 38] argv[3]="Test Page"
>D [12/Apr/2012:01:24:27 +0200] [Job 38] argv[4]="1"
>D [12/Apr/2012:01:24:27 +0200] [Job 38] argv[5]="job-uuid=urn:uuid:9d4bf66c-9da7-3c24-58bc-d4f759d953c9 job-originating-host-name=localhost time-at-creation=1334186667 time-at-processing=1334186667 AP_D_InputSlot="
>D [12/Apr/2012:01:24:27 +0200] [Job 38] argv[6]="/var/spool/cups/d00038-001"
>D [12/Apr/2012:01:24:27 +0200] [Job 38] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
>D [12/Apr/2012:01:24:27 +0200] [Job 38] envp[1]="CUPS_DATADIR=/usr/share/cups"
>D [12/Apr/2012:01:24:27 +0200] [Job 38] envp[2]="CUPS_DOCROOT=/usr/share/cups/www"
>D [12/Apr/2012:01:24:27 +0200] [Job 38] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
>D [12/Apr/2012:01:24:27 +0200] [Job 38] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
>D [12/Apr/2012:01:24:27 +0200] [Job 38] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
>D [12/Apr/2012:01:24:27 +0200] [Job 38] envp[6]="CUPS_SERVERROOT=/etc/cups"
>D [12/Apr/2012:01:24:27 +0200] [Job 38] envp[7]="CUPS_STATEDIR=/var/run/cups"
>D [12/Apr/2012:01:24:27 +0200] [Job 38] envp[8]="HOME=/var/spool/cups/tmp"
>D [12/Apr/2012:01:24:27 +0200] [Job 38] envp[9]="PATH=/usr/lib/cups/filter:/usr/lib64/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
>D [12/Apr/2012:01:24:27 +0200] [Job 38] envp[10]="SERVER_ADMIN=root@mypc"
>D [12/Apr/2012:01:24:27 +0200] [Job 38] envp[11]="SOFTWARE=CUPS/1.5.2"
>D [12/Apr/2012:01:24:27 +0200] [Job 38] envp[12]="TMPDIR=/var/spool/cups/tmp"
>D [12/Apr/2012:01:24:27 +0200] [Job 38] envp[13]="USER=root"
>D [12/Apr/2012:01:24:27 +0200] [Job 38] envp[14]="CUPS_SERVER=/var/run/cups/cups.sock"
>D [12/Apr/2012:01:24:27 +0200] [Job 38] envp[15]="CUPS_ENCRYPTION=IfRequested"
>D [12/Apr/2012:01:24:27 +0200] [Job 38] envp[16]="IPP_PORT=631"
>D [12/Apr/2012:01:24:27 +0200] [Job 38] envp[17]="CHARSET=utf-8"
>D [12/Apr/2012:01:24:27 +0200] [Job 38] envp[18]="LANG=en_US.UTF-8"
>D [12/Apr/2012:01:24:27 +0200] [Job 38] envp[19]="PPD=/etc/cups/ppd/ccc3.ppd"
>D [12/Apr/2012:01:24:27 +0200] [Job 38] envp[20]="RIP_MAX_CACHE=128m"
>D [12/Apr/2012:01:24:27 +0200] [Job 38] envp[21]="CONTENT_TYPE=application/vnd.cups-banner"
>D [12/Apr/2012:01:24:27 +0200] [Job 38] envp[22]="DEVICE_URI=https://myprintserver/printers/Stampante3/.printer"
>D [12/Apr/2012:01:24:27 +0200] [Job 38] envp[23]="PRINTER_INFO=ccc3"
>D [12/Apr/2012:01:24:27 +0200] [Job 38] envp[24]="PRINTER_LOCATION="
>D [12/Apr/2012:01:24:27 +0200] [Job 38] envp[25]="PRINTER=ccc3"
>D [12/Apr/2012:01:24:27 +0200] [Job 38] envp[26]="PRINTER_STATE_REASONS=none"
>D [12/Apr/2012:01:24:27 +0200] [Job 38] envp[27]="CUPS_FILETYPE=document"
>D [12/Apr/2012:01:24:27 +0200] [Job 38] envp[28]="FINAL_CONTENT_TYPE=application/vnd.cups-postscript"
>D [12/Apr/2012:01:24:27 +0200] [Job 38] envp[29]="AUTH_I****"
>D [12/Apr/2012:01:24:27 +0200] [Job 38] envp[30]="AUTH_U****"
>D [12/Apr/2012:01:24:27 +0200] [Job 38] envp[31]="AUTH_P****"
>I [12/Apr/2012:01:24:27 +0200] [Job 38] Started filter /usr/lib/cups/filter/bannertops (PID 6420)
>I [12/Apr/2012:01:24:27 +0200] [Job 38] Started filter /usr/lib/cups/filter/pstops (PID 6421)
>I [12/Apr/2012:01:24:27 +0200] [Job 38] Started backend /usr/lib/cups/backend/https (PID 6422)
>D [12/Apr/2012:01:24:27 +0200] cupsdMarkDirty(-----S)
>D [12/Apr/2012:01:24:27 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients and dirty files"
>D [12/Apr/2012:01:24:27 +0200] Returning IPP successful-ok for Print-Job (ipp://localhost:631/printers/ccc3) from localhost
>D [12/Apr/2012:01:24:27 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
>D [12/Apr/2012:01:24:27 +0200] [Notifier] state=3
>D [12/Apr/2012:01:24:27 +0200] [Job 38] load_banner(filename="/var/spool/cups/d00038-001")
>D [12/Apr/2012:01:24:27 +0200] [Job 38] 1 #CUPS-BANNER
>D [12/Apr/2012:01:24:27 +0200] [Job 38] 2 Show printer-name printer-info printer-location printer-make-and-model printer-driver-name printer-driver-version paper-size imageable-area
>D [12/Apr/2012:01:24:27 +0200] [Job 38] 3 Header Printer Test Page
>D [12/Apr/2012:01:24:27 +0200] [Job 38] 4 Footer Printer Test Page
>D [12/Apr/2012:01:24:27 +0200] [Job 38] 5 Notice CUPS 1.5.2.
>D [12/Apr/2012:01:24:27 +0200] [Job 38] 6 Image images/cups.png
>D [12/Apr/2012:01:24:27 +0200] [Job 38] 7 Image images/color-wheel.png
>D [12/Apr/2012:01:24:27 +0200] Script header: Content-Type: text/html;charset=utf-8
>D [12/Apr/2012:01:24:27 +0200] Script header: 
>D [12/Apr/2012:01:24:27 +0200] cupsdReadClient: 20 WAITING Closing on EOF
>D [12/Apr/2012:01:24:27 +0200] cupsdCloseClient: 20
>D [12/Apr/2012:01:24:27 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
>D [12/Apr/2012:01:24:27 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
>D [12/Apr/2012:01:24:27 +0200] PID 6418 (/usr/lib/cups/cgi-bin/printers.cgi) exited with no errors.
>D [12/Apr/2012:01:24:27 +0200] [Notifier] Connected to D-BUS
>D [12/Apr/2012:01:24:27 +0200] [Notifier] JobCreated
>D [12/Apr/2012:01:24:27 +0200] [Job 38] Sending stdin for job...
>D [12/Apr/2012:01:24:27 +0200] [Job 38] update_reasons(attr=0(), s="+connecting-to-device")
>D [12/Apr/2012:01:24:27 +0200] [Job 38] STATE: +connecting-to-device
>D [12/Apr/2012:01:24:27 +0200] cupsdMarkDirty(-----S)
>D [12/Apr/2012:01:24:27 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Printing jobs and dirty files"
>D [12/Apr/2012:01:24:27 +0200] cupsdAcceptClient: skipping getpeercon()
>D [12/Apr/2012:01:24:27 +0200] cupsdAcceptClient: 19 from localhost (Domain)
>D [12/Apr/2012:01:24:27 +0200] cupsdReadClient: 19 POST / HTTP/1.1
>D [12/Apr/2012:01:24:27 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
>D [12/Apr/2012:01:24:27 +0200] cupsdAuthorize: No authentication data provided.
>D [12/Apr/2012:01:24:27 +0200] cupsdReadClient: 19 1.1 Get-Job-Attributes 1
>D [12/Apr/2012:01:24:27 +0200] Get-Job-Attributes ipp://localhost/jobs/38
>D [12/Apr/2012:01:24:27 +0200] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/38) from localhost
>D [12/Apr/2012:01:24:27 +0200] [Notifier] state=3
>D [12/Apr/2012:01:24:27 +0200] [Notifier] PrinterStateChanged
>D [12/Apr/2012:01:24:27 +0200] [Notifier] state=3
>D [12/Apr/2012:01:24:27 +0200] [Notifier] JobState
>D [12/Apr/2012:01:24:27 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
>D [12/Apr/2012:01:24:27 +0200] [Job 38] Looking up "myprintserver"...
>D [12/Apr/2012:01:24:27 +0200] cupsdAcceptClient: skipping getpeercon()
>D [12/Apr/2012:01:24:27 +0200] cupsdAcceptClient: 20 from localhost (Domain)
>D [12/Apr/2012:01:24:27 +0200] [Notifier] state=3
>D [12/Apr/2012:01:24:27 +0200] [Notifier] PrinterStateChanged
>D [12/Apr/2012:01:24:27 +0200] cupsdReadClient: 20 POST / HTTP/1.1
>D [12/Apr/2012:01:24:27 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
>D [12/Apr/2012:01:24:27 +0200] cupsdAuthorize: No authentication data provided.
>D [12/Apr/2012:01:24:27 +0200] cupsdReadClient: 20 1.1 Get-Job-Attributes 1
>D [12/Apr/2012:01:24:27 +0200] Get-Job-Attributes ipp://localhost/jobs/38
>D [12/Apr/2012:01:24:27 +0200] Returning IPP successful-ok for Get-Job-Attributes (ipp://localhost/jobs/38) from localhost
>D [12/Apr/2012:01:24:27 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
>D [12/Apr/2012:01:24:27 +0200] [Job 38] Page = 595x842; 12,12 to 583,830
>D [12/Apr/2012:01:24:27 +0200] [Job 38] Page = 595x842; 12,12 to 583,830
>D [12/Apr/2012:01:24:27 +0200] [Job 38] slow_collate=0, slow_duplex=0, slow_order=0
>D [12/Apr/2012:01:24:27 +0200] [Job 38] Before copy_comments - %!PS-Adobe-3.0
>D [12/Apr/2012:01:24:27 +0200] [Job 38] %!PS-Adobe-3.0
>D [12/Apr/2012:01:24:27 +0200] [Job 38] %%BoundingBox: 12 12 583 830
>D [12/Apr/2012:01:24:27 +0200] [Job 38] %cupsRotation: 0
>D [12/Apr/2012:01:24:27 +0200] [Job 38] %%Creator: bannertops/CUPS v1.5.2
>D [12/Apr/2012:01:24:27 +0200] [Job 38] %%CreationDate: Thu 12 Apr 2012 01:24:27 AM CEST
>D [12/Apr/2012:01:24:27 +0200] [Job 38] %%LanguageLevel: 2
>D [12/Apr/2012:01:24:27 +0200] [Job 38] %%DocumentData: Clean7Bit
>D [12/Apr/2012:01:24:27 +0200] [Job 38] %%Title: (Test Page)
>D [12/Apr/2012:01:24:27 +0200] [Job 38] %%For: (root)
>D [12/Apr/2012:01:24:27 +0200] [Job 38] %%Pages: 1
>D [12/Apr/2012:01:24:27 +0200] [Job 38] %%DocumentSuppliedResources: font Monospace
>D [12/Apr/2012:01:24:27 +0200] [Job 38] %%+ font Monospace-Bold
>D [12/Apr/2012:01:24:27 +0200] [Job 38] %%+ font Monospace-BoldOblique
>D [12/Apr/2012:01:24:27 +0200] [Job 38] %%+ font Monospace-Oblique
>D [12/Apr/2012:01:24:27 +0200] [Job 38] %%EndComments
>D [12/Apr/2012:01:24:27 +0200] [Job 38] Before copy_prolog - %%BeginProlog
>D [12/Apr/2012:01:24:29 +0200] cupsdReadClient: 17 GET /printers/ccc3 HTTP/1.1
>D [12/Apr/2012:01:24:29 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
>D [12/Apr/2012:01:24:29 +0200] cupsdAuthorize: Authorized as root using Basic
>D [12/Apr/2012:01:24:29 +0200] [CGI] argv[0] = "/usr/lib/cups/cgi-bin/printers.cgi"
>D [12/Apr/2012:01:24:29 +0200] [CGI] envp[0] = "CUPS_CACHEDIR=/var/cache/cups"
>D [12/Apr/2012:01:24:29 +0200] [CGI] envp[1] = "CUPS_DATADIR=/usr/share/cups"
>D [12/Apr/2012:01:24:29 +0200] [CGI] envp[2] = "CUPS_DOCROOT=/usr/share/cups/www"
>D [12/Apr/2012:01:24:29 +0200] [CGI] envp[3] = "CUPS_FONTPATH=/usr/share/cups/fonts"
>D [12/Apr/2012:01:24:29 +0200] [CGI] envp[4] = "CUPS_REQUESTROOT=/var/spool/cups"
>D [12/Apr/2012:01:24:29 +0200] [CGI] envp[5] = "CUPS_SERVERBIN=/usr/lib/cups"
>D [12/Apr/2012:01:24:29 +0200] [CGI] envp[6] = "CUPS_SERVERROOT=/etc/cups"
>D [12/Apr/2012:01:24:29 +0200] [CGI] envp[7] = "CUPS_STATEDIR=/var/run/cups"
>D [12/Apr/2012:01:24:29 +0200] [CGI] envp[8] = "HOME=/var/spool/cups/tmp"
>D [12/Apr/2012:01:24:29 +0200] [CGI] envp[9] = "PATH=/usr/lib/cups/filter:/usr/lib64/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
>D [12/Apr/2012:01:24:29 +0200] [CGI] envp[10] = "SERVER_ADMIN=root@mypc"
>D [12/Apr/2012:01:24:29 +0200] [CGI] envp[11] = "SOFTWARE=CUPS/1.5.2"
>D [12/Apr/2012:01:24:29 +0200] [CGI] envp[12] = "TMPDIR=/var/spool/cups/tmp"
>D [12/Apr/2012:01:24:29 +0200] [CGI] envp[13] = "USER=root"
>D [12/Apr/2012:01:24:29 +0200] [CGI] envp[14] = "CUPS_SERVER=/var/run/cups/cups.sock"
>D [12/Apr/2012:01:24:29 +0200] [CGI] envp[15] = "CUPS_ENCRYPTION=IfRequested"
>D [12/Apr/2012:01:24:29 +0200] [CGI] envp[16] = "IPP_PORT=631"
>D [12/Apr/2012:01:24:29 +0200] [CGI] envp[17] = "AUTH_TYPE=Basic"
>D [12/Apr/2012:01:24:29 +0200] [CGI] envp[18] = "LANG=en_US.UTF8"
>D [12/Apr/2012:01:24:29 +0200] [CGI] envp[19] = "REDIRECT_STATUS=1"
>D [12/Apr/2012:01:24:29 +0200] [CGI] envp[20] = "GATEWAY_INTERFACE=CGI/1.1"
>D [12/Apr/2012:01:24:29 +0200] [CGI] envp[21] = "SERVER_NAME=localhost"
>D [12/Apr/2012:01:24:29 +0200] [CGI] envp[22] = "SERVER_PORT=631"
>D [12/Apr/2012:01:24:29 +0200] [CGI] envp[23] = "REMOTE_ADDR=[v1.::1]"
>D [12/Apr/2012:01:24:29 +0200] [CGI] envp[24] = "REMOTE_HOST=localhost"
>D [12/Apr/2012:01:24:29 +0200] [CGI] envp[25] = "SCRIPT_NAME=/printers/ccc3"
>D [12/Apr/2012:01:24:29 +0200] [CGI] envp[26] = "SCRIPT_FILENAME=/usr/share/cups/www/printers/ccc3"
>D [12/Apr/2012:01:24:29 +0200] [CGI] envp[27] = "PATH_INFO=/ccc3"
>D [12/Apr/2012:01:24:29 +0200] [CGI] envp[28] = "REMOTE_USER=root"
>D [12/Apr/2012:01:24:29 +0200] [CGI] envp[29] = "SERVER_PROTOCOL=HTTP/1.1"
>D [12/Apr/2012:01:24:29 +0200] [CGI] envp[30] = "HTTP_COOKIE=org.cups.sid=b545ab5ead0b18efc1fd9b66d86609d6"
>D [12/Apr/2012:01:24:29 +0200] [CGI] envp[31] = "HTTP_USER_AGENT=Mozilla/5.0 (X11; Linux x86_64; rv:11.0) Gecko/20100101 Firefox/11.0"
>D [12/Apr/2012:01:24:29 +0200] [CGI] envp[32] = "HTTP_REFERER=http://localhost:631/printers/ccc3"
>D [12/Apr/2012:01:24:29 +0200] [CGI] envp[33] = "REQUEST_METHOD=GET"
>D [12/Apr/2012:01:24:29 +0200] [CGI] envp[34] = "QUERY_STRING="
>D [12/Apr/2012:01:24:29 +0200] [CGI] Started /usr/lib/cups/cgi-bin/printers.cgi (PID 6423)
>I [12/Apr/2012:01:24:29 +0200] Started "/usr/lib/cups/cgi-bin/printers.cgi" (pid=6423)
>D [12/Apr/2012:01:24:29 +0200] cupsdSendCommand: 17 file=24
>D [12/Apr/2012:01:24:29 +0200] [CGI] org.cups.sid cookie is "b545ab5ead0b18efc1fd9b66d86609d6"
>D [12/Apr/2012:01:24:29 +0200] cupsdAcceptClient: skipping getpeercon()
>D [12/Apr/2012:01:24:29 +0200] cupsdAcceptClient: 25 from localhost (Domain)
>D [12/Apr/2012:01:24:29 +0200] cupsdReadClient: 25 POST / HTTP/1.1
>D [12/Apr/2012:01:24:29 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
>D [12/Apr/2012:01:24:29 +0200] cupsdAuthorize: No authentication data provided.
>D [12/Apr/2012:01:24:29 +0200] cupsdReadClient: 25 1.1 CUPS-Get-Default 1
>D [12/Apr/2012:01:24:29 +0200] CUPS-Get-Default
>D [12/Apr/2012:01:24:29 +0200] CUPS-Get-Default client-error-not-found: No default printer.
>D [12/Apr/2012:01:24:29 +0200] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost
>D [12/Apr/2012:01:24:29 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
>D [12/Apr/2012:01:24:29 +0200] [CGI] show_printer(http=0x7fa3c90dfbb0, printer="ccc3")
>D [12/Apr/2012:01:24:29 +0200] cupsdReadClient: 25 POST / HTTP/1.1
>D [12/Apr/2012:01:24:29 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
>D [12/Apr/2012:01:24:29 +0200] cupsdAuthorize: No authentication data provided.
>D [12/Apr/2012:01:24:29 +0200] cupsdReadClient: 25 1.1 Get-Printer-Attributes 1
>D [12/Apr/2012:01:24:29 +0200] Get-Printer-Attributes ipp://localhost/printers/ccc3
>D [12/Apr/2012:01:24:29 +0200] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/ccc3) from localhost
>D [12/Apr/2012:01:24:29 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
>D [12/Apr/2012:01:24:29 +0200] Script header: Content-Type: text/html;charset=utf-8
>D [12/Apr/2012:01:24:29 +0200] Script header: 
>D [12/Apr/2012:01:24:29 +0200] [CGI] Regular expression ".*Clean.*"
>D [12/Apr/2012:01:24:29 +0200] [CGI] matches[0].rm_so=0
>D [12/Apr/2012:01:24:29 +0200] [CGI] matches[1].rm_so=-1
>D [12/Apr/2012:01:24:29 +0200] [CGI] Regular expression ".*PrintSelfTestPage.*"
>D [12/Apr/2012:01:24:29 +0200] [CGI] matches[0].rm_so=0
>D [12/Apr/2012:01:24:29 +0200] [CGI] matches[1].rm_so=-1
>D [12/Apr/2012:01:24:29 +0200] cupsdReadClient: 25 POST / HTTP/1.1
>D [12/Apr/2012:01:24:29 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
>D [12/Apr/2012:01:24:29 +0200] cupsdAuthorize: No authentication data provided.
>D [12/Apr/2012:01:24:29 +0200] cupsdReadClient: 25 1.1 Get-Jobs 1
>D [12/Apr/2012:01:24:29 +0200] Get-Jobs ipp://localhost:631/printers/ccc3
>D [12/Apr/2012:01:24:29 +0200] Returning IPP successful-ok for Get-Jobs (ipp://localhost:631/printers/ccc3) from localhost
>D [12/Apr/2012:01:24:29 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
>D [12/Apr/2012:01:24:29 +0200] cupsdReadClient: 25 WAITING Closing on EOF
>D [12/Apr/2012:01:24:29 +0200] cupsdCloseClient: 25
>D [12/Apr/2012:01:24:29 +0200] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
>D [12/Apr/2012:01:24:29 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
>D [12/Apr/2012:01:24:29 +0200] PID 6423 (/usr/lib/cups/cgi-bin/printers.cgi) exited with no errors.
>D [12/Apr/2012:01:24:31 +0200] [Job 38] prtGeneralCurrentLocalization type is 0, expected 2!
>D [12/Apr/2012:01:24:31 +0200] [Job 38] backendWaitLoop(snmp_fd=6, addr=0x7fc7151b53c8, side_cb=0x7fc714c6db90)
>D [12/Apr/2012:01:24:31 +0200] [Job 38] Connecting to myprintserver:443
>I [12/Apr/2012:01:24:31 +0200] [Job 38] Connecting to printer.
>D [12/Apr/2012:01:24:31 +0200] [Job 38] Set job-printer-state-message to "Connecting to printer.", current level=INFO
>D [12/Apr/2012:01:24:31 +0200] Discarding unused job-progress event...
>D [12/Apr/2012:01:24:31 +0200] cupsdMarkDirty(-----S)
>D [12/Apr/2012:01:24:31 +0200] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
>D [12/Apr/2012:01:24:31 +0200] [Notifier] state=3
>D [12/Apr/2012:01:24:31 +0200] [Notifier] PrinterStateChanged
>D [12/Apr/2012:01:24:31 +0200] [Job 38] update_reasons(attr=0(), s="-cups-certificate-error")
>D [12/Apr/2012:01:24:31 +0200] [Job 38] update_reasons(attr=0(), s="-connecting-to-device")
>D [12/Apr/2012:01:24:31 +0200] [Job 38] STATE: -connecting-to-device
>D [12/Apr/2012:01:24:31 +0200] cupsdMarkDirty(-----S)
>D [12/Apr/2012:01:24:31 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Dirty files"
>I [12/Apr/2012:01:24:31 +0200] [Job 38] Connected to printer.
>D [12/Apr/2012:01:24:31 +0200] [Job 38] Set job-printer-state-message to "Connected to printer.", current level=INFO
>D [12/Apr/2012:01:24:31 +0200] [Job 38] Connected to 10.4.1.150:443...
>D [12/Apr/2012:01:24:31 +0200] [Job 38] Getting supported attributes...
>D [12/Apr/2012:01:24:31 +0200] Discarding unused job-progress event...
>D [12/Apr/2012:01:24:31 +0200] cupsdMarkDirty(-----S)
>D [12/Apr/2012:01:24:31 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
>D [12/Apr/2012:01:24:31 +0200] [Notifier] state=3
>D [12/Apr/2012:01:24:31 +0200] [Notifier] PrinterStateChanged
>D [12/Apr/2012:01:24:31 +0200] [Notifier] state=3
>D [12/Apr/2012:01:24:31 +0200] [Notifier] PrinterStateChanged
>D [12/Apr/2012:01:24:31 +0200] [Job 38] Get-Printer-Attributes: cups-authorization-canceled (Unauthorized)
>D [12/Apr/2012:01:24:31 +0200] [Job 38] Get-Printer-Attributes returned cups-authorization-canceled.
>E [12/Apr/2012:01:24:31 +0200] [Job 38] Unable to get printer status.
>D [12/Apr/2012:01:24:31 +0200] [Job 38] Set job-printer-state-message to "Unable to get printer status.", current level=ERROR
>D [12/Apr/2012:01:24:31 +0200] Discarding unused job-progress event...
>D [12/Apr/2012:01:24:31 +0200] cupsdMarkDirty(-----S)
>D [12/Apr/2012:01:24:31 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files"
>D [12/Apr/2012:01:24:31 +0200] [Notifier] state=3
>D [12/Apr/2012:01:24:31 +0200] [Notifier] PrinterStateChanged
>D [12/Apr/2012:01:24:39 +0200] cupsdReadClient: 17 GET /printers/ccc3 HTTP/1.1
>D [12/Apr/2012:01:24:39 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
>D [12/Apr/2012:01:24:39 +0200] cupsdAuthorize: Authorized as root using Basic
>D [12/Apr/2012:01:24:39 +0200] [CGI] argv[0] = "/usr/lib/cups/cgi-bin/printers.cgi"
>D [12/Apr/2012:01:24:39 +0200] [CGI] envp[0] = "CUPS_CACHEDIR=/var/cache/cups"
>D [12/Apr/2012:01:24:39 +0200] [CGI] envp[1] = "CUPS_DATADIR=/usr/share/cups"
>D [12/Apr/2012:01:24:39 +0200] [CGI] envp[2] = "CUPS_DOCROOT=/usr/share/cups/www"
>D [12/Apr/2012:01:24:39 +0200] [CGI] envp[3] = "CUPS_FONTPATH=/usr/share/cups/fonts"
>D [12/Apr/2012:01:24:39 +0200] [CGI] envp[4] = "CUPS_REQUESTROOT=/var/spool/cups"
>D [12/Apr/2012:01:24:39 +0200] [CGI] envp[5] = "CUPS_SERVERBIN=/usr/lib/cups"
>D [12/Apr/2012:01:24:39 +0200] [CGI] envp[6] = "CUPS_SERVERROOT=/etc/cups"
>D [12/Apr/2012:01:24:39 +0200] [CGI] envp[7] = "CUPS_STATEDIR=/var/run/cups"
>D [12/Apr/2012:01:24:39 +0200] [CGI] envp[8] = "HOME=/var/spool/cups/tmp"
>D [12/Apr/2012:01:24:39 +0200] [CGI] envp[9] = "PATH=/usr/lib/cups/filter:/usr/lib64/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
>D [12/Apr/2012:01:24:39 +0200] [CGI] envp[10] = "SERVER_ADMIN=root@mypc"
>D [12/Apr/2012:01:24:39 +0200] [CGI] envp[11] = "SOFTWARE=CUPS/1.5.2"
>D [12/Apr/2012:01:24:39 +0200] [CGI] envp[12] = "TMPDIR=/var/spool/cups/tmp"
>D [12/Apr/2012:01:24:39 +0200] [CGI] envp[13] = "USER=root"
>D [12/Apr/2012:01:24:39 +0200] [CGI] envp[14] = "CUPS_SERVER=/var/run/cups/cups.sock"
>D [12/Apr/2012:01:24:39 +0200] [CGI] envp[15] = "CUPS_ENCRYPTION=IfRequested"
>D [12/Apr/2012:01:24:39 +0200] [CGI] envp[16] = "IPP_PORT=631"
>D [12/Apr/2012:01:24:39 +0200] [CGI] envp[17] = "AUTH_TYPE=Basic"
>D [12/Apr/2012:01:24:39 +0200] [CGI] envp[18] = "LANG=en_US.UTF8"
>D [12/Apr/2012:01:24:39 +0200] [CGI] envp[19] = "REDIRECT_STATUS=1"
>D [12/Apr/2012:01:24:39 +0200] [CGI] envp[20] = "GATEWAY_INTERFACE=CGI/1.1"
>D [12/Apr/2012:01:24:39 +0200] [CGI] envp[21] = "SERVER_NAME=localhost"
>D [12/Apr/2012:01:24:39 +0200] [CGI] envp[22] = "SERVER_PORT=631"
>D [12/Apr/2012:01:24:39 +0200] [CGI] envp[23] = "REMOTE_ADDR=[v1.::1]"
>D [12/Apr/2012:01:24:39 +0200] [CGI] envp[24] = "REMOTE_HOST=localhost"
>D [12/Apr/2012:01:24:39 +0200] [CGI] envp[25] = "SCRIPT_NAME=/printers/ccc3"
>D [12/Apr/2012:01:24:39 +0200] [CGI] envp[26] = "SCRIPT_FILENAME=/usr/share/cups/www/printers/ccc3"
>D [12/Apr/2012:01:24:39 +0200] [CGI] envp[27] = "PATH_INFO=/ccc3"
>D [12/Apr/2012:01:24:39 +0200] [CGI] envp[28] = "REMOTE_USER=root"
>D [12/Apr/2012:01:24:39 +0200] [CGI] envp[29] = "SERVER_PROTOCOL=HTTP/1.1"
>D [12/Apr/2012:01:24:39 +0200] [CGI] envp[30] = "HTTP_COOKIE=org.cups.sid=b545ab5ead0b18efc1fd9b66d86609d6"
>D [12/Apr/2012:01:24:39 +0200] [CGI] envp[31] = "HTTP_USER_AGENT=Mozilla/5.0 (X11; Linux x86_64; rv:11.0) Gecko/20100101 Firefox/11.0"
>D [12/Apr/2012:01:24:39 +0200] [CGI] envp[32] = "REQUEST_METHOD=GET"
>D [12/Apr/2012:01:24:39 +0200] [CGI] envp[33] = "QUERY_STRING="
>D [12/Apr/2012:01:24:39 +0200] [CGI] Started /usr/lib/cups/cgi-bin/printers.cgi (PID 6433)
>I [12/Apr/2012:01:24:39 +0200] Started "/usr/lib/cups/cgi-bin/printers.cgi" (pid=6433)
>D [12/Apr/2012:01:24:39 +0200] cupsdSendCommand: 17 file=24
>D [12/Apr/2012:01:24:39 +0200] [CGI] org.cups.sid cookie is "b545ab5ead0b18efc1fd9b66d86609d6"
>D [12/Apr/2012:01:24:39 +0200] cupsdAcceptClient: skipping getpeercon()
>D [12/Apr/2012:01:24:39 +0200] cupsdAcceptClient: 25 from localhost (Domain)
>D [12/Apr/2012:01:24:39 +0200] cupsdReadClient: 25 POST / HTTP/1.1
>D [12/Apr/2012:01:24:39 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
>D [12/Apr/2012:01:24:39 +0200] cupsdAuthorize: No authentication data provided.
>D [12/Apr/2012:01:24:39 +0200] cupsdReadClient: 25 1.1 CUPS-Get-Default 1
>D [12/Apr/2012:01:24:39 +0200] CUPS-Get-Default
>D [12/Apr/2012:01:24:39 +0200] CUPS-Get-Default client-error-not-found: No default printer.
>D [12/Apr/2012:01:24:39 +0200] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost
>D [12/Apr/2012:01:24:39 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
>D [12/Apr/2012:01:24:39 +0200] [CGI] show_printer(http=0x7fbc39f0fbb0, printer="ccc3")
>D [12/Apr/2012:01:24:39 +0200] cupsdReadClient: 25 POST / HTTP/1.1
>D [12/Apr/2012:01:24:39 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
>D [12/Apr/2012:01:24:39 +0200] cupsdAuthorize: No authentication data provided.
>D [12/Apr/2012:01:24:39 +0200] cupsdReadClient: 25 1.1 Get-Printer-Attributes 1
>D [12/Apr/2012:01:24:39 +0200] Get-Printer-Attributes ipp://localhost/printers/ccc3
>D [12/Apr/2012:01:24:39 +0200] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/ccc3) from localhost
>D [12/Apr/2012:01:24:39 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
>D [12/Apr/2012:01:24:39 +0200] Script header: Content-Type: text/html;charset=utf-8
>D [12/Apr/2012:01:24:39 +0200] Script header: 
>D [12/Apr/2012:01:24:39 +0200] [CGI] Regular expression ".*Clean.*"
>D [12/Apr/2012:01:24:39 +0200] [CGI] matches[0].rm_so=0
>D [12/Apr/2012:01:24:39 +0200] [CGI] matches[1].rm_so=-1
>D [12/Apr/2012:01:24:39 +0200] [CGI] Regular expression ".*PrintSelfTestPage.*"
>D [12/Apr/2012:01:24:39 +0200] [CGI] matches[0].rm_so=0
>D [12/Apr/2012:01:24:39 +0200] [CGI] matches[1].rm_so=-1
>D [12/Apr/2012:01:24:39 +0200] cupsdReadClient: 25 POST / HTTP/1.1
>D [12/Apr/2012:01:24:39 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
>D [12/Apr/2012:01:24:39 +0200] cupsdAuthorize: No authentication data provided.
>D [12/Apr/2012:01:24:39 +0200] cupsdReadClient: 25 1.1 Get-Jobs 1
>D [12/Apr/2012:01:24:39 +0200] Get-Jobs ipp://localhost:631/printers/ccc3
>D [12/Apr/2012:01:24:39 +0200] Returning IPP successful-ok for Get-Jobs (ipp://localhost:631/printers/ccc3) from localhost
>D [12/Apr/2012:01:24:39 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
>D [12/Apr/2012:01:24:39 +0200] cupsdReadClient: 25 WAITING Closing on EOF
>D [12/Apr/2012:01:24:39 +0200] cupsdCloseClient: 25
>D [12/Apr/2012:01:24:39 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
>D [12/Apr/2012:01:24:39 +0200] PID 6433 (/usr/lib/cups/cgi-bin/printers.cgi) exited with no errors.
>D [12/Apr/2012:01:24:39 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
>D [12/Apr/2012:01:24:39 +0200] cupsdReadClient: 17 GET /cups.css HTTP/1.1
>D [12/Apr/2012:01:24:39 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
>D [12/Apr/2012:01:24:39 +0200] cupsdAuthorize: Authorized as root using Basic
>D [12/Apr/2012:01:24:39 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
>D [12/Apr/2012:01:24:39 +0200] cupsdAcceptClient: skipping getpeercon()
>D [12/Apr/2012:01:24:39 +0200] cupsdAcceptClient: 24 from localhost:631 (IPv6)
>D [12/Apr/2012:01:24:39 +0200] cupsdAcceptClient: skipping getpeercon()
>D [12/Apr/2012:01:24:39 +0200] cupsdAcceptClient: 25 from localhost:631 (IPv6)
>D [12/Apr/2012:01:24:39 +0200] cupsdReadClient: 24 GET /images/left.gif HTTP/1.1
>D [12/Apr/2012:01:24:39 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
>D [12/Apr/2012:01:24:39 +0200] cupsdAuthorize: Authorized as root using Basic
>D [12/Apr/2012:01:24:39 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
>D [12/Apr/2012:01:24:39 +0200] cupsdAcceptClient: skipping getpeercon()
>D [12/Apr/2012:01:24:39 +0200] cupsdAcceptClient: 26 from localhost:631 (IPv6)
>D [12/Apr/2012:01:24:39 +0200] cupsdReadClient: 25 GET /images/right.gif HTTP/1.1
>D [12/Apr/2012:01:24:39 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
>D [12/Apr/2012:01:24:39 +0200] cupsdAuthorize: Authorized as root using Basic
>D [12/Apr/2012:01:24:39 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
>D [12/Apr/2012:01:24:39 +0200] cupsdReadClient: 17 GET /images/unsel.gif HTTP/1.1
>D [12/Apr/2012:01:24:39 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
>D [12/Apr/2012:01:24:39 +0200] cupsdAuthorize: Authorized as root using Basic
>D [12/Apr/2012:01:24:39 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
>D [12/Apr/2012:01:24:39 +0200] cupsdReadClient: 26 GET /images/sel.gif HTTP/1.1
>D [12/Apr/2012:01:24:39 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
>D [12/Apr/2012:01:24:39 +0200] cupsdAuthorize: Authorized as root using Basic
>D [12/Apr/2012:01:24:39 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
>D [12/Apr/2012:01:24:41 +0200] [Job 38] Getting supported attributes...
>D [12/Apr/2012:01:24:49 +0200] cupsdReadClient: 17 GET /printers/ccc3 HTTP/1.1
>D [12/Apr/2012:01:24:49 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
>D [12/Apr/2012:01:24:49 +0200] cupsdAuthorize: Authorized as root using Basic
>D [12/Apr/2012:01:24:49 +0200] [CGI] argv[0] = "/usr/lib/cups/cgi-bin/printers.cgi"
>D [12/Apr/2012:01:24:49 +0200] [CGI] envp[0] = "CUPS_CACHEDIR=/var/cache/cups"
>D [12/Apr/2012:01:24:49 +0200] [CGI] envp[1] = "CUPS_DATADIR=/usr/share/cups"
>D [12/Apr/2012:01:24:49 +0200] [CGI] envp[2] = "CUPS_DOCROOT=/usr/share/cups/www"
>D [12/Apr/2012:01:24:49 +0200] [CGI] envp[3] = "CUPS_FONTPATH=/usr/share/cups/fonts"
>D [12/Apr/2012:01:24:49 +0200] [CGI] envp[4] = "CUPS_REQUESTROOT=/var/spool/cups"
>D [12/Apr/2012:01:24:49 +0200] [CGI] envp[5] = "CUPS_SERVERBIN=/usr/lib/cups"
>D [12/Apr/2012:01:24:49 +0200] [CGI] envp[6] = "CUPS_SERVERROOT=/etc/cups"
>D [12/Apr/2012:01:24:49 +0200] [CGI] envp[7] = "CUPS_STATEDIR=/var/run/cups"
>D [12/Apr/2012:01:24:49 +0200] [CGI] envp[8] = "HOME=/var/spool/cups/tmp"
>D [12/Apr/2012:01:24:49 +0200] [CGI] envp[9] = "PATH=/usr/lib/cups/filter:/usr/lib64/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
>D [12/Apr/2012:01:24:49 +0200] [CGI] envp[10] = "SERVER_ADMIN=root@mypc"
>D [12/Apr/2012:01:24:49 +0200] [CGI] envp[11] = "SOFTWARE=CUPS/1.5.2"
>D [12/Apr/2012:01:24:49 +0200] [CGI] envp[12] = "TMPDIR=/var/spool/cups/tmp"
>D [12/Apr/2012:01:24:49 +0200] [CGI] envp[13] = "USER=root"
>D [12/Apr/2012:01:24:49 +0200] [CGI] envp[14] = "CUPS_SERVER=/var/run/cups/cups.sock"
>D [12/Apr/2012:01:24:49 +0200] [CGI] envp[15] = "CUPS_ENCRYPTION=IfRequested"
>D [12/Apr/2012:01:24:49 +0200] [CGI] envp[16] = "IPP_PORT=631"
>D [12/Apr/2012:01:24:49 +0200] [CGI] envp[17] = "AUTH_TYPE=Basic"
>D [12/Apr/2012:01:24:49 +0200] [CGI] envp[18] = "LANG=en_US.UTF8"
>D [12/Apr/2012:01:24:49 +0200] [CGI] envp[19] = "REDIRECT_STATUS=1"
>D [12/Apr/2012:01:24:49 +0200] [CGI] envp[20] = "GATEWAY_INTERFACE=CGI/1.1"
>D [12/Apr/2012:01:24:49 +0200] [CGI] envp[21] = "SERVER_NAME=localhost"
>D [12/Apr/2012:01:24:49 +0200] [CGI] envp[22] = "SERVER_PORT=631"
>D [12/Apr/2012:01:24:49 +0200] [CGI] envp[23] = "REMOTE_ADDR=[v1.::1]"
>D [12/Apr/2012:01:24:49 +0200] [CGI] envp[24] = "REMOTE_HOST=localhost"
>D [12/Apr/2012:01:24:49 +0200] [CGI] envp[25] = "SCRIPT_NAME=/printers/ccc3"
>D [12/Apr/2012:01:24:49 +0200] [CGI] envp[26] = "SCRIPT_FILENAME=/usr/share/cups/www/printers/ccc3"
>D [12/Apr/2012:01:24:49 +0200] [CGI] envp[27] = "PATH_INFO=/ccc3"
>D [12/Apr/2012:01:24:49 +0200] [CGI] envp[28] = "REMOTE_USER=root"
>D [12/Apr/2012:01:24:49 +0200] [CGI] envp[29] = "SERVER_PROTOCOL=HTTP/1.1"
>D [12/Apr/2012:01:24:49 +0200] [CGI] envp[30] = "HTTP_COOKIE=org.cups.sid=b545ab5ead0b18efc1fd9b66d86609d6"
>D [12/Apr/2012:01:24:49 +0200] [CGI] envp[31] = "HTTP_USER_AGENT=Mozilla/5.0 (X11; Linux x86_64; rv:11.0) Gecko/20100101 Firefox/11.0"
>D [12/Apr/2012:01:24:49 +0200] [CGI] envp[32] = "REQUEST_METHOD=GET"
>D [12/Apr/2012:01:24:49 +0200] [CGI] envp[33] = "QUERY_STRING="
>D [12/Apr/2012:01:24:49 +0200] [CGI] Started /usr/lib/cups/cgi-bin/printers.cgi (PID 6434)
>I [12/Apr/2012:01:24:49 +0200] Started "/usr/lib/cups/cgi-bin/printers.cgi" (pid=6434)
>D [12/Apr/2012:01:24:49 +0200] cupsdSendCommand: 17 file=27
>D [12/Apr/2012:01:24:49 +0200] [CGI] org.cups.sid cookie is "b545ab5ead0b18efc1fd9b66d86609d6"
>D [12/Apr/2012:01:24:49 +0200] cupsdAcceptClient: skipping getpeercon()
>D [12/Apr/2012:01:24:49 +0200] cupsdAcceptClient: 28 from localhost (Domain)
>D [12/Apr/2012:01:24:49 +0200] cupsdReadClient: 28 POST / HTTP/1.1
>D [12/Apr/2012:01:24:49 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
>D [12/Apr/2012:01:24:49 +0200] cupsdAuthorize: No authentication data provided.
>D [12/Apr/2012:01:24:49 +0200] cupsdReadClient: 28 1.1 CUPS-Get-Default 1
>D [12/Apr/2012:01:24:49 +0200] CUPS-Get-Default
>D [12/Apr/2012:01:24:49 +0200] CUPS-Get-Default client-error-not-found: No default printer.
>D [12/Apr/2012:01:24:49 +0200] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost
>D [12/Apr/2012:01:24:49 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
>D [12/Apr/2012:01:24:49 +0200] [CGI] show_printer(http=0x7fdfa8983bb0, printer="ccc3")
>D [12/Apr/2012:01:24:49 +0200] cupsdReadClient: 28 POST / HTTP/1.1
>D [12/Apr/2012:01:24:49 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
>D [12/Apr/2012:01:24:49 +0200] cupsdAuthorize: No authentication data provided.
>D [12/Apr/2012:01:24:49 +0200] cupsdReadClient: 28 1.1 Get-Printer-Attributes 1
>D [12/Apr/2012:01:24:49 +0200] Get-Printer-Attributes ipp://localhost/printers/ccc3
>D [12/Apr/2012:01:24:49 +0200] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/ccc3) from localhost
>D [12/Apr/2012:01:24:49 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
>D [12/Apr/2012:01:24:49 +0200] Script header: Content-Type: text/html;charset=utf-8
>D [12/Apr/2012:01:24:49 +0200] Script header: 
>D [12/Apr/2012:01:24:49 +0200] [CGI] Regular expression ".*Clean.*"
>D [12/Apr/2012:01:24:49 +0200] [CGI] matches[0].rm_so=0
>D [12/Apr/2012:01:24:49 +0200] [CGI] matches[1].rm_so=-1
>D [12/Apr/2012:01:24:49 +0200] [CGI] Regular expression ".*PrintSelfTestPage.*"
>D [12/Apr/2012:01:24:49 +0200] [CGI] matches[0].rm_so=0
>D [12/Apr/2012:01:24:49 +0200] [CGI] matches[1].rm_so=-1
>D [12/Apr/2012:01:24:49 +0200] cupsdReadClient: 28 POST / HTTP/1.1
>D [12/Apr/2012:01:24:49 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
>D [12/Apr/2012:01:24:49 +0200] cupsdAuthorize: No authentication data provided.
>D [12/Apr/2012:01:24:49 +0200] cupsdReadClient: 28 1.1 Get-Jobs 1
>D [12/Apr/2012:01:24:49 +0200] Get-Jobs ipp://localhost:631/printers/ccc3
>D [12/Apr/2012:01:24:49 +0200] Returning IPP successful-ok for Get-Jobs (ipp://localhost:631/printers/ccc3) from localhost
>D [12/Apr/2012:01:24:49 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
>D [12/Apr/2012:01:24:49 +0200] cupsdReadClient: 28 WAITING Closing on EOF
>D [12/Apr/2012:01:24:49 +0200] cupsdCloseClient: 28
>D [12/Apr/2012:01:24:49 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
>D [12/Apr/2012:01:24:49 +0200] PID 6434 (/usr/lib/cups/cgi-bin/printers.cgi) exited with no errors.
>D [12/Apr/2012:01:24:49 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
>D [12/Apr/2012:01:24:49 +0200] cupsdReadClient: 17 GET /cups.css HTTP/1.1
>D [12/Apr/2012:01:24:49 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
>D [12/Apr/2012:01:24:49 +0200] cupsdAuthorize: Authorized as root using Basic
>D [12/Apr/2012:01:24:49 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
>D [12/Apr/2012:01:24:49 +0200] cupsdReadClient: 24 GET /images/left.gif HTTP/1.1
>D [12/Apr/2012:01:24:49 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
>D [12/Apr/2012:01:24:49 +0200] cupsdAuthorize: Authorized as root using Basic
>D [12/Apr/2012:01:24:49 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
>D [12/Apr/2012:01:24:49 +0200] cupsdReadClient: 25 GET /images/right.gif HTTP/1.1
>D [12/Apr/2012:01:24:49 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
>D [12/Apr/2012:01:24:49 +0200] cupsdAuthorize: Authorized as root using Basic
>D [12/Apr/2012:01:24:49 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
>D [12/Apr/2012:01:24:49 +0200] cupsdReadClient: 17 GET /images/unsel.gif HTTP/1.1
>D [12/Apr/2012:01:24:49 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
>D [12/Apr/2012:01:24:49 +0200] cupsdAuthorize: Authorized as root using Basic
>D [12/Apr/2012:01:24:49 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
>D [12/Apr/2012:01:24:49 +0200] cupsdReadClient: 26 GET /images/sel.gif HTTP/1.1
>D [12/Apr/2012:01:24:49 +0200] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Printing jobs and dirty files"
>D [12/Apr/2012:01:24:49 +0200] cupsdAuthorize: Authorized as root using Basic
>D [12/Apr/2012:01:24:49 +0200] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"

Actions: View

Attachments on bug 810007: 576708 | 576709 | 576916 | 577116 | 577187 | 577189 | 577190