On Sunday 30 of August 2009, Alan Stern wrote: > On Sun, 30 Aug 2009, Arkadiusz Miskiewicz wrote: > > > Can you provide the dmesg log showing what happens during bootup with > > > the patch applied? > > > > Hm, can console= point to netconsole somehow, so userspace messages could > > be seen via netconsole? Anyway from netconsole: > > > > Aug 30 01:07:16 rhea 13.144139] netconsole: network logging started > > Aug 30 01:07:16 rhea 13.173297] SCSI subsystem initialized > > Aug 30 01:07:16 rhea 13.189630] megaraid cmm: 2.20.2.7 (Release Date: > > Sun Jul 16 00:01:03 EST 2006) Aug 30 01:07:16 rhea 13.216688] megaraid: > > 2.20.5.1 (Release Date: Thu Nov 16 15:32:35 EST 2006) Aug 30 01:07:16 > > rhea 13.238942] megaraid: probe new device 0x1000:0x0407:0x1000:0x0530: > > Aug 30 01:07:16 rhea bus: 2:slot 3:func 0 > > Aug 30 01:07:16 rhea 13.271180] megaraid 0000:02:03.0: PCI INT A -> GSI > > 27 (level, low) -> IRQ 27 Aug 30 01:07:16 rhea 13.316707] megaraid: fw > > version:[414G] bios version:[A100] Aug 30 01:07:16 rhea 13.334528] > > scsi0 : LSI Logic MegaRAID driver Aug 30 01:07:16 rhea 13.352156] > > scsi[0]: scanning scsi channel 0 [Phy 0] Aug 30 01:07:16 rhea for: > > non-raid devices > > Aug 30 01:07:16 rhea 13.381065] Driver 'sd' needs updating - please use > > bus_type methods Aug 30 01:07:16 rhea 13.420430] SGI XFS with ACLs, > > security attributes, large block/inode numbers, no debug enabled Aug 30 > > 01:07:16 rhea 13.453259] SGI XFS Quota Management subsystem Aug 30 > > 01:07:16 rhea 13.583779] VFS: Cannot open root device "802" or > > unknown-block(8,2) Aug 30 01:07:16 rhea 13.602814] Please append a > > correct "root=" boot option; here are the available partitions: Aug 30 > > 01:07:16 rhea 13.627824] Kernel panic - not syncing: VFS: Unable to > > mount root fs on unknown-block(8,2) Aug 30 01:07:16 rhea 13.652637] > > Pid: 1, comm: swapper Not tainted 2.6.30.5-vs2.3.0.36.14-pre7-0.3 #4 Aug > > 30 01:07:16 rhea 13.674797] Call Trace: > > Aug 30 01:07:16 rhea 13.682138] [<ffffffff8056e75d>] ? > > panic+0x7a/0x12e Aug 30 01:07:16 rhea 13.697003] [<ffffffff8056e851>] > > ? printk+0x40/0x47 Aug 30 01:07:16 rhea 13.711890] > > [<ffffffff8072e090>] ? mount_block_root+0x1d6/0x271 Aug 30 01:07:16 rhea > > 13.729892] [<ffffffff8072ecdb>] ? initrd_load+0x228/0x324 Aug 30 > > 01:07:16 rhea 13.746585] [<ffffffff8072e24f>] ? > > prepare_namespace+0xd5/0x18d Aug 30 01:07:16 rhea 13.764578] > > [<ffffffff8072d6cf>] ? kernel_init+0x178/0x188 Aug 30 01:07:16 rhea > > 13.781282] [<ffffffff8020ceba>] ? child_rip+0xa/0x20 Aug 30 01:07:16 > > rhea 13.796686] [<ffffffff8072d557>] ? kernel_init+0x0/0x188 Aug 30 > > 01:07:16 rhea 13.812858] [<ffffffff8020ceb0>] ? child_rip+0x0/0x20 Aug > > 30 01:07:16 rhea 13.828253] Rebooting in 60 seconds > > > > ... > > > > and of course adding sleep 10 after scsi_wait_scan fixes boot > > Not especially helpful, I'm afraid. If you could add some extra printk > statements, it would be better. For example, you might add some > KERN_INFO messages to sd.c at the start of sd_probe(), just before the > async_schedule() call near the end, and at the start of > sd_probe_async(). In addition, some messages demarking the various > steps of wait_scan_init() in scsi_wait_scan.c would be good. Aug 30 10:05:41 rhea 13.342770] netconsole: network logging started Aug 30 10:05:41 rhea 13.372165] SCSI subsystem initialized Aug 30 10:05:41 rhea 13.386641] megaraid cmm: 2.20.2.7 (Release Date: Sun Jul 16 00:01:03 EST 2006) Aug 30 10:05:41 rhea 13.414015] megaraid: 2.20.5.1 (Release Date: Thu Nov 16 15:32:35 EST 2006) Aug 30 10:05:41 rhea 13.436123] megaraid: probe new device 0x1000:0x0407:0x1000:0x0530: Aug 30 10:05:41 rhea bus: 2:slot 3:func 0 Aug 30 10:05:41 rhea 13.468399] megaraid 0000:02:03.0: PCI INT A -> GSI 27 (level, low) -> IRQ 27 Aug 30 10:05:41 rhea 13.516699] megaraid: fw version:[414G] bios version:[A100] Aug 30 10:05:41 rhea 13.535997] scsi0 : LSI Logic MegaRAID driver Aug 30 10:05:41 rhea 13.553565] scsi[0]: scanning scsi channel 0 [Phy 0] Aug 30 10:05:41 rhea for: non-raid devices Aug 30 10:05:41 rhea 13.586494] Driver 'sd' needs updating - please use bus_type methods Aug 30 10:05:41 rhea 13.607265] wait_scan_init: BEFORE wait_for_device_probe Aug 30 10:05:41 rhea 13.625998] wait_scan_init: AFTER wait_for_device_probe Aug 30 10:05:41 rhea 13.645813] wait_scan_init: BEFORE scsi_complete_async_scans Aug 30 10:05:41 rhea 13.666926] wait_scan_init: AFTER scsi_complete_async_scans Aug 30 10:05:41 rhea 13.687750] wait_scan_init: BEFORE async_synchronize_full Aug 30 10:05:41 rhea 13.708100] wait_scan_init: AFTER wait_for_device_probe Aug 30 10:05:42 rhea 13.973100] SGI XFS with ACLs, security attributes, large block/inode numbers, no debug enabled Aug 30 10:05:42 rhea 14.005223] SGI XFS Quota Management subsystem Aug 30 10:05:42 rhea 14.093763] VFS: Cannot open root device "802" or unknown-block(8,2) Aug 30 10:05:42 rhea 14.112812] Please append a correct "root=" boot option; here are the available partitions: Aug 30 10:05:42 rhea 14.137870] Kernel panic - not syncing: VFS: Unable to mount root fs on unknown-block(8,2) Aug 30 10:05:42 rhea 14.140707] scsi 0:0:6:0: Processor ESG-SHV SCA HSBP M29 1.08 PQ: 0 ANSI: 2 Aug 30 10:05:42 rhea 14.186854] Pid: 1, comm: swapper Not tainted 2.6.30.5-vs2.3.0.36.14-pre7-0.3 #4 Aug 30 10:05:42 rhea 14.209012] Call Trace: Aug 30 10:05:42 rhea 14.216352] [<ffffffff8056e75d>] ? panic+0x7a/0x12e Aug 30 10:05:42 rhea 14.231214] [<ffffffff8056e851>] ? printk+0x40/0x47 Aug 30 10:05:42 rhea 14.246097] [<ffffffff8072e090>] ? mount_block_root+0x1d6/0x271 Aug 30 10:05:42 rhea 14.264099] [<ffffffff8072ecdb>] ? initrd_load+0x228/0x324 Aug 30 10:05:42 rhea 14.280790] [<ffffffff8072e24f>] ? prepare_namespace+0xd5/0x18d Aug 30 10:05:42 rhea 14.298777] [<ffffffff8072d6cf>] ? kernel_init+0x178/0x188 Aug 30 10:05:42 rhea 14.315481] [<ffffffff8020ceba>] ? child_rip+0xa/0x20 Aug 30 10:05:42 rhea 14.330885] [<ffffffff8072d557>] ? kernel_init+0x0/0x188 Aug 30 10:05:42 rhea 14.347077] [<ffffffff8020ceb0>] ? child_rip+0x0/0x20 Aug 30 10:05:42 rhea 14.362470] Rebooting in 60 seconds.. > > Let's see what these messages produce both with and without the "sleep > 10" in your initrd. with sleep Aug 30 11:11:52 rhea kernel: [ 6.950127] console [netcon0] enabled Aug 30 11:11:52 rhea kernel: [ 13.116253] netconsole: network logging started Aug 30 11:11:52 rhea kernel: [ 13.145344] SCSI subsystem initialized Aug 30 11:11:52 rhea kernel: [ 13.160103] megaraid cmm: 2.20.2.7 (Release Date: Sun Jul 16 00:01:03 EST 2006) Aug 30 11:11:52 rhea kernel: [ 13.187529] megaraid: 2.20.5.1 (Release Date: Thu Nov 16 15:32:35 EST 2006) Aug 30 11:11:52 rhea kernel: [ 13.209685] megaraid: probe new device 0x1000:0x0407:0x1000:0x0530: bus 2:slot 3:func 0 Aug 30 11:11:52 rhea kernel: [ 13.241872] alloc irq_desc for 27 on cpu 0 node 0 Aug 30 11:11:52 rhea kernel: [ 13.241876] alloc kstat_irqs on cpu 0 node 0 Aug 30 11:11:52 rhea kernel: [ 13.241885] megaraid 0000:02:03.0: PCI INT A -> GSI 27 (level, low) -> IRQ 27 Aug 30 11:11:52 rhea kernel: [ 13.286708] megaraid: fw version:[414G] bios version:[A100] Aug 30 11:11:52 rhea kernel: [ 13.305284] scsi0 : LSI Logic MegaRAID driver Aug 30 11:11:52 rhea kernel: [ 13.322942] scsi[0]: scanning scsi channel 0 [Phy 0] for non-raid devices Aug 30 11:11:52 rhea kernel: [ 13.355882] Driver 'sd' needs updating - please use bus_type methods Aug 30 11:11:52 rhea kernel: [ 13.379162] wait_scan_init: BEFORE wait_for_device_probe Aug 30 11:11:52 rhea kernel: [ 13.397928] wait_scan_init: AFTER wait_for_device_probe Aug 30 11:11:52 rhea kernel: [ 13.417739] wait_scan_init: BEFORE scsi_complete_async_scans Aug 30 11:11:52 rhea kernel: [ 13.438822] wait_scan_init: AFTER scsi_complete_async_scans Aug 30 11:11:52 rhea kernel: [ 13.459688] wait_scan_init: BEFORE async_synchronize_full Aug 30 11:11:52 rhea kernel: [ 13.479998] wait_scan_init: AFTER wait_for_device_probe Aug 30 11:11:52 rhea kernel: [ 13.902193] scsi 0:0:6:0: Processor ESG-SHV SCA HSBP M29 1.08 PQ: 0 ANSI: 2 Aug 30 11:11:52 rhea kernel: [ 15.930664] scsi[0]: scanning scsi channel 1 [Phy 1] for non-raid devices Aug 30 11:11:52 rhea kernel: [ 19.706530] scsi[0]: scanning scsi channel 2 [virtual] for logical drives Aug 30 11:11:52 rhea kernel: [ 19.727104] scsi 0:2:0:0: Direct-Access MegaRAID LD 0 RAID5 280G 414G PQ: 0 ANSI: 2 Aug 30 11:11:52 rhea kernel: [ 19.757564] sd_probe: BEFORE async_schedule Aug 30 11:11:52 rhea kernel: [ 19.770091] sd_probe: AFTER async_schedule Aug 30 11:11:52 rhea kernel: [ 19.782507] sd_probe_async: ENTERED Aug 30 11:11:52 rhea kernel: [ 19.793223] sd 0:2:0:0: [sda] 574218240 512-byte hardware sectors: (293 GB/273 GiB) Aug 30 11:11:52 rhea kernel: [ 19.816173] sd 0:2:0:0: [sda] Write Protect is off Aug 30 11:11:52 rhea kernel: [ 19.830525] sd 0:2:0:0: [sda] Mode Sense: 00 00 00 00 Aug 30 11:11:52 rhea kernel: [ 19.830549] sd 0:2:0:0: [sda] Asking for cache data failed Aug 30 11:11:52 rhea kernel: [ 19.846978] sd 0:2:0:0: [sda] Assuming drive cache: write through Aug 30 11:11:52 rhea kernel: [ 19.865496] sd 0:2:0:0: [sda] Asking for cache data failed Aug 30 11:11:52 rhea kernel: [ 19.881920] sd 0:2:0:0: [sda] Assuming drive cache: write through Aug 30 11:11:52 rhea kernel: [ 19.900198] sda: sda1 sda2 sda3 Aug 30 11:11:52 rhea kernel: [ 19.924019] sd 0:2:0:0: [sda] Attached SCSI disk Aug 30 11:11:52 rhea kernel: [ 23.113336] eth0: no IPv6 routers present Aug 30 11:11:52 rhea kernel: [ 23.754010] SGI XFS with ACLs, security attributes, large block/inode numbers, no debug enabled Aug 30 11:11:52 rhea kernel: [ 23.786463] SGI XFS Quota Management subsystem Aug 30 11:11:52 rhea kernel: [ 23.915852] XFS mounting filesystem sda2 Aug 30 11:11:52 rhea kernel: [ 24.050956] Ending clean XFS mount for filesystem: sda2 Aug 30 11:11:52 rhea kernel: [ 24.051050] VFS: Mounted root (xfs filesystem) readonly on device 8:2. > > Alan Stern -- Arkadiusz Miśkiewicz PLD/Linux Team arekm / maven.pl http://ftp.pld-linux.org/ -- To unsubscribe from this list: send the line "unsubscribe linux-scsi" in the body of a message to majordomo@xxxxxxxxxxxxxxx More majordomo info at http://vger.kernel.org/majordomo-info.html