You are not logged in.
Hi,
I'm running an up-to-date Arch Linux with its latest official kernel, 4.18.5-arch1-1-ARCH.
Current CUPS version is 2.2.8-3.
My HP LaserJet Professional P1102 printer used to work with no problems at all with foo2zjs drivers (foo2zjs-nightly from the AUR) until about 1 month ago. Now when I try and print anything I get a new job stating "sending data to the printer", but nothing gets printed, although the activity led on the printer starts to blink as it does when it prints. Job status states "sending data to the printer" until I cancel the job; even after this, printer's activity led continues blinking until I turn the printer off.
The printer does work without problems with hplip and hplip-plugin 3.18.6 (which were not installed during the tests I report here).
I can't tell for sure which package upgrade caused it to stop working, anyway here are the relevant lines from /var/log/pacman.log (everything cups related and kernel related since about 1 month ago --- there's nothing foo2zjs related since many months, so foo2zjs should not be the problem here)...
[2018-07-23 07:30] [ALPM] upgraded cups-filters (1.20.3-2 -> 1.20.4-1)
[2018-08-12 08:39] [ALPM] upgraded cups-filters (1.20.4-1 -> 1.20.4-2)
[2018-08-24 16:12] [ALPM] upgraded cups-filters (1.20.4-2 -> 1.21.0-1)
[2018-08-27 00:30] [ALPM] upgraded cups-filters (1.21.0-1 -> 1.21.1-1)
[2018-07-23 07:30] [ALPM] upgraded linux (4.17.5-1 -> 4.17.8-1)
[2018-08-12 08:40] [ALPM] upgraded linux (4.17.8-1 -> 4.17.14.arch1-1)
[2018-08-18 19:09] [ALPM] upgraded linux (4.17.14.arch1-1 -> 4.18.1.arch1-1)
[2018-08-24 16:12] [ALPM] upgraded linux (4.18.1.arch1-1 -> 4.18.4.arch1-1)
[2018-08-27 00:30] [ALPM] upgraded linux (4.18.4.arch1-1 -> 4.18.5.arch1-1)
Here is what I get from system log when starting cups, turning the printer on, trying and print the test page...
ago 27 05:39:52 gargantua systemd[1]: Starting CUPS Scheduler...
ago 27 05:39:52 gargantua colord[453]: failed to get session [pid 7588]: Nessun dato disponibile
ago 27 05:39:52 gargantua dbus-daemon[419]: [system] Activating via systemd: service name='org.freedesktop.Avahi' unit='dbus-org.freedesktop.Avahi.service' requested by ':1.365' (uid=0 pid=7588 comm="/usr/bin/cupsd -l ")
ago 27 05:39:52 gargantua dbus-daemon[419]: [system] Activation via systemd failed for unit 'dbus-org.freedesktop.Avahi.service': Unit dbus-org.freedesktop.Avahi.service not found.
ago 27 05:39:52 gargantua systemd[1]: Started CUPS Scheduler.
ago 27 05:40:27 gargantua kernel: usb 1-8: new high-speed USB device number 5 using xhci_hcd
ago 27 05:40:27 gargantua kernel: usb 1-8: New USB device found, idVendor=03f0, idProduct=002a, bcdDevice= 1.00
ago 27 05:40:27 gargantua kernel: usb 1-8: New USB device strings: Mfr=1, Product=2, SerialNumber=3
ago 27 05:40:27 gargantua kernel: usb 1-8: Product: HP LaserJet Professional P1102
ago 27 05:40:27 gargantua kernel: usb 1-8: Manufacturer: Hewlett-Packard
ago 27 05:40:27 gargantua kernel: usb 1-8: SerialNumber: 000000000Q87FWBPSI1c
ago 27 05:40:27 gargantua kernel: usb-storage 1-8:1.0: USB Mass Storage device detected
ago 27 05:40:27 gargantua kernel: scsi host6: usb-storage 1-8:1.0
ago 27 05:40:27 gargantua upowerd[730]: unhandled action 'bind' on /sys/devices/pci0000:00/0000:00:14.0/usb1/1-8/1-8:1.0
ago 27 05:40:27 gargantua upowerd[730]: unhandled action 'bind' on /sys/devices/pci0000:00/0000:00:14.0/usb1/1-8
ago 27 05:40:28 gargantua kernel: usb 1-8: USB disconnect, device number 5
ago 27 05:40:29 gargantua upowerd[730]: unhandled action 'unbind' on /sys/devices/pci0000:00/0000:00:14.0/usb1/1-8/1-8:1.0
ago 27 05:40:29 gargantua upowerd[730]: unhandled action 'unbind' on /sys/devices/pci0000:00/0000:00:14.0/usb1/1-8
ago 27 05:40:29 gargantua kernel: usb 1-8: new high-speed USB device number 6 using xhci_hcd
ago 27 05:40:29 gargantua kernel: usb 1-8: New USB device found, idVendor=03f0, idProduct=002a, bcdDevice= 1.00
ago 27 05:40:29 gargantua kernel: usb 1-8: New USB device strings: Mfr=1, Product=2, SerialNumber=3
ago 27 05:40:29 gargantua kernel: usb 1-8: Product: HP LaserJet Professional P1102
ago 27 05:40:29 gargantua kernel: usb 1-8: Manufacturer: Hewlett-Packard
ago 27 05:40:29 gargantua kernel: usb 1-8: SerialNumber: 000000000Q87FWBPPR1a
ago 27 05:40:29 gargantua kernel: usblp 1-8:1.0: usblp1: USB Bidirectional printer dev 6 if 0 alt 0 proto 2 vid 0x03F0 pid 0x002A
ago 27 05:40:29 gargantua upowerd[730]: unhandled action 'bind' on /sys/devices/pci0000:00/0000:00:14.0/usb1/1-8/1-8:1.0
ago 27 05:40:29 gargantua upowerd[730]: unhandled action 'bind' on /sys/devices/pci0000:00/0000:00:14.0/usb1/1-8
ago 27 05:40:56 gargantua kernel: usblp1: removed
ago 27 05:40:56 gargantua upowerd[730]: unhandled action 'unbind' on /sys/devices/pci0000:00/0000:00:14.0/usb1/1-8/1-8:1.0
ago 27 05:40:56 gargantua upowerd[730]: unhandled action 'bind' on /sys/devices/pci0000:00/0000:00:14.0/usb1/1-8/1-8:1.0
ago 27 05:40:56 gargantua foo2zjs-wrapper[7630]: foo2zjs-wrapper -z2 -P -L0 -r1200x600 -p9 -T3 -m1 -s7 -n1
ago 27 05:40:56 gargantua foo2zjs-wrapper[7642]: gs -sPAPERSIZE=a4 -g9920x7016 -r1200x600 -sDEVICE=pbmraw -dCOLORSCREEN -dMaxBitmap=500000000
ago 27 05:40:56 gargantua foo2zjs-wrapper[7643]: foo2zjs -r1200x600 -g9920x7016 -p9 -m1 -n1 -d1 -s7 -z2 -u 192x96 -l 192x96 -L 0 -T3 -P
ago 27 05:42:18 gargantua upowerd[730]: unhandled action 'unbind' on /sys/devices/pci0000:00/0000:00:14.0/usb1/1-8/1-8:1.0
Is it normal that as soon as a job is started I get that "usblp1: removed" line?
And here is what I get from /var/log/cups/error_log (debug level): https://pastebin.com/ew32Swby
Kind regards
Last edited by pezcurrel (2018-10-08 20:42:39)
Offline
So, the printer works fine with packages from the official repos, but not with those from AUR?
Moving to AUR Issues.
Offline
So, the printer works fine with packages from the official repos, but not with those from AUR?
No, it doesn't work with packages from the official repos, it used to work with foo2zjs-nightly (AUR) and now it only works with hplip (official repos) but requires hplip-plugin (AUR) too.
Moving to AUR Issues.
It makes sense you moved the post to AUR Issues, but I posted to Kernel & Hardware since I suspect it could be a usb kernel related problem.
(Seems to be the same problem reported here: https://bbs.archlinux.org/viewtopic.php?id=239657 )
Offline
I suspect that the "usblp1: removed" is normal - see also the wiki article on usblp conflicts. Since this is a regression, you could try downgrading packages (maybe the kernel, the other thread mentioned ghostscript) to versions at the time of the last successful print.
Offline
I suspect that the "usblp1: removed" is normal - see also the wiki article on usblp conflicts.
Yes, I tried blacklisting usblp and the message disappeared, but nothing changed, still same problem.
Since this is a regression, you could try downgrading packages (maybe the kernel, the other thread mentioned ghostscript) to versions at the time of the last successful print.
I tried downgrading ghostscript, cups, libcups, cups-filters, poppler, but to no avail.
I managed to make the printer work from the terminal, maybe this could help someone further understand the problem, I posted about this in the other thread ( https://bbs.archlinux.org/viewtopic.php … 3#p1805683 ).
Offline
Hi guys,
Same issue for me with an up to date archinux system.
For anything I try to print the printer uses 2 pages, and prints nothing on the first page, and exactly the following lines on the second one :
ERROR:
undefined
OFFENDING COMMAND:
currentcolortransfe
STACK:
-mark-
-mark-
-mark-
-mark-
Feel free to ask me more logs if it can help.
Offline
I opened a bug report here: https://github.com/OpenPrinting/cups-filters/issues/58
Seems to be a glibc issue.
Offline
Seems fixed now, recent upgrade to cups-filters 1.21.3-1 solved the issue here.
Offline