[cups.general] Error: (/usr/lib/cups/filter/pstops) did not catch or ignore signal 13

[Steve Sakoman]

Still struggling with the issue below.

Any ideas?

Steve

On Sat, Oct 30, 2010 at 6:42 AM, Steve Sakoman <sakoman at gmail.com> wrote:
> I'm attempting to get cups/gs/hplip working on an OMAP3 embedded device.
>
> The basics seem to work - I can use the web UI to add a printer and
> the code seems to actually be talking to my networked HP7410.
>
> However when I attempt to print I run into issues.
>
> I've enabled debug in the config and see the following errors in the log:
>
> D [29/Oct/2010:15:56:15 -0700] [Job 1] Running /usr/bin/gs -dQUIET
> -dDEBUG -dPARANOIDSAFER -dNOPAUSE -dBATCH -dNOMEDIAATTRS -sDEVICE=cups
> -sstdout=%stderr -sOUTPUTFILE=%stdout -c  -f -_
> D [29/Oct/2010:15:56:15 -0700] Discarding unused job-progress event...
> D [29/Oct/2010:15:56:15 -0700] [Job 1] START 0 1443028 157482 1301468
> 13168 true 536 3 <0>
> D [29/Oct/2010:15:56:15 -0700] PID 8064 (/usr/lib/cups/filter/pstops)
> did not catch or ignore signal 13.
> D [29/Oct/2010:15:56:15 -0700] [Job 1] prnt/hpcups/HPCupsFilter.cpp
> 505: cupsRasterOpen failed, fd = 0
> D [29/Oct/2010:15:56:15 -0700] PID 8066 (/usr/lib/cups/filter/hpcups)
> stopped with status 1!
> E [29/Oct/2010:15:56:15 -0700] PID 8065
> (/usr/lib/cups/filter/pstoraster) crashed on signal 11!
> D [29/Oct/2010:15:56:17 -0700] [Job 1] backendRunLoop(print_fd=0,
> device_fd=5, snmp_fd=6, addr=0x1c904, use_bc=1, side_cb=0xa0c8)
> I [29/Oct/2010:15:56:17 -0700] [Job 1] Print file sent, waiting for
> printer to finish...
> D [29/Oct/2010:15:56:17 -0700] Discarding unused job-progress event...
>
> Any ideas on what might be wrong?
>
> The complete log of this session is included below.
>
> Best regards,
>
> Steve
>
> E [29/Oct/2010:15:50:19 -0700] Unknown SystemGroup "lpadmin sys root"
> on line 13, ignoring!
> E [29/Oct/2010:15:52:27 -0700] [cups-deviced] PID 8015 (hpfax) stopped
> with status 1!
> E [29/Oct/2010:15:55:02 -0700] [cups-deviced] PID 8042 (hpfax) stopped
> with status 1!
> E [29/Oct/2010:15:55:54 -0700] Unknown SystemGroup "lpadmin sys root"
> on line 13, ignoring!
> I [29/Oct/2010:15:55:54 -0700] Listening to ::1:631 (IPv6)
> I [29/Oct/2010:15:55:54 -0700] Listening to 127.0.0.1:631 (IPv4)
> I [29/Oct/2010:15:55:54 -0700] Listening to /var/run/cups/cups.sock (Domain)
> I [29/Oct/2010:15:55:54 -0700] Remote access is disabled.
> D [29/Oct/2010:15:55:54 -0700] Added auto ServerAlias omap3-multi
> I [29/Oct/2010:15:55:54 -0700] Loaded configuration file "/etc/cups/cupsd..conf"
> I [29/Oct/2010:15:55:54 -0700] Using default TempDir of /var/spool/cups/tmp...
> I [29/Oct/2010:15:55:54 -0700] Configured for up to 100 clients.
> I [29/Oct/2010:15:55:54 -0700] Allowing up to 100 client connections per host.
> I [29/Oct/2010:15:55:54 -0700] Using policy "default" as the default!
> D [29/Oct/2010:15:55:54 -0700] load_ppd: Loading /var/cache/cups/HP7410.ipp2...
> D [29/Oct/2010:15:55:55 -0700] cupsdRegisterPrinter(p=0x98330(HP7410))
> D [29/Oct/2010:15:55:55 -0700] cupsdMarkDirty(---p--)
> D [29/Oct/2010:15:55:55 -0700] cupsdSetBusyState: Dirty files
> I [29/Oct/2010:15:55:55 -0700] Partial reload complete.
> I [29/Oct/2010:15:55:55 -0700] Listening to ::1:631 on fd 3...
> I [29/Oct/2010:15:55:55 -0700] Listening to 127.0.0.1:631 on fd 5...
> I [29/Oct/2010:15:55:55 -0700] Listening to /var/run/cups/cups.sock on fd 6...
> I [29/Oct/2010:15:55:55 -0700] Resuming new connection processing...
> D [29/Oct/2010:15:55:55 -0700] cupsdRegisterPrinter(p=0x98330(HP7410))
> D [29/Oct/2010:15:55:55 -0700] Discarding unused server-restarted event....
> D [29/Oct/2010:15:55:56 -0700] Report: clients=0
> D [29/Oct/2010:15:55:56 -0700] Report: jobs=0
> D [29/Oct/2010:15:55:56 -0700] Report: jobs-active=0
> D [29/Oct/2010:15:55:56 -0700] Report: printers=1
> D [29/Oct/2010:15:55:56 -0700] Report: printers-implicit=0
> D [29/Oct/2010:15:55:56 -0700] Report: stringpool-string-count=23351
> D [29/Oct/2010:15:55:56 -0700] Report: stringpool-alloc-bytes=9488
> D [29/Oct/2010:15:55:56 -0700] Report: stringpool-total-bytes=435536
> D [29/Oct/2010:15:55:56 -0700] PID 8060
> (/usr/lib/cups/cgi-bin/admin.cgi) exited with no errors.
> D [29/Oct/2010:15:55:59 -0700] cupsdAcceptClient: 10 from localhost:631 (IPv4)
> D [29/Oct/2010:15:55:59 -0700] cupsdReadClient: 10 GET
> /admin/?OP=redirect HTTP/1.1
> D [29/Oct/2010:15:55:59 -0700] cupsdSetBusyState: Active clients and dirty files
> D [29/Oct/2010:15:55:59 -0700] cupsdAuthorize: Authorized as root using Basic
> D [29/Oct/2010:15:55:59 -0700] [CGI] argv[0] = "/usr/lib/cups/cgi-bin/admin.cgi"
> D [29/Oct/2010:15:55:59 -0700] [CGI] argv[1] = "OP=redirect"
> D [29/Oct/2010:15:55:59 -0700] [CGI] envp[0] = "CUPS_CACHEDIR=/var/cache/cups"
> D [29/Oct/2010:15:55:59 -0700] [CGI] envp[1] = "CUPS_DATADIR=/usr/share/cups"
> D [29/Oct/2010:15:55:59 -0700] [CGI] envp[2] =
> "CUPS_DOCROOT=/usr/share/doc/cups"
> D [29/Oct/2010:15:55:59 -0700] [CGI] envp[3] =
> "CUPS_FONTPATH=/usr/share/cups/fonts"
> D [29/Oct/2010:15:55:59 -0700] [CGI] envp[4] =
> "CUPS_REQUESTROOT=/var/spool/cups"
> D [29/Oct/2010:15:55:59 -0700] [CGI] envp[5] = "CUPS_SERVERBIN=/usr/lib/cups"
> D [29/Oct/2010:15:55:59 -0700] [CGI] envp[6] = "CUPS_SERVERROOT=/etc/cups"
> D [29/Oct/2010:15:55:59 -0700] [CGI] envp[7] = "CUPS_STATEDIR=/var/run/cups"
> D [29/Oct/2010:15:55:59 -0700] [CGI] envp[8] = "HOME=/var/spool/cups/tmp"
> D [29/Oct/2010:15:55:59 -0700] [CGI] envp[9] =
> "PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
> D [29/Oct/2010:15:55:59 -0700] [CGI] envp[10] = "SERVER_ADMIN=root at omap3-multi"
> D [29/Oct/2010:15:55:59 -0700] [CGI] envp[11] = "SOFTWARE=CUPS/1.4.4"
> D [29/Oct/2010:15:55:59 -0700] [CGI] envp[12] = "TMPDIR=/var/spool/cups/tmp"
> D [29/Oct/2010:15:55:59 -0700] [CGI] envp[13] = "USER=root"
> D [29/Oct/2010:15:55:59 -0700] [CGI] envp[14] =
> "CUPS_SERVER=/var/run/cups/cups.sock"
> D [29/Oct/2010:15:55:59 -0700] [CGI] envp[15] = "CUPS_ENCRYPTION=IfRequested"
> D [29/Oct/2010:15:55:59 -0700] [CGI] envp[16] = "IPP_PORT=631"
> D [29/Oct/2010:15:55:59 -0700] [CGI] envp[17] = "CUPSD_AUTH_TYPE=Basic"
> D [29/Oct/2010:15:55:59 -0700] [CGI] envp[18] = "LANG=en_US.UTF8"
> D [29/Oct/2010:15:55:59 -0700] [CGI] envp[19] = "REDIRECT_STATUS=1"
> D [29/Oct/2010:15:55:59 -0700] [CGI] envp[20] = "GATEWAY_INTERFACE=CGI/1.1"
> D [29/Oct/2010:15:55:59 -0700] [CGI] envp[21] = "SERVER_NAME=localhost"
> D [29/Oct/2010:15:55:59 -0700] [CGI] envp[22] = "SERVER_PORT=631"
> D [29/Oct/2010:15:55:59 -0700] [CGI] envp[23] = "REMOTE_ADDR=127.0.0.1"
> D [29/Oct/2010:15:55:59 -0700] [CGI] envp[24] = "REMOTE_HOST=localhost"
> D [29/Oct/2010:15:55:59 -0700] [CGI] envp[25] = "SCRIPT_NAME=/admin/"
> D [29/Oct/2010:15:55:59 -0700] [CGI] envp[26] =
> "SCRIPT_FILENAME=/usr/share/doc/cups/admin/"
> D [29/Oct/2010:15:55:59 -0700] [CGI] envp[27] = "REMOTE_USER=root"
> D [29/Oct/2010:15:55:59 -0700] [CGI] envp[28] = "SERVER_PROTOCOL=HTTP/1.1"
> D [29/Oct/2010:15:55:59 -0700] [CGI] envp[29] =
> "HTTP_COOKIE=org.cups.sid=013b9ec7635f9fccdf8554253ebf5082"
> D [29/Oct/2010:15:55:59 -0700] [CGI] envp[30] =
> "HTTP_USER_AGENT=Mozilla/5.0 (X11; U; Linux armv7l; c)
> AppleWebKit/534.7+ (KHTML, like Gecko) Version/5.0 Safari/534.7+
> Epiphany/2.30.2"
> D [29/Oct/2010:15:55:59 -0700] [CGI] envp[31] =
> "HTTP_REFERER=http://localhost:631/admin/"
> D [29/Oct/2010:15:55:59 -0700] [CGI] envp[32] = "REQUEST_METHOD=GET"
> D [29/Oct/2010:15:55:59 -0700] [CGI] envp[33] = "QUERY_STRING=OP=redirect"
> D [29/Oct/2010:15:55:59 -0700] [CGI] Started
> /usr/lib/cups/cgi-bin/admin.cgi (PID 8061)
> I [29/Oct/2010:15:55:59 -0700] Started
> "/usr/lib/cups/cgi-bin/admin.cgi" (pid=8061)
> D [29/Oct/2010:15:55:59 -0700] cupsdSendCommand: 10 file=11
> D [29/Oct/2010:15:56:00 -0700] [CGI] admin.cgi started...
> D [29/Oct/2010:15:56:00 -0700] cupsdAcceptClient: 12 from localhost (Domain)
> D [29/Oct/2010:15:56:00 -0700] [CGI] http=0x1f968
> D [29/Oct/2010:15:56:00 -0700] [CGI] org.cups.sid cookie is
> "013b9ec7635f9fccdf8554253ebf5082"
> D [29/Oct/2010:15:56:00 -0700] [CGI] redirecting with prefix
> http://localhost:631!
> D [29/Oct/2010:15:56:00 -0700] cupsdReadClient: 12 WAITING Closing on EOF
> D [29/Oct/2010:15:56:00 -0700] cupsdCloseClient: 12
> D [29/Oct/2010:15:56:00 -0700] Script header: Location:
> http://localhost:631/admin
> D [29/Oct/2010:15:56:00 -0700] Script header:
> D [29/Oct/2010:15:56:00 -0700] cupsdSetBusyState: Dirty files
> D [29/Oct/2010:15:56:00 -0700] cupsdReadClient: 10 GET /admin HTTP/1.1
> D [29/Oct/2010:15:56:00 -0700] cupsdSetBusyState: Active clients and dirty files
> D [29/Oct/2010:15:56:00 -0700] cupsdAuthorize: Authorized as root using Basic
> D [29/Oct/2010:15:56:00 -0700] [CGI] argv[0] = "/usr/lib/cups/cgi-bin/admin.cgi"
> D [29/Oct/2010:15:56:00 -0700] [CGI] envp[0] = "CUPS_CACHEDIR=/var/cache/cups"
> D [29/Oct/2010:15:56:00 -0700] [CGI] envp[1] = "CUPS_DATADIR=/usr/share/cups"
> D [29/Oct/2010:15:56:00 -0700] [CGI] envp[2] =
> "CUPS_DOCROOT=/usr/share/doc/cups"
> D [29/Oct/2010:15:56:00 -0700] [CGI] envp[3] =
> "CUPS_FONTPATH=/usr/share/cups/fonts"
> D [29/Oct/2010:15:56:00 -0700] [CGI] envp[4] =
> "CUPS_REQUESTROOT=/var/spool/cups"
> D [29/Oct/2010:15:56:00 -0700] [CGI] envp[5] = "CUPS_SERVERBIN=/usr/lib/cups"
> D [29/Oct/2010:15:56:00 -0700] [CGI] envp[6] = "CUPS_SERVERROOT=/etc/cups"
> D [29/Oct/2010:15:56:00 -0700] [CGI] envp[7] = "CUPS_STATEDIR=/var/run/cups"
> D [29/Oct/2010:15:56:00 -0700] [CGI] envp[8] = "HOME=/var/spool/cups/tmp"
> D [29/Oct/2010:15:56:00 -0700] [CGI] envp[9] =
> "PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
> D [29/Oct/2010:15:56:00 -0700] [CGI] envp[10] = "SERVER_ADMIN=root at omap3-multi"
> D [29/Oct/2010:15:56:00 -0700] [CGI] envp[11] = "SOFTWARE=CUPS/1.4.4"
> D [29/Oct/2010:15:56:00 -0700] [CGI] envp[12] = "TMPDIR=/var/spool/cups/tmp"
> D [29/Oct/2010:15:56:00 -0700] [CGI] envp[13] = "USER=root"
> D [29/Oct/2010:15:56:00 -0700] [CGI] envp[14] =
> "CUPS_SERVER=/var/run/cups/cups.sock"
> D [29/Oct/2010:15:56:00 -0700] [CGI] envp[15] = "CUPS_ENCRYPTION=IfRequested"
> D [29/Oct/2010:15:56:00 -0700] [CGI] envp[16] = "IPP_PORT=631"
> D [29/Oct/2010:15:56:00 -0700] [CGI] envp[17] = "CUPSD_AUTH_TYPE=Basic"
> D [29/Oct/2010:15:56:00 -0700] [CGI] envp[18] = "LANG=en_US.UTF8"
> D [29/Oct/2010:15:56:00 -0700] [CGI] envp[19] = "REDIRECT_STATUS=1"
> D [29/Oct/2010:15:56:00 -0700] [CGI] envp[20] = "GATEWAY_INTERFACE=CGI/1.1"
> D [29/Oct/2010:15:56:00 -0700] [CGI] envp[21] = "SERVER_NAME=localhost"
> D [29/Oct/2010:15:56:00 -0700] [CGI] envp[22] = "SERVER_PORT=631"
> D [29/Oct/2010:15:56:00 -0700] [CGI] envp[23] = "REMOTE_ADDR=127.0.0.1"
> D [29/Oct/2010:15:56:00 -0700] [CGI] envp[24] = "REMOTE_HOST=localhost"
> D [29/Oct/2010:15:56:00 -0700] [CGI] envp[25] = "SCRIPT_NAME=/admin"
> D [29/Oct/2010:15:56:00 -0700] [CGI] envp[26] =
> "SCRIPT_FILENAME=/usr/share/doc/cups/admin"
> D [29/Oct/2010:15:56:00 -0700] [CGI] envp[27] = "REMOTE_USER=root"
> D [29/Oct/2010:15:56:00 -0700] [CGI] envp[28] = "SERVER_PROTOCOL=HTTP/1.1"
> D [29/Oct/2010:15:56:00 -0700] [CGI] envp[29] =
> "HTTP_COOKIE=org.cups.sid=013b9ec7635f9fccdf8554253ebf5082"
> D [29/Oct/2010:15:56:00 -0700] [CGI] envp[30] =
> "HTTP_USER_AGENT=Mozilla/5.0 (X11; U; Linux armv7l; c)
> AppleWebKit/534.7+ (KHTML, like Gecko) Version/5.0 Safari/534.7+
> Epiphany/2.30.2"
> D [29/Oct/2010:15:56:00 -0700] [CGI] envp[31] =
> "HTTP_REFERER=http://localhost:631/admin/"
> D [29/Oct/2010:15:56:00 -0700] [CGI] envp[32] = "REQUEST_METHOD=GET"
> D [29/Oct/2010:15:56:00 -0700] [CGI] envp[33] = "QUERY_STRING="
> D [29/Oct/2010:15:56:00 -0700] [CGI] Started
> /usr/lib/cups/cgi-bin/admin.cgi (PID 8062)
> I [29/Oct/2010:15:56:00 -0700] Started
> "/usr/lib/cups/cgi-bin/admin.cgi" (pid=8062)
> D [29/Oct/2010:15:56:00 -0700] cupsdSendCommand: 10 file=11
> D [29/Oct/2010:15:56:00 -0700] PID 8061
> (/usr/lib/cups/cgi-bin/admin.cgi) exited with no errors.
> D [29/Oct/2010:15:56:00 -0700] [CGI] admin.cgi started...
> D [29/Oct/2010:15:56:00 -0700] cupsdAcceptClient: 12 from localhost (Domain)
> D [29/Oct/2010:15:56:00 -0700] [CGI] http=0x1f968
> D [29/Oct/2010:15:56:00 -0700] [CGI] org.cups.sid cookie is
> "013b9ec7635f9fccdf8554253ebf5082"
> D [29/Oct/2010:15:56:00 -0700] [CGI] No form data, showing main menu...
> D [29/Oct/2010:15:56:00 -0700] [CGI]
> /usr/share/cups/drivers/pscript5.dll: No such file or directory
> D [29/Oct/2010:15:56:00 -0700] cupsdReadClient: 12 POST / HTTP/1.1
> D [29/Oct/2010:15:56:00 -0700] cupsdAuthorize: No authentication data provided.
> D [29/Oct/2010:15:56:00 -0700] cupsdReadClient: 12 1.1 Get-Subscriptions 1
> D [29/Oct/2010:15:56:00 -0700] Get-Subscriptions ipp://localhost/
> D [29/Oct/2010:15:56:00 -0700] Get-Subscriptions
> client-error-not-found: No subscriptions found.
> D [29/Oct/2010:15:56:00 -0700] Returning IPP client-error-not-found
> for Get-Subscriptions (ipp://localhost/) from localhost
> D [29/Oct/2010:15:56:00 -0700] Script header: Content-Type:
> text/html;charset=utf-8
> D [29/Oct/2010:15:56:00 -0700] Script header:
> D [29/Oct/2010:15:56:00 -0700] cupsdReadClient: 12 WAITING Closing on EOF
> D [29/Oct/2010:15:56:00 -0700] cupsdCloseClient: 12
> D [29/Oct/2010:15:56:00 -0700] cupsdSetBusyState: Dirty files
> D [29/Oct/2010:15:56:00 -0700] PID 8062
> (/usr/lib/cups/cgi-bin/admin.cgi) exited with no errors.
> D [29/Oct/2010:15:56:04 -0700] cupsdReadClient: 10 GET /printers/? HTTP/1..1
> D [29/Oct/2010:15:56:04 -0700] cupsdSetBusyState: Active clients and dirty files
> D [29/Oct/2010:15:56:04 -0700] cupsdAuthorize: No authentication data provided.
> D [29/Oct/2010:15:56:04 -0700] [CGI] argv[0] =
> "/usr/lib/cups/cgi-bin/printers.cgi"
> D [29/Oct/2010:15:56:04 -0700] [CGI] envp[0] = "CUPS_CACHEDIR=/var/cache/cups"
> D [29/Oct/2010:15:56:04 -0700] [CGI] envp[1] = "CUPS_DATADIR=/usr/share/cups"
> D [29/Oct/2010:15:56:04 -0700] [CGI] envp[2] =
> "CUPS_DOCROOT=/usr/share/doc/cups"
> D [29/Oct/2010:15:56:04 -0700] [CGI] envp[3] =
> "CUPS_FONTPATH=/usr/share/cups/fonts"
> D [29/Oct/2010:15:56:04 -0700] [CGI] envp[4] =
> "CUPS_REQUESTROOT=/var/spool/cups"
> D [29/Oct/2010:15:56:04 -0700] [CGI] envp[5] = "CUPS_SERVERBIN=/usr/lib/cups"
> D [29/Oct/2010:15:56:04 -0700] [CGI] envp[6] = "CUPS_SERVERROOT=/etc/cups"
> D [29/Oct/2010:15:56:04 -0700] [CGI] envp[7] = "CUPS_STATEDIR=/var/run/cups"
> D [29/Oct/2010:15:56:04 -0700] [CGI] envp[8] = "HOME=/var/spool/cups/tmp"
> D [29/Oct/2010:15:56:04 -0700] [CGI] envp[9] =
> "PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
> D [29/Oct/2010:15:56:04 -0700] [CGI] envp[10] = "SERVER_ADMIN=root at omap3-multi"
> D [29/Oct/2010:15:56:04 -0700] [CGI] envp[11] = "SOFTWARE=CUPS/1.4.4"
> D [29/Oct/2010:15:56:04 -0700] [CGI] envp[12] = "TMPDIR=/var/spool/cups/tmp"
> D [29/Oct/2010:15:56:04 -0700] [CGI] envp[13] = "USER=root"
> D [29/Oct/2010:15:56:04 -0700] [CGI] envp[14] =
> "CUPS_SERVER=/var/run/cups/cups.sock"
> D [29/Oct/2010:15:56:04 -0700] [CGI] envp[15] = "CUPS_ENCRYPTION=IfRequested"
> D [29/Oct/2010:15:56:04 -0700] [CGI] envp[16] = "IPP_PORT=631"
> D [29/Oct/2010:15:56:04 -0700] [CGI] envp[17] = "LANG=en_US.UTF8"
> D [29/Oct/2010:15:56:04 -0700] [CGI] envp[18] = "REDIRECT_STATUS=1"
> D [29/Oct/2010:15:56:04 -0700] [CGI] envp[19] = "GATEWAY_INTERFACE=CGI/1.1"
> D [29/Oct/2010:15:56:04 -0700] [CGI] envp[20] = "SERVER_NAME=localhost"
> D [29/Oct/2010:15:56:04 -0700] [CGI] envp[21] = "SERVER_PORT=631"
> D [29/Oct/2010:15:56:04 -0700] [CGI] envp[22] = "REMOTE_ADDR=127.0.0.1"
> D [29/Oct/2010:15:56:04 -0700] [CGI] envp[23] = "REMOTE_HOST=localhost"
> D [29/Oct/2010:15:56:04 -0700] [CGI] envp[24] = "SCRIPT_NAME=/printers/"
> D [29/Oct/2010:15:56:04 -0700] [CGI] envp[25] =
> "SCRIPT_FILENAME=/usr/share/doc/cups/printers/"
> D [29/Oct/2010:15:56:04 -0700] [CGI] envp[26] = "PATH_INFO=/"
> D [29/Oct/2010:15:56:04 -0700] [CGI] envp[27] = "SERVER_PROTOCOL=HTTP/1.1"
> D [29/Oct/2010:15:56:04 -0700] [CGI] envp[28] =
> "HTTP_COOKIE=org.cups.sid=013b9ec7635f9fccdf8554253ebf5082"
> D [29/Oct/2010:15:56:04 -0700] [CGI] envp[29] =
> "HTTP_USER_AGENT=Mozilla/5.0 (X11; U; Linux armv7l; c)
> AppleWebKit/534.7+ (KHTML, like Gecko) Version/5.0 Safari/534.7+
> Epiphany/2.30.2"
> D [29/Oct/2010:15:56:04 -0700] [CGI] envp[30] =
> "HTTP_REFERER=http://localhost:631/admin"
> D [29/Oct/2010:15:56:04 -0700] [CGI] envp[31] = "REQUEST_METHOD=GET"
> D [29/Oct/2010:15:56:04 -0700] [CGI] envp[32] = "QUERY_STRING="
> D [29/Oct/2010:15:56:04 -0700] [CGI] Started
> /usr/lib/cups/cgi-bin/printers.cgi (PID 8063)
> I [29/Oct/2010:15:56:04 -0700] Started
> "/usr/lib/cups/cgi-bin/printers.cgi" (pid=8063)
> D [29/Oct/2010:15:56:04 -0700] cupsdSendCommand: 10 file=11
> D [29/Oct/2010:15:56:04 -0700] [CGI] org.cups.sid cookie is
> "013b9ec7635f9fccdf8554253ebf5082"
> D [29/Oct/2010:15:56:04 -0700] cupsdAcceptClient: 12 from localhost (Domain)
> D [29/Oct/2010:15:56:04 -0700] cupsdReadClient: 12 POST / HTTP/1.1
> D [29/Oct/2010:15:56:04 -0700] cupsdAuthorize: No authentication data provided.
> D [29/Oct/2010:15:56:04 -0700] cupsdReadClient: 12 1.1 CUPS-Get-Default 1
> D [29/Oct/2010:15:56:04 -0700] CUPS-Get-Default
> D [29/Oct/2010:15:56:04 -0700] CUPS-Get-Default
> client-error-not-found: No default printer
> D [29/Oct/2010:15:56:04 -0700] Returning IPP client-error-not-found
> for CUPS-Get-Default (no URI) from localhost
> D [29/Oct/2010:15:56:04 -0700] [CGI] show_all_printers(http=0x15490,
> user="(null)")
> D [29/Oct/2010:15:56:04 -0700] Script header: Content-Type:
> text/html;charset=utf-8
> D [29/Oct/2010:15:56:04 -0700] Script header:
> D [29/Oct/2010:15:56:04 -0700] cupsdReadClient: 12 POST / HTTP/1.1
> D [29/Oct/2010:15:56:04 -0700] cupsdAuthorize: No authentication data provided.
> D [29/Oct/2010:15:56:04 -0700] cupsdReadClient: 12 1.1 CUPS-Get-Printers 1
> D [29/Oct/2010:15:56:04 -0700] CUPS-Get-Printers
> D [29/Oct/2010:15:56:04 -0700] Returning IPP successful-ok for
> CUPS-Get-Printers (no URI) from localhost
> D [29/Oct/2010:15:56:04 -0700] cupsdReadClient: 12 WAITING Closing on EOF
> D [29/Oct/2010:15:56:04 -0700] cupsdCloseClient: 12
> D [29/Oct/2010:15:56:04 -0700] cupsdSetBusyState: Dirty files
> D [29/Oct/2010:15:56:04 -0700] PID 8063
> (/usr/lib/cups/cgi-bin/printers.cgi) exited with no errors.
> D [29/Oct/2010:15:56:09 -0700] cupsdAcceptClient: 11 from localhost (Domain)
> D [29/Oct/2010:15:56:09 -0700] cupsdReadClient: 11 WAITING Closing on EOF
> D [29/Oct/2010:15:56:09 -0700] cupsdCloseClient: 11
> D [29/Oct/2010:15:56:09 -0700] cupsdAcceptClient: 11 from localhost (Domain)
> D [29/Oct/2010:15:56:10 -0700] cupsdReadClient: 11 POST / HTTP/1.1
> D [29/Oct/2010:15:56:10 -0700] cupsdSetBusyState: Active clients and dirty files
> D [29/Oct/2010:15:56:10 -0700] cupsdAuthorize: No authentication data provided.
> D [29/Oct/2010:15:56:10 -0700] cupsdReadClient: 11 1.1 CUPS-Get-Printers 1
> D [29/Oct/2010:15:56:10 -0700] CUPS-Get-Printers
> D [29/Oct/2010:15:56:10 -0700] Returning IPP successful-ok for
> CUPS-Get-Printers (no URI) from localhost
> D [29/Oct/2010:15:56:10 -0700] cupsdSetBusyState: Dirty files
> D [29/Oct/2010:15:56:10 -0700] cupsdReadClient: 11 WAITING Closing on EOF
> D [29/Oct/2010:15:56:10 -0700] cupsdCloseClient: 11
> D [29/Oct/2010:15:56:10 -0700] cupsdAcceptClient: 11 from localhost (Domain)
> D [29/Oct/2010:15:56:10 -0700] cupsdReadClient: 11 WAITING Closing on EOF
> D [29/Oct/2010:15:56:10 -0700] cupsdCloseClient: 11
> D [29/Oct/2010:15:56:10 -0700] cupsdAcceptClient: 11 from localhost (Domain)
> D [29/Oct/2010:15:56:10 -0700] cupsdReadClient: 11 POST / HTTP/1.1
> D [29/Oct/2010:15:56:10 -0700] cupsdSetBusyState: Active clients and dirty files
> D [29/Oct/2010:15:56:10 -0700] cupsdAuthorize: No authentication data provided.
> D [29/Oct/2010:15:56:10 -0700] cupsdReadClient: 11 1.1 CUPS-Get-Printers 1
> D [29/Oct/2010:15:56:10 -0700] CUPS-Get-Printers
> D [29/Oct/2010:15:56:10 -0700] Returning IPP successful-ok for
> CUPS-Get-Printers (no URI) from localhost
> D [29/Oct/2010:15:56:10 -0700] cupsdSetBusyState: Dirty files
> D [29/Oct/2010:15:56:10 -0700] cupsdReadClient: 11 WAITING Closing on EOF
> D [29/Oct/2010:15:56:10 -0700] cupsdCloseClient: 11
> D [29/Oct/2010:15:56:10 -0700] cupsdAcceptClient: 11 from localhost (Domain)
> D [29/Oct/2010:15:56:10 -0700] cupsdReadClient: 11 WAITING Closing on EOF
> D [29/Oct/2010:15:56:10 -0700] cupsdCloseClient: 11
> D [29/Oct/2010:15:56:10 -0700] cupsdAcceptClient: 11 from localhost (Domain)
> D [29/Oct/2010:15:56:10 -0700] cupsdReadClient: 11 POST / HTTP/1.1
> D [29/Oct/2010:15:56:10 -0700] cupsdSetBusyState: Active clients and dirty files
> D [29/Oct/2010:15:56:10 -0700] cupsdAuthorize: No authentication data provided.
> D [29/Oct/2010:15:56:10 -0700] cupsdReadClient: 11 1.1 CUPS-Get-Printers 1
> D [29/Oct/2010:15:56:10 -0700] CUPS-Get-Printers
> D [29/Oct/2010:15:56:10 -0700] Returning IPP successful-ok for
> CUPS-Get-Printers (no URI) from localhost
> D [29/Oct/2010:15:56:10 -0700] cupsdSetBusyState: Dirty files
> D [29/Oct/2010:15:56:10 -0700] cupsdReadClient: 11 WAITING Closing on EOF
> D [29/Oct/2010:15:56:10 -0700] cupsdCloseClient: 11
> D [29/Oct/2010:15:56:10 -0700] cupsdAcceptClient: 11 from localhost (Domain)
> D [29/Oct/2010:15:56:10 -0700] cupsdReadClient: 11 WAITING Closing on EOF
> D [29/Oct/2010:15:56:10 -0700] cupsdCloseClient: 11
> D [29/Oct/2010:15:56:10 -0700] cupsdAcceptClient: 11 from localhost (Domain)
> D [29/Oct/2010:15:56:10 -0700] cupsdReadClient: 11 POST / HTTP/1.1
> D [29/Oct/2010:15:56:10 -0700] cupsdSetBusyState: Active clients and dirty files
> D [29/Oct/2010:15:56:10 -0700] cupsdAuthorize: No authentication data provided.
> D [29/Oct/2010:15:56:10 -0700] cupsdReadClient: 11 1.1 CUPS-Get-Printers 1
> D [29/Oct/2010:15:56:10 -0700] CUPS-Get-Printers
> D [29/Oct/2010:15:56:10 -0700] Returning IPP successful-ok for
> CUPS-Get-Printers (no URI) from localhost
> D [29/Oct/2010:15:56:10 -0700] cupsdSetBusyState: Dirty files
> D [29/Oct/2010:15:56:10 -0700] cupsdReadClient: 11 WAITING Closing on EOF
> D [29/Oct/2010:15:56:10 -0700] cupsdCloseClient: 11
> D [29/Oct/2010:15:56:11 -0700] cupsdAcceptClient: 11 from localhost (Domain)
> D [29/Oct/2010:15:56:11 -0700] cupsdReadClient: 11 WAITING Closing on EOF
> D [29/Oct/2010:15:56:11 -0700] cupsdCloseClient: 11
> D [29/Oct/2010:15:56:11 -0700] cupsdAcceptClient: 11 from localhost (Domain)
> D [29/Oct/2010:15:56:11 -0700] cupsdReadClient: 11 POST / HTTP/1.1
> D [29/Oct/2010:15:56:11 -0700] cupsdSetBusyState: Active clients and dirty files
> D [29/Oct/2010:15:56:11 -0700] cupsdAuthorize: No authentication data provided.
> D [29/Oct/2010:15:56:11 -0700] cupsdReadClient: 11 1.1 CUPS-Get-Printers 1
> D [29/Oct/2010:15:56:11 -0700] CUPS-Get-Printers
> D [29/Oct/2010:15:56:11 -0700] Returning IPP successful-ok for
> CUPS-Get-Printers (no URI) from localhost
> D [29/Oct/2010:15:56:11 -0700] cupsdSetBusyState: Dirty files
> D [29/Oct/2010:15:56:11 -0700] cupsdReadClient: 11 WAITING Closing on EOF
> D [29/Oct/2010:15:56:11 -0700] cupsdCloseClient: 11
> D [29/Oct/2010:15:56:11 -0700] cupsdAcceptClient: 11 from localhost (Domain)
> D [29/Oct/2010:15:56:11 -0700] cupsdReadClient: 11 WAITING Closing on EOF
> D [29/Oct/2010:15:56:11 -0700] cupsdCloseClient: 11
> D [29/Oct/2010:15:56:11 -0700] cupsdAcceptClient: 11 from localhost (Domain)
> D [29/Oct/2010:15:56:11 -0700] cupsdReadClient: 11 POST / HTTP/1.1
> D [29/Oct/2010:15:56:11 -0700] cupsdSetBusyState: Active clients and dirty files
> D [29/Oct/2010:15:56:11 -0700] cupsdAuthorize: No authentication data provided.
> D [29/Oct/2010:15:56:11 -0700] cupsdReadClient: 11 1.1 CUPS-Get-Printers 1
> D [29/Oct/2010:15:56:11 -0700] CUPS-Get-Printers
> D [29/Oct/2010:15:56:11 -0700] Returning IPP successful-ok for
> CUPS-Get-Printers (no URI) from localhost
> D [29/Oct/2010:15:56:11 -0700] cupsdSetBusyState: Dirty files
> D [29/Oct/2010:15:56:11 -0700] cupsdReadClient: 11 WAITING Closing on EOF
> D [29/Oct/2010:15:56:11 -0700] cupsdCloseClient: 11
> D [29/Oct/2010:15:56:11 -0700] cupsdAcceptClient: 11 from localhost (Domain)
> D [29/Oct/2010:15:56:11 -0700] cupsdReadClient: 11 GET
> /printers/HP7410.ppd HTTP/1.1
> D [29/Oct/2010:15:56:11 -0700] cupsdSetBusyState: Active clients and dirty files
> D [29/Oct/2010:15:56:11 -0700] cupsdAuthorize: No authentication data provided.
> D [29/Oct/2010:15:56:11 -0700] cupsdSetBusyState: Dirty files
> D [29/Oct/2010:15:56:11 -0700] cupsdReadClient: 11 WAITING Closing on EOF
> D [29/Oct/2010:15:56:11 -0700] cupsdCloseClient: 11
> D [29/Oct/2010:15:56:11 -0700] cupsdAcceptClient: 11 from localhost (Domain)
> D [29/Oct/2010:15:56:11 -0700] cupsdReadClient: 11 WAITING Closing on EOF
> D [29/Oct/2010:15:56:11 -0700] cupsdCloseClient: 11
> D [29/Oct/2010:15:56:11 -0700] cupsdAcceptClient: 11 from localhost (Domain)
> D [29/Oct/2010:15:56:11 -0700] cupsdReadClient: 11 POST / HTTP/1.1
> D [29/Oct/2010:15:56:11 -0700] cupsdSetBusyState: Active clients and dirty files
> D [29/Oct/2010:15:56:11 -0700] cupsdAuthorize: No authentication data provided.
> D [29/Oct/2010:15:56:12 -0700] cupsdReadClient: 11 1.1 CUPS-Get-Printers 1
> D [29/Oct/2010:15:56:12 -0700] CUPS-Get-Printers
> D [29/Oct/2010:15:56:12 -0700] Returning IPP successful-ok for
> CUPS-Get-Printers (no URI) from localhost
> D [29/Oct/2010:15:56:12 -0700] cupsdSetBusyState: Dirty files
> D [29/Oct/2010:15:56:12 -0700] cupsdReadClient: 11 WAITING Closing on EOF
> D [29/Oct/2010:15:56:12 -0700] cupsdCloseClient: 11
> D [29/Oct/2010:15:56:12 -0700] cupsdAcceptClient: 11 from localhost (Domain)
> D [29/Oct/2010:15:56:12 -0700] cupsdReadClient: 11 WAITING Closing on EOF
> D [29/Oct/2010:15:56:12 -0700] cupsdCloseClient: 11
> D [29/Oct/2010:15:56:12 -0700] cupsdAcceptClient: 11 from localhost (Domain)
> D [29/Oct/2010:15:56:12 -0700] cupsdReadClient: 11 POST / HTTP/1.1
> D [29/Oct/2010:15:56:12 -0700] cupsdSetBusyState: Active clients and dirty files
> D [29/Oct/2010:15:56:12 -0700] cupsdAuthorize: No authentication data provided.
> D [29/Oct/2010:15:56:12 -0700] cupsdReadClient: 11 1.1 CUPS-Get-Printers 1
> D [29/Oct/2010:15:56:12 -0700] CUPS-Get-Printers
> D [29/Oct/2010:15:56:12 -0700] Returning IPP successful-ok for
> CUPS-Get-Printers (no URI) from localhost
> D [29/Oct/2010:15:56:12 -0700] cupsdSetBusyState: Dirty files
> D [29/Oct/2010:15:56:12 -0700] cupsdReadClient: 11 WAITING Closing on EOF
> D [29/Oct/2010:15:56:12 -0700] cupsdCloseClient: 11
> D [29/Oct/2010:15:56:12 -0700] cupsdAcceptClient: 11 from localhost (Domain)
> D [29/Oct/2010:15:56:12 -0700] cupsdReadClient: 11 WAITING Closing on EOF
> D [29/Oct/2010:15:56:12 -0700] cupsdCloseClient: 11
> D [29/Oct/2010:15:56:12 -0700] cupsdAcceptClient: 11 from localhost (Domain)
> D [29/Oct/2010:15:56:12 -0700] cupsdReadClient: 11 POST / HTTP/1.1
> D [29/Oct/2010:15:56:12 -0700] cupsdSetBusyState: Active clients and dirty files
> D [29/Oct/2010:15:56:12 -0700] cupsdAuthorize: No authentication data provided.
> D [29/Oct/2010:15:56:12 -0700] cupsdReadClient: 11 1.1 CUPS-Get-Printers 1
> D [29/Oct/2010:15:56:12 -0700] CUPS-Get-Printers
> D [29/Oct/2010:15:56:12 -0700] Returning IPP successful-ok for
> CUPS-Get-Printers (no URI) from localhost
> D [29/Oct/2010:15:56:12 -0700] cupsdSetBusyState: Dirty files
> D [29/Oct/2010:15:56:12 -0700] cupsdReadClient: 11 WAITING Closing on EOF
> D [29/Oct/2010:15:56:12 -0700] cupsdCloseClient: 11
> D [29/Oct/2010:15:56:13 -0700] cupsdAcceptClient: 11 from localhost (Domain)
> D [29/Oct/2010:15:56:13 -0700] cupsdReadClient: 11 WAITING Closing on EOF
> D [29/Oct/2010:15:56:13 -0700] cupsdCloseClient: 11
> D [29/Oct/2010:15:56:13 -0700] cupsdAcceptClient: 11 from localhost (Domain)
> D [29/Oct/2010:15:56:13 -0700] cupsdReadClient: 11 POST / HTTP/1.1
> D [29/Oct/2010:15:56:13 -0700] cupsdSetBusyState: Active clients and dirty files
> D [29/Oct/2010:15:56:13 -0700] cupsdAuthorize: No authentication data provided.
> D [29/Oct/2010:15:56:13 -0700] cupsdReadClient: 11 1.1 CUPS-Get-Printers 1
> D [29/Oct/2010:15:56:13 -0700] CUPS-Get-Printers
> D [29/Oct/2010:15:56:13 -0700] Returning IPP successful-ok for
> CUPS-Get-Printers (no URI) from localhost
> D [29/Oct/2010:15:56:13 -0700] cupsdSetBusyState: Dirty files
> D [29/Oct/2010:15:56:13 -0700] cupsdReadClient: 11 WAITING Closing on EOF
> D [29/Oct/2010:15:56:13 -0700] cupsdCloseClient: 11
> D [29/Oct/2010:15:56:13 -0700] cupsdAcceptClient: 11 from localhost (Domain)
> D [29/Oct/2010:15:56:13 -0700] cupsdReadClient: 11 WAITING Closing on EOF
> D [29/Oct/2010:15:56:13 -0700] cupsdCloseClient: 11
> D [29/Oct/2010:15:56:13 -0700] cupsdAcceptClient: 11 from localhost (Domain)
> D [29/Oct/2010:15:56:13 -0700] cupsdReadClient: 11 POST / HTTP/1.1
> D [29/Oct/2010:15:56:13 -0700] cupsdSetBusyState: Active clients and dirty files
> D [29/Oct/2010:15:56:13 -0700] cupsdAuthorize: No authentication data provided.
> D [29/Oct/2010:15:56:13 -0700] cupsdReadClient: 11 1.1 CUPS-Get-Printers 1
> D [29/Oct/2010:15:56:13 -0700] CUPS-Get-Printers
> D [29/Oct/2010:15:56:13 -0700] Returning IPP successful-ok for
> CUPS-Get-Printers (no URI) from localhost
> D [29/Oct/2010:15:56:13 -0700] cupsdSetBusyState: Dirty files
> D [29/Oct/2010:15:56:13 -0700] cupsdReadClient: 11 WAITING Closing on EOF
> D [29/Oct/2010:15:56:13 -0700] cupsdCloseClient: 11
> D [29/Oct/2010:15:56:13 -0700] cupsdAcceptClient: 11 from localhost (Domain)
> D [29/Oct/2010:15:56:13 -0700] cupsdReadClient: 11 WAITING Closing on EOF
> D [29/Oct/2010:15:56:13 -0700] cupsdCloseClient: 11
> D [29/Oct/2010:15:56:13 -0700] cupsdAcceptClient: 11 from localhost (Domain)
> D [29/Oct/2010:15:56:13 -0700] cupsdReadClient: 11 POST / HTTP/1.1
> D [29/Oct/2010:15:56:13 -0700] cupsdSetBusyState: Active clients and dirty files
> D [29/Oct/2010:15:56:13 -0700] cupsdAuthorize: No authentication data provided.
> D [29/Oct/2010:15:56:13 -0700] cupsdReadClient: 11 1.1 CUPS-Get-Printers 1
> D [29/Oct/2010:15:56:13 -0700] CUPS-Get-Printers
> D [29/Oct/2010:15:56:13 -0700] Returning IPP successful-ok for
> CUPS-Get-Printers (no URI) from localhost
> D [29/Oct/2010:15:56:13 -0700] cupsdSetBusyState: Dirty files
> D [29/Oct/2010:15:56:13 -0700] cupsdReadClient: 11 WAITING Closing on EOF
> D [29/Oct/2010:15:56:13 -0700] cupsdCloseClient: 11
> D [29/Oct/2010:15:56:13 -0700] cupsdAcceptClient: 11 from localhost (Domain)
> D [29/Oct/2010:15:56:13 -0700] cupsdReadClient: 11 WAITING Closing on EOF
> D [29/Oct/2010:15:56:13 -0700] cupsdCloseClient: 11
> D [29/Oct/2010:15:56:13 -0700] cupsdAcceptClient: 11 from localhost (Domain)
> D [29/Oct/2010:15:56:13 -0700] cupsdReadClient: 11 POST / HTTP/1.1
> D [29/Oct/2010:15:56:13 -0700] cupsdSetBusyState: Active clients and dirty files
> D [29/Oct/2010:15:56:13 -0700] cupsdAuthorize: No authentication data provided.
> D [29/Oct/2010:15:56:13 -0700] cupsdReadClient: 11 1.1 CUPS-Get-Printers 1
> D [29/Oct/2010:15:56:13 -0700] CUPS-Get-Printers
> D [29/Oct/2010:15:56:13 -0700] Returning IPP successful-ok for
> CUPS-Get-Printers (no URI) from localhost
> D [29/Oct/2010:15:56:13 -0700] cupsdSetBusyState: Dirty files
> D [29/Oct/2010:15:56:13 -0700] cupsdReadClient: 11 WAITING Closing on EOF
> D [29/Oct/2010:15:56:13 -0700] cupsdCloseClient: 11
> D [29/Oct/2010:15:56:13 -0700] cupsdAcceptClient: 11 from localhost (Domain)
> D [29/Oct/2010:15:56:13 -0700] cupsdReadClient: 11 WAITING Closing on EOF
> D [29/Oct/2010:15:56:13 -0700] cupsdCloseClient: 11
> D [29/Oct/2010:15:56:13 -0700] cupsdAcceptClient: 11 from localhost (Domain)
> D [29/Oct/2010:15:56:13 -0700] cupsdReadClient: 11 POST / HTTP/1.1
> D [29/Oct/2010:15:56:13 -0700] cupsdSetBusyState: Active clients and dirty files
> D [29/Oct/2010:15:56:13 -0700] cupsdAuthorize: No authentication data provided.
> D [29/Oct/2010:15:56:13 -0700] cupsdReadClient: 11 1.1 CUPS-Get-Printers 1
> D [29/Oct/2010:15:56:13 -0700] CUPS-Get-Printers
> D [29/Oct/2010:15:56:13 -0700] Returning IPP successful-ok for
> CUPS-Get-Printers (no URI) from localhost
> D [29/Oct/2010:15:56:13 -0700] cupsdSetBusyState: Dirty files
> D [29/Oct/2010:15:56:13 -0700] cupsdReadClient: 11 WAITING Closing on EOF
> D [29/Oct/2010:15:56:13 -0700] cupsdCloseClient: 11
> D [29/Oct/2010:15:56:14 -0700] cupsdAcceptClient: 11 from localhost (Domain)
> D [29/Oct/2010:15:56:14 -0700] cupsdReadClient: 11 WAITING Closing on EOF
> D [29/Oct/2010:15:56:14 -0700] cupsdCloseClient: 11
> D [29/Oct/2010:15:56:14 -0700] cupsdAcceptClient: 11 from localhost (Domain)
> D [29/Oct/2010:15:56:14 -0700] cupsdReadClient: 11 POST / HTTP/1.1
> D [29/Oct/2010:15:56:14 -0700] cupsdSetBusyState: Active clients and dirty files
> D [29/Oct/2010:15:56:14 -0700] cupsdAuthorize: No authentication data provided.
> D [29/Oct/2010:15:56:14 -0700] cupsdReadClient: 11 1.1 CUPS-Get-Printers 1
> D [29/Oct/2010:15:56:14 -0700] CUPS-Get-Printers
> D [29/Oct/2010:15:56:14 -0700] Returning IPP successful-ok for
> CUPS-Get-Printers (no URI) from localhost
> D [29/Oct/2010:15:56:14 -0700] cupsdSetBusyState: Dirty files
> D [29/Oct/2010:15:56:14 -0700] cupsdReadClient: 11 WAITING Closing on EOF
> D [29/Oct/2010:15:56:14 -0700] cupsdCloseClient: 11
> D [29/Oct/2010:15:56:14 -0700] cupsdAcceptClient: 11 from localhost (Domain)
> D [29/Oct/2010:15:56:14 -0700] cupsdAcceptClient: 12 from localhost (Domain)
> D [29/Oct/2010:15:56:14 -0700] cupsdReadClient: 11 WAITING Closing on EOF
> D [29/Oct/2010:15:56:14 -0700] cupsdCloseClient: 11
> D [29/Oct/2010:15:56:14 -0700] cupsdReadClient: 12 POST / HTTP/1.1
> D [29/Oct/2010:15:56:14 -0700] cupsdSetBusyState: Active clients and dirty files
> D [29/Oct/2010:15:56:14 -0700] cupsdAuthorize: No authentication data provided.
> D [29/Oct/2010:15:56:14 -0700] cupsdReadClient: 12 1.1 CUPS-Get-Printers 1
> D [29/Oct/2010:15:56:14 -0700] CUPS-Get-Printers
> D [29/Oct/2010:15:56:14 -0700] Returning IPP successful-ok for
> CUPS-Get-Printers (no URI) from localhost
> D [29/Oct/2010:15:56:14 -0700] cupsdSetBusyState: Dirty files
> D [29/Oct/2010:15:56:14 -0700] cupsdReadClient: 12 WAITING Closing on EOF
> D [29/Oct/2010:15:56:14 -0700] cupsdCloseClient: 12
> D [29/Oct/2010:15:56:15 -0700] cupsdAcceptClient: 11 from localhost (Domain)
> D [29/Oct/2010:15:56:15 -0700] cupsdReadClient: 11 POST
> /printers/HP7410 HTTP/1.1
> D [29/Oct/2010:15:56:15 -0700] cupsdSetBusyState: Active clients and dirty files
> D [29/Oct/2010:15:56:15 -0700] cupsdAuthorize: No authentication data provided.
> D [29/Oct/2010:15:56:15 -0700] cupsdReadClient: 11 1.1 Print-Job 1
> D [29/Oct/2010:15:56:15 -0700] Print-Job ipp://localhost:631/printers/HP7410
> D [29/Oct/2010:15:56:15 -0700] [Job ???] Auto-typing file...
> I [29/Oct/2010:15:56:15 -0700] [Job ???] Request file type is
> application/postscript.
> D [29/Oct/2010:15:56:15 -0700] cupsdMarkDirty(----J-)
> D [29/Oct/2010:15:56:15 -0700] add_job: requesting-user-name="root"
> I [29/Oct/2010:15:56:15 -0700] [Job 1] Adding start banner page "none".
> D [29/Oct/2010:15:56:15 -0700] Discarding unused job-created event...
> D [29/Oct/2010:15:56:15 -0700] cupsdMarkDirty(----J-)
> I [29/Oct/2010:15:56:15 -0700] [Job 1] Adding end banner page "none".
> I [29/Oct/2010:15:56:15 -0700] [Job 1] File of type
> application/postscript queued by "root".
> D [29/Oct/2010:15:56:15 -0700] [Job 1] hold_until=0
> I [29/Oct/2010:15:56:15 -0700] [Job 1] Queued on "HP7410" by "root".
> D [29/Oct/2010:15:56:15 -0700] cupsdMarkDirty(----J-)
> D [29/Oct/2010:15:56:15 -0700] cupsdSetBusyState: Active clients,
> printing jobs, and dirty files
> D [29/Oct/2010:15:56:15 -0700] Discarding unused printer-state-changed event...
> D [29/Oct/2010:15:56:15 -0700] [Job 1] job-sheets=none,none
> D [29/Oct/2010:15:56:15 -0700] [Job 1] argv[0]="HP7410"
> D [29/Oct/2010:15:56:15 -0700] [Job 1] argv[1]="1"
> D [29/Oct/2010:15:56:15 -0700] [Job 1] argv[2]="root"
> D [29/Oct/2010:15:56:15 -0700] [Job 1] argv[3]="Web Browser job #1"
> D [29/Oct/2010:15:56:15 -0700] [Job 1] argv[4]="1"
> D [29/Oct/2010:15:56:15 -0700] [Job 1] argv[5]="OutputMode=Normal
> MediaType=Automatic InputSlot=Auto ColorModel=RGB number-up=1
> Duplex=None PageSize=A4
> job-uuid=urn:uuid:d9a9dc22-d834-3730-650d-6e8d77a9565e
> job-originating-host-name=localhost"
> D [29/Oct/2010:15:56:15 -0700] [Job 1] argv[6]="/var/spool/cups/d00001-001"
> D [29/Oct/2010:15:56:15 -0700] [Job 1] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
> D [29/Oct/2010:15:56:15 -0700] [Job 1] envp[1]="CUPS_DATADIR=/usr/share/cups"
> D [29/Oct/2010:15:56:15 -0700] [Job 1]
> envp[2]="CUPS_DOCROOT=/usr/share/doc/cups"
> D [29/Oct/2010:15:56:15 -0700] [Job 1]
> envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
> D [29/Oct/2010:15:56:15 -0700] [Job 1]
> envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
> D [29/Oct/2010:15:56:15 -0700] [Job 1] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
> D [29/Oct/2010:15:56:15 -0700] [Job 1] envp[6]="CUPS_SERVERROOT=/etc/cups"
> D [29/Oct/2010:15:56:15 -0700] [Job 1] envp[7]="CUPS_STATEDIR=/var/run/cups"
> D [29/Oct/2010:15:56:15 -0700] [Job 1] envp[8]="HOME=/var/spool/cups/tmp"
> D [29/Oct/2010:15:56:15 -0700] [Job 1]
> envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
> D [29/Oct/2010:15:56:15 -0700] [Job 1] envp[10]="SERVER_ADMIN=root at omap3-multi"
> D [29/Oct/2010:15:56:15 -0700] [Job 1] envp[11]="SOFTWARE=CUPS/1.4.4"
> D [29/Oct/2010:15:56:15 -0700] [Job 1] envp[12]="TMPDIR=/var/spool/cups/tmp"
> D [29/Oct/2010:15:56:15 -0700] [Job 1] envp[13]="USER=root"
> D [29/Oct/2010:15:56:15 -0700] [Job 1]
> envp[14]="CUPS_SERVER=/var/run/cups/cups.sock"
> D [29/Oct/2010:15:56:15 -0700] [Job 1] envp[15]="CUPS_ENCRYPTION=IfRequested"
> D [29/Oct/2010:15:56:15 -0700] [Job 1] envp[16]="IPP_PORT=631"
> D [29/Oct/2010:15:56:15 -0700] [Job 1] envp[17]="CHARSET=utf-8"
> D [29/Oct/2010:15:56:15 -0700] [Job 1] envp[18]="LANG=en.UTF-8"
> D [29/Oct/2010:15:56:15 -0700] [Job 1] envp[19]="PPD=/etc/cups/ppd/HP7410.ppd"
> D [29/Oct/2010:15:56:15 -0700] [Job 1] envp[20]="RIP_MAX_CACHE=8m"
> D [29/Oct/2010:15:56:15 -0700] [Job 1]
> envp[21]="CONTENT_TYPE=application/postscript"
> D [29/Oct/2010:15:56:15 -0700] [Job 1]
> envp[22]="DEVICE_URI=socket://192.168.0.222:9100"
> D [29/Oct/2010:15:56:15 -0700] [Job 1] envp[23]="PRINTER_INFO=HP All-in-One"
> D [29/Oct/2010:15:56:15 -0700] [Job 1] envp[24]="PRINTER_LOCATION=Office"
> D [29/Oct/2010:15:56:15 -0700] [Job 1] envp[25]="PRINTER=HP7410"
> D [29/Oct/2010:15:56:15 -0700] [Job 1] envp[26]="CUPS_FILETYPE=document"
> D [29/Oct/2010:15:56:15 -0700] [Job 1]
> envp[27]="FINAL_CONTENT_TYPE=printer/HP7410"
> I [29/Oct/2010:15:56:15 -0700] [Job 1] Started filter
> /usr/lib/cups/filter/pstops (PID 8064)
> I [29/Oct/2010:15:56:15 -0700] [Job 1] Started filter
> /usr/lib/cups/filter/pstoraster (PID 8065)
> I [29/Oct/2010:15:56:15 -0700] [Job 1] Started filter
> /usr/lib/cups/filter/hpcups (PID 8066)
> I [29/Oct/2010:15:56:15 -0700] [Job 1] Started backend
> /usr/lib/cups/backend/socket (PID 8067)
> D [29/Oct/2010:15:56:15 -0700] Discarding unused job-state-changed event....
> D [29/Oct/2010:15:56:15 -0700] Returning IPP successful-ok for
> Print-Job (ipp://localhost:631/printers/HP7410) from localhost
> D [29/Oct/2010:15:56:15 -0700] cupsdSetBusyState: Printing jobs and dirty files
> D [29/Oct/2010:15:56:15 -0700] cupsdReadClient: 11 WAITING Closing on EOF
> D [29/Oct/2010:15:56:15 -0700] cupsdCloseClient: 11
> D [29/Oct/2010:15:56:15 -0700] [Job 1] STATE: +connecting-to-device
> D [29/Oct/2010:15:56:15 -0700] Discarding unused printer-state-changed event...
> D [29/Oct/2010:15:56:15 -0700] [Job 1] Looking up "192.168.0.222"...
> D [29/Oct/2010:15:56:15 -0700] [Job 1] Connecting to 192.168.0.222:9100
> I [29/Oct/2010:15:56:15 -0700] [Job 1] Connecting to printer...
> D [29/Oct/2010:15:56:15 -0700] Discarding unused job-progress event...
> D [29/Oct/2010:15:56:15 -0700] [Job 1] Page = 595x842; 9,9 to 586,833
> D [29/Oct/2010:15:56:15 -0700] [Job 1] slow_collate=0, slow_duplex=0,
> slow_order=0
> D [29/Oct/2010:15:56:15 -0700] [Job 1] STATE: -connecting-to-device
> I [29/Oct/2010:15:56:15 -0700] [Job 1] Connected to printer...
> D [29/Oct/2010:15:56:15 -0700] [Job 1] Connected to 192.168.0.222:9100 (IPv4)...
> D [29/Oct/2010:15:56:15 -0700] Discarding unused job-progress event...
> D [29/Oct/2010:15:56:15 -0700] [Job 1] Before copy_comments - %!PS-Adobe-3.0
> D [29/Oct/2010:15:56:15 -0700] [Job 1] %!PS-Adobe-3.0
> D [29/Oct/2010:15:56:15 -0700] [Job 1] %%Creator: cairo 1.10.0
> (http://cairographics.org)
> D [29/Oct/2010:15:56:15 -0700] [Job 1] %%CreationDate: Fri Oct 29 15:56:15 2010
> D [29/Oct/2010:15:56:15 -0700] [Job 1] %%Pages: 1
> D [29/Oct/2010:15:56:15 -0700] [Job 1] %%BoundingBox: 0 0 596 842
> D [29/Oct/2010:15:56:15 -0700] [Job 1] %%DocumentData: Clean7Bit
> D [29/Oct/2010:15:56:15 -0700] [Job 1] %%LanguageLevel: 2
> D [29/Oct/2010:15:56:15 -0700] [Job 1] %%DocumentMedia: A4 595 842 0 () ()
> D [29/Oct/2010:15:56:15 -0700] [Job 1] %%EndComments
> D [29/Oct/2010:15:56:15 -0700] [Job 1] Before copy_prolog - %%BeginProlog
> D [29/Oct/2010:15:56:15 -0700] [Job 1] Before copy_setup - 11 dict begin
> D [29/Oct/2010:15:56:15 -0700] [Job 1] Before page loop - %%Page: 1 1
> D [29/Oct/2010:15:56:15 -0700] [Job 1] Copying page 1...
> D [29/Oct/2010:15:56:15 -0700] [Job 1] pagew = 577.4, pagel = 823.7
> D [29/Oct/2010:15:56:15 -0700] [Job 1] bboxx = 0, bboxy = 0, bboxw =
> 595, bboxl = 841
> D [29/Oct/2010:15:56:15 -0700] [Job 1] PageLeft = 9.0, PageRight = 586.4
> D [29/Oct/2010:15:56:15 -0700] [Job 1] PageTop = 832.7, PageBottom = 9.0
> D [29/Oct/2010:15:56:15 -0700] [Job 1] PageWidth = 595.4, PageLength = 841.7
> I [29/Oct/2010:15:56:15 -0700] [Job 1] Starting GPL Ghostscript 8.71...
> D [29/Oct/2010:15:56:15 -0700] [Job 1] Running /usr/bin/gs -dQUIET
> -dDEBUG -dPARANOIDSAFER -dNOPAUSE -dBATCH -dNOMEDIAATTRS -sDEVICE=cups
> -sstdout=%stderr -sOUTPUTFILE=%stdout -c  -f -_
> D [29/Oct/2010:15:56:15 -0700] Discarding unused job-progress event...
> D [29/Oct/2010:15:56:15 -0700] [Job 1] START 0 1443028 157482 1301468
> 13168 true 536 3 <0>
> D [29/Oct/2010:15:56:15 -0700] PID 8064 (/usr/lib/cups/filter/pstops)
> did not catch or ignore signal 13.
> D [29/Oct/2010:15:56:15 -0700] [Job 1] prnt/hpcups/HPCupsFilter.cpp
> 505: cupsRasterOpen failed, fd = 0
> D [29/Oct/2010:15:56:15 -0700] PID 8066 (/usr/lib/cups/filter/hpcups)
> stopped with status 1!
> E [29/Oct/2010:15:56:15 -0700] PID 8065
> (/usr/lib/cups/filter/pstoraster) crashed on signal 11!
> D [29/Oct/2010:15:56:17 -0700] [Job 1] backendRunLoop(print_fd=0,
> device_fd=5, snmp_fd=6, addr=0x1c904, use_bc=1, side_cb=0xa0c8)
> I [29/Oct/2010:15:56:17 -0700] [Job 1] Print file sent, waiting for
> printer to finish...
> D [29/Oct/2010:15:56:17 -0700] Discarding unused job-progress event...
> I [29/Oct/2010:15:56:17 -0700] [Job 1] Ready to print.
> D [29/Oct/2010:15:56:17 -0700] Discarding unused job-progress event...
> D [29/Oct/2010:15:56:17 -0700] PID 8067 (/usr/lib/cups/backend/socket)
> exited with no errors.
> D [29/Oct/2010:15:56:17 -0700] Discarding unused job-state-changed event....
> E [29/Oct/2010:15:56:17 -0700] [Job 1] Job stopped due to filter
> errors; please consult the error_log file for details.
> D [29/Oct/2010:15:56:17 -0700] cupsdMarkDirty(----J-)
> D [29/Oct/2010:15:56:17 -0700] Discarding unused printer-state-changed event...
> D [29/Oct/2010:15:56:17 -0700] [Job 1] The following messages were
> recorded from 15:56:17 to 15:56:17
> D [29/Oct/2010:15:56:17 -0700] [Job 1] hrDeviceDesc="Unknown"
> D [29/Oct/2010:15:56:17 -0700] [Job 1] prtGeneralCurrentLocalization=1
> D [29/Oct/2010:15:56:17 -0700] [Job 1] prtLocalizationCharacterSet=2004
> D [29/Oct/2010:15:56:17 -0700] [Job 1] End of messages
> D [29/Oct/2010:15:56:17 -0700] [Job 1] printer-state=3(idle)
> D [29/Oct/2010:15:56:17 -0700] [Job 1] printer-state-message="Ready to print."
> D [29/Oct/2010:15:56:17 -0700] [Job 1] printer-state-reasons=none
> D [29/Oct/2010:15:56:18 -0700] [Job 1] Unloading...
> D [29/Oct/2010:15:56:24 -0700] cupsdReadClient: 10 GET /printers/HP7410 HTTP/1.1
> D [29/Oct/2010:15:56:24 -0700] cupsdSetBusyState: Active clients and dirty files
> D [29/Oct/2010:15:56:24 -0700] cupsdAuthorize: No authentication data provided.
> D [29/Oct/2010:15:56:24 -0700] [CGI] argv[0] =
> "/usr/lib/cups/cgi-bin/printers.cgi"
> D [29/Oct/2010:15:56:24 -0700] [CGI] envp[0] = "CUPS_CACHEDIR=/var/cache/cups"
> D [29/Oct/2010:15:56:24 -0700] [CGI] envp[1] = "CUPS_DATADIR=/usr/share/cups"
> D [29/Oct/2010:15:56:24 -0700] [CGI] envp[2] =
> "CUPS_DOCROOT=/usr/share/doc/cups"
> D [29/Oct/2010:15:56:24 -0700] [CGI] envp[3] =
> "CUPS_FONTPATH=/usr/share/cups/fonts"
> D [29/Oct/2010:15:56:24 -0700] [CGI] envp[4] =
> "CUPS_REQUESTROOT=/var/spool/cups"
> D [29/Oct/2010:15:56:24 -0700] [CGI] envp[5] = "CUPS_SERVERBIN=/usr/lib/cups"
> D [29/Oct/2010:15:56:24 -0700] [CGI] envp[6] = "CUPS_SERVERROOT=/etc/cups"
> D [29/Oct/2010:15:56:24 -0700] [CGI] envp[7] = "CUPS_STATEDIR=/var/run/cups"
> D [29/Oct/2010:15:56:24 -0700] [CGI] envp[8] = "HOME=/var/spool/cups/tmp"
> D [29/Oct/2010:15:56:24 -0700] [CGI] envp[9] =
> "PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
> D [29/Oct/2010:15:56:24 -0700] [CGI] envp[10] = "SERVER_ADMIN=root at omap3-multi"
> D [29/Oct/2010:15:56:24 -0700] [CGI] envp[11] = "SOFTWARE=CUPS/1.4.4"
> D [29/Oct/2010:15:56:24 -0700] [CGI] envp[12] = "TMPDIR=/var/spool/cups/tmp"
> D [29/Oct/2010:15:56:24 -0700] [CGI] envp[13] = "USER=root"
> D [29/Oct/2010:15:56:24 -0700] [CGI] envp[14] =
> "CUPS_SERVER=/var/run/cups/cups.sock"
> D [29/Oct/2010:15:56:24 -0700] [CGI] envp[15] = "CUPS_ENCRYPTION=IfRequested"
> D [29/Oct/2010:15:56:24 -0700] [CGI] envp[16] = "IPP_PORT=631"
> D [29/Oct/2010:15:56:24 -0700] [CGI] envp[17] = "LANG=en_US.UTF8"
> D [29/Oct/2010:15:56:24 -0700] [CGI] envp[18] = "REDIRECT_STATUS=1"
> D [29/Oct/2010:15:56:24 -0700] [CGI] envp[19] = "GATEWAY_INTERFACE=CGI/1.1"
> D [29/Oct/2010:15:56:24 -0700] [CGI] envp[20] = "SERVER_NAME=localhost"
> D [29/Oct/2010:15:56:24 -0700] [CGI] envp[21] = "SERVER_PORT=631"
> D [29/Oct/2010:15:56:24 -0700] [CGI] envp[22] = "REMOTE_ADDR=127.0.0.1"
> D [29/Oct/2010:15:56:24 -0700] [CGI] envp[23] = "REMOTE_HOST=localhost"
> D [29/Oct/2010:15:56:24 -0700] [CGI] envp[24] = "SCRIPT_NAME=/printers/HP7410"
> D [29/Oct/2010:15:56:24 -0700] [CGI] envp[25] =
> "SCRIPT_FILENAME=/usr/share/doc/cups/printers/HP7410"
> D [29/Oct/2010:15:56:24 -0700] [CGI] envp[26] = "PATH_INFO=/HP7410"
> D [29/Oct/2010:15:56:24 -0700] [CGI] envp[27] = "SERVER_PROTOCOL=HTTP/1.1"
> D [29/Oct/2010:15:56:24 -0700] [CGI] envp[28] =
> "HTTP_COOKIE=org.cups.sid=013b9ec7635f9fccdf8554253ebf5082"
> D [29/Oct/2010:15:56:24 -0700] [CGI] envp[29] =
> "HTTP_USER_AGENT=Mozilla/5.0 (X11; U; Linux armv7l; c)
> AppleWebKit/534.7+ (KHTML, like Gecko) Version/5.0 Safari/534.7+
> Epiphany/2.30.2"
> D [29/Oct/2010:15:56:24 -0700] [CGI] envp[30] =
> "HTTP_REFERER=http://localhost:631/printers/?"
> D [29/Oct/2010:15:56:24 -0700] [CGI] envp[31] = "REQUEST_METHOD=GET"
> D [29/Oct/2010:15:56:24 -0700] [CGI] envp[32] = "QUERY_STRING="
> D [29/Oct/2010:15:56:24 -0700] [CGI] Started
> /usr/lib/cups/cgi-bin/printers.cgi (PID 8069)
> I [29/Oct/2010:15:56:24 -0700] Started
> "/usr/lib/cups/cgi-bin/printers.cgi" (pid=8069)
> D [29/Oct/2010:15:56:24 -0700] cupsdSendCommand: 10 file=11
> D [29/Oct/2010:15:56:24 -0700] [CGI] org.cups.sid cookie is
> "013b9ec7635f9fccdf8554253ebf5082"
> D [29/Oct/2010:15:56:24 -0700] cupsdAcceptClient: 12 from localhost (Domain)
> D [29/Oct/2010:15:56:24 -0700] cupsdReadClient: 12 POST / HTTP/1.1
> D [29/Oct/2010:15:56:24 -0700] cupsdAuthorize: No authentication data provided.
> D [29/Oct/2010:15:56:24 -0700] cupsdReadClient: 12 1.1 CUPS-Get-Default 1
> D [29/Oct/2010:15:56:24 -0700] CUPS-Get-Default
> D [29/Oct/2010:15:56:24 -0700] CUPS-Get-Default
> client-error-not-found: No default printer
> D [29/Oct/2010:15:56:24 -0700] Returning IPP client-error-not-found
> for CUPS-Get-Default (no URI) from localhost
> D [29/Oct/2010:15:56:24 -0700] [CGI] show_printer(http=0x154d0,
> printer="HP7410")
> D [29/Oct/2010:15:56:24 -0700] cupsdReadClient: 12 POST / HTTP/1.1
> D [29/Oct/2010:15:56:24 -0700] cupsdAuthorize: No authentication data provided.
> D [29/Oct/2010:15:56:24 -0700] cupsdReadClient: 12 1.1 Get-Printer-Attributes 1
> D [29/Oct/2010:15:56:24 -0700] Get-Printer-Attributes
> ipp://localhost/printers/HP7410
> D [29/Oct/2010:15:56:24 -0700] Returning IPP successful-ok for
> Get-Printer-Attributes (ipp://localhost/printers/HP7410) from
> localhost
> D [29/Oct/2010:15:56:24 -0700] Script header: Content-Type:
> text/html;charset=utf-8
> D [29/Oct/2010:15:56:24 -0700] Script header:
> D [29/Oct/2010:15:56:24 -0700] [CGI] Regular expression ".*Clean.*"
> D [29/Oct/2010:15:56:24 -0700] [CGI] Regular expression ".*PrintSelfTestPage.*"
> D [29/Oct/2010:15:56:24 -0700] cupsdReadClient: 12 POST / HTTP/1.1
> D [29/Oct/2010:15:56:24 -0700] cupsdAuthorize: No authentication data provided.
> D [29/Oct/2010:15:56:24 -0700] cupsdReadClient: 12 1.1 Get-Jobs 1
> D [29/Oct/2010:15:56:24 -0700] Get-Jobs ipp://localhost:631/printers/HP7410
> D [29/Oct/2010:15:56:24 -0700] [Job 1] Loading attributes...
> D [29/Oct/2010:15:56:24 -0700] Returning IPP successful-ok for
> Get-Jobs (ipp://localhost:631/printers/HP7410) from localhost
> D [29/Oct/2010:15:56:24 -0700] cupsdReadClient: 12 WAITING Closing on EOF
> D [29/Oct/2010:15:56:24 -0700] cupsdCloseClient: 12
> D [29/Oct/2010:15:56:24 -0700] cupsdSetBusyState: Dirty files
> D [29/Oct/2010:15:56:24 -0700] PID 8069
> (/usr/lib/cups/cgi-bin/printers.cgi) exited with no errors.
> I [29/Oct/2010:15:56:26 -0700] Generating printcap /etc/printcap...
> I [29/Oct/2010:15:56:26 -0700] Saving job cache file
> "/var/cache/cups/job.cache"...
> D [29/Oct/2010:15:56:26 -0700] cupsdSetBusyState: Not busy
> D [29/Oct/2010:15:56:38 -0700] cupsdReadClient: 10 GET /admin HTTP/1.1
> D [29/Oct/2010:15:56:38 -0700] cupsdSetBusyState: Active clients
> D [29/Oct/2010:15:56:38 -0700] cupsdAuthorize: Authorized as root using Basic
> D [29/Oct/2010:15:56:38 -0700] [CGI] argv[0] = "/usr/lib/cups/cgi-bin/admin.cgi"
> D [29/Oct/2010:15:56:38 -0700] [CGI] envp[0] = "CUPS_CACHEDIR=/var/cache/cups"
> D [29/Oct/2010:15:56:38 -0700] [CGI] envp[1] = "CUPS_DATADIR=/usr/share/cups"
> D [29/Oct/2010:15:56:38 -0700] [CGI] envp[2] =
> "CUPS_DOCROOT=/usr/share/doc/cups"
> D [29/Oct/2010:15:56:38 -0700] [CGI] envp[3] =
> "CUPS_FONTPATH=/usr/share/cups/fonts"
> D [29/Oct/2010:15:56:38 -0700] [CGI] envp[4] =
> "CUPS_REQUESTROOT=/var/spool/cups"
> D [29/Oct/2010:15:56:38 -0700] [CGI] envp[5] = "CUPS_SERVERBIN=/usr/lib/cups"
> D [29/Oct/2010:15:56:38 -0700] [CGI] envp[6] = "CUPS_SERVERROOT=/etc/cups"
> D [29/Oct/2010:15:56:38 -0700] [CGI] envp[7] = "CUPS_STATEDIR=/var/run/cups"
> D [29/Oct/2010:15:56:38 -0700] [CGI] envp[8] = "HOME=/var/spool/cups/tmp"
> D [29/Oct/2010:15:56:38 -0700] [CGI] envp[9] =
> "PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
> D [29/Oct/2010:15:56:38 -0700] [CGI] envp[10] = "SERVER_ADMIN=root at omap3-multi"
> D [29/Oct/2010:15:56:38 -0700] [CGI] envp[11] = "SOFTWARE=CUPS/1.4.4"
> D [29/Oct/2010:15:56:38 -0700] [CGI] envp[12] = "TMPDIR=/var/spool/cups/tmp"
> D [29/Oct/2010:15:56:38 -0700] [CGI] envp[13] = "USER=root"
> D [29/Oct/2010:15:56:38 -0700] [CGI] envp[14] =
> "CUPS_SERVER=/var/run/cups/cups.sock"
> D [29/Oct/2010:15:56:38 -0700] [CGI] envp[15] = "CUPS_ENCRYPTION=IfRequested"
> D [29/Oct/2010:15:56:38 -0700] [CGI] envp[16] = "IPP_PORT=631"
> D [29/Oct/2010:15:56:38 -0700] [CGI] envp[17] = "CUPSD_AUTH_TYPE=Basic"
> D [29/Oct/2010:15:56:38 -0700] [CGI] envp[18] = "LANG=en_US.UTF8"
> D [29/Oct/2010:15:56:38 -0700] [CGI] envp[19] = "REDIRECT_STATUS=1"
> D [29/Oct/2010:15:56:38 -0700] [CGI] envp[20] = "GATEWAY_INTERFACE=CGI/1.1"
> D [29/Oct/2010:15:56:38 -0700] [CGI] envp[21] = "SERVER_NAME=localhost"
> D [29/Oct/2010:15:56:38 -0700] [CGI] envp[22] = "SERVER_PORT=631"
> D [29/Oct/2010:15:56:38 -0700] [CGI] envp[23] = "REMOTE_ADDR=127.0.0.1"
> D [29/Oct/2010:15:56:38 -0700] [CGI] envp[24] = "REMOTE_HOST=localhost"
> D [29/Oct/2010:15:56:38 -0700] [CGI] envp[25] = "SCRIPT_NAME=/admin"
> D [29/Oct/2010:15:56:38 -0700] [CGI] envp[26] =
> "SCRIPT_FILENAME=/usr/share/doc/cups/admin"
> D [29/Oct/2010:15:56:38 -0700] [CGI] envp[27] = "REMOTE_USER=root"
> D [29/Oct/2010:15:56:38 -0700] [CGI] envp[28] = "SERVER_PROTOCOL=HTTP/1.1"
> D [29/Oct/2010:15:56:38 -0700] [CGI] envp[29] =
> "HTTP_COOKIE=org.cups.sid=013b9ec7635f9fccdf8554253ebf5082"
> D [29/Oct/2010:15:56:38 -0700] [CGI] envp[30] =
> "HTTP_USER_AGENT=Mozilla/5.0 (X11; U; Linux armv7l; c)
> AppleWebKit/534.7+ (KHTML, like Gecko) Version/5.0 Safari/534.7+
> Epiphany/2.30.2"
> D [29/Oct/2010:15:56:38 -0700] [CGI] envp[31] =
> "HTTP_REFERER=http://localhost:631/printers/?"
> D [29/Oct/2010:15:56:38 -0700] [CGI] envp[32] = "REQUEST_METHOD=GET"
> D [29/Oct/2010:15:56:38 -0700] [CGI] envp[33] = "QUERY_STRING="
> D [29/Oct/2010:15:56:38 -0700] [CGI] Started
> /usr/lib/cups/cgi-bin/admin.cgi (PID 8070)
> I [29/Oct/2010:15:56:38 -0700] Started
> "/usr/lib/cups/cgi-bin/admin.cgi" (pid=8070)
> D [29/Oct/2010:15:56:38 -0700] cupsdSendCommand: 10 file=11
> D [29/Oct/2010:15:56:38 -0700] [CGI] admin.cgi started...
> D [29/Oct/2010:15:56:38 -0700] cupsdAcceptClient: 12 from localhost (Domain)
> D [29/Oct/2010:15:56:38 -0700] [CGI] http=0x1f968
> D [29/Oct/2010:15:56:38 -0700] [CGI] org.cups.sid cookie is
> "013b9ec7635f9fccdf8554253ebf5082"
> D [29/Oct/2010:15:56:38 -0700] [CGI] No form data, showing main menu...
> D [29/Oct/2010:15:56:38 -0700] [CGI]
> /usr/share/cups/drivers/pscript5.dll: No such file or directory
> D [29/Oct/2010:15:56:38 -0700] cupsdReadClient: 12 POST / HTTP/1.1
> D [29/Oct/2010:15:56:38 -0700] cupsdAuthorize: No authentication data provided.
> D [29/Oct/2010:15:56:38 -0700] cupsdReadClient: 12 1.1 Get-Subscriptions 1
> D [29/Oct/2010:15:56:38 -0700] Get-Subscriptions ipp://localhost/
> D [29/Oct/2010:15:56:38 -0700] Get-Subscriptions
> client-error-not-found: No subscriptions found.
> D [29/Oct/2010:15:56:38 -0700] Returning IPP client-error-not-found
> for Get-Subscriptions (ipp://localhost/) from localhost
> D [29/Oct/2010:15:56:38 -0700] Script header: Content-Type:
> text/html;charset=utf-8
> D [29/Oct/2010:15:56:38 -0700] Script header:
> D [29/Oct/2010:15:56:38 -0700] cupsdReadClient: 12 WAITING Closing on EOF
> D [29/Oct/2010:15:56:38 -0700] cupsdCloseClient: 12
> D [29/Oct/2010:15:56:38 -0700] cupsdSetBusyState: Not busy
> D [29/Oct/2010:15:56:38 -0700] PID 8070
> (/usr/lib/cups/cgi-bin/admin.cgi) exited with no errors.
> D [29/Oct/2010:15:56:41 -0700] cupsdReadClient: 10 GET
> /admin/log/access_log? HTTP/1.1
> D [29/Oct/2010:15:56:41 -0700] cupsdSetBusyState: Active clients
> D [29/Oct/2010:15:56:41 -0700] cupsdAuthorize: Authorized as root using Basic
> D [29/Oct/2010:15:56:41 -0700] cupsdSetBusyState: Not busy
> D [29/Oct/2010:15:56:41 -0700] cupsdReadClient: 10 GET /favicon.ico HTTP/1.1
> D [29/Oct/2010:15:56:41 -0700] cupsdSetBusyState: Active clients
> D [29/Oct/2010:15:56:41 -0700] cupsdAuthorize: No authentication data provided.
> D [29/Oct/2010:15:56:41 -0700] cupsdReadClient: 10 Closing because
> Keep-Alive disabled
> D [29/Oct/2010:15:56:41 -0700] cupsdCloseClient: 10
> D [29/Oct/2010:15:56:41 -0700] cupsdSetBusyState: Not busy
> D [29/Oct/2010:15:56:41 -0700] cupsdAcceptClient: 10 from localhost:631 (IPv4)
> D [29/Oct/2010:15:56:41 -0700] cupsdReadClient: 10 GET /favicon.ico HTTP/1.1
> D [29/Oct/2010:15:56:41 -0700] cupsdSetBusyState: Active clients
> D [29/Oct/2010:15:56:41 -0700] cupsdAuthorize: No authentication data provided.
> D [29/Oct/2010:15:56:41 -0700] cupsdReadClient: 10 Closing because
> Keep-Alive disabled
> D [29/Oct/2010:15:56:41 -0700] cupsdCloseClient: 10
> D [29/Oct/2010:15:56:41 -0700] cupsdSetBusyState: Not busy
> D [29/Oct/2010:15:56:57 -0700] cupsdAcceptClient: 10 from localhost:631 (IPv4)
> D [29/Oct/2010:15:56:57 -0700] Report: clients=1
> D [29/Oct/2010:15:56:57 -0700] Report: jobs=1
> D [29/Oct/2010:15:56:57 -0700] Report: jobs-active=1
> D [29/Oct/2010:15:56:57 -0700] Report: printers=1
> D [29/Oct/2010:15:56:57 -0700] Report: printers-implicit=0
> D [29/Oct/2010:15:56:57 -0700] Report: stringpool-string-count=23401
> D [29/Oct/2010:15:56:57 -0700] Report: stringpool-alloc-bytes=10560
> D [29/Oct/2010:15:56:57 -0700] Report: stringpool-total-bytes=436456
> D [29/Oct/2010:15:56:57 -0700] cupsdReadClient: 10 GET
> /admin/log/error_log? HTTP/1.1
> D [29/Oct/2010:15:56:57 -0700] cupsdSetBusyState: Active clients
> D [29/Oct/2010:15:56:57 -0700] cupsdAuthorize: Authorized as root using Basic
>