[Bug 462048] New: Autodetected USB printer fails after first printjob
https://bugzilla.novell.com/show_bug.cgi?id=462048 User egrimminck@novell.com added comment https://bugzilla.novell.com/show_bug.cgi?id=462048#c1 Summary: Autodetected USB printer fails after first printjob Product: openSUSE 11.1 Version: Final Platform: HP OS/Version: openSUSE 11.1 Status: NEW Severity: Normal Priority: P5 - None Component: Printing AssignedTo: jsmeix@novell.com ReportedBy: egrimminck@novell.com QAContact: jsmeix@novell.com Found By: Customer Created an attachment (id=262301) --> (https://bugzilla.novell.com/attachment.cgi?id=262301) combined hp-check.log and cups-autodetect.log When connecting the Printer (USB) for the first time the following messages is displayed in the /var/log/messages: Dec 23 19:56:02 suse01 kernel: usb 6-2: new full speed USB device using uhci_hcd and address 21 Dec 23 19:56:02 suse01 kernel: usb 6-2: configuration #1 chosen from 1 choice Dec 23 19:56:02 suse01 kernel: usblp0: USB Bidirectional printer dev 21 if 0 alt 0 proto 2 vid 0x03F0 pid 0xB402 Dec 23 19:56:02 suse01 kernel: scsi14 : SCSI emulation for USB Mass Storage devices Dec 23 19:56:02 suse01 kernel: usb 6-2: New USB device found, idVendor=03f0, idProduct=b402 Dec 23 19:56:02 suse01 kernel: usb 6-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Dec 23 19:56:02 suse01 kernel: usb 6-2: Product: photosmart 7700 series Dec 23 19:56:02 suse01 kernel: usb 6-2: Manufacturer: hp Dec 23 19:56:02 suse01 kernel: usb 6-2: SerialNumber: MY4CH2K160U0 Dec 23 19:56:02 suse01 kernel: usb-storage: device found at 21 Dec 23 19:56:02 suse01 kernel: usb-storage: waiting for device to settle before scanning Dec 23 19:56:03 suse01 kernel: ppdev0: registered pardevice Dec 23 19:56:03 suse01 hp: io/hpmud/pp.c 627: unable to read device-id ret=-1 Dec 23 19:56:03 suse01 kernel: ppdev0: unregistered pardevice Dec 23 19:56:03 suse01 kernel: scsi 14:0:0:0: Direct-Access HP photosmart 7700 1.00 PQ: 0 ANSI: 2 Dec 23 19:56:03 suse01 kernel: sd 14:0:0:0: [sdc] Attached SCSI removable disk Dec 23 19:56:03 suse01 kernel: sd 14:0:0:0: Attached scsi generic sg4 type 0 Dec 23 19:56:03 suse01 kernel: usb-storage: device scan complete After that the first test-page prints without a problem: Dec 23 19:57:13 suse01 kernel: usblp0: removed Dec 23 19:57:14 suse01 hpijs: WARNING: color pen has low ink Dec 23 19:57:14 suse01 hpijs: STATE: marker-supply-low-warning However when I try to print a second page nothing is printed, the printer doesn't respond anymore and the following messages are displayed: Dec 23 19:58:59 suse01 hpijs: WARNING: color pen has low ink Dec 23 19:58:59 suse01 hpijs: STATE: marker-supply-low-warning Dec 23 19:59:31 suse01 kernel: usb 6-2: reset full speed USB device using uhci_hcd and address 21 Dec 23 19:59:44 suse01 photosmart_7700_series?serial=MY4CH2K160U0: io/hpmud/musb.c 1335: unable to write data hp:/usb/photosmart_7700_series?serial=MY4CH2K160U0: 45 second io timeout Dec 23 19:59:46 suse01 kernel: usb 6-2: device descriptor read/64, error -110 Dec 23 20:00:01 suse01 kernel: usb 6-2: device descriptor read/64, error -110 Dec 23 20:00:01 suse01 kernel: usb 6-2: reset full speed USB device using uhci_hcd and address 21 Dec 23 20:00:32 suse01 kernel: usb 6-2: device descriptor read/64, error -110 Dec 23 20:00:32 suse01 kernel: usb 6-2: reset full speed USB device using uhci_hcd and address 21 Dec 23 20:00:37 suse01 kernel: usb 6-2: device descriptor read/8, error -110 Dec 23 20:00:42 suse01 kernel: usb 6-2: device descriptor read/8, error -110 Dec 23 20:00:42 suse01 kernel: usb 6-2: reset full speed USB device using uhci_hcd and address 21 Dec 23 20:00:47 suse01 kernel: usb 6-2: device descriptor read/8, error -110 Dec 23 20:00:52 suse01 kernel: usb 6-2: device descriptor read/8, error -110 Dec 23 20:00:52 suse01 photosmart_7700_series?serial=MY4CH2K160U0: io/hpmud/musb.c 679: invalid deviceid wIndex=0, retrying wIndex=0: No such device Dec 23 20:00:52 suse01 kernel: usb 6-2: USB disconnect, address 21 Dec 23 20:00:52 suse01 kernel: sd 14:0:0:0: Device offlined - not ready after error recovery Dec 23 20:00:52 suse01 photosmart_7700_series?serial=MY4CH2K160U0: io/hpmud/musb.c 688: invalid deviceid retry ret=-19: No such device Dec 23 20:00:52 suse01 photosmart_7700_series?serial=MY4CH2K160U0: io/hpmud/musb.c 731: invalid device_status: No such device Dec 23 20:00:52 suse01 photosmart_7700_series?serial=MY4CH2K160U0: prnt/backend/hp.c 594: ERROR: 1015 other; will retry in 30 seconds... Dec 23 20:00:52 suse01 kernel: usb 6-2: new full speed USB device using uhci_hcd and address 22 Dec 23 20:00:53 suse01 kernel: usb 6-2: device descriptor read/64, error -71 Dec 23 20:00:53 suse01 kernel: usb 6-2: device descriptor read/64, error -71 Dec 23 20:00:53 suse01 kernel: usb 6-2: new full speed USB device using uhci_hcd and address 23 Dec 23 20:00:53 suse01 kernel: usb 6-2: device descriptor read/64, error -71 Dec 23 20:00:53 suse01 kernel: usb 6-2: device descriptor read/64, error -71 Dec 23 20:00:54 suse01 kernel: usb 6-2: new full speed USB device using uhci_hcd and address 24 Dec 23 20:00:54 suse01 kernel: usb 6-2: device not accepting address 24, error -71 Dec 23 20:00:54 suse01 kernel: usb 6-2: new full speed USB device using uhci_hcd and address 25 Dec 23 20:00:54 suse01 kernel: usb 6-2: device not accepting address 25, error -71 Dec 23 20:00:54 suse01 kernel: hub 6-0:1.0: unable to enumerate USB device on port 2 Dec 23 20:01:22 suse01 photosmart_7700_series?serial=MY4CH2K160U0: io/hpmud/musb.c 679: invalid deviceid wIndex=0, retrying wIndex=0: No such device Dec 23 20:01:22 suse01 photosmart_7700_series?serial=MY4CH2K160U0: io/hpmud/musb.c 688: invalid deviceid retry ret=-19: No such device Dec 23 20:01:22 suse01 photosmart_7700_series?serial=MY4CH2K160U0: io/hpmud/musb.c 731: invalid device_status: No such device Dec 23 20:01:22 suse01 photosmart_7700_series?serial=MY4CH2K160U0: prnt/backend/hp.c 594: ERROR: 1015 other; will retry in 30 seconds... Attached the cups-autoconfig.log file and a hp-check.log file combined in one file. -- Configure bugmail: https://bugzilla.novell.com/userprefs.cgi?tab=email ------- You are receiving this mail because: ------- You are on the CC list for the bug.
https://bugzilla.novell.com/show_bug.cgi?id=462048
Johannes Meixner
https://bugzilla.novell.com/show_bug.cgi?id=462048
User jsmeix@novell.com added comment
https://bugzilla.novell.com/show_bug.cgi?id=462048#c1
Johannes Meixner
https://bugzilla.novell.com/show_bug.cgi?id=462048
User egrimminck@novell.com added comment
https://bugzilla.novell.com/show_bug.cgi?id=462048#c2
--- Comment #2 from Edwin Grimminck
https://bugzilla.novell.com/show_bug.cgi?id=462048
User aorlovskyy@novell.com added comment
https://bugzilla.novell.com/show_bug.cgi?id=462048#c3
Alexander Orlovskyy
https://bugzilla.novell.com/show_bug.cgi?id=462048
User egrimminck@novell.com added comment
https://bugzilla.novell.com/show_bug.cgi?id=462048#c4
--- Comment #4 from Edwin Grimminck
https://bugzilla.novell.com/show_bug.cgi?id=462048
User aorlovskyy@novell.com added comment
https://bugzilla.novell.com/show_bug.cgi?id=462048#c5
Alexander Orlovskyy
https://bugzilla.novell.com/show_bug.cgi?id=462048
User aorlovskyy@novell.com added comment
https://bugzilla.novell.com/show_bug.cgi?id=462048#c6
Alexander Orlovskyy
https://bugzilla.novell.com/show_bug.cgi?id=462048
User gregkh@novell.com added comment
https://bugzilla.novell.com/show_bug.cgi?id=462048#c7
Greg Kroah-Hartman
https://bugzilla.novell.com/show_bug.cgi?id=462048
User bphilips@novell.com added comment
https://bugzilla.novell.com/show_bug.cgi?id=462048#c8
Brandon Philips
Brandon, is this the same thing that your USB printer had problem with?
My printer had the same symptoms- only printing one job. However, I wasn't getting resets or errors from the USB subsystem. It is possible that adding the same quirk to this device could clear up the issue. Perhaps userspace in 11.0 wasn't doing things like checking for low ink? -- Configure bugmail: https://bugzilla.novell.com/userprefs.cgi?tab=email ------- You are receiving this mail because: ------- You are on the CC list for the bug.
https://bugzilla.novell.com/show_bug.cgi?id=462048
User bphilips@novell.com added comment
https://bugzilla.novell.com/show_bug.cgi?id=462048#c9
Brandon Philips
https://bugzilla.novell.com/show_bug.cgi?id=462048
User bphilips@novell.com added comment
https://bugzilla.novell.com/show_bug.cgi?id=462048#c10
--- Comment #10 from Brandon Philips
https://bugzilla.novell.com/show_bug.cgi?id=462048
User egrimminck@novell.com added comment
https://bugzilla.novell.com/show_bug.cgi?id=462048#c11
--- Comment #11 from Edwin Grimminck
https://bugzilla.novell.com/show_bug.cgi?id=462048
User egrimminck@novell.com added comment
https://bugzilla.novell.com/show_bug.cgi?id=462048#c12
--- Comment #12 from Edwin Grimminck
https://bugzilla.novell.com/show_bug.cgi?id=462048
User bphilips@novell.com added comment
https://bugzilla.novell.com/show_bug.cgi?id=462048#c13
--- Comment #13 from Brandon Philips
ok, so I removed the pae kernel and installed the default one you send me and it seems to be working. I've been able to print several documents from different applications now.
Great. Before I submit this fix can you capture some debugging output for me? 1) Boot the PAE Kernel and run these commands as root. Then switch to a text editor like gedit and print a simple document that says "Hello". When the print job completes copy the text in the terminal and attach it as a comment on this bug. Then close the terminal and reboot. mount -t debugfs none_debugs /sys/kernel/debug modprobe usbmon export umonfile=$(lsusb | grep 03F0:B402 | cut -f2 -d" " | xargs printf /sys/kernel/debug/usbmon/%du) echo $umonfile cat $umonfile > /tmp/462048-`uname -r`.usbmon 2) Boot my debug Kernel and go through the same process you did with the PAE kernel in 1. Attach the output of the two commands and the /tmp/462048-*.usbmon files to this bug. Thanks! Brandon -- Configure bugmail: https://bugzilla.novell.com/userprefs.cgi?tab=email ------- You are receiving this mail because: ------- You are on the CC list for the bug.
https://bugzilla.novell.com/show_bug.cgi?id=462048
User egrimminck@novell.com added comment
https://bugzilla.novell.com/show_bug.cgi?id=462048#c14
--- Comment #14 from Edwin Grimminck
https://bugzilla.novell.com/show_bug.cgi?id=462048
User egrimminck@novell.com added comment
https://bugzilla.novell.com/show_bug.cgi?id=462048#c15
--- Comment #15 from Edwin Grimminck
https://bugzilla.novell.com/show_bug.cgi?id=462048
Brandon Philips
https://bugzilla.novell.com/show_bug.cgi?id=462048
User bphilips@novell.com added comment
https://bugzilla.novell.com/show_bug.cgi?id=462048#c16
--- Comment #16 from Brandon Philips
https://bugzilla.novell.com/show_bug.cgi?id=462048
User bphilips@novell.com added comment
https://bugzilla.novell.com/show_bug.cgi?id=462048#c17
Brandon Philips
https://bugzilla.novell.com/show_bug.cgi?id=462048
User egrimminck@novell.com added comment
https://bugzilla.novell.com/show_bug.cgi?id=462048#c18
Edwin Grimminck
https://bugzilla.novell.com/show_bug.cgi?id=462048
User egrimminck@novell.com added comment
https://bugzilla.novell.com/show_bug.cgi?id=462048#c19
Edwin Grimminck
https://bugzilla.novell.com/show_bug.cgi?id=462048
User bphilips@novell.com added comment
https://bugzilla.novell.com/show_bug.cgi?id=462048#c20
Brandon Philips
From Comment #18 logs I see:
Mar 18 17:11:50 suse01 hpijs: WARNING: color pen has low ink Mar 18 17:11:50 suse01 hpijs: STATE: marker-supply-low-warning Mar 18 17:12:30 suse01 hpijs: WARNING: color pen has low ink Mar 18 17:12:30 suse01 hpijs: STATE: marker-supply-low-warning Mar 18 17:13:02 suse01 kernel: usb 2-1: reset full speed USB device using uhci_hcd and address 2 Mar 18 17:13:15 suse01 photosmart_7700_series?serial=MY4CH2K160U0: io/hpmud/musb.c 1335: unable to write data hp:/usb/photosmart_7700_series?serial=MY4CH2K160U0: 45 second io timeout Mar 18 17:13:17 suse01 kernel: usb 2-1: device descriptor read/64, error -110 Mar 18 17:13:32 suse01 kernel: usb 2-1: device descriptor read/64, error -110 Mar 18 17:13:33 suse01 kernel: usb 2-1: reset full speed USB device using uhci_hcd and address 2
From Comment #19 logs (which includes my Kernel patch) I see:
Mar 18 17:21:29 suse01 kernel: usblp0: Disabling reads from problematic bidirectional printer .. Mar 18 17:22:08 suse01 kernel: usblp0: removed Mar 18 17:22:09 suse01 hpijs: WARNING: color pen has low ink Mar 18 17:22:09 suse01 hpijs: STATE: marker-supply-low-warning Mar 18 17:22:41 suse01 kernel: usb 2-1: reset full speed USB device using uhci_hcd and address 2 Mar 18 17:22:55 suse01 photosmart_7700_series?serial=MY4CH2K160U0: io/hpmud/musb.c 1335: unable to write data hp:/usb/photosmart_7700_series?serial=MY4CH2K160U0: 45 second io timeout Mar 18 17:22:56 suse01 kernel: usb 2-1: device descriptor read/64, error -110 Mar 18 17:23:11 suse01 kernel: usb 2-1: device descriptor read/64, error -110 Since this seems to be happening from user space via hpijs could you suggest some debugging steps? I filed a bug upstream with HPLIP, perhaps they have an idea. https://bugs.launchpad.net/hplip/+bug/344571 Cheers, Brandon -- Configure bugmail: https://bugzilla.novell.com/userprefs.cgi?tab=email ------- You are receiving this mail because: ------- You are on the CC list for the bug.
https://bugzilla.novell.com/show_bug.cgi?id=462048
User bphilips@novell.com added comment
https://bugzilla.novell.com/show_bug.cgi?id=462048#c21
Brandon Philips
It seems like hpijs may be sending the printer something it doesn't like causing the USB side of the device to stop responding.
Since this seems to be happening from user space via hpijs could you suggest some debugging steps?
Sorry for not being clear. Johannes, could you suggest some debugging steps for Edwin to try? Thanks, Brandon -- Configure bugmail: https://bugzilla.novell.com/userprefs.cgi?tab=email ------- You are receiving this mail because: ------- You are on the CC list for the bug.
https://bugzilla.novell.com/show_bug.cgi?id=462048
User jsmeix@novell.com added comment
https://bugzilla.novell.com/show_bug.cgi?id=462048#c22
Johannes Meixner
https://bugzilla.novell.com/show_bug.cgi?id=462048
User jsmeix@novell.com added comment
https://bugzilla.novell.com/show_bug.cgi?id=462048#c23
--- Comment #23 from Johannes Meixner
https://bugzilla.novell.com/show_bug.cgi?id=462048
User egrimminck@novell.com added comment
https://bugzilla.novell.com/show_bug.cgi?id=462048#c24
--- Comment #24 from Edwin Grimminck
https://bugzilla.novell.com/show_bug.cgi?id=462048
User bphilips@novell.com added comment
https://bugzilla.novell.com/show_bug.cgi?id=462048#c25
Brandon Philips
https://bugzilla.novell.com/show_bug.cgi?id=462048
User jsmeix@novell.com added comment
https://bugzilla.novell.com/show_bug.cgi?id=462048#c26
Johannes Meixner
https://bugzilla.novell.com/show_bug.cgi?id=462048
User jsmeix@novell.com added comment
https://bugzilla.novell.com/show_bug.cgi?id=462048#c27
Johannes Meixner
participants (1)
-
bugzilla_noreply@novell.com