Re: scsi_wait_scan not working (2.6.30.5)

[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index]

 



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

[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index]
[Index of Archives]     [SCSI Target Devel]     [Linux SCSI Target Infrastructure]     [Kernel Newbies]     [IDE]     [Security]     [Git]     [Netfilter]     [Bugtraq]     [Yosemite News]     [MIPS Linux]     [ARM Linux]     [Linux Security]     [Linux RAID]     [Linux ATA RAID]     [Linux IIO]     [Samba]     [Device Mapper]
  Powered by Linux