You are not logged in.
I am using a Brother DCP-195C scanner/printer for some years now with arch. Using the (orphaned) package brother-dcp195c from AUR was sufficient to run the printer. From yesterdays
pacaur -Syuon only the scanner part is still working. The printer is connected via USB.
When I try to print a page (test-page whatever) first status in CUPS is presented with
brother (Idle, Accepting Jobs, Not Shared), starting a job sets the status to
Processing, Accepting Jobs, Not Shared) processing since Tue 12 Dec 2017 12:02:46 PM CET "Waiting for printer to become available."I removed the drivers from the AUR-package and installed the drivers from brothers website download via
dpkgstill with the same behaviour.
$ lsusb
Bus 001 Device 007: ID 04f9:0222 Brother Industries, Ltd DCP-195C$ dmesg
[ 1035.603926] usblp0: removed
[ 1039.393116] usb 1-1.2.2: new full-speed USB device number 8 using ehci-pci
[ 1039.494289] usblp 1-1.2.2:1.0: usblp0: USB Bidirectional printer dev 8 if 0 alt 0 proto 2 vid 0x04F9 pid 0x0222
[ 1039.494456] usb-storage 1-1.2.2:1.2: USB Mass Storage device detected
[ 1039.497971] scsi host6: usb-storage 1-1.2.2:1.2
[ 1040.520891] scsi 6:0:0:0: Direct-Access Brother DCP-195C 1.00 PQ: 0 ANSI: 2
[ 1040.581007] sd 6:0:0:0: [sdb] Attached SCSI removable disk$ cat /usr/lib/cups/backend/usb
DEBUG: list_devices
INFODEBUG: Fatal USB error.
ERRORusb-unidirnoofffalseusb-no-reattachSending data to printer.PAGE: 1 1
Unable to read print data.DEBUG: selectDEBUG: readDEBUG: Sent %lld bytes...
Unable to open print fileDEBUG: Loading USB quirks from "%s".
DEBUG: Unable to allocate memory for quirkDEBUG: Read %d bytes of back-channel data...
DEBUG: Got USB transaction timeout during read.
DEBUG: Got USB pipe stalled during read.
DEBUG: Got USB return aborted during read.
DEBUG: CUPS_SC_CMD_SOFT_RESET received from driver...
DEBUG: Returning status CUPS_STATUS_OK with no bytes...
DEBUG: CUPS_SC_CMD_DRAIN_OUTPUT received from driver...
DEBUG: CUPS_SC_CMD_GET_BIDI received from driver...
DEBUG: Returned CUPS_SC_STATUS_OK with 1 byte (%02X)...
DEBUG: CUPS_SC_CMD_GET_DEVICE_ID received from driver...
DEBUG: Returning CUPS_SC_STATUS_OK with %d bytes (%s)...
DEBUG: CUPS_SC_CMD_GET_STATE received from driver...
DEBUG: CUPS_SC_CMD_GET_CONNECTED received from driver...
DEBUG: Unknown side-channel command (%d) received from driver...
DEBUG: Returned CUPS_SC_STATUS_NOT_IMPLEMENTED with no bytes...
DEBUG: Restoring USB device configuration: %d -> %d
DEBUG: Failed to set configuration %d
DEBUG: Failed to set configuration %d for %04x:%04x
DEBUG: Failed to re-attach "usblp" kernel module
DEBUG: Failed to re-attach "usblp" kernel module to %04x:%04x
DEBUG: Failed to get configuration descriptor %d
DEBUG: Device reset failed, error code: %d
DEBUG: Unable to initialize USB access via libusb, libusb error %i
DEBUG: libusb_get_device_list=%d
DEBUG: Printer does not report class 7 and/or subclass 1 but works as a printer anyway
DEBUG: Failed to open device, code: %d
DEBUG: Failed to get device descriptor, code: %d
DEBUG: Failed to detach "usblp" module from %04x:%04x
DEBUG: Failed to check whether %04x:%04x has the "usblp" kernel module attached
DEBUG: Failed to get config descriptor for %04x:%04x
DEBUG: Switching USB device configuration: %d -> %d
DEBUG: Failed to claim interface %d for %04x:%04x: %s
DEBUG: Failed to set alternate interface %d for %04x:%04x: %s
DEBUG2: Printer found with device ID: %s Device URI: %s
DEBUG: Printer reports bi-di support but in reality works only uni-directionally
DEBUG: Uni-directional USB communication only!
DEBUG: Printer does not like usblp kernel module to be re-attached after job
DEBUG: Printing on printer with URI: %s
Waiting for printer to become available.There was an unrecoverable USB error.DEBUG: Couldn't create side-channel thread.
DEBUG: Forced uni-directional communication via "usb-unidir" option.
DEBUG: Forced not re-attaching the usblp kernel module after the job via "usb-no-reattach" option.
DEBUG: Couldn't create read thread.
DEBUG: Uni-directional device/mode, back channel deactivated.
DEBUG: Received an interrupt before any bytes were written, aborting.
DEBUG: Read %d bytes of print data...
DEBUG: Got USB transaction timeout during write.
DEBUG: Got USB pipe stalled during write.
DEBUG: Got USB return aborted during write.
Unable to send data to printer.DEBUG: libusb write operation returned %x.
DEBUG: Wrote %d bytes of print data...
DEBUG: Sending print file, %lld bytes...
DEBUG: Waiting for read thread to exit...
DEBUG: Read thread still active, aborting the pending read...
Usage: %s job-id user title copies options [file]No device URI found in argv[0] or in DEVICE_URI environment variable.$ cat /var/log/cups/error_log
E [12/Dec/2017:11:50:01 +0100] [Job 389] Invalid printer command \"Clean\".
E [12/Dec/2017:11:50:01 +0100] [Job 389] Job stopped due to filter errors; please consult the error_log file for details.
D [12/Dec/2017:11:50:01 +0100] [Job 389] The following messages were recorded from 11:50:01 to 11:50:01
D [12/Dec/2017:11:50:01 +0100] [Job 389] Applying default options...
D [12/Dec/2017:11:50:01 +0100] [Job 389] Adding default media-col=media-bottom-margin
D [12/Dec/2017:11:50:01 +0100] [Job 389] Adding start banner page "none".
D [12/Dec/2017:11:50:01 +0100] [Job 389] Adding end banner page "none".
D [12/Dec/2017:11:50:01 +0100] [Job 389] File of type application/vnd.cups-command queued by "kodiak".
D [12/Dec/2017:11:50:01 +0100] [Job 389] hold_until=0
D [12/Dec/2017:11:50:01 +0100] [Job 389] Queued on "Brother-DCP-195C" by "kodiak".
D [12/Dec/2017:11:50:01 +0100] [Job 389] time-at-processing=1513075801
D [12/Dec/2017:11:50:01 +0100] [Job 389] 2 filters for job:
D [12/Dec/2017:11:50:01 +0100] [Job 389] commandtops (application/vnd.cups-command to printer/Brother-DCP-195C/application/postscript, cost 100)
D [12/Dec/2017:11:50:01 +0100] [Job 389] - (printer/Brother-DCP-195C/application/postscript to printer/Brother-DCP-195C, cost 0)
D [12/Dec/2017:11:50:01 +0100] [Job 389] job-sheets=none,none
D [12/Dec/2017:11:50:01 +0100] [Job 389] argv[0]="Brother-DCP-195C"
D [12/Dec/2017:11:50:01 +0100] [Job 389] argv[1]="389"
D [12/Dec/2017:11:50:01 +0100] [Job 389] argv[2]="kodiak"
D [12/Dec/2017:11:50:01 +0100] [Job 389] argv[3]="Test Page"
D [12/Dec/2017:11:50:01 +0100] [Job 389] argv[4]="1"
D [12/Dec/2017:11:50:01 +0100] [Job 389] argv[5]="job-uuid=urn:uuid:5a0b30b7-0e62-3610-720b-85d190d494e5 job-originating-host-name=localhost date-time-at-creation= date-time-at-processing= time-at-creation=1513075801 time-at-processing=1513075801"
D [12/Dec/2017:11:50:01 +0100] [Job 389] argv[6]="/var/spool/cups/d00389-001"
D [12/Dec/2017:11:50:01 +0100] [Job 389] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [12/Dec/2017:11:50:01 +0100] [Job 389] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [12/Dec/2017:11:50:01 +0100] [Job 389] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc"
D [12/Dec/2017:11:50:01 +0100] [Job 389] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [12/Dec/2017:11:50:01 +0100] [Job 389] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [12/Dec/2017:11:50:01 +0100] [Job 389] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [12/Dec/2017:11:50:01 +0100] [Job 389] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [12/Dec/2017:11:50:01 +0100] [Job 389] envp[7]="CUPS_STATEDIR=/run/cups"
D [12/Dec/2017:11:50:01 +0100] [Job 389] envp[8]="HOME=/var/spool/cups/tmp"
D [12/Dec/2017:11:50:01 +0100] [Job 389] envp[9]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/bin:/bin:/usr/bin"
D [12/Dec/2017:11:50:01 +0100] [Job 389] envp[10]="SERVER_ADMIN=root@SIG-NB022"
D [12/Dec/2017:11:50:01 +0100] [Job 389] envp[11]="SOFTWARE=CUPS/2.2.6"
D [12/Dec/2017:11:50:01 +0100] [Job 389] envp[12]="TMPDIR=/var/spool/cups/tmp"
D [12/Dec/2017:11:50:01 +0100] [Job 389] envp[13]="USER=root"
D [12/Dec/2017:11:50:01 +0100] [Job 389] envp[14]="CUPS_MAX_MESSAGE=2047"
D [12/Dec/2017:11:50:01 +0100] [Job 389] envp[15]="CUPS_SERVER=/run/cups/cups.sock"
D [12/Dec/2017:11:50:01 +0100] [Job 389] envp[16]="CUPS_ENCRYPTION=IfRequested"
D [12/Dec/2017:11:50:01 +0100] [Job 389] envp[17]="IPP_PORT=631"
D [12/Dec/2017:11:50:01 +0100] [Job 389] envp[18]="CHARSET=utf-8"
D [12/Dec/2017:11:50:01 +0100] [Job 389] envp[19]="LANG=en_US.UTF-8"
D [12/Dec/2017:11:50:01 +0100] [Job 389] envp[20]="PPD=/etc/cups/ppd/Brother-DCP-195C.ppd"
D [12/Dec/2017:11:50:01 +0100] [Job 389] envp[21]="RIP_MAX_CACHE=128m"
D [12/Dec/2017:11:50:01 +0100] [Job 389] envp[22]="CONTENT_TYPE=application/vnd.cups-command"
D [12/Dec/2017:11:50:01 +0100] [Job 389] envp[23]="DEVICE_URI=usb://Brother/DCP-195C?serial=BROH3F241025"
D [12/Dec/2017:11:50:01 +0100] [Job 389] envp[24]="PRINTER_INFO=Brother DCP-195C"
D [12/Dec/2017:11:50:01 +0100] [Job 389] envp[25]="PRINTER_LOCATION="
D [12/Dec/2017:11:50:01 +0100] [Job 389] envp[26]="PRINTER=Brother-DCP-195C"
D [12/Dec/2017:11:50:01 +0100] [Job 389] envp[27]="PRINTER_STATE_REASONS=none"
D [12/Dec/2017:11:50:01 +0100] [Job 389] envp[28]="CUPS_FILETYPE=document"
D [12/Dec/2017:11:50:01 +0100] [Job 389] envp[29]="FINAL_CONTENT_TYPE=application/postscript"
D [12/Dec/2017:11:50:01 +0100] [Job 389] envp[30]="AUTH_I****"
D [12/Dec/2017:11:50:01 +0100] [Job 389] Started filter /usr/lib/cups/filter/commandtops (PID 1112)
D [12/Dec/2017:11:50:01 +0100] [Job 389] Started backend /usr/lib/cups/backend/usb (PID 1113)
D [12/Dec/2017:11:50:01 +0100] [Job 389] Set job-printer-state-message to "Invalid printer command \"Clean\".", current level=ERROR
D [12/Dec/2017:11:50:01 +0100] [Job 389] PID 1112 (/usr/lib/cups/filter/commandtops) stopped with status 1.
D [12/Dec/2017:11:50:01 +0100] [Job 389] Hint: Try setting the LogLevel to "debug" to find out more.
D [12/Dec/2017:11:50:01 +0100] [Job 389] Loading USB quirks from \"/usr/share/cups/usb\".
D [12/Dec/2017:11:50:01 +0100] [Job 389] Loaded 85 quirks.
D [12/Dec/2017:11:50:01 +0100] [Job 389] Printing on printer with URI: usb://Brother/DCP-195C?serial=BROH3F241025
D [12/Dec/2017:11:50:01 +0100] [Job 389] libusb_get_device_list=10
D [12/Dec/2017:11:50:01 +0100] [Job 389] STATE: +connecting-to-device
D [12/Dec/2017:11:50:01 +0100] [Job 389] STATE: -connecting-to-device
D [12/Dec/2017:11:50:01 +0100] [Job 389] Printer found with device ID: MFG:Brother;CMD:HBP,BRPJL;MDL:DCP-195C;CLS:PRINTER; Device URI: usb://Brother/DCP-195C?serial=BROH3F241025
D [12/Dec/2017:11:50:01 +0100] [Job 389] Device protocol: 2
D [12/Dec/2017:11:50:01 +0100] [Job 389] Sending data to printer.
D [12/Dec/2017:11:50:01 +0100] [Job 389] Sent 0 bytes...
D [12/Dec/2017:11:50:01 +0100] [Job 389] Waiting for read thread to exit...
D [12/Dec/2017:11:50:01 +0100] [Job 389] PID 1113 (/usr/lib/cups/backend/usb) exited with no errors.
D [12/Dec/2017:11:50:01 +0100] [Job 389] End of messages
D [12/Dec/2017:11:50:01 +0100] [Job 389] printer-state=3(idle)
D [12/Dec/2017:11:50:01 +0100] [Job 389] printer-state-message="Sending data to printer."
D [12/Dec/2017:11:50:01 +0100] [Job 389] printer-state-reasons=none
W [12/Dec/2017:11:56:32 +0100] CreateProfile failed: org.freedesktop.ColorManager.AlreadyExists:profile id \'brother-Gray..\' already exists
W [12/Dec/2017:11:56:32 +0100] CreateProfile failed: org.freedesktop.ColorManager.AlreadyExists:profile id \'brother-RGB..\' already exists$ lpinfo -v
network socket
file cups-pdf:/
network https
file cups-brf:/
network beh
network ipps
network lpd
network http
network ipp
network smb$ lsmod | grep usblp
usblp 24576 0
usbcore 245760 7 uvcvideo,usbhid,usb_storage,ehci_hcd,usblp,uas,ehci_pci$ groups
sys lp wheel users kodiakSo nothing gets printed :-( - any ideas?
Last edited by kodiak (2018-05-11 11:20:15)
Offline
I can confirm hat printer is working. I have another Laptop running an arch installation from 2015 and the printer runs smoothly.
Here another output from
cat /usr/lib/cups/backend/usbDEBUG: Resetting printer.
?interface=&interface=?serial=??serial=LexmarkHPPrinterUnknown ModelSTATE: +connecting-to-device
STATE: -connecting-to-device
SERIALNUMBERSERNSNMANUFACTURERMFGMODELMDLHewlett-PackardLexmark InternationalDESCRIPTIONDES?serial=%s&interface=%d?serial=%s?interface=%d/%s%sDEBUG: Device protocol: %d
DEBUG: list_devices
INFODEBUG: Fatal USB error.
ERRORusb-unidirnoofffalseusb-no-reattachSending data to printer.PAGE: 1 1
Unable to read print data.DEBUG: selectDEBUG: readDEBUG: Sent %lld bytes...
Unable to open print fileDEBUG: Loading USB quirks from "%s".
DEBUG: Unable to allocate memory for quirkDEBUG: Read %d bytes of back-channel data...
DEBUG: Got USB transaction timeout during read.
DEBUG: Got USB pipe stalled during read.
DEBUG: Got USB return aborted during read.
DEBUG: CUPS_SC_CMD_SOFT_RESET received from driver...
DEBUG: Returning status CUPS_STATUS_OK with no bytes...
DEBUG: CUPS_SC_CMD_DRAIN_OUTPUT received from driver...
DEBUG: CUPS_SC_CMD_GET_BIDI received from driver...
DEBUG: Returned CUPS_SC_STATUS_OK with 1 byte (%02X)...
DEBUG: CUPS_SC_CMD_GET_DEVICE_ID received from driver...
DEBUG: Returning CUPS_SC_STATUS_OK with %d bytes (%s)...
DEBUG: CUPS_SC_CMD_GET_STATE received from driver...
DEBUG: CUPS_SC_CMD_GET_CONNECTED received from driver...
DEBUG: Unknown side-channel command (%d) received from driver...
DEBUG: Returned CUPS_SC_STATUS_NOT_IMPLEMENTED with no bytes...
DEBUG: Restoring USB device configuration: %d -> %d
DEBUG: Failed to set configuration %d
DEBUG: Failed to set configuration %d for %04x:%04x
DEBUG: Failed to re-attach "usblp" kernel module
DEBUG: Failed to re-attach "usblp" kernel module to %04x:%04x
DEBUG: Failed to get configuration descriptor %d
DEBUG: Device reset failed, error code: %d
DEBUG: Unable to initialize USB access via libusb, libusb error %i
DEBUG: libusb_get_device_list=%d
DEBUG: Printer does not report class 7 and/or subclass 1 but works as a printer anyway
DEBUG: Failed to open device, code: %d
DEBUG: Failed to get device descriptor, code: %d
DEBUG: Failed to detach "usblp" module from %04x:%04x
DEBUG: Failed to check whether %04x:%04x has the "usblp" kernel module attached
DEBUG: Failed to get config descriptor for %04x:%04x
DEBUG: Switching USB device configuration: %d -> %d
DEBUG: Failed to claim interface %d for %04x:%04x: %s
DEBUG: Failed to set alternate interface %d for %04x:%04x: %s
DEBUG2: Printer found with device ID: %s Device URI: %s
DEBUG: Printer reports bi-di support but in reality works only uni-directionally
DEBUG: Uni-directional USB communication only!
DEBUG: Printer does not like usblp kernel module to be re-attached after job
DEBUG: Printing on printer with URI: %s
Waiting for printer to become available.There was an unrecoverable USB error.DEBUG: Couldn't create side-channel thread.
DEBUG: Forced uni-directional communication via "usb-unidir" option.
DEBUG: Forced not re-attaching the usblp kernel module after the job via "usb-no-reattach" option.
DEBUG: Couldn't create read thread.
DEBUG: Uni-directional device/mode, back channel deactivated.
DEBUG: Received an interrupt before any bytes were written, aborting.
DEBUG: Read %d bytes of print data...
DEBUG: Got USB transaction timeout during write.
DEBUG: Got USB pipe stalled during write.
DEBUG: Got USB return aborted during write.
Unable to send data to printer.DEBUG: libusb write operation returned %x.
DEBUG: Wrote %d bytes of print data...
DEBUG: Sending print file, %lld bytes...
DEBUG: Waiting for read thread to exit...
DEBUG: Read thread still active, aborting the pending read..Looks like something is going wrong with USB? Blacklisting usblp did not help.
Last edited by kodiak (2017-12-30 10:26:01)
Offline
Turned out to be a permission problem:
https://wiki.archlinux.org/index.php/CU … ermissions
Though I do not know what caused it.
Offline