PATA Sil680 Warm Plug Caused 2.6.18-rc2 Kernel Internel Error

linux-ide.vger.kernel.org archive mirror
 help / color / mirror / Atom feed

* PATA Sil680 Warm Plug Caused 2.6.18-rc2 Kernel Internel Error
@ 2006-08-23 16:06 Fajun Chen
  2006-08-23 16:24 ` Tejun Heo
  2006-08-23 16:24 ` Jeff Garzik
  0 siblings, 2 replies; 14+ messages in thread
From: Fajun Chen @ 2006-08-23 16:06 UTC (permalink / raw)
  To: linux-ide; +Cc: alan, jgarzik

Hi Folks,

I used Linux 2.6.18-rc2 with Jeff Garzik's git libata patch for new EH, hotplug,
and pata support. Hardware is ARM IOP80321 with PCI-X. Host adapters
is pata Sil680.  The sequence of actions are "power off drive ->
remove drive -> power on drive -> add drive" and there's kernel errors
while adding the drive.  Complete dmesg traces attached. Has anyone
seen this problem before?

Thanks,
Fajun

~ $ dmesg
TCP bind hash table entries: 1024 (order: 0, 4096 bytes)
TCP: Hash tables configured (established 2048 bind 1024)
TCP reno registered
Calling initcall 0xc000f39c: timer_init_sysfs+0x0/0x3c()
Calling initcall 0xc002c4ec: iop3xx_aau_init+0x0/0x504()
Intel IOP3xx AAU RAID Copyright(c) 2003 Intel Corporation
Calling initcall 0xc0011444: fpe_init+0x0/0x84()
NetWinder Floating Point Emulator V0.97 (double precision)
Calling initcall 0xc0011d80: create_proc_profile+0x0/0x70()
Calling initcall 0xc0011f48: ioresources_init+0x0/0x5c()
Calling initcall 0xc00121d4: timekeeping_init_device+0x0/0x38()
Calling initcall 0xc0012388: uid_cache_init+0x0/0xa8()
Calling initcall 0xc0012754: param_sysfs_init+0x0/0x180()
Calling initcall 0xc00128d4: init_posix_timers+0x0/0xc0()
Calling initcall 0xc00129dc: init_posix_cpu_timers+0x0/0x84()
Calling initcall 0xc0012aac: init_clocksource_sysfs+0x0/0x68()
Calling initcall 0xc0012ba8: init_jiffies_clocksource+0x0/0x1c()
Calling initcall 0xc0012bc4: init+0x0/0x60()
Calling initcall 0xc0012c24: kallsyms_init+0x0/0x38()
Calling initcall 0xc00140c8: init_per_zone_pages_min+0x0/0x50()
Calling initcall 0xc0014400: pdflush_init+0x0/0x1c()
Calling initcall 0xc0014454: kswapd_init+0x0/0x38()
Calling initcall 0xc0014500: procswaps_init+0x0/0x38()
Calling initcall 0xc0014538: init_tmpfs+0x0/0x100()
Calling initcall 0xc00146a8: cpucache_init+0x0/0x1c()
Calling initcall 0xc0014f90: fasync_init+0x0/0x4c()
Calling initcall 0xc0015724: aio_setup+0x0/0x94()
Calling initcall 0xc00157b8: inotify_setup+0x0/0x24()
Calling initcall 0xc00157dc: inotify_user_setup+0x0/0xf8()
Calling initcall 0xc00158d4: eventpoll_init+0x0/0xec()
Calling initcall 0xc0015ec0: init_devpts_fs+0x0/0x48()
Calling initcall 0xc0015f08: init_ext2_fs+0x0/0x88()
Calling initcall 0xc0015f90: init_ramfs_fs+0x0/0x1c()
Calling initcall 0xc001618c: noop_init+0x0/0x1c()
io scheduler noop registered
Calling initcall 0xc00161a8: as_init+0x0/0x80()
io scheduler anticipatory registered
Calling initcall 0xc0016228: deadline_init+0x0/0x78()
io scheduler deadline registered
Calling initcall 0xc00162a0: cfq_init+0x0/0x10c()
io scheduler cfq registered (default)
Calling initcall 0xc00175b8: pci_init+0x0/0x3c()
PCI: Calling quirk c0018048 for 0000:00:01.0
PCI: Calling quirk c001c878 for 0000:00:01.0
Calling initcall 0xc0019044: pci_sysfs_init+0x0/0x44()
Calling initcall 0xc0019298: pci_proc_init+0x0/0x90()
Calling initcall 0xc0019e9c: rand_initialize+0x0/0x38()
Calling initcall 0xc0019f70: tty_init+0x0/0x1f8()
Calling initcall 0xc001a168: pty_init+0x0/0x3fc()
Calling initcall 0xc00db7cc: aauc_init+0x0/0x14c()
Calling initcall 0xc00e8ab4: usbfifoInit+0x0/0x1c()
Calling initcall 0xc001b184: serial8250_init+0x0/0x130()
Serial: 8250/16550 driver $Revision: 1.4 $ 2 ports, IRQ sharing disabled
serial8250: ttyS0 at MMIO 0xfe800000 (irq = 29) is a SC16C752
serial8250: ttyS1 at MMIO 0xfe800008 (irq = 30) is a SC16C752
Calling initcall 0xc001b578: serial8250_pci_init+0x0/0x20()
Calling initcall 0xc001bc80: rd_init+0x0/0x194()
RAMDISK driver initialized: 16 RAM disks of 10485760K size 1024 blocksize
Calling initcall 0xc001bef4: net_olddevs_init+0x0/0xdc()
Calling initcall 0xc001c024: tun_init+0x0/0x64()
tun: Universal TUN/TAP device driver, 1.6
tun: (C) 1999-2004 Max Krasnyansky <maxk@qualcomm.com>
Calling initcall 0xc001c3ac: spi_transport_init+0x0/0x44()
Calling initcall 0xc001c3f0: fc_transport_init+0x0/0x4c()
Calling initcall 0xc001c43c: iscsi_transport_init+0x0/0x108()
Calling initcall 0xc001c544: ata_init+0x0/0xa0()
libata version 2.00 loaded.
Calling initcall 0xc001c5e4: sil_init+0x0/0x20()
Calling initcall 0xc001c604: sil24_init+0x0/0x20()
Calling initcall 0xc001c624: sil680_init+0x0/0x20()
pata_sil680 0000:00:01.0: version 0.3.2
sil680: BA5_EN = 1 clock = 00
sil680: BA5_EN = 1 clock = 10
sil680: 133MHz clock.
PCI: enabling device 0000:00:01.0 (0140 -> 0143)
PCI: Enabling bus mastering for device 0000:00:01.0
ata1: PATA max UDMA/133 cmd 0xFE000010 ctl 0xFE000022 bmdma 0xFE000000 irq 27
ata2: PATA max UDMA/133 cmd 0xFE000018 ctl 0xFE000026 bmdma 0xFE000008 irq 27
scsi0 : pata_sil680
ata1.00: ATA-7, max UDMA/100, 625142448 sectors: LBA48
ata1.00: configured for UDMA/100
scsi1 : pata_sil680
ata2.00: ATA-7, max UDMA/100, 625142448 sectors: LBA48
ata2.00: configured for UDMA/100
  Vendor: ATA       Model: ST3320820A        Rev: 3.AA
  Type:   Direct-Access                      ANSI SCSI revision: 05
  Vendor: ATA       Model: ST3320820A        Rev: 3.AA
  Type:   Direct-Access                      ANSI SCSI revision: 05
Calling initcall 0xc001c644: init_sd+0x0/0x8c()
SCSI device sda: 625142448 512-byte hdwr sectors (320073 MB)
sda: Write Protect is off
sda: Mode Sense: 00 3a 00 00
SCSI device sda: drive cache: write back
SCSI device sda: 625142448 512-byte hdwr sectors (320073 MB)
sda: Write Protect is off
sda: Mode Sense: 00 3a 00 00
SCSI device sda: drive cache: write back
 sda: unknown partition table
sd 0:0:0:0: Attached scsi disk sda
SCSI device sdb: 625142448 512-byte hdwr sectors (320073 MB)
sdb: Write Protect is off
sdb: Mode Sense: 00 3a 00 00
SCSI device sdb: drive cache: write back
SCSI device sdb: 625142448 512-byte hdwr sectors (320073 MB)
sdb: Write Protect is off
sdb: Mode Sense: 00 3a 00 00
SCSI device sdb: drive cache: write back
 sdb: unknown partition table
sd 1:0:0:0: Attached scsi disk sdb
Calling initcall 0xc001c6d0: init_sg+0x0/0x14c()
sd 0:0:0:0: Attached scsi generic sg0 type 0
sd 1:0:0:0: Attached scsi generic sg1 type 0
Calling initcall 0xc001cd50: i2c_dev_init+0x0/0xa8()
i2c /dev entries driver
Calling initcall 0xc001cdf8: i2c_iop3xx_init+0x0/0x1c()
Calling initcall 0xc001ce14: hwmon_init+0x0/0x5c()
Calling initcall 0xc001d460: flow_cache_init+0x0/0x174()
Calling initcall 0xc001e888: xfrm4_transport_init+0x0/0x20()
Calling initcall 0xc001e8a8: xfrm4_tunnel_init+0x0/0x20()
Calling initcall 0xc001e8c8: inet_diag_init+0x0/0x80()
Calling initcall 0xc001e948: tcp_diag_init+0x0/0x1c()
Calling initcall 0xc001e964: bictcp_register+0x0/0x1c()
TCP bic registered
Calling initcall 0xc001eb40: af_unix_init+0x0/0x80()
NET: Registered protocol family 1
Calling initcall 0xc001ebc0: packet_init+0x0/0x70()
NET: Registered protocol family 17
Calling initcall 0xc0012a88: clocksource_done_booting+0x0/0x24()
Calling initcall 0xc0019ed4: seqgen_init+0x0/0x1c()
Calling initcall 0xc001ba44: early_uart_console_switch+0x0/0x90()
Calling initcall 0xc0139c74: net_random_reseed+0x0/0x38()
RAMDISK: Compressed image found at block 0
VFS: Mounted root (ext2 filesystem).
Freeing init memory: 104K
ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
ata1.00: (BMDMA stat 0x1)
ata1.00: tag 0 cmd 0xc8 Emask 0x4 stat 0x40 err 0x0 (timeout)
ata1: soft resetting port
ata1.00: configured for UDMA/100
ata1: EH complete
SCSI device sda: 625142448 512-byte hdwr sectors (320073 MB)
sda: Write Protect is off
sda: Mode Sense: 00 3a 00 00
SCSI device sda: drive cache: write back
ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
ata2.00: (BMDMA stat 0x1)
ata2.00: tag 0 cmd 0xc8 Emask 0x4 stat 0x40 err 0x0 (timeout)
ata2: soft resetting port
ata2.00: qc timeout (cmd 0xec)
ata2.00: failed to IDENTIFY (I/O error, err_mask=0x4)
ata2.00: revalidation failed (errno=-5)
ata2: failed to recover some devices, retrying in 5 secs
ata2: soft resetting port
ata2.00: qc timeout (cmd 0xec)
ata2.00: failed to IDENTIFY (I/O error, err_mask=0x4)
ata2.00: revalidation failed (errno=-5)
ata2: failed to recover some devices, retrying in 5 secs
ata2: soft resetting port
ata2.00: qc timeout (cmd 0xec)
ata2.00: failed to IDENTIFY (I/O error, err_mask=0x4)
ata2.00: revalidation failed (errno=-5)
ata2.00: disabled
ata2: EH complete

~ $ sg_scan
/dev/sg0: scsi0 channel=0 id=0 lun=0 [em]
/dev/sg1: scsi1 channel=0 id=0 lun=0 [em]

~ $ echo "scsi remove-single-device 1 0 0 0" > /proc/scsi/scsi
~ $ dmesg
TCP bind hash table entries: 1024 (order: 0, 4096 bytes)
TCP: Hash tables configured (established 2048 bind 1024)
TCP reno registered
Calling initcall 0xc000f39c: timer_init_sysfs+0x0/0x3c()
Calling initcall 0xc002c4ec: iop3xx_aau_init+0x0/0x504()
Intel IOP3xx AAU RAID Copyright(c) 2003 Intel Corporation
Calling initcall 0xc0011444: fpe_init+0x0/0x84()
NetWinder Floating Point Emulator V0.97 (double precision)
Calling initcall 0xc0011d80: create_proc_profile+0x0/0x70()
Calling initcall 0xc0011f48: ioresources_init+0x0/0x5c()
Calling initcall 0xc00121d4: timekeeping_init_device+0x0/0x38()
Calling initcall 0xc0012388: uid_cache_init+0x0/0xa8()
Calling initcall 0xc0012754: param_sysfs_init+0x0/0x180()
Calling initcall 0xc00128d4: init_posix_timers+0x0/0xc0()
Calling initcall 0xc00129dc: init_posix_cpu_timers+0x0/0x84()
Calling initcall 0xc0012aac: init_clocksource_sysfs+0x0/0x68()
Calling initcall 0xc0012ba8: init_jiffies_clocksource+0x0/0x1c()
Calling initcall 0xc0012bc4: init+0x0/0x60()
Calling initcall 0xc0012c24: kallsyms_init+0x0/0x38()
Calling initcall 0xc00140c8: init_per_zone_pages_min+0x0/0x50()
Calling initcall 0xc0014400: pdflush_init+0x0/0x1c()
Calling initcall 0xc0014454: kswapd_init+0x0/0x38()
Calling initcall 0xc0014500: procswaps_init+0x0/0x38()
Calling initcall 0xc0014538: init_tmpfs+0x0/0x100()
Calling initcall 0xc00146a8: cpucache_init+0x0/0x1c()
Calling initcall 0xc0014f90: fasync_init+0x0/0x4c()
Calling initcall 0xc0015724: aio_setup+0x0/0x94()
Calling initcall 0xc00157b8: inotify_setup+0x0/0x24()
Calling initcall 0xc00157dc: inotify_user_setup+0x0/0xf8()
Calling initcall 0xc00158d4: eventpoll_init+0x0/0xec()
Calling initcall 0xc0015ec0: init_devpts_fs+0x0/0x48()
Calling initcall 0xc0015f08: init_ext2_fs+0x0/0x88()
Calling initcall 0xc0015f90: init_ramfs_fs+0x0/0x1c()
Calling initcall 0xc001618c: noop_init+0x0/0x1c()
io scheduler noop registered
Calling initcall 0xc00161a8: as_init+0x0/0x80()
io scheduler anticipatory registered
Calling initcall 0xc0016228: deadline_init+0x0/0x78()
io scheduler deadline registered
Calling initcall 0xc00162a0: cfq_init+0x0/0x10c()
io scheduler cfq registered (default)
Calling initcall 0xc00175b8: pci_init+0x0/0x3c()
PCI: Calling quirk c0018048 for 0000:00:01.0
PCI: Calling quirk c001c878 for 0000:00:01.0
Calling initcall 0xc0019044: pci_sysfs_init+0x0/0x44()
Calling initcall 0xc0019298: pci_proc_init+0x0/0x90()
Calling initcall 0xc0019e9c: rand_initialize+0x0/0x38()
Calling initcall 0xc0019f70: tty_init+0x0/0x1f8()
Calling initcall 0xc001a168: pty_init+0x0/0x3fc()
Calling initcall 0xc00db7cc: aauc_init+0x0/0x14c()
Calling initcall 0xc00e8ab4: usbfifoInit+0x0/0x1c()
Calling initcall 0xc001b184: serial8250_init+0x0/0x130()
Serial: 8250/16550 driver $Revision: 1.4 $ 2 ports, IRQ sharing disabled
serial8250: ttyS0 at MMIO 0xfe800000 (irq = 29) is a SC16C752
serial8250: ttyS1 at MMIO 0xfe800008 (irq = 30) is a SC16C752
Calling initcall 0xc001b578: serial8250_pci_init+0x0/0x20()
Calling initcall 0xc001bc80: rd_init+0x0/0x194()
RAMDISK driver initialized: 16 RAM disks of 10485760K size 1024 blocksize
Calling initcall 0xc001bef4: net_olddevs_init+0x0/0xdc()
Calling initcall 0xc001c024: tun_init+0x0/0x64()
tun: Universal TUN/TAP device driver, 1.6
tun: (C) 1999-2004 Max Krasnyansky <maxk@qualcomm.com>
Calling initcall 0xc001c3ac: spi_transport_init+0x0/0x44()
Calling initcall 0xc001c3f0: fc_transport_init+0x0/0x4c()
Calling initcall 0xc001c43c: iscsi_transport_init+0x0/0x108()
Calling initcall 0xc001c544: ata_init+0x0/0xa0()
libata version 2.00 loaded.
Calling initcall 0xc001c5e4: sil_init+0x0/0x20()
Calling initcall 0xc001c604: sil24_init+0x0/0x20()
Calling initcall 0xc001c624: sil680_init+0x0/0x20()
pata_sil680 0000:00:01.0: version 0.3.2
sil680: BA5_EN = 1 clock = 00
sil680: BA5_EN = 1 clock = 10
sil680: 133MHz clock.
PCI: enabling device 0000:00:01.0 (0140 -> 0143)
PCI: Enabling bus mastering for device 0000:00:01.0
ata1: PATA max UDMA/133 cmd 0xFE000010 ctl 0xFE000022 bmdma 0xFE000000 irq 27
ata2: PATA max UDMA/133 cmd 0xFE000018 ctl 0xFE000026 bmdma 0xFE000008 irq 27
scsi0 : pata_sil680
ata1.00: ATA-7, max UDMA/100, 625142448 sectors: LBA48
ata1.00: configured for UDMA/100
scsi1 : pata_sil680
ata2.00: ATA-7, max UDMA/100, 625142448 sectors: LBA48
ata2.00: configured for UDMA/100
  Vendor: ATA       Model: ST3320820A        Rev: 3.AA
  Type:   Direct-Access                      ANSI SCSI revision: 05
  Vendor: ATA       Model: ST3320820A        Rev: 3.AA
  Type:   Direct-Access                      ANSI SCSI revision: 05
Calling initcall 0xc001c644: init_sd+0x0/0x8c()
SCSI device sda: 625142448 512-byte hdwr sectors (320073 MB)
sda: Write Protect is off
sda: Mode Sense: 00 3a 00 00
SCSI device sda: drive cache: write back
SCSI device sda: 625142448 512-byte hdwr sectors (320073 MB)
sda: Write Protect is off
sda: Mode Sense: 00 3a 00 00
SCSI device sda: drive cache: write back
 sda: unknown partition table
sd 0:0:0:0: Attached scsi disk sda
SCSI device sdb: 625142448 512-byte hdwr sectors (320073 MB)
sdb: Write Protect is off
sdb: Mode Sense: 00 3a 00 00
SCSI device sdb: drive cache: write back
SCSI device sdb: 625142448 512-byte hdwr sectors (320073 MB)
sdb: Write Protect is off
sdb: Mode Sense: 00 3a 00 00
SCSI device sdb: drive cache: write back
 sdb: unknown partition table
sd 1:0:0:0: Attached scsi disk sdb
Calling initcall 0xc001c6d0: init_sg+0x0/0x14c()
sd 0:0:0:0: Attached scsi generic sg0 type 0
sd 1:0:0:0: Attached scsi generic sg1 type 0
Calling initcall 0xc001cd50: i2c_dev_init+0x0/0xa8()
i2c /dev entries driver
Calling initcall 0xc001cdf8: i2c_iop3xx_init+0x0/0x1c()
Calling initcall 0xc001ce14: hwmon_init+0x0/0x5c()
Calling initcall 0xc001d460: flow_cache_init+0x0/0x174()
Calling initcall 0xc001e888: xfrm4_transport_init+0x0/0x20()
Calling initcall 0xc001e8a8: xfrm4_tunnel_init+0x0/0x20()
Calling initcall 0xc001e8c8: inet_diag_init+0x0/0x80()
Calling initcall 0xc001e948: tcp_diag_init+0x0/0x1c()
Calling initcall 0xc001e964: bictcp_register+0x0/0x1c()
TCP bic registered
Calling initcall 0xc001eb40: af_unix_init+0x0/0x80()
NET: Registered protocol family 1
Calling initcall 0xc001ebc0: packet_init+0x0/0x70()
NET: Registered protocol family 17
Calling initcall 0xc0012a88: clocksource_done_booting+0x0/0x24()
Calling initcall 0xc0019ed4: seqgen_init+0x0/0x1c()
Calling initcall 0xc001ba44: early_uart_console_switch+0x0/0x90()
Calling initcall 0xc0139c74: net_random_reseed+0x0/0x38()
RAMDISK: Compressed image found at block 0
VFS: Mounted root (ext2 filesystem).
Freeing init memory: 104K
ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
ata1.00: (BMDMA stat 0x1)
ata1.00: tag 0 cmd 0xc8 Emask 0x4 stat 0x40 err 0x0 (timeout)
ata1: soft resetting port
ata1.00: configured for UDMA/100
ata1: EH complete
SCSI device sda: 625142448 512-byte hdwr sectors (320073 MB)
sda: Write Protect is off
sda: Mode Sense: 00 3a 00 00
SCSI device sda: drive cache: write back
ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
ata2.00: (BMDMA stat 0x1)
ata2.00: tag 0 cmd 0xc8 Emask 0x4 stat 0x40 err 0x0 (timeout)
ata2: soft resetting port
ata2.00: qc timeout (cmd 0xec)
ata2.00: failed to IDENTIFY (I/O error, err_mask=0x4)
ata2.00: revalidation failed (errno=-5)
ata2: failed to recover some devices, retrying in 5 secs
ata2: soft resetting port
ata2.00: qc timeout (cmd 0xec)
ata2.00: failed to IDENTIFY (I/O error, err_mask=0x4)
ata2.00: revalidation failed (errno=-5)
ata2: failed to recover some devices, retrying in 5 secs
ata2: soft resetting port
ata2.00: qc timeout (cmd 0xec)
ata2.00: failed to IDENTIFY (I/O error, err_mask=0x4)
ata2.00: revalidation failed (errno=-5)
ata2.00: disabled
ata2: EH complete

~ $ sg_scan
/dev/sg0: scsi0 channel=0 id=0 lun=0 [em]

~ $ cat /proc/scsi/scsi
Attached devices:
Host: scsi0 Channel: 00 Id: 00 Lun: 00
  Vendor: ATA      Model: ST3320820A       Rev: 3.AA
  Type:   Direct-Access                    ANSI SCSI revision: 05

~ $ dmesg
TCP bind hash table entries: 1024 (order: 0, 4096 bytes)
TCP: Hash tables configured (established 2048 bind 1024)
TCP reno registered
Calling initcall 0xc000f39c: timer_init_sysfs+0x0/0x3c()
Calling initcall 0xc002c4ec: iop3xx_aau_init+0x0/0x504()
Intel IOP3xx AAU RAID Copyright(c) 2003 Intel Corporation
Calling initcall 0xc0011444: fpe_init+0x0/0x84()
NetWinder Floating Point Emulator V0.97 (double precision)
Calling initcall 0xc0011d80: create_proc_profile+0x0/0x70()
Calling initcall 0xc0011f48: ioresources_init+0x0/0x5c()
Calling initcall 0xc00121d4: timekeeping_init_device+0x0/0x38()
Calling initcall 0xc0012388: uid_cache_init+0x0/0xa8()
Calling initcall 0xc0012754: param_sysfs_init+0x0/0x180()
Calling initcall 0xc00128d4: init_posix_timers+0x0/0xc0()
Calling initcall 0xc00129dc: init_posix_cpu_timers+0x0/0x84()
Calling initcall 0xc0012aac: init_clocksource_sysfs+0x0/0x68()
Calling initcall 0xc0012ba8: init_jiffies_clocksource+0x0/0x1c()
Calling initcall 0xc0012bc4: init+0x0/0x60()
Calling initcall 0xc0012c24: kallsyms_init+0x0/0x38()
Calling initcall 0xc00140c8: init_per_zone_pages_min+0x0/0x50()
Calling initcall 0xc0014400: pdflush_init+0x0/0x1c()
Calling initcall 0xc0014454: kswapd_init+0x0/0x38()
Calling initcall 0xc0014500: procswaps_init+0x0/0x38()
Calling initcall 0xc0014538: init_tmpfs+0x0/0x100()
Calling initcall 0xc00146a8: cpucache_init+0x0/0x1c()
Calling initcall 0xc0014f90: fasync_init+0x0/0x4c()
Calling initcall 0xc0015724: aio_setup+0x0/0x94()
Calling initcall 0xc00157b8: inotify_setup+0x0/0x24()
Calling initcall 0xc00157dc: inotify_user_setup+0x0/0xf8()
Calling initcall 0xc00158d4: eventpoll_init+0x0/0xec()
Calling initcall 0xc0015ec0: init_devpts_fs+0x0/0x48()
Calling initcall 0xc0015f08: init_ext2_fs+0x0/0x88()
Calling initcall 0xc0015f90: init_ramfs_fs+0x0/0x1c()
Calling initcall 0xc001618c: noop_init+0x0/0x1c()
io scheduler noop registered
Calling initcall 0xc00161a8: as_init+0x0/0x80()
io scheduler anticipatory registered
Calling initcall 0xc0016228: deadline_init+0x0/0x78()
io scheduler deadline registered
Calling initcall 0xc00162a0: cfq_init+0x0/0x10c()
io scheduler cfq registered (default)
Calling initcall 0xc00175b8: pci_init+0x0/0x3c()
PCI: Calling quirk c0018048 for 0000:00:01.0
PCI: Calling quirk c001c878 for 0000:00:01.0
Calling initcall 0xc0019044: pci_sysfs_init+0x0/0x44()
Calling initcall 0xc0019298: pci_proc_init+0x0/0x90()
Calling initcall 0xc0019e9c: rand_initialize+0x0/0x38()
Calling initcall 0xc0019f70: tty_init+0x0/0x1f8()
Calling initcall 0xc001a168: pty_init+0x0/0x3fc()
Calling initcall 0xc00db7cc: aauc_init+0x0/0x14c()
Calling initcall 0xc00e8ab4: usbfifoInit+0x0/0x1c()
Calling initcall 0xc001b184: serial8250_init+0x0/0x130()
Serial: 8250/16550 driver $Revision: 1.4 $ 2 ports, IRQ sharing disabled
serial8250: ttyS0 at MMIO 0xfe800000 (irq = 29) is a SC16C752
serial8250: ttyS1 at MMIO 0xfe800008 (irq = 30) is a SC16C752
Calling initcall 0xc001b578: serial8250_pci_init+0x0/0x20()
Calling initcall 0xc001bc80: rd_init+0x0/0x194()
RAMDISK driver initialized: 16 RAM disks of 10485760K size 1024 blocksize
Calling initcall 0xc001bef4: net_olddevs_init+0x0/0xdc()
Calling initcall 0xc001c024: tun_init+0x0/0x64()
tun: Universal TUN/TAP device driver, 1.6
tun: (C) 1999-2004 Max Krasnyansky <maxk@qualcomm.com>
Calling initcall 0xc001c3ac: spi_transport_init+0x0/0x44()
Calling initcall 0xc001c3f0: fc_transport_init+0x0/0x4c()
Calling initcall 0xc001c43c: iscsi_transport_init+0x0/0x108()
Calling initcall 0xc001c544: ata_init+0x0/0xa0()
libata version 2.00 loaded.
Calling initcall 0xc001c5e4: sil_init+0x0/0x20()
Calling initcall 0xc001c604: sil24_init+0x0/0x20()
Calling initcall 0xc001c624: sil680_init+0x0/0x20()
pata_sil680 0000:00:01.0: version 0.3.2
sil680: BA5_EN = 1 clock = 00
sil680: BA5_EN = 1 clock = 10
sil680: 133MHz clock.
PCI: enabling device 0000:00:01.0 (0140 -> 0143)
PCI: Enabling bus mastering for device 0000:00:01.0
ata1: PATA max UDMA/133 cmd 0xFE000010 ctl 0xFE000022 bmdma 0xFE000000 irq 27
ata2: PATA max UDMA/133 cmd 0xFE000018 ctl 0xFE000026 bmdma 0xFE000008 irq 27
scsi0 : pata_sil680
ata1.00: ATA-7, max UDMA/100, 625142448 sectors: LBA48
ata1.00: configured for UDMA/100
scsi1 : pata_sil680
ata2.00: ATA-7, max UDMA/100, 625142448 sectors: LBA48
ata2.00: configured for UDMA/100
  Vendor: ATA       Model: ST3320820A        Rev: 3.AA
  Type:   Direct-Access                      ANSI SCSI revision: 05
  Vendor: ATA       Model: ST3320820A        Rev: 3.AA
  Type:   Direct-Access                      ANSI SCSI revision: 05
Calling initcall 0xc001c644: init_sd+0x0/0x8c()
SCSI device sda: 625142448 512-byte hdwr sectors (320073 MB)
sda: Write Protect is off
sda: Mode Sense: 00 3a 00 00
SCSI device sda: drive cache: write back
SCSI device sda: 625142448 512-byte hdwr sectors (320073 MB)
sda: Write Protect is off
sda: Mode Sense: 00 3a 00 00
SCSI device sda: drive cache: write back
 sda: unknown partition table
sd 0:0:0:0: Attached scsi disk sda
SCSI device sdb: 625142448 512-byte hdwr sectors (320073 MB)
sdb: Write Protect is off
sdb: Mode Sense: 00 3a 00 00
SCSI device sdb: drive cache: write back
SCSI device sdb: 625142448 512-byte hdwr sectors (320073 MB)
sdb: Write Protect is off
sdb: Mode Sense: 00 3a 00 00
SCSI device sdb: drive cache: write back
 sdb: unknown partition table
sd 1:0:0:0: Attached scsi disk sdb
Calling initcall 0xc001c6d0: init_sg+0x0/0x14c()
sd 0:0:0:0: Attached scsi generic sg0 type 0
sd 1:0:0:0: Attached scsi generic sg1 type 0
Calling initcall 0xc001cd50: i2c_dev_init+0x0/0xa8()
i2c /dev entries driver
Calling initcall 0xc001cdf8: i2c_iop3xx_init+0x0/0x1c()
Calling initcall 0xc001ce14: hwmon_init+0x0/0x5c()
Calling initcall 0xc001d460: flow_cache_init+0x0/0x174()
Calling initcall 0xc001e888: xfrm4_transport_init+0x0/0x20()
Calling initcall 0xc001e8a8: xfrm4_tunnel_init+0x0/0x20()
Calling initcall 0xc001e8c8: inet_diag_init+0x0/0x80()
Calling initcall 0xc001e948: tcp_diag_init+0x0/0x1c()
Calling initcall 0xc001e964: bictcp_register+0x0/0x1c()
TCP bic registered
Calling initcall 0xc001eb40: af_unix_init+0x0/0x80()
NET: Registered protocol family 1
Calling initcall 0xc001ebc0: packet_init+0x0/0x70()
NET: Registered protocol family 17
Calling initcall 0xc0012a88: clocksource_done_booting+0x0/0x24()
Calling initcall 0xc0019ed4: seqgen_init+0x0/0x1c()
Calling initcall 0xc001ba44: early_uart_console_switch+0x0/0x90()
Calling initcall 0xc0139c74: net_random_reseed+0x0/0x38()
RAMDISK: Compressed image found at block 0
VFS: Mounted root (ext2 filesystem).
Freeing init memory: 104K
ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
ata1.00: (BMDMA stat 0x1)
ata1.00: tag 0 cmd 0xc8 Emask 0x4 stat 0x40 err 0x0 (timeout)
ata1: soft resetting port
ata1.00: configured for UDMA/100
ata1: EH complete
SCSI device sda: 625142448 512-byte hdwr sectors (320073 MB)
sda: Write Protect is off
sda: Mode Sense: 00 3a 00 00
SCSI device sda: drive cache: write back
ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
ata2.00: (BMDMA stat 0x1)
ata2.00: tag 0 cmd 0xc8 Emask 0x4 stat 0x40 err 0x0 (timeout)
ata2: soft resetting port
ata2.00: qc timeout (cmd 0xec)
ata2.00: failed to IDENTIFY (I/O error, err_mask=0x4)
ata2.00: revalidation failed (errno=-5)
ata2: failed to recover some devices, retrying in 5 secs
ata2: soft resetting port
ata2.00: qc timeout (cmd 0xec)
ata2.00: failed to IDENTIFY (I/O error, err_mask=0x4)
ata2.00: revalidation failed (errno=-5)
ata2: failed to recover some devices, retrying in 5 secs
ata2: soft resetting port
ata2.00: qc timeout (cmd 0xec)
ata2.00: failed to IDENTIFY (I/O error, err_mask=0x4)
ata2.00: revalidation failed (errno=-5)
ata2.00: disabled
ata2: EH complete
~ $
~ $ pwd
/
~ $ ./PowerOn 0
driveOn = 1
~ $ dmesg
TCP bind hash table entries: 1024 (order: 0, 4096 bytes)
TCP: Hash tables configured (established 2048 bind 1024)
TCP reno registered
Calling initcall 0xc000f39c: timer_init_sysfs+0x0/0x3c()
Calling initcall 0xc002c4ec: iop3xx_aau_init+0x0/0x504()
Intel IOP3xx AAU RAID Copyright(c) 2003 Intel Corporation
Calling initcall 0xc0011444: fpe_init+0x0/0x84()
NetWinder Floating Point Emulator V0.97 (double precision)
Calling initcall 0xc0011d80: create_proc_profile+0x0/0x70()
Calling initcall 0xc0011f48: ioresources_init+0x0/0x5c()
Calling initcall 0xc00121d4: timekeeping_init_device+0x0/0x38()
Calling initcall 0xc0012388: uid_cache_init+0x0/0xa8()
Calling initcall 0xc0012754: param_sysfs_init+0x0/0x180()
Calling initcall 0xc00128d4: init_posix_timers+0x0/0xc0()
Calling initcall 0xc00129dc: init_posix_cpu_timers+0x0/0x84()
Calling initcall 0xc0012aac: init_clocksource_sysfs+0x0/0x68()
Calling initcall 0xc0012ba8: init_jiffies_clocksource+0x0/0x1c()
Calling initcall 0xc0012bc4: init+0x0/0x60()
Calling initcall 0xc0012c24: kallsyms_init+0x0/0x38()
Calling initcall 0xc00140c8: init_per_zone_pages_min+0x0/0x50()
Calling initcall 0xc0014400: pdflush_init+0x0/0x1c()
Calling initcall 0xc0014454: kswapd_init+0x0/0x38()
Calling initcall 0xc0014500: procswaps_init+0x0/0x38()
Calling initcall 0xc0014538: init_tmpfs+0x0/0x100()
Calling initcall 0xc00146a8: cpucache_init+0x0/0x1c()
Calling initcall 0xc0014f90: fasync_init+0x0/0x4c()
Calling initcall 0xc0015724: aio_setup+0x0/0x94()
Calling initcall 0xc00157b8: inotify_setup+0x0/0x24()
Calling initcall 0xc00157dc: inotify_user_setup+0x0/0xf8()
Calling initcall 0xc00158d4: eventpoll_init+0x0/0xec()
Calling initcall 0xc0015ec0: init_devpts_fs+0x0/0x48()
Calling initcall 0xc0015f08: init_ext2_fs+0x0/0x88()
Calling initcall 0xc0015f90: init_ramfs_fs+0x0/0x1c()
Calling initcall 0xc001618c: noop_init+0x0/0x1c()
io scheduler noop registered
Calling initcall 0xc00161a8: as_init+0x0/0x80()
io scheduler anticipatory registered
Calling initcall 0xc0016228: deadline_init+0x0/0x78()
io scheduler deadline registered
Calling initcall 0xc00162a0: cfq_init+0x0/0x10c()
io scheduler cfq registered (default)
Calling initcall 0xc00175b8: pci_init+0x0/0x3c()
PCI: Calling quirk c0018048 for 0000:00:01.0
PCI: Calling quirk c001c878 for 0000:00:01.0
Calling initcall 0xc0019044: pci_sysfs_init+0x0/0x44()
Calling initcall 0xc0019298: pci_proc_init+0x0/0x90()
Calling initcall 0xc0019e9c: rand_initialize+0x0/0x38()
Calling initcall 0xc0019f70: tty_init+0x0/0x1f8()
Calling initcall 0xc001a168: pty_init+0x0/0x3fc()
Calling initcall 0xc00db7cc: aauc_init+0x0/0x14c()
Calling initcall 0xc00e8ab4: usbfifoInit+0x0/0x1c()
Calling initcall 0xc001b184: serial8250_init+0x0/0x130()
Serial: 8250/16550 driver $Revision: 1.4 $ 2 ports, IRQ sharing disabled
serial8250: ttyS0 at MMIO 0xfe800000 (irq = 29) is a SC16C752
serial8250: ttyS1 at MMIO 0xfe800008 (irq = 30) is a SC16C752
Calling initcall 0xc001b578: serial8250_pci_init+0x0/0x20()
Calling initcall 0xc001bc80: rd_init+0x0/0x194()
RAMDISK driver initialized: 16 RAM disks of 10485760K size 1024 blocksize
Calling initcall 0xc001bef4: net_olddevs_init+0x0/0xdc()
Calling initcall 0xc001c024: tun_init+0x0/0x64()
tun: Universal TUN/TAP device driver, 1.6
tun: (C) 1999-2004 Max Krasnyansky <maxk@qualcomm.com>
Calling initcall 0xc001c3ac: spi_transport_init+0x0/0x44()
Calling initcall 0xc001c3f0: fc_transport_init+0x0/0x4c()
Calling initcall 0xc001c43c: iscsi_transport_init+0x0/0x108()
Calling initcall 0xc001c544: ata_init+0x0/0xa0()
libata version 2.00 loaded.
Calling initcall 0xc001c5e4: sil_init+0x0/0x20()
Calling initcall 0xc001c604: sil24_init+0x0/0x20()
Calling initcall 0xc001c624: sil680_init+0x0/0x20()
pata_sil680 0000:00:01.0: version 0.3.2
sil680: BA5_EN = 1 clock = 00
sil680: BA5_EN = 1 clock = 10
sil680: 133MHz clock.
PCI: enabling device 0000:00:01.0 (0140 -> 0143)
PCI: Enabling bus mastering for device 0000:00:01.0
ata1: PATA max UDMA/133 cmd 0xFE000010 ctl 0xFE000022 bmdma 0xFE000000 irq 27
ata2: PATA max UDMA/133 cmd 0xFE000018 ctl 0xFE000026 bmdma 0xFE000008 irq 27
scsi0 : pata_sil680
ata1.00: ATA-7, max UDMA/100, 625142448 sectors: LBA48
ata1.00: configured for UDMA/100
scsi1 : pata_sil680
ata2.00: ATA-7, max UDMA/100, 625142448 sectors: LBA48
ata2.00: configured for UDMA/100
  Vendor: ATA       Model: ST3320820A        Rev: 3.AA
  Type:   Direct-Access                      ANSI SCSI revision: 05
  Vendor: ATA       Model: ST3320820A        Rev: 3.AA
  Type:   Direct-Access                      ANSI SCSI revision: 05
Calling initcall 0xc001c644: init_sd+0x0/0x8c()
SCSI device sda: 625142448 512-byte hdwr sectors (320073 MB)
sda: Write Protect is off
sda: Mode Sense: 00 3a 00 00
SCSI device sda: drive cache: write back
SCSI device sda: 625142448 512-byte hdwr sectors (320073 MB)
sda: Write Protect is off
sda: Mode Sense: 00 3a 00 00
SCSI device sda: drive cache: write back
 sda: unknown partition table
sd 0:0:0:0: Attached scsi disk sda
SCSI device sdb: 625142448 512-byte hdwr sectors (320073 MB)
sdb: Write Protect is off
sdb: Mode Sense: 00 3a 00 00
SCSI device sdb: drive cache: write back
SCSI device sdb: 625142448 512-byte hdwr sectors (320073 MB)
sdb: Write Protect is off
sdb: Mode Sense: 00 3a 00 00
SCSI device sdb: drive cache: write back
 sdb: unknown partition table
sd 1:0:0:0: Attached scsi disk sdb
Calling initcall 0xc001c6d0: init_sg+0x0/0x14c()
sd 0:0:0:0: Attached scsi generic sg0 type 0
sd 1:0:0:0: Attached scsi generic sg1 type 0
Calling initcall 0xc001cd50: i2c_dev_init+0x0/0xa8()
i2c /dev entries driver
Calling initcall 0xc001cdf8: i2c_iop3xx_init+0x0/0x1c()
Calling initcall 0xc001ce14: hwmon_init+0x0/0x5c()
Calling initcall 0xc001d460: flow_cache_init+0x0/0x174()
Calling initcall 0xc001e888: xfrm4_transport_init+0x0/0x20()
Calling initcall 0xc001e8a8: xfrm4_tunnel_init+0x0/0x20()
Calling initcall 0xc001e8c8: inet_diag_init+0x0/0x80()
Calling initcall 0xc001e948: tcp_diag_init+0x0/0x1c()
Calling initcall 0xc001e964: bictcp_register+0x0/0x1c()
TCP bic registered
Calling initcall 0xc001eb40: af_unix_init+0x0/0x80()
NET: Registered protocol family 1
Calling initcall 0xc001ebc0: packet_init+0x0/0x70()
NET: Registered protocol family 17
Calling initcall 0xc0012a88: clocksource_done_booting+0x0/0x24()
Calling initcall 0xc0019ed4: seqgen_init+0x0/0x1c()
Calling initcall 0xc001ba44: early_uart_console_switch+0x0/0x90()
Calling initcall 0xc0139c74: net_random_reseed+0x0/0x38()
RAMDISK: Compressed image found at block 0
VFS: Mounted root (ext2 filesystem).
Freeing init memory: 104K
ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
ata1.00: (BMDMA stat 0x1)
ata1.00: tag 0 cmd 0xc8 Emask 0x4 stat 0x40 err 0x0 (timeout)
ata1: soft resetting port
ata1.00: configured for UDMA/100
ata1: EH complete
SCSI device sda: 625142448 512-byte hdwr sectors (320073 MB)
sda: Write Protect is off
sda: Mode Sense: 00 3a 00 00
SCSI device sda: drive cache: write back
ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
ata2.00: (BMDMA stat 0x1)
ata2.00: tag 0 cmd 0xc8 Emask 0x4 stat 0x40 err 0x0 (timeout)
ata2: soft resetting port
ata2.00: qc timeout (cmd 0xec)
ata2.00: failed to IDENTIFY (I/O error, err_mask=0x4)
ata2.00: revalidation failed (errno=-5)
ata2: failed to recover some devices, retrying in 5 secs
ata2: soft resetting port
ata2.00: qc timeout (cmd 0xec)
ata2.00: failed to IDENTIFY (I/O error, err_mask=0x4)
ata2.00: revalidation failed (errno=-5)
ata2: failed to recover some devices, retrying in 5 secs
ata2: soft resetting port
ata2.00: qc timeout (cmd 0xec)
ata2.00: failed to IDENTIFY (I/O error, err_mask=0x4)
ata2.00: revalidation failed (errno=-5)
ata2.00: disabled
ata2: EH complete
~ $
~ $ echo "scsi add-single-device 1 0 0 0" > /proc/scsi/scsi
~ $ sg_scan
/dev/sg0: scsi0 channel=0 id=0 lun=0 [em]
~ $ dmesg
ng initcall 0xc00162a0: cfq_init+0x0/0x10c()
io scheduler cfq registered (default)
Calling initcall 0xc00175b8: pci_init+0x0/0x3c()
PCI: Calling quirk c0018048 for 0000:00:01.0
PCI: Calling quirk c001c878 for 0000:00:01.0
Calling initcall 0xc0019044: pci_sysfs_init+0x0/0x44()
Calling initcall 0xc0019298: pci_proc_init+0x0/0x90()
Calling initcall 0xc0019e9c: rand_initialize+0x0/0x38()
Calling initcall 0xc0019f70: tty_init+0x0/0x1f8()
Calling initcall 0xc001a168: pty_init+0x0/0x3fc()
Calling initcall 0xc00db7cc: aauc_init+0x0/0x14c()
Calling initcall 0xc00e8ab4: usbfifoInit+0x0/0x1c()
Calling initcall 0xc001b184: serial8250_init+0x0/0x130()
Serial: 8250/16550 driver $Revision: 1.4 $ 2 ports, IRQ sharing disabled
serial8250: ttyS0 at MMIO 0xfe800000 (irq = 29) is a SC16C752
serial8250: ttyS1 at MMIO 0xfe800008 (irq = 30) is a SC16C752
Calling initcall 0xc001b578: serial8250_pci_init+0x0/0x20()
Calling initcall 0xc001bc80: rd_init+0x0/0x194()
RAMDISK driver initialized: 16 RAM disks of 10485760K size 1024 blocksize
Calling initcall 0xc001bef4: net_olddevs_init+0x0/0xdc()
Calling initcall 0xc001c024: tun_init+0x0/0x64()
tun: Universal TUN/TAP device driver, 1.6
tun: (C) 1999-2004 Max Krasnyansky <maxk@qualcomm.com>
Calling initcall 0xc001c3ac: spi_transport_init+0x0/0x44()
Calling initcall 0xc001c3f0: fc_transport_init+0x0/0x4c()
Calling initcall 0xc001c43c: iscsi_transport_init+0x0/0x108()
Calling initcall 0xc001c544: ata_init+0x0/0xa0()
libata version 2.00 loaded.
Calling initcall 0xc001c5e4: sil_init+0x0/0x20()
Calling initcall 0xc001c604: sil24_init+0x0/0x20()
Calling initcall 0xc001c624: sil680_init+0x0/0x20()
pata_sil680 0000:00:01.0: version 0.3.2
sil680: BA5_EN = 1 clock = 00
sil680: BA5_EN = 1 clock = 10
sil680: 133MHz clock.
PCI: enabling device 0000:00:01.0 (0140 -> 0143)
PCI: Enabling bus mastering for device 0000:00:01.0
ata1: PATA max UDMA/133 cmd 0xFE000010 ctl 0xFE000022 bmdma 0xFE000000 irq 27
ata2: PATA max UDMA/133 cmd 0xFE000018 ctl 0xFE000026 bmdma 0xFE000008 irq 27
scsi0 : pata_sil680
ata1.00: ATA-7, max UDMA/100, 625142448 sectors: LBA48
ata1.00: configured for UDMA/100
scsi1 : pata_sil680
ata2.00: ATA-7, max UDMA/100, 625142448 sectors: LBA48
ata2.00: configured for UDMA/100
  Vendor: ATA       Model: ST3320820A        Rev: 3.AA
  Type:   Direct-Access                      ANSI SCSI revision: 05
  Vendor: ATA       Model: ST3320820A        Rev: 3.AA
  Type:   Direct-Access                      ANSI SCSI revision: 05
Calling initcall 0xc001c644: init_sd+0x0/0x8c()
SCSI device sda: 625142448 512-byte hdwr sectors (320073 MB)
sda: Write Protect is off
sda: Mode Sense: 00 3a 00 00
SCSI device sda: drive cache: write back
SCSI device sda: 625142448 512-byte hdwr sectors (320073 MB)
sda: Write Protect is off
sda: Mode Sense: 00 3a 00 00
SCSI device sda: drive cache: write back
 sda: unknown partition table
sd 0:0:0:0: Attached scsi disk sda
SCSI device sdb: 625142448 512-byte hdwr sectors (320073 MB)
sdb: Write Protect is off
sdb: Mode Sense: 00 3a 00 00
SCSI device sdb: drive cache: write back
SCSI device sdb: 625142448 512-byte hdwr sectors (320073 MB)
sdb: Write Protect is off
sdb: Mode Sense: 00 3a 00 00
SCSI device sdb: drive cache: write back
 sdb: unknown partition table
sd 1:0:0:0: Attached scsi disk sdb
Calling initcall 0xc001c6d0: init_sg+0x0/0x14c()
sd 0:0:0:0: Attached scsi generic sg0 type 0
sd 1:0:0:0: Attached scsi generic sg1 type 0
Calling initcall 0xc001cd50: i2c_dev_init+0x0/0xa8()
i2c /dev entries driver
Calling initcall 0xc001cdf8: i2c_iop3xx_init+0x0/0x1c()
Calling initcall 0xc001ce14: hwmon_init+0x0/0x5c()
Calling initcall 0xc001d460: flow_cache_init+0x0/0x174()
Calling initcall 0xc001e888: xfrm4_transport_init+0x0/0x20()
Calling initcall 0xc001e8a8: xfrm4_tunnel_init+0x0/0x20()
Calling initcall 0xc001e8c8: inet_diag_init+0x0/0x80()
Calling initcall 0xc001e948: tcp_diag_init+0x0/0x1c()
Calling initcall 0xc001e964: bictcp_register+0x0/0x1c()
TCP bic registered
Calling initcall 0xc001eb40: af_unix_init+0x0/0x80()
NET: Registered protocol family 1
Calling initcall 0xc001ebc0: packet_init+0x0/0x70()
NET: Registered protocol family 17
Calling initcall 0xc0012a88: clocksource_done_booting+0x0/0x24()
Calling initcall 0xc0019ed4: seqgen_init+0x0/0x1c()
Calling initcall 0xc001ba44: early_uart_console_switch+0x0/0x90()
Calling initcall 0xc0139c74: net_random_reseed+0x0/0x38()
RAMDISK: Compressed image found at block 0
VFS: Mounted root (ext2 filesystem).
Freeing init memory: 104K
ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
ata1.00: (BMDMA stat 0x1)
ata1.00: tag 0 cmd 0xc8 Emask 0x4 stat 0x40 err 0x0 (timeout)
ata1: soft resetting port
ata1.00: configured for UDMA/100
ata1: EH complete
SCSI device sda: 625142448 512-byte hdwr sectors (320073 MB)
sda: Write Protect is off
sda: Mode Sense: 00 3a 00 00
SCSI device sda: drive cache: write back
ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
ata2.00: (BMDMA stat 0x1)
ata2.00: tag 0 cmd 0xc8 Emask 0x4 stat 0x40 err 0x0 (timeout)
ata2: soft resetting port
ata2.00: qc timeout (cmd 0xec)
ata2.00: failed to IDENTIFY (I/O error, err_mask=0x4)
ata2.00: revalidation failed (errno=-5)
ata2: failed to recover some devices, retrying in 5 secs
ata2: soft resetting port
ata2.00: qc timeout (cmd 0xec)
ata2.00: failed to IDENTIFY (I/O error, err_mask=0x4)
ata2.00: revalidation failed (errno=-5)
ata2: failed to recover some devices, retrying in 5 secs
ata2: soft resetting port
ata2.00: qc timeout (cmd 0xec)
ata2.00: failed to IDENTIFY (I/O error, err_mask=0x4)
ata2.00: revalidation failed (errno=-5)
ata2.00: disabled
ata2: EH complete
ata2: soft resetting port
ata2.00: ATA-7, max UDMA/100, 625142448 sectors: LBA48
ata2.00: configured for UDMA/100
ata2: EH complete
Unable to handle kernel paging request at virtual address 6f020091
pgd = c0004000
[6f020091] *pgd=00000000
Internal error: Oops: f3 [#1]
Modules linked in:
CPU: 0
PC is at scsi_device_get+0x40/0x98
LR is at kobject_get+0x18/0x20
pc : [<c00f6728>]    lr : [<c00c8274>]    Not tainted
sp : c0b5ff10  ip : c0b5feec  fp : c0b5ff24
r10: c0b68298  r9 : 00000000  r8 : 60000013
r7 : c0b68298  r6 : 00000000  r5 : c0bba090  r4 : c0bba000
r3 : 6f020045  r2 : fffffffa  r1 : c0197340  r0 : c0bba090
Flags: NzCv  IRQs off  FIQs on  Mode SVC_32  Segment kernel
Control: 397F  Table: 02EB8000  DAC: 00000017
Process ata_aux (pid: 13, stack limit = 0xc0b5e250)
Stack: (0xc0b5ff10 to 0xc0b60000)
ff00:                                     c0bba000 c0b68424 c0b5ff50 c0b5ff28
ff20: c0112d28 c00f66f4 c0b50b20 20000013 c0112c98 c0b50b28 00000001 00000000
ff40: fffffffc c0b5ff70 c0b5ff54 c0047e4c c0112ca4 c0b50b30 c0b50b28 c0b5ff90
ff60: c0b50b20 c0b5ffc0 c0b5ff74 c0047fb4 c0047da4 ffffffff ffffffff 00000001
ff80: 00000000 c003406c 00010000 00000000 00000000 c0b5b940 c003406c 00100100
ffa0: 00200200 c0b50b20 c0b5e000 c0befefc c0047ea0 c0b5fff4 c0b5ffc4 c004b670
ffc0: c0047eac 00000001 ffffffff ffffffff 00000000 00000000 00000000 00000000
ffe0: 00000000 00000000 00000000 c0b5fff8 c0039d24 c004b590 906f8a57 c8a970b5
Backtrace:
[<c00f66e8>] (scsi_device_get+0x0/0x98) from [<c0112d28>]
(ata_scsi_hotplug+0x90/0x188)
 r5 = C0B68424  r4 = C0BBA000
[<c0112c98>] (ata_scsi_hotplug+0x0/0x188) from [<c0047e4c>]
(run_workqueue+0xb4/0x108)
[<c0047d98>] (run_workqueue+0x0/0x108) from [<c0047fb4>]
(worker_thread+0x114/0x16c)
 r7 = C0B50B20  r6 = C0B5FF90  r5 = C0B50B28  r4 = C0B50B30
[<c0047ea0>] (worker_thread+0x0/0x16c) from [<c004b670>] (kthread+0xec/0x11c)
 r7 = C0047EA0  r6 = C0BEFEFC  r5 = C0B5E000  r4 = C0B50B20
[<c004b584>] (kthread+0x0/0x11c) from [<c0039d24>] (do_exit+0x0/0x7f4)
Code: e3500000 e3e02005 0a000014 e5943000 (e593304c)

^ permalink raw reply	[flat|nested] 14+ messages in thread

* Re: PATA Sil680 Warm Plug Caused 2.6.18-rc2 Kernel Internel Error
  2006-08-23 16:06 PATA Sil680 Warm Plug Caused 2.6.18-rc2 Kernel Internel Error Fajun Chen
@ 2006-08-23 16:24 ` Tejun Heo
  2006-08-23 19:12   ` Fajun Chen
  2006-08-23 16:24 ` Jeff Garzik
  1 sibling, 1 reply; 14+ messages in thread
From: Tejun Heo @ 2006-08-23 16:24 UTC (permalink / raw)
  To: Fajun Chen; +Cc: linux-ide, alan, jgarzik

Fajun Chen wrote:
> Hi Folks,
> 
> I used Linux 2.6.18-rc2 with Jeff Garzik's git libata patch for new EH, 
> hotplug,
> and pata support. Hardware is ARM IOP80321 with PCI-X. Host adapters
> is pata Sil680.  The sequence of actions are "power off drive ->
> remove drive -> power on drive -> add drive" and there's kernel errors
> while adding the drive.  Complete dmesg traces attached. Has anyone
> seen this problem before?

Can you please try the latest -mm?

-- 
tejun

^ permalink raw reply	[flat|nested] 14+ messages in thread

* Re: PATA Sil680 Warm Plug Caused 2.6.18-rc2 Kernel Internel Error
  2006-08-23 16:24 ` Tejun Heo
@ 2006-08-23 19:12   ` Fajun Chen
  2006-08-23 19:24     ` Tejun Heo
  0 siblings, 1 reply; 14+ messages in thread
From: Fajun Chen @ 2006-08-23 19:12 UTC (permalink / raw)
  To: Tejun Heo; +Cc: linux-ide, alan, jgarzik

On 8/23/06, Tejun Heo <htejun@gmail.com> wrote:
> Fajun Chen wrote:
> > Hi Folks,
> >
> > I used Linux 2.6.18-rc2 with Jeff Garzik's git libata patch for new EH,
> > hotplug,
> > and pata support. Hardware is ARM IOP80321 with PCI-X. Host adapters
> > is pata Sil680.  The sequence of actions are "power off drive ->
> > remove drive -> power on drive -> add drive" and there's kernel errors
> > while adding the drive.  Complete dmesg traces attached. Has anyone
> > seen this problem before?
>
> Can you please try the latest -mm?
We have had issues with -mm to get it to run on our ARM IOP80321
board.  Do you have any patches which can be applied to 2.6.18 rc2?

>
> --
> tejun
>

^ permalink raw reply	[flat|nested] 14+ messages in thread

* Re: PATA Sil680 Warm Plug Caused 2.6.18-rc2 Kernel Internel Error
  2006-08-23 19:12   ` Fajun Chen
@ 2006-08-23 19:24     ` Tejun Heo
  2006-08-23 19:55       ` Fajun Chen
  0 siblings, 1 reply; 14+ messages in thread
From: Tejun Heo @ 2006-08-23 19:24 UTC (permalink / raw)
  To: Fajun Chen; +Cc: linux-ide, alan, jgarzik

Fajun Chen wrote:
> On 8/23/06, Tejun Heo <htejun@gmail.com> wrote:
>> Fajun Chen wrote:
>> > Hi Folks,
>> >
>> > I used Linux 2.6.18-rc2 with Jeff Garzik's git libata patch for new EH,
>> > hotplug,
>> > and pata support. Hardware is ARM IOP80321 with PCI-X. Host adapters
>> > is pata Sil680.  The sequence of actions are "power off drive ->
>> > remove drive -> power on drive -> add drive" and there's kernel errors
>> > while adding the drive.  Complete dmesg traces attached. Has anyone
>> > seen this problem before?
>>
>> Can you please try the latest -mm?
> We have had issues with -mm to get it to run on our ARM IOP80321
> board.  Do you have any patches which can be applied to 2.6.18 rc2?

ISTR there has been some SCSI ref counting bug fixed recently.  I can't 
really pinpoint it.  I've taken a long look at libata-scsi after reading 
your bug report but couldn't find anything wrong although I found out 
that things can be simplified quite a bit.  I'll submit patch for that 
after resolving this issue.

Does 2.6.18-rc4 work on your platform albeit without sil680 support?  If 
so, I can send you a patch for sil680 over 2.6.18-rc4.

-- 
tejun

^ permalink raw reply	[flat|nested] 14+ messages in thread

* Re: PATA Sil680 Warm Plug Caused 2.6.18-rc2 Kernel Internel Error
  2006-08-23 19:24     ` Tejun Heo
@ 2006-08-23 19:55       ` Fajun Chen
       [not found]         ` <8202f4270608231349v5aabace2xaff8fe93c133a7ca@mail.gmail.com>
  0 siblings, 1 reply; 14+ messages in thread
From: Fajun Chen @ 2006-08-23 19:55 UTC (permalink / raw)
  To: Tejun Heo; +Cc: linux-ide, alan, jgarzik

On 8/23/06, Tejun Heo <htejun@gmail.com> wrote:
> Fajun Chen wrote:
> > On 8/23/06, Tejun Heo <htejun@gmail.com> wrote:
> >> Fajun Chen wrote:
> >> > Hi Folks,
> >> >
> >> > I used Linux 2.6.18-rc2 with Jeff Garzik's git libata patch for new EH,
> >> > hotplug,
> >> > and pata support. Hardware is ARM IOP80321 with PCI-X. Host adapters
> >> > is pata Sil680.  The sequence of actions are "power off drive ->
> >> > remove drive -> power on drive -> add drive" and there's kernel errors
> >> > while adding the drive.  Complete dmesg traces attached. Has anyone
> >> > seen this problem before?
> >>
> >> Can you please try the latest -mm?
> > We have had issues with -mm to get it to run on our ARM IOP80321
> > board.  Do you have any patches which can be applied to 2.6.18 rc2?
>
> ISTR there has been some SCSI ref counting bug fixed recently.  I can't
> really pinpoint it.  I've taken a long look at libata-scsi after reading
> your bug report but couldn't find anything wrong although I found out
> that things can be simplified quite a bit.  I'll submit patch for that
> after resolving this issue.
>
> Does 2.6.18-rc4 work on your platform albeit without sil680 support?  If
> so, I can send you a patch for sil680 over 2.6.18-rc4.

2.6.18-rc4 without Sil680 has not been tested on my platform.  What's
the difference between rc2 and rc4? In other word, could I apply your
upcoming patch for sil680 over 2.6.18-rc2? Quite a few other patches
have to been applied to upgrade kernel for our system,  I can have
much quicker turnaround if your patch is applicable to 2.6.18-rc2.

Thanks,
Fajun

^ permalink raw reply	[flat|nested] 14+ messages in thread

[parent not found: <8202f4270608231349v5aabace2xaff8fe93c133a7ca@mail.gmail.com>]

[parent not found: <20060824070257.GD21866@htj.dyndns.org>]

[parent not found: <8202f4270608240942i6b620961t1a03d4148dd4a32d@mail.gmail.com>]

* Re: PATA Sil680 Warm Plug Caused 2.6.18-rc2 Kernel Internel Error
       [not found]             ` <8202f4270608240942i6b620961t1a03d4148dd4a32d@mail.gmail.com>
@ 2006-08-24 17:02               ` Tejun Heo
  2006-08-25  0:01                 ` Fajun Chen
  0 siblings, 1 reply; 14+ messages in thread
From: Tejun Heo @ 2006-08-24 17:02 UTC (permalink / raw)
  To: Fajun Chen, linux-ide@vger.kernel.org

[cc'ing linux-ide again]

Fajun Chen wrote:
> Hi Tejun,
> 
> Your patch is successful at fixing the kernel error when adding pata
> drive on 2.6.18-rc2 but there's some sg availability issue.  I did the
> same sequence of test: power off drive -> remove drive -> power on
> drive -> add drive. From dmesg log, pata drive was added back
> successfully as sg0 but somehow it is unavailable for upper level. For
> instance, sg_scan didn't detect it. It is not shown in
> /sys/class/scsi_generic/.  Sg utilities sg_inq and sg_dd complained
> about no such device for sg0.  Is there any magic command I need to
> issue to populate sg information up to the user space? If not, then
> there is still bug somewhere.  Complete log of the test sequence is
> attached.
> 
> I'll hold off the testing on 2.6.18-rc4 for now. Please let me know if
> you think it still makes sense to test your patch in the new release.
> Thanks for your help!

The thing is that the patch shouldn't really change behavior.  With the 
patch, libata might be more forgiving about SCSI refcnt bugs but the 
code before and after are identical correctness-wise.  ISTR there has 
been SCSI ref bug fixed sometime inbetween.  I can't pinpoint it though. 
  So, please try 2.5.18-rc4 w/ or w/o the patch.  Pull 
libata-dev#pata-drivers, that's basically current linus #master + 
libata-dev#upstream updates + Alan's pata-drivers.

Of course, I might be wrong, but I kind of have too little lead to 
follow on at the moment, especially because I can't reproduce it here. 
If testing new kernel on your target platform takes a lot of effort, 
just perform preliminary tests on x86.  As far as SCSI and libata are 
concerned, there's little difference.

-- 
tejun

^ permalink raw reply	[flat|nested] 14+ messages in thread

* Re: PATA Sil680 Warm Plug Caused 2.6.18-rc2 Kernel Internel Error
  2006-08-24 17:02               ` Tejun Heo
@ 2006-08-25  0:01                 ` Fajun Chen
  2006-08-25 15:26                   ` Fajun Chen
  0 siblings, 1 reply; 14+ messages in thread
From: Fajun Chen @ 2006-08-25  0:01 UTC (permalink / raw)
  To: Tejun Heo; +Cc: linux-ide@vger.kernel.org

[-- Attachment #1: Type: text/plain, Size: 2477 bytes --]

Hi Tejun,

I tested 2.6.18-rc4-mm2 on i386 platform with and without your patch.
The behavior is the same as rc2 with your patch. No kernel error and
the only relevant dmesg traces are:
[  125.048966] ata5: soft resetting port
[  125.202410] ata5.00: configured for UDMA/100
[  125.202492] ata5: EH complete
[End of dmesg]
It did not proceed to add/attach sg device!

In rc4-mm2 release without your patch, I forgot to power on pata drive
and add drive will cause kernel error. Please see attachment for
detailed log.

I can reproduce the problem easily, please feel free to let me know
what kind of log/traces can be collected.

Thanks,
Fajun


On 8/24/06, Tejun Heo <htejun@gmail.com> wrote:
> [cc'ing linux-ide again]
>
> Fajun Chen wrote:
> > Hi Tejun,
> >
> > Your patch is successful at fixing the kernel error when adding pata
> > drive on 2.6.18-rc2 but there's some sg availability issue.  I did the
> > same sequence of test: power off drive -> remove drive -> power on
> > drive -> add drive. From dmesg log, pata drive was added back
> > successfully as sg0 but somehow it is unavailable for upper level. For
> > instance, sg_scan didn't detect it. It is not shown in
> > /sys/class/scsi_generic/.  Sg utilities sg_inq and sg_dd complained
> > about no such device for sg0.  Is there any magic command I need to
> > issue to populate sg information up to the user space? If not, then
> > there is still bug somewhere.  Complete log of the test sequence is
> > attached.
> >
> > I'll hold off the testing on 2.6.18-rc4 for now. Please let me know if
> > you think it still makes sense to test your patch in the new release.
> > Thanks for your help!
>
> The thing is that the patch shouldn't really change behavior.  With the
> patch, libata might be more forgiving about SCSI refcnt bugs but the
> code before and after are identical correctness-wise.  ISTR there has
> been SCSI ref bug fixed sometime inbetween.  I can't pinpoint it though.
>   So, please try 2.5.18-rc4 w/ or w/o the patch.  Pull
> libata-dev#pata-drivers, that's basically current linus #master +
> libata-dev#upstream updates + Alan's pata-drivers.
>
> Of course, I might be wrong, but I kind of have too little lead to
> follow on at the moment, especially because I can't reproduce it here.
> If testing new kernel on your target platform takes a lot of effort,
> just perform preliminary tests on x86.  As far as SCSI and libata are
> concerned, there's little difference.
>
> --
> tejun
>

[-- Attachment #2: warmplug-fail-2.6.18-rc4-mm2.txt --]
[-- Type: text/plain, Size: 16289 bytes --]

Script started on Thu 24 Aug 2006 05:22:13 PM MDT
^[]0;fchen@RockySnow:~/Projects/gemstar/debug\a[fchen@RockySnow debug]$ te\b^[[K\b^[[K!tel
telnet 192.168.0.2
Trying 192.168.0.2...
Connected to 192.168.0.2.
Escape character is '^]'.
stdin, stdout, etderr: 0 1 2
sh-2.04# dmesg
[    0.000000] Linux version 2.6.18-rc4-mm2 (fchen@RockySnow) (gcc version 3.2.2 20030222 (Red Hat Linux 3.2.2-5)) #1 Thu Aug 24 17:11:24 MDT 2006
[    0.000000] BIOS-provided physical RAM map:
[    0.000000] sanitize start
[    0.000000] sanitize end
[    0.000000] copy_e820_map() start: 0000000000000000 size: 00000000000a0000 end: 00000000000a0000 type: 1
[    0.000000] copy_e820_map() type is E820_RAM
[    0.000000] copy_e820_map() start: 00000000000f0000 size: 0000000000010000 end: 0000000000100000 type: 2
[    0.000000] copy_e820_map() start: 0000000000100000 size: 0000000003e00000 end: 0000000003f00000 type: 1
[    0.000000] copy_e820_map() type is E820_RAM
[    0.000000] copy_e820_map() start: 00000000ffb00000 size: 0000000000500000 end: 0000000100000000 type: 2
[    0.000000]  BIOS-e820: 0000000000000000 - 00000000000a0000 (usable)
[    0.000000]  BIOS-e820: 00000000000f0000 - 0000000000100000 (reserved)
[    0.000000]  BIOS-e820: 0000000000100000 - 0000000003f00000 (usable)
[    0.000000]  BIOS-e820: 00000000ffb00000 - 0000000100000000 (reserved)
[    0.000000] 63MB LOWMEM available.
[    0.000000] On node 0 totalpages: 16128
[    0.000000]   DMA zone: 4096 pages, LIFO batch:0
[    0.000000]   Normal zone: 12032 pages, LIFO batch:1
[    0.000000] DMI 2.2 present.
[    0.000000] Allocating PCI resources starting at 10000000 (gap: 03f00000:fbc00000)
[    0.000000] Detected 735.048 MHz processor.
[   25.962253] Built 1 zonelists.  Total pages: 16128
[   25.962259] Kernel command line: rw root=/dev/ram 
[   25.962865] Enabling fast FPU save and restore... done.
[   25.962874] Enabling unmasked SIMD FPU exception support... done.
[   25.962880] Initializing CPU#0
[   25.962961] PID hash table entries: 256 (order: 8, 1024 bytes)
[   25.964819] Console: colour VGA+ 80x25
[   25.966538] Dentry cache hash table entries: 8192 (order: 3, 32768 bytes)
[   25.966741] Inode-cache hash table entries: 4096 (order: 2, 16384 bytes)
[   25.974315] Memory: 55496k/64512k available (2230k kernel code, 8612k reserved, 671k data, 184k init, 0k highmem)
[   25.974437] virtual kernel memory layout:
[   25.974440]     fixmap  : 0xffffd000 - 0xfffff000   (   8 kB)
[   25.974444]     vmalloc : 0xc4800000 - 0xffffb000   ( 951 MB)
[   25.974447]     lowmem  : 0xc0000000 - 0xc3f00000   (  63 MB)
[   25.974451]       .init : 0xc03d8000 - 0xc0406000   ( 184 kB)
[   25.974454]       .data : 0xc032d9b4 - 0xc03d5988   ( 671 kB)
[   25.974458]       .text : 0xc0100000 - 0xc032d9b4   (2230 kB)
[   25.974855] Checking if this processor honours the WP bit even in supervisor mode... Ok.
[   26.034946] Calibrating delay using timer specific routine.. 1470.69 BogoMIPS (lpj=735346)
[   26.035189] Mount-cache hash table entries: 512
[   26.035565] CPU: After generic identify, caps: 0383f9ff 00000000 00000000 00000000 00000000 00000000 00000000
[   26.035595] CPU: L1 I cache: 16K, L1 D cache: 16K
[   26.035686] CPU: L2 cache: 128K
[   26.035744] CPU: After all inits, caps: 0383f9ff 00000000 00000000 00000040 00000000 00000000 00000000
[   26.035759] Intel machine check architecture supported.
[   26.035822] Intel machine check reporting enabled on CPU#0.
[   26.035904] Compat vDSO mapped to ffffe000.
[   26.036007] CPU: Intel Celeron (Coppermine) stepping 0a
[   26.036146] Checking 'hlt' instruction... OK.
[   26.040649] checking if image is initramfs...it isn't (no cpio magic); looks like an initrd
[   26.700271] Freeing initrd memory: 4672k freed
[   26.701393] NET: Registered protocol family 16
[   26.713849] PCI: PCI BIOS revision 2.10 entry at 0xfb400, last bus=1
[   26.713942] PCI: Using configuration type 1
[   26.714000] Setting up standard PCI resources
[   26.723021] Linux Plug and Play Support v0.97 (c) Adam Belay
[   26.723226] PCI: Probing PCI hardware
[   26.723293] PCI: Probing PCI hardware (bus 00)
[   26.723629] Boot video device is 0000:00:01.0
[   26.723882] PCI quirk: region 4000-407f claimed by ICH4 ACPI/GPIO/TCO
[   26.723958] PCI quirk: region 4080-40bf claimed by ICH4 GPIO
[   26.724467] PCI: Transparent bridge - 0000:00:1e.0
[   26.725900] PCI: Using IRQ router PIIX/ICH [8086/2410] at 0000:00:1f.0
[   26.734370] PCI: Ignore bogus resource 6 [0:0] of 0000:00:01.0
[   26.734464] PCI: Bridge: 0000:00:1e.0
[   26.734522]   IO window: b000-cfff
[   26.734586]   MEM window: d4000000-d5ffffff
[   26.734649]   PREFETCH window: 10000000-100fffff
[   26.734732] PCI: Setting latency timer of device 0000:00:1e.0 to 64
[   26.734881] NET: Registered protocol family 2
[   26.744873] IP route cache hash table entries: 512 (order: -1, 2048 bytes)
[   26.745219] TCP established hash table entries: 2048 (order: 1, 8192 bytes)
[   26.745325] TCP bind hash table entries: 1024 (order: 0, 4096 bytes)
[   26.745408] TCP: Hash tables configured (established 2048 bind 1024)
[   26.745474] TCP reno registered
[   26.747181] NTFS driver 2.1.27 [Flags: R/O].
[   26.747406] io scheduler noop registered
[   26.747494] io scheduler anticipatory registered (default)
[   26.747602] io scheduler deadline registered
[   26.747712] io scheduler cfq registered
[   26.748054] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
[   26.748512] isapnp: Scanning for PnP cards...
[   27.104483] isapnp: No Plug & Play device found
[   27.257337] Real Time Clock Driver v1.12ac
[   27.257416] Serial: 8250/16550 driver $Revision: 1.90 $ 4 ports, IRQ sharing enabled
[   27.501579] serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
[   27.745577] serial8250: ttyS1 at I/O 0x2f8 (irq = 3) is a 16550A
[   27.747944] Floppy drive(s): fd0 is 1.44M
[   27.763094] FDC 0 is a post-1991 82077
[   27.764520] RAMDISK driver initialized: 1 RAM disks of 16384K size 1024 blocksize
[   27.765100] 8139cp: 10/100 PCI Ethernet driver v1.2 (Mar 22, 2004)
[   27.765185] 8139cp 0000:01:08.0: This (id 10ec:8139 rev 10) is not an 8139C+ compatible chip
[   27.765275] 8139cp 0000:01:08.0: Try the "8139too" driver instead.
[   27.765464] 8139too Fast Ethernet driver 0.9.27
[   27.765569] PCI: setting IRQ 10 as level-triggered
[   27.765576] PCI: Found IRQ 10 for device 0000:01:08.0
[   27.765644] PCI: Sharing IRQ 10 with 0000:00:01.0
[   27.766341] eth0: RealTek RTL8139 at 0xc480c000, 00:d0:c9:54:04:69, IRQ 10
[   27.766416] eth0:  Identified 8139 chip type 'RTL-8139B'
[   27.766826] PNP: No PS/2 controller found. Probing ports directly.
[   27.768741] serio: i8042 AUX port at 0x60,0x64 irq 12
[   27.768877] serio: i8042 KBD port at 0x60,0x64 irq 1
[   27.769480] mice: PS/2 mouse device common for all mice
[   27.769643] md: md driver 0.90.3 MAX_MD_DEVS=256, MD_SB_DISKS=27
[   27.769710] md: bitmap version 4.39
[   27.769904] TCP bic registered
[   27.769984] NET: Registered protocol family 1
[   27.770053] NET: Registered protocol family 17
[   27.770233] Using IPI Shortcut mode
[   27.770439] Time: tsc clocksource has been installed.
[   27.771204] md: Autodetecting RAID arrays.
[   27.771272] md: autorun ...
[   27.771325] md: ... autorun DONE.
[   27.771633] RAMDISK: Compressed image found at block 0
[   28.537528] VFS: Mounted root (ext2 filesystem).
[   28.538554] Freeing unused kernel memory: 184k freed
[   28.655953] input: AT Translated Set 2 keyboard as /class/input/input0
[   31.374481] eth0: link up, 100Mbps, full-duplex, lpa 0x45E1
[   31.498219] warning: process `cmd_sock_server' used the removed sysctl system call
[   31.515686] warning: process `cmd_sock_server' used the removed sysctl system call
[   31.517293] warning: process `cmd_sock_server' used the removed sysctl system call
[  141.249637] warning: process `ls' used the removed sysctl system call
[  149.029301] SCSI subsystem initialized
[  149.117317] libata version 2.00 loaded.
[  149.129655] sata_sil24 0000:01:02.0: version 0.3
[  149.129804] PCI: setting IRQ 11 as level-triggered
[  149.129868] PCI: Found IRQ 11 for device 0000:01:02.0
[  149.130395] ata1: SATA max UDMA/100 cmd 0xC4820000 ctl 0x0 bmdma 0x0 irq 11
[  149.130983] ata2: SATA max UDMA/100 cmd 0xC4822000 ctl 0x0 bmdma 0x0 irq 11
[  149.131658] ata3: SATA max UDMA/100 cmd 0xC4824000 ctl 0x0 bmdma 0x0 irq 11
[  149.132394] ata4: SATA max UDMA/100 cmd 0xC4826000 ctl 0x0 bmdma 0x0 irq 11
[  149.133988] scsi0 : sata_sil24
[  149.548645] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[  149.550073] ata1.00: ATA-6, max UDMA/133, 78125000 sectors: LBA48 NCQ (depth 31/32)
[  149.551611] ata1.00: configured for UDMA/100
[  149.551695] scsi1 : sata_sil24
[  149.854550] ata2: SATA link down (SStatus 0 SControl 300)
[  149.854649] scsi2 : sata_sil24
[  150.157457] ata3: SATA link down (SStatus 0 SControl 300)
[  150.157543] scsi3 : sata_sil24
[  150.460368] ata4: SATA link down (SStatus 0 SControl 300)
[  150.460730]   Vendor: ATA       Model: ST340014AS        Rev: 8.12
[  150.461532]   Type:   Direct-Access                      ANSI SCSI revision: 05
[  150.475322] pata_sil680 0000:01:0d.0: version 0.3.2
[  150.475440] sil680: BA5_EN = 1 clock = 00
[  150.475502] sil680: BA5_EN = 1 clock = 10
[  150.475576] sil680: 133MHz clock.
[  150.475658] PCI: setting IRQ 15 as level-triggered
[  150.475720] PCI: Found IRQ 15 for device 0000:01:0d.0
[  150.475971] ata5: PATA max UDMA/133 cmd 0xB800 ctl 0xBC02 bmdma 0xC800 irq 15
[  150.476140] ata6: PATA max UDMA/133 cmd 0xC000 ctl 0xC402 bmdma 0xC808 irq 15
[  150.476238] scsi4 : pata_sil680
[  150.628794] ata5.00: ATA-6, max UDMA/100, 586072368 sectors: LBA48 
[  150.630288] ata5.00: configured for UDMA/100
[  150.630371] scsi5 : pata_sil680
[  151.960469] ATA: abnormal status 0x7F on port 0xC007
[  151.960979]   Vendor: ATA       Model: ST3300831A        Rev: 2.04
[  151.961770]   Type:   Direct-Access                      ANSI SCSI revision: 05
[  151.975757] scsi 0:0:0:0: Attached scsi generic sg0 type 0
[  151.976010] scsi 4:0:0:0: Attached scsi generic sg1 type 0
[  166.665477] ata1: exception Emask 0x10 SAct 0x0 SErr 0x80000 action 0x2 frozen
[  166.665585] ata1: (irq_stat 0x01100010, PHY RDY changed)
[  167.906233] ata1: soft resetting port
[  167.906308] ata1: SATA link down (SStatus 0 SControl 300)
[  167.906381] ata1: failed to recover some devices, retrying in 5 secs
[  173.425609] ata1: hard resetting port
[  175.445019] ata1: SATA link down (SStatus 0 SControl 300)
[  175.445089] ata1: failed to recover some devices, retrying in 5 secs
[  180.964393] ata1: hard resetting port
[  183.589635] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[  183.592578] ata1.00: configured for UDMA/100
[  183.592654] ata1: EH complete
[  288.313094] ata5: soft resetting port
[  289.589115] ATA: abnormal status 0x7F on port 0xB807
[  290.717469] ATA: abnormal status 0x7F on port 0xB807
[  291.845618] ATA: abnormal status 0x7F on port 0xB807
[  292.970969] ATA: abnormal status 0x7F on port 0xB807
[  294.096315] ATA: abnormal status 0x7F on port 0xB807
[  295.221660] ATA: abnormal status 0x7F on port 0xB807
[  325.213051] ata5.00: qc timeout (cmd 0xec)
[  325.213138] ata5.00: failed to IDENTIFY (I/O error, err_mask=0x4)
[  325.213204] ata5.00: revalidation failed (errno=-5)
[  325.213269] ata5: failed to recover some devices, retrying in 5 secs
[  330.212534] ata5: soft resetting port
[  331.488778] ATA: abnormal status 0x7F on port 0xB807
[  332.617033] ATA: abnormal status 0x7F on port 0xB807
[  333.745177] ATA: abnormal status 0x7F on port 0xB807
[  334.870528] ATA: abnormal status 0x7F on port 0xB807
[  335.995875] ATA: abnormal status 0x7F on port 0xB807
[  337.121220] ATA: abnormal status 0x7F on port 0xB807
[  367.112745] ata5.00: qc timeout (cmd 0xec)
[  367.112832] ata5.00: failed to IDENTIFY (I/O error, err_mask=0x4)
[  367.112898] ata5.00: revalidation failed (errno=-5)
[  367.112963] ata5: failed to recover some devices, retrying in 5 secs
[  372.112235] ata5: soft resetting port
[  373.388459] ATA: abnormal status 0x7F on port 0xB807
[  374.516705] ATA: abnormal status 0x7F on port 0xB807
[  375.644854] ATA: abnormal status 0x7F on port 0xB807
[  376.770204] ATA: abnormal status 0x7F on port 0xB807
[  377.895551] ATA: abnormal status 0x7F on port 0xB807
[  379.020896] ATA: abnormal status 0x7F on port 0xB807
[  409.012409] ata5.00: qc timeout (cmd 0xec)
[  409.012488] ata5.00: failed to IDENTIFY (I/O error, err_mask=0x4)
[  409.012554] ata5.00: revalidation failed (errno=-5)
[  409.012618] ata5.00: disabled
[  409.513207] ata5: soft resetting port
[  410.789460] ATA: abnormal status 0x7F on port 0xB807
[  410.789626] ata5: EH complete
[  410.789696] BUG: warning at lib/kref.c:32/kref_get()
[  410.789764]  [<c0234c14>] kref_get+0x44/0x50
[  410.789868]  [<c02342ca>] kobject_get+0x1a/0x30
[  410.789953]  [<c0278946>] get_device+0x16/0x30
[  410.790057]  [<c4838c8e>] scsi_device_get+0x3e/0x80 [scsi_mod]
[  410.790224]  [<c4864341>] ata_scsi_remove_dev+0x31/0xd0 [libata]
[  410.790391]  [<c486441e>] ata_scsi_hotplug+0x3e/0xc0 [libata]
[  410.790499]  [<c0121c4f>] run_workqueue+0x6f/0xd0
[  410.790596]  [<c48643e0>] ata_scsi_hotplug+0x0/0xc0 [libata]
[  410.790704]  [<c0121e18>] worker_thread+0x168/0x190
[  410.790791]  [<c010e210>] default_wake_function+0x0/0x20
[  410.790890]  [<c010e210>] default_wake_function+0x0/0x20
[  410.790979]  [<c0121cb0>] worker_thread+0x0/0x190
[  410.791064]  [<c0125387>] kthread+0xb7/0xc0
[  410.791157]  [<c01252d0>] kthread+0x0/0xc0
[  410.791241]  [<c01031ab>] kernel_thread_helper+0x7/0x1c
[  410.791335]  =======================
[  410.791404] BUG: unable to handle kernel NULL pointer dereference at virtual address 00000058
[  410.791517]  printing eip:
[  410.791570] c4838c9e
[  410.791620] *pde = 00000000
[  410.791676] Oops: 0000 [#1]
[  410.791729] 8K_STACKS 
[  410.791804] last sysfs file: 
[  410.791857] Modules linked in: sg pata_sil680 sata_sil24 libata scsi_mod
[  410.792071] CPU:    0
[  410.792073] EIP:    0060:[<c4838c9e>]    Not tainted VLI
[  410.792077] EFLAGS: 00010086   (2.6.18-rc4-mm2 #1) 
[  410.792261] EIP is at scsi_device_get+0x4e/0x80 [scsi_mod]
[  410.792325] eax: 00000000   ebx: c2848400   ecx: 000003d4   edx: 00000001
[  410.792393] esi: c2848490   edi: c2864448   ebp: c28642c0   esp: c2809ee0
[  410.792459] ds: 007b   es: 007b   ss: 0068
[  410.792519] Process ata_aux (pid: 740, ti=c2808000 task=c3edfa70 task.ti=c2808000)
[  410.792586] Stack: c2848490 c2848400 00000282 c4864341 c2848400 c3a5bd40 00000000 c390dfa4 
[  410.792887]        c2864448 00000001 c28642c0 c28642c0 c486441e c2864448 c28662ac 00000296 
[  410.793189]        c39a02a0 c0121c4f c28642c0 000001e8 bee2c8c6 c39a02b8 c39a02a8 c48643e0 
[  410.793490] Call Trace:
[  410.793586]  [<c4864341>] ata_scsi_remove_dev+0x31/0xd0 [libata]
[  410.793699]  [<c486441e>] ata_scsi_hotplug+0x3e/0xc0 [libata]
[  410.793807]  [<c0121c4f>] run_workqueue+0x6f/0xd0
[  410.793893]  [<c48643e0>] ata_scsi_hotplug+0x0/0xc0 [libata]
[  410.794001]  [<c0121e18>] worker_thread+0x168/0x190
[  410.794088]  [<c010e210>] default_wake_function+0x0/0x20
[  410.794177]  [<c010e210>] default_wake_function+0x0/0x20
[  410.794266]  [<c0121cb0>] worker_thread+0x0/0x190
[  410.794351]  [<c0125387>] kthread+0xb7/0xc0
[  410.794436]  [<c01252d0>] kthread+0x0/0xc0
[  410.794520]  [<c01031ab>] kernel_thread_helper+0x7/0x1c
[  410.794607]  =======================
[  410.794662] Code: 5c 24 04 89 d0 8b 74 24 08 83 c4 0c c3 8d b3 90 00 00 00 89 34 24 e8 a2 fc a3 fb ba fa ff ff ff 85 c0 74 db 8b 03 ba 01 00 00 00 <8b> 40 58 8b 00 85 c0 74 0b 83 38 02 74 1d ff 80 20 01 00 00 85 
[  410.796319] EIP: [<c4838c9e>] scsi_device_get+0x4e/0x80 [scsi_mod] SS:ESP 0068:c2809ee0
[  410.796476]  
sh-2.04# exit
exit
Connection closed by foreign host.
^[]0;fchen@RockySnow:~/Projects/gemstar/debug\a[fchen@RockySnow debug]$ exit
exit

Script done on Thu 24 Aug 2006 05:22:56 PM MDT

^ permalink raw reply	[flat|nested] 14+ messages in thread

* Re: PATA Sil680 Warm Plug Caused 2.6.18-rc2 Kernel Internel Error
  2006-08-25  0:01                 ` Fajun Chen
@ 2006-08-25 15:26                   ` Fajun Chen
  2006-08-25 15:35                     ` Tejun Heo
  0 siblings, 1 reply; 14+ messages in thread
From: Fajun Chen @ 2006-08-25 15:26 UTC (permalink / raw)
  To: Tejun Heo; +Cc: linux-ide@vger.kernel.org

Hi Tejun,

JFYI. I found a workaround which seems to be working in 2.6.18-rc2.
During warm plug/unplug, if I don't delete the device through sysfs or
proc and just rescan the host, it recovered just fine.

Thanks,
Fajun

On 8/24/06, Fajun Chen <fajunchen@gmail.com> wrote:
> Hi Tejun,
>
> I tested 2.6.18-rc4-mm2 on i386 platform with and without your patch.
> The behavior is the same as rc2 with your patch. No kernel error and
> the only relevant dmesg traces are:
> [  125.048966] ata5: soft resetting port
> [  125.202410] ata5.00: configured for UDMA/100
> [  125.202492] ata5: EH complete
> [End of dmesg]
> It did not proceed to add/attach sg device!
>
> In rc4-mm2 release without your patch, I forgot to power on pata drive
> and add drive will cause kernel error. Please see attachment for
> detailed log.
>
> I can reproduce the problem easily, please feel free to let me know
> what kind of log/traces can be collected.
>
> Thanks,
> Fajun
>
>
> On 8/24/06, Tejun Heo <htejun@gmail.com> wrote:
> > [cc'ing linux-ide again]
> >
> > Fajun Chen wrote:
> > > Hi Tejun,
> > >
> > > Your patch is successful at fixing the kernel error when adding pata
> > > drive on 2.6.18-rc2 but there's some sg availability issue.  I did the
> > > same sequence of test: power off drive -> remove drive -> power on
> > > drive -> add drive. From dmesg log, pata drive was added back
> > > successfully as sg0 but somehow it is unavailable for upper level. For
> > > instance, sg_scan didn't detect it. It is not shown in
> > > /sys/class/scsi_generic/.  Sg utilities sg_inq and sg_dd complained
> > > about no such device for sg0.  Is there any magic command I need to
> > > issue to populate sg information up to the user space? If not, then
> > > there is still bug somewhere.  Complete log of the test sequence is
> > > attached.
> > >
> > > I'll hold off the testing on 2.6.18-rc4 for now. Please let me know if
> > > you think it still makes sense to test your patch in the new release.
> > > Thanks for your help!
> >
> > The thing is that the patch shouldn't really change behavior.  With the
> > patch, libata might be more forgiving about SCSI refcnt bugs but the
> > code before and after are identical correctness-wise.  ISTR there has
> > been SCSI ref bug fixed sometime inbetween.  I can't pinpoint it though.
> >   So, please try 2.5.18-rc4 w/ or w/o the patch.  Pull
> > libata-dev#pata-drivers, that's basically current linus #master +
> > libata-dev#upstream updates + Alan's pata-drivers.
> >
> > Of course, I might be wrong, but I kind of have too little lead to
> > follow on at the moment, especially because I can't reproduce it here.
> > If testing new kernel on your target platform takes a lot of effort,
> > just perform preliminary tests on x86.  As far as SCSI and libata are
> > concerned, there's little difference.
> >
> > --
> > tejun
> >
>
>
>

^ permalink raw reply	[flat|nested] 14+ messages in thread

* Re: PATA Sil680 Warm Plug Caused 2.6.18-rc2 Kernel Internel Error
  2006-08-25 15:26                   ` Fajun Chen
@ 2006-08-25 15:35                     ` Tejun Heo
  2006-08-25 17:27                       ` Fajun Chen
  0 siblings, 1 reply; 14+ messages in thread
From: Tejun Heo @ 2006-08-25 15:35 UTC (permalink / raw)
  To: Fajun Chen; +Cc: linux-ide@vger.kernel.org

Fajun Chen wrote:
> Hi Tejun,
> 
> JFYI. I found a workaround which seems to be working in 2.6.18-rc2.
> During warm plug/unplug, if I don't delete the device through sysfs or
> proc and just rescan the host, it recovered just fine.

Hello,

I'm trying to reproduce it here but haven't succeeded yet.  Can you 
describe what you did in more detail?  I'm trying various things - 
issuing delete / scan, combination of them after unplugging my drive, 
etc..., but haven't succeeded in reproducing your error condition.  It 
seems to be a sdev refcnting problem in libata but I need more clue...

Thanks.

-- 
tejun

^ permalink raw reply	[flat|nested] 14+ messages in thread

* Re: PATA Sil680 Warm Plug Caused 2.6.18-rc2 Kernel Internel Error
  2006-08-25 15:35                     ` Tejun Heo
@ 2006-08-25 17:27                       ` Fajun Chen
  2006-08-25 18:00                         ` Tejun Heo
  0 siblings, 1 reply; 14+ messages in thread
From: Fajun Chen @ 2006-08-25 17:27 UTC (permalink / raw)
  To: Tejun Heo; +Cc: linux-ide@vger.kernel.org

Hi Tejun,

Below are the tests I performed:
Test1:
a) Power off the drive
b) echo "scsi remove-single-device h b t l" > /proc/scsi/scsi
or delete using sysfs
c) Power on the drive
d) echo "scsi add-single-device h b t l" > /proc/scsi/scsi
or scan using sysfs
The kernel error in my first email is induced in this test but not
consistently reproducible. In most of the case, no kernel error but sg
was not reattached when adding device.

Test2:
Ignore step c) in test1. Basically, try to add device while the device
is still powered off.

Hope this helps.

Thanks,
Fajun

On 8/25/06, Tejun Heo <htejun@gmail.com> wrote:
> Fajun Chen wrote:
> > Hi Tejun,
> >
> > JFYI. I found a workaround which seems to be working in 2.6.18-rc2.
> > During warm plug/unplug, if I don't delete the device through sysfs or
> > proc and just rescan the host, it recovered just fine.
>
> Hello,
>
> I'm trying to reproduce it here but haven't succeeded yet.  Can you
> describe what you did in more detail?  I'm trying various things -
> issuing delete / scan, combination of them after unplugging my drive,
> etc..., but haven't succeeded in reproducing your error condition.  It
> seems to be a sdev refcnting problem in libata but I need more clue...
>
> Thanks.
>
> --
> tejun
>

^ permalink raw reply	[flat|nested] 14+ messages in thread

* Re: PATA Sil680 Warm Plug Caused 2.6.18-rc2 Kernel Internel Error
  2006-08-25 17:27                       ` Fajun Chen
@ 2006-08-25 18:00                         ` Tejun Heo
  2006-08-25 20:19                           ` Fajun Chen
  0 siblings, 1 reply; 14+ messages in thread
From: Tejun Heo @ 2006-08-25 18:00 UTC (permalink / raw)
  To: Fajun Chen; +Cc: linux-ide@vger.kernel.org

Fajun Chen wrote:
> Hi Tejun,
> 
> Below are the tests I performed:
> Test1:
> a) Power off the drive
> b) echo "scsi remove-single-device h b t l" > /proc/scsi/scsi
> or delete using sysfs
> c) Power on the drive
> d) echo "scsi add-single-device h b t l" > /proc/scsi/scsi
> or scan using sysfs
> The kernel error in my first email is induced in this test but not
> consistently reproducible. In most of the case, no kernel error but sg
> was not reattached when adding device.
> 
> Test2:
> Ignore step c) in test1. Basically, try to add device while the device
> is still powered off.
> 
> Hope this helps.

Was the drive loaded with commands issued via /dev/sgX when you did 
above operation?

-- 
tejun

^ permalink raw reply	[flat|nested] 14+ messages in thread

* Re: PATA Sil680 Warm Plug Caused 2.6.18-rc2 Kernel Internel Error
  2006-08-25 18:00                         ` Tejun Heo
@ 2006-08-25 20:19                           ` Fajun Chen
  2006-08-25 20:32                             ` Tejun Heo
  0 siblings, 1 reply; 14+ messages in thread
From: Fajun Chen @ 2006-08-25 20:19 UTC (permalink / raw)
  To: Tejun Heo; +Cc: linux-ide@vger.kernel.org

On 8/25/06, Tejun Heo <htejun@gmail.com> wrote:
> Fajun Chen wrote:
> > Hi Tejun,
> >
> > Below are the tests I performed:
> > Test1:
> > a) Power off the drive
> > b) echo "scsi remove-single-device h b t l" > /proc/scsi/scsi
> > or delete using sysfs
> > c) Power on the drive
> > d) echo "scsi add-single-device h b t l" > /proc/scsi/scsi
> > or scan using sysfs
> > The kernel error in my first email is induced in this test but not
> > consistently reproducible. In most of the case, no kernel error but sg
> > was not reattached when adding device.
> >
> > Test2:
> > Ignore step c) in test1. Basically, try to add device while the device
> > is still powered off.
> >
> > Hope this helps.
>
> Was the drive loaded with commands issued via /dev/sgX when you did
> above operation?

 No.   One note: the kernel error I reported in my first email
happened in ARM XSCale IOP80321 platform.

Thanks,
Fajun

^ permalink raw reply	[flat|nested] 14+ messages in thread

* Re: PATA Sil680 Warm Plug Caused 2.6.18-rc2 Kernel Internel Error
  2006-08-25 20:19                           ` Fajun Chen
@ 2006-08-25 20:32                             ` Tejun Heo
  0 siblings, 0 replies; 14+ messages in thread
From: Tejun Heo @ 2006-08-25 20:32 UTC (permalink / raw)
  To: Fajun Chen; +Cc: linux-ide@vger.kernel.org

Fajun Chen wrote:
> On 8/25/06, Tejun Heo <htejun@gmail.com> wrote:
>> Fajun Chen wrote:
>> > Hi Tejun,
>> >
>> > Below are the tests I performed:
>> > Test1:
>> > a) Power off the drive
>> > b) echo "scsi remove-single-device h b t l" > /proc/scsi/scsi
>> > or delete using sysfs
>> > c) Power on the drive
>> > d) echo "scsi add-single-device h b t l" > /proc/scsi/scsi
>> > or scan using sysfs
>> > The kernel error in my first email is induced in this test but not
>> > consistently reproducible. In most of the case, no kernel error but sg
>> > was not reattached when adding device.
>> >
>> > Test2:
>> > Ignore step c) in test1. Basically, try to add device while the device
>> > is still powered off.
>> >
>> > Hope this helps.
>>
>> Was the drive loaded with commands issued via /dev/sgX when you did
>> above operation?
> 
> No.   One note: the kernel error I reported in my first email
> happened in ARM XSCale IOP80321 platform.

I could regenerate an oops while the drive was loaded w/ command from 
sg.  Mine occurs earlier than yours because kmalloc debug is turned on 
(the memory is poisoned on free and the the next access oopses).  It 
seems that sg has refcounting bug.

You can issue all raw commands via high level device node - e.g. 
/dev/sdX or /dev/srX, so you don't really need to use sg devices in many 
cases.

Other than sg related, I couldn't find any problem with hot/warm/pervert 
plugging.  Can you please try without any sg use?  If you need loaded 
test, just load them with regular IO or use /dev/sdX to issue raw 
commands.  I'm not sure I'll track down the sg problem.

-- 
tejun

^ permalink raw reply	[flat|nested] 14+ messages in thread

* Re: PATA Sil680 Warm Plug Caused 2.6.18-rc2 Kernel Internel Error
  2006-08-23 16:06 PATA Sil680 Warm Plug Caused 2.6.18-rc2 Kernel Internel Error Fajun Chen
  2006-08-23 16:24 ` Tejun Heo
@ 2006-08-23 16:24 ` Jeff Garzik
  1 sibling, 0 replies; 14+ messages in thread
From: Jeff Garzik @ 2006-08-23 16:24 UTC (permalink / raw)
  To: Fajun Chen; +Cc: linux-ide, alan, Tejun Heo

Fajun Chen wrote:
> ata2.00: qc timeout (cmd 0xec)
> ata2.00: failed to IDENTIFY (I/O error, err_mask=0x4)
> ata2.00: revalidation failed (errno=-5)
> ata2.00: disabled
> ata2: EH complete
> ata2: soft resetting port
> ata2.00: ATA-7, max UDMA/100, 625142448 sectors: LBA48
> ata2.00: configured for UDMA/100
> ata2: EH complete
> Unable to handle kernel paging request at virtual address 6f020091
> pgd = c0004000
> [6f020091] *pgd=00000000
> Internal error: Oops: f3 [#1]
> Modules linked in:
> CPU: 0
> PC is at scsi_device_get+0x40/0x98
> LR is at kobject_get+0x18/0x20
> pc : [<c00f6728>]    lr : [<c00c8274>]    Not tainted
> sp : c0b5ff10  ip : c0b5feec  fp : c0b5ff24
> r10: c0b68298  r9 : 00000000  r8 : 60000013
> r7 : c0b68298  r6 : 00000000  r5 : c0bba090  r4 : c0bba000
> r3 : 6f020045  r2 : fffffffa  r1 : c0197340  r0 : c0bba090
> Flags: NzCv  IRQs off  FIQs on  Mode SVC_32  Segment kernel
> Control: 397F  Table: 02EB8000  DAC: 00000017
> Process ata_aux (pid: 13, stack limit = 0xc0b5e250)
> Stack: (0xc0b5ff10 to 0xc0b60000)
> ff00:                                     c0bba000 c0b68424 c0b5ff50 
> c0b5ff28
> ff20: c0112d28 c00f66f4 c0b50b20 20000013 c0112c98 c0b50b28 00000001 
> 00000000
> ff40: fffffffc c0b5ff70 c0b5ff54 c0047e4c c0112ca4 c0b50b30 c0b50b28 
> c0b5ff90
> ff60: c0b50b20 c0b5ffc0 c0b5ff74 c0047fb4 c0047da4 ffffffff ffffffff 
> 00000001
> ff80: 00000000 c003406c 00010000 00000000 00000000 c0b5b940 c003406c 
> 00100100
> ffa0: 00200200 c0b50b20 c0b5e000 c0befefc c0047ea0 c0b5fff4 c0b5ffc4 
> c004b670
> ffc0: c0047eac 00000001 ffffffff ffffffff 00000000 00000000 00000000 
> 00000000
> ffe0: 00000000 00000000 00000000 c0b5fff8 c0039d24 c004b590 906f8a57 
> c8a970b5
> Backtrace:
> [<c00f66e8>] (scsi_device_get+0x0/0x98) from [<c0112d28>]
> (ata_scsi_hotplug+0x90/0x188)
> r5 = C0B68424  r4 = C0BBA000
> [<c0112c98>] (ata_scsi_hotplug+0x0/0x188) from [<c0047e4c>]
> (run_workqueue+0xb4/0x108)
> [<c0047d98>] (run_workqueue+0x0/0x108) from [<c0047fb4>]
> (worker_thread+0x114/0x16c)
> r7 = C0B50B20  r6 = C0B5FF90  r5 = C0B50B28  r4 = C0B50B30
> [<c0047ea0>] (worker_thread+0x0/0x16c) from [<c004b670>] 
> (kthread+0xec/0x11c)


That's interesting.  Looks like a scsidev refcounting problem...

	Jeff


^ permalink raw reply	[flat|nested] 14+ messages in thread

end of thread, other threads:[~2006-08-25 20:32 UTC | newest]

Thread overview: 14+ messages (download: mbox.gz follow: Atom feed
-- links below jump to the message on this page --
2006-08-23 16:06 PATA Sil680 Warm Plug Caused 2.6.18-rc2 Kernel Internel Error Fajun Chen
2006-08-23 16:24 ` Tejun Heo
2006-08-23 19:12   ` Fajun Chen
2006-08-23 19:24     ` Tejun Heo
2006-08-23 19:55       ` Fajun Chen
     [not found]         ` <8202f4270608231349v5aabace2xaff8fe93c133a7ca@mail.gmail.com>
     [not found]           ` <20060824070257.GD21866@htj.dyndns.org>
     [not found]             ` <8202f4270608240942i6b620961t1a03d4148dd4a32d@mail.gmail.com>
2006-08-24 17:02               ` Tejun Heo
2006-08-25  0:01                 ` Fajun Chen
2006-08-25 15:26                   ` Fajun Chen
2006-08-25 15:35                     ` Tejun Heo
2006-08-25 17:27                       ` Fajun Chen
2006-08-25 18:00                         ` Tejun Heo
2006-08-25 20:19                           ` Fajun Chen
2006-08-25 20:32                             ` Tejun Heo
2006-08-23 16:24 ` Jeff Garzik

This is a public inbox, see mirroring instructions
for how to clone and mirror all data and code used for this inbox;
as well as URLs for NNTP newsgroup(s).