Microteck Scanmaker V6UPL is working fine with kernel 2.6.11-gentoo-r5, not with new kernel 2.6.14_rc5. My scanner is a usb scanner that uses scsi commands so attaches as a scsi device. Have udev rule that works fine and also makes symlink /dev/scanner to /dev/sg0 as long as using kernel 2.6.11-gentoo-r5 and not the other. /etc/sane.d/microtek.conf looks for either /dev/scanner or /dev/sg0. Have remerged libusb, hotplug, xsane, xsane-backends. Also upgraded to sane-backends-1.0.16-r4 which upgraded a lot of packages to ~amd64 unfortunately. But that has not helped either. For the time going to downgrade back to what had before. Did not do a 'make oldconfig' when making the new kernel. But did make sure that all the stuff that needed to be set were. You can see from the output of 'lsmod' that modules sg, microtek are loaded. Don't know why this is not attaching as a scsi device and keeping it as usb. Hotplug,udev, kernel? Here is a few versions of relevent packages have installed. sys-fs/udev-070-r1 media-gfx/xsane-0.97 media-gfx/sane-backends-1.0.16-r4 going to downgrade back to stable 1.0.15 dev-libs/libusb-0.1.10a sys-apps/hotplug-20040923-r1 sys-apps/hotplug-base-20040401 Break down of attached files: Outputs_2.6.14kernel.txt & Ouputs_2.6.11kernel.txt If tail /var/log/kernel.log you see difference after detects scanner and microtekX6 is seen as scsi. On the 2.6.11-gentoo-r5 kernel it attaches the scsi device, on the 2.6.14_rc5 it still see's it as usb still and never attaches as scsi device. If tail /var/log/hotplug/events will see where with 2.6.11-gentoo-r5 that it is attached to scsi. Where as with 2.6.14_rc5 it is still considered usb. If run sane-find-scanner with 2.6.11-gentoo-r5 it sees /dev/sg0 and symlink /dev/scanner and recognizes the scanner. With 2.6.14_rc5 it misses it completely because there isn't any scsi devices. Nor does it see it as usb either though. It does recognize the venderID and productID of the scanner though. Checked and my scanner Scanmaker V6UPL is still supported and in the kernel microtek.c file. If check output of 'lsusb -vv' it is the same with either kernel used. Output of 'lsusb -t' also produces same tree. If check output of 'lsscsi' with 2.6.11-gentoo-r5 again, scanner is recognized as scsi device. Checking with 2.6.14_rc5 shows no scsi devices attached. Dmesg just shows the same results. That scanner is not being attached as scsi. Output of lsmod & emerge --info for particular kernel. Reproducible: Always Steps to Reproduce: 1. 2. 3.
Created attachment 72261 [details] Output from results with 2.6.11-gentoo-r5 kernel, briefed in notes.
Created attachment 72262 [details] Output from results with 2.6.14 kernel, briefed in notes.
Created attachment 72317 [details] Further output results with 2.6.14 kernel. How kern.log output changes.
Added new attachment (Further output results with 2.6.14_rc5 kernel...) that gives info on when unplug/replug the scanner in. Pretty much switches back and forth between the outputs in kern.log. One time the main diff is: (as shown in first section below): Nov 6 09:56:43 decibels microtek usb (rev 0.4.3): error -22 submitting URB Nov 6 09:56:43 decibels microtek usb (rev 0.4.3): error -22 submitting URB Next time kern.log shows the 2nd section below: Nov 6 10:06:40 decibels microtek usb (rev 0.4.3): could not submit URB! Error was -1 Nov 6 10:06:40 decibels ohci_hcd 0000:00:02.0: GetStatus roothub.portstatus [1] = 0x00100103 PRSC PPS PES CCS Nov 6 10:06:40 decibels usb 2-2: reset full speed USB device using ohci_hcd and address 23 Nov 6 10:06:40 decibels ohci_hcd 0000:00:02.0: GetStatus roothub.portstatus [1] = 0x00100103 PRSC PPS PES CCS Nov 6 10:06:50 decibels scsi: Device offlined - not ready after error recovery: host 13 channel 0 id 0 lun 0
Created attachment 72369 [details] Output from debug.log for both kernels after uncommenting debug in all hotplug files.
Comment on attachment 72262 [details] Output from results with 2.6.14 kernel, briefed in notes. kernel 2.6.14 1) kern.log after plugging in scanner: Nov 8 07:34:33 decibels hub 1-0:1.0: state 5 ports 8 chg 0000 evt 0004 Nov 8 07:34:33 decibels ehci_hcd 0000:00:02.2: GetStatus port 2 status 001002 POWER sig=se0 CSC Nov 8 07:34:33 decibels hub 1-0:1.0: port 2, status 0100, change 0001, 12 Mb/s Nov 8 07:34:33 decibels hub 1-0:1.0: debounce: port 2: total 100ms stable 100ms status 0x100 Nov 8 07:34:33 decibels hub 1-0:1.0: state 5 ports 8 chg 0000 evt 0004 Nov 8 07:34:33 decibels ehci_hcd 0000:00:02.2: GetStatus port 2 status 001803 POWER sig=j CSC CONNECT Nov 8 07:34:33 decibels hub 1-0:1.0: port 2, status 0501, change 0001, 480 Mb/s Nov 8 07:34:34 decibels hub 1-0:1.0: debounce: port 2: total 100ms stable 100ms status 0x501 Nov 8 07:34:34 decibels ehci_hcd 0000:00:02.2: port 2 full speed --> companion Nov 8 07:34:34 decibels ehci_hcd 0000:00:02.2: GetStatus port 2 status 003001 POWER OWNER sig=se0 CONNECT Nov 8 07:34:34 decibels hub 2-0:1.0: state 5 ports 4 chg 0000 evt 0004 Nov 8 07:34:34 decibels ohci_hcd 0000:00:02.0: GetStatus roothub.portstatus [1] = 0x00010101 CSC PPS CCS Nov 8 07:34:34 decibels hub 2-0:1.0: port 2, status 0101, change 0001, 12 Mb/s Nov 8 07:34:34 decibels hub 2-0:1.0: debounce: port 2: total 100ms stable 100ms status 0x101 Nov 8 07:34:34 decibels ohci_hcd 0000:00:02.0: GetStatus roothub.portstatus [1] = 0x00100103 PRSC PPS PES CCS Nov 8 07:34:34 decibels usb 2-2: new full speed USB device using ohci_hcd and address 4 Nov 8 07:34:34 decibels ohci_hcd 0000:00:02.0: GetStatus roothub.portstatus [1] = 0x00100103 PRSC PPS PES CCS Nov 8 07:34:34 decibels usb 2-2: new device strings: Mfr=0, Product=0, SerialNumber=0 Nov 8 07:34:34 decibels usb 2-2: hotplug Nov 8 07:34:34 decibels usb 2-2: adding 2-2:1.0 (config #1, interface 0) Nov 8 07:34:34 decibels usb 2-2:1.0: hotplug Nov 8 07:34:34 decibels microtekX6 2-2:1.0: usb_probe_interface Nov 8 07:34:34 decibels microtekX6 2-2:1.0: usb_probe_interface - got id Nov 8 07:34:34 decibels microtek usb (rev 0.4.3): model Scanmaker V6UPL is not known to be fully supported, reports welcome! Nov 8 07:34:34 decibels scsi1 : microtekX6 ***NOTE: this is where the problem seems to start. Other kernel attaches it to scsi generic sg0 Nov 8 07:34:34 decibels ohci_hcd 0000:00:02.0: urb ffff81002acce780 path 2 ep2in 83160000 cc 8 --> status -75 Nov 8 07:34:34 decibels microtek usb (rev 0.4.3): error -22 submitting URB Nov 8 07:34:34 decibels microtek usb (rev 0.4.3): error -22 submitting URB Nov 8 07:34:34 decibels hub 2-0:1.0: state 5 ports 4 chg 0000 evt 0004 2) /var/log/hotplug/events after plugging in scanner: HOTPLUG_TIME='Tue Nov 8 07:34:34 CST 2005' PHYSDEVPATH=/devices/platform/host1 SUBSYSTEM=scsi_host HOTPLUG_ARGS= DEVPATH=/class/scsi_host/host1 HOTPLUG_TYPE=scsi_host ACTION=add UDEVD_EVENT=1 DEBUG=yes SEQNUM=1093 HOTPLUG_TIME='Tue Nov 8 07:34:35 CST 2005' PHYSDEVPATH=/devices/pci0000:00/0000:00:02.0/usb2/2-2 SUBSYSTEM=usb_device HOTPLUG_ARGS= DEVPATH=/class/usb_device/usbdev2.4 MINOR=131 HOTPLUG_TYPE=usb_device ACTION=add MAJOR=189 UDEVD_EVENT=1 DEVNAME=/dev/usbdev2.4 PHYSDEVDRIVER=usb DEBUG=yes PHYSDEVBUS=usb SEQNUM=1094 3) Output of sane-find-scanner -v (udev rule makes it /dev/sg0 with symlink /dev/scanner). It sees the scanner vender and product, but isn't able to see it connect to /dev decibels david # sane-find-scanner -v This is sane-find-scanner from sane-backends 1.0.16-r4 (same as with 1.0.15) using xsane-0.97 This is sane-find-scanner from sane-backends 1.0.16 # sane-find-scanner will now attempt to detect your scanner. If the # result is different from what you expected, first make sure your # scanner is powered up and properly connected to your computer. searching for SCSI scanners: checking /dev/scanner... failed to open (Invalid argument) checking /dev/sg0... failed to open (Invalid argument) checking /dev/sg1... failed to open (Invalid argument) checking /dev/sg2... failed to open (Invalid argument) checking /dev/sg3... failed to open (Invalid argument) checking /dev/sg4... failed to open (Invalid argument) checking /dev/sg5... failed to open (Invalid argument) checking /dev/sg6... failed to open (Invalid argument) checking /dev/sg7... failed to open (Invalid argument) checking /dev/sg8... failed to open (Invalid argument) checking /dev/sg9... failed to open (Invalid argument) checking /dev/sga... failed to open (Invalid argument) checking /dev/sgb... failed to open (Invalid argument) checking /dev/sgc... failed to open (Invalid argument) checking /dev/sgd... failed to open (Invalid argument) checking /dev/sge... failed to open (Invalid argument) checking /dev/sgf... failed to open (Invalid argument) checking /dev/sgg... failed to open (Invalid argument) checking /dev/sgh... failed to open (Invalid argument) checking /dev/sgi... failed to open (Invalid argument) checking /dev/sgj... failed to open (Invalid argument) checking /dev/sgk... failed to open (Invalid argument) checking /dev/sgl... failed to open (Invalid argument) checking /dev/sgm... failed to open (Invalid argument) checking /dev/sgn... failed to open (Invalid argument) checking /dev/sgo... failed to open (Invalid argument) checking /dev/sgp... failed to open (Invalid argument) checking /dev/sgq... failed to open (Invalid argument) checking /dev/sgr... failed to open (Invalid argument) checking /dev/sgs... failed to open (Invalid argument) checking /dev/sgt... failed to open (Invalid argument) checking /dev/sgu... failed to open (Invalid argument) checking /dev/sgv... failed to open (Invalid argument) checking /dev/sgw... failed to open (Invalid argument) checking /dev/sgx... failed to open (Invalid argument) checking /dev/sgy... failed to open (Invalid argument) checking /dev/sgz... failed to open (Invalid argument) # No SCSI scanners found. If you expected something different, make sure that # you have loaded a SCSI driver for your SCSI adapter. searching for USB scanners: checking /dev/usb/scanner... failed to open (Invalid argument) checking /dev/usb/scanner0... failed to open (Invalid argument) checking /dev/usb/scanner1... failed to open (Invalid argument) checking /dev/usb/scanner2... failed to open (Invalid argument) checking /dev/usb/scanner3... failed to open (Invalid argument) checking /dev/usb/scanner4... failed to open (Invalid argument) checking /dev/usb/scanner5... failed to open (Invalid argument) checking /dev/usb/scanner5... failed to open (Invalid argument) checking /dev/usb/scanner7... failed to open (Invalid argument) checking /dev/usb/scanner8... failed to open (Invalid argument) checking /dev/usb/scanner9... failed to open (Invalid argument) checking /dev/usb/scanner10... failed to open (Invalid argument) checking /dev/usb/scanner11... failed to open (Invalid argument) checking /dev/usb/scanner12... failed to open (Invalid argument) checking /dev/usb/scanner13... failed to open (Invalid argument) checking /dev/usb/scanner14... failed to open (Invalid argument) checking /dev/usb/scanner15... failed to open (Invalid argument) checking /dev/usbscanner... failed to open (Invalid argument) checking /dev/usbscanner0... failed to open (Invalid argument) checking /dev/usbscanner1... failed to open (Invalid argument) checking /dev/usbscanner2... failed to open (Invalid argument) checking /dev/usbscanner3... failed to open (Invalid argument) checking /dev/usbscanner4... failed to open (Invalid argument) checking /dev/usbscanner5... failed to open (Invalid argument) checking /dev/usbscanner6... failed to open (Invalid argument) checking /dev/usbscanner7... failed to open (Invalid argument) checking /dev/usbscanner8... failed to open (Invalid argument) checking /dev/usbscanner9... failed to open (Invalid argument) checking /dev/usbscanner10... failed to open (Invalid argument) checking /dev/usbscanner11... failed to open (Invalid argument) checking /dev/usbscanner12... failed to open (Invalid argument) checking /dev/usbscanner13... failed to open (Invalid argument) checking /dev/usbscanner14... failed to open (Invalid argument) checking /dev/usbscanner15... failed to open (Invalid argument) found USB scanner (vendor=0x05da, product=0x00b6) at libusb:002:004 # Your USB scanner was (probably) detected. It may or may not be supported by # SANE. Try scanimage -L and read the backend's manpage. # Not checking for parallel port scanners. # Most Scanners connected to the parallel port or other proprietary ports # can't be detected by this program. done 4) Starting at line 663 shows my Scanner is supported still in Microtek.c . /* These are taken from the msmUSB.inf file on the Windows driver CD */ const static struct vendor_product mts_supported_products[] = { { "Phantom 336CX", mts_sup_unknown}, { "Phantom 336CX", mts_sup_unknown}, { "Scanmaker X6", mts_sup_alpha}, { "Phantom C6", mts_sup_unknown}, { "Phantom 336CX", mts_sup_unknown}, { "ScanMaker V6USL", mts_sup_unknown}, { "ScanMaker V6USL", mts_sup_unknown}, { "Scanmaker V6UL", mts_sup_unknown}, { "Scanmaker V6UPL", mts_sup_alpha}, }; /* The entries of microtek_table must correspond, line-by-line to the entries of mts_supported_products[]. */ static struct usb_device_id mts_usb_ids [] = { { USB_DEVICE(0x4ce, 0x0300) }, { USB_DEVICE(0x5da, 0x0094) }, { USB_DEVICE(0x5da, 0x0099) }, { USB_DEVICE(0x5da, 0x009a) }, { USB_DEVICE(0x5da, 0x00a0) }, { USB_DEVICE(0x5da, 0x00a3) }, { USB_DEVICE(0x5da, 0x80a3) }, { USB_DEVICE(0x5da, 0x80ac) }, { USB_DEVICE(0x5da, 0x00b6) }, { } /* Terminating entry */ }; 5) lsusb -vv output for scanner Bus 002 Device 004: ID 05da:00b6 Microtek International, Inc. ScanMaker V6UPL Language IDs: none (invalid length string descriptor bf; len=0) Device Descriptor: bLength 18 bDescriptorType 1 bcdUSB 1.00 bDeviceClass 255 Vendor Specific Class bDeviceSubClass 3 bDeviceProtocol 0 bMaxPacketSize0 64 idVendor 0x05da Microtek International, Inc. idProduct 0x00b6 ScanMaker V6UPL bcdDevice 1.00 iManufacturer 0 iProduct 0 iSerial 0 bNumConfigurations 1 Configuration Descriptor: bLength 9 bDescriptorType 2 wTotalLength 39 bNumInterfaces 1 bConfigurationValue 1 iConfiguration 0 bmAttributes 0x40 Self Powered MaxPower 0mA Interface Descriptor: bLength 9 bDescriptorType 4 bInterfaceNumber 0 bAlternateSetting 0 bNumEndpoints 3 bInterfaceClass 0 (Defined at Interface level) bInterfaceSubClass 0 bInterfaceProtocol 0 iInterface 0 Endpoint Descriptor: bLength 7 bDescriptorType 5 bEndpointAddress 0x01 EP 1 OUT bmAttributes 2 Transfer Type Bulk Synch Type none wMaxPacketSize 32 bInterval 0 Endpoint Descriptor: bLength 7 bDescriptorType 5 bEndpointAddress 0x82 EP 2 IN bmAttributes 2 Transfer Type Bulk Synch Type none wMaxPacketSize 32 bInterval 0 Endpoint Descriptor: bLength 7 bDescriptorType 5 bEndpointAddress 0x83 EP 3 IN bmAttributes 2 Transfer Type Bulk Synch Type none wMaxPacketSize 64 bInterval 0 Language IDs: none (invalid length string descriptor bf; len=0) 6) lsusb -t decibels ~ # lsusb -t Bus# 3 `-Dev# 1 Vendor 0x0000 Product 0x0000 Bus# 2 `-Dev# 1 Vendor 0x0000 Product 0x0000 |-Dev# 4 Vendor 0x05da Product 0x00b6 `-Dev# 3 Vendor 0x045e Product 0x0040 Bus# 1 `-Dev# 1 Vendor 0x0000 Product 0x0000 7) decibels david # lsscsi --generic --verbose blank, nothing shows up. 8) decibels david # lsscsi --classic Attached devices: none 9) Dmesg output: david@decibels ~ $ dmesg , IRQ sharing disabled ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A ttyS1 at I/O 0x2f8 (irq = 3) is a 16550A parport0: PC-style at 0x378 [PCSPP,TRISTATE,EPP] parport0: faking semi-colon parport0: Printer, HEWLETT-PACKARD DESKJET 720C lp0: using parport0 (polling). io scheduler noop registered io scheduler anticipatory registered io scheduler deadline registered io scheduler cfq registered (default) Floppy drive(s): fd0 is 1.44M FDC 0 is a post-1991 82077 RAMDISK driver initialized: 16 RAM disks of 4096K size 1024 blocksize loop: loaded (max 8 devices) pktcdvd: v0.2.0a 2004-07-14 Jens Axboe (axboe@suse.de) and petero2@telia.com Uniform Multi-Platform E-IDE driver Revision: 7.00alpha2 ide: Assuming 33MHz system bus speed for PIO modes; override with idebus=xx NFORCE3-250: IDE controller at PCI slot 0000:00:08.0 NFORCE3-250: chipset revision 162 NFORCE3-250: not 100% native mode: will probe irqs later NFORCE3-250: BIOS didn't set cable bits correctly. Enabling workaround. NFORCE3-250: BIOS didn't set cable bits correctly. Enabling workaround. NFORCE3-250: 0000:00:08.0 (rev a2) UDMA133 controller ide0: BM-DMA at 0xf000-0xf007, BIOS settings: hda:DMA, hdb:DMA ide1: BM-DMA at 0xf008-0xf00f, BIOS settings: hdc:DMA, hdd:DMA Probing IDE interface ide0... hda: WDC WD200BB-00AUA1, ATA DISK drive hdb: SAMSUNG SP1604N, ATA DISK drive ide0 at 0x1f0-0x1f7,0x3f6 on irq 14 Probing IDE interface ide1... hdc: LITE-ON COMBO LTC-48161H, ATAPI CD/DVD-ROM drive hdd: SAMSUNG SP1604N, ATA DISK drive ide1 at 0x170-0x177,0x376 on irq 15 Probing IDE interface ide2... Probing IDE interface ide3... Probing IDE interface ide4... Probing IDE interface ide5... hda: max request size: 128KiB hda: Host Protected Area detected. current capacity is 39100223 sectors (20019 MB) native capacity is 39102336 sectors (20020 MB) hda: Host Protected Area disabled. hda: 39102336 sectors (20020 MB) w/2048KiB Cache, CHS=38792/16/63, UDMA(100) hda: cache flushes not supported hda: hda1 hdb: max request size: 1024KiB hdb: Host Protected Area detected. current capacity is 66055248 sectors (33820 MB) native capacity is 312581808 sectors (160041 MB) hdb: Host Protected Area disabled. hdb: 312581808 sectors (160041 MB) w/2048KiB Cache, CHS=19457/255/63, UDMA(100) hdb: cache flushes supported hdb: hdb1 hdb2 < hdb5 hdb6 hdb7 > hdb3 hdb4 hdd: max request size: 1024KiB hdd: 312581808 sectors (160041 MB) w/2048KiB Cache, CHS=19457/255/63, UDMA(100) hdd: cache flushes supported hdd: hdd1 hdd2 hdd3 < hdd5 hdd6 hdd7 > hdc: ATAPI 48X DVD-ROM CD-R/RW drive, 2048kB Cache, UDMA(33) Uniform CD-ROM driver Revision: 3.20 ide-floppy driver 0.99.newide ehci_hcd: block sizes: qh 160 qtd 96 itd 192 sitd 96 ACPI: PCI Interrupt Link [APCL] enabled at IRQ 22 ACPI: PCI Interrupt 0000:00:02.2[C] -> Link [APCL] -> GSI 22 (level, high) -> IRQ 177 PCI: Setting latency timer of device 0000:00:02.2 to 64 ehci_hcd 0000:00:02.2: EHCI Host Controller ehci_hcd 0000:00:02.2: reset hcs_params 0x102488 dbg=1 cc=2 pcc=4 !ppc ports=8 ehci_hcd 0000:00:02.2: reset portroute 0 0 1 1 1 0 1 0 ehci_hcd 0000:00:02.2: reset hcc_params a082 caching frame 256/512/1024 ehci_hcd 0000:00:02.2: debug port 1 ehci_hcd 0000:00:02.2: capability 1000001 at a0 ehci_hcd 0000:00:02.2: new USB bus registered, assigned bus number 1 ehci_hcd 0000:00:02.2: irq 177, io mem 0xfd004000 ehci_hcd 0000:00:02.2: reset command 080002 (park)=0 ithresh=8 period=1024 Reset HALT PCI: cache line size of 64 is not supported by device 0000:00:02.2 ehci_hcd 0000:00:02.2: unable to enable MWI - not fatal. ehci_hcd 0000:00:02.2: init command 010009 (park)=0 ithresh=1 period=256 RUN ehci_hcd 0000:00:02.2: USB 2.0 initialized, EHCI 1.00, driver 10 Dec 2004 ehci_hcd 0000:00:02.2: supports USB remote wakeup usb usb1: default language 0x0409 usb usb1: new device strings: Mfr=3, Product=2, SerialNumber=1 usb usb1: Product: EHCI Host Controller usb usb1: Manufacturer: Linux 2.6.14 ehci_hcd usb usb1: SerialNumber: 0000:00:02.2 usb usb1: hotplug usb usb1: adding 1-0:1.0 (config #1, interface 0) usb 1-0:1.0: hotplug hub 1-0:1.0: usb_probe_interface hub 1-0:1.0: usb_probe_interface - got id hub 1-0:1.0: USB hub found hub 1-0:1.0: 8 ports detected hub 1-0:1.0: standalone hub hub 1-0:1.0: no power switching (usb 1.0) hub 1-0:1.0: individual port over-current protection hub 1-0:1.0: Single TT hub 1-0:1.0: TT requires at most 8 FS bit times (666 ns) hub 1-0:1.0: power on to power good time: 20ms hub 1-0:1.0: local power source is good hub 1-0:1.0: state 5 ports 8 chg 0000 evt 0000 ehci_hcd 0000:00:02.2: GetStatus port 2 status 001803 POWER sig=j CSC CONNECT hub 1-0:1.0: port 2, status 0501, change 0001, 480 Mb/s ohci_hcd: 2005 April 22 USB 1.1 'Open' Host Controller (OHCI) Driver (PCI) ohci_hcd: block sizes: ed 80 td 96 ACPI: PCI Interrupt Link [APCF] enabled at IRQ 21 ACPI: PCI Interrupt 0000:00:02.0[A] -> Link [APCF] -> GSI 21 (level, high) -> IRQ 185 PCI: Setting latency timer of device 0000:00:02.0 to 64 ohci_hcd 0000:00:02.0: OHCI Host Controller ohci_hcd 0000:00:02.0: USB HC TakeOver from BIOS/SMM ohci_hcd 0000:00:02.0: new USB bus registered, assigned bus number 2 ohci_hcd 0000:00:02.0: irq 185, io mem 0xfd002000 ohci_hcd 0000:00:02.0: resetting from state 'reset', control = 0x600 ohci_hcd 0000:00:02.0: OHCI controller state ohci_hcd 0000:00:02.0: OHCI 1.0, NO legacy support registers ohci_hcd 0000:00:02.0: control 0x683 RWE RWC HCFS=operational CBSR=3 ohci_hcd 0000:00:02.0: cmdstatus 0x00000 SOC=0 ohci_hcd 0000:00:02.0: intrstatus 0x00000004 SF ohci_hcd 0000:00:02.0: intrenable 0x8000000a MIE RD WDH ohci_hcd 0000:00:02.0: fminterval a7782edf ohci_hcd 0000:00:02.0: hcca frame #0003 ohci_hcd 0000:00:02.0: roothub.a 01000204 POTPGT=1 NPS NDP=4(4) ohci_hcd 0000:00:02.0: roothub.b 00000000 PPCM=0000 DR=0000 ohci_hcd 0000:00:02.0: roothub.status 00008000 DRWE ohci_hcd 0000:00:02.0: roothub.portstatus [0] 0x00000100 PPS ohci_hcd 0000:00:02.0: roothub.portstatus [1] 0x00000100 PPS ohci_hcd 0000:00:02.0: roothub.portstatus [2] 0x00000100 PPS ohci_hcd 0000:00:02.0: roothub.portstatus [3] 0x00000100 PPS ohci_hcd 0000:00:02.0: created debug files ohci_hcd 0000:00:02.0: supports USB remote wakeup usb usb2: default language 0x0409 usb usb2: new device strings: Mfr=3, Product=2, SerialNumber=1 usb usb2: Product: OHCI Host Controller usb usb2: Manufacturer: Linux 2.6.14 ohci_hcd usb usb2: SerialNumber: 0000:00:02.0 usb usb2: hotplug usb usb2: adding 2-0:1.0 (config #1, interface 0) usb 2-0:1.0: hotplug hub 2-0:1.0: usb_probe_interface hub 2-0:1.0: usb_probe_interface - got id hub 2-0:1.0: USB hub found hub 2-0:1.0: 4 ports detected hub 2-0:1.0: standalone hub hub 2-0:1.0: no power switching (usb 1.0) hub 2-0:1.0: global over-current protection hub 2-0:1.0: power on to power good time: 2ms hub 2-0:1.0: local power source is good hub 2-0:1.0: no over-current condition exists hub 1-0:1.0: debounce: port 2: total 100ms stable 100ms status 0x501 ACPI: PCI Interrupt Link [APCG] enabled at IRQ 20 ACPI: PCI Interrupt 0000:00:02.1[B] -> Link [APCG] -> GSI 20 (level, high) -> IRQ 193 PCI: Setting latency timer of device 0000:00:02.1 to 64 ohci_hcd 0000:00:02.1: OHCI Host Controller ohci_hcd 0000:00:02.1: USB HC TakeOver from BIOS/SMM ehci_hcd 0000:00:02.2: port 2 full speed --> companion ehci_hcd 0000:00:02.2: GetStatus port 2 status 003001 POWER OWNER sig=se0 CONNECT ehci_hcd 0000:00:02.2: GetStatus port 5 status 001403 POWER sig=k CSC CONNECT hub 1-0:1.0: port 5, status 0501, change 0001, 480 Mb/s ohci_hcd 0000:00:02.1: new USB bus registered, assigned bus number 3 ohci_hcd 0000:00:02.1: irq 193, io mem 0xfd003000 ohci_hcd 0000:00:02.1: resetting from state 'reset', control = 0x600 ohci_hcd 0000:00:02.1: OHCI controller state ohci_hcd 0000:00:02.1: OHCI 1.0, NO legacy support registers ohci_hcd 0000:00:02.1: control 0x683 RWE RWC HCFS=operational CBSR=3 ohci_hcd 0000:00:02.1: cmdstatus 0x00000 SOC=0 ohci_hcd 0000:00:02.1: intrstatus 0x00000004 SF ohci_hcd 0000:00:02.1: intrenable 0x8000000a MIE RD WDH ohci_hcd 0000:00:02.1: fminterval a7782edf ohci_hcd 0000:00:02.1: hcca frame #0003 ohci_hcd 0000:00:02.1: roothub.a 01000204 POTPGT=1 NPS NDP=4(4) ohci_hcd 0000:00:02.1: roothub.b 00000000 PPCM=0000 DR=0000 ohci_hcd 0000:00:02.1: roothub.status 00008000 DRWE ohci_hcd 0000:00:02.1: roothub.portstatus [0] 0x00000100 PPS ohci_hcd 0000:00:02.1: roothub.portstatus [1] 0x00000100 PPS ohci_hcd 0000:00:02.1: roothub.portstatus [2] 0x00000100 PPS ohci_hcd 0000:00:02.1: roothub.portstatus [3] 0x00000100 PPS ohci_hcd 0000:00:02.1: created debug files ohci_hcd 0000:00:02.1: supports USB remote wakeup usb usb3: default language 0x0409 usb usb3: new device strings: Mfr=3, Product=2, SerialNumber=1 usb usb3: Product: OHCI Host Controller usb usb3: Manufacturer: Linux 2.6.14 ohci_hcd usb usb3: SerialNumber: 0000:00:02.1 usb usb3: hotplug usb usb3: adding 3-0:1.0 (config #1, interface 0) usb 3-0:1.0: hotplug hub 3-0:1.0: usb_probe_interface hub 3-0:1.0: usb_probe_interface - got id hub 3-0:1.0: USB hub found hub 3-0:1.0: 4 ports detected hub 3-0:1.0: standalone hub hub 3-0:1.0: no power switching (usb 1.0) hub 3-0:1.0: global over-current protection hub 3-0:1.0: power on to power good time: 2ms hub 3-0:1.0: local power source is good hub 3-0:1.0: no over-current condition exists hub 1-0:1.0: debounce: port 5: total 100ms stable 100ms status 0x501 ehci_hcd 0000:00:02.2: port 5 low speed --> companion ehci_hcd 0000:00:02.2: GetStatus port 5 status 003402 POWER OWNER sig=k CSC hub 2-0:1.0: state 5 ports 4 chg 0000 evt 0000 usbcore: registered new driver usblp drivers/usb/class/usblp.c: v0.13: USB Printer Device Class driver Initializing USB Mass Storage driver... ohci_hcd 0000:00:02.0: GetStatus roothub.portstatus [1] = 0x00010101 CSC PPS CCS hub 2-0:1.0: port 2, status 0101, change 0001, 12 Mb/s hub 2-0:1.0: debounce: port 2: total 100ms stable 100ms status 0x101 ohci_hcd 0000:00:02.0: GetStatus roothub.portstatus [1] = 0x00100103 PRSC PPS PES CCS usb 2-2: new full speed USB device using ohci_hcd and address 2 ohci_hcd 0000:00:02.0: GetStatus roothub.portstatus [1] = 0x00100103 PRSC PPS PES CCS usb 2-2: new device strings: Mfr=0, Product=0, SerialNumber=0 usb 2-2: hotplug usb 2-2: adding 2-2:1.0 (config #1, interface 0) usb 2-2:1.0: hotplug ohci_hcd 0000:00:02.0: GetStatus roothub.portstatus [2] = 0x00010301 CSC LSDA PPS CCS hub 2-0:1.0: port 3, status 0301, change 0001, 1.5 Mb/s hub 2-0:1.0: debounce: port 3: total 100ms stable 100ms status 0x301 ohci_hcd 0000:00:02.0: GetStatus roothub.portstatus [2] = 0x00100303 PRSC LSDA PPS PES CCS usb 2-3: new low speed USB device using ohci_hcd and address 3 ohci_hcd 0000:00:02.0: GetStatus roothub.portstatus [2] = 0x00100303 PRSC LSDA PPS PES CCS usb 2-3: skipped 1 descriptor after interface usb 2-3: default language 0x0409 usb 2-3: new device strings: Mfr=1, Product=2, SerialNumber=0 usb 2-3: Product: Microsoft Wheel Mouse Optical
Comment on attachment 72262 [details] Output from results with 2.6.14 kernel, briefed in notes. kernel 2.6.14 1) kern.log after plugging in scanner: Nov 8 07:34:33 decibels hub 1-0:1.0: state 5 ports 8 chg 0000 evt 0004 Nov 8 07:34:33 decibels ehci_hcd 0000:00:02.2: GetStatus port 2 status 001002 POWER sig=se0 CSC Nov 8 07:34:33 decibels hub 1-0:1.0: port 2, status 0100, change 0001, 12 Mb/s Nov 8 07:34:33 decibels hub 1-0:1.0: debounce: port 2: total 100ms stable 100ms status 0x100 Nov 8 07:34:33 decibels hub 1-0:1.0: state 5 ports 8 chg 0000 evt 0004 Nov 8 07:34:33 decibels ehci_hcd 0000:00:02.2: GetStatus port 2 status 001803 POWER sig=j CSC CONNECT Nov 8 07:34:33 decibels hub 1-0:1.0: port 2, status 0501, change 0001, 480 Mb/s Nov 8 07:34:34 decibels hub 1-0:1.0: debounce: port 2: total 100ms stable 100ms status 0x501 Nov 8 07:34:34 decibels ehci_hcd 0000:00:02.2: port 2 full speed --> companion Nov 8 07:34:34 decibels ehci_hcd 0000:00:02.2: GetStatus port 2 status 003001 POWER OWNER sig=se0 CONNECT Nov 8 07:34:34 decibels hub 2-0:1.0: state 5 ports 4 chg 0000 evt 0004 Nov 8 07:34:34 decibels ohci_hcd 0000:00:02.0: GetStatus roothub.portstatus [1] = 0x00010101 CSC PPS CCS Nov 8 07:34:34 decibels hub 2-0:1.0: port 2, status 0101, change 0001, 12 Mb/s Nov 8 07:34:34 decibels hub 2-0:1.0: debounce: port 2: total 100ms stable 100ms status 0x101 Nov 8 07:34:34 decibels ohci_hcd 0000:00:02.0: GetStatus roothub.portstatus [1] = 0x00100103 PRSC PPS PES CCS Nov 8 07:34:34 decibels usb 2-2: new full speed USB device using ohci_hcd and address 4 Nov 8 07:34:34 decibels ohci_hcd 0000:00:02.0: GetStatus roothub.portstatus [1] = 0x00100103 PRSC PPS PES CCS Nov 8 07:34:34 decibels usb 2-2: new device strings: Mfr=0, Product=0, SerialNumber=0 Nov 8 07:34:34 decibels usb 2-2: hotplug Nov 8 07:34:34 decibels usb 2-2: adding 2-2:1.0 (config #1, interface 0) Nov 8 07:34:34 decibels usb 2-2:1.0: hotplug Nov 8 07:34:34 decibels microtekX6 2-2:1.0: usb_probe_interface Nov 8 07:34:34 decibels microtekX6 2-2:1.0: usb_probe_interface - got id Nov 8 07:34:34 decibels microtek usb (rev 0.4.3): model Scanmaker V6UPL is not known to be fully supported, reports welcome! Nov 8 07:34:34 decibels scsi1 : microtekX6 ***NOTE: this is where the problem seems to start. Other kernel attaches it to scsi generic sg0 Nov 8 07:34:34 decibels ohci_hcd 0000:00:02.0: urb ffff81002acce780 path 2 ep2in 83160000 cc 8 --> status -75 Nov 8 07:34:34 decibels microtek usb (rev 0.4.3): error -22 submitting URB Nov 8 07:34:34 decibels microtek usb (rev 0.4.3): error -22 submitting URB Nov 8 07:34:34 decibels hub 2-0:1.0: state 5 ports 4 chg 0000 evt 0004 2) /var/log/hotplug/events after plugging in scanner: HOTPLUG_TIME='Tue Nov 8 07:34:34 CST 2005' PHYSDEVPATH=/devices/platform/host1 SUBSYSTEM=scsi_host HOTPLUG_ARGS= DEVPATH=/class/scsi_host/host1 HOTPLUG_TYPE=scsi_host ACTION=add UDEVD_EVENT=1 DEBUG=yes SEQNUM=1093 HOTPLUG_TIME='Tue Nov 8 07:34:35 CST 2005' PHYSDEVPATH=/devices/pci0000:00/0000:00:02.0/usb2/2-2 SUBSYSTEM=usb_device HOTPLUG_ARGS= DEVPATH=/class/usb_device/usbdev2.4 MINOR=131 HOTPLUG_TYPE=usb_device ACTION=add MAJOR=189 UDEVD_EVENT=1 DEVNAME=/dev/usbdev2.4 PHYSDEVDRIVER=usb DEBUG=yes PHYSDEVBUS=usb SEQNUM=1094 3) Output of sane-find-scanner -v (udev rule makes it /dev/sg0 with symlink /dev/scanner). It sees the scanner vender and product, but isn't able to see it connect to /dev decibels david # sane-find-scanner -v This is sane-find-scanner from sane-backends 1.0.16-r4 (same as with 1.0.15) using xsane-0.97 This is sane-find-scanner from sane-backends 1.0.16 # sane-find-scanner will now attempt to detect your scanner. If the # result is different from what you expected, first make sure your # scanner is powered up and properly connected to your computer. searching for SCSI scanners: checking /dev/scanner... failed to open (Invalid argument) checking /dev/sg0... failed to open (Invalid argument) checking /dev/sg1... failed to open (Invalid argument) checking /dev/sg2... failed to open (Invalid argument) checking /dev/sg3... failed to open (Invalid argument) checking /dev/sg4... failed to open (Invalid argument) checking /dev/sg5... failed to open (Invalid argument) checking /dev/sg6... failed to open (Invalid argument) checking /dev/sg7... failed to open (Invalid argument) checking /dev/sg8... failed to open (Invalid argument) checking /dev/sg9... failed to open (Invalid argument) checking /dev/sga... failed to open (Invalid argument) checking /dev/sgb... failed to open (Invalid argument) checking /dev/sgc... failed to open (Invalid argument) checking /dev/sgd... failed to open (Invalid argument) checking /dev/sge... failed to open (Invalid argument) checking /dev/sgf... failed to open (Invalid argument) checking /dev/sgg... failed to open (Invalid argument) checking /dev/sgh... failed to open (Invalid argument) checking /dev/sgi... failed to open (Invalid argument) checking /dev/sgj... failed to open (Invalid argument) checking /dev/sgk... failed to open (Invalid argument) checking /dev/sgl... failed to open (Invalid argument) checking /dev/sgm... failed to open (Invalid argument) checking /dev/sgn... failed to open (Invalid argument) checking /dev/sgo... failed to open (Invalid argument) checking /dev/sgp... failed to open (Invalid argument) checking /dev/sgq... failed to open (Invalid argument) checking /dev/sgr... failed to open (Invalid argument) checking /dev/sgs... failed to open (Invalid argument) checking /dev/sgt... failed to open (Invalid argument) checking /dev/sgu... failed to open (Invalid argument) checking /dev/sgv... failed to open (Invalid argument) checking /dev/sgw... failed to open (Invalid argument) checking /dev/sgx... failed to open (Invalid argument) checking /dev/sgy... failed to open (Invalid argument) checking /dev/sgz... failed to open (Invalid argument) # No SCSI scanners found. If you expected something different, make sure that # you have loaded a SCSI driver for your SCSI adapter. searching for USB scanners: checking /dev/usb/scanner... failed to open (Invalid argument) checking /dev/usb/scanner0... failed to open (Invalid argument) checking /dev/usb/scanner1... failed to open (Invalid argument) checking /dev/usb/scanner2... failed to open (Invalid argument) checking /dev/usb/scanner3... failed to open (Invalid argument) checking /dev/usb/scanner4... failed to open (Invalid argument) checking /dev/usb/scanner5... failed to open (Invalid argument) checking /dev/usb/scanner5... failed to open (Invalid argument) checking /dev/usb/scanner7... failed to open (Invalid argument) checking /dev/usb/scanner8... failed to open (Invalid argument) checking /dev/usb/scanner9... failed to open (Invalid argument) checking /dev/usb/scanner10... failed to open (Invalid argument) checking /dev/usb/scanner11... failed to open (Invalid argument) checking /dev/usb/scanner12... failed to open (Invalid argument) checking /dev/usb/scanner13... failed to open (Invalid argument) checking /dev/usb/scanner14... failed to open (Invalid argument) checking /dev/usb/scanner15... failed to open (Invalid argument) checking /dev/usbscanner... failed to open (Invalid argument) checking /dev/usbscanner0... failed to open (Invalid argument) checking /dev/usbscanner1... failed to open (Invalid argument) checking /dev/usbscanner2... failed to open (Invalid argument) checking /dev/usbscanner3... failed to open (Invalid argument) checking /dev/usbscanner4... failed to open (Invalid argument) checking /dev/usbscanner5... failed to open (Invalid argument) checking /dev/usbscanner6... failed to open (Invalid argument) checking /dev/usbscanner7... failed to open (Invalid argument) checking /dev/usbscanner8... failed to open (Invalid argument) checking /dev/usbscanner9... failed to open (Invalid argument) checking /dev/usbscanner10... failed to open (Invalid argument) checking /dev/usbscanner11... failed to open (Invalid argument) checking /dev/usbscanner12... failed to open (Invalid argument) checking /dev/usbscanner13... failed to open (Invalid argument) checking /dev/usbscanner14... failed to open (Invalid argument) checking /dev/usbscanner15... failed to open (Invalid argument) found USB scanner (vendor=0x05da, product=0x00b6) at libusb:002:004 # Your USB scanner was (probably) detected. It may or may not be supported by # SANE. Try scanimage -L and read the backend's manpage. # Not checking for parallel port scanners. # Most Scanners connected to the parallel port or other proprietary ports # can't be detected by this program. done 4) Starting at line 663 shows my Scanner is supported still in Microtek.c . /* These are taken from the msmUSB.inf file on the Windows driver CD */ const static struct vendor_product mts_supported_products[] = { { "Phantom 336CX", mts_sup_unknown}, { "Phantom 336CX", mts_sup_unknown}, { "Scanmaker X6", mts_sup_alpha}, { "Phantom C6", mts_sup_unknown}, { "Phantom 336CX", mts_sup_unknown}, { "ScanMaker V6USL", mts_sup_unknown}, { "ScanMaker V6USL", mts_sup_unknown}, { "Scanmaker V6UL", mts_sup_unknown}, { "Scanmaker V6UPL", mts_sup_alpha}, }; /* The entries of microtek_table must correspond, line-by-line to the entries of mts_supported_products[]. */ static struct usb_device_id mts_usb_ids [] = { { USB_DEVICE(0x4ce, 0x0300) }, { USB_DEVICE(0x5da, 0x0094) }, { USB_DEVICE(0x5da, 0x0099) }, { USB_DEVICE(0x5da, 0x009a) }, { USB_DEVICE(0x5da, 0x00a0) }, { USB_DEVICE(0x5da, 0x00a3) }, { USB_DEVICE(0x5da, 0x80a3) }, { USB_DEVICE(0x5da, 0x80ac) }, { USB_DEVICE(0x5da, 0x00b6) }, { } /* Terminating entry */ }; 5) lsusb -vv output for scanner Bus 002 Device 004: ID 05da:00b6 Microtek International, Inc. ScanMaker V6UPL Language IDs: none (invalid length string descriptor bf; len=0) Device Descriptor: bLength 18 bDescriptorType 1 bcdUSB 1.00 bDeviceClass 255 Vendor Specific Class bDeviceSubClass 3 bDeviceProtocol 0 bMaxPacketSize0 64 idVendor 0x05da Microtek International, Inc. idProduct 0x00b6 ScanMaker V6UPL bcdDevice 1.00 iManufacturer 0 iProduct 0 iSerial 0 bNumConfigurations 1 Configuration Descriptor: bLength 9 bDescriptorType 2 wTotalLength 39 bNumInterfaces 1 bConfigurationValue 1 iConfiguration 0 bmAttributes 0x40 Self Powered MaxPower 0mA Interface Descriptor: bLength 9 bDescriptorType 4 bInterfaceNumber 0 bAlternateSetting 0 bNumEndpoints 3 bInterfaceClass 0 (Defined at Interface level) bInterfaceSubClass 0 bInterfaceProtocol 0 iInterface 0 Endpoint Descriptor: bLength 7 bDescriptorType 5 bEndpointAddress 0x01 EP 1 OUT bmAttributes 2 Transfer Type Bulk Synch Type none wMaxPacketSize 32 bInterval 0 Endpoint Descriptor: bLength 7 bDescriptorType 5 bEndpointAddress 0x82 EP 2 IN bmAttributes 2 Transfer Type Bulk Synch Type none wMaxPacketSize 32 bInterval 0 Endpoint Descriptor: bLength 7 bDescriptorType 5 bEndpointAddress 0x83 EP 3 IN bmAttributes 2 Transfer Type Bulk Synch Type none wMaxPacketSize 64 bInterval 0 Language IDs: none (invalid length string descriptor bf; len=0) 6) lsusb -t decibels ~ # lsusb -t Bus# 3 `-Dev# 1 Vendor 0x0000 Product 0x0000 Bus# 2 `-Dev# 1 Vendor 0x0000 Product 0x0000 |-Dev# 4 Vendor 0x05da Product 0x00b6 `-Dev# 3 Vendor 0x045e Product 0x0040 Bus# 1 `-Dev# 1 Vendor 0x0000 Product 0x0000 7) decibels david # lsscsi --generic --verbose blank, nothing shows up. 8) decibels david # lsscsi --classic Attached devices: none 9) Dmesg output: david@decibels ~ $ dmesg , IRQ sharing disabled ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A ttyS1 at I/O 0x2f8 (irq = 3) is a 16550A parport0: PC-style at 0x378 [PCSPP,TRISTATE,EPP] parport0: faking semi-colon parport0: Printer, HEWLETT-PACKARD DESKJET 720C lp0: using parport0 (polling). io scheduler noop registered io scheduler anticipatory registered io scheduler deadline registered io scheduler cfq registered (default) Floppy drive(s): fd0 is 1.44M FDC 0 is a post-1991 82077 RAMDISK driver initialized: 16 RAM disks of 4096K size 1024 blocksize loop: loaded (max 8 devices) pktcdvd: v0.2.0a 2004-07-14 Jens Axboe (axboe@suse.de) and petero2@telia.com Uniform Multi-Platform E-IDE driver Revision: 7.00alpha2 ide: Assuming 33MHz system bus speed for PIO modes; override with idebus=xx NFORCE3-250: IDE controller at PCI slot 0000:00:08.0 NFORCE3-250: chipset revision 162 NFORCE3-250: not 100% native mode: will probe irqs later NFORCE3-250: BIOS didn't set cable bits correctly. Enabling workaround. NFORCE3-250: BIOS didn't set cable bits correctly. Enabling workaround. NFORCE3-250: 0000:00:08.0 (rev a2) UDMA133 controller ide0: BM-DMA at 0xf000-0xf007, BIOS settings: hda:DMA, hdb:DMA ide1: BM-DMA at 0xf008-0xf00f, BIOS settings: hdc:DMA, hdd:DMA Probing IDE interface ide0... hda: WDC WD200BB-00AUA1, ATA DISK drive hdb: SAMSUNG SP1604N, ATA DISK drive ide0 at 0x1f0-0x1f7,0x3f6 on irq 14 Probing IDE interface ide1... hdc: LITE-ON COMBO LTC-48161H, ATAPI CD/DVD-ROM drive hdd: SAMSUNG SP1604N, ATA DISK drive ide1 at 0x170-0x177,0x376 on irq 15 Probing IDE interface ide2... Probing IDE interface ide3... Probing IDE interface ide4... Probing IDE interface ide5... hda: max request size: 128KiB hda: Host Protected Area detected. current capacity is 39100223 sectors (20019 MB) native capacity is 39102336 sectors (20020 MB) hda: Host Protected Area disabled. hda: 39102336 sectors (20020 MB) w/2048KiB Cache, CHS=38792/16/63, UDMA(100) hda: cache flushes not supported hda: hda1 hdb: max request size: 1024KiB hdb: Host Protected Area detected. current capacity is 66055248 sectors (33820 MB) native capacity is 312581808 sectors (160041 MB) hdb: Host Protected Area disabled. hdb: 312581808 sectors (160041 MB) w/2048KiB Cache, CHS=19457/255/63, UDMA(100) hdb: cache flushes supported hdb: hdb1 hdb2 < hdb5 hdb6 hdb7 > hdb3 hdb4 hdd: max request size: 1024KiB hdd: 312581808 sectors (160041 MB) w/2048KiB Cache, CHS=19457/255/63, UDMA(100) hdd: cache flushes supported hdd: hdd1 hdd2 hdd3 < hdd5 hdd6 hdd7 > hdc: ATAPI 48X DVD-ROM CD-R/RW drive, 2048kB Cache, UDMA(33) Uniform CD-ROM driver Revision: 3.20 ide-floppy driver 0.99.newide ehci_hcd: block sizes: qh 160 qtd 96 itd 192 sitd 96 ACPI: PCI Interrupt Link [APCL] enabled at IRQ 22 ACPI: PCI Interrupt 0000:00:02.2[C] -> Link [APCL] -> GSI 22 (level, high) -> IRQ 177 PCI: Setting latency timer of device 0000:00:02.2 to 64 ehci_hcd 0000:00:02.2: EHCI Host Controller ehci_hcd 0000:00:02.2: reset hcs_params 0x102488 dbg=1 cc=2 pcc=4 !ppc ports=8 ehci_hcd 0000:00:02.2: reset portroute 0 0 1 1 1 0 1 0 ehci_hcd 0000:00:02.2: reset hcc_params a082 caching frame 256/512/1024 ehci_hcd 0000:00:02.2: debug port 1 ehci_hcd 0000:00:02.2: capability 1000001 at a0 ehci_hcd 0000:00:02.2: new USB bus registered, assigned bus number 1 ehci_hcd 0000:00:02.2: irq 177, io mem 0xfd004000 ehci_hcd 0000:00:02.2: reset command 080002 (park)=0 ithresh=8 period=1024 Reset HALT PCI: cache line size of 64 is not supported by device 0000:00:02.2 ehci_hcd 0000:00:02.2: unable to enable MWI - not fatal. ehci_hcd 0000:00:02.2: init command 010009 (park)=0 ithresh=1 period=256 RUN ehci_hcd 0000:00:02.2: USB 2.0 initialized, EHCI 1.00, driver 10 Dec 2004 ehci_hcd 0000:00:02.2: supports USB remote wakeup usb usb1: default language 0x0409 usb usb1: new device strings: Mfr=3, Product=2, SerialNumber=1 usb usb1: Product: EHCI Host Controller usb usb1: Manufacturer: Linux 2.6.14 ehci_hcd usb usb1: SerialNumber: 0000:00:02.2 usb usb1: hotplug usb usb1: adding 1-0:1.0 (config #1, interface 0) usb 1-0:1.0: hotplug hub 1-0:1.0: usb_probe_interface hub 1-0:1.0: usb_probe_interface - got id hub 1-0:1.0: USB hub found hub 1-0:1.0: 8 ports detected hub 1-0:1.0: standalone hub hub 1-0:1.0: no power switching (usb 1.0) hub 1-0:1.0: individual port over-current protection hub 1-0:1.0: Single TT hub 1-0:1.0: TT requires at most 8 FS bit times (666 ns) hub 1-0:1.0: power on to power good time: 20ms hub 1-0:1.0: local power source is good hub 1-0:1.0: state 5 ports 8 chg 0000 evt 0000 ehci_hcd 0000:00:02.2: GetStatus port 2 status 001803 POWER sig=j CSC CONNECT hub 1-0:1.0: port 2, status 0501, change 0001, 480 Mb/s ohci_hcd: 2005 April 22 USB 1.1 'Open' Host Controller (OHCI) Driver (PCI) ohci_hcd: block sizes: ed 80 td 96 ACPI: PCI Interrupt Link [APCF] enabled at IRQ 21 ACPI: PCI Interrupt 0000:00:02.0[A] -> Link [APCF] -> GSI 21 (level, high) -> IRQ 185 PCI: Setting latency timer of device 0000:00:02.0 to 64 ohci_hcd 0000:00:02.0: OHCI Host Controller ohci_hcd 0000:00:02.0: USB HC TakeOver from BIOS/SMM ohci_hcd 0000:00:02.0: new USB bus registered, assigned bus number 2 ohci_hcd 0000:00:02.0: irq 185, io mem 0xfd002000 ohci_hcd 0000:00:02.0: resetting from state 'reset', control = 0x600 ohci_hcd 0000:00:02.0: OHCI controller state ohci_hcd 0000:00:02.0: OHCI 1.0, NO legacy support registers ohci_hcd 0000:00:02.0: control 0x683 RWE RWC HCFS=operational CBSR=3 ohci_hcd 0000:00:02.0: cmdstatus 0x00000 SOC=0 ohci_hcd 0000:00:02.0: intrstatus 0x00000004 SF ohci_hcd 0000:00:02.0: intrenable 0x8000000a MIE RD WDH ohci_hcd 0000:00:02.0: fminterval a7782edf ohci_hcd 0000:00:02.0: hcca frame #0003 ohci_hcd 0000:00:02.0: roothub.a 01000204 POTPGT=1 NPS NDP=4(4) ohci_hcd 0000:00:02.0: roothub.b 00000000 PPCM=0000 DR=0000 ohci_hcd 0000:00:02.0: roothub.status 00008000 DRWE ohci_hcd 0000:00:02.0: roothub.portstatus [0] 0x00000100 PPS ohci_hcd 0000:00:02.0: roothub.portstatus [1] 0x00000100 PPS ohci_hcd 0000:00:02.0: roothub.portstatus [2] 0x00000100 PPS ohci_hcd 0000:00:02.0: roothub.portstatus [3] 0x00000100 PPS ohci_hcd 0000:00:02.0: created debug files ohci_hcd 0000:00:02.0: supports USB remote wakeup usb usb2: default language 0x0409 usb usb2: new device strings: Mfr=3, Product=2, SerialNumber=1 usb usb2: Product: OHCI Host Controller usb usb2: Manufacturer: Linux 2.6.14 ohci_hcd usb usb2: SerialNumber: 0000:00:02.0 usb usb2: hotplug usb usb2: adding 2-0:1.0 (config #1, interface 0) usb 2-0:1.0: hotplug hub 2-0:1.0: usb_probe_interface hub 2-0:1.0: usb_probe_interface - got id hub 2-0:1.0: USB hub found hub 2-0:1.0: 4 ports detected hub 2-0:1.0: standalone hub hub 2-0:1.0: no power switching (usb 1.0) hub 2-0:1.0: global over-current protection hub 2-0:1.0: power on to power good time: 2ms hub 2-0:1.0: local power source is good hub 2-0:1.0: no over-current condition exists hub 1-0:1.0: debounce: port 2: total 100ms stable 100ms status 0x501 ACPI: PCI Interrupt Link [APCG] enabled at IRQ 20 ACPI: PCI Interrupt 0000:00:02.1[B] -> Link [APCG] -> GSI 20 (level, high) -> IRQ 193 PCI: Setting latency timer of device 0000:00:02.1 to 64 ohci_hcd 0000:00:02.1: OHCI Host Controller ohci_hcd 0000:00:02.1: USB HC TakeOver from BIOS/SMM ehci_hcd 0000:00:02.2: port 2 full speed --> companion ehci_hcd 0000:00:02.2: GetStatus port 2 status 003001 POWER OWNER sig=se0 CONNECT ehci_hcd 0000:00:02.2: GetStatus port 5 status 001403 POWER sig=k CSC CONNECT hub 1-0:1.0: port 5, status 0501, change 0001, 480 Mb/s ohci_hcd 0000:00:02.1: new USB bus registered, assigned bus number 3 ohci_hcd 0000:00:02.1: irq 193, io mem 0xfd003000 ohci_hcd 0000:00:02.1: resetting from state 'reset', control = 0x600 ohci_hcd 0000:00:02.1: OHCI controller state ohci_hcd 0000:00:02.1: OHCI 1.0, NO legacy support registers ohci_hcd 0000:00:02.1: control 0x683 RWE RWC HCFS=operational CBSR=3 ohci_hcd 0000:00:02.1: cmdstatus 0x00000 SOC=0 ohci_hcd 0000:00:02.1: intrstatus 0x00000004 SF ohci_hcd 0000:00:02.1: intrenable 0x8000000a MIE RD WDH ohci_hcd 0000:00:02.1: fminterval a7782edf ohci_hcd 0000:00:02.1: hcca frame #0003 ohci_hcd 0000:00:02.1: roothub.a 01000204 POTPGT=1 NPS NDP=4(4) ohci_hcd 0000:00:02.1: roothub.b 00000000 PPCM=0000 DR=0000 ohci_hcd 0000:00:02.1: roothub.status 00008000 DRWE ohci_hcd 0000:00:02.1: roothub.portstatus [0] 0x00000100 PPS ohci_hcd 0000:00:02.1: roothub.portstatus [1] 0x00000100 PPS ohci_hcd 0000:00:02.1: roothub.portstatus [2] 0x00000100 PPS ohci_hcd 0000:00:02.1: roothub.portstatus [3] 0x00000100 PPS ohci_hcd 0000:00:02.1: created debug files ohci_hcd 0000:00:02.1: supports USB remote wakeup usb usb3: default language 0x0409 usb usb3: new device strings: Mfr=3, Product=2, SerialNumber=1 usb usb3: Product: OHCI Host Controller usb usb3: Manufacturer: Linux 2.6.14 ohci_hcd usb usb3: SerialNumber: 0000:00:02.1 usb usb3: hotplug usb usb3: adding 3-0:1.0 (config #1, interface 0) usb 3-0:1.0: hotplug hub 3-0:1.0: usb_probe_interface hub 3-0:1.0: usb_probe_interface - got id hub 3-0:1.0: USB hub found hub 3-0:1.0: 4 ports detected hub 3-0:1.0: standalone hub hub 3-0:1.0: no power switching (usb 1.0) hub 3-0:1.0: global over-current protection hub 3-0:1.0: power on to power good time: 2ms hub 3-0:1.0: local power source is good hub 3-0:1.0: no over-current condition exists hub 1-0:1.0: debounce: port 5: total 100ms stable 100ms status 0x501 ehci_hcd 0000:00:02.2: port 5 low speed --> companion ehci_hcd 0000:00:02.2: GetStatus port 5 status 003402 POWER OWNER sig=k CSC hub 2-0:1.0: state 5 ports 4 chg 0000 evt 0000 usbcore: registered new driver usblp drivers/usb/class/usblp.c: v0.13: USB Printer Device Class driver Initializing USB Mass Storage driver... ohci_hcd 0000:00:02.0: GetStatus roothub.portstatus [1] = 0x00010101 CSC PPS CCS hub 2-0:1.0: port 2, status 0101, change 0001, 12 Mb/s hub 2-0:1.0: debounce: port 2: total 100ms stable 100ms status 0x101 ohci_hcd 0000:00:02.0: GetStatus roothub.portstatus [1] = 0x00100103 PRSC PPS PES CCS usb 2-2: new full speed USB device using ohci_hcd and address 2 ohci_hcd 0000:00:02.0: GetStatus roothub.portstatus [1] = 0x00100103 PRSC PPS PES CCS usb 2-2: new device strings: Mfr=0, Product=0, SerialNumber=0 usb 2-2: hotplug usb 2-2: adding 2-2:1.0 (config #1, interface 0) usb 2-2:1.0: hotplug ohci_hcd 0000:00:02.0: GetStatus roothub.portstatus [2] = 0x00010301 CSC LSDA PPS CCS hub 2-0:1.0: port 3, status 0301, change 0001, 1.5 Mb/s hub 2-0:1.0: debounce: port 3: total 100ms stable 100ms status 0x301 ohci_hcd 0000:00:02.0: GetStatus roothub.portstatus [2] = 0x00100303 PRSC LSDA PPS PES CCS usb 2-3: new low speed USB device using ohci_hcd and address 3 ohci_hcd 0000:00:02.0: GetStatus roothub.portstatus [2] = 0x00100303 PRSC LSDA PPS PES CCS usb 2-3: skipped 1 descriptor after interface usb 2-3: default language 0x0409 usb 2-3: new device strings: Mfr=1, Product=2, SerialNumber=0 usb 2-3: Product: Microsoft Wheel Mouse Optical® usb 2-3: Manufacturer: Microsoft usb 2-3: hotplug usb 2-3: adding 2-3:1.0 (config #1, interface 0) usb 2-3:1.0: hotplug hub 3-0:1.0: state 5 ports 4 chg 0000 evt 0000 usbcore: registered new driver usb-storage USB Mass Storage support registered. hub 2-0:1.0: state 5 ports 4 chg 0000 evt 0008 usbhid 2-3:1.0: usb_probe_interface usbhid 2-3:1.0: usb_probe_interface - got id input: USB HID v1.00 Mouse [Microsoft Microsoft Wheel Mouse Optical®] on usb-0000:00:02.0-3 usbcore: registered new driver usbhid drivers/usb/input/hid-core.c: v2.6:USB HID core driver mice: PS/2 mouse device common for all mice Advanced Linux Sound Architecture Driver Version 1.0.10rc1 (Mon Sep 12 08:13:09 2005 UTC). ALSA device list: No soundcards found. NET: Registered protocol family 2 IP route cache hash table entries: 65536 (order: 7, 524288 bytes) TCP established hash table entries: 262144 (order: 9, 2097152 bytes) TCP bind hash table entries: 65536 (order: 7, 524288 bytes) TCP: Hash tables configured (established 262144 bind 65536) TCP reno registered ip_conntrack version 2.3 (4095 buckets, 32760 max) - 296 bytes per conntrack ohci_hcd 0000:00:02.1: suspend root hub ip_tables: (C) 2000-2002 Netfilter core team TCP bic registered NET: Registered protocol family 1 NET: Registered protocol family 17 powernow-k8: Found 1 AMD Athlon 64 / Opteron processors (version 1.50.4) powernow-k8: 0 : fid 0x2 (1000 MHz), vid 0x12 (1100 mV) powernow-k8: 1 : fid 0xa (1800 MHz), vid 0x6 (1400 mV) cpu_init done, current fid 0xa, vid 0x6 ReiserFS: hdb4: found reiserfs format "3.6" with standard journal input: AT Translated Set 2 keyboard on isa0060/serio0 ReiserFS: hdb4: using ordered data mode ReiserFS: hdb4: journal params: device hdb4, size 8192, journal first block 18, max trans len 1024, max batch 900, max commit age 30, max trans age 30 ReiserFS: hdb4: checking transaction log (hdb4) ReiserFS: hdb4: Using r5 hash to sort names VFS: Mounted root (reiserfs filesystem) readonly. Freeing unused kernel memory: 180k freed Adding 489940k swap on /dev/hdb7. Priority:-1 extents:1 across:489940k ACPI: PCI Interrupt Link [APC4] enabled at IRQ 19 ACPI: PCI Interrupt 0000:02:0b.0[A] -> Link [APC4] -> GSI 19 (level, low) -> IRQ 201 skge addr 0xfc000000 irq 201 chip Yukon-Lite rev 9 skge eth0: addr 00:0f:ea:7a:8e:53 ACPI: PCI Interrupt Link [APC3] enabled at IRQ 18 ACPI: PCI Interrupt 0000:02:0a.0[A] -> Link [APC3] -> GSI 18 (level, low) -> IRQ 209 nvidia: module license 'NVIDIA' taints kernel. ACPI: PCI Interrupt Link [APC5] enabled at IRQ 16 ACPI: PCI Interrupt 0000:01:00.0[A] -> Link [APC5] -> GSI 16 (level, low) -> IRQ 217 NVRM: loading NVIDIA Linux x86_64 NVIDIA Kernel Module 1.0-7676 Fri Jul 29 13:15:16 PDT 2005 microtekX6 2-2:1.0: usb_probe_interface microtekX6 2-2:1.0: usb_probe_interface - got id microtek usb (rev 0.4.3): model Scanmaker V6UPL is not known to be fully supported, reports welcome! scsi0 : microtekX6 ohci_hcd 0000:00:02.0: urb ffff81003de17500 path 2 ep2in 83160000 cc 8 --> status -75 microtek usb (rev 0.4.3): error -22 submitting URB microtek usb (rev 0.4.3): error -22 submitting URB usbcore: registered new driver microtekX6 ReiserFS: hdb5: found reiserfs format "3.6" with standard journal ReiserFS: hdb5: using ordered data mode ReiserFS: hdb5: journal params: device hdb5, size 8192, journal first block 18, max trans len 1024, max batch 900, max commit age 30, max trans age 30 ReiserFS: hdb5: checking transaction log (hdb5) ReiserFS: hdb5: Using r5 hash to sort names i2c_adapter i2c-0: nForce2 SMBus adapter at 0x1c00 i2c_adapter i2c-1: nForce2 SMBus adapter at 0x2000 forcedeth.c: Reverse Engineered nForce ethernet driver. Version 0.41. ACPI: PCI Interrupt Link [APCH] enabled at IRQ 22 ACPI: PCI Interrupt 0000:00:05.0[A] -> Link [APCH] -> GSI 22 (level, high) -> IRQ 177 PCI: Setting latency timer of device 0000:00:05.0 to 64 eth1: forcedeth.c: subsystem: 01458:e000 bound to 0000:00:05.0 gameport: EMU10K1 is pci0000:02:0a.1/gameport0, io 0x9400, speed 1196kHz skge eth0: enabling interface skge eth0: Link is up at 100 Mbps, full duplex, flow control tx and rx it87: Found IT8712F chip at 0x290, revision 5 agpgart: Found an AGP 3.0 compliant device at 0000:00:00.0. agpgart: Putting AGP V3 device at 0000:00:00.0 into 8x mode agpgart: Putting AGP V3 device at 0000:01:00.0 into 8x mode agpgart: Found an AGP 3.0 compliant device at 0000:00:00.0. agpgart: Putting AGP V3 device at 0000:00:00.0 into 8x mode agpgart: Putting AGP V3 device at 0000:01:00.0 into 8x mode NVRM: Xid: 17, Head=0 X=1024 Y=768 Refresh=60 10) david@decibels ~ $ lsmod Module Size Used by it87 23520 0 hwmon_vid 2432 1 it87 eeprom 6800 0 i2c_isa 4544 1 it87 snd_seq_midi 7552 0 snd_emu10k1_synth 6912 0 snd_emux_synth 35200 1 snd_emu10k1_synth snd_seq_virmidi 6016 1 snd_emux_synth snd_seq_midi_emul 7808 1 snd_emux_synth emu10k1_gp 3456 0 gameport 12304 2 emu10k1_gp nvidiafb 53280 0 i2c_algo_bit 8520 1 nvidiafb forcedeth 20480 0 i2c_nforce2 6848 0 i2c_core 19480 6 it87,eeprom,i2c_isa,nvidiafb,i2c_algo_bit,i2c_nforce2 microtek 7616 0 nvidia 4379848 12 sg 35256 0 snd_pcm_oss 49952 0 snd_seq_dummy 3204 0 snd_seq_oss 31616 0 snd_seq_midi_event 6848 3 snd_seq_midi,snd_seq_virmidi,snd_seq_oss snd_seq 50944 9 snd_seq_midi,snd_emux_synth,snd_seq_virmidi,snd_seq_midi_emul,snd_seq_dummy,snd _seq_oss,snd_seq_midi_event snd_mixer_oss 16192 1 snd_pcm_oss snd_emu10k1 109508 1 snd_emu10k1_synth snd_rawmidi 22560 3 snd_seq_midi,snd_seq_virmidi,snd_emu10k1 snd_seq_device 7952 8 snd_seq_midi,snd_emu10k1_synth,snd_emux_synth,snd_seq_dummy,snd_seq_oss,snd_seq ,snd_emu10k1,snd_rawmidi snd_ac97_codec 103000 1 snd_emu10k1 snd_pcm 84172 3 snd_pcm_oss,snd_emu10k1,snd_ac97_codec snd_timer 20872 3 snd_seq,snd_emu10k1,snd_pcm snd_ac97_bus 2432 1 snd_ac97_codec snd_page_alloc 9424 2 snd_emu10k1,snd_pcm snd_util_mem 4096 2 snd_emux_synth,snd_emu10k1 snd_hwdep 8608 2 snd_emux_synth,snd_emu10k1 skge 34256 0 11) david@decibels ~ $ emerge info Portage 2.0.51.22-r3 (default-linux/amd64/2005.0, gcc-3.4.4, glibc-2.3.5-r2, 2.6.14 x86_64) ================================================================= System uname: 2.6.14 x86_64 AMD Athlon(tm) 64 Processor 3000+ Gentoo Base System version 1.12.0_pre9 dev-lang/python: 2.4.2 sys-apps/sandbox: 1.2.12 sys-devel/autoconf: 2.13, 2.59-r7 sys-devel/automake: 1.4_p6, 1.5, 1.6.3, 1.7.9-r1, 1.8.5-r3, 1.9.6-r1 sys-devel/binutils: 2.15.92.0.2-r10 sys-devel/libtool: 1.5.20 virtual/os-headers: 2.6.11-r2 ACCEPT_KEYWORDS="amd64" AUTOCLEAN="yes" CBUILD="x86_64-pc-linux-gnu" CFLAGS="-march=athlon64 -O2 -pipe" CHOST="x86_64-pc-linux-gnu" CONFIG_PROTECT="/etc /lib/modules /usr/kde/2/share/config /usr/kde/3.4/env /usr/kde/3.4/share/config /usr/kde/3.4/shutdown /usr/kde/3/share/config /usr/lib/X11/xkb /usr/share/config /var/qmail/alias /var/qmail/control /var/vpopmail/domains /var/vpopmail/etc" CONFIG_PROTECT_MASK="/etc/gconf /etc/splash /etc/terminfo /etc/env.d" CXXFLAGS="-march=athlon64 -O2 -pipe" DISTDIR="/usr/portage/distfiles" FEATURES="autoconfig distlocks sandbox sfperms strict" GENTOO_MIRRORS="http://mirror.datapipe.net/gentoo http://gentoo.mirrors.tds.net/gentoo http://gentoo.seren.com/gentoo" MAKEOPTS="-j2" PKGDIR="/usr/portage/packages" PORTAGE_TMPDIR="/var/tmp" PORTDIR="/usr/portage" PORTDIR_OVERLAY="/usr/local/portage" SYNC="rsync://rsync.namerica.gentoo.org/gentoo-portage" USE="amd64 X aalib alsa arts audiofile avi bitmap-fonts bonobo cdr crypt cups curl dvd eds emboss encode esd fam flac flash foomaticdb fortran gdbm gif gimpprint gnome gphoto2 gpm gstreamer gtk gtk2 gtkhtml guile imagemagick imlib ipv6 java jpeg kde libwww lzw lzw-tiff mad mikmod motif mozilla mp3 mpeg mysql ncurses nls nptl ogg oggvorbis opengl pdflib perl png ppds python qt quicktime readline scanner sdl spell ssl tcpd theora tiff truetype-fonts type1-fonts udev usb userlocales vcd vorbis wmf xml xml2 xmms xpm xv xvid zlib userland_GNU kernel_linux elibc_glibc" Unset: ASFLAGS, CTARGET, LANG, LC_ALL, LDFLAGS, LINGUAS
Comment on attachment 72317 [details] Further output results with 2.6.14 kernel. How kern.log output changes. Further info on the in the 2.6.14 kernel. Sometimes when plug it in kern.log shows (as shown in first section below. This is where it looks like the main problem is.): Nov 8 07:34:34 decibels ohci_hcd 0000:00:02.0: urb ffff81002acce780 path 2 ep2in 83160000 cc 8 --> status -75 Nov 8 07:34:34 decibels microtek usb (rev 0.4.3): error -22 submitting URB Nov 8 07:34:34 decibels microtek usb (rev 0.4.3): error -22 submitting URB Other times kern.log shows the 2nd section below: Nov 6 10:06:40 decibels microtek usb (rev 0.4.3): could not submit URB! Error was -1 Nov 6 10:06:40 decibels ohci_hcd 0000:00:02.0: GetStatus roothub.portstatus [1] = 0x00100103 PRSC PPS PES CCS Nov 6 10:06:40 decibels usb 2-2: reset full speed USB device using ohci_hcd and address 23 Nov 6 10:06:40 decibels ohci_hcd 0000:00:02.0: GetStatus roothub.portstatus [1] = 0x00100103 PRSC PPS PES CCS Nov 6 10:06:50 decibels scsi: Device offlined - not ready after error recovery: host 13 channel 0 id 0 lun 0 Usually this after unplugging, then replugging, the ouputs (section 1 & 2). One time section 1, then next time section 2, sometimes section 2 doesn't show up, but usually does. Section 1 (plugging in scanner) Nov 8 07:34:33 decibels hub 1-0:1.0: state 5 ports 8 chg 0000 evt 0004 Nov 8 07:34:33 decibels ehci_hcd 0000:00:02.2: GetStatus port 2 status 001002 POWER sig=se0 CSC Nov 8 07:34:33 decibels hub 1-0:1.0: port 2, status 0100, change 0001, 12 Mb/s Nov 8 07:34:33 decibels hub 1-0:1.0: debounce: port 2: total 100ms stable 100ms status 0x100 Nov 8 07:34:33 decibels hub 1-0:1.0: state 5 ports 8 chg 0000 evt 0004 Nov 8 07:34:33 decibels ehci_hcd 0000:00:02.2: GetStatus port 2 status 001803 POWER sig=j CSC CONNECT Nov 8 07:34:33 decibels hub 1-0:1.0: port 2, status 0501, change 0001, 480 Mb/s Nov 8 07:34:34 decibels hub 1-0:1.0: debounce: port 2: total 100ms stable 100ms status 0x501 Nov 8 07:34:34 decibels ehci_hcd 0000:00:02.2: port 2 full speed --> companion Nov 8 07:34:34 decibels ehci_hcd 0000:00:02.2: GetStatus port 2 status 003001 POWER OWNER sig=se0 CONNECT Nov 8 07:34:34 decibels hub 2-0:1.0: state 5 ports 4 chg 0000 evt 0004 Nov 8 07:34:34 decibels ohci_hcd 0000:00:02.0: GetStatus roothub.portstatus [1] = 0x00010101 CSC PPS CCS Nov 8 07:34:34 decibels hub 2-0:1.0: port 2, status 0101, change 0001, 12 Mb/s Nov 8 07:34:34 decibels hub 2-0:1.0: debounce: port 2: total 100ms stable 100ms status 0x101 Nov 8 07:34:34 decibels ohci_hcd 0000:00:02.0: GetStatus roothub.portstatus [1] = 0x00100103 PRSC PPS PES CCS Nov 8 07:34:34 decibels usb 2-2: new full speed USB device using ohci_hcd and address 4 Nov 8 07:34:34 decibels ohci_hcd 0000:00:02.0: GetStatus roothub.portstatus [1] = 0x00100103 PRSC PPS PES CCS Nov 8 07:34:34 decibels usb 2-2: new device strings: Mfr=0, Product=0, SerialNumber=0 Nov 8 07:34:34 decibels usb 2-2: hotplug Nov 8 07:34:34 decibels usb 2-2: adding 2-2:1.0 (config #1, interface 0) Nov 8 07:34:34 decibels usb 2-2:1.0: hotplug Nov 8 07:34:34 decibels microtekX6 2-2:1.0: usb_probe_interface Nov 8 07:34:34 decibels microtekX6 2-2:1.0: usb_probe_interface - got id Nov 8 07:34:34 decibels microtek usb (rev 0.4.3): model Scanmaker V6UPL is not known to be fully supported, reports welcome! Nov 8 07:34:34 decibels scsi1 : microtekX6 Nov 8 07:34:34 decibels ohci_hcd 0000:00:02.0: urb ffff81002acce780 path 2 ep2in 83160000 cc 8 --> status -75 Nov 8 07:34:34 decibels microtek usb (rev 0.4.3): error -22 submitting URB Nov 8 07:34:34 decibels microtek usb (rev 0.4.3): error -22 submitting URB Nov 8 07:34:34 decibels hub 2-0:1.0: state 5 ports 4 chg 0000 evt 0004 Section 2 (plugging in scanner, can't always duplicate below. But does it sometimes) Nov 6 10:06:33 decibels hub 1-0:1.0: state 5 ports 8 chg 0000 evt 0004 Nov 6 10:06:33 decibels ehci_hcd 0000:00:02.2: GetStatus port 2 status 001002 POWER sig=se0 CSC Nov 6 10:06:33 decibels hub 1-0:1.0: port 2, status 0100, change 0001, 12 Mb/s Nov 6 10:06:34 decibels hub 1-0:1.0: debounce: port 2: total 100ms stable 100ms status 0x100 Nov 6 10:06:34 decibels hub 1-0:1.0: state 5 ports 8 chg 0000 evt 0004 Nov 6 10:06:34 decibels ehci_hcd 0000:00:02.2: GetStatus port 2 status 001803 POWER sig=j CSC CONNECT Nov 6 10:06:34 decibels hub 1-0:1.0: port 2, status 0501, change 0001, 480 Mb/s Nov 6 10:06:34 decibels hub 1-0:1.0: debounce: port 2: total 100ms stable 100ms status 0x501 Nov 6 10:06:34 decibels ehci_hcd 0000:00:02.2: port 2 full speed --> companion Nov 6 10:06:34 decibels ehci_hcd 0000:00:02.2: GetStatus port 2 status 003001 POWER OWNER sig=se0 CONNECT Nov 6 10:06:34 decibels hub 2-0:1.0: state 5 ports 4 chg 0000 evt 0004 Nov 6 10:06:34 decibels ohci_hcd 0000:00:02.0: GetStatus roothub.portstatus [1] = 0x00010101 CSC PPS CCS Nov 6 10:06:34 decibels hub 2-0:1.0: port 2, status 0101, change 0001, 12 Mb/s Nov 6 10:06:34 decibels hub 2-0:1.0: debounce: port 2: total 100ms stable 100ms status 0x101 Nov 6 10:06:35 decibels ohci_hcd 0000:00:02.0: GetStatus roothub.portstatus [1] = 0x00100103 PRSC PPS PES CCS Nov 6 10:06:35 decibels usb 2-2: new full speed USB device using ohci_hcd and address 23 Nov 6 10:06:35 decibels ohci_hcd 0000:00:02.0: GetStatus roothub.portstatus [1] = 0x00100103 PRSC PPS PES CCS Nov 6 10:06:35 decibels usb 2-2: new device strings: Mfr=0, Product=0, SerialNumber=0 Nov 6 10:06:35 decibels usb 2-2: hotplug Nov 6 10:06:35 decibels usb 2-2: adding 2-2:1.0 (config #1, interface 0) Nov 6 10:06:35 decibels usb 2-2:1.0: hotplug Nov 6 10:06:35 decibels microtekX6 2-2:1.0: usb_probe_interface Nov 6 10:06:35 decibels microtekX6 2-2:1.0: usb_probe_interface - got id Nov 6 10:06:35 decibels microtek usb (rev 0.4.3): model Scanmaker V6UPL is not known to be fully supported, reports welcome! Nov 6 10:06:35 decibels scsi13 : microtekX6 Nov 6 10:06:40 decibels microtek usb (rev 0.4.3): could not submit URB! Error was -1 Nov 6 10:06:40 decibels ohci_hcd 0000:00:02.0: GetStatus roothub.portstatus [1] = 0x00100103 PRSC PPS PES CCS Nov 6 10:06:40 decibels usb 2-2: reset full speed USB device using ohci_hcd and address 23 Nov 6 10:06:40 decibels ohci_hcd 0000:00:02.0: GetStatus roothub.portstatus [1] = 0x00100103 PRSC PPS PES CCS Nov 6 10:06:50 decibels scsi: Device offlined - not ready after error recovery: host 13 channel 0 id 0 lun 0 Nov 6 10:06:51 decibels hub 2-0:1.0: state 5 ports 4 chg 0000 evt 0004
Comment on attachment 72369 [details] Output from debug.log for both kernels after uncommenting debug in all hotplug files. These results are after plugging the scanner in. Output from /var/log/user.log for 2.6.14 Nov 8 07:58:41 decibels default.hotplug[15838]: arguments (scsi_host) env (PHYSDEVPATH=/devices/platform/host7 SUBSYSTEM=scsi_host OLDPWD=/ DEVPATH=/class/scsi_host/host7 ACTION=add PWD=/etc/hotplug UDEVD_EVENT=1 SHLVL=1 DEBUG=yes SEQNUM=1141 _=/bin/env) Nov 8 07:58:41 decibels default.hotplug[15838]: no runnable /etc/hotplug/scsi_host.agent is installed Nov 8 07:58:41 decibels default.hotplug[15838]: log to /var/log/hotplug/events (scsi_host ) Nov 8 07:58:41 decibels default.hotplug[15834]: arguments (usb) env (SUBSYSTEM=usb OLDPWD=/ DEVPATH=/devices/pci0000:00/0000:00:02.0/usb2/2-2 ACTION=add PWD=/etc/hotplug UDEVD_EVENT=1 SHLVL=1 PHYSDEVDRIVER=usb DEBUG=yes PHYSDEVBUS=usb SEQNUM=1139 _=/bin/env) Nov 8 07:58:41 decibels default.hotplug[15834]: invoke /etc/hotplug/usb.agent () Nov 8 07:58:41 decibels default.hotplug[15869]: arguments (usb) env (SUBSYSTEM=usb OLDPWD=/ DEVPATH=/devices/pci0000:00/0000:00:02.0/usb2/2-2/2-2:1.0 ACTION=add MODALIAS=usb:v05DAp00B6d0100dcFFdsc03dp00ic*isc*ip* PWD=/etc/hotplug UDEVD_EVENT=1 SHLVL=1 DEVICE=/proc/bus/usb/002/014 PRODUCT=5da/b6/100 TYPE=255/3/0 DEBUG=yes PHYSDEVBUS=usb SEQNUM=1140 _=/bin/env) Nov 8 07:58:41 decibels default.hotplug[15869]: invoke /etc/hotplug/usb.agent () Nov 8 07:58:41 decibels usb.agent[15869]: Setup microtek for USB product 5da/b6/100 Nov 8 07:58:42 decibels default.hotplug[15905]: arguments (usb_device) env (PHYSDEVPATH=/devices/pci0000:00/0000:00:02.0/usb2/2-2 SUBSYSTEM=usb_device OLDPWD=/ DEVPATH=/class/usb_device/usbdev2.14 MINOR=141 ACTION=add PWD=/etc/hotplug MAJOR=189 UDEVD_EVENT=1 DEVNAME=/dev/usbdev2.14 SHLVL=1 PHYSDEVDRIVER=usb DEBUG=yes PHYSDEVBUS=usb SEQNUM=1142 _=/bin/env) Nov 8 07:58:42 decibels default.hotplug[15905]: no runnable /etc/hotplug/usb_device.agent is installed Nov 8 07:58:42 decibels default.hotplug[15905]: log to /var/log/hotplug/events (usb_device ) Output from /var/log/user.log for 2.6.11-gentoo-r5 Nov 7 08:51:29 decibels default.hotplug[16449]: arguments (usb) env (SUBSYSTEM=usb OLDPWD=/ DEVPATH=/devices/pci0000:00/0000:00:02.0/usb2/2-2 ACTION=add PWD=/etc/hotplug UDEVD_EVENT=1 SHLVL=1 PHYSDEVDRIVER=usb DEBUG=yes PHYSDEVBUS=usb SEQNUM=1151 _=/bin/env) Nov 7 08:51:29 decibels default.hotplug[16449]: invoke /etc/hotplug/usb.agent () Nov 7 08:51:29 decibels default.hotplug[16468]: arguments (scsi) env (SUBSYSTEM=scsi OLDPWD=/ DEVPATH=/devices/platform/host1/target1:0:0/1:0:0:0 ACTION=add PWD=/etc/hotplug UDEVD_EVENT=1 SHLVL=1 DEBUG=yes PHYSDEVBUS=scsi SEQNUM=1154 _=/bin/env) Nov 7 08:51:29 decibels default.hotplug[16468]: invoke /etc/hotplug/scsi.agent () Nov 7 08:51:29 decibels scsi.agent[16468]: how to add device type=scanner at /devices/platform/host1/target1:0:0/1:0:0:0 ?? Nov 7 08:51:29 decibels default.hotplug[16459]: arguments (scsi_host) env (PHYSDEVPATH=/devices/platform/host1 SUBSYSTEM=scsi_host OLDPWD=/ DEVPATH=/class/scsi_host/host1 ACTION=add PWD=/etc/hotplug UDEVD_EVENT=1 SHLVL=1 DEBUG=yes SEQNUM=1153 _=/bin/env) Nov 7 08:51:29 decibels default.hotplug[16459]: no runnable /etc/hotplug/scsi_host.agent is installed Nov 7 08:51:29 decibels default.hotplug[16459]: log to /var/log/hotplug/events (scsi_host ) Nov 7 08:51:29 decibels default.hotplug[16496]: arguments (scsi_device) env (PHYSDEVPATH=/devices/platform/host1/target1:0:0/1:0:0:0 SUBSYSTEM=scsi_device OLDPWD=/ DEVPATH=/class/scsi_device/1:0:0:0 ACTION=add PWD=/etc/hotplug UDEVD_EVENT=1 SHLVL=1 DEBUG=yes PHYSDEVBUS=scsi SEQNUM=1155 _=/bin/env) Nov 7 08:51:29 decibels default.hotplug[16496]: no runnable /etc/hotplug/scsi_device.agent is installed Nov 7 08:51:29 decibels default.hotplug[16496]: log to /var/log/hotplug/events (scsi_device ) Nov 7 08:51:29 decibels default.hotplug[16476]: arguments (usb) env (SUBSYSTEM=usb OLDPWD=/ DEVPATH=/devices/pci0000:00/0000:00:02.0/usb2/2-2/2-2:1.0 ACTION=add PWD=/etc/hotplug UDEVD_EVENT=1 SHLVL=1 DEVICE=/proc/bus/usb/002/007 PRODUCT=5da/b6/100 TYPE=255/3/0 DEBUG=yes PHYSDEVBUS=usb SEQNUM=1152 _=/bin/env) Nov 7 08:51:29 decibels default.hotplug[16476]: invoke /etc/hotplug/usb.agent () Nov 7 08:51:29 decibels usb.agent[16476]: Setup microtek for USB product 5da/b6/100 Nov 7 08:51:30 decibels default.hotplug[16529]: arguments (scsi_generic) env (PHYSDEVPATH=/devices/platform/host1/target1:0:0/1:0:0:0 SUBSYSTEM=scsi_generic OLDPWD=/ DEVPATH=/class/scsi_generic/sg0 ACTION=add PWD=/etc/hotplug UDEVD_EVENT=1 DEVNAME=/dev/sg0 SHLVL=1 DEBUG=yes PHYSDEVBUS=scsi SEQNUM=1156 _=/bin/env) Nov 7 08:51:30 decibels default.hotplug[16529]: no runnable /etc/hotplug/scsi_generic.agent is installed Nov 7 08:51:30 decibels default.hotplug[16529]: log to /var/log/hotplug/events (scsi_generic )
Sorry about Comments #6-8, was trying to edit my outputs from 2.6.14_rc5 kernel cause updated to 2.6.14. Doesn't seem we have a real edit function, so basically it got messed up and they ended up being 'actual' comments to the bug. Sorry. :( Anyway, I did upgrade to the 2.6.14 kernel and same stuff happens: 1) If look at kern.log output it is the same as working kernel, until it gets a ohci_hcd error, thena microtek usb error -22 (whatever that means). 2) You can see from the hotplug events that the working kernel hands it to usb.agent first then then the scsi.agent and works. The 2.6.14 hands it to scsi_host.agent which isn't there and then usb.agent. Then even though sees the scanner all hope is lost already. The 2.6.14 never tries to hand it to the scsi.agent, which might be able to recover the problem. 3) So still don't know at this time if is hotplug or kernel problem. Same hotplug for both kernels though. If someone can delete the comments #6-8 so that just my attachments stay, that would be cool.
This is a kernel problem as signified by the USB error, no need to diagnose other software. This isn't a problem with Gentoo kernels specifically; please file this as an upstream bug at http://bugzilla.kernel.org and post the new bug URL here.
Okay, but I'll have to get a account there first.
Well, since don't have to 'edit' any attachments, I don't think can screw posting the url to new bug at kernel.org here. :) http://bugzilla.kernel.org/show_bug.cgi?id=5579
we have a fix upstream
http://www.kernel.org/pub/linux/kernel/people/gregkh/gregkh-2.6/gregkh-04-usb/usb-adapt-microtek-driver-to-new-scsi-features.patch
Fixed in gentoo-sources-2.6.14-r3 (genpatches-2.6.14-4)
