[cups.general] HP Photosmart 7260 debug2 loglevel states successful, but no print

wing549 wing549 at earthlink.com
Sun Jul 11 16:13:07 PDT 2004 

I am using Gentoo which I know someone is going to hound me for some
reason or another, but I followed the Gentoo printing guide to the T:
http://www.gentoo.org/doc/en/printing-howto.xml, by having all the
necessary USE flags: cups usb foomatic ppds
which then I proceeded to emerge cups foomatic hpoj hpijs. From there I
ran ptal-init setup which reports my HP Photosmart 7260 as

Currently defined device names ([*]=default):
    "mlc:usb:photosmart_7200_series"
        Model is "photosmart 7200 series".
        Serial number is "CN3963B1QZI5".

I then started up the services which all complete successfully
/etc/init.d/hpoj start
/etc/init.d/cupsd start

grub has lp=lp0 boog argument .. dmesg output:

07:12:13 PM_EDT_2004 root at Important /home/stealth
> dmesg | grep lp        
On node 0 totalpages: 196604
Kernel command line: root=/dev/hda6 fbcon directfb dga vga=0x31A
video=vesafb mtrr lp=lp0 bttv hdd=ide-scsi psmouse_noext=1
psmouse.proto=imps2
lp: driver loaded but no devices found
lp0: using parport0 (polling).
Uniform Multi-Platform E-IDE driver Revision: 7.00alpha2
usbcore: registered new driver usblp
drivers/usb/class/usblp.c: v0.13: USB Printer Device Class driver
drivers/usb/class/usblp.c: usblp0: USB Bidirectional printer dev 2 if 0
alt 0 proto 2 vid 0x03F0 pid 0xB002


I point firefox to localhost:631 and setup my printer which it
identifies in the dropdown menu as the PTAL MLC device. The driver I
choose is specific HP Photosmart 7260 from the list.

But then when I try to print from firefox... nothing happens, no
printing. Please someone help as I am all out of ideas, and need to
print documents for school. I cant print my Open Source in Education
pamphlets in windows... way too unethical, please help. 

/var/log/cups/error_log @ LogLevel debug2
D [11/Jul/2004:19:02:34 -0400] AcceptClient() 5 from localhost:631.
d [11/Jul/2004:19:02:34 -0400] AcceptClient: Adding fd 5 to InputSet...
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5, used=0
D [11/Jul/2004:19:02:34 -0400] ReadClient() 5 POST / HTTP/1.1
d [11/Jul/2004:19:02:34 -0400] decode_auth(0x4030d008): Authorization
string = ""
d [11/Jul/2004:19:02:34 -0400] decode_auth() 5 username=""
d [11/Jul/2004:19:02:34 -0400] IsAuthorized: con->uri = "/"
d [11/Jul/2004:19:02:34 -0400] FindBest: uri = "/"...
d [11/Jul/2004:19:02:34 -0400] FindBest: Location / Limit 7f
d [11/Jul/2004:19:02:34 -0400] FindBest: Location /admin Limit 7f
d [11/Jul/2004:19:02:34 -0400] FindBest: best = "/"
d [11/Jul/2004:19:02:34 -0400] IsAuthorized: auth = 0, satisfy=0...
d [11/Jul/2004:19:02:34 -0400] POST /
d [11/Jul/2004:19:02:34 -0400] CONTENT_TYPE = application/ipp
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 con->data_encoding =
length, con->data_remaining = 137, con->file = 0
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5, used=0
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 con->data_encoding =
length, con->data_remaining = 129, con->file = 0
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5, used=0
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 con->data_encoding =
length, con->data_remaining = 95, con->file = 0
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5, used=0
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 con->data_encoding =
length, con->data_remaining = 61, con->file = 0
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5, used=23
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 con->data_encoding =
length, con->data_remaining = 24, con->file = 0
d [11/Jul/2004:19:02:34 -0400] ProcessIPPRequest(0x4030d008[5]):
operation_id = 4002
d [11/Jul/2004:19:02:34 -0400] get_printers(0x4030d008[5], 0)
d [11/Jul/2004:19:02:34 -0400] add_printer_state_reasons(0x4030d008[5],
0x808e8d8[hp])
d [11/Jul/2004:19:02:34 -0400] add_queued_job_count(0x4030d008[5],
0x808e8d8[hp])
d [11/Jul/2004:19:02:34 -0400] copy_attrs(0x80de960, 0x8092758,
0x80df1e8, 0)
d [11/Jul/2004:19:02:34 -0400] copy_attribute(0x80de960,
0x80928b8[printer-name,4,42])
d [11/Jul/2004:19:02:34 -0400] copy_attribute(0x80de960,
0x8092ac8[job-sheets-default,4,42])
d [11/Jul/2004:19:02:34 -0400] copy_attrs(0x80de960, 0x808ee08,
0x80df1e8, 0)
D [11/Jul/2004:19:02:34 -0400] ProcessIPPRequest: 5 status_code=1
d [11/Jul/2004:19:02:34 -0400] ProcessIPPRequest: Adding fd 5 to
OutputSet...
d [11/Jul/2004:19:02:34 -0400] WriteClient: Removing fd 5 from
OutputSet...
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5, used=0
D [11/Jul/2004:19:02:34 -0400] CloseClient() 5
d [11/Jul/2004:19:02:34 -0400] CloseClient: Removing fd 5 from InputSet
and OutputSet...
d [11/Jul/2004:19:02:34 -0400] AcceptClient(0x808a410) 0 NumClients = 0
D [11/Jul/2004:19:02:34 -0400] AcceptClient() 5 from localhost:631.
d [11/Jul/2004:19:02:34 -0400] AcceptClient: Adding fd 5 to InputSet...
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5, used=0
D [11/Jul/2004:19:02:34 -0400] ReadClient() 5 POST / HTTP/1.1
d [11/Jul/2004:19:02:34 -0400] decode_auth(0x4030d008): Authorization
string = ""
d [11/Jul/2004:19:02:34 -0400] decode_auth() 5 username=""
d [11/Jul/2004:19:02:34 -0400] IsAuthorized: con->uri = "/"
d [11/Jul/2004:19:02:34 -0400] FindBest: uri = "/"...
d [11/Jul/2004:19:02:34 -0400] FindBest: Location / Limit 7f
d [11/Jul/2004:19:02:34 -0400] FindBest: Location /admin Limit 7f
d [11/Jul/2004:19:02:34 -0400] FindBest: best = "/"
d [11/Jul/2004:19:02:34 -0400] IsAuthorized: auth = 0, satisfy=0...
d [11/Jul/2004:19:02:34 -0400] POST /
d [11/Jul/2004:19:02:34 -0400] CONTENT_TYPE = application/ipp
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 con->data_encoding =
length, con->data_remaining = 137, con->file = 0
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5, used=0
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 con->data_encoding =
length, con->data_remaining = 129, con->file = 0
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5, used=0
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 con->data_encoding =
length, con->data_remaining = 95, con->file = 0
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5, used=0
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 con->data_encoding =
length, con->data_remaining = 61, con->file = 0
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5, used=23
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 con->data_encoding =
length, con->data_remaining = 24, con->file = 0
d [11/Jul/2004:19:02:34 -0400] ProcessIPPRequest(0x4030d008[5]):
operation_id = 4005
d [11/Jul/2004:19:02:34 -0400] get_printers(0x4030d008[5], 1)
D [11/Jul/2004:19:02:34 -0400] ProcessIPPRequest: 5 status_code=1
d [11/Jul/2004:19:02:34 -0400] ProcessIPPRequest: Adding fd 5 to
OutputSet...
d [11/Jul/2004:19:02:34 -0400] WriteClient: Removing fd 5 from
OutputSet...
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5, used=0
D [11/Jul/2004:19:02:34 -0400] CloseClient() 5
d [11/Jul/2004:19:02:34 -0400] CloseClient: Removing fd 5 from InputSet
and OutputSet...
d [11/Jul/2004:19:02:34 -0400] AcceptClient(0x808a410) 0 NumClients = 0
D [11/Jul/2004:19:02:34 -0400] AcceptClient() 5 from localhost:631.
d [11/Jul/2004:19:02:34 -0400] AcceptClient: Adding fd 5 to InputSet...
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5, used=0
D [11/Jul/2004:19:02:34 -0400] ReadClient() 5 POST / HTTP/1.1
d [11/Jul/2004:19:02:34 -0400] decode_auth(0x4030d008): Authorization
string = ""
d [11/Jul/2004:19:02:34 -0400] decode_auth() 5 username=""
d [11/Jul/2004:19:02:34 -0400] IsAuthorized: con->uri = "/"
d [11/Jul/2004:19:02:34 -0400] FindBest: uri = "/"...
d [11/Jul/2004:19:02:34 -0400] FindBest: Location / Limit 7f
d [11/Jul/2004:19:02:34 -0400] FindBest: Location /admin Limit 7f
d [11/Jul/2004:19:02:34 -0400] FindBest: best = "/"
d [11/Jul/2004:19:02:34 -0400] IsAuthorized: auth = 0, satisfy=0...
d [11/Jul/2004:19:02:34 -0400] POST /
d [11/Jul/2004:19:02:34 -0400] CONTENT_TYPE = application/ipp
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 con->data_encoding =
length, con->data_remaining = 77, con->file = 0
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5, used=0
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 con->data_encoding =
length, con->data_remaining = 69, con->file = 0
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5, used=0
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 con->data_encoding =
length, con->data_remaining = 35, con->file = 0
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5, used=0
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 con->data_encoding =
length, con->data_remaining = 1, con->file = 0
d [11/Jul/2004:19:02:34 -0400] ProcessIPPRequest(0x4030d008[5]):
operation_id = 4001
d [11/Jul/2004:19:02:34 -0400] get_default(0x4030d008[5])
d [11/Jul/2004:19:02:34 -0400] copy_attrs(0x80df488, 0x8092758, (nil),
0)
d [11/Jul/2004:19:02:34 -0400] copy_attribute(0x80df488,
0x8092780[printer-uri-supported,4,45])
d [11/Jul/2004:19:02:34 -0400] copy_attribute(0x80df488,
0x80927f0[uri-authentication-supported,4,44])
d [11/Jul/2004:19:02:34 -0400] copy_attribute(0x80df488,
0x8092860[uri-security-supported,4,44])
d [11/Jul/2004:19:02:34 -0400] copy_attribute(0x80df488,
0x80928b8[printer-name,4,42])
d [11/Jul/2004:19:02:34 -0400] copy_attribute(0x80df488,
0x8092908[printer-location,4,41])
d [11/Jul/2004:19:02:34 -0400] copy_attribute(0x80df488,
0x8092958[printer-info,4,41])
d [11/Jul/2004:19:02:34 -0400] copy_attribute(0x80df488,
0x80929a8[printer-more-info,4,45])
d [11/Jul/2004:19:02:34 -0400] copy_attribute(0x80df488,
0x8092a10[job-quota-period,4,21])
d [11/Jul/2004:19:02:34 -0400] copy_attribute(0x80df488,
0x8092a50[job-k-limit,4,21])
d [11/Jul/2004:19:02:34 -0400] copy_attribute(0x80df488,
0x8092a88[job-page-limit,4,21])
d [11/Jul/2004:19:02:34 -0400] copy_attribute(0x80df488,
0x8092ac8[job-sheets-default,4,42])
d [11/Jul/2004:19:02:34 -0400] copy_attribute(0x80df488,
0x8092b30[device-uri,4,45])
d [11/Jul/2004:19:02:34 -0400] copy_attribute(0x80df488,
0x80a33b0[color-supported,4,22])
d [11/Jul/2004:19:02:34 -0400] copy_attribute(0x80df488,
0x80a2ae0[pages-per-minute,4,21])
d [11/Jul/2004:19:02:34 -0400] copy_attribute(0x80df488,
0x80a30d0[printer-make-and-model,4,41])
d [11/Jul/2004:19:02:34 -0400] copy_attribute(0x80df488,
0x8092b98[media-supported,4,44])
d [11/Jul/2004:19:02:34 -0400] copy_attribute(0x80df488,
0x80a3a58[media-default,4,44])
d [11/Jul/2004:19:02:34 -0400] copy_attribute(0x80df488,
0x80a3aa8[sides-supported,4,44])
d [11/Jul/2004:19:02:34 -0400] copy_attribute(0x80df488,
0x80a3b40[sides-default,4,44])
d [11/Jul/2004:19:02:34 -0400] copy_attribute(0x80df488,
0x809b000[finishings-supported,4,23])
d [11/Jul/2004:19:02:34 -0400] copy_attribute(0x80df488,
0x809a210[finishings-default,4,23])
d [11/Jul/2004:19:02:34 -0400] copy_attribute(0x80df488,
0x809a410[printer-type,4,23])
D [11/Jul/2004:19:02:34 -0400] ProcessIPPRequest: 5 status_code=0
d [11/Jul/2004:19:02:34 -0400] ProcessIPPRequest: Adding fd 5 to
OutputSet...
d [11/Jul/2004:19:02:34 -0400] WriteClient: Removing fd 5 from
OutputSet...
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5, used=0
D [11/Jul/2004:19:02:34 -0400] ReadClient() 5 POST /printers/hp HTTP/1.1
d [11/Jul/2004:19:02:34 -0400] decode_auth(0x4030d008): Authorization
string = ""
d [11/Jul/2004:19:02:34 -0400] decode_auth() 5 username=""
d [11/Jul/2004:19:02:34 -0400] IsAuthorized: con->uri = "/printers/hp"
d [11/Jul/2004:19:02:34 -0400] FindBest: uri = "/printers/hp"...
d [11/Jul/2004:19:02:34 -0400] FindBest: Location / Limit 7f
d [11/Jul/2004:19:02:34 -0400] FindBest: Location /admin Limit 7f
d [11/Jul/2004:19:02:34 -0400] FindBest: best = "/"
d [11/Jul/2004:19:02:34 -0400] IsAuthorized: auth = 0, satisfy=0...
d [11/Jul/2004:19:02:34 -0400] POST /printers/hp
d [11/Jul/2004:19:02:34 -0400] CONTENT_TYPE = application/ipp
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 con->data_encoding =
length, con->data_remaining = 509209, con->file = 0
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 REQUEST
/var/spool/cups/00000002=7
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 writing 1749 bytes to 7
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5, used=0
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 con->data_encoding =
length, con->data_remaining = 507211, con->file = 7
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 writing 32768 bytes to 7
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5, used=0
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 con->data_encoding =
length, con->data_remaining = 474443, con->file = 7
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 writing 14333 bytes to 7
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5, used=0
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 con->data_encoding =
length, con->data_remaining = 460110, con->file = 7
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 writing 32768 bytes to 7
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5, used=0
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 con->data_encoding =
length, con->data_remaining = 427342, con->file = 7
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 writing 32768 bytes to 7
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5, used=0
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 con->data_encoding =
length, con->data_remaining = 394574, con->file = 7
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 writing 32768 bytes to 7
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5, used=0
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 con->data_encoding =
length, con->data_remaining = 361806, con->file = 7
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 writing 32768 bytes to 7
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5, used=0
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 con->data_encoding =
length, con->data_remaining = 329038, con->file = 7
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 writing 16686 bytes to 7
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5, used=0
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 con->data_encoding =
length, con->data_remaining = 312352, con->file = 7
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 writing 32768 bytes to 7
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5, used=0
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 con->data_encoding =
length, con->data_remaining = 279584, con->file = 7
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 writing 32768 bytes to 7
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5, used=0
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 con->data_encoding =
length, con->data_remaining = 246816, con->file = 7
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 writing 32768 bytes to 7
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5, used=0
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 con->data_encoding =
length, con->data_remaining = 214048, con->file = 7
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 writing 32768 bytes to 7
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5, used=0
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 con->data_encoding =
length, con->data_remaining = 181280, con->file = 7
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 writing 32768 bytes to 7
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5, used=0
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 con->data_encoding =
length, con->data_remaining = 148512, con->file = 7
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 writing 32768 bytes to 7
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5, used=0
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 con->data_encoding =
length, con->data_remaining = 115744, con->file = 7
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 writing 32768 bytes to 7
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5, used=0
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 con->data_encoding =
length, con->data_remaining = 82976, con->file = 7
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 writing 32768 bytes to 7
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5, used=0
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 con->data_encoding =
length, con->data_remaining = 50208, con->file = 7
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 writing 32768 bytes to 7
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5, used=0
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 con->data_encoding =
length, con->data_remaining = 17440, con->file = 7
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 writing 17440 bytes to 7
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5 Closing data file 7, size
= 508960.
d [11/Jul/2004:19:02:34 -0400] ProcessIPPRequest(0x4030d008[5]):
operation_id = 0002
d [11/Jul/2004:19:02:34 -0400] print_job(0x4030d008[5],
ipp://localhost:631/printers/hp)
D [11/Jul/2004:19:02:34 -0400] print_job: auto-typing file...
D [11/Jul/2004:19:02:34 -0400] print_job: request file type is
application/postscript.
d [11/Jul/2004:19:02:34 -0400] check_quotas(0x4030d008[5],
0x808e8d8[hp])
D [11/Jul/2004:19:02:34 -0400] check_quotas: requesting-user-name =
'stealth'
D [11/Jul/2004:19:02:34 -0400] print_job: requesting-user-name =
'stealth'
I [11/Jul/2004:19:02:34 -0400] Adding start banner page "none" to job 8.
d [11/Jul/2004:19:02:34 -0400] copy_banner(0x4030d008[5], 0x80df398[8],
none)
d [11/Jul/2004:19:02:34 -0400] add_file(con=0x4030d008[5], job=8,
filetype=application/postscript, compression=0)
I [11/Jul/2004:19:02:34 -0400] Adding end banner page "none" to job 8.
d [11/Jul/2004:19:02:34 -0400] copy_banner(0x4030d008[5], 0x80df398[8],
none)
I [11/Jul/2004:19:02:34 -0400] Job 8 queued on 'hp' by 'stealth'.
D [11/Jul/2004:19:02:34 -0400] Job 8 hold_until = 0
d [11/Jul/2004:19:02:34 -0400] SaveJob: Closing file 7...
D [11/Jul/2004:19:02:34 -0400] StartJob(8, 0x808e8d8)
D [11/Jul/2004:19:02:34 -0400] StartJob() id = 8, file = 0/1
D [11/Jul/2004:19:02:34 -0400] job-sheets=none,none
D [11/Jul/2004:19:02:34 -0400] banner_page = 0
D [11/Jul/2004:19:02:34 -0400] StartJob: argv =
"hp","8","stealth","(stdin)","1","","/var/spool/cups/d00008-001"
D [11/Jul/2004:19:02:34 -0400] StartJob:
envp[0]="PATH=/usr/lib/cups/filter:/bin:/usr/bin"
D [11/Jul/2004:19:02:34 -0400] StartJob: envp[1]="SOFTWARE=CUPS/1.1"
D [11/Jul/2004:19:02:34 -0400] StartJob: envp[2]="USER=root"
D [11/Jul/2004:19:02:34 -0400] StartJob: envp[3]="CHARSET=iso-8859-1"
D [11/Jul/2004:19:02:34 -0400] StartJob: envp[4]="LANG=en"
D [11/Jul/2004:19:02:34 -0400] StartJob:
envp[5]="PPD=/etc/cups/ppd/hp.ppd"
D [11/Jul/2004:19:02:34 -0400] StartJob:
envp[6]="CUPS_SERVERROOT=/etc/cups"
D [11/Jul/2004:19:02:34 -0400] StartJob: envp[7]="RIP_MAX_CACHE=8m"
D [11/Jul/2004:19:02:34 -0400] StartJob:
envp[8]="TMPDIR=/var/spool/cups/tmp"
D [11/Jul/2004:19:02:34 -0400] StartJob:
envp[9]="CONTENT_TYPE=application/postscript"
D [11/Jul/2004:19:02:34 -0400] StartJob:
envp[10]="DEVICE_URI=ptal:/mlc:usb:photosmart_7200_series"
D [11/Jul/2004:19:02:34 -0400] StartJob: envp[11]="PRINTER=hp"
D [11/Jul/2004:19:02:34 -0400] StartJob:
envp[12]="CUPS_DATADIR=/usr/share/cups"
D [11/Jul/2004:19:02:34 -0400] StartJob:
envp[13]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [11/Jul/2004:19:02:34 -0400] StartJob:
envp[14]="CUPS_SERVER=localhost"
D [11/Jul/2004:19:02:34 -0400] StartJob: envp[15]="IPP_PORT=631"
d [11/Jul/2004:19:02:34 -0400] StartJob: Allocating status buffer...
D [11/Jul/2004:19:02:34 -0400] StartJob: statusfds = [ 7 8 ]
D [11/Jul/2004:19:02:34 -0400] StartJob: filterfds[1] = [ 10 -1 ]
D [11/Jul/2004:19:02:34 -0400] StartJob: filter =
"/usr/lib/cups/filter/pstops"
D [11/Jul/2004:19:02:34 -0400] StartJob: filterfds[0] = [ 11 12 ]
D [11/Jul/2004:19:02:34 -0400]
start_process("/usr/lib/cups/filter/pstops", 0xbffef680, 0xbffee9f0, 10,
12, 8)
I [11/Jul/2004:19:02:34 -0400] Started filter
/usr/lib/cups/filter/pstops (PID 14942) for job 8.
D [11/Jul/2004:19:02:34 -0400] StartJob: filter =
"/usr/lib/cups/filter/foomatic-rip"
D [11/Jul/2004:19:02:34 -0400] StartJob: filterfds[1] = [ 10 13 ]
D [11/Jul/2004:19:02:34 -0400]
start_process("/usr/lib/cups/filter/foomatic-rip", 0xbffef680,
0xbffee9f0, 11, 13, 8)
I [11/Jul/2004:19:02:34 -0400] Started filter
/usr/lib/cups/filter/foomatic-rip (PID 14943) for job 8.
D [11/Jul/2004:19:02:34 -0400] StartJob: backend =
"/usr/lib/cups/backend/ptal"
D [11/Jul/2004:19:02:34 -0400] StartJob: filterfds[0] = [ -1 11 ]
D [11/Jul/2004:19:02:34 -0400]
start_process("/usr/lib/cups/backend/ptal", 0xbffef680, 0xbffee9f0, 10,
11, 8)
I [11/Jul/2004:19:02:34 -0400] Started backend
/usr/lib/cups/backend/ptal (PID 14944) for job 8.
d [11/Jul/2004:19:02:34 -0400] StartJob: Adding fd 7 to InputSet...
d [11/Jul/2004:19:02:34 -0400] add_job_state_reasons(0x4030d008[5], 8)
D [11/Jul/2004:19:02:34 -0400] ProcessIPPRequest: 5 status_code=0
d [11/Jul/2004:19:02:34 -0400] ProcessIPPRequest: Adding fd 5 to
OutputSet...
D [11/Jul/2004:19:02:34 -0400] [Job 8] Page = 612x792; 18,36 to 594,783
D [11/Jul/2004:19:02:34 -0400] [Job 8] slowcollate=0, slowduplex=0,
sloworder=0
D [11/Jul/2004:19:02:34 -0400] [Job 8] 0 %%BoundingBox: 18 18 594 774
D [11/Jul/2004:19:02:34 -0400] [Job 8] 0 %%Creator: Mozilla PostScript
module (rv:1.6/0)
D [11/Jul/2004:19:02:34 -0400] [Job 8] 0 %%DocumentData: Clean8Bit
D [11/Jul/2004:19:02:34 -0400] [Job 8] 0 %%DocumentPaperSizes: Letter
D [11/Jul/2004:19:02:34 -0400] [Job 8] 0 %%Orientation: Portrait
D [11/Jul/2004:19:02:34 -0400] [Job 8] 0 %%Pages: (atend)
D [11/Jul/2004:19:02:34 -0400] [Job 8] 0 %%PageOrder: Ascend
D [11/Jul/2004:19:02:34 -0400] [Job 8] 0 %%EndComments
D [11/Jul/2004:19:02:34 -0400] [Job 8] 0 %%BeginProlog
D [11/Jul/2004:19:02:34 -0400] [Job 8]
/usr/lib/cups/filter/foomatic-rip: No such file or directory
d [11/Jul/2004:19:02:34 -0400] WriteClient: Removing fd 5 from
OutputSet...
D [11/Jul/2004:19:02:34 -0400] [Job 8] ptal-connect: connecting to
device "mlc:usb:photosmart_7200_series"...  DEBUG: 0 %%EndProlog
D [11/Jul/2004:19:02:34 -0400] [Job 8] 0 %%Page: 1 1
D [11/Jul/2004:19:02:34 -0400] [Job 8] 0 %%Page: 1 1
D [11/Jul/2004:19:02:34 -0400] [Job 8] pw = 576.0, pl = 747.0
D [11/Jul/2004:19:02:34 -0400] [Job 8] PageLeft = 18.0, PageRight =
594.0
D [11/Jul/2004:19:02:34 -0400] [Job 8] PageTop = 783.0, PageBottom =
36.0
D [11/Jul/2004:19:02:34 -0400] [Job 8] PageWidth = 612.0, PageLength =
792.0
D [11/Jul/2004:19:02:34 -0400] [Job 8] 0 %%BeginPageSetup
D [11/Jul/2004:19:02:34 -0400] [Job 8] 0 %%EndPageSetup
D [11/Jul/2004:19:02:34 -0400] [Job 8] 0 %%Trailer
D [11/Jul/2004:19:02:34 -0400] [Job 8] Saw Trailer!
D [11/Jul/2004:19:02:34 -0400] [Job 8] Saw EOF!
d [11/Jul/2004:19:02:34 -0400] PID 14942 exited with no errors.
E [11/Jul/2004:19:02:34 -0400] PID 14943 stopped with status 22!
D [11/Jul/2004:19:02:34 -0400] [Job 8] successful.
D [11/Jul/2004:19:02:34 -0400] UpdateJob: job 8, file 0 is complete.
d [11/Jul/2004:19:02:34 -0400] UpdateJob: Removing fd 7 from InputSet...
D [11/Jul/2004:19:02:34 -0400] CancelJob: id = 8
D [11/Jul/2004:19:02:34 -0400] StopJob: id = 8, force = 0
D [11/Jul/2004:19:02:34 -0400] StopJob: printer state is 3
d [11/Jul/2004:19:02:34 -0400] StopJob: Freeing status buffer...
d [11/Jul/2004:19:02:34 -0400] SaveJob: Closing file 7...
d [11/Jul/2004:19:02:34 -0400] SaveJob: Closing file 7...
d [11/Jul/2004:19:02:34 -0400] PID 14944 exited with no errors.
d [11/Jul/2004:19:02:34 -0400] ReadClient() 5, used=0
D [11/Jul/2004:19:02:34 -0400] CloseClient() 5


Thank you,
Bryan Taylor

ps
yes I have been to www.linuxprinting.org MANY times. :)
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <https://lists.cups.org/pipermail/cups/attachments/20040711/cab9b3ee/attachment-0001.html>

More information about the cups mailing list