how cups detect printer language?

[anonymous]

1. I changed my Color Laser HP5500's personality setting from Auto (PS/PCL)
to PCL.
2. I used HP's PPD file (XP version) and set up the printer on my
CUPS/Redhat 9.
3. Test page printed successfully with pstops filter.
4. Submitted 1pg.ps job, didn't work, print out error messages. (used pstops
filter)

Question:
1. After providing a PPD file, how can CUPS know whether it's a Postscript
printer or PCL?
2. Can CUPS print text/PCL file to a PCL printer?

Errorlog attached with CUPS debug on


I [21/Oct/2004:11:03:20 -0700] LoadPPDs: Read "/etc/cups/ppds.dat", 15 
PPDs...
D [21/Oct/2004:11:03:20 -0700] LoadPPDs: Adding ppd "HP5500_6.ppd"...
I [21/Oct/2004:11:03:20 -0700] LoadPPDs: Wrote "/etc/cups/ppds.dat", 16 
PPDs...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"parallel:/dev/lp0"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device "http"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device "ipp"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device "lpd"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device "scsi"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"serial:/dev/ttyS0?baud=115200"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"serial:/dev/ttyS1?baud=115200"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"serial:/dev/ttyS2?baud=115200"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"serial:/dev/ttyS3?baud=115200"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"serial:/dev/ttyS4?baud=115200"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"serial:/dev/ttyS5?baud=115200"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"serial:/dev/ttyS6?baud=115200"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"serial:/dev/ttyS7?baud=115200"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"serial:/dev/ttyS8?baud=115200"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"serial:/dev/ttyS9?baud=115200"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"serial:/dev/ttyS10?baud=115200"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"serial:/dev/ttyS11?baud=115200"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"serial:/dev/ttyS12?baud=115200"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"serial:/dev/ttyS13?baud=115200"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"serial:/dev/ttyS14?baud=115200"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"serial:/dev/ttyS15?baud=115200"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"serial:/dev/ttyS16?baud=115200"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"serial:/dev/ttyS17?baud=115200"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"serial:/dev/ttyS18?baud=115200"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"serial:/dev/ttyS19?baud=115200"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"serial:/dev/ttyS20?baud=115200"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"serial:/dev/ttyS21?baud=115200"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"serial:/dev/ttyS22?baud=115200"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"serial:/dev/ttyS23?baud=115200"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"serial:/dev/ttyS24?baud=115200"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"serial:/dev/ttyS25?baud=115200"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"serial:/dev/ttyS26?baud=115200"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"serial:/dev/ttyS27?baud=115200"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"serial:/dev/ttyS28?baud=115200"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"serial:/dev/ttyS29?baud=115200"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"serial:/dev/ttyS30?baud=115200"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"serial:/dev/ttyS31?baud=115200"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device "socket"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"usb:/dev/usb/lp0"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"usb:/dev/usb/lp1"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"usb:/dev/usb/lp2"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"usb:/dev/usb/lp3"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"usb:/dev/usb/lp4"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"usb:/dev/usb/lp5"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"usb:/dev/usb/lp6"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"usb:/dev/usb/lp7"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"usb:/dev/usb/lp8"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"usb:/dev/usb/lp9"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"usb:/dev/usb/lp10"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"usb:/dev/usb/lp11"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"usb:/dev/usb/lp12"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"usb:/dev/usb/lp13"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"usb:/dev/usb/lp14"...
D [21/Oct/2004:11:03:21 -0700] LoadDevices: Added device 
"usb:/dev/usb/lp15"...
D [21/Oct/2004:11:03:21 -0700] StartListening: NumListeners=1
D [21/Oct/2004:11:03:21 -0700] StartListening: address=7f000001 port=631
D [21/Oct/2004:11:03:21 -0700] ResumeListening: setting input bits...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Scanning /var/spool/cups...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 1...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 2...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 3...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 4...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 5...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 12...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 13...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 14...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 9...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 16...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 15...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 17...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 18...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 19...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 20...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 21...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 22...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 24...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 23...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 26...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 25...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 28...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 27...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 31...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 29...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 32...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 30...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 33...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 34...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 35...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 36...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 37...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 38...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 39...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 40...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 41...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 42...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 43...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 44...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 45...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 46...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 47...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 48...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 49...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 50...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 51...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 52...
D [21/Oct/2004:11:03:21 -0700] LoadAllJobs: Loading attributes for job 53...
D [21/Oct/2004:11:03:23 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:03:23 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:03:23 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:03:23 -0700] CloseClient() 3
D [21/Oct/2004:11:03:28 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:03:28 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:03:28 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:03:28 -0700] CloseClient() 3
D [21/Oct/2004:11:03:33 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:03:33 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:03:33 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:03:33 -0700] CloseClient() 3
D [21/Oct/2004:11:03:38 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:03:38 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:03:38 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:03:38 -0700] CloseClient() 3
D [21/Oct/2004:11:03:39 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:03:39 -0700] ReadClient() 3 POST /admin HTTP/1.1
D [21/Oct/2004:11:03:39 -0700] CGI /usr/lib/cups/cgi-bin/admin.cgi started - 
PID = 3239
I [21/Oct/2004:11:03:39 -0700] Started "/usr/lib/cups/cgi-bin/admin.cgi" 
(pid=3239)
D [21/Oct/2004:11:03:39 -0700] SendCommand() 3 file=6
D [21/Oct/2004:11:03:39 -0700] AcceptClient() 5 from localhost:631.
D [21/Oct/2004:11:03:39 -0700] AcceptClient() 7 from localhost:631.
D [21/Oct/2004:11:03:39 -0700] ReadClient() 7 GET /cups.css HTTP/1.1
D [21/Oct/2004:11:03:39 -0700] SendError() 7 code=304
D [21/Oct/2004:11:03:42 -0700] CloseClient() 5
D [21/Oct/2004:11:03:43 -0700] AcceptClient() 5 from localhost:631.
D [21/Oct/2004:11:03:43 -0700] ReadClient() 5 POST / HTTP/1.1
D [21/Oct/2004:11:03:43 -0700] ProcessIPPRequest: 5 status_code=1
D [21/Oct/2004:11:03:43 -0700] CloseClient() 5
D [21/Oct/2004:11:03:47 -0700] ReadClient() 7 GET /cups.css HTTP/1.1
D [21/Oct/2004:11:03:47 -0700] SendError() 7 code=304
D [21/Oct/2004:11:03:48 -0700] AcceptClient() 5 from localhost:631.
D [21/Oct/2004:11:03:48 -0700] ReadClient() 5 POST / HTTP/1.1
D [21/Oct/2004:11:03:48 -0700] ProcessIPPRequest: 5 status_code=1
D [21/Oct/2004:11:03:48 -0700] CloseClient() 5
D [21/Oct/2004:11:03:52 -0700] ReadClient() 3 POST /admin HTTP/1.1
D [21/Oct/2004:11:03:52 -0700] CGI /usr/lib/cups/cgi-bin/admin.cgi started - 
PID = 3240
I [21/Oct/2004:11:03:52 -0700] Started "/usr/lib/cups/cgi-bin/admin.cgi" 
(pid=3240)
D [21/Oct/2004:11:03:52 -0700] SendCommand() 3 file=6
D [21/Oct/2004:11:03:52 -0700] AcceptClient() 5 from localhost:631.
D [21/Oct/2004:11:03:52 -0700] CloseClient() 5
D [21/Oct/2004:11:03:52 -0700] ReadClient() 7 GET /cups.css HTTP/1.1
D [21/Oct/2004:11:03:52 -0700] SendError() 7 code=304
D [21/Oct/2004:11:03:53 -0700] AcceptClient() 5 from localhost:631.
D [21/Oct/2004:11:03:53 -0700] ReadClient() 5 POST / HTTP/1.1
D [21/Oct/2004:11:03:53 -0700] ProcessIPPRequest: 5 status_code=1
D [21/Oct/2004:11:03:53 -0700] CloseClient() 5
D [21/Oct/2004:11:03:58 -0700] AcceptClient() 5 from localhost:631.
D [21/Oct/2004:11:03:58 -0700] ReadClient() 5 POST / HTTP/1.1
D [21/Oct/2004:11:03:58 -0700] ProcessIPPRequest: 5 status_code=1
D [21/Oct/2004:11:03:58 -0700] CloseClient() 5
D [21/Oct/2004:11:04:03 -0700] AcceptClient() 5 from localhost:631.
D [21/Oct/2004:11:04:03 -0700] ReadClient() 5 POST / HTTP/1.1
D [21/Oct/2004:11:04:03 -0700] ProcessIPPRequest: 5 status_code=1
D [21/Oct/2004:11:04:03 -0700] CloseClient() 5
D [21/Oct/2004:11:04:05 -0700] ReadClient() 3 POST /admin HTTP/1.1
D [21/Oct/2004:11:04:05 -0700] CGI /usr/lib/cups/cgi-bin/admin.cgi started - 
PID = 3241
I [21/Oct/2004:11:04:05 -0700] Started "/usr/lib/cups/cgi-bin/admin.cgi" 
(pid=3241)
D [21/Oct/2004:11:04:05 -0700] SendCommand() 3 file=6
D [21/Oct/2004:11:04:05 -0700] AcceptClient() 5 from localhost:631.
D [21/Oct/2004:11:04:05 -0700] ReadClient() 5 POST / HTTP/1.1
D [21/Oct/2004:11:04:05 -0700] ProcessIPPRequest: 5 status_code=0
D [21/Oct/2004:11:04:05 -0700] ReadClient() 7 GET /cups.css HTTP/1.1
D [21/Oct/2004:11:04:05 -0700] SendError() 7 code=304
D [21/Oct/2004:11:04:05 -0700] CloseClient() 5
D [21/Oct/2004:11:04:09 -0700] AcceptClient() 5 from localhost:631.
D [21/Oct/2004:11:04:09 -0700] ReadClient() 5 POST / HTTP/1.1
D [21/Oct/2004:11:04:09 -0700] ProcessIPPRequest: 5 status_code=1
D [21/Oct/2004:11:04:09 -0700] CloseClient() 5
D [21/Oct/2004:11:04:09 -0700] ReadClient() 7 POST /admin HTTP/1.1
D [21/Oct/2004:11:04:09 -0700] CGI /usr/lib/cups/cgi-bin/admin.cgi started - 
PID = 3242
I [21/Oct/2004:11:04:09 -0700] Started "/usr/lib/cups/cgi-bin/admin.cgi" 
(pid=3242)
D [21/Oct/2004:11:04:09 -0700] SendCommand() 7 file=6
D [21/Oct/2004:11:04:09 -0700] AcceptClient() 5 from localhost:631.
D [21/Oct/2004:11:04:09 -0700] ReadClient() 5 POST / HTTP/1.1
D [21/Oct/2004:11:04:09 -0700] ProcessIPPRequest: 5 status_code=0
D [21/Oct/2004:11:04:09 -0700] ReadClient() 3 GET /cups.css HTTP/1.1
D [21/Oct/2004:11:04:09 -0700] SendError() 3 code=304
D [21/Oct/2004:11:04:12 -0700] CloseClient() 5
D [21/Oct/2004:11:04:14 -0700] AcceptClient() 5 from localhost:631.
D [21/Oct/2004:11:04:14 -0700] ReadClient() 5 POST / HTTP/1.1
D [21/Oct/2004:11:04:14 -0700] ProcessIPPRequest: 5 status_code=1
D [21/Oct/2004:11:04:14 -0700] CloseClient() 5
D [21/Oct/2004:11:04:17 -0700] ReadClient() 3 POST /admin HTTP/1.1
D [21/Oct/2004:11:04:17 -0700] CGI /usr/lib/cups/cgi-bin/admin.cgi started - 
PID = 3243
I [21/Oct/2004:11:04:17 -0700] Started "/usr/lib/cups/cgi-bin/admin.cgi" 
(pid=3243)
D [21/Oct/2004:11:04:17 -0700] SendCommand() 3 file=6
D [21/Oct/2004:11:04:17 -0700] AcceptClient() 5 from localhost:631.
D [21/Oct/2004:11:04:17 -0700] ReadClient() 5 POST /admin/ HTTP/1.1
D [21/Oct/2004:11:04:17 -0700] SendError() 5 code=401
D [21/Oct/2004:11:04:17 -0700] ReadClient() 7 GET /cups.css HTTP/1.1
D [21/Oct/2004:11:04:17 -0700] SendError() 7 code=304
D [21/Oct/2004:11:04:19 -0700] AcceptClient() 8 from localhost:631.
D [21/Oct/2004:11:04:19 -0700] ReadClient() 8 POST / HTTP/1.1
D [21/Oct/2004:11:04:19 -0700] ProcessIPPRequest: 8 status_code=1
D [21/Oct/2004:11:04:19 -0700] CloseClient() 8
D [21/Oct/2004:11:04:20 -0700] AcceptClient() 8 from localhost:631.
D [21/Oct/2004:11:04:20 -0700] ReadClient() 8 POST /admin/ HTTP/1.1
I [21/Oct/2004:11:04:20 -0700] Setting HP5500PS device-uri to 
"socket://172.30.4.184" (was "".)
I [21/Oct/2004:11:04:20 -0700] Setting HP5500PS printer-is-accepting-jobs to 
1 (was 0.)
I [21/Oct/2004:11:04:20 -0700] Setting HP5500PS printer-state to 3 (was 5.)
D [21/Oct/2004:11:04:20 -0700] add_printer: srcfile = 
"/usr/share/cups/model/HP5500_6.ppd"
D [21/Oct/2004:11:04:20 -0700] add_printer: Copied PPD file successfully!
I [21/Oct/2004:11:04:20 -0700] Saving printers.conf...
I [21/Oct/2004:11:04:20 -0700] New printer 'HP5500PS' added by 'root'.
D [21/Oct/2004:11:04:20 -0700] ProcessIPPRequest: 8 status_code=0
D [21/Oct/2004:11:04:21 -0700] CloseClient() 8
D [21/Oct/2004:11:04:23 -0700] ReadClient() 7 GET /printers HTTP/1.1
D [21/Oct/2004:11:04:23 -0700] CGI /usr/lib/cups/cgi-bin/printers.cgi 
started - PID = 3244
I [21/Oct/2004:11:04:23 -0700] Started "/usr/lib/cups/cgi-bin/printers.cgi" 
(pid=3244)
D [21/Oct/2004:11:04:23 -0700] SendCommand() 7 file=8
D [21/Oct/2004:11:04:23 -0700] AcceptClient() 6 from localhost:631.
D [21/Oct/2004:11:04:23 -0700] ReadClient() 3 GET /cups.css HTTP/1.1
D [21/Oct/2004:11:04:23 -0700] SendError() 3 code=304
D [21/Oct/2004:11:04:23 -0700] ReadClient() 6 POST / HTTP/1.1
D [21/Oct/2004:11:04:23 -0700] ProcessIPPRequest: 6 status_code=0
D [21/Oct/2004:11:04:24 -0700] AcceptClient() 9 from localhost:631.
D [21/Oct/2004:11:04:24 -0700] ReadClient() 9 POST / HTTP/1.1
D [21/Oct/2004:11:04:24 -0700] ProcessIPPRequest: 9 status_code=1
D [21/Oct/2004:11:04:24 -0700] CloseClient() 9
D [21/Oct/2004:11:04:25 -0700] ReadClient() 6 POST / HTTP/1.1
D [21/Oct/2004:11:04:25 -0700] ProcessIPPRequest: 6 status_code=0
D [21/Oct/2004:11:04:25 -0700] CloseClient() 6
D [21/Oct/2004:11:04:29 -0700] AcceptClient() 6 from localhost:631.
D [21/Oct/2004:11:04:29 -0700] ReadClient() 6 POST / HTTP/1.1
D [21/Oct/2004:11:04:29 -0700] ProcessIPPRequest: 6 status_code=1
D [21/Oct/2004:11:04:29 -0700] CloseClient() 6
D [21/Oct/2004:11:04:29 -0700] ReadClient() 3 GET 
/admin/?op=config-printer&printer_name=HP5500PS HTTP/1.1
D [21/Oct/2004:11:04:29 -0700] CGI /usr/lib/cups/cgi-bin/admin.cgi started - 
PID = 3245
I [21/Oct/2004:11:04:29 -0700] Started "/usr/lib/cups/cgi-bin/admin.cgi" 
(pid=3245)
D [21/Oct/2004:11:04:29 -0700] SendCommand() 3 file=8
D [21/Oct/2004:11:04:29 -0700] AcceptClient() 6 from localhost:631.
D [21/Oct/2004:11:04:29 -0700] AcceptClient() 9 from localhost:631.
D [21/Oct/2004:11:04:29 -0700] ReadClient() 7 GET /cups.css HTTP/1.1
D [21/Oct/2004:11:04:29 -0700] SendError() 7 code=304
D [21/Oct/2004:11:04:29 -0700] ReadClient() 9 POST / HTTP/1.1
D [21/Oct/2004:11:04:29 -0700] ProcessIPPRequest: 9 status_code=0
D [21/Oct/2004:11:04:32 -0700] ReadClient() 9 GET /printers/HP5500PS.ppd 
HTTP/1.1
D [21/Oct/2004:11:04:32 -0700] SendFile() 9 file=10
D [21/Oct/2004:11:04:34 -0700] AcceptClient() 10 from localhost:631.
D [21/Oct/2004:11:04:34 -0700] ReadClient() 10 POST / HTTP/1.1
D [21/Oct/2004:11:04:34 -0700] ProcessIPPRequest: 10 status_code=1
D [21/Oct/2004:11:04:34 -0700] CloseClient() 10
D [21/Oct/2004:11:04:34 -0700] ReadClient() 6 POST / HTTP/1.1
D [21/Oct/2004:11:04:34 -0700] ProcessIPPRequest: 6 status_code=0
D [21/Oct/2004:11:04:34 -0700] CloseClient() 6
D [21/Oct/2004:11:04:34 -0700] CloseClient() 9
D [21/Oct/2004:11:04:39 -0700] AcceptClient() 6 from localhost:631.
D [21/Oct/2004:11:04:39 -0700] ReadClient() 6 POST / HTTP/1.1
D [21/Oct/2004:11:04:39 -0700] ProcessIPPRequest: 6 status_code=1
D [21/Oct/2004:11:04:39 -0700] CloseClient() 6
D [21/Oct/2004:11:04:44 -0700] AcceptClient() 6 from localhost:631.
D [21/Oct/2004:11:04:44 -0700] ReadClient() 6 POST / HTTP/1.1
D [21/Oct/2004:11:04:44 -0700] ProcessIPPRequest: 6 status_code=1
D [21/Oct/2004:11:04:44 -0700] CloseClient() 6
D [21/Oct/2004:11:04:46 -0700] ReadClient() 7 GET /printers HTTP/1.1
D [21/Oct/2004:11:04:46 -0700] CGI /usr/lib/cups/cgi-bin/printers.cgi 
started - PID = 3246
I [21/Oct/2004:11:04:46 -0700] Started "/usr/lib/cups/cgi-bin/printers.cgi" 
(pid=3246)
D [21/Oct/2004:11:04:46 -0700] SendCommand() 7 file=8
D [21/Oct/2004:11:04:46 -0700] AcceptClient() 6 from localhost:631.
D [21/Oct/2004:11:04:46 -0700] ReadClient() 6 POST / HTTP/1.1
D [21/Oct/2004:11:04:46 -0700] ProcessIPPRequest: 6 status_code=0
D [21/Oct/2004:11:04:46 -0700] ReadClient() 3 GET /cups.css HTTP/1.1
D [21/Oct/2004:11:04:46 -0700] SendError() 3 code=304
D [21/Oct/2004:11:04:46 -0700] ReadClient() 6 POST / HTTP/1.1
D [21/Oct/2004:11:04:46 -0700] ProcessIPPRequest: 6 status_code=0
D [21/Oct/2004:11:04:49 -0700] AcceptClient() 9 from localhost:631.
D [21/Oct/2004:11:04:49 -0700] ReadClient() 9 POST / HTTP/1.1
D [21/Oct/2004:11:04:49 -0700] ProcessIPPRequest: 9 status_code=1
D [21/Oct/2004:11:04:49 -0700] CloseClient() 9
D [21/Oct/2004:11:04:50 -0700] CloseClient() 6
D [21/Oct/2004:11:04:52 -0700] AcceptClient() 6 from localhost:631.
D [21/Oct/2004:11:04:52 -0700] ReadClient() 6 GET 
/printers/HP5500PS?op=print-test-page HTTP/1.1
D [21/Oct/2004:11:04:52 -0700] CGI /usr/lib/cups/cgi-bin/printers.cgi 
started - PID = 3247
I [21/Oct/2004:11:04:52 -0700] Started "/usr/lib/cups/cgi-bin/printers.cgi" 
(pid=3247)
D [21/Oct/2004:11:04:52 -0700] SendCommand() 6 file=9
D [21/Oct/2004:11:04:52 -0700] AcceptClient() 8 from localhost:631.
D [21/Oct/2004:11:04:53 -0700] AcceptClient() 10 from localhost:631.
D [21/Oct/2004:11:04:53 -0700] ReadClient() 10 GET /cups.css HTTP/1.1
D [21/Oct/2004:11:04:53 -0700] SendFile() 10 file=11
D [21/Oct/2004:11:04:53 -0700] ReadClient() 10 GET /images/navbar.gif 
HTTP/1.1
D [21/Oct/2004:11:04:53 -0700] SendFile() 10 file=11
D [21/Oct/2004:11:04:54 -0700] AcceptClient() 11 from localhost:631.
D [21/Oct/2004:11:04:54 -0700] ReadClient() 11 POST / HTTP/1.1
D [21/Oct/2004:11:04:54 -0700] ProcessIPPRequest: 11 status_code=1
D [21/Oct/2004:11:04:54 -0700] CloseClient() 11
D [21/Oct/2004:11:04:55 -0700] ReadClient() 8 POST /printers/HP5500PS 
HTTP/1.1
D [21/Oct/2004:11:04:55 -0700] print_job: request file type is 
application/postscript.
D [21/Oct/2004:11:04:55 -0700] check_quotas: requesting-user-name = ''
D [21/Oct/2004:11:04:55 -0700] print_job: requesting-user-name = ''
D [21/Oct/2004:11:04:55 -0700] Adding default job-sheets values 
"none,none"...
I [21/Oct/2004:11:04:55 -0700] Job 54 queued on 'HP5500PS' by ''.
D [21/Oct/2004:11:04:55 -0700] Job 54 hold_until = 0
D [21/Oct/2004:11:04:55 -0700] StartJob(54, 0x80e5b20)
D [21/Oct/2004:11:04:55 -0700] StartJob() id = 54, file = 0/1
D [21/Oct/2004:11:04:55 -0700] job-sheets=none,none
D [21/Oct/2004:11:04:55 -0700] banner_page = 0
D [21/Oct/2004:11:04:55 -0700] StartJob: argv = "HP5500PS","54","","Test 
Page","1","","/var/spool/cups/d00054-001"
D [21/Oct/2004:11:04:55 -0700] StartJob: envp = 
"PATH=/usr/lib/cups/filter:/bin:/usr/bin","SOFTWARE=CUPS/1.1","USER=root","CHARSET=iso-8859-1","LANG=en","","PPD=/etc/cups/ppd/HP5500PS.ppd","CUPS_SERVERROOT=/etc/cups","RIP_MAX_CACHE=8m","TMPDIR=/var/spool/cups/tmp","CONTENT_TYPE=application/postscript","DEVICE_URI=socket://172.30.4.184","PRINTER=HP5500PS","CUPS_DATADIR=/usr/share/cups","CUPS_FONTPATH=/usr/share/cups/fonts","","",""
D [21/Oct/2004:11:04:55 -0700] StartJob: statusfds = 11, 12
D [21/Oct/2004:11:04:55 -0700] StartJob: filterfds[1] = 13, -1
D [21/Oct/2004:11:04:55 -0700] StartJob: filter = 
"/usr/lib/cups/filter/pstops"
D [21/Oct/2004:11:04:55 -0700] StartJob: filterfds[0] = 14, 15
D [21/Oct/2004:11:04:55 -0700] start_process("/usr/lib/cups/filter/pstops", 
0xbfff0990, 0xbffefe40, 13, 15, 12)
I [21/Oct/2004:11:04:55 -0700] Started filter /usr/lib/cups/filter/pstops 
(PID 3248) for job 54.
D [21/Oct/2004:11:04:55 -0700] StartJob: backend = 
"/usr/lib/cups/backend/socket"
D [21/Oct/2004:11:04:55 -0700] StartJob: filterfds[1] = -1, 13
D [21/Oct/2004:11:04:55 -0700] start_process("/usr/lib/cups/backend/socket", 
0xbfff0990, 0xbffefe40, 14, 13, 12)
I [21/Oct/2004:11:04:55 -0700] Started backend /usr/lib/cups/backend/socket 
(PID 3249) for job 54.
D [21/Oct/2004:11:04:55 -0700] ProcessIPPRequest: 8 status_code=0
D [21/Oct/2004:11:04:55 -0700] [Job 54] Page = 612x792; 12,12 to 600,780
D [21/Oct/2004:11:04:55 -0700] [Job 54] 0 %%BoundingBox: 0 0 612 792
D [21/Oct/2004:11:04:55 -0700] [Job 54] 0 %%Pages: 1
D [21/Oct/2004:11:04:55 -0700] [Job 54] 0 %%LanguageLevel: 1
D [21/Oct/2004:11:04:55 -0700] [Job 54] 0 %%DocumentData: Clean7Bit
D [21/Oct/2004:11:04:55 -0700] [Job 54] 0 %%DocumentSuppliedResources: 
procset testprint/1.0
D [21/Oct/2004:11:04:55 -0700] [Job 54] 0 %%DocumentNeededResources: font 
Helvetica Helvetica-Bold Times-Roman
D [21/Oct/2004:11:04:55 -0700] [Job 54] 0 %%Creator: Michael Sweet, Easy 
Software Products
D [21/Oct/2004:11:04:55 -0700] [Job 54] 0 %%CreationDate: May 11, 1999
D [21/Oct/2004:11:04:55 -0700] [Job 54] 0 %%Title: Test Page
D [21/Oct/2004:11:04:55 -0700] [Job 54] 0 %%EndComments
D [21/Oct/2004:11:04:55 -0700] [Job 54] 0 %%BeginProlog
D [21/Oct/2004:11:04:55 -0700] [Job 54] 0 %%BeginResource procset testprint 
1.1 0
D [21/Oct/2004:11:04:55 -0700] [Job 54] 0 %%EndResource
D [21/Oct/2004:11:04:55 -0700] [Job 54] 0 %%EndProlog
D [21/Oct/2004:11:04:55 -0700] [Job 54] 0 %%Page: 1 1
D [21/Oct/2004:11:04:55 -0700] CloseClient() 8
D [21/Oct/2004:11:04:55 -0700] [Job 54] 0 %%Page: 1 1
D [21/Oct/2004:11:04:55 -0700] [Job 54] pw = 587.9, pl = 767.8
D [21/Oct/2004:11:04:55 -0700] [Job 54] PageLeft = 12.0, PageRight = 599.9
D [21/Oct/2004:11:04:55 -0700] [Job 54] PageTop = 779.9, PageBottom = 12.1
D [21/Oct/2004:11:04:55 -0700] [Job 54] PageWidth = 612.0, PageLength = 
792.0
D [21/Oct/2004:11:04:55 -0700] [Job 54] 0 %%EOF
D [21/Oct/2004:11:04:55 -0700] [Job 54] Saw EOF!
D [21/Oct/2004:11:04:55 -0700] UpdateJob: job 54, file 0 is complete.
D [21/Oct/2004:11:04:55 -0700] CancelJob: id = 54
D [21/Oct/2004:11:04:55 -0700] StopJob: id = 54, force = 0
D [21/Oct/2004:11:04:55 -0700] StopJob: printer state is 3
D [21/Oct/2004:11:04:59 -0700] AcceptClient() 9 from localhost:631.
D [21/Oct/2004:11:04:59 -0700] ReadClient() 9 POST / HTTP/1.1
D [21/Oct/2004:11:04:59 -0700] ProcessIPPRequest: 9 status_code=1
D [21/Oct/2004:11:04:59 -0700] CloseClient() 9
D [21/Oct/2004:11:05:04 -0700] AcceptClient() 9 from localhost:631.
D [21/Oct/2004:11:05:04 -0700] ReadClient() 9 POST / HTTP/1.1
D [21/Oct/2004:11:05:04 -0700] ProcessIPPRequest: 9 status_code=1
D [21/Oct/2004:11:05:04 -0700] CloseClient() 9
D [21/Oct/2004:11:05:09 -0700] AcceptClient() 9 from localhost:631.
D [21/Oct/2004:11:05:09 -0700] ReadClient() 9 POST / HTTP/1.1
D [21/Oct/2004:11:05:09 -0700] ProcessIPPRequest: 9 status_code=1
D [21/Oct/2004:11:05:09 -0700] CloseClient() 9
D [21/Oct/2004:11:05:14 -0700] AcceptClient() 9 from localhost:631.
D [21/Oct/2004:11:05:14 -0700] ReadClient() 9 POST / HTTP/1.1
D [21/Oct/2004:11:05:14 -0700] ProcessIPPRequest: 9 status_code=1
D [21/Oct/2004:11:05:14 -0700] CloseClient() 9
D [21/Oct/2004:11:05:19 -0700] AcceptClient() 9 from localhost:631.
D [21/Oct/2004:11:05:19 -0700] ReadClient() 9 POST / HTTP/1.1
D [21/Oct/2004:11:05:19 -0700] ProcessIPPRequest: 9 status_code=1
D [21/Oct/2004:11:05:19 -0700] CloseClient() 9
D [21/Oct/2004:11:05:24 -0700] AcceptClient() 9 from localhost:631.
D [21/Oct/2004:11:05:24 -0700] ReadClient() 9 POST / HTTP/1.1
D [21/Oct/2004:11:05:24 -0700] ProcessIPPRequest: 9 status_code=1
D [21/Oct/2004:11:05:24 -0700] CloseClient() 9
D [21/Oct/2004:11:05:29 -0700] AcceptClient() 9 from localhost:631.
D [21/Oct/2004:11:05:29 -0700] ReadClient() 9 POST / HTTP/1.1
D [21/Oct/2004:11:05:29 -0700] ProcessIPPRequest: 9 status_code=1
D [21/Oct/2004:11:05:29 -0700] CloseClient() 9
D [21/Oct/2004:11:05:34 -0700] AcceptClient() 9 from localhost:631.
D [21/Oct/2004:11:05:34 -0700] ReadClient() 9 POST / HTTP/1.1
D [21/Oct/2004:11:05:34 -0700] ProcessIPPRequest: 9 status_code=1
D [21/Oct/2004:11:05:34 -0700] CloseClient() 9
D [21/Oct/2004:11:05:39 -0700] AcceptClient() 9 from localhost:631.
D [21/Oct/2004:11:05:39 -0700] ReadClient() 9 POST / HTTP/1.1
D [21/Oct/2004:11:05:39 -0700] ProcessIPPRequest: 9 status_code=1
D [21/Oct/2004:11:05:39 -0700] CloseClient() 9
D [21/Oct/2004:11:05:44 -0700] AcceptClient() 9 from localhost:631.
D [21/Oct/2004:11:05:44 -0700] ReadClient() 9 POST / HTTP/1.1
D [21/Oct/2004:11:05:44 -0700] ProcessIPPRequest: 9 status_code=1
D [21/Oct/2004:11:05:44 -0700] CloseClient() 9
D [21/Oct/2004:11:05:49 -0700] AcceptClient() 9 from localhost:631.
D [21/Oct/2004:11:05:49 -0700] ReadClient() 9 POST / HTTP/1.1
D [21/Oct/2004:11:05:49 -0700] ProcessIPPRequest: 9 status_code=1
D [21/Oct/2004:11:05:49 -0700] CloseClient() 9
D [21/Oct/2004:11:05:54 -0700] AcceptClient() 9 from localhost:631.
D [21/Oct/2004:11:05:54 -0700] ReadClient() 9 POST / HTTP/1.1
D [21/Oct/2004:11:05:54 -0700] ProcessIPPRequest: 9 status_code=1
D [21/Oct/2004:11:05:54 -0700] CloseClient() 9
D [21/Oct/2004:11:05:58 -0700] CloseClient() 3
D [21/Oct/2004:11:05:58 -0700] CloseClient() 10
D [21/Oct/2004:11:05:59 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:05:59 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:05:59 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:05:59 -0700] CloseClient() 3
D [21/Oct/2004:11:06:04 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:06:04 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:06:04 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:06:04 -0700] CloseClient() 3
D [21/Oct/2004:11:06:09 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:06:09 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:06:09 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:06:09 -0700] CloseClient() 3
D [21/Oct/2004:11:06:13 -0700] CloseClient() 7
D [21/Oct/2004:11:06:14 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:06:14 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:06:14 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:06:14 -0700] CloseClient() 3
D [21/Oct/2004:11:06:19 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:06:19 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:06:19 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:06:19 -0700] CloseClient() 3
D [21/Oct/2004:11:06:24 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:06:24 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:06:24 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:06:24 -0700] CloseClient() 3
D [21/Oct/2004:11:06:28 -0700] CloseClient() 6
D [21/Oct/2004:11:06:29 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:06:29 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:06:29 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:06:29 -0700] CloseClient() 3
D [21/Oct/2004:11:06:34 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:06:34 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:06:34 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:06:34 -0700] CloseClient() 3
D [21/Oct/2004:11:06:39 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:06:39 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:06:39 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:06:39 -0700] CloseClient() 3
D [21/Oct/2004:11:06:44 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:06:44 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:06:44 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:06:44 -0700] CloseClient() 3
D [21/Oct/2004:11:06:49 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:06:49 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:06:49 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:06:49 -0700] CloseClient() 3
D [21/Oct/2004:11:06:54 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:06:54 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:06:54 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:06:54 -0700] CloseClient() 3
D [21/Oct/2004:11:06:59 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:06:59 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:06:59 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:06:59 -0700] CloseClient() 3
D [21/Oct/2004:11:07:04 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:07:04 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:07:04 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:07:04 -0700] CloseClient() 3
D [21/Oct/2004:11:07:09 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:07:09 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:07:09 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:07:09 -0700] CloseClient() 3
D [21/Oct/2004:11:07:14 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:07:14 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:07:14 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:07:14 -0700] CloseClient() 3
D [21/Oct/2004:11:07:19 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:07:19 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:07:19 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:07:19 -0700] CloseClient() 3
D [21/Oct/2004:11:07:24 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:07:24 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:07:24 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:07:24 -0700] CloseClient() 3
D [21/Oct/2004:11:07:29 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:07:29 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:07:29 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:07:29 -0700] CloseClient() 3
D [21/Oct/2004:11:07:34 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:07:34 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:07:34 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:07:34 -0700] CloseClient() 3
D [21/Oct/2004:11:07:39 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:07:39 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:07:39 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:07:39 -0700] CloseClient() 3
D [21/Oct/2004:11:07:44 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:07:44 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:07:44 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:07:44 -0700] CloseClient() 3
D [21/Oct/2004:11:07:49 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:07:49 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:07:49 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:07:49 -0700] CloseClient() 3
D [21/Oct/2004:11:07:54 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:07:54 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:07:54 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:07:54 -0700] CloseClient() 3
D [21/Oct/2004:11:07:59 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:07:59 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:07:59 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:07:59 -0700] CloseClient() 3
D [21/Oct/2004:11:08:04 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:08:04 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:08:04 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:08:04 -0700] CloseClient() 3
D [21/Oct/2004:11:08:09 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:08:09 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:08:09 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:08:09 -0700] CloseClient() 3
D [21/Oct/2004:11:08:14 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:08:14 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:08:14 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:08:14 -0700] CloseClient() 3
D [21/Oct/2004:11:08:19 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:08:19 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:08:19 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:08:19 -0700] CloseClient() 3
D [21/Oct/2004:11:08:24 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:08:24 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:08:24 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:08:24 -0700] CloseClient() 3
D [21/Oct/2004:11:08:29 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:08:29 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:08:29 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:08:29 -0700] CloseClient() 3
D [21/Oct/2004:11:08:34 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:08:34 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:08:34 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:08:34 -0700] CloseClient() 3
D [21/Oct/2004:11:08:39 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:08:39 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:08:39 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:08:39 -0700] CloseClient() 3
D [21/Oct/2004:11:08:44 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:08:44 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:08:44 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:08:44 -0700] CloseClient() 3
D [21/Oct/2004:11:08:49 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:08:49 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:08:49 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:08:49 -0700] CloseClient() 3
D [21/Oct/2004:11:08:54 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:08:54 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:08:54 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:08:54 -0700] CloseClient() 3
D [21/Oct/2004:11:08:59 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:08:59 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:08:59 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:08:59 -0700] CloseClient() 3
D [21/Oct/2004:11:09:04 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:09:04 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:09:04 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:09:04 -0700] CloseClient() 3
D [21/Oct/2004:11:09:09 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:09:09 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:09:09 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:09:09 -0700] CloseClient() 3
D [21/Oct/2004:11:09:14 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:09:14 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:09:14 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:09:14 -0700] CloseClient() 3
D [21/Oct/2004:11:09:18 -0700] CloseClient() 5
D [21/Oct/2004:11:09:19 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:09:19 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:09:19 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:09:19 -0700] CloseClient() 3
D [21/Oct/2004:11:09:24 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:09:24 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:09:24 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:09:24 -0700] CloseClient() 3
D [21/Oct/2004:11:09:29 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:09:29 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:09:29 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:09:29 -0700] CloseClient() 3
D [21/Oct/2004:11:09:34 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:09:34 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:09:34 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:09:34 -0700] CloseClient() 3
D [21/Oct/2004:11:09:39 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:09:39 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:09:39 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:09:39 -0700] CloseClient() 3
D [21/Oct/2004:11:09:44 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:09:44 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:09:44 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:09:44 -0700] CloseClient() 3
D [21/Oct/2004:11:09:49 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:09:49 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:09:49 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:09:49 -0700] CloseClient() 3
D [21/Oct/2004:11:09:54 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:09:54 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:09:54 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:09:54 -0700] CloseClient() 3
D [21/Oct/2004:11:09:59 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:09:59 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:09:59 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:09:59 -0700] CloseClient() 3
D [21/Oct/2004:11:10:04 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:10:04 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:10:04 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:10:04 -0700] CloseClient() 3
D [21/Oct/2004:11:10:09 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:10:09 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:10:09 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:10:09 -0700] CloseClient() 3
D [21/Oct/2004:11:10:14 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:10:14 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:10:14 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:10:14 -0700] CloseClient() 3
D [21/Oct/2004:11:10:19 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:10:19 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:10:19 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:10:19 -0700] CloseClient() 3
D [21/Oct/2004:11:10:24 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:10:24 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:10:24 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:10:24 -0700] CloseClient() 3
D [21/Oct/2004:11:10:29 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:10:29 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:10:29 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:10:29 -0700] CloseClient() 3
D [21/Oct/2004:11:10:34 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:10:34 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:10:34 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:10:34 -0700] CloseClient() 3
D [21/Oct/2004:11:10:39 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:10:39 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:10:39 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:10:39 -0700] CloseClient() 3
D [21/Oct/2004:11:10:44 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:10:44 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:10:44 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:10:44 -0700] CloseClient() 3
D [21/Oct/2004:11:10:49 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:10:49 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:10:49 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:10:49 -0700] CloseClient() 3
D [21/Oct/2004:11:10:54 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:10:54 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:10:54 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:10:54 -0700] CloseClient() 3
D [21/Oct/2004:11:10:59 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:10:59 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:10:59 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:10:59 -0700] CloseClient() 3
D [21/Oct/2004:11:11:04 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:11:04 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:11:04 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:11:04 -0700] CloseClient() 3
D [21/Oct/2004:11:11:09 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:11:09 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:11:09 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:11:09 -0700] CloseClient() 3
D [21/Oct/2004:11:11:14 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:11:14 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:11:14 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:11:14 -0700] CloseClient() 3
D [21/Oct/2004:11:11:19 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:11:19 -0700] ReadClient() 3 POST / HTTP/1.1
D [21/Oct/2004:11:11:19 -0700] ProcessIPPRequest: 3 status_code=1
D [21/Oct/2004:11:11:19 -0700] CloseClient() 3
D [21/Oct/2004:11:11:24 -0700] AcceptClient() 3 from localhost:631.
D [21/Oct/2004:11:11:24 -0700] ReadClient() 3 GET /printers HTTP/1.1
D [21/Oct/2004:11:11:24 -0700] CGI /usr/lib/cups/cgi-bin/printers.cgi 
started - PID = 3253
I [21/Oct/2004:11:11:24 -0700] Started "/usr/lib/cups/cgi-bin/printers.cgi" 
(pid=3253)
D [21/Oct/2004:11:11:24 -0700] SendCommand() 3 file=6
D [21/Oct/2004:11:11:24 -0700] AcceptClient() 5 from localhost:631.
D [21/Oct/2004:11:11:24 -0700] ReadClient() 5 POST / HTTP/1.1
D [21/Oct/2004:11:11:24 -0700] ProcessIPPRequest: 5 status_code=1
D [21/Oct/2004:11:11:24 -0700] CloseClient() 5
D [21/Oct/2004:11:11:27 -0700] AcceptClient() 5 from localhost:631.
D [21/Oct/2004:11:11:27 -0700] ReadClient() 5 POST / HTTP/1.1
D [21/Oct/2004:11:11:27 -0700] ProcessIPPRequest: 5 status_code=0
D [21/Oct/2004:11:11:27 -0700] ReadClient() 5 POST / HTTP/1.1
D [21/Oct/2004:11:11:27 -0700] ProcessIPPRequest: 5 status_code=0
D [21/Oct/2004:11:11:27 -0700] CloseClient() 5
D [21/Oct/2004:11:11:28 -0700] AcceptClient() 5 from localhost:631.
D [21/Oct/2004:11:11:28 -0700] ReadClient() 3 GET /images/right.gif HTTP/1.1
D [21/Oct/2004:11:11:28 -0700] SendFile() 3 file=6
D [21/Oct/2004:11:11:28 -0700] ReadClient() 5 GET /images/left.gif HTTP/1.1
D [21/Oct/2004:11:11:28 -0700] SendFile() 5 file=7
D [21/Oct/2004:11:11:28 -0700] ReadClient() 5 GET /images/printer-idle.gif 
HTTP/1.1
D [21/Oct/2004:11:11:28 -0700] SendFile() 5 file=6
D [21/Oct/2004:11:11:28 -0700] ReadClient() 3 GET 
/images/print-test-page.gif HTTP/1.1
D [21/Oct/2004:11:11:28 -0700] SendFile() 3 file=6
D [21/Oct/2004:11:11:28 -0700] ReadClient() 5 GET /images/stop-printer.gif 
HTTP/1.1
D [21/Oct/2004:11:11:28 -0700] SendFile() 5 file=7
D [21/Oct/2004:11:11:28 -0700] ReadClient() 3 GET /images/modify-printer.gif 
HTTP/1.1
D [21/Oct/2004:11:11:28 -0700] SendFile() 3 file=6
D [21/Oct/2004:11:11:28 -0700] ReadClient() 5 GET /images/reject-jobs.gif 
HTTP/1.1
D [21/Oct/2004:11:11:28 -0700] SendFile() 5 file=7
D [21/Oct/2004:11:11:28 -0700] ReadClient() 3 GET /images/config-printer.gif 
HTTP/1.1
D [21/Oct/2004:11:11:28 -0700] SendFile() 3 file=6
D [21/Oct/2004:11:11:28 -0700] ReadClient() 5 GET /images/delete-printer.gif 
HTTP/1.1
D [21/Oct/2004:11:11:28 -0700] SendFile() 5 file=7
D [21/Oct/2004:11:11:28 -0700] ReadClient() 5 GET /images/add-printer.gif 
HTTP/1.1
D [21/Oct/2004:11:11:28 -0700] SendFile() 5 file=6
D [21/Oct/2004:11:11:29 -0700] AcceptClient() 6 from localhost:631.
D [21/Oct/2004:11:11:29 -0700] ReadClient() 6 POST / HTTP/1.1
D [21/Oct/2004:11:11:29 -0700] ProcessIPPRequest: 6 status_code=1
D [21/Oct/2004:11:11:29 -0700] CloseClient() 6
D [21/Oct/2004:11:11:34 -0700] AcceptClient() 6 from localhost:631.
D [21/Oct/2004:11:11:34 -0700] ReadClient() 6 POST / HTTP/1.1
D [21/Oct/2004:11:11:34 -0700] ProcessIPPRequest: 6 status_code=1
D [21/Oct/2004:11:11:34 -0700] CloseClient() 6
D [21/Oct/2004:11:11:37 -0700] AcceptClient() 6 from localhost:631.
D [21/Oct/2004:11:11:37 -0700] ReadClient() 6 POST / HTTP/1.1
D [21/Oct/2004:11:11:37 -0700] ProcessIPPRequest: 6 status_code=0
D [21/Oct/2004:11:11:37 -0700] CloseClient() 6
D [21/Oct/2004:11:11:37 -0700] AcceptClient() 6 from localhost:631.
D [21/Oct/2004:11:11:37 -0700] ReadClient() 6 POST / HTTP/1.1
D [21/Oct/2004:11:11:37 -0700] ProcessIPPRequest: 6 status_code=0
D [21/Oct/2004:11:11:37 -0700] CloseClient() 6
D [21/Oct/2004:11:11:37 -0700] AcceptClient() 6 from localhost:631.
D [21/Oct/2004:11:11:37 -0700] ReadClient() 6 POST / HTTP/1.1
D [21/Oct/2004:11:11:37 -0700] ProcessIPPRequest: 6 status_code=0
D [21/Oct/2004:11:11:37 -0700] ReadClient() 6 POST /printers/HP5500PS 
HTTP/1.1
D [21/Oct/2004:11:11:37 -0700] print_job: auto-typing file...
D [21/Oct/2004:11:11:37 -0700] print_job: request file type is 
application/postscript.
D [21/Oct/2004:11:11:37 -0700] check_quotas: requesting-user-name = 'george'
D [21/Oct/2004:11:11:37 -0700] print_job: requesting-user-name = 'george'
I [21/Oct/2004:11:11:37 -0700] Job 55 queued on 'HP5500PS' by 'george'.
D [21/Oct/2004:11:11:37 -0700] Job 55 hold_until = 0
D [21/Oct/2004:11:11:37 -0700] StartJob(55, 0x80e5b20)
D [21/Oct/2004:11:11:37 -0700] StartJob() id = 55, file = 0/1
D [21/Oct/2004:11:11:37 -0700] job-sheets=none,none
D [21/Oct/2004:11:11:37 -0700] banner_page = 0
D [21/Oct/2004:11:11:37 -0700] StartJob: argv = 
"HP5500PS","55","george","1pg.ps","1","","/var/spool/cups/d00055-001"
D [21/Oct/2004:11:11:37 -0700] StartJob: envp = 
"PATH=/usr/lib/cups/filter:/bin:/usr/bin","SOFTWARE=CUPS/1.1","USER=root","CHARSET=iso-8859-1","LANG=en_US","","PPD=/etc/cups/ppd/HP5500PS.ppd","CUPS_SERVERROOT=/etc/cups","RIP_MAX_CACHE=8m","TMPDIR=/var/spool/cups/tmp","CONTENT_TYPE=application/postscript","DEVICE_URI=socket://172.30.4.184","PRINTER=HP5500PS","CUPS_DATADIR=/usr/share/cups","CUPS_FONTPATH=/usr/share/cups/fonts","","",""
D [21/Oct/2004:11:11:37 -0700] StartJob: statusfds = 7, 9
D [21/Oct/2004:11:11:37 -0700] StartJob: filterfds[1] = 10, -1
D [21/Oct/2004:11:11:37 -0700] StartJob: filter = 
"/usr/lib/cups/filter/pstops"
D [21/Oct/2004:11:11:37 -0700] StartJob: filterfds[0] = 11, 12
D [21/Oct/2004:11:11:37 -0700] start_process("/usr/lib/cups/filter/pstops", 
0xbfff0990, 0xbffefe40, 10, 12, 9)
I [21/Oct/2004:11:11:37 -0700] Started filter /usr/lib/cups/filter/pstops 
(PID 3255) for job 55.
D [21/Oct/2004:11:11:37 -0700] StartJob: backend = 
"/usr/lib/cups/backend/socket"
D [21/Oct/2004:11:11:37 -0700] StartJob: filterfds[1] = -1, 10
D [21/Oct/2004:11:11:37 -0700] start_process("/usr/lib/cups/backend/socket", 
0xbfff0990, 0xbffefe40, 11, 10, 9)
I [21/Oct/2004:11:11:37 -0700] Started backend /usr/lib/cups/backend/socket 
(PID 3256) for job 55.
D [21/Oct/2004:11:11:37 -0700] ProcessIPPRequest: 6 status_code=0
D [21/Oct/2004:11:11:37 -0700] [Job 55] Page = 612x792; 12,12 to 600,780
D [21/Oct/2004:11:11:37 -0700] [Job 55] 0 %%
D [21/Oct/2004:11:11:37 -0700] [Job 55] 0 %%BeginProlog
D [21/Oct/2004:11:11:37 -0700] [Job 55] 0 %%EndProlog
D [21/Oct/2004:11:11:37 -0700] CloseClient() 6
D [21/Oct/2004:11:11:37 -0700] UpdateJob: job 55, file 0 is complete.
D [21/Oct/2004:11:11:37 -0700] CancelJob: id = 55
D [21/Oct/2004:11:11:37 -0700] StopJob: id = 55, force = 0
D [21/Oct/2004:11:11:37 -0700] StopJob: printer state is 3
D [21/Oct/2004:11:11:39 -0700] AcceptClient() 6 from localhost:631.
D [21/Oct/2004:11:11:39 -0700] ReadClient() 6 POST / HTTP/1.1
D [21/Oct/2004:11:11:39 -0700] ProcessIPPRequest: 6 status_code=1
D [21/Oct/2004:11:11:39 -0700] CloseClient() 6
D [21/Oct/2004:11:11:44 -0700] AcceptClient() 6 from localhost:631.
D [21/Oct/2004:11:11:44 -0700] ReadClient() 6 POST / HTTP/1.1
D [21/Oct/2004:11:11:44 -0700] ProcessIPPRequest: 6 status_code=1
D [21/Oct/2004:11:11:44 -0700] CloseClient() 6