Linux/Jádro/Chyby/ehci hcd/diary/2008-01-17.Thu

Datum: 2008-01-17.Thu

Diářový záznam, týkající se projevů chybného modulu ehci_hcd (ještě nemuselo být zjevné, že se jedná o tento modul).

@INA

Dostal jsem k vánocům od Ferdy USB čtečku paměťových karet.
Zatím jsem měl se všemi ostatními tady na INA problémy.

kingston technology

Tahle je první, která vypadá, že by mohla fungovat.
Strčil jsem tam MMC kartu 64 MB z mobilu Nokia:

Jádro hlásí (na rootovské konsoli nebo pak ve /var/log/kern.log):
----
usb 4-4: new high speed USB device using ehci_hcd and address 4
usb 4-4: configuration #1 chosen from 1 choice
Initializing USB Mass Storage driver...
scsi2 : SCSI emulation for USB Mass Storage devices
usbcore: registered new interface driver usb-storage
USB Mass Storage support registered.
scsi 2:0:0:0: Direct-Access     Generic  STORAGE DEVICE   93AF PQ: 0 ANSI: 0
scsi 2:0:0:1: Direct-Access     Generic  STORAGE DEVICE   93AF PQ: 0 ANSI: 0
scsi 2:0:0:2: Direct-Access     Generic  STORAGE DEVICE   93AF PQ: 0 ANSI: 0
scsi 2:0:0:3: Direct-Access     Generic  STORAGE DEVICE   93AF PQ: 0 ANSI: 0
sd 2:0:0:0: Attached scsi removable disk sdb
sd 2:0:0:1: Attached scsi removable disk sdc
SCSI device sdd: 125440 512-byte hdwr sectors (64 MB)
sdd: Write Protect is off
sdd: assuming drive cache: write through
SCSI device sdd: 125440 512-byte hdwr sectors (64 MB)
sdd: Write Protect is off
sdd: assuming drive cache: write through
 sdd: sdd1
sd 2:0:0:2: Attached scsi removable disk sdd
sd 2:0:0:3: Attached scsi removable disk sde

------------

/proc/scsi/scsi: 
--
Attached devices:
Host: scsi0 Channel: 00 Id: 00 Lun: 00
  Vendor: ATA      Model: WDC WD3200KS-00P Rev: 21.0
  Type:   Direct-Access                    ANSI  SCSI revision: 05
Host: scsi2 Channel: 00 Id: 00 Lun: 00
  Vendor: Generic  Model: STORAGE DEVICE   Rev: 93AF
  Type:   Direct-Access                    ANSI  SCSI revision: 00
Host: scsi2 Channel: 00 Id: 00 Lun: 01
  Vendor: Generic  Model: STORAGE DEVICE   Rev: 93AF
  Type:   Direct-Access                    ANSI  SCSI revision: 00
Host: scsi2 Channel: 00 Id: 00 Lun: 02
  Vendor: Generic  Model: STORAGE DEVICE   Rev: 93AF
  Type:   Direct-Access                    ANSI  SCSI revision: 00
Host: scsi2 Channel: 00 Id: 00 Lun: 03
  Vendor: Generic  Model: STORAGE DEVICE   Rev: 93AF
  Type:   Direct-Access                    ANSI  SCSI revision: 00
--

Vypadá to, že se namapovala na /dev/sdd :
--
/proc/scsi/usb-storage/2 :
   Host scsi2: usb-storage
       Vendor: Kingston
      Product: FCR-HS215/1
Serial Number: 000014597
     Protocol: Transparent SCSI
    Transport: Bulk
       Quirks:
--
# cfdisk /dev/sdd

Název   Příznaky  Typ oddílu Typ SS [Popis]   Size (MB) Sectors  Cylinders
--------------------------------------------------------------------------
        Pri/Log   Volný prostor                 0,07        128       1
sdd1    Primární  FAT16          [Memorka64]   64,16     125312     979
--

# fdisk /dev/sdd

Disk /dev/sdd: 64 MB, 64225280 bytes
4 heads, 32 sectors/track, 980 cylinders
Units = cylindry of 128 * 512 = 65536 bytes

 Zařízení Boot      Start         End      Blocks   Id  System
/dev/sdd1               2         980       62656    6  FAT16

Disk /dev/sdd: hlav: 4, sektorů: 32, cylindrů: 980

Nr AF  Hd Sec  Cyl  Hd Sec  Cyl     Start      Size ID
 1 00   0   1    1   3  32  979        128     125312 06
 2 00   0   0    0   0   0    0          0          0 00
 3 00   0   0    0   0   0    0          0          0 00
 4 00   0   0    0   0   0    0          0          0 00

--

# sfdisk -l /dev/sdd

Disk /dev/sdd: cylindrů: 980, hlav: 4, sektorů/stopu: 32
Jednotky = cylindry po 65536 bajtech, bloky po 1024 bajtech, počítáno od 0

   Device Boot Start     End   #cyls    #blocks   Id  System
/dev/sdd1          1     979     979      62656    6  FAT16
/dev/sdd2          0       -       0          0    0  Prázdný prostor
/dev/sdd3          0       -       0          0    0  Prázdný prostor
/dev/sdd4          0       -       0          0    0  Prázdný prostor

--

Teď při pokusu o kopírování pomocí mc se zkopírovalo asi 20 souborů a pak:

Chyba:
  Nelze číst zdrojový soubor "/MINOLTA/d/Imag~12008(003).jpg"
  Chyba vstupu/výstupu (5)

          [ Přeskočit ]  [ Zkusit znovu ]  [ Zrušit ]

--

Divné je, že ty původní v tom mc zmizely :-(

/var/log/kern.log:

--
Jan 17 12:46:20 ina kernel: sd 2:0:0:2: Device not ready: <6>: Current: sense key: Not Ready
Jan 17 12:46:20 ina kernel:     Additional sense: Medium not present
Jan 17 12:46:20 ina kernel: end_request: I/O error, dev sdd, sector 119285
Jan 17 12:46:20 ina kernel: sd 2:0:0:2: Device not ready: <6>: Current: sense key: Not Ready
Jan 17 12:46:20 ina kernel:     Additional sense: Medium not present
Jan 17 12:46:20 ina kernel: end_request: I/O error, dev sdd, sector 119285
Jan 17 12:46:33 ina kernel: FAT: FAT read failed (blocknr 234)
Jan 17 12:46:33 ina last message repeated 6 times
Jan 17 12:46:33 ina kernel: Buffer I/O error on device sdd1, logical block 120155
Jan 17 12:46:33 ina kernel: Buffer I/O error on device sdd1, logical block 120156
Jan 17 12:46:33 ina kernel: FAT: FAT read failed (blocknr 234)
Jan 17 12:46:33 ina last message repeated 32 times
Jan 17 12:46:33 ina kernel: Buffer I/O error on device sdd1, logical block 120155
Jan 17 12:46:33 ina kernel: Buffer I/O error on device sdd1, logical block 120156
Jan 17 12:46:36 ina kernel: FAT: FAT read failed (blocknr 237)
Jan 17 12:46:36 ina last message repeated 6 times
Jan 17 12:46:36 ina kernel: Buffer I/O error on device sdd1, logical block 121367
Jan 17 12:46:36 ina kernel: Buffer I/O error on device sdd1, logical block 121368
Jan 17 12:46:36 ina kernel: FAT: FAT read failed (blocknr 237)
Jan 17 12:46:36 ina last message repeated 32 times
Jan 17 12:46:36 ina kernel: Buffer I/O error on device sdd1, logical block 121367
Jan 17 12:46:36 ina kernel: Buffer I/O error on device sdd1, logical block 121368
Jan 17 12:46:37 ina kernel: FAT: FAT read failed (blocknr 239)
Jan 17 12:46:37 ina last message repeated 6 times
Jan 17 12:46:37 ina kernel: Buffer I/O error on device sdd1, logical block 122557
Jan 17 12:46:37 ina kernel: Buffer I/O error on device sdd1, logical block 122558
Jan 17 12:46:37 ina kernel: FAT: FAT read failed (blocknr 239)
Jan 17 12:46:37 ina last message repeated 32 times
Jan 17 12:46:40 ina kernel: FAT: FAT read failed (blocknr 241)
Jan 17 12:46:40 ina last message repeated 6 times
Jan 17 12:46:40 ina kernel: printk: 2 messages suppressed.
Jan 17 12:46:40 ina kernel: Buffer I/O error on device sdd1, logical block 123713
Jan 17 12:46:40 ina kernel: FAT: FAT read failed (blocknr 241)
Jan 17 12:46:40 ina last message repeated 32 times
Jan 17 12:46:48 ina kernel: printk: 3 messages suppressed.
Jan 17 12:46:48 ina kernel: Buffer I/O error on device sdd1, logical block 72086
Jan 17 12:46:48 ina kernel: lost page write due to I/O error on sdd1
Jan 17 12:46:53 ina kernel: FAT: unable to read inode block for updating (i_pos 1541653)
Jan 17 12:47:03 ina kernel: printk: 1 messages suppressed.
Jan 17 12:47:03 ina kernel: Buffer I/O error on device sdd1, logical block 226
Jan 17 12:47:03 ina kernel: lost page write due to I/O error on sdd1
Jan 17 12:47:03 ina kernel: Buffer I/O error on device sdd1, logical block 227
Jan 17 12:47:03 ina kernel: lost page write due to I/O error on sdd1
Jan 17 12:47:03 ina kernel: Buffer I/O error on device sdd1, logical block 228
Jan 17 12:47:03 ina kernel: lost page write due to I/O error on sdd1
Jan 17 12:47:08 ina kernel: FAT: unable to read inode block for updating (i_pos 1541656)
Jan 17 12:47:08 ina kernel: FAT: unable to read inode block for updating (i_pos 1541659)
Jan 17 12:47:08 ina kernel: FAT: unable to read inode block for updating (i_pos 1541662)
Jan 17 12:47:13 ina kernel: FAT: unable to read inode block for updating (i_pos 1153382)
Jan 17 12:47:43 ina kernel: printk: 12 messages suppressed.
Jan 17 12:47:43 ina kernel: Buffer I/O error on device sdd1, logical block 96354
Jan 17 12:47:43 ina kernel: lost page write due to I/O error on sdd1
Jan 17 12:47:46 ina kernel: FAT: FAT read failed (blocknr 3)
Jan 17 12:47:50 ina kernel: FAT: Directory bread(block 72086) failed
Jan 17 12:47:50 ina kernel: FAT: Directory bread(block 96353) failed
Jan 17 12:47:50 ina kernel: FAT: Directory bread(block 96354) failed
Jan 17 12:49:34 ina kernel: FAT: Directory bread(block 72086) failed
Jan 17 12:49:34 ina kernel: FAT: Directory bread(block 96353) failed
Jan 17 12:49:34 ina kernel: FAT: Directory bread(block 96354) failed
Jan 17 12:50:27 ina kernel: FAT: Directory bread(block 72086) failed
Jan 17 12:50:27 ina kernel: FAT: Directory bread(block 96353) failed
Jan 17 12:50:27 ina kernel: FAT: Directory bread(block 96354) failed
Jan 17 12:50:51 ina kernel: FAT: Directory bread(block 72086) failed
Jan 17 12:50:51 ina kernel: FAT: Directory bread(block 96353) failed
Jan 17 12:50:51 ina kernel: FAT: Directory bread(block 96354) failed
Jan 17 12:51:00 ina kernel: FAT: Directory bread(block 72086) failed
Jan 17 12:51:00 ina kernel: FAT: Directory bread(block 96353) failed
Jan 17 12:51:00 ina kernel: FAT: Directory bread(block 96354) failed
Jan 17 12:53:36 ina kernel: FAT: Directory bread(block 72086) failed
Jan 17 12:53:36 ina kernel: FAT: Directory bread(block 96353) failed
Jan 17 12:53:36 ina kernel: FAT: Directory bread(block 96354) failed
Jan 17 12:53:42 ina kernel: FAT: FAT read failed (blocknr 14)
Jan 17 12:53:42 ina last message repeated 6 times
Jan 17 12:53:42 ina kernel: Buffer I/O error on device sdd1, logical block 7539
Jan 17 12:53:42 ina kernel: Buffer I/O error on device sdd1, logical block 7540
Jan 17 12:53:42 ina kernel: FAT: FAT read failed (blocknr 14)
Jan 17 12:53:42 ina last message repeated 32 times
Jan 17 12:53:42 ina kernel: Buffer I/O error on device sdd1, logical block 7539
Jan 17 12:53:42 ina kernel: Buffer I/O error on device sdd1, logical block 7540
Jan 17 12:54:22 ina kernel: FAT: FAT read failed (blocknr 14)
Jan 17 12:54:22 ina last message repeated 5 times
Jan 17 12:54:22 ina kernel: Buffer I/O error on device sdd1, logical block 7539
Jan 17 12:54:22 ina kernel: Buffer I/O error on device sdd1, logical block 7540
Jan 17 12:54:31 ina kernel: FAT: FAT read failed (blocknr 16)
Jan 17 12:54:31 ina last message repeated 6 times
Jan 17 12:54:31 ina kernel: Buffer I/O error on device sdd1, logical block 8303
Jan 17 12:54:31 ina kernel: Buffer I/O error on device sdd1, logical block 8304
Jan 17 12:54:31 ina kernel: FAT: FAT read failed (blocknr 16)
Jan 17 12:54:31 ina last message repeated 32 times
Jan 17 12:54:31 ina kernel: Buffer I/O error on device sdd1, logical block 8303
Jan 17 12:54:31 ina kernel: Buffer I/O error on device sdd1, logical block 8304
Jan 17 12:54:38 ina kernel: FAT: FAT read failed (blocknr 16)
Jan 17 12:54:38 ina last message repeated 5 times
Jan 17 12:54:38 ina kernel: Buffer I/O error on device sdd1, logical block 8303
Jan 17 12:54:38 ina kernel: Buffer I/O error on device sdd1, logical block 8304
Jan 17 12:54:43 ina kernel: Buffer I/O error on device sdd1, logical block 14131
Jan 17 12:54:43 ina kernel: lost page write due to I/O error on sdd1
Jan 17 12:54:43 ina kernel: FAT: FAT read failed (blocknr 16)
Jan 17 12:54:43 ina last message repeated 5 times
Jan 17 12:54:43 ina kernel: Buffer I/O error on device sdd1, logical block 8303
Jan 17 12:54:43 ina kernel: Buffer I/O error on device sdd1, logical block 8304
Jan 17 12:54:48 ina kernel: FAT: FAT read failed (blocknr 18)
Jan 17 12:54:48 ina last message repeated 6 times
Jan 17 12:54:48 ina kernel: Buffer I/O error on device sdd1, logical block 9231
Jan 17 12:54:48 ina kernel: Buffer I/O error on device sdd1, logical block 9232
Jan 17 12:54:48 ina kernel: FAT: FAT read failed (blocknr 18)
Jan 17 12:54:48 ina last message repeated 32 times
Jan 17 12:54:48 ina kernel: Buffer I/O error on device sdd1, logical block 9231
Jan 17 12:54:48 ina kernel: Buffer I/O error on device sdd1, logical block 9232
Jan 17 12:54:53 ina kernel: FAT: unable to read inode block for updating (i_pos 226104)
Jan 17 12:55:03 ina kernel: FAT: unable to read inode block for updating (i_pos 226107)
Jan 17 12:55:18 ina kernel: FAT: unable to read inode block for updating (i_pos 226110)
Jan 17 12:57:06 ina kernel: FAT: Directory bread(block 14131) failed
Jan 17 12:57:06 ina kernel: FAT: Directory bread(block 72086) failed
Jan 17 12:57:06 ina kernel: FAT: Directory bread(block 96353) failed
Jan 17 12:57:06 ina kernel: FAT: Directory bread(block 96354) failed
Jan 17 12:57:06 ina kernel: FAT: Directory bread(block 14131) failed
--

Soubory
	/proc/scsi/usb-storage/2
	/proc/scsi/scsi
se nezměnily

mount:
/dev/sdd1 on /MINOLTA/d type vfat (rw,noexec,nosuid,nodev,user=petr)


# fdisk /dev/sdd
	/dev/sdd nelze otevřít


/sys/block/sdd/stat :
     696       76    18685     8176       21       72       93      412        0     6340     8588 

/sys/block/sdd/sdd1/stat :
     737    18405       93       93 


Podívám se na USB:
/sys/bus/usb/devices :
1-0:1.0
1-1
1-1:1.0
1-1:1.1
2-0:1.0
2-1
2-1:1.0
3-0:1.0
4-0:1.0
4-4
4-4:1.0
usb1
usb2
usb3
usb4


/sys/bus/usb/drivers/usb-storage :
4-4:1.0
bind
module
new_id
unbind


Takže to vypadá, že čtečka je na usb4?



INA zezadu je teď zapojeno (podle /sys/bus/usb/drivers/):


+-------------------------+-------------------------+
| I. klávesnice           | usb-storage (čtečka)    |
|                         | 4-4:1.0                 |
|                         |                         |
+-------------------------+-------------------------+
| II. (na BOSS - teď nic) | usblp (tiskárna)        |
|                         | 2-1:1.0                 |
|                         |                         |
+-------------------------+-------------------------+


zepředu:

+-------------------------+-------------------------+
|                         |                         |
|                         |                         |
|                         |                         |
+-------------------------+-------------------------+


hwinfo:
...

 16: udi = '/org/freedesktop/Hal/devices/usb_device_11b0_6108_000014597_if0'
  info.udi = '/org/freedesktop/Hal/devices/usb_device_11b0_6108_000014597_if0'
  linux.subsystem = 'usb'
  linux.hotplug_type = 1 (0x1)
  info.product = 'USB Mass Storage Interface'
  usb.interface.protocol = 80 (0x50)
  usb.interface.subclass = 6 (0x6)
  usb.interface.class = 8 (0x8)
  usb.interface.number = 0 (0x0)
  info.linux.driver = 'usb-storage'
  usb.linux.sysfs_path = '/sys/devices/pci0000:00/0000:00:10.3/usb4/4-4/4-4:1.0'
  usb.configuration_value = 1 (0x1)
  usb.num_configurations = 1 (0x1)
  usb.num_interfaces = 1 (0x1)
  usb.device_class = 0 (0x0)
  usb.device_subclass = 0 (0x0)
  usb.device_protocol = 0 (0x0)
  usb.vendor_id = 4528 (0x11b0)
  usb.product_id = 24840 (0x6108)
  usb.vendor = 'Kingston'
  usb.product = 'USB Mass Storage Interface'
  usb.device_revision_bcd = 37807 (0x93af)
  usb.max_power = 500 (0x1f4)
  usb.num_ports = 0 (0x0)
  usb.linux.device_number = 4 (0x4)
  usb.serial = '000014597'
  usb.speed_bcd = 294912 (0x48000)
  usb.version_bcd = 512 (0x200)
  usb.is_self_powered = false
  usb.can_wake_up = false
  usb.bus_number = 4 (0x4)
  info.bus = 'usb'
  info.parent = '/org/freedesktop/Hal/devices/usb_device_11b0_6108_000014597'
  linux.sysfs_path_device = '/sys/devices/pci0000:00/0000:00:10.3/usb4/4-4/4-4:1.0'
  linux.sysfs_path = '/sys/devices/pci0000:00/0000:00:10.3/usb4/4-4/4-4:1.0'

17: udi = '/org/freedesktop/Hal/devices/usb_device_11b0_6108_000014597'
  info.udi = '/org/freedesktop/Hal/devices/usb_device_11b0_6108_000014597'
  linux.subsystem = 'usb'
  linux.hotplug_type = 1 (0x1)
  usb_device.bus_number = 4 (0x4)
  usb_device.can_wake_up = false
  usb_device.is_self_powered = false
  usb_device.version_bcd = 512 (0x200)
  usb_device.speed_bcd = 294912 (0x48000)
  usb_device.serial = '000014597'
  usb_device.linux.device_number = 4 (0x4)
  usb_device.num_ports = 0 (0x0)
  usb_device.max_power = 500 (0x1f4)
  usb_device.device_revision_bcd = 37807 (0x93af)
  info.product = 'FCR-HS215/1'
  usb_device.product = 'FCR-HS215/1'
  info.vendor = 'Kingston'
  usb_device.vendor = 'Kingston'
  usb_device.product_id = 24840 (0x6108)
  usb_device.vendor_id = 4528 (0x11b0)
  usb_device.device_protocol = 0 (0x0)
  usb_device.device_subclass = 0 (0x0)
  usb_device.device_class = 0 (0x0)
  usb_device.num_interfaces = 1 (0x1)
  usb_device.num_configurations = 1 (0x1)
  usb_device.configuration_value = 1 (0x1)
  usb_device.linux.sysfs_path = '/sys/devices/pci0000:00/0000:00:10.3/usb4/4-4'
  info.linux.driver = 'usb'
  info.bus = 'usb_device'
  info.parent = '/org/freedesktop/Hal/devices/usb_device_0_0_0000_00_10_3'
  linux.sysfs_path_device = '/sys/devices/pci0000:00/0000:00:10.3/usb4/4-4'
  linux.sysfs_path = '/sys/devices/pci0000:00/0000:00:10.3/usb4/4-4'
...