Bug 2266609

Summary: [regression libcupsfilters-2.0.0-6.fc39] "Print job canceled at printer" on Epson L3160 driverless
Product: [Fedora] Fedora Reporter: Kamil Páral (Red Hat) <kparal>
Component: libcupsfiltersAssignee: Zdenek Dohnal <zdohnal>
Status: CLOSED ERRATA QA Contact:
Severity: unspecified Docs Contact:
Priority: unspecified    
Version: 39CC: zdohnal
Target Milestone: ---   
Target Release: ---   
Hardware: Unspecified   
OS: Unspecified   
Whiteboard:
Fixed In Version: libcupsfilters-2.0.0-7.fc38 libcupsfilters-2.0.0-7.fc39 libcupsfilters-2.0.0-7.fc40 Doc Type: If docs needed, set a value
Doc Text:
Story Points: ---
Clone Of: Environment:
Last Closed: 2024-03-20 01:55:39 UTC Type: Bug
Regression: --- Mount Type: ---
Documentation: --- CRM:
Verified Versions: Category: ---
oVirt Team: --- RHEL 7.3 requirements from Atomic Host:
Cloudforms Team: --- Target Upstream Version:
Embargoed:
Attachments:
Description Flags
libcupsfilters-2.0.0-2_cups_whole_log.txt
none
libcupsfilters-2.0.0-2_ipptool.attr
none
libcupsfilters-2.0.0-6_cups_whole_log.txt
none
libcupsfilters-2.0.0-6_ipptool.attr none

Description Kamil Páral (Red Hat) 2024-02-28 14:14:12 UTC 
Description of problem:
With libcupsfilters-2.0.0-6.fc39 I can no longer use my Epson L3160 network printer in driverless mode. Every time I try to print, I see these errors:

Feb 28 15:08:29 fedoratest cupsd[4907]: REQUEST localhost - - "POST / HTTP/1.1" 200 342 Create-Printer-Subscriptions successful-ok
Feb 28 15:08:31 fedoratest cupsd[4907]: REQUEST localhost - - "POST / HTTP/1.1" 200 3406092 CUPS-Get-PPDs -
Feb 28 15:08:32 fedoratest cupsd[4907]: REQUEST localhost - - "POST / HTTP/1.1" 200 150 Cancel-Subscription successful-ok
Feb 28 15:08:41 fedoratest cupsd[4907]: REQUEST localhost - - "POST / HTTP/1.1" 200 249 CUPS-Create-Local-Printer successful-ok
Feb 28 15:08:49 fedoratest cupsd[4907]: REQUEST localhost - - "POST /printers/EPSON_L3160_Series HTTP/1.1" 200 4162 Print-Job successful-ok
Feb 28 15:08:52 fedoratest cupsd[4907]: [Job 13] Print job canceled at printer.
Feb 28 15:08:52 fedoratest cupsd[4907]: EPSON_L3160_Series qa 13 [28/Feb/2024:15:08:52 +0100] total 1 - localhost gnome-text-editor job #6 - -
Feb 28 15:08:52 fedoratest cupsd[4907]: [Job 13] Backend ipp returned status 5 (cancel job)


With previous libcupsfilters-2.0.0-2.fc39.x86_64 printing works OK, here's the log:

Feb 28 14:59:56 fedoratest cupsd[4477]: REQUEST localhost - - "POST / HTTP/1.1" 200 150 Cancel-Subscription successful-ok
Feb 28 14:59:57 fedoratest cupsd[4477]: REQUEST localhost - - "POST / HTTP/1.1" 200 342 Create-Printer-Subscriptions successful-ok
Feb 28 14:59:59 fedoratest cupsd[4477]: REQUEST localhost - - "POST / HTTP/1.1" 200 3406092 CUPS-Get-PPDs -
Feb 28 15:00:04 fedoratest cupsd[4477]: REQUEST localhost - - "POST / HTTP/1.1" 200 249 CUPS-Create-Local-Printer successful-ok
Feb 28 15:00:12 fedoratest cupsd[4477]: REQUEST localhost - - "POST /printers/EPSON_L3160_Series HTTP/1.1" 200 4161 Print-Job successful-ok
Feb 28 15:00:21 fedoratest cupsd[4477]: EPSON_L3160_Series qa 12 [28/Feb/2024:15:00:21 +0100] total 1 - localhost gnome-text-editor job #5 - -
Feb 28 15:01:37 fedoratest cupsd[4477]: REQUEST localhost - - "POST / HTTP/1.1" 200 150 Cancel-Subscription successful-ok


This was tested on a completely clean F39 Workstation installation, to make sure my local configuration isn't affecting it in any way. In a default installation, without any configuration, I can open gnome-control-center -> Printers and see my printer. Then open gnome-text-editor, input a few characters and print it, it works fine. Once I update libcupsfilters to 2.0.0-6 and restart cups.service or reboot, I can still see the printer, but printing no longer works with the error message shown above.


Version-Release number of selected component (if applicable):
libcupsfilters-2.0.0-6.fc39  # broken
libcupsfilters-2.0.0-2.fc39  # works fine


How reproducible:
always

Steps to Reproduce:
1. clean install of F39 Workstation
2. open gnome-text-editor, input a few characters, open the print dialog
3. select my printer, it shows up fine
4. try to print
5. no visual error, but "Print job canceled at printer" in system journal
Comment 1 Zdenek Dohnal 2024-02-28 15:56:04 UTC 
Hi Kamil,

thank you for reporting the issue!

Can you upload information from https://docs.fedoraproject.org/en-US/quick-docs/cups-debug-printing-issues/#_my_printer_doesnt_print_correctly_i_use_everywhere_model for libcupsfilters-2.0.0-6 and libcupsfilters-2.0.0-2?

There was fix for b&w printing - if AirPrint was used for generating PPD for b&w printer, colored file was created, so when sent to b&w printer, the job gets cancelled. It might cause regression.
Comment 2 Kamil Páral (Red Hat) 2024-03-01 09:29:24 UTC 
Created attachment 2019560 [details]
libcupsfilters-2.0.0-2_cups_whole_log.txt
Comment 3 Kamil Páral (Red Hat) 2024-03-01 09:29:27 UTC 
Created attachment 2019561 [details]
libcupsfilters-2.0.0-2_ipptool.attr
Comment 4 Kamil Páral (Red Hat) 2024-03-01 09:29:30 UTC 
Created attachment 2019562 [details]
libcupsfilters-2.0.0-6_cups_whole_log.txt
Comment 5 Kamil Páral (Red Hat) 2024-03-01 09:29:33 UTC 
Created attachment 2019563 [details]
libcupsfilters-2.0.0-6_ipptool.attr
Comment 6 Kamil Páral (Red Hat) 2024-03-01 09:31:03 UTC 
Hi Zdeněk, please see the files above. Thanks!
Comment 7 Zdenek Dohnal 2024-03-04 11:37:16 UTC 
libcupsfilters-2.0.0-6:
cfFilterGhostscript: Ghostscript command line: gs -dQUIET -dSAFER -dNOPAUSE -dBATCH -dNOINTERPOLATE -dNOMEDIAATTRS -dUsePDFX3Profile -sstdout=%stderr -sOutputFile=%stdout -sDEVICE=appleraster -sMediaType=Stationery -sOutputType=automatic -r360x360 -dDEVICEWIDTHPOINTS=595 -dDEVICEHEIGHTPOINTS=842 -dcupsBitsPerColor=8 -dcupsColorOrder=0 -dcupsColorSpace=1 -dcupsBorderlessScalingFactor=0.0000 -dcupsInteger1=1 -dcupsInteger2=1 -dcupsInteger8=4 -scupsRenderingIntent=auto -scupsPageSizeName=A4 -dcupsManualCopies -I/usr/share/cups/fonts -c -f -_

libcupsfilters-2.0.0-2:
cfFilterGhostscript: Ghostscript command line: gs -dQUIET -dSAFER -dNOPAUSE -dBATCH -dNOINTERPOLATE -dNOMEDIAATTRS -dUsePDFX3Profile -sstdout=%stderr -sOutputFile=%stdout -sDEVICE=appleraster -sMediaType=Stationery -sOutputType=automatic -r360x360 -dDEVICEWIDTHPOINTS=595 -dDEVICEHEIGHTPOINTS=842 -dcupsBitsPerColor=8 -dcupsColorOrder=0 -dcupsColorSpace=19 -dcupsBorderlessScalingFactor=0.0000 -dcupsInteger1=1 -dcupsInteger2=1 -dcupsInteger8=4 -scupsRenderingIntent=auto -scupsPageSizeName=A4 -dcupsManualCopies -I/usr/share/cups/fonts -sOutputICCProfile=srgb.icc -c -f -_

The difference is:

-dcupsColorSpace=19 => -dcupsColorSpace=1
-sOutputICCProfile=srgb.icc => ''

The printing options look the same:

-6:
[Job 17] argv[5]="ColorModel=RGB OutputBin=FaceUp number-up-layout=lrtb number-up=1 MediaType=Stationery Collate PageSize=A4 cupsPrintQuality=Normal job-uuid=urn:uuid:92407cac-d618-3bab-7957-ab261aad10e9 job-originating-host-name=localhost date-time-at-creation= date-time-at-processing= time-at-creation=1709284533 time-at-processing=1709284533 print-quality=4"

-2:
[Job 18] argv[5]="ColorModel=RGB OutputBin=FaceUp number-up-layout=lrtb number-up=1 MediaType=Stationery Collate PageSize=A4 cupsPrintQuality=Normal job-uuid=urn:uuid:caecf777-5322-31f2-4314-5e4720ee0480 job-originating-host-name=localhost date-time-at-creation= date-time-at-processing= time-at-creation=1709285087 time-at-processing=1709285087 print-quality=4"

So I'll look into color logic which was changed by latest upstream patches.
Comment 8 Zdenek Dohnal 2024-03-04 17:23:55 UTC 
https://github.com/OpenPrinting/libcupsfilters/pull/51
Comment 9 Fedora Update System 2024-03-11 14:38:53 UTC 
FEDORA-2024-8a6413f4d3 (libcupsfilters-2.0.0-7.fc40) has been submitted as an update to Fedora 40.
https://bodhi.fedoraproject.org/updates/FEDORA-2024-8a6413f4d3
Comment 10 Fedora Update System 2024-03-11 14:50:28 UTC 
FEDORA-2024-1cda3d1796 (libcupsfilters-2.0.0-7.fc39) has been submitted as an update to Fedora 39.
https://bodhi.fedoraproject.org/updates/FEDORA-2024-1cda3d1796
Comment 11 Fedora Update System 2024-03-11 15:02:16 UTC 
FEDORA-2024-5d5c869c7b (libcupsfilters-2.0.0-7.fc38) has been submitted as an update to Fedora 38.
https://bodhi.fedoraproject.org/updates/FEDORA-2024-5d5c869c7b
Comment 12 Kamil Páral (Red Hat) 2024-03-11 15:35:26 UTC 
This fixes printing on my Epson L3160, thanks!
Comment 13 Fedora Update System 2024-03-12 02:18:59 UTC 
FEDORA-2024-8a6413f4d3 has been pushed to the Fedora 40 testing repository.
Soon you'll be able to install the update with the following command:
`sudo dnf upgrade --enablerepo=updates-testing --refresh --advisory=FEDORA-2024-8a6413f4d3`
You can provide feedback for this update here: https://bodhi.fedoraproject.org/updates/FEDORA-2024-8a6413f4d3

See also https://fedoraproject.org/wiki/QA:Updates_Testing for more information on how to test updates.
Comment 14 Fedora Update System 2024-03-12 03:01:56 UTC 
FEDORA-2024-1cda3d1796 has been pushed to the Fedora 39 testing repository.
Soon you'll be able to install the update with the following command:
`sudo dnf upgrade --enablerepo=updates-testing --refresh --advisory=FEDORA-2024-1cda3d1796`
You can provide feedback for this update here: https://bodhi.fedoraproject.org/updates/FEDORA-2024-1cda3d1796

See also https://fedoraproject.org/wiki/QA:Updates_Testing for more information on how to test updates.
Comment 15 Fedora Update System 2024-03-12 03:59:29 UTC 
FEDORA-2024-5d5c869c7b has been pushed to the Fedora 38 testing repository.
Soon you'll be able to install the update with the following command:
`sudo dnf upgrade --enablerepo=updates-testing --refresh --advisory=FEDORA-2024-5d5c869c7b`
You can provide feedback for this update here: https://bodhi.fedoraproject.org/updates/FEDORA-2024-5d5c869c7b

See also https://fedoraproject.org/wiki/QA:Updates_Testing for more information on how to test updates.
Comment 16 Fedora Update System 2024-03-20 01:55:39 UTC 
FEDORA-2024-5d5c869c7b (libcupsfilters-2.0.0-7.fc38) has been pushed to the Fedora 38 stable repository.
If problem still persists, please make note of it in this bug report.
Comment 17 Fedora Update System 2024-03-20 02:04:04 UTC 
FEDORA-2024-1cda3d1796 (libcupsfilters-2.0.0-7.fc39) has been pushed to the Fedora 39 stable repository.
If problem still persists, please make note of it in this bug report.
Comment 18 Fedora Update System 2024-03-23 00:33:51 UTC 
FEDORA-2024-8a6413f4d3 (libcupsfilters-2.0.0-7.fc40) has been pushed to the Fedora 40 stable repository.
If problem still persists, please make note of it in this bug report.