I [09/Aug/2010:08:54:00 -0500] Saving job cache file "/var/cache/cups/job.cache"...
I [09/Aug/2010:08:54:44 -0500] Listening to ::1:631 (IPv6)
I [09/Aug/2010:08:54:44 -0500] Listening to 127.0.0.1:631 (IPv4)
I [09/Aug/2010:08:54:44 -0500] Listening to /var/run/cups/cups.sock (Domain)
I [09/Aug/2010:08:54:44 -0500] Remote access is disabled.
D [09/Aug/2010:08:54:44 -0500] Added auto ServerAlias researchlinux
I [09/Aug/2010:08:54:44 -0500] Loaded configuration file "/etc/cups/cupsd.conf"
I [09/Aug/2010:08:54:44 -0500] Using default TempDir of /var/spool/cups/tmp...
I [09/Aug/2010:08:54:44 -0500] Configured for up to 100 clients.
I [09/Aug/2010:08:54:44 -0500] Allowing up to 100 client connections per host.
I [09/Aug/2010:08:54:44 -0500] Using policy "default" as the default!
I [09/Aug/2010:08:54:44 -0500] Full reload is required.
I [09/Aug/2010:08:54:44 -0500] Loaded MIME database from "/usr/share/cups/mime" and "/etc/cups": 35 types, 40 filters...
D [09/Aug/2010:08:54:44 -0500] Loading printer HP_LaserJet_4100_Series...
D [09/Aug/2010:08:54:44 -0500] load_ppd: Loading /var/cache/cups/HP_LaserJet_4100_Series.ipp2...
D [09/Aug/2010:08:54:44 -0500] cupsdRegisterPrinter(p=0xb8a711e8(HP_LaserJet_4100_Series))
D [09/Aug/2010:08:54:44 -0500] Loading printer OKI_DATA_CORP_ML320_1TURBO...
D [09/Aug/2010:08:54:44 -0500] load_ppd: Loading /var/cache/cups/OKI_DATA_CORP_ML320_1TURBO.ipp2...
D [09/Aug/2010:08:54:44 -0500] cupsdRegisterPrinter(p=0xb8a75d68(OKI_DATA_CORP_ML320_1TURBO))
I [09/Aug/2010:08:54:44 -0500] Loading job cache file "/var/cache/cups/job.cache"...
D [09/Aug/2010:08:54:44 -0500] [Job 1] Loading from cache...
D [09/Aug/2010:08:54:44 -0500] [Job 4] Loading from cache...
D [09/Aug/2010:08:54:44 -0500] cupsdAddSubscription(mask=0, dest=(nil)(), job=(nil)(0), uri="(null)")
D [09/Aug/2010:08:54:44 -0500] cupsdAddSubscription(mask=0, dest=(nil)(), job=(nil)(0), uri="(null)")
I [09/Aug/2010:08:54:44 -0500] Full reload complete.
D [09/Aug/2010:08:54:44 -0500] cupsd_clean_files(path="/var/spool/cups/tmp", pattern="(null)")
I [09/Aug/2010:08:54:44 -0500] Cleaning out old files in "/var/spool/cups/tmp"...
D [09/Aug/2010:08:54:44 -0500] cupsd_clean_files(path="/var/cache/cups", pattern="*.ipp")
I [09/Aug/2010:08:54:44 -0500] Cleaning out old files in "/var/cache/cups"...
I [09/Aug/2010:08:54:44 -0500] Listening to ::1:631 on fd 6...
I [09/Aug/2010:08:54:44 -0500] Listening to 127.0.0.1:631 on fd 7...
I [09/Aug/2010:08:54:44 -0500] Listening to /var/run/cups/cups.sock on fd 8...
I [09/Aug/2010:08:54:44 -0500] Resuming new connection processing...
D [09/Aug/2010:08:54:44 -0500] cupsdRegisterPrinter(p=0xb8a711e8(HP_LaserJet_4100_Series))
D [09/Aug/2010:08:54:44 -0500] cupsdRegisterPrinter(p=0xb8a75d68(OKI_DATA_CORP_ML320_1TURBO))
E [09/Aug/2010:08:54:44 -0500] Unable to set ACLs on root certificate "/var/run/cups/certs/0" - Operation not supported
D [09/Aug/2010:08:54:44 -0500] Discarding unused server-started event...
D [09/Aug/2010:08:54:45 -0500] Report: clients=0
D [09/Aug/2010:08:54:45 -0500] Report: jobs=2
D [09/Aug/2010:08:54:45 -0500] Report: jobs-active=0
D [09/Aug/2010:08:54:45 -0500] Report: printers=2
D [09/Aug/2010:08:54:45 -0500] Report: printers-implicit=0
D [09/Aug/2010:08:54:45 -0500] Report: stringpool-string-count=1414
D [09/Aug/2010:08:54:45 -0500] Report: stringpool-alloc-bytes=7984
D [09/Aug/2010:08:54:45 -0500] Report: stringpool-total-bytes=28152
D [09/Aug/2010:08:55:26 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [09/Aug/2010:08:55:26 -0500] cupsdReadClient: 12 POST / HTTP/1.1
D [09/Aug/2010:08:55:26 -0500] cupsdSetBusyState: Active clients
D [09/Aug/2010:08:55:26 -0500] cupsdAuthorize: No authentication data provided.
D [09/Aug/2010:08:55:26 -0500] cupsdReadClient: 12 1.1 Create-Printer-Subscription 1
D [09/Aug/2010:08:55:26 -0500] Create-Printer-Subscription /
D [09/Aug/2010:08:55:26 -0500] cupsdCreateSubscription(con=0xb8aafda0(12), uri="/")
D [09/Aug/2010:08:55:26 -0500] pullmethod="ippget"
D [09/Aug/2010:08:55:26 -0500] notify-lease-duration=86400
D [09/Aug/2010:08:55:26 -0500] notify-time-interval=0
D [09/Aug/2010:08:55:26 -0500] cupsdAddSubscription(mask=1798f, dest=(nil)(), job=(nil)(0), uri="(null)")
D [09/Aug/2010:08:55:26 -0500] Added subscription 23 for server
D [09/Aug/2010:08:55:26 -0500] cupsdMarkDirty(-----S)
D [09/Aug/2010:08:55:26 -0500] cupsdSetBusyState: Active clients and dirty files
D [09/Aug/2010:08:55:26 -0500] Returning IPP successful-ok for Create-Printer-Subscription (/) from localhost
D [09/Aug/2010:08:55:26 -0500] cupsdSetBusyState: Dirty files
D [09/Aug/2010:08:55:26 -0500] cupsdReadClient: 12 POST / HTTP/1.1
D [09/Aug/2010:08:55:26 -0500] cupsdSetBusyState: Active clients and dirty files
D [09/Aug/2010:08:55:26 -0500] cupsdAuthorize: No authentication data provided.
D [09/Aug/2010:08:55:26 -0500] cupsdReadClient: 12 1.1 Get-Jobs 1
D [09/Aug/2010:08:55:26 -0500] Get-Jobs ipp://localhost/printers/
D [09/Aug/2010:08:55:26 -0500] Returning IPP successful-ok for Get-Jobs (ipp://localhost/printers/) from localhost
D [09/Aug/2010:08:55:26 -0500] cupsdSetBusyState: Dirty files
D [09/Aug/2010:08:55:26 -0500] cupsdReadClient: 12 POST / HTTP/1.1
D [09/Aug/2010:08:55:26 -0500] cupsdSetBusyState: Active clients and dirty files
D [09/Aug/2010:08:55:26 -0500] cupsdAuthorize: No authentication data provided.
D [09/Aug/2010:08:55:26 -0500] cupsdReadClient: 12 1.1 CUPS-Get-Printers 1
D [09/Aug/2010:08:55:26 -0500] CUPS-Get-Printers
D [09/Aug/2010:08:55:26 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [09/Aug/2010:08:55:26 -0500] cupsdSetBusyState: Dirty files
D [09/Aug/2010:08:55:26 -0500] cupsdReadClient: 12 POST / HTTP/1.1
D [09/Aug/2010:08:55:26 -0500] cupsdSetBusyState: Active clients and dirty files
D [09/Aug/2010:08:55:26 -0500] cupsdAuthorize: No authentication data provided.
D [09/Aug/2010:08:55:26 -0500] cupsdReadClient: 12 1.1 CUPS-Get-Printers 1
D [09/Aug/2010:08:55:26 -0500] CUPS-Get-Printers
D [09/Aug/2010:08:55:26 -0500] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [09/Aug/2010:08:55:26 -0500] cupsdSetBusyState: Dirty files
D [09/Aug/2010:08:55:26 -0500] cupsdReadClient: 12 POST / HTTP/1.1
D [09/Aug/2010:08:55:26 -0500] cupsdSetBusyState: Active clients and dirty files
D [09/Aug/2010:08:55:26 -0500] cupsdAuthorize: No authentication data provided.
D [09/Aug/2010:08:55:26 -0500] cupsdReadClient: 12 1.1 CUPS-Get-Default 1
D [09/Aug/2010:08:55:26 -0500] CUPS-Get-Default
D [09/Aug/2010:08:55:26 -0500] CUPS-Get-Default client-error-not-found: No default printer
D [09/Aug/2010:08:55:26 -0500] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost
D [09/Aug/2010:08:55:26 -0500] cupsdSetBusyState: Dirty files
D [09/Aug/2010:08:55:26 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [09/Aug/2010:08:55:26 -0500] cupsdCloseClient: 12
D [09/Aug/2010:08:55:28 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [09/Aug/2010:08:55:28 -0500] cupsdReadClient: 12 POST / HTTP/1.1
D [09/Aug/2010:08:55:28 -0500] cupsdSetBusyState: Active clients and dirty files
D [09/Aug/2010:08:55:28 -0500] cupsdAuthorize: No authentication data provided.
D [09/Aug/2010:08:55:28 -0500] cupsdReadClient: 12 1.1 Get-Notifications 1
D [09/Aug/2010:08:55:28 -0500] Get-Notifications /
D [09/Aug/2010:08:55:28 -0500] cupsdIsAuthorized: requesting-user-name="glsadmin"
D [09/Aug/2010:08:55:28 -0500] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [09/Aug/2010:08:55:28 -0500] cupsdSetBusyState: Dirty files
D [09/Aug/2010:08:55:28 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [09/Aug/2010:08:55:28 -0500] cupsdCloseClient: 12
D [09/Aug/2010:08:55:34 -0500] cupsdAcceptClient: 12 from localhost:631 (IPv4)
D [09/Aug/2010:08:55:34 -0500] cupsdReadClient: 12 GET /images/cups-icon.png HTTP/1.1
D [09/Aug/2010:08:55:34 -0500] cupsdSetBusyState: Active clients and dirty files
D [09/Aug/2010:08:55:34 -0500] cupsdAuthorize: No authentication data provided.
D [09/Aug/2010:08:55:34 -0500] cupsdReadClient: 12 Closing on EOF
D [09/Aug/2010:08:55:34 -0500] cupsdCloseClient: 12
D [09/Aug/2010:08:55:34 -0500] cupsdSetBusyState: Dirty files
D [09/Aug/2010:08:55:34 -0500] cupsdAcceptClient: 12 from localhost:631 (IPv4)
D [09/Aug/2010:08:55:34 -0500] cupsdReadClient: 12 GET /admin/ HTTP/1.1
D [09/Aug/2010:08:55:34 -0500] cupsdSetBusyState: Active clients and dirty files
D [09/Aug/2010:08:55:34 -0500] cupsdAuthorize: No authentication data provided.
D [09/Aug/2010:08:55:34 -0500] [CGI] argv[0] = "/usr/lib/cups/cgi-bin/admin.cgi"
D [09/Aug/2010:08:55:34 -0500] [CGI] envp[0] = "CUPS_CACHEDIR=/var/cache/cups"
D [09/Aug/2010:08:55:34 -0500] [CGI] envp[1] = "CUPS_DATADIR=/usr/share/cups"
D [09/Aug/2010:08:55:34 -0500] [CGI] envp[2] = "CUPS_DOCROOT=/usr/share/cups/doc"
D [09/Aug/2010:08:55:34 -0500] [CGI] envp[3] = "CUPS_FONTPATH=/usr/share/cups/fonts"
D [09/Aug/2010:08:55:34 -0500] [CGI] envp[4] = "CUPS_REQUESTROOT=/var/spool/cups"
D [09/Aug/2010:08:55:34 -0500] [CGI] envp[5] = "CUPS_SERVERBIN=/usr/lib/cups"
D [09/Aug/2010:08:55:34 -0500] [CGI] envp[6] = "CUPS_SERVERROOT=/etc/cups"
D [09/Aug/2010:08:55:34 -0500] [CGI] envp[7] = "CUPS_STATEDIR=/var/run/cups"
D [09/Aug/2010:08:55:34 -0500] [CGI] envp[8] = "HOME=/var/spool/cups/tmp"
D [09/Aug/2010:08:55:34 -0500] [CGI] envp[9] = "PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [09/Aug/2010:08:55:34 -0500] [CGI] envp[10] = "SERVER_ADMIN=root@researchlinux"
D [09/Aug/2010:08:55:34 -0500] [CGI] envp[11] = "SOFTWARE=CUPS/1.4.4"
D [09/Aug/2010:08:55:34 -0500] [CGI] envp[12] = "TMPDIR=/var/spool/cups/tmp"
D [09/Aug/2010:08:55:34 -0500] [CGI] envp[13] = "USER=root"
D [09/Aug/2010:08:55:34 -0500] [CGI] envp[14] = "CUPS_SERVER=/var/run/cups/cups.sock"
D [09/Aug/2010:08:55:34 -0500] [CGI] envp[15] = "CUPS_ENCRYPTION=IfRequested"
D [09/Aug/2010:08:55:34 -0500] [CGI] envp[16] = "IPP_PORT=631"
D [09/Aug/2010:08:55:34 -0500] [CGI] envp[17] = "LANG=en_US.UTF8"
D [09/Aug/2010:08:55:34 -0500] [CGI] envp[18] = "REDIRECT_STATUS=1"
D [09/Aug/2010:08:55:34 -0500] [CGI] envp[19] = "GATEWAY_INTERFACE=CGI/1.1"
D [09/Aug/2010:08:55:34 -0500] [CGI] envp[20] = "SERVER_NAME=localhost"
D [09/Aug/2010:08:55:34 -0500] [CGI] envp[21] = "SERVER_PORT=631"
D [09/Aug/2010:08:55:34 -0500] [CGI] envp[22] = "REMOTE_ADDR=127.0.0.1"
D [09/Aug/2010:08:55:34 -0500] [CGI] envp[23] = "REMOTE_HOST=localhost"
D [09/Aug/2010:08:55:34 -0500] [CGI] envp[24] = "SCRIPT_NAME=/admin/"
D [09/Aug/2010:08:55:34 -0500] [CGI] envp[25] = "SCRIPT_FILENAME=/usr/share/cups/doc/admin/"
D [09/Aug/2010:08:55:34 -0500] [CGI] envp[26] = "SERVER_PROTOCOL=HTTP/1.1"
D [09/Aug/2010:08:55:34 -0500] [CGI] envp[27] = "HTTP_COOKIE=org.cups.sid=3250ea73be415d540e5706404fbe0908"
D [09/Aug/2010:08:55:34 -0500] [CGI] envp[28] = "HTTP_USER_AGENT=Mozilla/5.0 (X11; U; Linux i686; en-US; rv:1.9.2.8) Gecko/20100724 IceCat/3.6.8 (like Firefox/3.6.8)"
D [09/Aug/2010:08:55:34 -0500] [CGI] envp[29] = "HTTP_REFERER=http://localhost:631/admin"
D [09/Aug/2010:08:55:34 -0500] [CGI] envp[30] = "REQUEST_METHOD=GET"
D [09/Aug/2010:08:55:34 -0500] [CGI] envp[31] = "QUERY_STRING="
D [09/Aug/2010:08:55:34 -0500] [CGI] Started /usr/lib/cups/cgi-bin/admin.cgi (PID 1800)
I [09/Aug/2010:08:55:34 -0500] Started "/usr/lib/cups/cgi-bin/admin.cgi" (pid=1800)
D [09/Aug/2010:08:55:34 -0500] cupsdSendCommand: 12 file=14
D [09/Aug/2010:08:55:34 -0500] [CGI] admin.cgi started...
D [09/Aug/2010:08:55:34 -0500] cupsdAcceptClient: 15 from localhost (Domain)
D [09/Aug/2010:08:55:34 -0500] [CGI] http=0xb8d49e38
D [09/Aug/2010:08:55:34 -0500] [CGI] org.cups.sid cookie is "3250ea73be415d540e5706404fbe0908"
D [09/Aug/2010:08:55:34 -0500] [CGI] No form data, showing main menu...
D [09/Aug/2010:08:55:34 -0500] [CGI] /usr/share/cups/drivers/pscript5.dll: No such file or directory
D [09/Aug/2010:08:55:34 -0500] cupsdReadClient: 15 POST / HTTP/1.1
D [09/Aug/2010:08:55:34 -0500] cupsdAuthorize: No authentication data provided.
D [09/Aug/2010:08:55:34 -0500] cupsdReadClient: 15 1.1 Get-Subscriptions 1
D [09/Aug/2010:08:55:34 -0500] Get-Subscriptions ipp://localhost/
D [09/Aug/2010:08:55:34 -0500] Returning IPP successful-ok for Get-Subscriptions (ipp://localhost/) from localhost
D [09/Aug/2010:08:55:34 -0500] Script header: Content-Type: text/html;charset=utf-8
D [09/Aug/2010:08:55:34 -0500] Script header: 
D [09/Aug/2010:08:55:34 -0500] cupsdReadClient: 15 WAITING Closing on EOF
D [09/Aug/2010:08:55:34 -0500] cupsdCloseClient: 15
D [09/Aug/2010:08:55:34 -0500] cupsdSetBusyState: Dirty files
D [09/Aug/2010:08:55:34 -0500] PID 1800 (/usr/lib/cups/cgi-bin/admin.cgi) exited with no errors.
D [09/Aug/2010:08:55:35 -0500] cupsdReadClient: 12 GET /cups.css HTTP/1.1
D [09/Aug/2010:08:55:35 -0500] cupsdSetBusyState: Active clients and dirty files
D [09/Aug/2010:08:55:35 -0500] cupsdAuthorize: No authentication data provided.
D [09/Aug/2010:08:55:35 -0500] cupsdSetBusyState: Dirty files
D [09/Aug/2010:08:55:35 -0500] cupsdReadClient: 12 GET /images/left.gif HTTP/1.1
D [09/Aug/2010:08:55:35 -0500] cupsdSetBusyState: Active clients and dirty files
D [09/Aug/2010:08:55:35 -0500] cupsdAuthorize: No authentication data provided.
D [09/Aug/2010:08:55:35 -0500] cupsdSetBusyState: Dirty files
D [09/Aug/2010:08:55:35 -0500] cupsdAcceptClient: 14 from localhost:631 (IPv4)
D [09/Aug/2010:08:55:35 -0500] cupsdReadClient: 14 GET /images/right.gif HTTP/1.1
D [09/Aug/2010:08:55:35 -0500] cupsdSetBusyState: Active clients and dirty files
D [09/Aug/2010:08:55:35 -0500] cupsdAuthorize: No authentication data provided.
D [09/Aug/2010:08:55:35 -0500] cupsdSetBusyState: Dirty files
D [09/Aug/2010:08:55:36 -0500] cupsdReadClient: 12 GET /images/cups-icon.png HTTP/1.1
D [09/Aug/2010:08:55:36 -0500] cupsdSetBusyState: Active clients and dirty files
D [09/Aug/2010:08:55:36 -0500] cupsdAuthorize: No authentication data provided.
D [09/Aug/2010:08:55:36 -0500] cupsdSetBusyState: Dirty files
D [09/Aug/2010:08:55:36 -0500] cupsdReadClient: 14 GET /images/unsel.gif HTTP/1.1
D [09/Aug/2010:08:55:36 -0500] cupsdSetBusyState: Active clients and dirty files
D [09/Aug/2010:08:55:36 -0500] cupsdAuthorize: No authentication data provided.
D [09/Aug/2010:08:55:36 -0500] cupsdSetBusyState: Dirty files
D [09/Aug/2010:08:55:36 -0500] cupsdReadClient: 12 GET /images/sel.gif HTTP/1.1
D [09/Aug/2010:08:55:36 -0500] cupsdSetBusyState: Active clients and dirty files
D [09/Aug/2010:08:55:36 -0500] cupsdAuthorize: No authentication data provided.
D [09/Aug/2010:08:55:36 -0500] cupsdSetBusyState: Dirty files
D [09/Aug/2010:08:55:36 -0500] cupsdReadClient: 14 GET /printers/OKI_DATA_CORP_ML320_1TURBO HTTP/1.1
D [09/Aug/2010:08:55:36 -0500] cupsdSetBusyState: Active clients and dirty files
D [09/Aug/2010:08:55:36 -0500] cupsdAuthorize: No authentication data provided.
D [09/Aug/2010:08:55:36 -0500] [CGI] argv[0] = "/usr/lib/cups/cgi-bin/printers.cgi"
D [09/Aug/2010:08:55:36 -0500] [CGI] envp[0] = "CUPS_CACHEDIR=/var/cache/cups"
D [09/Aug/2010:08:55:36 -0500] [CGI] envp[1] = "CUPS_DATADIR=/usr/share/cups"
D [09/Aug/2010:08:55:36 -0500] [CGI] envp[2] = "CUPS_DOCROOT=/usr/share/cups/doc"
D [09/Aug/2010:08:55:36 -0500] [CGI] envp[3] = "CUPS_FONTPATH=/usr/share/cups/fonts"
D [09/Aug/2010:08:55:36 -0500] [CGI] envp[4] = "CUPS_REQUESTROOT=/var/spool/cups"
D [09/Aug/2010:08:55:36 -0500] [CGI] envp[5] = "CUPS_SERVERBIN=/usr/lib/cups"
D [09/Aug/2010:08:55:36 -0500] [CGI] envp[6] = "CUPS_SERVERROOT=/etc/cups"
D [09/Aug/2010:08:55:36 -0500] [CGI] envp[7] = "CUPS_STATEDIR=/var/run/cups"
D [09/Aug/2010:08:55:36 -0500] [CGI] envp[8] = "HOME=/var/spool/cups/tmp"
D [09/Aug/2010:08:55:36 -0500] [CGI] envp[9] = "PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [09/Aug/2010:08:55:36 -0500] [CGI] envp[10] = "SERVER_ADMIN=root@researchlinux"
D [09/Aug/2010:08:55:36 -0500] [CGI] envp[11] = "SOFTWARE=CUPS/1.4.4"
D [09/Aug/2010:08:55:36 -0500] [CGI] envp[12] = "TMPDIR=/var/spool/cups/tmp"
D [09/Aug/2010:08:55:36 -0500] [CGI] envp[13] = "USER=root"
D [09/Aug/2010:08:55:36 -0500] [CGI] envp[14] = "CUPS_SERVER=/var/run/cups/cups.sock"
D [09/Aug/2010:08:55:36 -0500] [CGI] envp[15] = "CUPS_ENCRYPTION=IfRequested"
D [09/Aug/2010:08:55:36 -0500] [CGI] envp[16] = "IPP_PORT=631"
D [09/Aug/2010:08:55:36 -0500] [CGI] envp[17] = "LANG=en_US.UTF8"
D [09/Aug/2010:08:55:36 -0500] [CGI] envp[18] = "REDIRECT_STATUS=1"
D [09/Aug/2010:08:55:36 -0500] [CGI] envp[19] = "GATEWAY_INTERFACE=CGI/1.1"
D [09/Aug/2010:08:55:36 -0500] [CGI] envp[20] = "SERVER_NAME=localhost"
D [09/Aug/2010:08:55:36 -0500] [CGI] envp[21] = "SERVER_PORT=631"
D [09/Aug/2010:08:55:36 -0500] [CGI] envp[22] = "REMOTE_ADDR=127.0.0.1"
D [09/Aug/2010:08:55:36 -0500] [CGI] envp[23] = "REMOTE_HOST=localhost"
D [09/Aug/2010:08:55:36 -0500] [CGI] envp[24] = "SCRIPT_NAME=/printers/OKI_DATA_CORP_ML320_1TURBO"
D [09/Aug/2010:08:55:36 -0500] [CGI] envp[25] = "SCRIPT_FILENAME=/usr/share/cups/doc/printers/OKI_DATA_CORP_ML320_1TURBO"
D [09/Aug/2010:08:55:36 -0500] [CGI] envp[26] = "PATH_INFO=/OKI_DATA_CORP_ML320_1TURBO"
D [09/Aug/2010:08:55:36 -0500] [CGI] envp[27] = "SERVER_PROTOCOL=HTTP/1.1"
D [09/Aug/2010:08:55:36 -0500] [CGI] envp[28] = "HTTP_COOKIE=org.cups.sid=3250ea73be415d540e5706404fbe0908"
D [09/Aug/2010:08:55:36 -0500] [CGI] envp[29] = "HTTP_USER_AGENT=Mozilla/5.0 (X11; U; Linux i686; en-US; rv:1.9.2.8) Gecko/20100724 IceCat/3.6.8 (like Firefox/3.6.8)"
D [09/Aug/2010:08:55:36 -0500] [CGI] envp[30] = "HTTP_REFERER=http://localhost:631/printers/"
D [09/Aug/2010:08:55:36 -0500] [CGI] envp[31] = "REQUEST_METHOD=GET"
D [09/Aug/2010:08:55:36 -0500] [CGI] envp[32] = "QUERY_STRING="
D [09/Aug/2010:08:55:36 -0500] [CGI] Started /usr/lib/cups/cgi-bin/printers.cgi (PID 1802)
I [09/Aug/2010:08:55:36 -0500] Started "/usr/lib/cups/cgi-bin/printers.cgi" (pid=1802)
D [09/Aug/2010:08:55:36 -0500] cupsdSendCommand: 14 file=15
D [09/Aug/2010:08:55:36 -0500] [CGI] org.cups.sid cookie is "3250ea73be415d540e5706404fbe0908"
D [09/Aug/2010:08:55:36 -0500] cupsdAcceptClient: 16 from localhost (Domain)
D [09/Aug/2010:08:55:36 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [09/Aug/2010:08:55:36 -0500] cupsdAuthorize: No authentication data provided.
D [09/Aug/2010:08:55:36 -0500] cupsdReadClient: 16 1.1 CUPS-Get-Default 1
D [09/Aug/2010:08:55:36 -0500] CUPS-Get-Default
D [09/Aug/2010:08:55:36 -0500] CUPS-Get-Default client-error-not-found: No default printer
D [09/Aug/2010:08:55:36 -0500] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost
D [09/Aug/2010:08:55:36 -0500] [CGI] show_printer(http=0xb85cf988, printer="OKI_DATA_CORP_ML320_1TURBO")
D [09/Aug/2010:08:55:36 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [09/Aug/2010:08:55:36 -0500] cupsdAuthorize: No authentication data provided.
D [09/Aug/2010:08:55:36 -0500] cupsdReadClient: 16 1.1 Get-Printer-Attributes 1
D [09/Aug/2010:08:55:36 -0500] Get-Printer-Attributes ipp://localhost/printers/OKI_DATA_CORP_ML320_1TURBO
D [09/Aug/2010:08:55:36 -0500] Returning IPP successful-ok for Get-Printer-Attributes (ipp://localhost/printers/OKI_DATA_CORP_ML320_1TURBO) from localhost
D [09/Aug/2010:08:55:36 -0500] Script header: Content-Type: text/html;charset=utf-8
D [09/Aug/2010:08:55:36 -0500] Script header: 
D [09/Aug/2010:08:55:36 -0500] [CGI] Regular expression ".*Clean.*"
D [09/Aug/2010:08:55:36 -0500] [CGI] matches[0].rm_so=0
D [09/Aug/2010:08:55:36 -0500] [CGI] matches[1].rm_so=-1
D [09/Aug/2010:08:55:36 -0500] [CGI] Regular expression ".*PrintSelfTestPage.*"
D [09/Aug/2010:08:55:36 -0500] [CGI] matches[0].rm_so=0
D [09/Aug/2010:08:55:36 -0500] [CGI] matches[1].rm_so=-1
D [09/Aug/2010:08:55:36 -0500] cupsdReadClient: 16 POST / HTTP/1.1
D [09/Aug/2010:08:55:36 -0500] cupsdAuthorize: No authentication data provided.
D [09/Aug/2010:08:55:36 -0500] cupsdReadClient: 16 1.1 Get-Jobs 1
D [09/Aug/2010:08:55:36 -0500] Get-Jobs ipp://localhost:631/printers/OKI_DATA_CORP_ML320_1TURBO
D [09/Aug/2010:08:55:36 -0500] Returning IPP successful-ok for Get-Jobs (ipp://localhost:631/printers/OKI_DATA_CORP_ML320_1TURBO) from localhost
D [09/Aug/2010:08:55:36 -0500] cupsdReadClient: 16 WAITING Closing on EOF
D [09/Aug/2010:08:55:36 -0500] cupsdCloseClient: 16
D [09/Aug/2010:08:55:36 -0500] PID 1802 (/usr/lib/cups/cgi-bin/printers.cgi) exited with no errors.
D [09/Aug/2010:08:55:36 -0500] cupsdSetBusyState: Dirty files
D [09/Aug/2010:08:55:37 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [09/Aug/2010:08:55:37 -0500] cupsdCloseClient: 12
D [09/Aug/2010:08:55:37 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [09/Aug/2010:08:55:37 -0500] cupsdCloseClient: 14
D [09/Aug/2010:08:55:44 -0500] cupsdAcceptClient: 12 from localhost:631 (IPv4)
D [09/Aug/2010:08:55:44 -0500] cupsdReadClient: 12 POST /admin/ HTTP/1.1
D [09/Aug/2010:08:55:44 -0500] cupsdSetBusyState: Active clients and dirty files
D [09/Aug/2010:08:55:44 -0500] cupsdAuthorize: No authentication data provided.
D [09/Aug/2010:08:55:44 -0500] [CGI] argv[0] = "/usr/lib/cups/cgi-bin/admin.cgi"
D [09/Aug/2010:08:55:44 -0500] [CGI] envp[0] = "CUPS_CACHEDIR=/var/cache/cups"
D [09/Aug/2010:08:55:44 -0500] [CGI] envp[1] = "CUPS_DATADIR=/usr/share/cups"
D [09/Aug/2010:08:55:44 -0500] [CGI] envp[2] = "CUPS_DOCROOT=/usr/share/cups/doc"
D [09/Aug/2010:08:55:44 -0500] [CGI] envp[3] = "CUPS_FONTPATH=/usr/share/cups/fonts"
D [09/Aug/2010:08:55:44 -0500] [CGI] envp[4] = "CUPS_REQUESTROOT=/var/spool/cups"
D [09/Aug/2010:08:55:44 -0500] [CGI] envp[5] = "CUPS_SERVERBIN=/usr/lib/cups"
D [09/Aug/2010:08:55:44 -0500] [CGI] envp[6] = "CUPS_SERVERROOT=/etc/cups"
D [09/Aug/2010:08:55:44 -0500] [CGI] envp[7] = "CUPS_STATEDIR=/var/run/cups"
D [09/Aug/2010:08:55:44 -0500] [CGI] envp[8] = "HOME=/var/spool/cups/tmp"
D [09/Aug/2010:08:55:44 -0500] [CGI] envp[9] = "PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [09/Aug/2010:08:55:44 -0500] [CGI] envp[10] = "SERVER_ADMIN=root@researchlinux"
D [09/Aug/2010:08:55:44 -0500] [CGI] envp[11] = "SOFTWARE=CUPS/1.4.4"
D [09/Aug/2010:08:55:44 -0500] [CGI] envp[12] = "TMPDIR=/var/spool/cups/tmp"
D [09/Aug/2010:08:55:44 -0500] [CGI] envp[13] = "USER=root"
D [09/Aug/2010:08:55:44 -0500] [CGI] envp[14] = "CUPS_SERVER=/var/run/cups/cups.sock"
D [09/Aug/2010:08:55:44 -0500] [CGI] envp[15] = "CUPS_ENCRYPTION=IfRequested"
D [09/Aug/2010:08:55:44 -0500] [CGI] envp[16] = "IPP_PORT=631"
D [09/Aug/2010:08:55:44 -0500] [CGI] envp[17] = "LANG=en_US.UTF8"
D [09/Aug/2010:08:55:44 -0500] [CGI] envp[18] = "REDIRECT_STATUS=1"
D [09/Aug/2010:08:55:44 -0500] [CGI] envp[19] = "GATEWAY_INTERFACE=CGI/1.1"
D [09/Aug/2010:08:55:44 -0500] [CGI] envp[20] = "SERVER_NAME=localhost"
D [09/Aug/2010:08:55:44 -0500] [CGI] envp[21] = "SERVER_PORT=631"
D [09/Aug/2010:08:55:44 -0500] [CGI] envp[22] = "REMOTE_ADDR=127.0.0.1"
D [09/Aug/2010:08:55:44 -0500] [CGI] envp[23] = "REMOTE_HOST=localhost"
D [09/Aug/2010:08:55:44 -0500] [CGI] envp[24] = "SCRIPT_NAME=/admin/"
D [09/Aug/2010:08:55:44 -0500] [CGI] envp[25] = "SCRIPT_FILENAME=/usr/share/cups/doc/admin/"
D [09/Aug/2010:08:55:44 -0500] [CGI] envp[26] = "SERVER_PROTOCOL=HTTP/1.1"
D [09/Aug/2010:08:55:44 -0500] [CGI] envp[27] = "HTTP_COOKIE=org.cups.sid=3250ea73be415d540e5706404fbe0908"
D [09/Aug/2010:08:55:44 -0500] [CGI] envp[28] = "HTTP_USER_AGENT=Mozilla/5.0 (X11; U; Linux i686; en-US; rv:1.9.2.8) Gecko/20100724 IceCat/3.6.8 (like Firefox/3.6.8)"
D [09/Aug/2010:08:55:44 -0500] [CGI] envp[29] = "HTTP_REFERER=http://localhost:631/admin/"
D [09/Aug/2010:08:55:44 -0500] [CGI] envp[30] = "REQUEST_METHOD=POST"
D [09/Aug/2010:08:55:44 -0500] [CGI] envp[31] = "CONTENT_LENGTH=60"
D [09/Aug/2010:08:55:44 -0500] [CGI] envp[32] = "CONTENT_TYPE=application/x-www-form-urlencoded"
D [09/Aug/2010:08:55:44 -0500] [CGI] Started /usr/lib/cups/cgi-bin/admin.cgi (PID 1821)
I [09/Aug/2010:08:55:44 -0500] Started "/usr/lib/cups/cgi-bin/admin.cgi" (pid=1821)
D [09/Aug/2010:08:55:44 -0500] cupsdSendCommand: 12 file=15
D [09/Aug/2010:08:55:44 -0500] [CGI] admin.cgi started...
D [09/Aug/2010:08:55:44 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [09/Aug/2010:08:55:44 -0500] [CGI] http=0xb8755e38
D [09/Aug/2010:08:55:44 -0500] [CGI] org.cups.sid cookie is "3250ea73be415d540e5706404fbe0908"
D [09/Aug/2010:08:55:44 -0500] [CGI] op="add-printer"...
D [09/Aug/2010:08:55:44 -0500] [CGI] do_am_printer: DEVICE_URI="(null)"
D [09/Aug/2010:08:55:44 -0500] [CGI] Getting list of devices...
D [09/Aug/2010:08:55:44 -0500] cupsdReadClient: 14 POST / HTTP/1.1
D [09/Aug/2010:08:55:44 -0500] cupsdAuthorize: No authentication data provided.
D [09/Aug/2010:08:55:44 -0500] cupsdReadClient: 14 1.1 CUPS-Get-Devices 1
D [09/Aug/2010:08:55:44 -0500] CUPS-Get-Devices
D [09/Aug/2010:08:55:44 -0500] cupsdIsAuthorized: username=""
D [09/Aug/2010:08:55:44 -0500] Returning HTTP Unauthorized for CUPS-Get-Devices (no URI) from localhost
D [09/Aug/2010:08:55:44 -0500] cupsdSendHeader: 14 WWW-Authenticate: Basic realm="CUPS", trc="y"
D [09/Aug/2010:08:55:44 -0500] [CGI] cgi_passwd(prompt="Password for daemon on localhost? ") called!
D [09/Aug/2010:08:55:44 -0500] Script header: Status: 401
D [09/Aug/2010:08:55:44 -0500] cupsdSendHeader: 12 WWW-Authenticate: Basic realm="CUPS"
D [09/Aug/2010:08:55:44 -0500] Script header: 
D [09/Aug/2010:08:55:44 -0500] cupsdWriteClient: 12 Closing because Keep-Alive disabled
D [09/Aug/2010:08:55:44 -0500] cupsdCloseClient: 12
D [09/Aug/2010:08:55:44 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [09/Aug/2010:08:55:44 -0500] cupsdCloseClient: 14
D [09/Aug/2010:08:55:44 -0500] cupsdSetBusyState: Dirty files
D [09/Aug/2010:08:55:44 -0500] PID 1821 (/usr/lib/cups/cgi-bin/admin.cgi) was terminated normally with signal 15.
I [09/Aug/2010:08:55:57 -0500] Saving subscriptions.conf...
D [09/Aug/2010:08:55:57 -0500] cupsdSetBusyState: Not busy
D [09/Aug/2010:08:55:57 -0500] Report: clients=0
D [09/Aug/2010:08:55:57 -0500] Report: jobs=2
D [09/Aug/2010:08:55:57 -0500] Report: jobs-active=0
D [09/Aug/2010:08:55:57 -0500] Report: printers=2
D [09/Aug/2010:08:55:57 -0500] Report: printers-implicit=0
D [09/Aug/2010:08:55:57 -0500] Report: stringpool-string-count=1415
D [09/Aug/2010:08:55:57 -0500] Report: stringpool-alloc-bytes=7984
D [09/Aug/2010:08:55:57 -0500] Report: stringpool-total-bytes=28168
D [09/Aug/2010:08:56:07 -0500] cupsdAcceptClient: 12 from localhost:631 (IPv4)
D [09/Aug/2010:08:56:07 -0500] cupsdReadClient: 12 POST /admin/ HTTP/1.1
D [09/Aug/2010:08:56:07 -0500] cupsdSetBusyState: Active clients
D [09/Aug/2010:08:56:07 -0500] cupsdAuthorize: Authorized as root using Basic
D [09/Aug/2010:08:56:07 -0500] [CGI] argv[0] = "/usr/lib/cups/cgi-bin/admin.cgi"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[0] = "CUPS_CACHEDIR=/var/cache/cups"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[1] = "CUPS_DATADIR=/usr/share/cups"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[2] = "CUPS_DOCROOT=/usr/share/cups/doc"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[3] = "CUPS_FONTPATH=/usr/share/cups/fonts"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[4] = "CUPS_REQUESTROOT=/var/spool/cups"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[5] = "CUPS_SERVERBIN=/usr/lib/cups"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[6] = "CUPS_SERVERROOT=/etc/cups"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[7] = "CUPS_STATEDIR=/var/run/cups"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[8] = "HOME=/var/spool/cups/tmp"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[9] = "PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[10] = "SERVER_ADMIN=root@researchlinux"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[11] = "SOFTWARE=CUPS/1.4.4"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[12] = "TMPDIR=/var/spool/cups/tmp"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[13] = "USER=root"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[14] = "CUPS_SERVER=/var/run/cups/cups.sock"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[15] = "CUPS_ENCRYPTION=IfRequested"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[16] = "IPP_PORT=631"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[17] = "CUPSD_AUTH_TYPE=Basic"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[18] = "LANG=en_US.UTF8"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[19] = "REDIRECT_STATUS=1"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[20] = "GATEWAY_INTERFACE=CGI/1.1"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[21] = "SERVER_NAME=localhost"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[22] = "SERVER_PORT=631"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[23] = "REMOTE_ADDR=127.0.0.1"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[24] = "REMOTE_HOST=localhost"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[25] = "SCRIPT_NAME=/admin/"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[26] = "SCRIPT_FILENAME=/usr/share/cups/doc/admin/"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[27] = "REMOTE_USER=root"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[28] = "SERVER_PROTOCOL=HTTP/1.1"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[29] = "HTTP_COOKIE=org.cups.sid=3250ea73be415d540e5706404fbe0908"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[30] = "HTTP_USER_AGENT=Mozilla/5.0 (X11; U; Linux i686; en-US; rv:1.9.2.8) Gecko/20100724 IceCat/3.6.8 (like Firefox/3.6.8)"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[31] = "HTTP_REFERER=http://localhost:631/admin/"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[32] = "REQUEST_METHOD=POST"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[33] = "CONTENT_LENGTH=60"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[34] = "CONTENT_TYPE=application/x-www-form-urlencoded"
D [09/Aug/2010:08:56:07 -0500] [CGI] Started /usr/lib/cups/cgi-bin/admin.cgi (PID 1857)
I [09/Aug/2010:08:56:07 -0500] Started "/usr/lib/cups/cgi-bin/admin.cgi" (pid=1857)
D [09/Aug/2010:08:56:07 -0500] cupsdSendCommand: 12 file=15
D [09/Aug/2010:08:56:07 -0500] [CGI] admin.cgi started...
D [09/Aug/2010:08:56:07 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [09/Aug/2010:08:56:07 -0500] [CGI] http=0xb96b2e38
D [09/Aug/2010:08:56:07 -0500] [CGI] org.cups.sid cookie is "3250ea73be415d540e5706404fbe0908"
D [09/Aug/2010:08:56:07 -0500] [CGI] op="add-printer"...
D [09/Aug/2010:08:56:07 -0500] [CGI] do_am_printer: DEVICE_URI="(null)"
D [09/Aug/2010:08:56:07 -0500] [CGI] Getting list of devices...
D [09/Aug/2010:08:56:07 -0500] cupsdReadClient: 14 POST / HTTP/1.1
D [09/Aug/2010:08:56:07 -0500] cupsdAuthorize: No authentication data provided.
D [09/Aug/2010:08:56:07 -0500] cupsdReadClient: 14 1.1 CUPS-Get-Devices 1
D [09/Aug/2010:08:56:07 -0500] CUPS-Get-Devices
D [09/Aug/2010:08:56:07 -0500] cupsdIsAuthorized: username=""
D [09/Aug/2010:08:56:07 -0500] Returning HTTP Unauthorized for CUPS-Get-Devices (no URI) from localhost
D [09/Aug/2010:08:56:07 -0500] cupsdSendHeader: 14 WWW-Authenticate: Basic realm="CUPS", trc="y"
D [09/Aug/2010:08:56:07 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [09/Aug/2010:08:56:07 -0500] cupsdCloseClient: 14
D [09/Aug/2010:08:56:07 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [09/Aug/2010:08:56:07 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [09/Aug/2010:08:56:07 -0500] cupsdCloseClient: 14
D [09/Aug/2010:08:56:07 -0500] cupsdAcceptClient: 14 from localhost (Domain)
D [09/Aug/2010:08:56:07 -0500] cupsdReadClient: 14 POST / HTTP/1.1
D [09/Aug/2010:08:56:07 -0500] cupsdAuthorize: Authorized as root using Local
D [09/Aug/2010:08:56:07 -0500] cupsdReadClient: 14 1.1 CUPS-Get-Devices 1
D [09/Aug/2010:08:56:07 -0500] CUPS-Get-Devices
D [09/Aug/2010:08:56:07 -0500] cupsdIsAuthorized: username="root"
D [09/Aug/2010:08:56:07 -0500] [CGI] argv[0] = "/usr/lib/cups/daemon/cups-deviced"
D [09/Aug/2010:08:56:07 -0500] [CGI] argv[1] = "1"
D [09/Aug/2010:08:56:07 -0500] [CGI] argv[2] = "0"
D [09/Aug/2010:08:56:07 -0500] [CGI] argv[3] = "30"
D [09/Aug/2010:08:56:07 -0500] [CGI] argv[4] = "2"
D [09/Aug/2010:08:56:07 -0500] [CGI] argv[5] = "requested-attributes=all"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[0] = "CUPS_CACHEDIR=/var/cache/cups"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[1] = "CUPS_DATADIR=/usr/share/cups"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[2] = "CUPS_DOCROOT=/usr/share/cups/doc"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[3] = "CUPS_FONTPATH=/usr/share/cups/fonts"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[4] = "CUPS_REQUESTROOT=/var/spool/cups"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[5] = "CUPS_SERVERBIN=/usr/lib/cups"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[6] = "CUPS_SERVERROOT=/etc/cups"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[7] = "CUPS_STATEDIR=/var/run/cups"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[8] = "HOME=/var/spool/cups/tmp"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[9] = "PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[10] = "SERVER_ADMIN=root@researchlinux"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[11] = "SOFTWARE=CUPS/1.4.4"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[12] = "TMPDIR=/var/spool/cups/tmp"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[13] = "USER=root"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[14] = "CUPS_SERVER=/var/run/cups/cups.sock"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[15] = "CUPS_ENCRYPTION=IfRequested"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[16] = "IPP_PORT=631"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[17] = "CUPSD_AUTH_TYPE=Local"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[18] = "LANG=en_US.UTF8"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[19] = "REDIRECT_STATUS=1"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[20] = "GATEWAY_INTERFACE=CGI/1.1"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[21] = "SERVER_NAME=localhost"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[22] = "SERVER_PORT=631"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[23] = "REMOTE_ADDR="
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[24] = "REMOTE_HOST=localhost"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[25] = "SCRIPT_NAME=/"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[26] = "SCRIPT_FILENAME=/usr/share/cups/doc/"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[27] = "REMOTE_USER=root"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[28] = "SERVER_PROTOCOL=HTTP/1.1"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[29] = "HTTP_USER_AGENT=CUPS/1.4.4"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[30] = "REQUEST_METHOD=POST"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[31] = "CONTENT_LENGTH=91"
D [09/Aug/2010:08:56:07 -0500] [CGI] envp[32] = "CONTENT_TYPE=application/ipp"
D [09/Aug/2010:08:56:07 -0500] [CGI] Started /usr/lib/cups/daemon/cups-deviced (PID 1858)
I [09/Aug/2010:08:56:07 -0500] Started "/usr/lib/cups/daemon/cups-deviced" (pid=1858)
D [09/Aug/2010:08:56:07 -0500] cupsdSendCommand: 14 file=16
D [09/Aug/2010:08:56:07 -0500] [cups-deviced] Started backend /usr/lib/cups/backend/ipp (PID 1859)
D [09/Aug/2010:08:56:07 -0500] [cups-deviced] Started backend /usr/lib/cups/backend/usb (PID 1860)
D [09/Aug/2010:08:56:07 -0500] [cups-deviced] Started backend /usr/lib/cups/backend/socket (PID 1861)
D [09/Aug/2010:08:56:07 -0500] [cups-deviced] Started backend /usr/lib/cups/backend/lpd (PID 1862)
D [09/Aug/2010:08:56:07 -0500] [cups-deviced] Started backend /usr/lib/cups/backend/smb (PID 1863)
D [09/Aug/2010:08:56:07 -0500] [cups-deviced] Started backend /usr/lib/cups/backend/http (PID 1864)
D [09/Aug/2010:08:56:07 -0500] [cups-deviced] Started backend /usr/lib/cups/backend/snmp (PID 1865)
D [09/Aug/2010:08:56:07 -0500] [cups-deviced] Started backend /usr/lib/cups/backend/bluetooth (PID 1866)
D [09/Aug/2010:08:56:07 -0500] [cups-deviced] Started backend /usr/lib/cups/backend/serial (PID 1867)
D [09/Aug/2010:08:56:07 -0500] [cups-deviced] Started backend /usr/lib/cups/backend/parallel (PID 1868)
D [09/Aug/2010:08:56:07 -0500] [cups-deviced] Started backend /usr/lib/cups/backend/beh (PID 1869)
D [09/Aug/2010:08:56:07 -0500] [cups-deviced] Started backend /usr/lib/cups/backend/scsi (PID 1870)
D [09/Aug/2010:08:56:07 -0500] [CGI] list_devices
D [09/Aug/2010:08:56:07 -0500] [CGI] usb_find_busses=5
D [09/Aug/2010:08:56:07 -0500] [CGI] Flushed attributes...
D [09/Aug/2010:08:56:07 -0500] [cups-deviced] Found device "http"...
D [09/Aug/2010:08:56:07 -0500] Script header: Content-Type: application/ipp
D [09/Aug/2010:08:56:07 -0500] Script header: 
D [09/Aug/2010:08:56:07 -0500] [CGI] Flushed attributes...
D [09/Aug/2010:08:56:07 -0500] [cups-deviced] Found device "scsi"...
D [09/Aug/2010:08:56:07 -0500] [cups-deviced] PID 1870 (scsi) exited with no errors.
D [09/Aug/2010:08:56:07 -0500] Script header: MIME-Version: 1.0
D [09/Aug/2010:08:56:07 -0500] Script header: Content-Type: multipart/x-mixed-replace; boundary="CUPS-MULTIPART"
D [09/Aug/2010:08:56:07 -0500] Script header: 
D [09/Aug/2010:08:56:07 -0500] [CGI] Flushed attributes...
D [09/Aug/2010:08:56:07 -0500] [cups-deviced] Found device "lpd"...
D [09/Aug/2010:08:56:07 -0500] [cups-deviced] PID 1862 (lpd) exited with no errors.
D [09/Aug/2010:08:56:07 -0500] [CGI] Flushed attributes...
D [09/Aug/2010:08:56:07 -0500] [cups-deviced] Found device "socket"...
D [09/Aug/2010:08:56:07 -0500] [cups-deviced] PID 1861 (socket) exited with no errors.
D [09/Aug/2010:08:56:07 -0500] [cups-deviced] PID 1859 (ipp) exited with no errors.
D [09/Aug/2010:08:56:07 -0500] [CGI] Flushed attributes...
D [09/Aug/2010:08:56:07 -0500] [cups-deviced] Found device "ipp"...
D [09/Aug/2010:08:56:07 -0500] [cups-deviced] PID 1864 (http) exited with no errors.
D [09/Aug/2010:08:56:07 -0500] [cups-deviced] PID 1867 (serial) exited with no errors.
D [09/Aug/2010:08:56:07 -0500] [CGI] Flushed attributes...
D [09/Aug/2010:08:56:07 -0500] [cups-deviced] Found device "parallel:/dev/lp0"...
D [09/Aug/2010:08:56:07 -0500] [cups-deviced] PID 1868 (parallel) exited with no errors.
D [09/Aug/2010:08:56:07 -0500] [CGI] usb_find_devices=7
D [09/Aug/2010:08:56:07 -0500] [cups-deviced] PID 1860 (usb) exited with no errors.
D [09/Aug/2010:08:56:07 -0500] [CGI] Flushed attributes...
D [09/Aug/2010:08:56:07 -0500] [cups-deviced] Found device "smb"...
D [09/Aug/2010:08:56:07 -0500] [cups-deviced] PID 1863 (smb) exited with no errors.
D [09/Aug/2010:08:56:07 -0500] [CGI] Regular expression "[a-z]+://"
D [09/Aug/2010:08:56:07 -0500] [cups-deviced] PID 1866 (bluetooth) exited with no errors.
D [09/Aug/2010:08:56:07 -0500] [CGI] Regular expression "[a-z]+://"
D [09/Aug/2010:08:56:07 -0500] [CGI] Flushed attributes...
D [09/Aug/2010:08:56:07 -0500] [cups-deviced] Found device "beh"...
D [09/Aug/2010:08:56:07 -0500] [cups-deviced] PID 1869 (beh) exited with no errors.
D [09/Aug/2010:08:56:08 -0500] cupsdAcceptClient: 17 from localhost:631 (IPv4)
D [09/Aug/2010:08:56:08 -0500] cupsdReadClient: 17 GET /images/wait.gif HTTP/1.1
D [09/Aug/2010:08:56:08 -0500] cupsdAuthorize: No authentication data provided.
D [09/Aug/2010:08:56:09 -0500] cupsdReadClient: 17 WAITING Closing on EOF
D [09/Aug/2010:08:56:09 -0500] cupsdCloseClient: 17
D [09/Aug/2010:08:56:09 -0500] [CGI] Flushed attributes...
D [09/Aug/2010:08:56:09 -0500] [cups-deviced] Found device "socket://192.168.139.45"...
D [09/Aug/2010:08:56:11 -0500] [cups-deviced] PID 1865 (snmp) exited with no errors.
D [09/Aug/2010:08:56:11 -0500] PID 1858 (/usr/lib/cups/daemon/cups-deviced) exited with no errors.
D [09/Aug/2010:08:56:11 -0500] [CGI] Got device list!
D [09/Aug/2010:08:56:11 -0500] [CGI] Regular expression "[a-z]+://"
D [09/Aug/2010:08:56:11 -0500] [CGI] Regular expression "[a-z]+://"
D [09/Aug/2010:08:56:11 -0500] [CGI] Regular expression "[a-z]+://"
D [09/Aug/2010:08:56:11 -0500] [CGI] Regular expression "[a-z]+://"
D [09/Aug/2010:08:56:11 -0500] [CGI] Regular expression "[a-z]+://"
D [09/Aug/2010:08:56:11 -0500] [CGI] Regular expression "[a-z]+://"
D [09/Aug/2010:08:56:11 -0500] [CGI] Regular expression "[a-z]+://"
D [09/Aug/2010:08:56:11 -0500] [CGI] Regular expression "[a-z]+://"
D [09/Aug/2010:08:56:11 -0500] [CGI] Regular expression "[a-z]+://"
D [09/Aug/2010:08:56:11 -0500] [CGI] matches[0].rm_so=0
D [09/Aug/2010:08:56:11 -0500] [CGI] matches[1].rm_so=-1
D [09/Aug/2010:08:56:11 -0500] [CGI] Regular expression "[a-z]+://"
D [09/Aug/2010:08:56:11 -0500] [CGI] Regular expression "[a-z]+://"
D [09/Aug/2010:08:56:11 -0500] [CGI] Regular expression "[a-z]+://"
D [09/Aug/2010:08:56:11 -0500] [CGI] Regular expression "[a-z]+://"
D [09/Aug/2010:08:56:11 -0500] [CGI] Regular expression "[a-z]+://"
D [09/Aug/2010:08:56:11 -0500] [CGI] Regular expression "[a-z]+://"
D [09/Aug/2010:08:56:11 -0500] [CGI] Regular expression "[a-z]+://"
D [09/Aug/2010:08:56:11 -0500] [CGI] Regular expression "[a-z]+://"
D [09/Aug/2010:08:56:11 -0500] [CGI] Regular expression "[a-z]+://"
D [09/Aug/2010:08:56:11 -0500] [CGI] matches[0].rm_so=0
D [09/Aug/2010:08:56:11 -0500] [CGI] matches[1].rm_so=-1
D [09/Aug/2010:08:56:11 -0500] cupsdReadClient: 14 WAITING Closing on EOF
D [09/Aug/2010:08:56:11 -0500] cupsdCloseClient: 14
D [09/Aug/2010:08:56:11 -0500] cupsdSetBusyState: Not busy
D [09/Aug/2010:08:56:11 -0500] PID 1857 (/usr/lib/cups/cgi-bin/admin.cgi) exited with no errors.
D [09/Aug/2010:08:56:12 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [09/Aug/2010:08:56:12 -0500] cupsdCloseClient: 12
D [09/Aug/2010:08:56:28 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [09/Aug/2010:08:56:28 -0500] cupsdReadClient: 12 POST / HTTP/1.1
D [09/Aug/2010:08:56:28 -0500] cupsdSetBusyState: Active clients
D [09/Aug/2010:08:56:28 -0500] cupsdAuthorize: No authentication data provided.
D [09/Aug/2010:08:56:28 -0500] cupsdReadClient: 12 1.1 Get-Notifications 1
D [09/Aug/2010:08:56:28 -0500] Get-Notifications /
D [09/Aug/2010:08:56:28 -0500] cupsdIsAuthorized: requesting-user-name="glsadmin"
D [09/Aug/2010:08:56:28 -0500] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [09/Aug/2010:08:56:28 -0500] cupsdSetBusyState: Not busy
D [09/Aug/2010:08:56:28 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [09/Aug/2010:08:56:28 -0500] cupsdCloseClient: 12
D [09/Aug/2010:08:57:28 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [09/Aug/2010:08:57:28 -0500] Report: clients=1
D [09/Aug/2010:08:57:28 -0500] Report: jobs=2
D [09/Aug/2010:08:57:28 -0500] Report: jobs-active=0
D [09/Aug/2010:08:57:28 -0500] Report: printers=2
D [09/Aug/2010:08:57:28 -0500] Report: printers-implicit=0
D [09/Aug/2010:08:57:28 -0500] Report: stringpool-string-count=1415
D [09/Aug/2010:08:57:28 -0500] Report: stringpool-alloc-bytes=7984
D [09/Aug/2010:08:57:28 -0500] Report: stringpool-total-bytes=28168
D [09/Aug/2010:08:57:28 -0500] cupsdReadClient: 12 POST / HTTP/1.1
D [09/Aug/2010:08:57:28 -0500] cupsdSetBusyState: Active clients
D [09/Aug/2010:08:57:28 -0500] cupsdAuthorize: No authentication data provided.
D [09/Aug/2010:08:57:28 -0500] cupsdReadClient: 12 1.1 Get-Notifications 1
D [09/Aug/2010:08:57:28 -0500] Get-Notifications /
D [09/Aug/2010:08:57:28 -0500] cupsdIsAuthorized: requesting-user-name="glsadmin"
D [09/Aug/2010:08:57:28 -0500] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [09/Aug/2010:08:57:28 -0500] cupsdSetBusyState: Not busy
D [09/Aug/2010:08:57:28 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [09/Aug/2010:08:57:28 -0500] cupsdCloseClient: 12
D [09/Aug/2010:08:58:28 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [09/Aug/2010:08:58:28 -0500] Report: clients=1
D [09/Aug/2010:08:58:28 -0500] Report: jobs=2
D [09/Aug/2010:08:58:28 -0500] Report: jobs-active=0
D [09/Aug/2010:08:58:28 -0500] Report: printers=2
D [09/Aug/2010:08:58:28 -0500] Report: printers-implicit=0
D [09/Aug/2010:08:58:28 -0500] Report: stringpool-string-count=1415
D [09/Aug/2010:08:58:28 -0500] Report: stringpool-alloc-bytes=7984
D [09/Aug/2010:08:58:28 -0500] Report: stringpool-total-bytes=28168
D [09/Aug/2010:08:58:28 -0500] cupsdReadClient: 12 POST / HTTP/1.1
D [09/Aug/2010:08:58:28 -0500] cupsdSetBusyState: Active clients
D [09/Aug/2010:08:58:28 -0500] cupsdAuthorize: No authentication data provided.
D [09/Aug/2010:08:58:28 -0500] cupsdReadClient: 12 1.1 Get-Notifications 1
D [09/Aug/2010:08:58:28 -0500] Get-Notifications /
D [09/Aug/2010:08:58:28 -0500] cupsdIsAuthorized: requesting-user-name="glsadmin"
D [09/Aug/2010:08:58:28 -0500] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [09/Aug/2010:08:58:28 -0500] cupsdSetBusyState: Not busy
D [09/Aug/2010:08:58:28 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [09/Aug/2010:08:58:28 -0500] cupsdCloseClient: 12
D [09/Aug/2010:08:59:28 -0500] cupsdAcceptClient: 12 from localhost (Domain)
D [09/Aug/2010:08:59:28 -0500] Report: clients=1
D [09/Aug/2010:08:59:28 -0500] Report: jobs=2
D [09/Aug/2010:08:59:28 -0500] Report: jobs-active=0
D [09/Aug/2010:08:59:28 -0500] Report: printers=2
D [09/Aug/2010:08:59:28 -0500] Report: printers-implicit=0
D [09/Aug/2010:08:59:28 -0500] Report: stringpool-string-count=1415
D [09/Aug/2010:08:59:28 -0500] Report: stringpool-alloc-bytes=7984
D [09/Aug/2010:08:59:28 -0500] Report: stringpool-total-bytes=28168
D [09/Aug/2010:08:59:28 -0500] cupsdReadClient: 12 POST / HTTP/1.1
D [09/Aug/2010:08:59:28 -0500] cupsdSetBusyState: Active clients
D [09/Aug/2010:08:59:28 -0500] cupsdAuthorize: No authentication data provided.
D [09/Aug/2010:08:59:28 -0500] cupsdReadClient: 12 1.1 Get-Notifications 1
D [09/Aug/2010:08:59:28 -0500] Get-Notifications /
D [09/Aug/2010:08:59:28 -0500] cupsdIsAuthorized: requesting-user-name="glsadmin"
D [09/Aug/2010:08:59:28 -0500] Returning IPP successful-ok for Get-Notifications (/) from localhost
D [09/Aug/2010:08:59:28 -0500] cupsdSetBusyState: Not busy
D [09/Aug/2010:08:59:28 -0500] cupsdReadClient: 12 WAITING Closing on EOF
D [09/Aug/2010:08:59:28 -0500] cupsdCloseClient: 12