Here are the log under debug mode:
didn't understand what happen. But is the server name supposed to be where the printer is (in my case DD-WRT router 192.168.1.1), instead of where CUPS is (in my case pogo ip 192.168.1.139?
$this->bbcode_second_pass_code('', 'I [27/Aug/2013:23:59:08 -0400] [Job 11] Job restarted by user.
D [27/Aug/2013:23:59:08 -0400] cupsdMarkDirty(---J-)
D [27/Aug/2013:23:59:08 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients"
D [27/Aug/2013:23:59:08 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [27/Aug/2013:23:59:08 -0400] [Job 11] time-at-processing=1377662348
D [27/Aug/2013:23:59:08 -0400] cupsdMarkDirty(---J-)
D [27/Aug/2013:23:59:08 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [27/Aug/2013:23:59:08 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [27/Aug/2013:23:59:08 -0400] Discarding unused printer-state-changed event...
D [27/Aug/2013:23:59:08 -0400] [Job 11] 4 filters for job:
D [27/Aug/2013:23:59:08 -0400] [Job 11] bannertopdf (application/vnd.cups-pdf-banner to application/pdf, cost 33)
D [27/Aug/2013:23:59:08 -0400] [Job 11] pdftopdf (application/pdf to application/vnd.cups-pdf, cost 66)
D [27/Aug/2013:23:59:08 -0400] [Job 11] gstoraster (application/vnd.cups-pdf to application/vnd.cups-raster, cost 66)
D [27/Aug/2013:23:59:08 -0400] [Job 11] hpcups (application/vnd.cups-raster to printer/HPOfficeJetPro8000Wireless, cost 0)
D [27/Aug/2013:23:59:08 -0400] [Job 11] job-sheets=none,none
D [27/Aug/2013:23:59:08 -0400] [Job 11] argv[0]="HPOfficeJetPro8000Wireless"
D [27/Aug/2013:23:59:08 -0400] [Job 11] argv[1]="11"
D [27/Aug/2013:23:59:08 -0400] [Job 11] argv[2]="root"
D [27/Aug/2013:23:59:08 -0400] [Job 11] argv[3]="Test Page"
D [27/Aug/2013:23:59:08 -0400] [Job 11] argv[4]="1"
D [27/Aug/2013:23:59:08 -0400] [Job 11] argv[5]="job-uuid=urn:uuid:28f747e2-7530-3526-58a2-ff8a4c0bd3af job-originating-host-name=localhost time-at-creation=1377401247 time-at-processing=1377662348"
D [27/Aug/2013:23:59:08 -0400] [Job 11] argv[6]="/var/spool/cups/d00011-001"
D [27/Aug/2013:23:59:08 -0400] [Job 11] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [27/Aug/2013:23:59:08 -0400] [Job 11] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [27/Aug/2013:23:59:08 -0400] [Job 11] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc"
D [27/Aug/2013:23:59:08 -0400] [Job 11] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [27/Aug/2013:23:59:08 -0400] [Job 11] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [27/Aug/2013:23:59:08 -0400] [Job 11] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [27/Aug/2013:23:59:08 -0400] [Job 11] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [27/Aug/2013:23:59:08 -0400] [Job 11] envp[7]="CUPS_STATEDIR=/run/cups"
D [27/Aug/2013:23:59:08 -0400] [Job 11] envp[8]="HOME=/var/spool/cups/tmp"
D [27/Aug/2013:23:59:08 -0400] [Job 11] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/bin:/bin:/usr/bin"
D [27/Aug/2013:23:59:08 -0400] [Job 11] envp[10]="SERVER_ADMIN=root@pogo_e02_a"
D [27/Aug/2013:23:59:08 -0400] [Job 11] envp[11]="SOFTWARE=CUPS/1.6.3"
D [27/Aug/2013:23:59:08 -0400] [Job 11] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [27/Aug/2013:23:59:08 -0400] [Job 11] envp[13]="USER=root"
D [27/Aug/2013:23:59:08 -0400] [Job 11] envp[14]="CUPS_MAX_MESSAGE=2047"
D [27/Aug/2013:23:59:08 -0400] [Job 11] envp[15]="CUPS_SERVER=/var/run/cups/cups.sock"
D [27/Aug/2013:23:59:08 -0400] [Job 11] envp[16]="CUPS_ENCRYPTION=IfRequested"
D [27/Aug/2013:23:59:08 -0400] [Job 11] envp[17]="IPP_PORT=631"
D [27/Aug/2013:23:59:08 -0400] [Job 11] envp[18]="CHARSET=utf-8"
D [27/Aug/2013:23:59:08 -0400] [Job 11] envp[19]="LANG=en_US.UTF-8"
D [27/Aug/2013:23:59:08 -0400] [Job 11] envp[20]="PPD=/etc/cups/ppd/HPOfficeJetPro8000Wireless.ppd"
D [27/Aug/2013:23:59:08 -0400] [Job 11] envp[21]="RIP_MAX_CACHE=128m"
D [27/Aug/2013:23:59:08 -0400] [Job 11] envp[22]="CONTENT_TYPE=application/vnd.cups-pdf-banner"
D [27/Aug/2013:23:59:08 -0400] [Job 11] envp[23]="DEVICE_URI=socket://192.168.1.1:9100"
D [27/Aug/2013:23:59:08 -0400] [Job 11] envp[24]="PRINTER_INFO=HPOfficeJetPro8000Wireless"
D [27/Aug/2013:23:59:08 -0400] [Job 11] envp[25]="PRINTER_LOCATION=Basement"
D [27/Aug/2013:23:59:08 -0400] [Job 11] envp[26]="PRINTER=HPOfficeJetPro8000Wireless"
D [27/Aug/2013:23:59:08 -0400] [Job 11] envp[27]="PRINTER_STATE_REASONS=none"
D [27/Aug/2013:23:59:08 -0400] [Job 11] envp[28]="CUPS_FILETYPE=document"
D [27/Aug/2013:23:59:08 -0400] [Job 11] envp[29]="FINAL_CONTENT_TYPE=application/vnd.cups-raster"
D [27/Aug/2013:23:59:08 -0400] [Job 11] envp[30]="AUTH_I****"
I [27/Aug/2013:23:59:08 -0400] [Job 11] Started filter /usr/lib/cups/filter/bannertopdf (PID 19174)
I [27/Aug/2013:23:59:08 -0400] [Job 11] Started filter /usr/lib/cups/filter/pdftopdf (PID 19175)
I [27/Aug/2013:23:59:08 -0400] [Job 11] Started filter /usr/lib/cups/filter/gstoraster (PID 19176)
I [27/Aug/2013:23:59:08 -0400] [Job 11] Started filter /usr/lib/cups/filter/hpcups (PID 19177)
I [27/Aug/2013:23:59:08 -0400] [Job 11] Started backend /usr/lib/cups/backend/socket (PID 19178)
D [27/Aug/2013:23:59:08 -0400] Discarding unused job-state-changed event...
I [27/Aug/2013:23:59:08 -0400] [Job 11] Restarted by "root".
D [27/Aug/2013:23:59:08 -0400] Returning IPP successful-ok for Restart-Job (ipp://localhost/jobs/11) from localhost
D [27/Aug/2013:23:59:08 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients and dirty files"
D [27/Aug/2013:23:59:08 -0400] [CGI] cgiSetVariable: refresh_page="5;URL=http://192.168.1.139:631/jobs/"
D [27/Aug/2013:23:59:08 -0400] [CGI] cgiSetVariable: TITLE="Jobs"
D [27/Aug/2013:23:59:08 -0400] [CGI] cgiSetVariable: SERVER_NAME="192.168.1.139"
D [27/Aug/2013:23:59:08 -0400] [CGI] cgiSetVariable: REMOTE_USER="root"
D [27/Aug/2013:23:59:08 -0400] [CGI] cgiSetVariable: CUPS_VERSION="CUPS v1.6.3"
D [27/Aug/2013:23:59:08 -0400] Script header: Content-Type: text/html;charset=utf-8
D [27/Aug/2013:23:59:08 -0400] Script header:
D [27/Aug/2013:23:59:08 -0400] [Client 13] HTTP_WAITING Closing on EOF
D [27/Aug/2013:23:59:08 -0400] [Client 13] Closing connection.
D [27/Aug/2013:23:59:08 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [27/Aug/2013:23:59:08 -0400] PID 19173 (/usr/lib/cups/cgi-bin/jobs.cgi) exited with no errors.
D [27/Aug/2013:23:59:08 -0400] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Active clients, printing jobs, and dirty files"
D [27/Aug/2013:23:59:08 -0400] [Job 11] STATE: +connecting-to-device
D [27/Aug/2013:23:59:08 -0400] cupsdMarkDirty(---J-)
D [27/Aug/2013:23:59:08 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Printing jobs and dirty files"
D [27/Aug/2013:23:59:08 -0400] Discarding unused printer-state-changed event...
D [27/Aug/2013:23:59:08 -0400] [Job 11] Looking up "192.168.1.1"...
D [27/Aug/2013:23:59:09 -0400] [Job 11] PID 19174 (/usr/lib/cups/filter/bannertopdf) exited with no errors.
D [27/Aug/2013:23:59:09 -0400] [Job 11] WARN: not compiled with DBus support
D [27/Aug/2013:23:59:09 -0400] [Job 11] PPD uses qualifier 'RGB.Plain.'
D [27/Aug/2013:23:59:09 -0400] [Job 11] WARN: not compiled with DBus support
I [27/Aug/2013:23:59:09 -0400] [Job 11] no profiles specified in PPD
D [27/Aug/2013:23:59:09 -0400] cupsdMarkDirty(---J-)
D [27/Aug/2013:23:59:09 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [27/Aug/2013:23:59:09 -0400] [Job 11] Set job-printer-state-message to "no profiles specified in PPD", current level=INFO
D [27/Aug/2013:23:59:09 -0400] [Job 11] Ghostscript command line: /usr/bin/gs -dQUIET -dPARANOIDSAFER -dNOPAUSE -dBATCH -dNOINTERPOLATE -sDEVICE=cups -sstdout=%stderr -sOutputFile=%stdout -sMediaType=Plain -sOutputType=0 -r600x600 -dMediaPosition=7 -dDEVICEWIDTHPOINTS=612 -dDEVICEHEIGHTPOINTS=792 -dcupsBitsPerColor=8 -dcupsColorOrder=0 -dcupsColorSpace=17 -dcupsInteger0=2 -scupsPageSizeName=Letter -I/usr/share/cups/fonts -c -f -_
D [27/Aug/2013:23:59:09 -0400] [Job 11] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [27/Aug/2013:23:59:09 -0400] [Job 11] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [27/Aug/2013:23:59:09 -0400] [Job 11] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc"
D [27/Aug/2013:23:59:09 -0400] [Job 11] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [27/Aug/2013:23:59:09 -0400] [Job 11] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [27/Aug/2013:23:59:09 -0400] [Job 11] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [27/Aug/2013:23:59:09 -0400] [Job 11] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [27/Aug/2013:23:59:09 -0400] [Job 11] envp[7]="CUPS_STATEDIR=/run/cups"
D [27/Aug/2013:23:59:09 -0400] [Job 11] envp[8]="HOME=/var/spool/cups/tmp"
D [27/Aug/2013:23:59:09 -0400] [Job 11] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/bin:/bin:/usr/bin"
D [27/Aug/2013:23:59:09 -0400] [Job 11] envp[10]="SERVER_ADMIN=root@pogo_e02_a"
D [27/Aug/2013:23:59:09 -0400] [Job 11] envp[11]="SOFTWARE=CUPS/1.6.3"
D [27/Aug/2013:23:59:09 -0400] [Job 11] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [27/Aug/2013:23:59:09 -0400] [Job 11] envp[13]="USER=root"
D [27/Aug/2013:23:59:09 -0400] [Job 11] envp[14]="CUPS_MAX_MESSAGE=2047"
D [27/Aug/2013:23:59:09 -0400] [Job 11] envp[15]="CUPS_SERVER=/var/run/cups/cups.sock"
D [27/Aug/2013:23:59:09 -0400] [Job 11] envp[16]="CUPS_ENCRYPTION=IfRequested"
D [27/Aug/2013:23:59:09 -0400] [Job 11] envp[17]="IPP_PORT=631"
D [27/Aug/2013:23:59:09 -0400] [Job 11] envp[18]="CHARSET=utf-8"
D [27/Aug/2013:23:59:09 -0400] [Job 11] envp[19]="LANG=en_US.UTF-8"
D [27/Aug/2013:23:59:09 -0400] [Job 11] envp[20]="PPD=/etc/cups/ppd/HPOfficeJetPro8000Wireless.ppd"
D [27/Aug/2013:23:59:09 -0400] [Job 11] envp[21]="RIP_MAX_CACHE=128m"
D [27/Aug/2013:23:59:09 -0400] [Job 11] envp[22]="CONTENT_TYPE=application/vnd.cups-pdf-banner"
D [27/Aug/2013:23:59:09 -0400] [Job 11] envp[23]="DEVICE_URI=socket://192.168.1.1:9100"
D [27/Aug/2013:23:59:09 -0400] [Job 11] envp[24]="PRINTER_INFO=HPOfficeJetPro8000Wireless"
D [27/Aug/2013:23:59:09 -0400] [Job 11] envp[25]="PRINTER_LOCATION=Basement"
D [27/Aug/2013:23:59:09 -0400] [Job 11] envp[26]="PRINTER=HPOfficeJetPro8000Wireless"
D [27/Aug/2013:23:59:09 -0400] [Job 11] envp[27]="PRINTER_STATE_REASONS=none"
D [27/Aug/2013:23:59:09 -0400] [Job 11] envp[28]="CUPS_FILETYPE=document"
D [27/Aug/2013:23:59:09 -0400] [Job 11] envp[29]="FINAL_CONTENT_TYPE=application/vnd.cups-raster"
D [27/Aug/2013:23:59:09 -0400] [Job 11] envp[30]="AUTH_INFO_REQUIRED=none"
D [27/Aug/2013:23:59:09 -0400] Discarding unused job-progress event...
D [27/Aug/2013:23:59:09 -0400] Discarding unused printer-state-changed event...
D [27/Aug/2013:23:59:09 -0400] [Job 11] PID 19175 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
I [27/Aug/2013:23:59:10 -0400] [Job 11] Start rendering...
D [27/Aug/2013:23:59:10 -0400] cupsdMarkDirty(---J-)
D [27/Aug/2013:23:59:10 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [27/Aug/2013:23:59:10 -0400] [Job 11] Set job-printer-state-message to "Start rendering...", current level=INFO
D [27/Aug/2013:23:59:10 -0400] Discarding unused job-progress event...
D [27/Aug/2013:23:59:10 -0400] Discarding unused printer-state-changed event...
I [27/Aug/2013:23:59:10 -0400] [Job 11] Processing page 1...
D [27/Aug/2013:23:59:10 -0400] cupsdMarkDirty(---J-)
D [27/Aug/2013:23:59:10 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [27/Aug/2013:23:59:10 -0400] [Job 11] Set job-printer-state-message to "Processing page 1...", current level=INFO
D [27/Aug/2013:23:59:10 -0400] Discarding unused job-progress event...
D [27/Aug/2013:23:59:10 -0400] Discarding unused printer-state-changed event...
D [27/Aug/2013:23:59:12 -0400] [Job 11] Error: /undefined in --setpagedevice--
D [27/Aug/2013:23:59:12 -0400] [Job 11] Operand stack:
D [27/Aug/2013:23:59:12 -0400] [Job 11] (/var/spool/cups/tmp/gs_TWAQoq) --nostringval-- --dict:10/10(L)-- --dict:6/6(L)-- --nostringval-- --nostringval-- --dict:3/3(L)-- --dict:6/6(L)-- --dict:153/153(ro)(L)-- --dict:21/159(L)-- --dict:1/10(L)-- --dict:3/3(L)-- PageSpotColors 1 --dict:3/3(ro)(G)-- 0
D [27/Aug/2013:23:59:12 -0400] [Job 11] Execution stack:
D [27/Aug/2013:23:59:12 -0400] [Job 11] %interp_exit .runexec2 --nostringval-- --nostringval-- --nostringval-- 2 %stopped_push --nostringval-- --nostringval-- --nostringval-- false 1 %stopped_push 1904 1 3 %oparray_pop 1903 1 3 %oparray_pop 1887 1 3 %oparray_pop --nostringval-- --nostringval-- --nostringval-- 2 1 1 --nostringval-- %for_pos_int_continue --nostringval-- 1866 4 7 %oparray_pop --nostringval-- --nostringval-- --nostringval-- --dict:1/10(L)-- --nostringval-- 9 %dict_continue --nostringval--
D [27/Aug/2013:23:59:12 -0400] [Job 11] Dictionary stack:
D [27/Aug/2013:23:59:12 -0400] [Job 11] --dict:1178/1684(ro)(G)-- --dict:1/20(G)-- --dict:82/200(L)-- --dict:82/200(L)-- --dict:109/127(ro)(G)-- --dict:292/300(ro)(G)-- --dict:25/32(L)--
D [27/Aug/2013:23:59:12 -0400] [Job 11] Current allocation mode is local
D [27/Aug/2013:23:59:12 -0400] [Job 11] Last OS error: No such file or directory
D [27/Aug/2013:23:59:12 -0400] [Job 11] GPL Ghostscript 9.07: Unrecoverable error, exit code 1
I [27/Aug/2013:23:59:12 -0400] [Job 11] Rendering completed
D [27/Aug/2013:23:59:12 -0400] cupsdMarkDirty(---J-)
D [27/Aug/2013:23:59:12 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Dirty files"
D [27/Aug/2013:23:59:12 -0400] [Job 11] Set job-printer-state-message to "Rendering completed", current level=INFO
D [27/Aug/2013:23:59:12 -0400] Discarding unused job-progress event...
D [27/Aug/2013:23:59:12 -0400] Discarding unused printer-state-changed event...
D [27/Aug/2013:23:59:12 -0400] [Job 11] prnt/hpcups/HPCupsFilter.cpp 548: cupsRasterOpen failed, fd = 0
D [27/Aug/2013:23:59:12 -0400] [Job 11] PID 19176 (/usr/lib/cups/filter/gstoraster) exited with no errors.
D [27/Aug/2013:23:59:12 -0400] [Client 14] GET /printers/ HTTP/1.1
D [27/Aug/2013:23:59:12 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Dirty files"
D [27/Aug/2013:23:59:12 -0400] [Client 14] No authentication data provided.
D [27/Aug/2013:23:59:12 -0400] [CGI] argv[0] = "/usr/lib/cups/cgi-bin/printers.cgi"
D [27/Aug/2013:23:59:12 -0400] [CGI] envp[0] = "CUPS_CACHEDIR=/var/cache/cups"
D [27/Aug/2013:23:59:12 -0400] [CGI] envp[1] = "CUPS_DATADIR=/usr/share/cups"
D [27/Aug/2013:23:59:12 -0400] [CGI] envp[2] = "CUPS_DOCROOT=/usr/share/cups/doc"
D [27/Aug/2013:23:59:12 -0400] [CGI] envp[3] = "CUPS_FONTPATH=/usr/share/cups/fonts"
D [27/Aug/2013:23:59:12 -0400] [CGI] envp[4] = "CUPS_REQUESTROOT=/var/spool/cups"
D [27/Aug/2013:23:59:12 -0400] [CGI] envp[5] = "CUPS_SERVERBIN=/usr/lib/cups"
D [27/Aug/2013:23:59:12 -0400] [CGI] envp[6] = "CUPS_SERVERROOT=/etc/cups"
D [27/Aug/2013:23:59:12 -0400] [CGI] envp[7] = "CUPS_STATEDIR=/run/cups"
D [27/Aug/2013:23:59:12 -0400] [CGI] envp[8] = "HOME=/var/spool/cups/tmp"
D [27/Aug/2013:23:59:12 -0400] [CGI] envp[9] = "PATH=/usr/lib/cups/filter:/usr/bin:/usr/bin:/bin:/usr/bin"
D [27/Aug/2013:23:59:12 -0400] [CGI] envp[10] = "SERVER_ADMIN=root@pogo_e02_a"
D [27/Aug/2013:23:59:12 -0400] [CGI] envp[11] = "SOFTWARE=CUPS/1.6.3"
D [27/Aug/2013:23:59:12 -0400] [CGI] envp[12] = "TMPDIR=/var/spool/cups/tmp"
D [27/Aug/2013:23:59:12 -0400] [CGI] envp[13] = "USER=root"
D [27/Aug/2013:23:59:12 -0400] [CGI] envp[14] = "CUPS_MAX_MESSAGE=2047"
D [27/Aug/2013:23:59:12 -0400] [CGI] envp[15] = "CUPS_SERVER=/var/run/cups/cups.sock"
D [27/Aug/2013:23:59:12 -0400] [CGI] envp[16] = "CUPS_ENCRYPTION=IfRequested"
D [27/Aug/2013:23:59:12 -0400] [CGI] envp[17] = "IPP_PORT=631"
D [27/Aug/2013:23:59:12 -0400] [CGI] envp[18] = "LANG=en_US.UTF8"
D [27/Aug/2013:23:59:12 -0400] [CGI] envp[19] = "REDIRECT_STATUS=1"
D [27/Aug/2013:23:59:12 -0400] [CGI] envp[20] = "GATEWAY_INTERFACE=CGI/1.1"
D [27/Aug/2013:23:59:12 -0400] [CGI] envp[21] = "SERVER_NAME=192.168.1.139"
D [27/Aug/2013:23:59:12 -0400] [CGI] envp[22] = "SERVER_PORT=631"
D [27/Aug/2013:23:59:12 -0400] [CGI] envp[23] = "REMOTE_ADDR=192.168.1.149"
D [27/Aug/2013:23:59:12 -0400] [CGI] envp[24] = "REMOTE_HOST=192.168.1.149"
D [27/Aug/2013:23:59:12 -0400] [CGI] envp[25] = "SCRIPT_NAME=/printers/"
D [27/Aug/2013:23:59:12 -0400] [CGI] envp[26] = "SCRIPT_FILENAME=/usr/share/cups/doc/printers/"
D [27/Aug/2013:23:59:12 -0400] [CGI] envp[27] = "SERVER_PROTOCOL=HTTP/1.1"
D [27/Aug/2013:23:59:12 -0400] [CGI] envp[28] = "HTTP_COOKIE=org.cups.sid=9b772c962318ec7b450f7f00bb5cbd3e"
D [27/Aug/2013:23:59:12 -0400] [CGI] envp[29] = "HTTP_USER_AGENT=Mozilla/5.0 (Windows NT 6.1; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/28.0.1500.95 Safari/537.36"
D [27/Aug/2013:23:59:12 -0400] [CGI] envp[30] = "HTTP_REFERER=http://192.168.1.139:631/jobs/"
D [27/Aug/2013:23:59:12 -0400] [CGI] envp[31] = "REQUEST_METHOD=GET"
D [27/Aug/2013:23:59:12 -0400] [CGI] envp[32] = "QUERY_STRING="
D [27/Aug/2013:23:59:12 -0400] [CGI] Started /usr/lib/cups/cgi-bin/printers.cgi (PID 19181)
I [27/Aug/2013:23:59:12 -0400] [Client 14] Started "/usr/lib/cups/cgi-bin/printers.cgi" (pid=19181)
D [27/Aug/2013:23:59:12 -0400] [Client 14] file=13
D [27/Aug/2013:23:59:12 -0400] [Job 11] PID 19177 (/usr/lib/cups/filter/hpcups) stopped with status 1.
D [27/Aug/2013:23:59:12 -0400] [CGI] org.cups.sid cookie is "9b772c962318ec7b450f7f00bb5cbd3e"
D [27/Aug/2013:23:59:12 -0400] [CGI] cgiSetVariable: SECTION="printers"
D [27/Aug/2013:23:59:12 -0400] [CGI] cgiSetVariable: REFRESH_PAGE=""
D [27/Aug/2013:23:59:13 -0400] [Job 11] prtGeneralCurrentLocalization type is 0, expected 2!
D [27/Aug/2013:23:59:13 -0400] [Job 11] backendWaitLoop(snmp_fd=5, addr=0xb6f8396c, side_cb=0xb6f6175c)
D [27/Aug/2013:23:59:13 -0400] [Job 11] PID 19178 (/usr/lib/cups/backend/socket) exited with no errors.
D [27/Aug/2013:23:59:13 -0400] Discarding unused job-state-changed event...
E [27/Aug/2013:23:59:13 -0400] [Job 11] Job stopped due to filter errors; please consult the error_log file for details.
D [27/Aug/2013:23:59:13 -0400] cupsdMarkDirty(---J-)
D [27/Aug/2013:23:59:13 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients and dirty files"
D [27/Aug/2013:23:59:13 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [27/Aug/2013:23:59:13 -0400] Discarding unused printer-state-changed event...
D [27/Aug/2013:23:59:13 -0400] cupsdMarkDirty(---J-)
D [27/Aug/2013:23:59:13 -0400] cupsdSetBusyState: newbusy="Active clients, printing jobs, and dirty files", busy="Active clients, printing jobs, and dirty files"
D [27/Aug/2013:23:59:13 -0400] [Job 11] The following messages were recorded from 11:59:11 PM to 11:59:11 PM
D [27/Aug/2013:23:59:13 -0400] [Job 11] hrDeviceDesc="Unknown"
D [27/Aug/2013:23:59:13 -0400] [Job 11] End of messages
D [27/Aug/2013:23:59:13 -0400] [Job 11] printer-state=3(idle)
D [27/Aug/2013:23:59:13 -0400] [Job 11] printer-state-message="Filter failed"
D [27/Aug/2013:23:59:13 -0400] [Job 11] printer-state-reasons=none
D [27/Aug/2013:23:59:13 -0400] [Client 15] Accepted from localhost (Domain)
D [27/Aug/2013:23:59:13 -0400] [Client 15] POST / HTTP/1.1
D [27/Aug/2013:23:59:13 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients, printing jobs, and dirty files"
D [27/Aug/2013:23:59:13 -0400] [Client 15] No authentication data provided.
D [27/Aug/2013:23:59:13 -0400] [Client 15] 2.0 CUPS-Get-Default 1
D [27/Aug/2013:23:59:13 -0400] CUPS-Get-Default
D [27/Aug/2013:23:59:13 -0400] CUPS-Get-Default client-error-not-found: No default printer.
D [27/Aug/2013:23:59:13 -0400] Returning IPP client-error-not-found for CUPS-Get-Default (no URI) from localhost
D [27/Aug/2013:23:59:13 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [27/Aug/2013:23:59:13 -0400] [Client 15] POST / HTTP/1.1
D [27/Aug/2013:23:59:13 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [27/Aug/2013:23:59:13 -0400] [Client 15] No authentication data provided.
D [27/Aug/2013:23:59:13 -0400] [CGI] show_all_printers(http=0xb6f7ff90, user="(null)")
D [27/Aug/2013:23:59:13 -0400] [CGI] cgiSetVariable: TITLE="Printers"
D [27/Aug/2013:23:59:13 -0400] [CGI] cgiSetVariable: SERVER_NAME="192.168.1.139"
D [27/Aug/2013:23:59:13 -0400] [CGI] cgiSetVariable: CUPS_VERSION="CUPS v1.6.3"
D [27/Aug/2013:23:59:13 -0400] Script header: Content-Type: text/html;charset=utf-8
D [27/Aug/2013:23:59:13 -0400] Script header:
D [27/Aug/2013:23:59:13 -0400] [Client 15] 2.0 CUPS-Get-Printers 2
D [27/Aug/2013:23:59:13 -0400] CUPS-Get-Printers
D [27/Aug/2013:23:59:13 -0400] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [27/Aug/2013:23:59:13 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [27/Aug/2013:23:59:13 -0400] [CGI] cgiSetVariable: TOTAL="1"
D [27/Aug/2013:23:59:13 -0400] [CGI] cgiSetVariable: SERVER_NAME="192.168.1.139"
D [27/Aug/2013:23:59:13 -0400] [CGI] cgiSetVariable: CUPS_VERSION="CUPS v1.6.3"
D [27/Aug/2013:23:59:13 -0400] [CGI] cgiSetArray: printer_state[0]="3"
D [27/Aug/2013:23:59:13 -0400] [CGI] cgiSetArray: printer_state_message[0]="Filter failed"
D [27/Aug/2013:23:59:13 -0400] [CGI] cgiSetArray: admin_uri[0]="/admin/"
D [27/Aug/2013:23:59:13 -0400] [CGI] cgiSetArray: printer_uri_supported[0]="/printers/HPOfficeJetPro8000Wireless"
D [27/Aug/2013:23:59:13 -0400] [CGI] cgiSetArray: printer_name[0]="HPOfficeJetPro8000Wireless"
D [27/Aug/2013:23:59:13 -0400] [CGI] cgiSetArray: printer_location[0]="Basement"
D [27/Aug/2013:23:59:13 -0400] [CGI] cgiSetArray: printer_info[0]="HPOfficeJetPro8000Wireless"
D [27/Aug/2013:23:59:13 -0400] [CGI] cgiSetArray: printer_make_and_model[0]="HP Officejet Pro 8000 a809, hpcups 3.13.8"
D [27/Aug/2013:23:59:13 -0400] [CGI] cgiSetVariable: THISURL="/printers/"
D [27/Aug/2013:23:59:13 -0400] [Client 15] HTTP_WAITING Closing on EOF
D [27/Aug/2013:23:59:13 -0400] [Client 15] Closing connection.
D [27/Aug/2013:23:59:13 -0400] cupsdSetBusyState: newbusy="Active clients and dirty files", busy="Active clients and dirty files"
D [27/Aug/2013:23:59:13 -0400] PID 19181 (/usr/lib/cups/cgi-bin/printers.cgi) exited with no errors.
D [27/Aug/2013:23:59:13 -0400] cupsdSetBusyState: newbusy="Dirty files", busy="Active clients and dirty files"
I [27/Aug/2013:23:59:39 -0400] Saving job.cache...
D [27/Aug/2013:23:59:39 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Dirty files"
D [27/Aug/2013:23:59:39 -0400] [Job 11] Unloading...
D [27/Aug/2013:23:59:39 -0400] Report: clients=1
D [27/Aug/2013:23:59:39 -0400] Report: jobs=4
D [27/Aug/2013:23:59:39 -0400] Report: jobs-active=1
D [27/Aug/2013:23:59:39 -0400] Report: printers=1
D [27/Aug/2013:23:59:39 -0400] Report: stringpool-string-count=5630
D [27/Aug/2013:23:59:39 -0400] Report: stringpool-alloc-bytes=10672
D [27/Aug/2013:23:59:39 -0400] Report: stringpool-total-bytes=105584
D [27/Aug/2013:23:59:49 -0400] [Client 14] GET /jobs/ HTTP/1.1
D [27/Aug/2013:23:59:49 -0400] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [27/Aug/2013:23:59:49 -0400] [Client 14] Authorized as root using Basic
D [27/Aug/2013:23:59:49 -0400] [CGI] argv[0] = "/usr/lib/cups/cgi-bin/jobs.cgi"
D [27/Aug/2013:23:59:49 -0400] [CGI] envp[0] = "CUPS_CACHEDIR=/var/cache/cups"
D [27/Aug/2013:23:59:49 -0400] [CGI] envp[1] = "CUPS_DATADIR=/usr/share/cups"
D [27/Aug/2013:23:59:49 -0400] [CGI] envp[2] = "CUPS_DOCROOT=/usr/share/cups/doc"
D [27/Aug/2013:23:59:49 -0400] [CGI] envp[3] = "CUPS_FONTPATH=/usr/share/cups/fonts"
D [27/Aug/2013:23:59:49 -0400] [CGI] envp[4] = "CUPS_REQUESTROOT=/var/spool/cups"
D [27/Aug/2013:23:59:49 -0400] [CGI] envp[5] = "CUPS_SERVERBIN=/usr/lib/cups"
D [27/Aug/2013:23:59:49 -0400] [CGI] envp[6] = "CUPS_SERVERROOT=/etc/cups"
D [27/Aug/2013:23:59:49 -0400] [CGI] envp[7] = "CUPS_STATEDIR=/run/cups"
D [27/Aug/2013:23:59:49 -0400] [CGI] envp[8] = "HOME=/var/spool/cups/tmp"
D [27/Aug/2013:23:59:49 -0400] [CGI] envp[9] = "PATH=/usr/lib/cups/filter:/usr/bin:/usr/bin:/bin:/usr/bin"
D [27/Aug/2013:23:59:49 -0400] [CGI] envp[10] = "SERVER_ADMIN=root@pogo_e02_a"
D [27/Aug/2013:23:59:49 -0400] [CGI] envp[11] = "SOFTWARE=CUPS/1.6.3"
D [27/Aug/2013:23:59:49 -0400] [CGI] envp[12] = "TMPDIR=/var/spool/cups/tmp"
D [27/Aug/2013:23:59:49 -0400] [CGI] envp[13] = "USER=root"
D [27/Aug/2013:23:59:49 -0400] [CGI] envp[14] = "CUPS_MAX_MESSAGE=2047"
D [27/Aug/2013:23:59:49 -0400] [CGI] envp[15] = "CUPS_SERVER=/var/run/cups/cups.sock"
D [27/Aug/2013:23:59:49 -0400] [CGI] envp[16] = "CUPS_ENCRYPTION=IfRequested"
D [27/Aug/2013:23:59:49 -0400] [CGI] envp[17] = "IPP_PORT=631"
D [27/Aug/2013:23:59:49 -0400] [CGI] envp[18] = "AUTH_TYPE=Basic"
D [27/Aug/2013:23:59:49 -0400] [CGI] envp[19] = "LANG=en_US.UTF8"
D [27/Aug/2013:23:59:49 -0400] [CGI] envp[20] = "REDIRECT_STATUS=1"
D [27/Aug/2013:23:59:49 -0400] [CGI] envp[21] = "GATEWAY_INTERFACE=CGI/1.1"
D [27/Aug/2013:23:59:49 -0400] [CGI] envp[22] = "SERVER_NAME=192.168.1.139"
D [27/Aug/2013:23:59:49 -0400] [CGI] envp[23] = "SERVER_PORT=631"
D [27/Aug/2013:23:59:49 -0400] [CGI] envp[24] = "REMOTE_ADDR=192.168.1.149"
D [27/Aug/2013:23:59:49 -0400] [CGI] envp[25] = "REMOTE_HOST=192.168.1.149"
D [27/Aug/2013:23:59:49 -0400] [CGI] envp[26] = "SCRIPT_NAME=/jobs/"
D [27/Aug/2013:23:59:49 -0400] [CGI] envp[27] = "SCRIPT_FILENAME=/usr/share/cups/doc/jobs/"
D [27/Aug/2013:23:59:49 -0400] [CGI] envp[28] = "REMOTE_USER=root"
D [27/Aug/2013:23:59:49 -0400] [CGI] envp[29] = "SERVER_PROTOCOL=HTTP/1.1"
D [27/Aug/2013:23:59:49 -0400] [CGI] envp[30] = "HTTP_COOKIE=org.cups.sid=9b772c962318ec7b450f7f00bb5cbd3e"
D [27/Aug/2013:23:59:49 -0400] [CGI] envp[31] = "HTTP_USER_AGENT=Mozilla/5.0 (Windows NT 6.1; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/28.0.1500.95 Safari/537.36"
D [27/Aug/2013:23:59:49 -0400] [CGI] envp[32] = "HTTP_REFERER=http://192.168.1.139:631/printers/"
D [27/Aug/2013:23:59:49 -0400] [CGI] envp[33] = "REQUEST_METHOD=GET"
D [27/Aug/2013:23:59:49 -0400] [CGI] envp[34] = "QUERY_STRING="
D [27/Aug/2013:23:59:49 -0400] [CGI] Started /usr/lib/cups/cgi-bin/jobs.cgi (PID 19183)
I [27/Aug/2013:23:59:49 -0400] [Client 14] Started "/usr/lib/cups/cgi-bin/jobs.cgi" (pid=19183)
D [27/Aug/2013:23:59:49 -0400] [Client 14] file=13
D [27/Aug/2013:23:59:49 -0400] [CGI] org.cups.sid cookie is "9b772c962318ec7b450f7f00bb5cbd3e"
D [27/Aug/2013:23:59:49 -0400] [CGI] cgiSetVariable: SECTION="jobs"
D [27/Aug/2013:23:59:49 -0400] [CGI] cgiSetVariable: REFRESH_PAGE=""
D [27/Aug/2013:23:59:49 -0400] [Client 15] Accepted from localhost (Domain)
D [27/Aug/2013:23:59:49 -0400] [CGI] cgiSetVariable: TITLE="Jobs"
D [27/Aug/2013:23:59:49 -0400] [CGI] cgiSetVariable: SERVER_NAME="192.168.1.139"
D [27/Aug/2013:23:59:49 -0400] [CGI] cgiSetVariable: REMOTE_USER="root"
D [27/Aug/2013:23:59:49 -0400] [CGI] cgiSetVariable: CUPS_VERSION="CUPS v1.6.3"
D [27/Aug/2013:23:59:49 -0400] Script header: Content-Type: text/html;charset=utf-8
D [27/Aug/2013:23:59:49 -0400] Script header:
D [27/Aug/2013:23:59:49 -0400] [Client 15] POST / HTTP/1.1
D [27/Aug/2013:23:59:49 -0400] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [27/Aug/2013:23:59:49 -0400] [Client 15] No authentication data provided.
D [27/Aug/2013:23:59:49 -0400] [Client 15] 2.0 Get-Jobs 1
D [27/Aug/2013:23:59:49 -0400] Get-Jobs ipp://localhost/
D [27/Aug/2013:23:59:49 -0400] [Job 11] Loading attributes...
D [27/Aug/2013:23:59:49 -0400] Returning IPP successful-ok for Get-Jobs (ipp://localhost/) from localhost
D [27/Aug/2013:23:59:49 -0400] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [27/Aug/2013:23:59:49 -0400] [CGI] cgiClearVariables called.
D [27/Aug/2013:23:59:49 -0400] [CGI] cgiSetVariable: ORDER="asc"
D [27/Aug/2013:23:59:49 -0400] [CGI] cgiSetVariable: SECTION="jobs"
D [27/Aug/2013:23:59:49 -0400] [CGI] cgiSetVariable: TOTAL="1"
D [27/Aug/2013:23:59:49 -0400] [CGI] cgiSetVariable: SERVER_NAME="192.168.1.139"
D [27/Aug/2013:23:59:49 -0400] [CGI] cgiSetVariable: REMOTE_USER="root"
D [27/Aug/2013:23:59:49 -0400] [CGI] cgiSetVariable: CUPS_VERSION="CUPS v1.6.3"
D [27/Aug/2013:23:59:49 -0400] [CGI] cgiSetArray: job_preserved[0]="1"
D [27/Aug/2013:23:59:49 -0400] [CGI] cgiSetArray: job_printer_name[0]="HPOfficeJetPro8000Wireless"
D [27/Aug/2013:23:59:49 -0400] [CGI] cgiSetArray: job_printer_uri[0]="/printers/HPOfficeJetPro8000Wireless"
D [27/Aug/2013:23:59:49 -0400] [CGI] cgiSetArray: time_at_creation[0]="Sat 24 Aug 2013 11:27:27 PM EDT"
D [27/Aug/2013:23:59:49 -0400] [CGI] cgiSetArray: time_at_processing[0]="Tue 27 Aug 2013 11:59:08 PM EDT"
D [27/Aug/2013:23:59:49 -0400] [CGI] cgiSetArray: time_at_completed[0]="novalue"
D [27/Aug/2013:23:59:49 -0400] [CGI] cgiSetArray: job_id[0]="11"
D [27/Aug/2013:23:59:49 -0400] [CGI] cgiSetArray: job_state[0]="6"
D [27/Aug/2013:23:59:49 -0400] [CGI] cgiSetArray: job_media_sheets_completed[0]="0"
D [27/Aug/2013:23:59:49 -0400] [CGI] cgiSetArray: job_k_octets[0]="1"
D [27/Aug/2013:23:59:49 -0400] [CGI] cgiSetArray: job_printer_state_message[0]="Filter failed"
D [27/Aug/2013:23:59:49 -0400] [CGI] cgiSetVariable: THISURL="/jobs/"
D [27/Aug/2013:23:59:49 -0400] [Client 15] HTTP_WAITING Closing on EOF
D [27/Aug/2013:23:59:49 -0400] [Client 15] Closing connection.
D [27/Aug/2013:23:59:49 -0400] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [27/Aug/2013:23:59:49 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [27/Aug/2013:23:59:49 -0400] PID 19183 (/usr/lib/cups/cgi-bin/jobs.cgi) exited with no errors.
D [28/Aug/2013:00:04:14 -0400] [Job 11] Unloading...
E [28/Aug/2013:00:04:14 -0400] [Job 11] Stopping unresponsive job.
D [28/Aug/2013:00:04:14 -0400] Report: clients=1
D [28/Aug/2013:00:04:14 -0400] Report: jobs=4
D [28/Aug/2013:00:04:14 -0400] Report: jobs-active=1
D [28/Aug/2013:00:04:14 -0400] Report: printers=1
D [28/Aug/2013:00:04:14 -0400] Report: stringpool-string-count=5630
D [28/Aug/2013:00:04:14 -0400] Report: stringpool-alloc-bytes=10672
D [28/Aug/2013:00:04:14 -0400] Report: stringpool-total-bytes=105584
D [28/Aug/2013:00:04:50 -0400] [Client 14] HTTP_WAITING Closing on EOF
D [28/Aug/2013:00:04:50 -0400] [Client 14] Closing connection.
D [28/Aug/2013:00:04:50 -0400] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"')
From the CUPS web interface I already set it up
Description: HPOfficeJetPro8000Wireless
Location: Basement
Driver: HP Officejet Pro 8000 a809, hpcups 3.13.8 (color, 2-sided printing)
Connection: socket://192.168.1.1:9100
Defaults: job-sheets=none, none media=na_letter_8.5x11in sides=one-sided