You are not logged in.

Pages: 1

#1 2010-07-04 08:43:52

artturi
Member
Registered: 2010-04-10
Posts: 10

[SOLVED] brother dcp7030 & cups : error when printing

Hello,

I have a brother dcp7030 sad and thanks to package brother-dcp7030 in aur, I've been able to use it until yesterday.

When I try to print, I get this in /var/log/cups/error_log :

D [04/Jul/2010:10:36:14 +0200] cupsdSetBusyState: Printing jobs
D [04/Jul/2010:10:36:19 +0200] [Job 287] usb_find_busses=0
D [04/Jul/2010:10:36:19 +0200] [Job 287] usb_find_devices=0
D [04/Jul/2010:10:36:19 +0200] [Job 287] STATE: +connecting-to-device
D [04/Jul/2010:10:36:19 +0200] [Job 287] Failed to set configuration 1 for 04f9:01ea
D [04/Jul/2010:10:36:19 +0200] [Job 287] Failed to claim interface 0 for 04f9:01ea: Operation not permitted
D [04/Jul/2010:10:36:19 +0200] [Job 287] STATE: -connecting-to-device
I [04/Jul/2010:10:36:19 +0200] [Job 287] Waiting for printer to become available...
D [04/Jul/2010:10:36:19 +0200] cupsdMarkDirty(-----S)
D [04/Jul/2010:10:36:19 +0200] cupsdSetBusyState: Printing jobs and dirty files
D [04/Jul/2010:10:36:24 +0200] [Job 287] usb_find_busses=0
D [04/Jul/2010:10:36:24 +0200] [Job 287] usb_find_devices=0
D [04/Jul/2010:10:36:24 +0200] [Job 287] STATE: +connecting-to-device
D [04/Jul/2010:10:36:24 +0200] [Job 287] Failed to set configuration 1 for 04f9:01ea
D [04/Jul/2010:10:36:24 +0200] [Job 287] Failed to claim interface 0 for 04f9:01ea: Operation not permitted
D [04/Jul/2010:10:36:24 +0200] [Job 287] STATE: -connecting-to-device
I [04/Jul/2010:10:36:24 +0200] [Job 287] Waiting for printer to become available...
D [04/Jul/2010:10:36:24 +0200] cupsdMarkDirty(-----S)

I also sometimes get this error in /var/log/kernel.log, bt not systematically :

Jul  4 10:13:54 miniacer kernel: brcupsconfig3[4249]: segfault at 2d373333 ip 00000000f76224f8 sp 00000000ffc63b94 error 6 in libc-2.12.so[f75ae000+145000]

The configuration for this printer worked, so the following elements were configured :

- usblp not loaded
- following udev rules set :

ACTION=="add", SUBSYSTEM=="usb", ENV{DEVTYPE}=="usb_device", ID_USB_INTERFACES="04f9:01ea", GROUP="lp", MODE="666"
SUBSYSTEM=="usb",ATTRS{idVendor}=="04f9",ATTRS{idProduct}=="01ea",MODE="0666",GROUP="lp",SYMLINK+="scanner"
ACTION=="add", ATTR{idVendor}=="04f9", GOTO="brscan3"
GOTO="brscan3_end"
LABEL="brscan3"
ATTR{idProduct}=="0206", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"
ATTR{idProduct}=="0204", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"
ATTR{idProduct}=="0205", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"
ATTR{idProduct}=="0201", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"
ATTR{idProduct}=="0200", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"
ATTR{idProduct}=="01ff", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"
ATTR{idProduct}=="01fe", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"
ATTR{idProduct}=="01fd", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"
ATTR{idProduct}=="01fb", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"
ATTR{idProduct}=="01fa", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"
ATTR{idProduct}=="01f9", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"
ATTR{idProduct}=="01f8", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"
ATTR{idProduct}=="01f7", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"
ATTR{idProduct}=="01f6", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"
ATTR{idProduct}=="01f5", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"
ATTR{idProduct}=="01f4", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"
ATTR{idProduct}=="01f1", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"
ATTR{idProduct}=="01f3", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"
ATTR{idProduct}=="01f2", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"
ATTR{idProduct}=="01f0", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"
ATTR{idProduct}=="01ef", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"
ATTR{idProduct}=="0207", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"
ATTR{idProduct}=="0208", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"
ATTR{idProduct}=="0203", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"
ATTR{idProduct}=="0202", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"
ATTR{idProduct}=="01fc", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"
ATTR{idProduct}=="01ee", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"
ATTR{idProduct}=="01ed", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"
ATTR{idProduct}=="01eb", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"
ATTR{idProduct}=="01ea", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"
ATTR{idProduct}=="01e9", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"
ATTR{idProduct}=="01e8", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"
ATTR{idProduct}=="01e7", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"
ATTR{idProduct}=="01e6", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"
ATTR{idProduct}=="01e5", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"
ATTR{idProduct}=="0218", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"
ATTR{idProduct}=="021f", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"
ATTR{idProduct}=="0217", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"
ATTR{idProduct}=="0216", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"
ATTR{idProduct}=="0215", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"
LABEL="brscan3_end"

This seems to be taken in account as demonstrated that way :

# lsusb 
Bus 002 Device 005: ID 04f9:01ea Brother Industries, Ltd 

# ls -l /dev/bus/usb/002/
total 0
crw-rw-rw- 1 root lp      189, 128 Jul  4  2010 001
crw-rw-rw- 1 root lp      189, 129 Jul  4  2010 002
crw-rw-rw- 1 root lp      189, 130 Jul  4  2010 003
crw-rw-r-- 1 root scanner 189, 132 Jul  4 10:27 005

Putting udev in debug mode gives this when plugging the printer :


Jul  4 10:27:53 miniacer udevd[798]: seq 1392 queued, 'add' 'usb'
Jul  4 10:27:53 miniacer udevd[798]: passed 283 bytes to netlink monitor 0x1b61230
Jul  4 10:27:53 miniacer udevd-work[3588]: seq 1392 running
Jul  4 10:27:53 miniacer udevd-work[3588]: device 0x1b71190 has devpath '/devices/pci0000:00/0000:00:0b.0/usb2/2-3'
Jul  4 10:27:53 miniacer udevd-work[3588]: LINK 'char/189:132' /lib/udev/rules.d/50-udev-default.rules:4
Jul  4 10:27:53 miniacer udevd-work[3588]: MODE 0664 /lib/udev/rules.d/50-udev-default.rules:59
Jul  4 10:27:53 miniacer udevd-work[3588]: IMPORT 'usb_id --export /devices/pci0000:00/0000:00:0b.0/usb2/2-3' /lib/udev/rules.d/50-udev-default.rules:70
Jul  4 10:27:53 miniacer udevd-work[3588]: 'usb_id --export /devices/pci0000:00/0000:00:0b.0/usb2/2-3' started
Jul  4 10:27:53 miniacer usb_id[4450]: custom logging function 0x1387010 registered
Jul  4 10:27:53 miniacer udevd[798]: seq 1393 queued, 'add' 'usb'
Jul  4 10:27:53 miniacer udevd[798]: seq 1394 queued, 'add' 'usb'
Jul  4 10:27:53 miniacer udevd-work[3588]: '/lib/udev/usb_id' (stdout) 'ID_VENDOR=04f9'
Jul  4 10:27:53 miniacer udevd-work[3588]: '/lib/udev/usb_id' (stdout) 'ID_VENDOR_ENC=04f9'
Jul  4 10:27:53 miniacer udevd-work[3588]: '/lib/udev/usb_id' (stdout) 'ID_VENDOR_ID=04f9'
Jul  4 10:27:53 miniacer udevd-work[3588]: '/lib/udev/usb_id' (stdout) 'ID_MODEL=01ea'
Jul  4 10:27:53 miniacer udevd-work[3588]: '/lib/udev/usb_id' (stdout) 'ID_MODEL_ENC=01ea'
Jul  4 10:27:53 miniacer udevd-work[3588]: '/lib/udev/usb_id' (stdout) 'ID_MODEL_ID=01ea'
Jul  4 10:27:53 miniacer udevd-work[3588]: '/lib/udev/usb_id' (stdout) 'ID_REVISION=0100'
Jul  4 10:27:53 miniacer udevd-work[3588]: '/lib/udev/usb_id' (stdout) 'ID_SERIAL=04f9_01ea_000E8N257201'
Jul  4 10:27:53 miniacer udevd-work[3588]: '/lib/udev/usb_id' (stdout) 'ID_SERIAL_SHORT=000E8N257201'
Jul  4 10:27:53 miniacer udevd-work[3588]: '/lib/udev/usb_id' (stdout) 'ID_BUS=usb'
Jul  4 10:27:53 miniacer udevd-work[3588]: '/lib/udev/usb_id' (stdout) 'ID_USB_INTERFACES=:070102:ffffff:'
Jul  4 10:27:53 miniacer udevd-work[3588]: 'usb_id --export /devices/pci0000:00/0000:00:0b.0/usb2/2-3' returned with exitcode 0
Jul  4 10:27:53 miniacer udevd-work[3588]: GROUP 7 /lib/udev/rules.d/50-udev-default.rules:71
Jul  4 10:27:53 miniacer udevd-work[3588]: MODE 0664 /lib/udev/rules.d/50-udev-default.rules:71
Jul  4 10:27:53 miniacer udevd-work[3588]: device 0x1b71480 has devpath '/devices/pci0000:00/0000:00:0b.0/usb2'
Jul  4 10:27:53 miniacer udevd-work[3588]: device 0x1b64fc0 has devpath '/devices/pci0000:00/0000:00:0b.0'
Jul  4 10:27:53 miniacer udevd-work[3588]: device 0x1b65290 has devpath '/devices/pci0000:00'
Jul  4 10:27:53 miniacer udevd-work[3588]: RUN 'socket:@/org/freedesktop/hal/udev_event' /lib/udev/rules.d/90-hal.rules:2
Jul  4 10:27:53 miniacer udevd-work[3588]: GROUP 7 /etc/udev/rules.d/98-libsane.rules:4
Jul  4 10:27:53 miniacer udevd-work[3588]: MODE 0666 /etc/udev/rules.d/98-libsane.rules:4
Jul  4 10:27:53 miniacer udevd-work[3588]: LINK 'scanner' /etc/udev/rules.d/98-libsane.rules:4
Jul  4 10:27:53 miniacer udevd-work[3588]: GROUP 7 /etc/udev/rules.d/98-usblp.rules:1
Jul  4 10:27:53 miniacer udevd-work[3588]: MODE 0666 /etc/udev/rules.d/98-usblp.rules:1
Jul  4 10:27:53 miniacer udevd-work[3588]: GROUP 96 /etc/udev/rules.d/brscan3.rules:33
Jul  4 10:27:53 miniacer udevd-work[3588]: MODE 0664 /etc/udev/rules.d/brscan3.rules:33
Jul  4 10:27:53 miniacer udevd-work[3588]: LINK 'scanner3' /etc/udev/rules.d/brscan3.rules:33
Jul  4 10:27:53 miniacer udevd-work[3588]: no node name set, will use kernel supplied name 'bus/usb/002/005'
Jul  4 10:27:53 miniacer udevd-work[3588]: created db file for '/devices/pci0000:00/0000:00:0b.0/usb2/2-3' in '/dev/.udev/db/usb:2-3'
Jul  4 10:27:53 miniacer udevd-work[3588]: creating device node '/dev/bus/usb/002/005', devnum=189:132, mode=0664, uid=0, gid=96
Jul  4 10:27:53 miniacer udevd-work[3588]: preserve file '/dev/bus/usb/002/005', because it has correct dev_t
Jul  4 10:27:53 miniacer udevd-work[3588]: set permissions /dev/bus/usb/002/005, 020664, uid=0, gid=96
Jul  4 10:27:53 miniacer udevd-work[3588]: creating symlink '/dev/char/189:132' to '../bus/usb/002/005'
Jul  4 10:27:53 miniacer udevd-work[3588]: creating link '/dev/scanner' to '/dev/bus/usb/002/005'
Jul  4 10:27:53 miniacer udevd-work[3588]: creating symlink '/dev/scanner' to 'bus/usb/002/005'
Jul  4 10:27:53 miniacer udevd-work[3588]: creating link '/dev/scanner3' to '/dev/bus/usb/002/005'
Jul  4 10:27:53 miniacer udevd-work[3588]: creating symlink '/dev/scanner3' to 'bus/usb/002/005'
Jul  4 10:27:53 miniacer udevd[798]: seq 1392 done with 0
Jul  4 10:27:53 miniacer udevd[798]: passed 299 bytes to netlink monitor 0x1b61230
Jul  4 10:27:53 miniacer udevd[798]: passed 305 bytes to netlink monitor 0x1b61230
Jul  4 10:27:53 miniacer udevd-work[3588]: passed 573 bytes to socket monitor 0x1b71190
Jul  4 10:27:53 miniacer udevd-work[3588]: passed -1 bytes to netlink monitor 0x1b70fe0
Jul  4 10:27:53 miniacer udevd-work[3588]: seq 1392 processed with 0
Jul  4 10:27:53 miniacer udevd-work[3588]: seq 1393 running
Jul  4 10:27:53 miniacer udevd-work[3588]: device 0x1b611a0 has devpath '/devices/pci0000:00/0000:00:0b.0/usb2/2-3/2-3:1.0'
Jul  4 10:27:53 miniacer udevd-work[3588]: device 0x1b653a0 has devpath '/devices/pci0000:00/0000:00:0b.0/usb2/2-3'
Jul  4 10:27:53 miniacer udevd-work[3588]: device 0x1b61980 has devpath '/devices/pci0000:00/0000:00:0b.0/usb2'
Jul  4 10:27:53 miniacer udevd-work[3588]: device 0x1b71150 has devpath '/devices/pci0000:00/0000:00:0b.0'
Jul  4 10:27:53 miniacer udevd-work[3588]: device 0x1b719c0 has devpath '/devices/pci0000:00'
Jul  4 10:27:53 miniacer udevd-work[3588]: RUN '/lib/udev/load-modules.sh  $env{MODALIAS}' /lib/udev/rules.d/80-drivers.rules:5
Jul  4 10:27:53 miniacer udevd-work[3677]: seq 1394 running
Jul  4 10:27:53 miniacer udevd-work[3677]: device 0x1b6ff80 has devpath '/devices/pci0000:00/0000:00:0b.0/usb2/2-3/2-3:1.1'
Jul  4 10:27:53 miniacer udevd-work[3588]: RUN 'socket:@/org/freedesktop/hal/udev_event' /lib/udev/rules.d/90-hal.rules:2
Jul  4 10:27:53 miniacer udevd-work[3588]: '/lib/udev/load-modules.sh  usb:v04F9p01EAd0100dc00dsc00dp00ic07isc01ip02' started
Jul  4 10:27:53 miniacer udevd-work[3677]: device 0x1b61380 has devpath '/devices/pci0000:00/0000:00:0b.0/usb2/2-3'
Jul  4 10:27:53 miniacer udevd-work[3677]: device 0x1b705c0 has devpath '/devices/pci0000:00/0000:00:0b.0/usb2'
Jul  4 10:27:53 miniacer udevd-work[3677]: device 0x1b708e0 has devpath '/devices/pci0000:00/0000:00:0b.0'
Jul  4 10:27:53 miniacer udevd-work[3677]: device 0x1b70bf0 has devpath '/devices/pci0000:00'
Jul  4 10:27:53 miniacer udevd-work[3677]: RUN '/lib/udev/load-modules.sh  $env{MODALIAS}' /lib/udev/rules.d/80-drivers.rules:5
Jul  4 10:27:53 miniacer udevd-work[3677]: RUN 'socket:@/org/freedesktop/hal/udev_event' /lib/udev/rules.d/90-hal.rules:2
Jul  4 10:27:53 miniacer udevd-work[3677]: '/lib/udev/load-modules.sh  usb:v04F9p01EAd0100dc00dsc00dp00icFFiscFFipFF' started
Jul  4 10:27:53 miniacer udevd-work[3588]: '/lib/udev/load-modules.sh' (stderr) 'WARNING: All config files need .conf: /etc/modprobe.d/sound, it will be ignored in a future release.'
Jul  4 10:27:53 miniacer udevd-work[3677]: '/lib/udev/load-modules.sh' (stderr) 'WARNING: All config files need .conf: /etc/modprobe.d/sound, it will be ignored in a future release.'
Jul  4 10:27:53 miniacer udevd-work[3677]: '/lib/udev/load-modules.sh  usb:v04F9p01EAd0100dc00dsc00dp00icFFiscFFipFF' returned with exitcode 0
Jul  4 10:27:53 miniacer udevd-work[3677]: passed 319 bytes to socket monitor 0x1b70200
Jul  4 10:27:53 miniacer udevd-work[3677]: passed -1 bytes to netlink monitor 0x1b6feb0
Jul  4 10:27:53 miniacer udevd-work[3677]: seq 1394 processed with 0
Jul  4 10:27:53 miniacer udevd[798]: seq 1394 done with 0
Jul  4 10:27:53 miniacer udevd-work[3588]: '/lib/udev/load-modules.sh  usb:v04F9p01EAd0100dc00dsc00dp00ic07isc01ip02' returned with exitcode 0
Jul  4 10:27:53 miniacer udevd-work[3588]: passed 313 bytes to socket monitor 0x1b651a0
Jul  4 10:27:53 miniacer udevd-work[3588]: passed -1 bytes to netlink monitor 0x1b70fe0
Jul  4 10:27:53 miniacer udevd-work[3588]: seq 1393 processed with 0
Jul  4 10:27:53 miniacer udevd[798]: seq 1393 done with 0

Would anybody have an idea about what to do ?

Thanks,

Mikael

Last edited by artturi (2010-07-10 08:57:29)

Offline

#2 2010-07-05 18:36:17

nikel
Member
Registered: 2009-08-23
Posts: 2

Re: [SOLVED] brother dcp7030 & cups : error when printing

It may be a permission Problem:
D [04/Jul/2010:10:36:19 +0200] [Job 287] Failed to claim interface 0 for 04f9:01ea: Operation not permitted

Check, which user had cpus-deamon
# ps aux|grep cups

and see, which mode has device file (may be under /dev/usb/*)

other possibility is, that usbfs is needed. Try:
# mount -t usbfs none /proc/bus/usb

I haven't used the driver for some time. I will test, if it work for me.

Offline

#3 2010-07-06 19:09:25

artturi
Member
Registered: 2010-04-10
Posts: 10

Re: [SOLVED] brother dcp7030 & cups : error when printing

Yes, that was what I thought but :

# ps aux|grep cups
root      3580  0.0  0.2  76040  4328 ?        Ss   20:47   0:00 /usr/sbin/cupsd -C /etc/cups/cupsd.conf
daemon    3583  0.0  0.0  15348  1724 ?        S    20:47   0:00 /bin/sh /usr/lib/cups/filter/brlpdwrapperDCP7030 289 mikael Travaux-SE.pdf 1 noCollate finishings=3 media=A4 number-up=1 outputorder=normal portrait Resolution=300dpi sides=one-sided TonerSaveMode=On job-uuid=urn:uuid:8a61adbc-8b9d-3baf-5fb9-d42ca53acf90 job-originating-host-name=localhost

I thought about changing rights via udev (666 instead of 660) but that did not help...

I also tried "mount -t usbfs none /proc/bus/usb" and restarted cups : not better...

Regards,

Mikael

Offline

#4 2010-07-10 09:00:34

artturi
Member
Registered: 2010-04-10
Posts: 10

Re: [SOLVED] brother dcp7030 & cups : error when printing

Well, it was a permission problem as you said smile

Solved it by changing the forementioned lines like this :

ATTR{idProduct}=="01f5", MODE="0664", GROUP="scanner", SYMLINK+="scanner%n"

to

ATTR{idProduct}=="01f5", MODE="0666", GROUP="scanner", SYMLINK+="scanner%n"

I don't understand what changed in my system as I've downgraded cups, libcups, glibc, my kernel & xorg and the problem persisted but anyway, now I can print...

Thanks for the help

Mikael

Offline

Pages: 1

Board footer

Powered by FluxBB