[cups-devel] print appears to be successful, but no output

Dean Guenther guenther at palousecom.com
Wed Mar 5 18:34:33 PST 2014


I have cupsd 1.4.2 running on a CentOS 6.5 box. I have an HP Psc 1200
printer attached to USB connection. When I print to the printer from the
CentOS box, it goes through. But when I print remotely from a windows 7
box, it appears to be successful, Eg no errors that I detect. But no print
actually gets sent to the printer.

>From the Windows 7 box, I am able to use the print interface:

    http://192.168.0.2:631/admin

>From this printer

    http://192.168.0.2:631/admin

this is what shows:

   Description:	Hewlett-Packard psc 1200 series
   Location:	localhost.localdomain
   Driver:	HP PSC 1200 Series, hpcups 3.12.4 (color)
   Connection:	usb://HP/psc%201200%20series?serial=MY36CC941Q5H
   Defaults:	job-sheets=none, none media=na_letter_8.5x11in

So then I send a print job and it seems to go through, but nothing
actually prints.

In the access_log it looks good:

192.168.0.144 - - [05/Mar/2014:06:58:11 -0800] "POST
/printers/psc-1200-series HTTP/1.1" 200 233592 Print-Job successful-ok

In the page_log it looks good:

psc-1200-series 6 Mary [05/Mar/2014:06:58:13 -0800] 1 1 - 192.168.0.144
PCS_BOYD-1 - -

When I show completed jobs it is there (the second job from "root" was
printed locally from the root account on the CentOS box):

psc-1200-series-6  	PCS_BOYD-1  	Mary  	228k  	1  	completed at
Wed 05 Mar 2014 06:58:13 AM PST

psc-1200-series-4  	psc-1200-series  	root  	5k  	2  	completed at
Tue 04 Mar 2014 10:04:27 PM PST

Here is what I see with debug turned on in the error_log. How do I pursue
this? thanks -- Dean guenther

D [05/Mar/2014:06:57:55 -0800] cupsdNetIFUpdate: "lo" = localhost:631
D [05/Mar/2014:06:57:55 -0800] cupsdNetIFUpdate: "eth0" = 192.168.0.2:631
D [05/Mar/2014:06:57:55 -0800] cupsdNetIFUpdate: "lo" = localhost:631
D [05/Mar/2014:06:57:55 -0800] cupsdNetIFUpdate: "eth0" =
fe80::20c:76ff:fea4:b4f3%eth0:631
D [05/Mar/2014:06:57:55 -0800] Report: clients=0
D [05/Mar/2014:06:57:55 -0800] Report: jobs=5
D [05/Mar/2014:06:57:55 -0800] Report: jobs-active=0
D [05/Mar/2014:06:57:55 -0800] Report: printers=1
D [05/Mar/2014:06:57:55 -0800] Report: printers-implicit=0
D [05/Mar/2014:06:57:55 -0800] Report: stringpool-string-count=526
D [05/Mar/2014:06:57:55 -0800] Report: stringpool-alloc-bytes=6784
D [05/Mar/2014:06:57:55 -0800] Report: stringpool-total-bytes=11048
D [05/Mar/2014:06:57:58 -0800] cupsdAcceptClient: skipping getpeercon()
D [05/Mar/2014:06:57:58 -0800] cupsdAcceptClient: 12 from
192.168.0.144:631 (IPv4)
D [05/Mar/2014:06:57:58 -0800] cupsdReadClient: 12 POST
/printers/psc-1200-series HTTP/1.1
D [05/Mar/2014:06:57:58 -0800] cupsdSetBusyState: Active clients
D [05/Mar/2014:06:57:58 -0800] cupsdAuthorize: No authentication data
provided.
D [05/Mar/2014:06:57:58 -0800] cupsdReadClient: 12 1.0
Get-Printer-Attributes 11
D [05/Mar/2014:06:57:58 -0800] Get-Printer-Attributes
http://192.168.0.2:631/printers/psc-1200-series
D [05/Mar/2014:06:57:58 -0800] Returning IPP successful-ok for
Get-Printer-Attributes (http://192.168.0.2:631/printers/psc-1200-series)
from 192.168.0.144
D [05/Mar/2014:06:57:58 -0800] cupsdSetBusyState: Not busy
D [05/Mar/2014:06:57:59 -0800] cupsdReadClient: 12 POST
/printers/psc-1200-series HTTP/1.1
D [05/Mar/2014:06:57:59 -0800] cupsdSetBusyState: Active clients
D [05/Mar/2014:06:57:59 -0800] cupsdAuthorize: No authentication data
provided.
D [05/Mar/2014:06:57:59 -0800] cupsdReadClient: 12 1.0
Get-Printer-Attributes 11
D [05/Mar/2014:06:57:59 -0800] Get-Printer-Attributes
http://192.168.0.2:631/printers/psc-1200-series
D [05/Mar/2014:06:57:59 -0800] Returning IPP successful-ok for
Get-Printer-Attributes (http://192.168.0.2:631/printers/psc-1200-series)
from 192.168.0.144
D [05/Mar/2014:06:57:59 -0800] cupsdSetBusyState: Not busy
D [05/Mar/2014:06:58:09 -0800] cupsdReadClient: 12 POST
/printers/psc-1200-series HTTP/1.1
D [05/Mar/2014:06:58:09 -0800] cupsdSetBusyState: Active clients
D [05/Mar/2014:06:58:09 -0800] cupsdAuthorize: No authentication data
provided.
D [05/Mar/2014:06:58:09 -0800] cupsdReadClient: 12 1.0
Get-Printer-Attributes 11
D [05/Mar/2014:06:58:09 -0800] Get-Printer-Attributes
http://192.168.0.2:631/printers/psc-1200-series
D [05/Mar/2014:06:58:09 -0800] Returning IPP successful-ok for
Get-Printer-Attributes (http://192.168.0.2:631/printers/psc-1200-series)
from 192.168.0.144
D [05/Mar/2014:06:58:09 -0800] cupsdSetBusyState: Not busy
D [05/Mar/2014:06:58:09 -0800] cupsdReadClient: 12 POST
/printers/psc-1200-series HTTP/1.1
D [05/Mar/2014:06:58:09 -0800] cupsdSetBusyState: Active clients
D [05/Mar/2014:06:58:09 -0800] cupsdAuthorize: No authentication data
provided.
D [05/Mar/2014:06:58:09 -0800] cupsdReadClient: 12 1.0 Get-Jobs 10
D [05/Mar/2014:06:58:09 -0800] Get-Jobs
http://192.168.0.2:631/printers/psc-1200-series
D [05/Mar/2014:06:58:09 -0800] Returning IPP successful-ok for Get-Jobs
(http://192.168.0.2:631/printers/psc-1200-series) from 192.168.0.144
D [05/Mar/2014:06:58:09 -0800] cupsdSetBusyState: Not busy
D [05/Mar/2014:06:58:10 -0800] cupsdReadClient: 12 POST
/printers/psc-1200-series HTTP/1.1
D [05/Mar/2014:06:58:10 -0800] cupsdSetBusyState: Active clients
D [05/Mar/2014:06:58:10 -0800] cupsdAuthorize: No authentication data
provided.
D [05/Mar/2014:06:58:10 -0800] cupsdReadClient: 12 1.0
Get-Printer-Attributes 11
D [05/Mar/2014:06:58:10 -0800] Get-Printer-Attributes
http://192.168.0.2:631/printers/psc-1200-series
D [05/Mar/2014:06:58:10 -0800] Returning IPP successful-ok for
Get-Printer-Attributes (http://192.168.0.2:631/printers/psc-1200-series)
from 192.168.0.144
D [05/Mar/2014:06:58:10 -0800] cupsdSetBusyState: Not busy
D [05/Mar/2014:06:58:11 -0800] cupsdReadClient: 12 POST
/printers/psc-1200-series HTTP/1.1
D [05/Mar/2014:06:58:11 -0800] cupsdSetBusyState: Active clients
D [05/Mar/2014:06:58:11 -0800] cupsdAuthorize: No authentication data
provided.
D [05/Mar/2014:06:58:11 -0800] cupsdReadClient: 12 1.0 Print-Job 2
D [05/Mar/2014:06:58:13 -0800] Print-Job
http://192.168.0.2:631/printers/psc-1200-series
D [05/Mar/2014:06:58:13 -0800] [Job ???] Auto-typing file...
I [05/Mar/2014:06:58:13 -0800] [Job ???] Request file type is
application/octet-stream.
D [05/Mar/2014:06:58:13 -0800] add_job: setting context of job to UNKNOWN SL
D [05/Mar/2014:06:58:13 -0800] cupsdMarkDirty(----J-)
D [05/Mar/2014:06:58:13 -0800] cupsdSetBusyState: Active clients and dirty
files
D [05/Mar/2014:06:58:13 -0800] add_job: requesting-user-name="Mary"
D [05/Mar/2014:06:58:13 -0800] Adding default job-sheets values
"none,none"...
I [05/Mar/2014:06:58:13 -0800] [Job 6] Adding start banner page "none".
D [05/Mar/2014:06:58:13 -0800] Discarding unused job-created event...
D [05/Mar/2014:06:58:13 -0800] cupsdMarkDirty(----J-)
I [05/Mar/2014:06:58:13 -0800] [Job 6] Adding end banner page "none".
I [05/Mar/2014:06:58:13 -0800] [Job 6] File of type
application/octet-stream queued by "Mary".
D [05/Mar/2014:06:58:13 -0800] [Job 6] hold_until=0
I [05/Mar/2014:06:58:13 -0800] [Job 6] Queued on "psc-1200-series" by "Mary".
D [05/Mar/2014:06:58:13 -0800] cupsdMarkDirty(----J-)
D [05/Mar/2014:06:58:13 -0800] cupsdSetBusyState: Active clients, printing
jobs, and dirty files
D [05/Mar/2014:06:58:13 -0800] Discarding unused printer-state-changed
event...
D [05/Mar/2014:06:58:13 -0800] [Job 6] job-sheets=none,none
D [05/Mar/2014:06:58:13 -0800] [Job 6] argv[0]="psc-1200-series"
D [05/Mar/2014:06:58:13 -0800] [Job 6] argv[1]="6"
D [05/Mar/2014:06:58:13 -0800] [Job 6] argv[2]="Mary"
D [05/Mar/2014:06:58:13 -0800] [Job 6] argv[3]="PCS_BOYD-1"
D [05/Mar/2014:06:58:13 -0800] [Job 6] argv[4]="1"
D [05/Mar/2014:06:58:13 -0800] [Job 6]
argv[5]="job-uuid=urn:uuid:d15345ce-1d19-3129-51cb-83cf86c8644c
job-originating-host-name=192.168.0.144"
D [05/Mar/2014:06:58:13 -0800] [Job 6] argv[6]="/var/spool/cups/d00006-001"
D [05/Mar/2014:06:58:13 -0800] [Job 6]
envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [05/Mar/2014:06:58:13 -0800] [Job 6] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [05/Mar/2014:06:58:13 -0800] [Job 6]
envp[2]="CUPS_DOCROOT=/usr/share/cups/www"
D [05/Mar/2014:06:58:13 -0800] [Job 6]
envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [05/Mar/2014:06:58:13 -0800] [Job 6]
envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [05/Mar/2014:06:58:13 -0800] [Job 6] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [05/Mar/2014:06:58:13 -0800] [Job 6] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [05/Mar/2014:06:58:13 -0800] [Job 6] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [05/Mar/2014:06:58:13 -0800] [Job 6] envp[8]="HOME=/var/spool/cups/tmp"
D [05/Mar/2014:06:58:13 -0800] [Job 6]
envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [05/Mar/2014:06:58:13 -0800] [Job 6]
envp[10]="SERVER_ADMIN=root at localhost.localdomain"
D [05/Mar/2014:06:58:13 -0800] [Job 6] envp[11]="SOFTWARE=CUPS/1.4.2"
D [05/Mar/2014:06:58:13 -0800] [Job 6] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [05/Mar/2014:06:58:13 -0800] [Job 6] envp[13]="USER=root"
D [05/Mar/2014:06:58:13 -0800] [Job 6]
envp[14]="CUPS_SERVER=/var/run/cups/cups.sock"
D [05/Mar/2014:06:58:13 -0800] [Job 6] envp[15]="CUPS_ENCRYPTION=IfRequested"
D [05/Mar/2014:06:58:13 -0800] [Job 6] envp[16]="IPP_PORT=631"
D [05/Mar/2014:06:58:13 -0800] [Job 6] envp[17]="CHARSET=utf-8"
D [05/Mar/2014:06:58:13 -0800] [Job 6] envp[18]="LANG=en_US.UTF-8"
D [05/Mar/2014:06:58:13 -0800] [Job 6]
envp[19]="PPD=/etc/cups/ppd/psc-1200-series.ppd"
D [05/Mar/2014:06:58:13 -0800] [Job 6] envp[20]="RIP_MAX_CACHE=128m"
D [05/Mar/2014:06:58:13 -0800] [Job 6]
envp[21]="CONTENT_TYPE=application/octet-stream"
D [05/Mar/2014:06:58:13 -0800] [Job 6]
envp[22]="DEVICE_URI=usb://HP/psc%201200%20series?serial=MY36CC941Q5H"
D [05/Mar/2014:06:58:13 -0800] [Job 6]
envp[23]="PRINTER_INFO=Hewlett-Packard psc 1200 series"
D [05/Mar/2014:06:58:13 -0800] [Job 6]
envp[24]="PRINTER_LOCATION=localhost.localdomain"
D [05/Mar/2014:06:58:13 -0800] [Job 6] envp[25]="PRINTER=psc-1200-series"
D [05/Mar/2014:06:58:13 -0800] [Job 6] envp[26]="CUPS_FILETYPE=document"
I [05/Mar/2014:06:58:13 -0800] [Job 6] Started backend
/usr/lib/cups/backend/usb (PID 11531)
D [05/Mar/2014:06:58:13 -0800] Discarding unused job-state-changed event...
D [05/Mar/2014:06:58:13 -0800] Returning IPP successful-ok for Print-Job
(http://192.168.0.2:631/printers/psc-1200-series) from 192.168.0.144
D [05/Mar/2014:06:58:13 -0800] cupsdSetBusyState: Printing jobs and dirty
files
D [05/Mar/2014:06:58:13 -0800] [Job 6] STATE: +connecting-to-device
D [05/Mar/2014:06:58:13 -0800] Discarding unused printer-state-changed
event...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Printer using device file
"/dev/usblp0"...
D [05/Mar/2014:06:58:13 -0800] [Job 6] STATE: -connecting-to-device
D [05/Mar/2014:06:58:13 -0800] Discarding unused printer-state-changed
event...
D [05/Mar/2014:06:58:13 -0800] [Job 6] PAGE: 1 1
D [05/Mar/2014:06:58:13 -0800] Discarding unused job-progress event...
D [05/Mar/2014:06:58:13 -0800] [Job 6] backendRunLoop(print_fd=5,
device_fd=6, snmp_fd=-1, addr=(nil), use_bc=1, side_cb=0xbaf5d0)
D [05/Mar/2014:06:58:13 -0800] [Job 6] Read 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] STATE: -media-empty-warning
D [05/Mar/2014:06:58:13 -0800] [Job 6] STATE: -offline-report
I [05/Mar/2014:06:58:13 -0800] [Job 6] Printer is now online.
D [05/Mar/2014:06:58:13 -0800] [Job 6] Wrote 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Read 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] Discarding unused printer-state-changed
event...
D [05/Mar/2014:06:58:13 -0800] Discarding unused job-progress event...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Wrote 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Read 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Wrote 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Read 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Wrote 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Read 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Wrote 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Read 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Wrote 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Read 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Wrote 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Read 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Wrote 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Read 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Wrote 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Read 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Wrote 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Read 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Wrote 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Read 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Wrote 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Read 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Wrote 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Read 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Wrote 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Read 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Wrote 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Read 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Wrote 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Read 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Wrote 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Read 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Wrote 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Read 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Wrote 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Read 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Wrote 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Read 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Wrote 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Read 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Wrote 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Read 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Wrote 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Read 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Wrote 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Read 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Wrote 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Read 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Wrote 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Read 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Wrote 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Read 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Wrote 8192 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Read 4026 bytes of print data...
D [05/Mar/2014:06:58:13 -0800] [Job 6] Wrote 4026 bytes of print data...
I [05/Mar/2014:06:58:13 -0800] [Job 6] Sent print file, 233402 bytes...
D [05/Mar/2014:06:58:13 -0800] Discarding unused printer-state-changed
event...
D [05/Mar/2014:06:58:13 -0800] Discarding unused job-progress event...
D [05/Mar/2014:06:58:13 -0800] PID 11531 (/usr/lib/cups/backend/usb)
exited with no errors.
D [05/Mar/2014:06:58:13 -0800] Discarding unused job-completed event...
I [05/Mar/2014:06:58:13 -0800] [Job 6] Job completed.
D [05/Mar/2014:06:58:13 -0800] cupsdMarkDirty(----J-)
D [05/Mar/2014:06:58:13 -0800] Discarding unused printer-state-changed
event...
D [05/Mar/2014:06:58:14 -0800] [Job 6] Unloading...
D [05/Mar/2014:06:58:20 -0800] cupsdAcceptClient: skipping getpeercon()
D [05/Mar/2014:06:58:20 -0800] cupsdAcceptClient: 13 from
192.168.0.144:631 (IPv4)
D [05/Mar/2014:06:58:25 -0800] cupsdReadClient: 13 WAITING Closing on EOF
D [05/Mar/2014:06:58:25 -0800] cupsdCloseClient: 13
D [05/Mar/2014:06:58:25 -0800] cupsdSetBusyState: Dirty files
D [05/Mar/2014:06:58:31 -0800] cupsdAcceptClient: skipping getpeercon()
D [05/Mar/2014:06:58:31 -0800] cupsdAcceptClient: 13 from
192.168.0.144:631 (IPv4)
D [05/Mar/2014:06:58:36 -0800] cupsdReadClient: 13 WAITING Closing on EOF
D [05/Mar/2014:06:58:36 -0800] cupsdCloseClient: 13
I [05/Mar/2014:06:58:44 -0800] Saving job cache file
"/var/cache/cups/job.cache"...
D [05/Mar/2014:06:58:44 -0800] cupsdSetBusyState: Not busy
D [05/Mar/2014:06:58:46 -0800] cupsdAcceptClient: skipping getpeercon()
D [05/Mar/2014:06:58:46 -0800] cupsdAcceptClient: 13 from
192.168.0.144:631 (IPv4)
D [05/Mar/2014:06:58:46 -0800] cupsdReadClient: 13 GET /jobs/ HTTP/1.1
D [05/Mar/2014:06:58:46 -0800] cupsdSetBusyState: Active clients
D [05/Mar/2014:06:58:46 -0800] cupsdAuthorize: No authentication data
provided.
D [05/Mar/2014:06:58:46 -0800] [CGI] argv[0] =
"/usr/lib/cups/cgi-bin/jobs.cgi"
D [05/Mar/2014:06:58:46 -0800] [CGI] envp[0] =
"CUPS_CACHEDIR=/var/cache/cups"
D [05/Mar/2014:06:58:46 -0800] [CGI] envp[1] = "CUPS_DATADIR=/usr/share/cups"
D [05/Mar/2014:06:58:46 -0800] [CGI] envp[2] =
"CUPS_DOCROOT=/usr/share/cups/www"
D [05/Mar/2014:06:58:46 -0800] [CGI] envp[3] =
"CUPS_FONTPATH=/usr/share/cups/fonts"
D [05/Mar/2014:06:58:46 -0800] [CGI] envp[4] =
"CUPS_REQUESTROOT=/var/spool/cups"
D [05/Mar/2014:06:58:46 -0800] [CGI] envp[5] = "CUPS_SERVERBIN=/usr/lib/cups"
D [05/Mar/2014:06:58:46 -0800] [CGI] envp[6] = "CUPS_SERVERROOT=/etc/cups"
D [05/Mar/2014:06:58:46 -0800] [CGI] envp[7] = "CUPS_STATEDIR=/var/run/cups"
D [05/Mar/2014:06:58:46 -0800] [CGI] envp[8] = "HOME=/var/spool/cups/tmp"
D [05/Mar/2014:06:58:46 -0800] [CGI] envp[9] =
"PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [05/Mar/2014:06:58:46 -0800] [CGI] envp[10] =
"SERVER_ADMIN=root at localhost.localdomain"
D [05/Mar/2014:06:58:46 -0800] [CGI] envp[11] = "SOFTWARE=CUPS/1.4.2"
D [05/Mar/2014:06:58:46 -0800] [CGI] envp[12] = "TMPDIR=/var/spool/cups/tmp"
D [05/Mar/2014:06:58:46 -0800] [CGI] envp[13] = "USER=root"
D [05/Mar/2014:06:58:46 -0800] [CGI] envp[14] =
"CUPS_SERVER=/var/run/cups/cups.sock"
D [05/Mar/2014:06:58:46 -0800] [CGI] envp[15] = "CUPS_ENCRYPTION=IfRequested"
D [05/Mar/2014:06:58:46 -0800] [CGI] envp[16] = "IPP_PORT=631"
D [05/Mar/2014:06:58:46 -0800] [CGI] envp[17] = "LANG=en_US.UTF8"
D [05/Mar/2014:06:58:46 -0800] [CGI] envp[18] = "REDIRECT_STATUS=1"
D [05/Mar/2014:06:58:46 -0800] [CGI] envp[19] = "GATEWAY_INTERFACE=CGI/1.1"
D [05/Mar/2014:06:58:46 -0800] [CGI] envp[20] = "SERVER_NAME=192.168.0.2"
D [05/Mar/2014:06:58:46 -0800] [CGI] envp[21] = "SERVER_PORT=631"
D [05/Mar/2014:06:58:46 -0800] [CGI] envp[22] = "REMOTE_ADDR=192.168.0.144"
D [05/Mar/2014:06:58:46 -0800] [CGI] envp[23] = "REMOTE_HOST=192.168.0.144"
D [05/Mar/2014:06:58:46 -0800] [CGI] envp[24] = "SCRIPT_NAME=/jobs/"
D [05/Mar/2014:06:58:46 -0800] [CGI] envp[25] =
"SCRIPT_FILENAME=/usr/share/cups/www/jobs/"
D [05/Mar/2014:06:58:46 -0800] [CGI] envp[26] = "SERVER_PROTOCOL=HTTP/1.1"
D [05/Mar/2014:06:58:46 -0800] [CGI] envp[27] =
"HTTP_COOKIE=org.cups.sid=0fc413a15ad3b5edaac3e6d056a39507"
D [05/Mar/2014:06:58:46 -0800] [CGI] envp[28] =
"HTTP_USER_AGENT=Mozilla/5.0 (Windows NT 6.1; WOW64; rv:27.0)
Gecko/20100101 Firefox/27.0"
D [05/Mar/2014:06:58:46 -0800] [CGI] envp[29] =
"HTTP_REFERER=http://192.168.0.2:631/admin/?ADVANCEDSETTINGS=YES"
D [05/Mar/2014:06:58:46 -0800] [CGI] envp[30] = "REQUEST_METHOD=GET"
D [05/Mar/2014:06:58:46 -0800] [CGI] envp[31] = "QUERY_STRING="
D [05/Mar/2014:06:58:46 -0800] [CGI] Started
/usr/lib/cups/cgi-bin/jobs.cgi (PID 11533)
I [05/Mar/2014:06:58:46 -0800] Started "/usr/lib/cups/cgi-bin/jobs.cgi"
(pid=11533)
D [05/Mar/2014:06:58:46 -0800] cupsdSendCommand: 13 file=17
D [05/Mar/2014:06:58:46 -0800] [CGI] org.cups.sid cookie is
"0fc413a15ad3b5edaac3e6d056a39507"
D [05/Mar/2014:06:58:46 -0800] cupsdAcceptClient: skipping getpeercon()
D [05/Mar/2014:06:58:46 -0800] cupsdAcceptClient: 18 from localhost (Domain)
D [05/Mar/2014:06:58:46 -0800] [CGI] lang="en_US.UTF8", locale="/en_US"...
D [05/Mar/2014:06:58:46 -0800] Script header: Content-Type:
text/html;charset=utf-8
D [05/Mar/2014:06:58:46 -0800] Script header:
D [05/Mar/2014:06:58:46 -0800] cupsdReadClient: 18 POST / HTTP/1.1
D [05/Mar/2014:06:58:46 -0800] cupsdAuthorize: No authentication data
provided.
D [05/Mar/2014:06:58:46 -0800] cupsdReadClient: 18 1.1 Get-Jobs 1
D [05/Mar/2014:06:58:46 -0800] Get-Jobs ipp://localhost/
D [05/Mar/2014:06:58:46 -0800] Returning IPP successful-ok for Get-Jobs
(ipp://localhost/) from localhost
D [05/Mar/2014:06:58:46 -0800] [CGI] lang="en_US.UTF8", locale="/en_US"...
D [05/Mar/2014:06:58:46 -0800] [CGI] lang="en_US.UTF8", locale="/en_US"...
D [05/Mar/2014:06:58:46 -0800] [CGI] lang="en_US.UTF8", locale="/en_US"...
D [05/Mar/2014:06:58:46 -0800] cupsdReadClient: 18 WAITING Closing on EOF
D [05/Mar/2014:06:58:46 -0800] cupsdCloseClient: 18
D [05/Mar/2014:06:58:46 -0800] PID 11533 (/usr/lib/cups/cgi-bin/jobs.cgi)
exited with no errors.
D [05/Mar/2014:06:58:46 -0800] [CGI] lang="en_US.UTF8", locale="/en_US"...
D [05/Mar/2014:06:58:46 -0800] cupsdSetBusyState: Not busy
D [05/Mar/2014:06:58:50 -0800] cupsdReadClient: 13 GET
/jobs?which_jobs=completed HTTP/1.1
D [05/Mar/2014:06:58:50 -0800] cupsdSetBusyState: Active clients
D [05/Mar/2014:06:58:50 -0800] cupsdAuthorize: No authentication data
provided.
D [05/Mar/2014:06:58:50 -0800] [CGI] argv[0] =
"/usr/lib/cups/cgi-bin/jobs.cgi"
D [05/Mar/2014:06:58:50 -0800] [CGI] argv[1] = "which_jobs=completed"
D [05/Mar/2014:06:58:50 -0800] [CGI] envp[0] =
"CUPS_CACHEDIR=/var/cache/cups"
D [05/Mar/2014:06:58:50 -0800] [CGI] envp[1] = "CUPS_DATADIR=/usr/share/cups"
D [05/Mar/2014:06:58:50 -0800] [CGI] envp[2] =
"CUPS_DOCROOT=/usr/share/cups/www"
D [05/Mar/2014:06:58:50 -0800] [CGI] envp[3] =
"CUPS_FONTPATH=/usr/share/cups/fonts"
D [05/Mar/2014:06:58:50 -0800] [CGI] envp[4] =
"CUPS_REQUESTROOT=/var/spool/cups"
D [05/Mar/2014:06:58:50 -0800] [CGI] envp[5] = "CUPS_SERVERBIN=/usr/lib/cups"
D [05/Mar/2014:06:58:50 -0800] [CGI] envp[6] = "CUPS_SERVERROOT=/etc/cups"
D [05/Mar/2014:06:58:50 -0800] [CGI] envp[7] = "CUPS_STATEDIR=/var/run/cups"
D [05/Mar/2014:06:58:50 -0800] [CGI] envp[8] = "HOME=/var/spool/cups/tmp"
D [05/Mar/2014:06:58:50 -0800] [CGI] envp[9] =
"PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [05/Mar/2014:06:58:50 -0800] [CGI] envp[10] =
"SERVER_ADMIN=root at localhost.localdomain"
D [05/Mar/2014:06:58:50 -0800] [CGI] envp[11] = "SOFTWARE=CUPS/1.4.2"
D [05/Mar/2014:06:58:50 -0800] [CGI] envp[12] = "TMPDIR=/var/spool/cups/tmp"
D [05/Mar/2014:06:58:50 -0800] [CGI] envp[13] = "USER=root"
D [05/Mar/2014:06:58:50 -0800] [CGI] envp[14] =
"CUPS_SERVER=/var/run/cups/cups.sock"
D [05/Mar/2014:06:58:50 -0800] [CGI] envp[15] = "CUPS_ENCRYPTION=IfRequested"
D [05/Mar/2014:06:58:50 -0800] [CGI] envp[16] = "IPP_PORT=631"
D [05/Mar/2014:06:58:50 -0800] [CGI] envp[17] = "LANG=en_US.UTF8"
D [05/Mar/2014:06:58:50 -0800] [CGI] envp[18] = "REDIRECT_STATUS=1"
D [05/Mar/2014:06:58:50 -0800] [CGI] envp[19] = "GATEWAY_INTERFACE=CGI/1.1"
D [05/Mar/2014:06:58:50 -0800] [CGI] envp[20] = "SERVER_NAME=192.168.0.2"
D [05/Mar/2014:06:58:50 -0800] [CGI] envp[21] = "SERVER_PORT=631"
D [05/Mar/2014:06:58:50 -0800] [CGI] envp[22] = "REMOTE_ADDR=192.168.0.144"
D [05/Mar/2014:06:58:50 -0800] [CGI] envp[23] = "REMOTE_HOST=192.168.0.144"
D [05/Mar/2014:06:58:50 -0800] [CGI] envp[24] = "SCRIPT_NAME=/jobs"
D [05/Mar/2014:06:58:50 -0800] [CGI] envp[25] =
"SCRIPT_FILENAME=/usr/share/cups/www/jobs"
D [05/Mar/2014:06:58:50 -0800] [CGI] envp[26] = "SERVER_PROTOCOL=HTTP/1.1"
D [05/Mar/2014:06:58:50 -0800] [CGI] envp[27] =
"HTTP_COOKIE=org.cups.sid=0fc413a15ad3b5edaac3e6d056a39507"
D [05/Mar/2014:06:58:50 -0800] [CGI] envp[28] =
"HTTP_USER_AGENT=Mozilla/5.0 (Windows NT 6.1; WOW64; rv:27.0)
Gecko/20100101 Firefox/27.0"
D [05/Mar/2014:06:58:50 -0800] [CGI] envp[29] =
"HTTP_REFERER=http://192.168.0.2:631/jobs/"
D [05/Mar/2014:06:58:50 -0800] [CGI] envp[30] = "REQUEST_METHOD=GET"
D [05/Mar/2014:06:58:50 -0800] [CGI] envp[31] =
"QUERY_STRING=which_jobs=completed"
D [05/Mar/2014:06:58:50 -0800] [CGI] Started
/usr/lib/cups/cgi-bin/jobs.cgi (PID 11534)
I [05/Mar/2014:06:58:50 -0800] Started "/usr/lib/cups/cgi-bin/jobs.cgi"
(pid=11534)
D [05/Mar/2014:06:58:50 -0800] cupsdSendCommand: 13 file=17
D [05/Mar/2014:06:58:50 -0800] [CGI] org.cups.sid cookie is
"0fc413a15ad3b5edaac3e6d056a39507"
D [05/Mar/2014:06:58:50 -0800] cupsdAcceptClient: skipping getpeercon()
D [05/Mar/2014:06:58:50 -0800] cupsdAcceptClient: 18 from localhost (Domain)
D [05/Mar/2014:06:58:50 -0800] [CGI] lang="en_US.UTF8", locale="/en_US"...
D [05/Mar/2014:06:58:50 -0800] Script header: Content-Type:
text/html;charset=utf-8
D [05/Mar/2014:06:58:50 -0800] Script header:
D [05/Mar/2014:06:58:50 -0800] cupsdReadClient: 18 POST / HTTP/1.1
D [05/Mar/2014:06:58:50 -0800] cupsdAuthorize: No authentication data
provided.
D [05/Mar/2014:06:58:50 -0800] cupsdReadClient: 18 1.1 Get-Jobs 1
D [05/Mar/2014:06:58:50 -0800] Get-Jobs ipp://localhost/
D [05/Mar/2014:06:58:50 -0800] [Job 1] Loading attributes...
D [05/Mar/2014:06:58:50 -0800] [Job 2] Loading attributes...
D [05/Mar/2014:06:58:50 -0800] [Job 3] Loading attributes...
D [05/Mar/2014:06:58:50 -0800] [Job 4] Loading attributes...
D [05/Mar/2014:06:58:50 -0800] [Job 5] Loading attributes...
D [05/Mar/2014:06:58:50 -0800] [Job 6] Loading attributes...
D [05/Mar/2014:06:58:50 -0800] Returning IPP successful-ok for Get-Jobs
(ipp://localhost/) from localhost
D [05/Mar/2014:06:58:50 -0800] [CGI] lang="en_US.UTF8", locale="/en_US"...
D [05/Mar/2014:06:58:50 -0800] [CGI] lang="en_US.UTF8", locale="/en_US"...
D [05/Mar/2014:06:58:50 -0800] [CGI] lang="en_US.UTF8", locale="/en_US"...
D [05/Mar/2014:06:58:50 -0800] cupsdReadClient: 18 WAITING Closing on EOF
D [05/Mar/2014:06:58:50 -0800] cupsdCloseClient: 18
D [05/Mar/2014:06:58:50 -0800] [CGI] lang="en_US.UTF8", locale="/en_US"...
D [05/Mar/2014:06:58:50 -0800] cupsdSetBusyState: Not busy
D [05/Mar/2014:06:58:50 -0800] PID 11534 (/usr/lib/cups/cgi-bin/jobs.cgi)
exited with no errors.
D [05/Mar/2014:06:59:08 -0800] cupsdReadClient: 13 GET /admin HTTP/1.1
D [05/Mar/2014:06:59:08 -0800] cupsdSetBusyState: Active clients
D [05/Mar/2014:06:59:08 -0800] cupsdAuthorize: No authentication data
provided.
D [05/Mar/2014:06:59:08 -0800] [CGI] argv[0] =
"/usr/lib/cups/cgi-bin/admin.cgi"
D [05/Mar/2014:06:59:08 -0800] [CGI] envp[0] =
"CUPS_CACHEDIR=/var/cache/cups"
D [05/Mar/2014:06:59:08 -0800] [CGI] envp[1] = "CUPS_DATADIR=/usr/share/cups"
D [05/Mar/2014:06:59:08 -0800] [CGI] envp[2] =
"CUPS_DOCROOT=/usr/share/cups/www"
D [05/Mar/2014:06:59:08 -0800] [CGI] envp[3] =
"CUPS_FONTPATH=/usr/share/cups/fonts"
D [05/Mar/2014:06:59:08 -0800] [CGI] envp[4] =
"CUPS_REQUESTROOT=/var/spool/cups"
D [05/Mar/2014:06:59:08 -0800] [CGI] envp[5] = "CUPS_SERVERBIN=/usr/lib/cups"
D [05/Mar/2014:06:59:08 -0800] [CGI] envp[6] = "CUPS_SERVERROOT=/etc/cups"
D [05/Mar/2014:06:59:08 -0800] [CGI] envp[7] = "CUPS_STATEDIR=/var/run/cups"
D [05/Mar/2014:06:59:08 -0800] [CGI] envp[8] = "HOME=/var/spool/cups/tmp"
D [05/Mar/2014:06:59:08 -0800] [CGI] envp[9] =
"PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [05/Mar/2014:06:59:08 -0800] [CGI] envp[10] =
"SERVER_ADMIN=root at localhost.localdomain"
D [05/Mar/2014:06:59:08 -0800] [CGI] envp[11] = "SOFTWARE=CUPS/1.4.2"
D [05/Mar/2014:06:59:08 -0800] [CGI] envp[12] = "TMPDIR=/var/spool/cups/tmp"
D [05/Mar/2014:06:59:08 -0800] [CGI] envp[13] = "USER=root"
D [05/Mar/2014:06:59:08 -0800] [CGI] envp[14] =
"CUPS_SERVER=/var/run/cups/cups.sock"
D [05/Mar/2014:06:59:08 -0800] [CGI] envp[15] = "CUPS_ENCRYPTION=IfRequested"
D [05/Mar/2014:06:59:08 -0800] [CGI] envp[16] = "IPP_PORT=631"
D [05/Mar/2014:06:59:08 -0800] [CGI] envp[17] = "LANG=en_US.UTF8"
D [05/Mar/2014:06:59:08 -0800] [CGI] envp[18] = "REDIRECT_STATUS=1"
D [05/Mar/2014:06:59:08 -0800] [CGI] envp[19] = "GATEWAY_INTERFACE=CGI/1.1"
D [05/Mar/2014:06:59:08 -0800] [CGI] envp[20] = "SERVER_NAME=192.168.0.2"
D [05/Mar/2014:06:59:08 -0800] [CGI] envp[21] = "SERVER_PORT=631"
D [05/Mar/2014:06:59:08 -0800] [CGI] envp[22] = "REMOTE_ADDR=192.168.0.144"
D [05/Mar/2014:06:59:08 -0800] [CGI] envp[23] = "REMOTE_HOST=192.168.0.144"
D [05/Mar/2014:06:59:08 -0800] [CGI] envp[24] = "SCRIPT_NAME=/admin"
D [05/Mar/2014:06:59:08 -0800] [CGI] envp[25] =
"SCRIPT_FILENAME=/usr/share/cups/www/admin"
D [05/Mar/2014:06:59:08 -0800] [CGI] envp[26] = "SERVER_PROTOCOL=HTTP/1.1"
D [05/Mar/2014:06:59:08 -0800] [CGI] envp[27] =
"HTTP_COOKIE=org.cups.sid=0fc413a15ad3b5edaac3e6d056a39507"
D [05/Mar/2014:06:59:08 -0800] [CGI] envp[28] =
"HTTP_USER_AGENT=Mozilla/5.0 (Windows NT 6.1; WOW64; rv:27.0)
Gecko/20100101 Firefox/27.0"
D [05/Mar/2014:06:59:08 -0800] [CGI] envp[29] =
"HTTP_REFERER=http://192.168.0.2:631/jobs?which_jobs=completed"
D [05/Mar/2014:06:59:08 -0800] [CGI] envp[30] = "REQUEST_METHOD=GET"
D [05/Mar/2014:06:59:08 -0800] [CGI] envp[31] = "QUERY_STRING="
D [05/Mar/2014:06:59:08 -0800] [CGI] Started
/usr/lib/cups/cgi-bin/admin.cgi (PID 11536)
I [05/Mar/2014:06:59:08 -0800] Started "/usr/lib/cups/cgi-bin/admin.cgi"
(pid=11536)
D [05/Mar/2014:06:59:08 -0800] cupsdSendCommand: 13 file=17
D [05/Mar/2014:06:59:08 -0800] Report: clients=2
D [05/Mar/2014:06:59:08 -0800] Report: jobs=6
D [05/Mar/2014:06:59:08 -0800] Report: jobs-active=0
D [05/Mar/2014:06:59:08 -0800] Report: printers=1
D [05/Mar/2014:06:59:08 -0800] Report: printers-implicit=0
D [05/Mar/2014:06:59:08 -0800] Report: stringpool-string-count=751
D [05/Mar/2014:06:59:08 -0800] Report: stringpool-alloc-bytes=8048
D [05/Mar/2014:06:59:08 -0800] Report: stringpool-total-bytes=15752
D [05/Mar/2014:06:59:08 -0800] [CGI] admin.cgi started...
D [05/Mar/2014:06:59:08 -0800] cupsdAcceptClient: skipping getpeercon()
D [05/Mar/2014:06:59:08 -0800] cupsdAcceptClient: 18 from localhost (Domain)
D [05/Mar/2014:06:59:08 -0800] [CGI] http=0x220b5d8
D [05/Mar/2014:06:59:08 -0800] [CGI] org.cups.sid cookie is
"0fc413a15ad3b5edaac3e6d056a39507"
D [05/Mar/2014:06:59:08 -0800] [CGI] No form data, showing main menu...
D [05/Mar/2014:06:59:08 -0800] [CGI] /usr/share/cups/drivers/pscript5.dll:
No such file or directory
D [05/Mar/2014:06:59:08 -0800] cupsdReadClient: 18 POST / HTTP/1.1
D [05/Mar/2014:06:59:08 -0800] cupsdAuthorize: No authentication data
provided.
D [05/Mar/2014:06:59:08 -0800] cupsdReadClient: 18 1.1 Get-Subscriptions 1
D [05/Mar/2014:06:59:08 -0800] Get-Subscriptions ipp://localhost/
D [05/Mar/2014:06:59:08 -0800] Get-Subscriptions client-error-not-found:
No subscriptions found.
D [05/Mar/2014:06:59:08 -0800] Returning IPP client-error-not-found for
Get-Subscriptions (ipp://localhost/) from localhost
D [05/Mar/2014:06:59:08 -0800] [CGI] lang="en_US.UTF8", locale="/en_US"...
D [05/Mar/2014:06:59:08 -0800] Script header: Content-Type:
text/html;charset=utf-8
D [05/Mar/2014:06:59:08 -0800] Script header:
D [05/Mar/2014:06:59:08 -0800] cupsdReadClient: 18 WAITING Closing on EOF
D [05/Mar/2014:06:59:08 -0800] cupsdCloseClient: 18
D [05/Mar/2014:06:59:08 -0800] [CGI] lang="en_US.UTF8", locale="/en_US"...
D [05/Mar/2014:06:59:08 -0800] [CGI] lang="en_US.UTF8", locale="/en_US"...
D [05/Mar/2014:06:59:08 -0800] cupsdSetBusyState: Not busy
D [05/Mar/2014:06:59:08 -0800] PID 11536 (/usr/lib/cups/cgi-bin/admin.cgi)
exited with no errors.
D [05/Mar/2014:06:59:13 -0800] cupsdReadClient: 12 WAITING Closing on EOF
D [05/Mar/2014:06:59:13 -0800] cupsdCloseClient: 12
D [05/Mar/2014:06:59:16 -0800] cupsdNetIFUpdate: "lo" = localhost:631
D [05/Mar/2014:06:59:16 -0800] cupsdNetIFUpdate: "eth0" = 192.168.0.2:631
D [05/Mar/2014:06:59:16 -0800] cupsdNetIFUpdate: "lo" = localhost:631
D [05/Mar/2014:06:59:16 -0800] cupsdNetIFUpdate: "eth0" =
fe80::20c:76ff:fea4:b4f3%eth0:631
D [05/Mar/2014:06:59:38 -0800] cupsdReadClient: 13 WAITING Closing on EOF
D [05/Mar/2014:06:59:38 -0800] cupsdCloseClient: 13
D [05/Mar/2014:06:59:59 -0800] cupsdAcceptClient: skipping getpeercon()
D [05/Mar/2014:06:59:59 -0800] cupsdAcceptClient: 12 from
192.168.0.144:631 (IPv4)
D [05/Mar/2014:06:59:59 -0800] [Job 1] Unloading...
D [05/Mar/2014:06:59:59 -0800] [Job 2] Unloading...
D [05/Mar/2014:06:59:59 -0800] [Job 3] Unloading...
D [05/Mar/2014:06:59:59 -0800] [Job 4] Unloading...
D [05/Mar/2014:06:59:59 -0800] [Job 5] Unloading...
D [05/Mar/2014:06:59:59 -0800] [Job 6] Unloading...
D [05/Mar/2014:06:59:59 -0800] cupsdReadClient: 12 GET /printers/ HTTP/1.1
D [05/Mar/2014:06:59:59 -0800] cupsdSetBusyState: Active clients
D [05/Mar/2014:06:59:59 -0800] cupsdAuthorize: No authentication data
provided.
D [05/Mar/2014:06:59:59 -0800] [CGI] argv[0] =
"/usr/lib/cups/cgi-bin/printers.cgi"
D [05/Mar/2014:06:59:59 -0800] [CGI] envp[0] =
"CUPS_CACHEDIR=/var/cache/cups"
D [05/Mar/2014:06:59:59 -0800] [CGI] envp[1] = "CUPS_DATADIR=/usr/share/cups"
D [05/Mar/2014:06:59:59 -0800] [CGI] envp[2] =
"CUPS_DOCROOT=/usr/share/cups/www"
D [05/Mar/2014:06:59:59 -0800] [CGI] envp[3] =
"CUPS_FONTPATH=/usr/share/cups/fonts"
D [05/Mar/2014:06:59:59 -0800] [CGI] envp[4] =
"CUPS_REQUESTROOT=/var/spool/cups"
D [05/Mar/2014:06:59:59 -0800] [CGI] envp[5] = "CUPS_SERVERBIN=/usr/lib/cups"
D [05/Mar/2014:06:59:59 -0800] [CGI] envp[6] = "CUPS_SERVERROOT=/etc/cups"
D [05/Mar/2014:06:59:59 -0800] [CGI] envp[7] = "CUPS_STATEDIR=/var/run/cups"
D [05/Mar/2014:06:59:59 -0800] [CGI] envp[8] = "HOME=/var/spool/cups/tmp"
D [05/Mar/2014:06:59:59 -0800] [CGI] envp[9] =
"PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [05/Mar/2014:06:59:59 -0800] [CGI] envp[10] =
"SERVER_ADMIN=root at localhost.localdomain"
D [05/Mar/2014:06:59:59 -0800] [CGI] envp[11] = "SOFTWARE=CUPS/1.4.2"
D [05/Mar/2014:06:59:59 -0800] [CGI] envp[12] = "TMPDIR=/var/spool/cups/tmp"
D [05/Mar/2014:06:59:59 -0800] [CGI] envp[13] = "USER=root"
D [05/Mar/2014:06:59:59 -0800] [CGI] envp[14] =
"CUPS_SERVER=/var/run/cups/cups.sock"
D [05/Mar/2014:06:59:59 -0800] [CGI] envp[15] = "CUPS_ENCRYPTION=IfRequested"
D [05/Mar/2014:06:59:59 -0800] [CGI] envp[16] = "IPP_PORT=631"
D [05/Mar/2014:06:59:59 -0800] [CGI] envp[17] = "LANG=en_US.UTF8"
D [05/Mar/2014:06:59:59 -0800] [CGI] envp[18] = "REDIRECT_STATUS=1"
D [05/Mar/2014:06:59:59 -0800] [CGI] envp[19] = "GATEWAY_INTERFACE=CGI/1.1"
D [05/Mar/2014:06:59:59 -0800] [CGI] envp[20] = "SERVER_NAME=192.168.0.2"
D [05/Mar/2014:06:59:59 -0800] [CGI] envp[21] = "SERVER_PORT=631"
D [05/Mar/2014:06:59:59 -0800] [CGI] envp[22] = "REMOTE_ADDR=192.168.0.144"
D [05/Mar/2014:06:59:59 -0800] [CGI] envp[23] = "REMOTE_HOST=192.168.0.144"
D [05/Mar/2014:06:59:59 -0800] [CGI] envp[24] = "SCRIPT_NAME=/printers/"
D [05/Mar/2014:06:59:59 -0800] [CGI] envp[25] =
"SCRIPT_FILENAME=/usr/share/cups/www/printers/"
D [05/Mar/2014:06:59:59 -0800] [CGI] envp[26] = "SERVER_PROTOCOL=HTTP/1.1"
D [05/Mar/2014:06:59:59 -0800] [CGI] envp[27] =
"HTTP_COOKIE=org.cups.sid=0fc413a15ad3b5edaac3e6d056a39507"
D [05/Mar/2014:06:59:59 -0800] [CGI] envp[28] =
"HTTP_USER_AGENT=Mozilla/5.0 (Windows NT 6.1; WOW64; rv:27.0)
Gecko/20100101 Firefox/27.0"
D [05/Mar/2014:06:59:59 -0800] [CGI] envp[29] =
"HTTP_REFERER=http://192.168.0.2:631/admin"
D [05/Mar/2014:06:59:59 -0800] [CGI] envp[30] = "REQUEST_METHOD=GET"
D [05/Mar/2014:06:59:59 -0800] [CGI] envp[31] = "QUERY_STRING="
D [05/Mar/2014:06:59:59 -0800] [CGI] Started
/usr/lib/cups/cgi-bin/printers.cgi (PID 11541)
I [05/Mar/2014:06:59:59 -0800] Started
"/usr/lib/cups/cgi-bin/printers.cgi" (pid=11541)
D [05/Mar/2014:06:59:59 -0800] cupsdSendCommand: 12 file=13
D [05/Mar/2014:06:59:59 -0800] [CGI] org.cups.sid cookie is
"0fc413a15ad3b5edaac3e6d056a39507"
D [05/Mar/2014:06:59:59 -0800] cupsdAcceptClient: skipping getpeercon()
D [05/Mar/2014:06:59:59 -0800] cupsdAcceptClient: 17 from localhost (Domain)
D [05/Mar/2014:06:59:59 -0800] cupsdReadClient: 17 POST / HTTP/1.1
D [05/Mar/2014:06:59:59 -0800] cupsdAuthorize: No authentication data
provided.
D [05/Mar/2014:06:59:59 -0800] cupsdReadClient: 17 1.1 CUPS-Get-Default 1
D [05/Mar/2014:06:59:59 -0800] CUPS-Get-Default
D [05/Mar/2014:06:59:59 -0800] Returning IPP successful-ok for
CUPS-Get-Default (no URI) from localhost
D [05/Mar/2014:06:59:59 -0800] [CGI] show_all_printers(http=0x13030d8,
user="(null)")
D [05/Mar/2014:06:59:59 -0800] [CGI] lang="en_US.UTF8", locale="/en_US"...
D [05/Mar/2014:06:59:59 -0800] Script header: Content-Type:
text/html;charset=utf-8
D [05/Mar/2014:06:59:59 -0800] Script header:
D [05/Mar/2014:06:59:59 -0800] cupsdReadClient: 17 POST / HTTP/1.1
D [05/Mar/2014:06:59:59 -0800] cupsdAuthorize: No authentication data
provided.
D [05/Mar/2014:06:59:59 -0800] cupsdReadClient: 17 1.1 CUPS-Get-Printers 1
D [05/Mar/2014:06:59:59 -0800] CUPS-Get-Printers
D [05/Mar/2014:06:59:59 -0800] Returning IPP successful-ok for
CUPS-Get-Printers (no URI) from localhost
D [05/Mar/2014:06:59:59 -0800] [CGI] lang="en_US.UTF8", locale="/en_US"...
D [05/Mar/2014:06:59:59 -0800] cupsdReadClient: 17 WAITING Closing on EOF
D [05/Mar/2014:06:59:59 -0800] cupsdCloseClient: 17
D [05/Mar/2014:06:59:59 -0800] [CGI] lang="en_US.UTF8", locale="/en_US"...
D [05/Mar/2014:06:59:59 -0800] [CGI] lang="en_US.UTF8", locale="/en_US"...
D [05/Mar/2014:06:59:59 -0800] [CGI] lang="en_US.UTF8", locale="/en_US"...
D [05/Mar/2014:06:59:59 -0800] cupsdSetBusyState: Not busy
D [05/Mar/2014:06:59:59 -0800] PID 11541
(/usr/lib/cups/cgi-bin/printers.cgi) exited with no errors.



More information about the cups-devel mailing list