Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

Printing impossible after disconnect at wrong time #72

Open
Xerxekyran opened this issue Oct 31, 2023 · 14 comments
Open

Printing impossible after disconnect at wrong time #72

Xerxekyran opened this issue Oct 31, 2023 · 14 comments

Comments

@Xerxekyran
Copy link

Hi there,

I am facing an issue where printing is not possible anymore until I restart the printer. When I try to print something and disconnect the USB-connection during this process (when I see the "! USB[1]: zero-size read" log entries in the IPP-USB printer log) then sometimes the printer initialization of IPP-USB gets stuck in an endless initilization loop. Re-connecting the printer or even restarting IPP-USB does not help. Only shutting down the printer and starting it up again. I know that this is not just a problem of this one printer (HP OfficeJet 200 Mobile Series), but also for example a Brother printer acted like this.
Is there a way of getting more information about what the actual problem is? Here are my logs for this situation:

// printing process:
31-10-2023 08:38:13: ! USB[1]: zero-size read
31-10-2023 08:38:14: ! USB[0]: zero-size read
31-10-2023 08:38:14: ! USB[1]: zero-size read
31-10-2023 08:38:14: ! USB[0]: zero-size read
31-10-2023 08:38:14: ! USB[1]: zero-size read
31-10-2023 08:38:15: ! USB[1]: zero-size read
31-10-2023 08:38:15: ! USB[1]: zero-size read

// disconnecting USB (the printer still has power but is not connected anymore)
31-10-2023 08:38:16: - DNS-SD: HP OfficeJet 200 Mobile Series [17EF3C] (USB): removed
31-10-2023 08:38:16: ! HTTP[155]: read tcp 127.0.0.1:60000->127.0.0.1:44058: use of closed network connection
31-10-2023 08:38:16: ! HTTP[155]: read tcp 127.0.0.1:60000->127.0.0.1:44058: use of closed network connection
31-10-2023 08:38:16: - Bus 003 Device 011: removed OfficeJet 200 Mobile Series
31-10-2023 08:38:29: + Bus 003 Device 012: added OfficeJet 200 Mobile Series

// and the loop begins
31-10-2023 08:38:35: ! USB[0]: send: libusb_bulk_transfer: Operation timed out
31-10-2023 08:38:35: ! HTTP[158]: libusb_bulk_transfer: Operation timed out
31-10-2023 08:38:35: ! IPP: HTTP: Post "http://localhost:60000/ipp/print": libusb_bulk_transfer: Operation timed out
31-10-2023 08:38:35: - Bus 003 Device 012: resetting OfficeJet 200 Mobile Series
31-10-2023 08:38:35: - Bus 003 Device 012: removed OfficeJet 200 Mobile Series
31-10-2023 08:38:37: + Bus 003 Device 012: added OfficeJet 200 Mobile Series
31-10-2023 08:38:38: ! HTTP[160]: ipp-usb is not ready for this device
31-10-2023 08:38:38: ! HTTP[161]: ipp-usb is not ready for this device
31-10-2023 08:38:39: ! HTTP[162]: ipp-usb is not ready for this device
31-10-2023 08:38:39: ! HTTP[163]: ipp-usb is not ready for this device
31-10-2023 08:38:40: ! HTTP[164]: ipp-usb is not ready for this device
31-10-2023 08:38:40: ! HTTP[165]: ipp-usb is not ready for this device
31-10-2023 08:38:42: ! HTTP[166]: ipp-usb is not ready for this device
31-10-2023 08:38:42: ! HTTP[167]: ipp-usb is not ready for this device
31-10-2023 08:38:42: ! USB[0]: send: libusb_bulk_transfer: Operation timed out
31-10-2023 08:38:42: ! HTTP[159]: libusb_bulk_transfer: Operation timed out
31-10-2023 08:38:42: ! IPP: HTTP: Post "http://localhost:60000/ipp/print": libusb_bulk_transfer: Operation timed out
31-10-2023 08:38:42: - Bus 003 Device 012: resetting OfficeJet 200 Mobile Series
31-10-2023 08:38:43: - Bus 003 Device 012: removed OfficeJet 200 Mobile Series
31-10-2023 08:38:45: + Bus 003 Device 012: added OfficeJet 200 Mobile Series

Thank you for any help on this topic.

Regards
Lars
@Xerxekyran
Copy link
Author

I set the IPP-USB logs to debug to get some more information here:

// printing file 
31-10-2023 09:50:10: ! USB[1]: zero-size read
31-10-2023 09:50:10: < HTTP[014]: POST http://localhost:60000/ipp/print - 200 OK
31-10-2023 09:50:10: < HTTP[014]: response body: got 1440 bytes; EOF
31-10-2023 09:50:10:   USB[1]: connection released, 1 in use: a-- ---
31-10-2023 09:50:10: > HTTP[015]: POST http://localhost:60000/ipp/print
31-10-2023 09:50:10: > HTTP[015]: request body: got 334 bytes; EOF
31-10-2023 09:50:10: > HTTP[015]: body is small (334 bytes), prefetched before sending
31-10-2023 09:50:10:   USB[1]: connection allocated, 2 in use: a-- a--
31-10-2023 09:50:10:   HTTP[015]: connection 1 allocated
31-10-2023 09:50:10: ! USB[1]: zero-size read
31-10-2023 09:50:10: < HTTP[015]: POST http://localhost:60000/ipp/print - 200 OK
31-10-2023 09:50:10: < HTTP[015]: response body: got 285 bytes; EOF
31-10-2023 09:50:10:   USB[1]: connection released, 1 in use: a-- ---
31-10-2023 09:50:11: > HTTP[016]: POST http://localhost:60000/ipp/print
31-10-2023 09:50:11: > HTTP[016]: request body: got 740 bytes; EOF
31-10-2023 09:50:11: > HTTP[016]: body is small (740 bytes), prefetched before sending
31-10-2023 09:50:11:   USB[1]: connection allocated, 2 in use: a-- a--
31-10-2023 09:50:11:   HTTP[016]: connection 1 allocated
31-10-2023 09:50:11: ! USB[1]: zero-size read

// printer cable disconnected
31-10-2023 09:50:11: ! USB[1]: recv: libusb_bulk_transfer: Input/Output Error
31-10-2023 09:50:11: ! HTTP[016]: libusb_bulk_transfer: Input/Output Error
31-10-2023 09:50:11:   USB[1]: connection released, 1 in use: a-- ---
31-10-2023 09:50:11: > HTTP[016]: POST http://localhost:60000/ipp/print
31-10-2023 09:50:11: ! HTTP[016]: libusb_bulk_transfer: Input/Output Error
31-10-2023 09:50:11: > HTTP[017]: POST http://localhost:60000/ipp/print
31-10-2023 09:50:11: > HTTP[017]: request body: got 334 bytes; EOF
31-10-2023 09:50:11: > HTTP[017]: body is small (334 bytes), prefetched before sending
31-10-2023 09:50:11:   USB[1]: connection allocated, 2 in use: a-- a--
31-10-2023 09:50:11:   HTTP[017]: connection 1 allocated
31-10-2023 09:50:11: ! USB[1]: send: libusb_bulk_transfer: Input/Output Error
31-10-2023 09:50:11: ! HTTP[017]: libusb_bulk_transfer: Input/Output Error
31-10-2023 09:50:11:   USB[1]: connection released, 1 in use: a-- ---
31-10-2023 09:50:11: > HTTP[017]: POST http://localhost:60000/ipp/print
31-10-2023 09:50:11: ! HTTP[017]: libusb_bulk_transfer: Input/Output Error
31-10-2023 09:50:11: - DNS-SD: HP OfficeJet 200 Mobile Series [17EF3C] (USB): removed
31-10-2023 09:50:11: > HTTP[013]: request body: got 238 bytes; read tcp 127.0.0.1:60000->127.0.0.1:54250: use of closed network connection
31-10-2023 09:50:11: ! HTTP[013]: read tcp 127.0.0.1:60000->127.0.0.1:54250: use of closed network connection
31-10-2023 09:50:11:   USB[0]: connection released, 0 in use: --- ---
31-10-2023 09:50:11: > HTTP[013]: POST http://localhost:60000/ipp/print
31-10-2023 09:50:11: ! HTTP[013]: read tcp 127.0.0.1:60000->127.0.0.1:54250: use of closed network connection
31-10-2023 09:50:11:   USB[0]: closed
31-10-2023 09:50:11:   USB[1]: closed
31-10-2023 09:50:11: - Bus 003 Device 003: removed OfficeJet 200 Mobile Series

// printer connected again
31-10-2023 09:50:21:
31-10-2023 09:50:21:   ===============================
31-10-2023 09:50:21: + Bus 003 Device 004: added OfficeJet 200 Mobile Series
31-10-2023 09:50:21:   Device info:
31-10-2023 09:50:21:     Ident:         03f0-e711-TH9BQ850DD0689-HP-OfficeJet-200-Mobile-Series
31-10-2023 09:50:21:     Manufacturer:  HP
31-10-2023 09:50:21:     Product:       OfficeJet 200 Mobile Series
31-10-2023 09:50:21:     SerialNumber:  TH9BQ850DD0689
31-10-2023 09:50:21:     MfgAndProduct: HP OfficeJet 200 Mobile Series
31-10-2023 09:50:21:     BasicCaps:     print,scan,fax,http
31-10-2023 09:50:21:
31-10-2023 09:50:21:   Device quirks:
31-10-2023 09:50:21:     from [*] (/usr/share/ipp-usb/quirks/default.conf:3)
31-10-2023 09:50:21:       blacklist = false
31-10-2023 09:50:21:       usb-max-interfaces = 0
31-10-2023 09:50:21:       disable-fax = false
31-10-2023 09:50:21:       init-delay = 0s
31-10-2023 09:50:21:       request-delay = 0s
31-10-2023 09:50:21:       http-connection = ""
31-10-2023 09:50:21:
31-10-2023 09:50:21:   USB stack parameters
31-10-2023 09:50:21:     authorized_default:          -1
31-10-2023 09:50:21:     autosuspend:                 2
31-10-2023 09:50:21:     blinkenlights:               N
31-10-2023 09:50:21:     initial_descriptor_timeout:  5000
31-10-2023 09:50:21:     nousb:                       N
31-10-2023 09:50:21:     old_scheme_first:            N
31-10-2023 09:50:21:     usbfs_memory_mb:             16
31-10-2023 09:50:21:     usbfs_snoop:                 N
31-10-2023 09:50:21:     use_both_schemes:            Y
31-10-2023 09:50:21:
31-10-2023 09:50:21:   USB interfaces:
31-10-2023 09:50:21:     Config Interface Alt Class SubClass Proto
31-10-2023 09:50:21:        1       0      0   7      1       2
31-10-2023 09:50:21: *      1       0      1   7      1       4
31-10-2023 09:50:21:        1       1      0   8      6       80
31-10-2023 09:50:21:        1       2      0   255    4       1
31-10-2023 09:50:21:        1       3      0   255    4       1
31-10-2023 09:50:21: *      1       3      1   7      1       4
31-10-2023 09:50:21:
31-10-2023 09:50:21:   USB[0]: open: Bus 003 Device 004 Interface 0 Alt 1
31-10-2023 09:50:21:   USB[1]: open: Bus 003 Device 004 Interface 3 Alt 1
31-10-2023 09:50:21: > HTTP[018]: POST http://localhost:60000/ipp/print
31-10-2023 09:50:21: > HTTP[018]: request body: got 462 bytes; closed
31-10-2023 09:50:21: > HTTP[018]: body is small (462 bytes), prefetched before sending
31-10-2023 09:50:21:   USB[0]: connection allocated, 1 in use: a-- ---
31-10-2023 09:50:21:   HTTP[018]: connection 0 allocated
31-10-2023 09:50:24: > HTTP[019]: POST /ipp/print
31-10-2023 09:50:24: ! HTTP[019]: ipp-usb is not ready for this device
31-10-2023 09:50:24: > HTTP[020]: POST /ipp/print
31-10-2023 09:50:24: ! HTTP[020]: ipp-usb is not ready for this device
31-10-2023 09:50:26: ! USB[0]: send: libusb_bulk_transfer: Operation timed out
31-10-2023 09:50:26: ! HTTP[018]: libusb_bulk_transfer: Operation timed out
31-10-2023 09:50:26:   USB[0]: connection released, 0 in use: --- ---
31-10-2023 09:50:26: ! IPP: HTTP: Post "http://localhost:60000/ipp/print": libusb_bulk_transfer: Operation timed out
31-10-2023 09:50:26: - Bus 003 Device 004: resetting OfficeJet 200 Mobile Series
31-10-2023 09:50:26:   USB[0]: closed
31-10-2023 09:50:26:   USB[1]: closed
31-10-2023 09:50:26: - Bus 003 Device 004: removed OfficeJet 200 Mobile Series
31-10-2023 09:50:28:
31-10-2023 09:50:28:   ===============================
31-10-2023 09:50:28: + Bus 003 Device 004: added OfficeJet 200 Mobile Series
31-10-2023 09:50:28:   Device info:
31-10-2023 09:50:28:     Ident:         03f0-e711-TH9BQ850DD0689-HP-OfficeJet-200-Mobile-Series
31-10-2023 09:50:28:     Manufacturer:  HP
31-10-2023 09:50:28:     Product:       OfficeJet 200 Mobile Series
31-10-2023 09:50:28:     SerialNumber:  TH9BQ850DD0689
31-10-2023 09:50:28:     MfgAndProduct: HP OfficeJet 200 Mobile Series
31-10-2023 09:50:28:     BasicCaps:     print,scan,fax,http
31-10-2023 09:50:28:
31-10-2023 09:50:28:   Device quirks:
31-10-2023 09:50:28:     from [*] (/usr/share/ipp-usb/quirks/default.conf:3)
31-10-2023 09:50:28:       blacklist = false
31-10-2023 09:50:28:       usb-max-interfaces = 0
31-10-2023 09:50:28:       disable-fax = false
31-10-2023 09:50:28:       init-delay = 0s
31-10-2023 09:50:28:       request-delay = 0s
31-10-2023 09:50:28:       http-connection = ""
31-10-2023 09:50:28:
31-10-2023 09:50:28:   USB stack parameters
31-10-2023 09:50:28:     authorized_default:          -1
31-10-2023 09:50:28:     autosuspend:                 2
31-10-2023 09:50:28:     blinkenlights:               N
31-10-2023 09:50:28:     initial_descriptor_timeout:  5000
31-10-2023 09:50:28:     nousb:                       N
31-10-2023 09:50:28:     old_scheme_first:            N
31-10-2023 09:50:28:     usbfs_memory_mb:             16
31-10-2023 09:50:28:     usbfs_snoop:                 N
31-10-2023 09:50:28:     use_both_schemes:            Y
31-10-2023 09:50:28:
31-10-2023 09:50:28:   USB interfaces:
31-10-2023 09:50:28:     Config Interface Alt Class SubClass Proto
31-10-2023 09:50:28:        1       0      0   7      1       2
31-10-2023 09:50:28: *      1       0      1   7      1       4
31-10-2023 09:50:28:        1       1      0   8      6       80
31-10-2023 09:50:28:        1       2      0   255    4       1
31-10-2023 09:50:28:        1       3      0   255    4       1
31-10-2023 09:50:28: *      1       3      1   7      1       4
31-10-2023 09:50:28:
31-10-2023 09:50:29:   USB[0]: open: Bus 003 Device 004 Interface 0 Alt 1
31-10-2023 09:50:29:   USB[1]: open: Bus 003 Device 004 Interface 3 Alt 1
31-10-2023 09:50:29: > HTTP[021]: POST http://localhost:60000/ipp/print
31-10-2023 09:50:29: > HTTP[021]: request body: got 462 bytes; closed
31-10-2023 09:50:29: > HTTP[021]: body is small (462 bytes), prefetched before sending
31-10-2023 09:50:29:   USB[0]: connection allocated, 1 in use: a-- ---
31-10-2023 09:50:29:   HTTP[021]: connection 0 allocated
31-10-2023 09:50:32: > HTTP[022]: POST /ipp/print
31-10-2023 09:50:32: ! HTTP[022]: ipp-usb is not ready for this device
31-10-2023 09:50:32: > HTTP[023]: POST /ipp/print
31-10-2023 09:50:32: ! HTTP[023]: ipp-usb is not ready for this device
31-10-2023 09:50:33: > HTTP[024]: POST /ipp/print
31-10-2023 09:50:33: ! HTTP[024]: ipp-usb is not ready for this device
31-10-2023 09:50:33: > HTTP[025]: POST /ipp/print
31-10-2023 09:50:33: ! HTTP[025]: ipp-usb is not ready for this device
31-10-2023 09:50:34: ! USB[0]: send: libusb_bulk_transfer: Operation timed out
31-10-2023 09:50:34: ! HTTP[021]: libusb_bulk_transfer: Operation timed out
31-10-2023 09:50:34:   USB[0]: connection released, 0 in use: --- ---
31-10-2023 09:50:34: ! IPP: HTTP: Post "http://localhost:60000/ipp/print": libusb_bulk_transfer: Operation timed out
31-10-2023 09:50:34: - Bus 003 Device 004: resetting OfficeJet 200 Mobile Series
31-10-2023 09:50:34:   USB[0]: closed
31-10-2023 09:50:34:   USB[1]: closed
31-10-2023 09:50:34: - Bus 003 Device 004: removed OfficeJet 200 Mobile Series
31-10-2023 09:50:36:
31-10-2023 09:50:36:   ===============================
31-10-2023 09:50:36: + Bus 003 Device 004: added OfficeJet 200 Mobile Series
31-10-2023 09:50:36:   Device info:
31-10-2023 09:50:36:     Ident:         03f0-e711-TH9BQ850DD0689-HP-OfficeJet-200-Mobile-Series
31-10-2023 09:50:36:     Manufacturer:  HP
31-10-2023 09:50:36:     Product:       OfficeJet 200 Mobile Series
31-10-2023 09:50:36:     SerialNumber:  TH9BQ850DD0689
31-10-2023 09:50:36:     MfgAndProduct: HP OfficeJet 200 Mobile Series
31-10-2023 09:50:36:     BasicCaps:     print,scan,fax,http
31-10-2023 09:50:36:
31-10-2023 09:50:36:   Device quirks:
31-10-2023 09:50:36:     from [*] (/usr/share/ipp-usb/quirks/default.conf:3)
31-10-2023 09:50:36:       blacklist = false
31-10-2023 09:50:36:       usb-max-interfaces = 0
31-10-2023 09:50:36:       disable-fax = false
31-10-2023 09:50:36:       init-delay = 0s
31-10-2023 09:50:36:       request-delay = 0s
31-10-2023 09:50:36:       http-connection = ""
31-10-2023 09:50:36:
31-10-2023 09:50:36:   USB stack parameters
31-10-2023 09:50:36:     authorized_default:          -1
31-10-2023 09:50:36:     autosuspend:                 2
31-10-2023 09:50:36:     blinkenlights:               N
31-10-2023 09:50:36:     initial_descriptor_timeout:  5000
31-10-2023 09:50:36:     nousb:                       N
31-10-2023 09:50:36:     old_scheme_first:            N
31-10-2023 09:50:36:     usbfs_memory_mb:             16
31-10-2023 09:50:36:     usbfs_snoop:                 N
31-10-2023 09:50:36:     use_both_schemes:            Y
31-10-2023 09:50:36:
31-10-2023 09:50:36:   USB interfaces:
31-10-2023 09:50:36:     Config Interface Alt Class SubClass Proto
31-10-2023 09:50:36:        1       0      0   7      1       2
31-10-2023 09:50:36: *      1       0      1   7      1       4
31-10-2023 09:50:36:        1       1      0   8      6       80
31-10-2023 09:50:36:        1       2      0   255    4       1
31-10-2023 09:50:36:        1       3      0   255    4       1
31-10-2023 09:50:36: *      1       3      1   7      1       4
31-10-2023 09:50:36:
31-10-2023 09:50:36:   USB[0]: open: Bus 003 Device 004 Interface 0 Alt 1
31-10-2023 09:50:36:   USB[1]: open: Bus 003 Device 004 Interface 3 Alt 1
31-10-2023 09:50:36: > HTTP[026]: POST http://localhost:60000/ipp/print
31-10-2023 09:50:36: > HTTP[026]: request body: got 462 bytes; closed
31-10-2023 09:50:36: > HTTP[026]: body is small (462 bytes), prefetched before sending
31-10-2023 09:50:36:   USB[0]: connection allocated, 1 in use: a-- ---
31-10-2023 09:50:36:   HTTP[026]: connection 0 allocated
31-10-2023 09:50:39: > HTTP[027]: POST /ipp/print
31-10-2023 09:50:39: ! HTTP[027]: ipp-usb is not ready for this device
31-10-2023 09:50:39: > HTTP[028]: POST /ipp/print
31-10-2023 09:50:39: ! HTTP[028]: ipp-usb is not ready for this device
31-10-2023 09:50:41: ! USB[0]: send: libusb_bulk_transfer: Operation timed out
31-10-2023 09:50:41: ! HTTP[026]: libusb_bulk_transfer: Operation timed out
31-10-2023 09:50:41:   USB[0]: connection released, 0 in use: --- ---
31-10-2023 09:50:41: ! IPP: HTTP: Post "http://localhost:60000/ipp/print": libusb_bulk_transfer: Operation timed out
31-10-2023 09:50:41: - Bus 003 Device 004: resetting OfficeJet 200 Mobile Series
31-10-2023 09:50:41:   USB[0]: closed
31-10-2023 09:50:41:   USB[1]: closed
31-10-2023 09:50:41: - Bus 003 Device 004: removed OfficeJet 200 Mobile Series

@alexpevzner
Copy link
Member

Hi @Xerxekyran!

First of all, seems your ipp-usb is not of the latest version. The latest is 0.9.23 for now.

If upgrade will not help, could you please play a bit with init-delay and init-reset quirks? For simplicity, you can edit direcly the /usr/share/ipp-usb/quirks/default.conf file (for all devices); if it will help, I'll tell later how to make these settings more specific.

@Xerxekyran
Copy link
Author

Hi @alexpevzner thank you for your quick answer. I am currently playing around with different settings for init-delay, init-reset, disable-fax and http-connection in the default.conf but could not yet find a setting where this problem is solved.
I will try upgrading next.

@Xerxekyran
Copy link
Author

First of all, seems your ipp-usb is not of the latest version. The latest is 0.9.23 for now.

I checked my build scripts and there it states that I use version 0.9.23 already. What made you think I am using an older version?

@Xerxekyran
Copy link
Author

Even when using relatively high values it seems not to recover from the "failure state of the printer":

31-10-2023 12:37:11:   Device quirks:
31-10-2023 12:37:11:     from [*] (/usr/share/ipp-usb/quirks/default.conf:3)
31-10-2023 12:37:11:       blacklist = false
31-10-2023 12:37:11:       usb-max-interfaces = 0
31-10-2023 12:37:11:       disable-fax = true
31-10-2023 12:37:11:       init-delay = 5s
31-10-2023 12:37:11:       request-delay = 5s
31-10-2023 12:37:11:       init-reset = hard
31-10-2023 12:37:11:       http-connection = ""

I tried hard, soft and none init-reset, high and low values for the delay and with or without the fax feature. Is there anything else I can test?

@alexpevzner
Copy link
Member

First of all, seems your ipp-usb is not of the latest version. The latest is 0.9.23 for now.

I checked my build scripts and there it states that I use version 0.9.23 already. What made you think I am using an older version?

Absence of the init-reset quirk parameter in your early log. This parameter was added in 0.9.21

@alexpevzner
Copy link
Member

I know that this is not just a problem of this one printer (HP OfficeJet 200 Mobile Series), but also for example a Brother printer acted like this.

Do you know the model name of this Brother?

@alexpevzner
Copy link
Member

BTW, #66 looks similar. Does tweaking usb-max-interfaces help in your case (0 means "unlimited", your device has only 2 interfaces, so the only reasonable number to try is 1)?

@alexpevzner
Copy link
Member

BTW, my colleague suggested a reasonable idea. Have you tried to replace an USB cable?

@Xerxekyran
Copy link
Author

Do you know the model name of this Brother?

Brother HL-L2370DW

BTW, my colleague suggested a reasonable idea. Have you tried to replace an USB cable?

This problem was reported to me from a person at a different location, so there was a different cable in use.

Further testing showed me that even printing directly to the printer via USB does not work (shutting IPP-USB off) as long as it is in this failure state. I needed to restart the printer completely by powering it off to recover it. After that everything works fine again.

@Xerxekyran
Copy link
Author

BTW, #66 looks similar. Does tweaking usb-max-interfaces help in your case (0 means "unlimited", your device has only 2 interfaces, so the only reasonable number to try is 1)?

Setting this to 2 or 1 does not "heal" the problematic state. I will check if it prevents getting to the state as soon as I can get my hands on the printer again in a couple of days.

I appreciate your help, thank you.

@Xerxekyran
Copy link
Author

Xerxekyran commented Dec 1, 2023 •
edited
Loading

So I got access to a very similar printer that a mentioned above: Brother-HL-L2370DN-series

When I do the same setup:

  • start printing
  • remove the USB cable during the printing
  • re-plug the USB cable

I see some kind of an endless loop in the IPP-USB printer log. Maybe in this scenario it is a CUPS issue? If I add another print job, this new one is not printed, as the first one where the cable was removed inbetween never finishes. As soon as I remove that "failed" print job, the next print job gets printed without any problem.
I also already tried some quirk options like the soft or hard reset and a longer init delay. What do you think, do you see an IPP-USB issue here at all?

01-12-2023 11:32:46: > HTTP[627]: POST http://127.0.0.1:60000/ipp/print
01-12-2023 11:32:46:   USB[0]: connection allocated, 1 in use: a-- ---
01-12-2023 11:32:46:   HTTP[627]: connection 0 allocated
01-12-2023 11:32:46: > HTTP[627]: request body: got 212 bytes; EOF
01-12-2023 11:32:46: < HTTP[627]: POST http://127.0.0.1:60000/ipp/print - 200 OK
01-12-2023 11:32:46: < HTTP[627]: response body: got 175 bytes; EOF
01-12-2023 11:32:46:   USB[0]: connection released, 0 in use: --- ---
01-12-2023 11:32:47: > HTTP[628]: POST http://localhost:60000/ipp/print
01-12-2023 11:32:47: > HTTP[628]: request body: got 711 bytes; EOF
01-12-2023 11:32:47: > HTTP[628]: body is small (711 bytes), prefetched before sending
01-12-2023 11:32:47:   USB[1]: connection allocated, 1 in use: --- a--
01-12-2023 11:32:47:   HTTP[628]: connection 1 allocated
01-12-2023 11:32:47: < HTTP[628]: POST http://localhost:60000/ipp/print - 200 OK
01-12-2023 11:32:47: < HTTP[628]: response body: got 1177 bytes; EOF
01-12-2023 11:32:47:   USB[1]: connection released, 0 in use: --- ---
01-12-2023 11:32:47: > HTTP[629]: POST http://localhost:60000/ipp/print
01-12-2023 11:32:47: > HTTP[629]: request body: got 300 bytes; EOF
01-12-2023 11:32:47: > HTTP[629]: body is small (300 bytes), prefetched before sending
01-12-2023 11:32:47:   USB[0]: connection allocated, 1 in use: a-- ---
01-12-2023 11:32:47:   HTTP[629]: connection 0 allocated
01-12-2023 11:32:47: > HTTP[630]: POST http://localhost:60000/ipp/print
01-12-2023 11:32:47: > HTTP[630]: request body: got 740 bytes; EOF
01-12-2023 11:32:47: > HTTP[630]: body is small (740 bytes), prefetched before sending
01-12-2023 11:32:47:   USB[1]: connection allocated, 2 in use: ar- a--
01-12-2023 11:32:47:   HTTP[630]: connection 1 allocated
01-12-2023 11:32:47: < HTTP[629]: POST http://localhost:60000/ipp/print - 200 OK
01-12-2023 11:32:47: < HTTP[629]: response body: got 72 bytes; EOF
01-12-2023 11:32:47:   USB[0]: connection released, 1 in use: --- ar-
01-12-2023 11:32:47: > HTTP[631]: POST http://localhost:60000/ipp/print
01-12-2023 11:32:47: > HTTP[631]: request body: got 271 bytes; EOF
01-12-2023 11:32:47: > HTTP[631]: body is small (271 bytes), prefetched before sending
01-12-2023 11:32:47:   USB[0]: connection allocated, 2 in use: a-- ar-
01-12-2023 11:32:47:   HTTP[631]: connection 0 allocated
01-12-2023 11:32:47: < HTTP[631]: POST http://localhost:60000/ipp/print - 200 OK
01-12-2023 11:32:47: < HTTP[630]: POST http://localhost:60000/ipp/print - 200 OK
01-12-2023 11:32:47: < HTTP[631]: response body: got 182 bytes; EOF
01-12-2023 11:32:47:   USB[0]: connection released, 1 in use: --- a--
01-12-2023 11:32:47: < HTTP[630]: response body: got 1177 bytes; EOF
01-12-2023 11:32:47:   USB[1]: connection released, 0 in use: --- ---
01-12-2023 11:32:47: > HTTP[632]: POST http://localhost:60000/ipp/print
01-12-2023 11:32:47: > HTTP[632]: request body: got 334 bytes; EOF
01-12-2023 11:32:47: > HTTP[632]: body is small (334 bytes), prefetched before sending
01-12-2023 11:32:47:   USB[0]: connection allocated, 1 in use: a-- ---
01-12-2023 11:32:47:   HTTP[632]: connection 0 allocated
01-12-2023 11:32:47: > HTTP[633]: POST http://localhost:60000/ipp/print
01-12-2023 11:32:47:   USB[1]: connection allocated, 2 in use: a-w a--
01-12-2023 11:32:47:   HTTP[633]: connection 1 allocated
01-12-2023 11:32:47: < HTTP[632]: POST http://localhost:60000/ipp/print - 200 OK
01-12-2023 11:32:47: < HTTP[632]: response body: got 273 bytes; EOF
01-12-2023 11:32:47:   USB[0]: connection released, 1 in use: --- a--
01-12-2023 11:32:48: > HTTP[634]: POST http://localhost:60000/ipp/print
01-12-2023 11:32:48: > HTTP[634]: request body: got 740 bytes; EOF
01-12-2023 11:32:48: > HTTP[634]: body is small (740 bytes), prefetched before sending
01-12-2023 11:32:48:   USB[0]: connection allocated, 2 in use: a-- a--
01-12-2023 11:32:48:   HTTP[634]: connection 0 allocated
01-12-2023 11:32:48: < HTTP[634]: POST http://localhost:60000/ipp/print - 200 OK
01-12-2023 11:32:48: < HTTP[634]: response body: got 1177 bytes; EOF
01-12-2023 11:32:48:   USB[0]: connection released, 1 in use: --- a--
01-12-2023 11:32:48: > HTTP[635]: POST http://localhost:60000/ipp/print
01-12-2023 11:32:48: > HTTP[635]: request body: got 334 bytes; EOF
01-12-2023 11:32:48: > HTTP[635]: body is small (334 bytes), prefetched before sending
01-12-2023 11:32:48:   USB[0]: connection allocated, 2 in use: a-- a--
01-12-2023 11:32:48:   HTTP[635]: connection 0 allocated
01-12-2023 11:32:48: < HTTP[635]: POST http://localhost:60000/ipp/print - 200 OK
01-12-2023 11:32:48: < HTTP[635]: response body: got 273 bytes; EOF
01-12-2023 11:32:48:   USB[0]: connection released, 1 in use: --- a--
01-12-2023 11:32:49: - DNS-SD: Brother HL-L2370DN series (USB): removed
01-12-2023 11:32:49: > HTTP[633]: request body: got 231 bytes; read tcp 127.0.0.1:60000->127.0.0.1:60072: use of closed network connection
01-12-2023 11:32:49: ! HTTP[633]: read tcp 127.0.0.1:60000->127.0.0.1:60072: use of closed network connection
01-12-2023 11:32:49:   USB[1]: connection released, 0 in use: --- ---
01-12-2023 11:32:49: > HTTP[633]: POST http://localhost:60000/ipp/print
01-12-2023 11:32:49: ! HTTP[633]: read tcp 127.0.0.1:60000->127.0.0.1:60072: use of closed network connection
01-12-2023 11:32:49: - Bus 003 Device 006: resetting HL-L2370DN series
01-12-2023 11:32:49:   USB[0]: closed
01-12-2023 11:32:49:   USB[1]: closed
01-12-2023 11:32:49: - Bus 003 Device 006: removed HL-L2370DN series
01-12-2023 11:32:53:
01-12-2023 11:32:53:   ===============================
01-12-2023 11:32:53: + Bus 003 Device 007: added HL-L2370DN series
01-12-2023 11:32:53:   Device info:
01-12-2023 11:32:53:     Ident:         04f9-00a0-E78098K2N252770-Brother-HL-L2370DN-series
01-12-2023 11:32:53:     Manufacturer:  Brother
01-12-2023 11:32:53:     Product:       HL-L2370DN series
01-12-2023 11:32:53:     SerialNumber:  E78098K2N252770
01-12-2023 11:32:53:     MfgAndProduct: Brother HL-L2370DN series
01-12-2023 11:32:53:     BasicCaps:     print,http
01-12-2023 11:32:53:
01-12-2023 11:32:53:   Device quirks:
01-12-2023 11:32:53:     from [*] (/usr/share/ipp-usb/quirks/default.conf:3)
01-12-2023 11:32:53:       blacklist = false
01-12-2023 11:32:53:       usb-max-interfaces = 0
01-12-2023 11:32:53:       disable-fax = false
01-12-2023 11:32:53:       init-delay = 0s
01-12-2023 11:32:53:       request-delay = 0s
01-12-2023 11:32:53:       http-connection = ""
01-12-2023 11:32:53:
01-12-2023 11:32:53:   USB stack parameters
01-12-2023 11:32:53:     authorized_default:          -1
01-12-2023 11:32:53:     autosuspend:                 2
01-12-2023 11:32:53:     blinkenlights:               N
01-12-2023 11:32:53:     initial_descriptor_timeout:  5000
01-12-2023 11:32:53:     nousb:                       N
01-12-2023 11:32:53:     old_scheme_first:            N
01-12-2023 11:32:53:     usbfs_memory_mb:             16
01-12-2023 11:32:53:     usbfs_snoop:                 N
01-12-2023 11:32:53:     use_both_schemes:            Y
01-12-2023 11:32:53:
01-12-2023 11:32:53:   USB interfaces:
01-12-2023 11:32:53:     Config Interface Alt Class SubClass Proto
01-12-2023 11:32:53:        1       0      0   7      1       2
01-12-2023 11:32:53: *      1       0      1   7      1       4
01-12-2023 11:32:53:        1       1      0   255    255     255
01-12-2023 11:32:53: *      1       1      1   7      1       4
01-12-2023 11:32:53:
01-12-2023 11:32:54:   USB[0]: open: Bus 003 Device 007 Interface 0 Alt 1
01-12-2023 11:32:54:   USB[1]: open: Bus 003 Device 007 Interface 1 Alt 1
01-12-2023 11:32:54: > HTTP[636]: POST http://localhost:60000/ipp/print
01-12-2023 11:32:54: > HTTP[636]: request body: got 462 bytes; closed
01-12-2023 11:32:54: > HTTP[636]: body is small (462 bytes), prefetched before sending
01-12-2023 11:32:54:   USB[0]: connection allocated, 1 in use: a-- ---
01-12-2023 11:32:54:   HTTP[636]: connection 0 allocated
01-12-2023 11:32:54: < HTTP[636]: POST http://localhost:60000/ipp/print - 200 OK
01-12-2023 11:32:54: < HTTP[636]: response body: got 2057 bytes; EOF
01-12-2023 11:32:54:   USB[0]: connection released, 0 in use: --- ---
01-12-2023 11:32:54:   IPP FaxOut service not in capabilities
01-12-2023 11:32:54: > HTTP[637]: GET http://localhost:60000/eSCL/ScannerCapabilities
01-12-2023 11:32:54:   USB[1]: connection allocated, 1 in use: --- a--
01-12-2023 11:32:54:   HTTP[637]: connection 1 allocated
01-12-2023 11:32:54: < HTTP[637]: GET http://localhost:60000/eSCL/ScannerCapabilities - 404 Not Found
01-12-2023 11:32:54: < HTTP[637]: client has gone; draining response from USB
01-12-2023 11:32:54: ! ESCL: eSCL: HTTP status: 404 Not Found
01-12-2023 11:32:54: > Brother HL-L2370DN series: _printer._tcp TXT record:
01-12-2023 11:32:54: > Brother HL-L2370DN series: _ipp._tcp TXT record:
01-12-2023 11:32:54:     air=none
01-12-2023 11:32:54:     mopria-certified=1.3
01-12-2023 11:32:54:     rp=ipp/print
01-12-2023 11:32:54:     priority=50
01-12-2023 11:32:54:     kind=document,envelope,label,postcard
01-12-2023 11:32:54:     PaperMax=legal-A4
01-12-2023 11:32:54:     URF=W8,CP1,IS4-1,MT1-3-4-5-8,OB10,PQ3-4-5,RS300-600-1200,V1.4,DM1
01-12-2023 11:32:54:     UUID=e3248000-80ce-11db-8000-b42200a72984
01-12-2023 11:32:54:     Color=F
01-12-2023 11:32:54:     Duplex=T
01-12-2023 11:32:54:     note=
01-12-2023 11:32:54:     qtotal=1
01-12-2023 11:32:54:     pdl=application/octet-stream,image/urf,image/pwg-raster
01-12-2023 11:32:54:     txtvers=1
01-12-2023 11:32:54:     adminurl=http://localhost:60000/net/net/airprint.html
01-12-2023 11:32:54:     Fax=F
01-12-2023 11:32:54:     Scan=F
01-12-2023 11:32:54: > Brother HL-L2370DN series: _http._tcp TXT record:
01-12-2023 11:32:54: > Brother HL-L2370DN series: _ipp-usb._tcp TXT record:
01-12-2023 11:32:54:   DNS-SD: Brother HL-L2370DN series (USB): trying
01-12-2023 11:32:54:   USB[1]: connection released, 0 in use: --- ---
01-12-2023 11:32:54:   DNS-SD: FQDN: "WS-123456.local"
01-12-2023 11:32:54:   DNS-SD: FQDN: "WS-123456.local"->"localhost"
01-12-2023 11:32:54:   DNS-SD: +subtype: "_universal._sub._ipp._tcp"
01-12-2023 11:32:54: + DNS-SD: Brother HL-L2370DN series (USB): publishing requested
01-12-2023 11:32:54:   DNS-SD: Brother HL-L2370DN series (USB): AVAHI_ENTRY_GROUP_REGISTERING
01-12-2023 11:32:54:   DNS-SD: Brother HL-L2370DN series (USB): AVAHI_ENTRY_GROUP_ESTABLISHED
01-12-2023 11:32:54:   DNS-SD: Brother HL-L2370DN series (USB): published
01-12-2023 11:32:55: > HTTP[638]: POST http://localhost:60000/ipp/print
01-12-2023 11:32:55: > HTTP[638]: request body: got 740 bytes; EOF
01-12-2023 11:32:55: > HTTP[638]: body is small (740 bytes), prefetched before sending
01-12-2023 11:32:55:   USB[0]: connection allocated, 1 in use: a-- ---
01-12-2023 11:32:55:   HTTP[638]: connection 0 allocated
01-12-2023 11:32:55: < HTTP[638]: POST http://localhost:60000/ipp/print - 200 OK
01-12-2023 11:32:55: < HTTP[638]: response body: got 1177 bytes; EOF
01-12-2023 11:32:55:   USB[0]: connection released, 0 in use: --- ---
01-12-2023 11:32:55: > HTTP[639]: POST http://localhost:60000/ipp/print
01-12-2023 11:32:55: > HTTP[639]: request body: got 334 bytes; EOF
01-12-2023 11:32:55: > HTTP[639]: body is small (334 bytes), prefetched before sending
01-12-2023 11:32:55:   USB[1]: connection allocated, 1 in use: --- a--
01-12-2023 11:32:55:   HTTP[639]: connection 1 allocated
01-12-2023 11:32:55: < HTTP[639]: POST http://localhost:60000/ipp/print - 200 OK
01-12-2023 11:32:55: < HTTP[639]: response body: got 273 bytes; EOF
01-12-2023 11:32:55:   USB[1]: connection released, 0 in use: --- ---
01-12-2023 11:32:56: > HTTP[640]: POST http://127.0.0.1:60000/ipp/print
01-12-2023 11:32:56:   USB[0]: connection allocated, 1 in use: a-- ---
01-12-2023 11:32:56:   HTTP[640]: connection 0 allocated
01-12-2023 11:32:56: > HTTP[640]: request body: got 212 bytes; EOF
01-12-2023 11:32:56: < HTTP[640]: POST http://127.0.0.1:60000/ipp/print - 200 OK
01-12-2023 11:32:56: < HTTP[640]: response body: got 175 bytes; EOF
01-12-2023 11:32:56:   USB[0]: connection released, 0 in use: --- ---
01-12-2023 11:32:58: > HTTP[641]: POST http://localhost:60000/ipp/print
01-12-2023 11:32:58: > HTTP[641]: request body: got 740 bytes; EOF
01-12-2023 11:32:58: > HTTP[641]: body is small (740 bytes), prefetched before sending
01-12-2023 11:32:58:   USB[1]: connection allocated, 1 in use: --- a--
01-12-2023 11:32:58:   HTTP[641]: connection 1 allocated
01-12-2023 11:32:58: < HTTP[641]: POST http://localhost:60000/ipp/print - 200 OK
01-12-2023 11:32:58: < HTTP[641]: response body: got 1177 bytes; EOF
01-12-2023 11:32:58:   USB[1]: connection released, 0 in use: --- ---
01-12-2023 11:32:58: > HTTP[642]: POST http://localhost:60000/ipp/print
01-12-2023 11:32:58: > HTTP[642]: request body: got 334 bytes; EOF
01-12-2023 11:32:58: > HTTP[642]: body is small (334 bytes), prefetched before sending
01-12-2023 11:32:58:   USB[0]: connection allocated, 1 in use: a-- ---
01-12-2023 11:32:58:   HTTP[642]: connection 0 allocated
01-12-2023 11:32:58: < HTTP[642]: POST http://localhost:60000/ipp/print - 200 OK
01-12-2023 11:32:58: < HTTP[642]: response body: got 273 bytes; EOF
01-12-2023 11:32:58:   USB[0]: connection released, 0 in use: --- ---
01-12-2023 11:33:03: > HTTP[643]: POST http://localhost:60000/ipp/print
01-12-2023 11:33:03: > HTTP[643]: request body: got 740 bytes; EOF
01-12-2023 11:33:03: > HTTP[643]: body is small (740 bytes), prefetched before sending
01-12-2023 11:33:03:   USB[1]: connection allocated, 1 in use: --- a--
01-12-2023 11:33:03:   HTTP[643]: connection 1 allocated
01-12-2023 11:33:03: < HTTP[643]: POST http://localhost:60000/ipp/print - 200 OK
01-12-2023 11:33:03: < HTTP[643]: response body: got 1177 bytes; EOF
01-12-2023 11:33:03:   USB[1]: connection released, 0 in use: --- ---
01-12-2023 11:33:03: > HTTP[644]: POST http://localhost:60000/ipp/print
01-12-2023 11:33:03: > HTTP[644]: request body: got 334 bytes; EOF
01-12-2023 11:33:03: > HTTP[644]: body is small (334 bytes), prefetched before sending
01-12-2023 11:33:03:   USB[0]: connection allocated, 1 in use: a-- ---
01-12-2023 11:33:03:   HTTP[644]: connection 0 allocated
01-12-2023 11:33:03: < HTTP[644]: POST http://localhost:60000/ipp/print - 200 OK
01-12-2023 11:33:03: < HTTP[644]: response body: got 273 bytes; EOF
01-12-2023 11:33:03:   USB[0]: connection released, 0 in use: --- ---
01-12-2023 11:33:11: > HTTP[645]: POST http://localhost:60000/ipp/print
01-12-2023 11:33:11: > HTTP[645]: request body: got 740 bytes; EOF
01-12-2023 11:33:11: > HTTP[645]: body is small (740 bytes), prefetched before sending
01-12-2023 11:33:11:   USB[1]: connection allocated, 1 in use: --- a--
01-12-2023 11:33:11:   HTTP[645]: connection 1 allocated
01-12-2023 11:33:11: < HTTP[645]: POST http://localhost:60000/ipp/print - 200 OK
01-12-2023 11:33:11: < HTTP[645]: response body: got 1177 bytes; EOF
01-12-2023 11:33:11:   USB[1]: connection released, 0 in use: --- ---
01-12-2023 11:33:11: > HTTP[646]: POST http://localhost:60000/ipp/print
01-12-2023 11:33:11: > HTTP[646]: request body: got 334 bytes; EOF
01-12-2023 11:33:11: > HTTP[646]: body is small (334 bytes), prefetched before sending
01-12-2023 11:33:11:   USB[0]: connection allocated, 1 in use: a-- ---
01-12-2023 11:33:11:   HTTP[646]: connection 0 allocated
01-12-2023 11:33:11: < HTTP[646]: POST http://localhost:60000/ipp/print - 200 OK
01-12-2023 11:33:11: < HTTP[646]: response body: got 273 bytes; EOF
01-12-2023 11:33:11:   USB[0]: connection released, 0 in use: --- ---
01-12-2023 11:33:12: > HTTP[647]: POST http://localhost:60000/ipp/print
01-12-2023 11:33:12: > HTTP[647]: request body: got 740 bytes; EOF
01-12-2023 11:33:12: > HTTP[647]: body is small (740 bytes), prefetched before sending
01-12-2023 11:33:12:   USB[1]: connection allocated, 1 in use: --- a--
01-12-2023 11:33:12:   HTTP[647]: connection 1 allocated
01-12-2023 11:33:12: < HTTP[647]: POST http://localhost:60000/ipp/print - 200 OK
01-12-2023 11:33:12: < HTTP[647]: response body: got 1177 bytes; EOF
01-12-2023 11:33:12:   USB[1]: connection released, 0 in use: --- ---
01-12-2023 11:33:12: > HTTP[648]: POST http://localhost:60000/ipp/print
01-12-2023 11:33:12: > HTTP[648]: request body: got 334 bytes; EOF
01-12-2023 11:33:12: > HTTP[648]: body is small (334 bytes), prefetched before sending
01-12-2023 11:33:12:   USB[0]: connection allocated, 1 in use: a-- ---
01-12-2023 11:33:12:   HTTP[648]: connection 0 allocated
01-12-2023 11:33:12: < HTTP[648]: POST http://localhost:60000/ipp/print - 200 OK
01-12-2023 11:33:12: < HTTP[648]: response body: got 273 bytes; EOF
01-12-2023 11:33:12:   USB[0]: connection released, 0 in use: --- ---
01-12-2023 11:33:13: > HTTP[649]: POST http://localhost:60000/ipp/print
01-12-2023 11:33:13: > HTTP[649]: request body: got 740 bytes; EOF
01-12-2023 11:33:13: > HTTP[649]: body is small (740 bytes), prefetched before sending
01-12-2023 11:33:13:   USB[1]: connection allocated, 1 in use: --- a--
01-12-2023 11:33:13:   HTTP[649]: connection 1 allocated
01-12-2023 11:33:13: < HTTP[649]: POST http://localhost:60000/ipp/print - 200 OK
01-12-2023 11:33:13: < HTTP[649]: response body: got 1177 bytes; EOF
01-12-2023 11:33:13:   USB[1]: connection released, 0 in use: --- ---
01-12-2023 11:33:13: > HTTP[650]: POST http://localhost:60000/ipp/print
01-12-2023 11:33:13: > HTTP[650]: request body: got 334 bytes; EOF
01-12-2023 11:33:13: > HTTP[650]: body is small (334 bytes), prefetched before sending
01-12-2023 11:33:13:   USB[0]: connection allocated, 1 in use: a-- ---
01-12-2023 11:33:13:   HTTP[650]: connection 0 allocated
01-12-2023 11:33:13: < HTTP[650]: POST http://localhost:60000/ipp/print - 200 OK
01-12-2023 11:33:13: < HTTP[650]: response body: got 273 bytes; EOF
01-12-2023 11:33:13:   USB[0]: connection released, 0 in use: --- ---
01-12-2023 11:33:15: > HTTP[651]: POST http://localhost:60000/ipp/print
01-12-2023 11:33:15: > HTTP[651]: request body: got 740 bytes; EOF
01-12-2023 11:33:15: > HTTP[651]: body is small (740 bytes), prefetched before sending
01-12-2023 11:33:15:   USB[1]: connection allocated, 1 in use: --- a--
01-12-2023 11:33:15:   HTTP[651]: connection 1 allocated
01-12-2023 11:33:15: < HTTP[651]: POST http://localhost:60000/ipp/print - 200 OK
01-12-2023 11:33:15: < HTTP[651]: response body: got 1177 bytes; EOF
01-12-2023 11:33:15:   USB[1]: connection released, 0 in use: --- ---
01-12-2023 11:33:15: > HTTP[652]: POST http://localhost:60000/ipp/print
01-12-2023 11:33:15: > HTTP[652]: request body: got 334 bytes; EOF
01-12-2023 11:33:15: > HTTP[652]: body is small (334 bytes), prefetched before sending
01-12-2023 11:33:15:   USB[0]: connection allocated, 1 in use: a-- ---
01-12-2023 11:33:15:   HTTP[652]: connection 0 allocated
01-12-2023 11:33:15: < HTTP[652]: POST http://localhost:60000/ipp/print - 200 OK
01-12-2023 11:33:15: < HTTP[652]: response body: got 273 bytes; EOF
01-12-2023 11:33:15:   USB[0]: connection released, 0 in use: --- ---

Restarting the printer had the same result as deleting the stuck printing job. The next print job in the queue gets properly printed.

@alexpevzner
Copy link
Member

Hi @Xerxekyran,

What do you think, do you see an IPP-USB issue here at all?

'ipp-usbis the communication daemon only. The fact that when problematic job is removed, printing recovers, tells that this is unlikely to be theipp-usb` issue.

However, it may be hard for CUPS guys to deal with this problem at their side (and there are not too much guys, after all).

I'll try to find one of devices you've mentioned locally and if I will succeed, it will be best of all. Otherwise, we will try to debug remotely, by e-mail :)

@volfyd
Copy link

volfyd commented Jan 31, 2025

I found this issue because I have a Brother HL-L2350DW and ipp-usb would show

USB[1]: zero-size read

I set

usb-max-interfaces = 1

because of @alexpevzner 's suggestion and that worked and the connection now seems stable. I can browse port 60000 without every other request causing the zero-size read.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
None yet
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
3 participants
@Xerxekyran @volfyd @alexpevzner