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

Bug#539406: marked as done (linux-image-2.6.30-1-alpha-smp: fails to load fw for 1st scsi adapter)



Your message dated Sun, 21 Mar 2010 22:13:51 +0100
with message-id <20100321211351.GA2910@galadriel.inutil.org>
and subject line Re: Bug#539406: linux-image-2.6.30-1-alpha-smp: fails to load fw for 1st scsi adapter
has caused the Debian Bug report #539406,
regarding linux-image-2.6.30-1-alpha-smp: fails to load fw for 1st scsi adapter
to be marked as done.

This means that you claim that the problem has been dealt with.
If this is not the case it is now your responsibility to reopen the
Bug report if necessary, and/or fix the problem forthwith.

(NB: If you are a system administrator and have no idea what this
message is talking about, this may indicate a serious mail system
misconfiguration somewhere. Please contact owner@bugs.debian.org
immediately.)


-- 
539406: http://bugs.debian.org/cgi-bin/bugreport.cgi?bug=539406
Debian Bug Tracking System
Contact owner@bugs.debian.org with problems
--- Begin Message ---
Package: linux-image-2.6.30-1-alpha-smp
Version: 2.6.30-2
Severity: important

Well, the firmware loading logic has been flaky on my system for a few 
releases now. I previously reported bug 527265 against 2.6.29, where the 
qla1040 firmware would not load at all, and that was resolved in a later 
2.6.29 image.

In this release (2.6.30-2) I get new/different bad behavior. My system 
has three QLA1040 cards in it. In the attached console output from the boot, 
notice that at time 23.256824, the first adapter (scsi0) is located, 
generates a stack trace trying to load firmware, and fails to initialize 
the card. (There goes my tape drive!) A little later, at 83.499957, the 
second adapter is found and this time the firmware loads fine. Ditto for 
the third adapter after that.

-- Package-specific info:

-- System Information:
Debian Release: 5.0.2
Architecture: alpha

Kernel: Linux 2.6.29-2-alpha-smp (SMP w/1 CPU core)
Locale: LANG=C, LC_CTYPE=C (charmap=ANSI_X3.4-1968)
Shell: /bin/sh linked to /bin/bash

Versions of packages linux-image-2.6.30-1-alpha-smp depends on:
ii  debconf [debconf-2.0]         1.5.24     Debian configuration management sy
ii  initramfs-tools [linux-initra 0.92o      tools for generating an initramfs
ii  module-init-tools             3.4-1      tools for managing Linux kernel mo

linux-image-2.6.30-1-alpha-smp recommends no packages.

Versions of packages linux-image-2.6.30-1-alpha-smp suggests:
ii  aboot                  1.0~pre20040408-3 Linux bootloader for the SRM conso
ii  fdutils                5.5-20060227-3    Linux floppy utilities
pn  linux-doc-2.6.30       <none>            (no description available)

-- debconf information:
  linux-image-2.6.30-1-alpha-smp/postinst/depmod-error-initrd-2.6.30-1-alpha-smp: false
  linux-image-2.6.30-1-alpha-smp/postinst/create-kimage-link-2.6.30-1-alpha-smp: true
  linux-image-2.6.30-1-alpha-smp/preinst/lilo-initrd-2.6.30-1-alpha-smp: true
  linux-image-2.6.30-1-alpha-smp/preinst/abort-install-2.6.30-1-alpha-smp:
  linux-image-2.6.30-1-alpha-smp/postinst/depmod-error-2.6.30-1-alpha-smp: false
  linux-image-2.6.30-1-alpha-smp/prerm/removing-running-kernel-2.6.30-1-alpha-smp: true
  linux-image-2.6.30-1-alpha-smp/prerm/would-invalidate-boot-loader-2.6.30-1-alpha-smp: true
  linux-image-2.6.30-1-alpha-smp/postinst/bootloader-test-error-2.6.30-1-alpha-smp:
  linux-image-2.6.30-1-alpha-smp/preinst/initrd-2.6.30-1-alpha-smp:
  linux-image-2.6.30-1-alpha-smp/postinst/kimage-is-a-directory:
  shared/kernel-image/really-run-bootloader: true
  linux-image-2.6.30-1-alpha-smp/preinst/lilo-has-ramdisk:
  linux-image-2.6.30-1-alpha-smp/preinst/elilo-initrd-2.6.30-1-alpha-smp: true
  linux-image-2.6.30-1-alpha-smp/preinst/overwriting-modules-2.6.30-1-alpha-smp: true
  linux-image-2.6.30-1-alpha-smp/postinst/bootloader-error-2.6.30-1-alpha-smp:
  linux-image-2.6.30-1-alpha-smp/preinst/abort-overwrite-2.6.30-1-alpha-smp:
  linux-image-2.6.30-1-alpha-smp/preinst/bootloader-initrd-2.6.30-1-alpha-smp: true
  linux-image-2.6.30-1-alpha-smp/postinst/old-initrd-link-2.6.30-1-alpha-smp: true
  linux-image-2.6.30-1-alpha-smp/postinst/old-dir-initrd-link-2.6.30-1-alpha-smp: true
  linux-image-2.6.30-1-alpha-smp/postinst/old-system-map-link-2.6.30-1-alpha-smp: true
  linux-image-2.6.30-1-alpha-smp/preinst/failed-to-move-modules-2.6.30-1-alpha-smp:
 P00>>>boot -fl 1
 Initializing...
  SROM V3.0 on cpu0
  SROM V3.0 on cpu2
  SROM V3.0 on cpu1
 XSROM V6.0 on cpu1
 XSROM V6.0 on cpu2
 XSROM V6.0 on cpu0
 BCache testing complete on cpu1
 BCache testing complete on cpu2
 BCache testing complete on cpu0
 mem_pair0 - 2048 MB 
 mem_pair1 - 1024 MB 
 mem_pair2 - 1024 MB 
 20..20..20..21..21..21..23..
 please wait 80 seconds for T24 to complete
 24..24..24..
 Memory testing complete on cpu0
 Memory testing complete on cpu1
 Memory testing complete on cpu2
 starting console on CPU 0
 sizing memory
   0   2048 MB EDO
   1   1024 MB EDO
   2   1024 MB EDO
 starting console on CPU 1
 starting console on CPU 2
 probing IOD1 hose 1 
   bus 0 slot 1 - NCR 53C810
   bus 0 slot 2 - PCI-PCI Bridge
     probing PCI-PCI Bridge, bus 2
       bus 2 slot 0 - QLogic ISP10X0
   bus 0 slot 3 - DE500-BA
 probing IOD0 hose 0 
   bus 0 slot 1 - PCEB
     probing EISA Bridge, bus 1
   bus 0 slot 3 - DECchip 21140-AA
   bus 0 slot 4 - PCI-PCI Bridge
     probing PCI-PCI Bridge, bus 2
       bus 2 slot 0 - QLogic ISP10X0
   bus 0 slot 5 - PCI-PCI Bridge
     probing PCI-PCI Bridge, bus 3
       bus 3 slot 0 - QLogic ISP10X0
 configuring I/O adapters...
   ncr0, hose 1, bus 0, slot 1
   isp0, hose 1, bus 2, slot 0
   tulip0, hose 1, bus 0, slot 3
   floppy0, hose 0, bus 1, slot 0
   tulip1, hose 0, bus 0, slot 3
   isp1, hose 0, bus 2, slot 0
   isp2, hose 0, bus 3, slot 0
 System temperature is 22 degrees C
 AlphaServer 4100 Console V6.0-4, 10-MAY-2001 10:11:42
 
 CPU 0 booting
 
 (boot dkb0.0.0.2000.1 -flags 1)
 block 0 of dkb0.0.0.2000.1 is a valid boot block
 reading 158 blocks from dkb0.0.0.2000.1
 bootstrap code read in
 Building FRU table
 base = 200000, image_start = 0, image_bytes = 13c00
 initializing HWRPB at 2000
 initializing page table at 1f2000
 initializing machine state
 setting affinity to the primary CPU
 jumping to bootstrap code
 aboot: Linux/Alpha SRM bootloader version 1.0_pre20040408
 aboot: switching to OSF/1 PALcode version 1.23
 aboot: booting from device 'SCSI 1 2000 0 0 0 1011 10201077'
 aboot: valid disklabel found: 4 partitions.
 aboot: loading uncompressed vmlinuz-2.6.30-1-alpha-smp...
 aboot: loading compressed vmlinuz-2.6.30-1-alpha-smp...
 aboot: zero-filling 4604752 bytes at 0xfffffc0001a47880
 aboot: loading initrd (11477856 bytes/11208 blocks) at 0xfffffc013f3ca000
 aboot: starting kernel vmlinuz-2.6.30-1-alpha-smp with arguments  ro root=/dev/vg00/rootvol console=ttyS0
 [    0.000000] Initializing cgroup subsys cpuset
 [    0.000000] Initializing cgroup subsys cpu
 [    0.000000] Linux version 2.6.30-1-alpha-smp (Debian 2.6.30-2) (waldi@debian.org) (gcc version 4.3.3 (Debian 4.3.3-13) ) #1 SMP W
 [    0.000000] Booting GENERIC on Rawhide variation Dodge using machine vector Rawhide from SRM
 [    0.000000] Major Options: SMP MAGIC_SYSRQ 
 [    0.000000] Command line:  ro root=/dev/vg00/rootvol console=ttyS0
 [    0.000000] memcluster 0, usage 1, start        0, end      256
 [    0.000000] memcluster 1, usage 0, start      256, end   393216
 [    0.000000] memcluster 2, usage 0, start   524288, end   655351
 [    0.000000] memcluster 3, usage 1, start   655351, end   655360
 [    0.000000] freeing pages 256:2048
 [    0.000000] freeing pages 3928:393216
 [    0.000000] freeing pages 524288:655351
 [    0.000000] reserving pages 3928:3938
 [    0.000000] Initial ramdisk at: 0xfffffc013f3ca000 (11477856 bytes)
 [    0.000000] 4096K Bcache detected; load hit latency 28 cycles, load miss latency 115 cycles
 [    0.000000] SMP: 3 CPUs probed -- cpu_present_map = 7
 [    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 650871
 [    0.000000] Kernel command line:  ro root=/dev/vg00/rootvol console=ttyS0
 [    0.000000] NR_IRQS:32784
 [    0.000000] mcpcia_init_hoses: found 2 hoses
 [    0.000000] PID hash table entries: 4096 (order: 12, 32768 bytes)
 [    0.000000] HWRPB cycle frequency bogus.  Estimated 466236031 Hz
 [    0.000000] Using epoch = 2000
 [    0.000000] Turning on RTC interrupts.
 [    0.001953] Console: colour dummy device 80x25
 [    0.001953] console [ttyS0] enabled
 [    1.812499] Dentry cache hash table entries: 1048576 (order: 10, 8388608 bytes)
 [    1.966795] Inode-cache hash table entries: 524288 (order: 9, 4194304 bytes)
 [    2.568358] Memory: 4114816k/5242808k available (2699k kernel code, 76704k reserved, 263k data, 344k init)
 [    2.683592] Calibrating delay loop... 791.12 BogoMIPS (lpj=386048)
 [    2.778318] Security Framework initialized
 [    2.828123] Mount-cache hash table entries: 512
 [    2.882811] Initializing cgroup subsys ns
 [    2.931639] Initializing cgroup subsys cpuacct
 [    2.984373] Initializing cgroup subsys devices
 [    3.038084] Initializing cgroup subsys freezer
 [    3.090818] Initializing cgroup subsys net_cls
 [    3.144529] SMP starting up secondaries.
 [    3.200193] Calibrating delay loop... 793.68 BogoMIPS (lpj=387072)
 [    3.300779] Calibrating delay loop... 795.24 BogoMIPS (lpj=388096)
 [    3.392576] Brought up 3 CPUs
 [    3.428709] SMP: Total of 3 processors activated (2384.29 BogoMIPS).
 [    3.520506] net_namespace: 1936 bytes
 [    3.566404] regulator: core version 0.5
 [    3.613279] NET: Registered protocol family 16
 [    3.669919] EISA bus registered
 [    3.710935] pci: enabling save/restore of SRM state
 [    3.779294] pci 0000:00:04.0: PCI bridge, secondary bus 0000:01
 [    3.849607] pci 0000:00:04.0:   IO window: 0x8000-0x8fff
 [    3.913083] pci 0000:00:04.0:   MEM window: 0x2200000-0x22fffff
 [    3.984372] pci 0000:00:04.0:   PREFETCH window: disabled
 [    4.048826] pci 0000:00:05.0: PCI bridge, secondary bus 0000:02
 [    4.120115] pci 0000:00:05.0:   IO window: 0x9000-0x9fff
 [    4.183591] pci 0000:00:05.0:   MEM window: 0x2300000-0x23fffff
 [    4.254880] pci 0000:00:05.0:   PREFETCH window: disabled
 [    4.319333] pci 0001:03:02.0: PCI bridge, secondary bus 0001:04
 [    4.390622] pci 0001:03:02.0:   IO window: 0x8000-0x8fff
 [    4.454099] pci 0001:03:02.0:   MEM window: 0x2200000-0x22fffff
 [    4.525388] pci 0001:03:02.0:   PREFETCH window: disabled
 [    4.603513] bio: create slab <bio-0> at 0
 [    4.657224] SCSI subsystem initialized
 [    4.712888] NET: Registered protocol family 2
 [    4.774411] IP route cache hash table entries: 262144 (order: 8, 2097152 bytes)
 [    4.874997] TCP established hash table entries: 524288 (order: 10, 8388608 bytes)
 [    5.006833] TCP bind hash table entries: 65536 (order: 7, 1048576 bytes)
 [    5.092770] TCP: Hash tables configured (established 524288 bind 65536)
 [    5.172848] TCP reno registered
 [    5.213864] NET: Registered protocol family 1
 [    5.266598] Trying to unpack rootfs image as initramfs...
 [    7.972652] Freeing initrd memory: 11208k freed
 [    8.033199] VFS: Disk quotas dquot_6.5.2
 [    8.081050] Dquot-cache hash table entries: 1024 (order 0, 8192 bytes)
 [    8.159175] msgmni has been set to 8059
 [    8.208003] alg: No test for stdrng (krng)
 [    8.256831] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 253)
 [    8.345698] io scheduler noop registered
 [    8.392573] io scheduler anticipatory registered
 [    8.448237] io scheduler deadline registered
 [    8.499019] io scheduler cfq registered (default)
 [    8.555659] isapnp: Scanning for PnP cards...
 [    8.912104] isapnp: No Plug & Play device found
 [    8.995112] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
 [    9.070307] serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
 [    9.142573] serial8250: ttyS1 at I/O 0x2f8 (irq = 3) is a 16550A
 [    9.232417] brd: module loaded
 [    9.276362] serio: i8042 KBD port at 0x60,0x64 irq 1
 [    9.335932] serio: i8042 AUX port at 0x60,0x64 irq 12
 [    9.397456] mice: PS/2 mouse device common for all mice
 [    9.460932] EISA: Probing bus 0 at 0000:00:01.0
 [    9.515620] atkbd.c: keyboard reset failed on isa0060/serio0
 [    9.515620] EISA: Mainboard DEC6400 detected.
 [    9.634760] Cannot allocate resource for EISA slot 8
 [    9.695307] EISA: Detected 0 cards.
 [    9.741205] TCP cubic registered
 [    9.779291] atkbd.c: keyboard reset failed on isa0060/serio1
 [    9.779291] NET: Registered protocol family 17
 [    9.901362] registered taskstats version 1
 [    9.952143] /build/buildd-linux-2.6_2.6.30-2-alpha-q6OEGR/linux-2.6-2.6.30/debian/build/source_alpha_none/drivers/rtc/hctosys.c: 
 [   10.124994] Freeing unused kernel memory: 344k freed
 Loading, please wait...
 Begin: Loading essential drivers ... done.
 Begin: Running /scripts/init-premount ... [   21.619129] Linux Tulip driver version 1.1.15-NAPI (Feb 27, 2007)
 [   21.698231] tulip0:  EEPROM default media type Autosense.
 [   21.762684] tulip0:  Index #0 - Media MII (#11) described by a 21140 MII PHY (1) block.
 [   21.863270] tulip0:  MII transceiver #5 config 2100 status 780f advertising 01e1.
 [   21.959949] eth0: Digital DS21140 Tulip rev 32 at Port 0xa000, 00:00:f8:05:1f:4a, IRQ 20.
 [   22.064441] tulip1:  EEPROM default media type Autosense.
 [   22.128894] tulip1:  Index #0 - Media 10baseT (#0) described by a 21142 Serial PHY (2) block.
 [   22.230457] tulip1:  Index #1 - Media 10baseT-FDX (#4) described by a 21142 Serial PHY (2) block.
 [   22.337879] tulip1:  Index #2 - Media 100baseTx (#3) described by a 21143 SYM PHY (4) block.
 [   22.438465] tulip1:  Index #3 - Media 100baseTx-FDX (#5) described by a 21143 SYM PHY (4) block.
 [   22.551746] eth1: Digital DS21142/43 Tulip rev 48 at Port 0x200009400, 08:00:2b:c4:5c:d1, IRQ 44.
 [   23.256824] qla1280: QLA1040 found on PCI bus 1, dev 0
 [   23.319323] qla1280 0000:01:00.0: firmware: requesting qlogic/1040.bin
 [   23.319323] ------------[ cut here ]------------
 [   23.319323] WARNING: at /build/buildd-linux-2.6_2.6.30-2-alpha-q6OEGR/linux-2.6-2.6.30/debian/build/source_alpha_none/kernel/soft
 [   23.319323] Modules linked in: qla1280(+) tulip bitrev crc32
 [   23.319323] fffffc013b4ff9f8 0000000000000005 fffffc0001046584 fffffc013b4adcc0 
 [   23.319323]        0000000000000000 fffffc013b499800 fffffc013b4adcc0 ffffffff00000010 
 [   23.319323]        fffffc0001221588 0000000000000001 fffffc00012366bc fffffc013b499800 
 [   23.319323]        fffffc013b499818 fffffc013b4adcc0 fffffc000116a6b4 fffffc013b43d030 
 [   23.319323]        0000000000000007 fffffc013b4adcc0 fffffc013b43d000 fffffc013e828340 
 [   23.319323]        fffffc0001a1f798 fffffc0001322643 0000000000000001 0000000000000000 
 [   23.319323] Trace:
 [   23.319323] [<fffffc0001046584>] _local_bh_enable_ip+0x4c/0xb8
 [   23.319323] [<fffffc0001221588>] sk_filter+0xd0/0x108
 [   23.319323] [<fffffc00012366bc>] netlink_broadcast+0x208/0x3ec
 [   23.319323] [<fffffc000116a6b4>] kobject_uevent_env+0x3a0/0x4bc
 [   23.319323] [<fffffc00011d66b8>] _request_firmware+0x468/0x57c
 [   23.319323] [<fffffc00011d66a0>] _request_firmware+0x450/0x57c
 [   23.319323] [<fffffc0001184224>] local_pci_probe+0x24/0x38
 [   23.319323] [<fffffc0001184570>] pci_device_probe+0x64/0xa0
 [   23.319323] [<fffffc00011d09bc>] driver_probe_device+0xcc/0x1e0
 [   23.319323] [<fffffc00011d0b58>] __driver_attach+0x88/0xd4
 [   23.319323] [<fffffc00011cff2c>] bus_for_each_dev+0x68/0xd0
 [   23.319323] [<fffffc00011d0ad0>] __driver_attach+0x0/0xd4
 [   23.319323] [<fffffc00011d0774>] driver_attach+0x2c/0x40
 [   23.319323] [<fffffc00011cf480>] bus_add_driver+0xd8/0x300
 [   23.319323] [<fffffc00011d1010>] driver_register+0x108/0x1d0
 [   23.319323] [<fffffc0001184aac>] __pci_register_driver+0x60/0x124
 [   23.319323] [<fffffc00010100e8>] do_one_initcall+0x74/0x1cc
 [   23.319323] [<fffffc000106ed88>] SyS_init_module+0xf0/0x2b0
 [   23.319323] [<fffffc000106ed70>] SyS_init_module+0xd8/0x2b0
 [   23.319323] [<fffffc0001010e24>] entSys+0xa4/0xc0
 [   23.319323] 
 [   23.319323] ---[ end trace 9aadef308c73a9f0 ]---
 [   26.039049] sym0: <810> rev 0x2 at pci 0001:03:01.0 irq 56
 [   26.107408] sym0: No NVRAM, ID 7, Fast-10, SE, parity checking
 [   26.176744] sym0: SCSI BUS has been reset.
 [   26.231431] scsi1 : sym-2.2.3
 [   30.645492] scsi 1:0:5:0: CD-ROM            DEC      RRD46   (C) DEC  0557 PQ: 0 ANSI: 2
 [   30.743148] scsi target1:0:5: Beginning Domain Validation
 [   30.810531] scsi target1:0:5: FAST-10 SCSI 10.0 MB/s ST (100 ns, offset 8)
 [   30.895491] scsi target1:0:5: Domain Validation skipping write tests
 [   30.971663] scsi target1:0:5: Ending Domain Validation
 [   83.320269] Failed to load image "qlogic/1040.bin" err -2
 [   83.384722] scsi(0): initialize: pci probe failed!
 [   83.442340] qla1x160: Failed to initialize adapter
 [   83.499957] qla1280: QLA1040 found on PCI bus 2, dev 0
 [   83.561480] qla1280 0000:02:00.0: firmware: requesting qlogic/1040.bin
 [  107.645452] Driver 'sr' needs updating - please use bus_type methods
 [  107.727483] sr0: scsi-1 drive
 [  107.763616] Uniform CD-ROM driver Revision: 3.20
 [  108.659124] sr 1:0:5:0: Attached scsi generic sg0 type 5
 [  109.597600] scsi(2:0): Resetting SCSI BUS
 [  112.658145] scsi2 : QLogic QLA1040 PCI to SCSI Host Adapter
 [  112.658145]        Firmware version:  7.65.06, Driver version 3.26
 [  112.799746] qla1280: QLA1040 found on PCI bus 4, dev 0
 [  112.805606] scsi 2:0:0:0: Direct-Access     DEC      RZ2DD-LS (C) DEC 0306 PQ: 0 ANSI: 2
 [  112.807559] scsi(2:0:0:0): Sync: period 10, offset 12, Wide, Tagged queuing: depth 31
 [  112.809512] scsi 2:0:1:0: Direct-Access     COMPAQ   BD009122C6       B016 PQ: 0 ANSI: 2
 [  112.811465] scsi(2:0:1:0): Sync: period 10, offset 12, Wide, Tagged queuing: depth 31
 [  112.814395] scsi 2:0:2:0: Direct-Access     COMPAQ   BD009122C6       B016 PQ: 0 ANSI: 2
 [  112.815371] scsi(2:0:2:0): Sync: period 10, offset 12, Wide, Tagged queuing: depth 31
 [  112.823184] scsi 2:0:3:0: Direct-Access     DEC      RZ2DD-LS (C) DEC 0306 PQ: 0 ANSI: 2
 [  112.824160] scsi(2:0:3:0): Sync: period 10, offset 12, Wide, Tagged queuing: depth 31
 [  112.830996] scsi 2:0:4:0: Direct-Access     DEC      RZ2DD-LS (C) DEC 0306 PQ: 0 ANSI: 2
 [  112.832950] scsi(2:0:4:0): Sync: period 10, offset 12, Wide, Tagged queuing: depth 31
 [  112.840762] scsi 2:0:5:0: Direct-Access     DEC      RZ2DD-LS (C) DEC 0306 PQ: 0 ANSI: 2
 [  112.841739] scsi(2:0:5:0): Sync: period 10, offset 12, Wide, Tagged queuing: depth 31
 [  114.005801] qla1280 0001:04:00.0: firmware: requesting qlogic/1040.bin
 [  115.141542] scsi 2:0:0:0: Attached scsi generic sg1 type 0
 [  115.215761] scsi 2:0:1:0: Attached scsi generic sg2 type 0
 [  115.289980] scsi 2:0:2:0: Attached scsi generic sg3 type 0
 [  115.365175] scsi 2:0:3:0: Attached scsi generic sg4 type 0
 [  115.441347] scsi 2:0:4:0: Attached scsi generic sg5 type 0
 [  115.508729] scsi 2:0:5:0: Attached scsi generic sg6 type 0
 [  116.273377] scsi(3:0): Resetting SCSI BUS
 [  119.327087] scsi3 : QLogic QLA1040 PCI to SCSI Host Adapter
 [  119.327087]        Firmware version:  7.65.06, Driver version 3.26
 [  119.469665] scsi 3:0:0:0: Direct-Access     COMPAQ   BD009122BA       3B07 PQ: 0 ANSI: 2
 [  119.567321] scsi(3:0:0:0): Sync: period 10, offset 12, Wide, Tagged queuing: depth 31
 [  119.664977] scsi 3:0:1:0: Direct-Access     COMPAQ   BD009122C6       B016 PQ: 0 ANSI: 2
 [  119.763610] scsi(3:0:1:0): Sync: period 10, offset 12, Wide, Tagged queuing: depth 31
 [  119.861266] scsi 3:0:2:0: Direct-Access     COMPAQ   BD009122C6       B016 PQ: 0 ANSI: 2
 [  119.957946] scsi(3:0:2:0): Sync: period 10, offset 12, Wide, Tagged queuing: depth 31
 [  120.055602] scsi 3:0:3:0: Direct-Access     COMPAQ   BD009122C6       B016 PQ: 0 ANSI: 2
 [  120.154235] scsi(3:0:3:0): Sync: period 10, offset 12, Wide, Tagged queuing: depth 31
 [  120.250914] scsi 3:0:4:0: Direct-Access     COMPAQ   BD009122C6       B016 PQ: 0 ANSI: 2
 [  120.349547] scsi(3:0:4:0): Sync: period 10, offset 12, Wide, Tagged queuing: depth 31
 [  120.446227] scsi 3:0:5:0: Direct-Access     COMPAQ   BD009122C6       B016 PQ: 0 ANSI: 2
 [  120.545836] scsi(3:0:5:0): Sync: period 10, offset 12, Wide, Tagged queuing: depth 31
 [  122.260679] Driver 'sd' needs updating - please use bus_type methods
 [  122.349546] sd 2:0:0:0: [sda] 17773524 512-byte hardware sectors: (9.10 GB/8.47 GiB)
 [  122.447202] sd 2:0:0:0: [sda] Write Protect is off
 [  122.505796] sd 2:0:3:0: [sdd] 17773524 512-byte hardware sectors: (9.10 GB/8.47 GiB)
 [  122.598570] sd 2:0:1:0: [sdb] 17773524 512-byte hardware sectors: (9.10 GB/8.47 GiB)
 [  122.691343] sd 2:0:4:0: [sde] 17773524 512-byte hardware sectors: (9.10 GB/8.47 GiB)
 [  122.691343] sd 2:0:2:0: [sdc] 17773524 512-byte hardware sectors: (9.10 GB/8.47 GiB)
 [  122.877866] sd 2:0:1:0: [sdb] Write Protect is off
 [  122.877866] sd 2:0:2:0: [sdc] Write Protect is off
 [  122.877866] sd 2:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA
 [  123.095640] sd 2:0:5:0: [sdf] 17773524 512-byte hardware sectors: (9.10 GB/8.47 GiB)
 [  123.095640] sd 2:0:3:0: [sdd] Write Protect is off
 [  123.246030] sd 2:0:4:0: [sde] Write Protect is off
 [  123.246030] sd 3:0:0:0: Attached scsi generic sg7 type 0
 [  123.246030] sd 3:0:1:0: Attached scsi generic sg8 type 0
 [  123.246030] sd 3:0:2:0: Attached scsi generic sg9 type 0
 [  123.246030] sd 3:0:3:0: Attached scsi generic sg10 type 0
 [  123.246030] sd 3:0:4:0: Attached scsi generic sg11 type 0
 [  123.246030] sd 3:0:5:0: Attached scsi generic sg12 type 0
 [  123.246030] sd 2:0:2:0: [sdc] Write cache: disabled, read cache: enabled, supports DPO and FUA
 [  123.791928] sd 2:0:3:0: [sdd] Write cache: disabled, read cache: enabled, supports DPO and FUA
 [  123.897397] sd 2:0:1:0: [sdb] Write cache: disabled, read cache: enabled, supports DPO and FUA
 [  123.897397] sd 2:0:5:0: [sdf] Write Protect is off
 [  124.057553]  sda:<5>sd 3:0:0:0: [sdg] 17773524 512-byte hardware sectors: (9.10 GB/8.47 GiB)
 [  124.081967] sd 2:0:4:0: [sde] Write cache: disabled, read cache: enabled, supports DPO and FUA
 [  124.081967] sd 3:0:1:0: [sdh] 17773524 512-byte hardware sectors: (9.10 GB/8.47 GiB)
 [  124.082944] sd 3:0:3:0: [sdj] 17773524 512-byte hardware sectors: (9.10 GB/8.47 GiB)
 [  124.083920]  sdd:<5>sd 3:0:1:0: [sdh] Write Protect is off
 [  124.086850] sd 3:0:3:0: [sdj] Write Protect is off
 [  124.088803] sd 3:0:1:0: [sdh] Write cache: disabled, read cache: enabled, supports DPO and FUA
 [  124.089780] sd 3:0:3:0: [sdj] Write cache: disabled, read cache: enabled, supports DPO and FUA
 [  124.090756]  sdb: sda1 sda4
 [  124.518490] sd 2:0:5:0: [sdf] Write cache: disabled, read cache: enabled, supports DPO and FUA
 [  124.914975] sd 3:0:5:0: [sdl] 17773524 512-byte hardware sectors: (9.10 GB/8.47 GiB)
 [  124.914975]  sdd1
 [  124.914975] sd 3:0:2:0: [sdi] 17773524 512-byte hardware sectors: (9.10 GB/8.47 GiB)
 [  124.914975] sd 3:0:0:0: [sdg] Write Protect is off
 [  125.123959] sd 2:0:3:0: [sdd] Attached SCSI disk
 [  125.123959]  sdb1
 [  125.124935] sd 2:0:0:0: [sda] Attached SCSI disk
 [  125.154232] sd 3:0:5:0: [sdl] Write Protect is off
 [  125.156185] sd 3:0:5:0: [sdl] Write cache: disabled, read cache: enabled, supports DPO and FUA
 [  125.474545] sd 3:0:4:0: [sdk] 17773524 512-byte hardware sectors: (9.10 GB/8.47 GiB)
 [  125.475521] sd 2:0:1:0: [sdb] Attached SCSI disk
 [  125.477474]  sde:<6> sdj:<5>sd 3:0:4:0: [sdk] Write Protect is off
 [  125.482357]  sdl: sde1
 [  125.724545]  sdl1
 [  125.748959] sd 3:0:2:0: [sdi] Write Protect is off
 [  125.748959]  sdf:<5>sd 3:0:5:0: [sdl] Attached SCSI disk
 [  125.749935] sd 2:0:4:0: [sde] Attached SCSI disk
 [  125.751888] sd 3:0:0:0: [sdg] Write cache: disabled, read cache: enabled, supports DPO and FUA
 [  125.761654]  sdf1
 [  126.049740] sd 3:0:4:0: [sdk] Write cache: disabled, read cache: enabled, supports DPO and FUA
 [  126.153255]  sdg: sdj1
 [  126.182552]  sdh:<6> sdc: sdh1<5>sd 3:0:2:0: [sdi] Write cache: disabled, read cache: enabled, supports DPO and FUA
 [  126.218685] 
 [  126.219661] sd 3:0:3:0: [sdj] Attached SCSI disk
 [  126.382747]  sdg1 sdg4
 [  126.412044]  sdc1<5>sd 3:0:0:0: [sdg] Attached SCSI disk
 [  126.476497] 
 [  126.494075] sd 2:0:5:0: [sdf] Attached SCSI disk
 [  126.494075] sd 2:0:2:0: [sdc] Attached SCSI disk
 [  126.494075] sd 3:0:1:0: [sdh] Attached SCSI disk
 [  126.665950]  sdi:<6> sdk: sdi1
 [  126.704036]  sdk1
 [  126.728450] sd 3:0:2:0: [sdi] Attached SCSI disk
 [  126.728450] sd 3:0:4:0: [sdk] Attached SCSI disk
 done.
 Begin: Mounting root file system ... Begin: Running /scripts/local-top ... Begin: Loading[  188.883692] md: raid1 personality regist
 Success: loaded module raid1.
 done.
 Begin: Assembling all MD arrays ... [  189.420801] md: md0 stopped.
 [  189.979394] md: bind<sdg1>
 [  190.015527] md: bind<sda1>
 [  190.532129] raid1: raid set md0 active with 2 out of 2 mirrors
 [  190.605371] md0: bitmap initialized from disk: read 1/1 pages, set 2 bits
 [  190.687402] created bitmap (3 pages) for device md0
 mdadm: /dev/md0 [  190.753808] md: md2 stopped.
 has been started[  190.805566]  md0: with 2 drives. unknown partition table
 
 [  191.327050] md: bind<sdg4>
 [  191.364159] md: bind<sda4>
 [  191.534081] raid1: raid set md2 active with 2 out of 2 mirrors
 [  191.658104] md2: bitmap initialized from disk: read 5/5 pages, set 73 bits
 [  191.740136] created bitmap (65 pages) for device md2
 mdadm: /dev/md2 [  191.807518] md: md3 stopped.
 has been started[  191.858300]  md2: with 2 drives.
  unknown partition table
 [  192.539940] md: bind<sdh1>
 [  192.574120] md: bind<sdb1>
 [  192.744041] raid1: raid set md3 active with 2 out of 2 mirrors
 [  192.934471] md3: bitmap initialized from disk: read 5/5 pages, set 0 bits
 [  193.016502] created bitmap (68 pages) for device md3
 mdadm: /dev/md3 has been started with 2 drives.
 [  193.340721] md: md4 stopped.
 [  193.375877]  md3: unknown partition table
 [  193.768455] md: bind<sdi1>
 [  193.803611] md: bind<sdc1>
 [  193.975486] raid1: raid set md4 active with 2 out of 2 mirrors
 [  194.107322] md4: bitmap initialized from disk: read 5/5 pages, set 0 bits
 [  194.188377] created bitmap (68 pages) for device md4
 mdadm: /dev/md4 has been started with 2 drives.
 [  194.454002] md: md5 stopped.
 [  194.491111]  md4: unknown partition table
 [  195.184470] md: bind<sdj1>
 [  195.223532] md: bind<sdd1>
 [  195.392478] raid1: raid set md5 active with 2 out of 2 mirrors
 [  195.517478] md5: bitmap initialized from disk: read 5/5 pages, set 0 bits
 [  195.599509] created bitmap (68 pages) for device md5
 mdadm: /dev/md5 [  195.668845] md: md6 stopped.
 has been started[  195.719626]  md5: with 2 drives.
  unknown partition table
 [  196.072165] md: bind<sdk1>
 [  196.111227] md: bind<sde1>
 [  196.461813] raid1: raid set md6 active with 2 out of 2 mirrors
 [  196.586813] md6: bitmap initialized from disk: read 5/5 pages, set 0 bits
 [  196.668844] created bitmap (68 pages) for device md6
 mdadm: /dev/md6 [  196.738180] md: md7 stopped.
 has been started[  196.789938]  md6: with 2 drives.
  unknown partition table
 [  197.188375] md: bind<sdl1>
 [  197.224508] md: bind<sdf1>
 [  197.520406] raid1: raid set md7 active with 2 out of 2 mirrors
 [  197.651265] md7: bitmap initialized from disk: read 5/5 pages, set 0 bits
 [  197.733297] created bitmap (68 pages) for device md7
 mdadm: /dev/md7 [  197.799703]  md7:has been started with 2 drives. unknown partition table
 
 Success: assembled all arrays.
 done.
 Begin: Waiting for udev to process events ... done.
 [  206.509659] device-mapper: uevent: version 1.0.3
 [  206.576066] device-mapper: ioctl: 4.14.0-ioctl (2008-04-23) initialised: dm-devel@redhat.com
   5 logical volume(s) in volume group "vg00" now active
 done.
 Begin: Running /scripts/local-premount ... done.
 [  218.345591] kjournald starting.  Commit interval 5 seconds
 [  218.345591] EXT3-fs: mounted filesystem with ordered data mode.
 Begin: Running /scripts/local-bottom ... done.
 done.
 Begin: Running /scripts/init-bottom ... done.
 INIT: version 2.86 booting
 Setting hostname to 'hamster'...done.
 Starting the hotplug events dispatcher: udevd[  221.777230] udevd version 125 started
 .
 Synthesizing the initial hotplug events...done.
 Waiting for /dev to be fully populated...[  307.847498] input: PC Speaker as /devices/platform/pcspkr/input/input0
 done.
 Setting the system clock.
 System Clock set to: Fri Jul 31 14:44:56 UTC 2009.
 Activating swap:swapon on /dev/mapper/vg00-swapvol
 [  401.792763] Adding 524272k swap on /dev/mapper/vg00-swapvol.  Priority:-1 extents:1 across:524272k 
 .
 Will now check root file system:fsck 1.41.3 (12-Oct-2008)
 [/sbin/fsck.ext3 (1) -- /] fsck.ext3 -a -C0 /dev/vg00/rootvol 
 /dev/vg00/rootvol: clean, 12252/32768 files, 107339/131072 blocks
 .
 [  402.332801] EXT3 FS on dm-4, internal journal
 Setting the system clock.
 System Clock set to: Fri Jul 31 14:44:58 UTC 2009.
 Cleaning up ifupdown....
 Regulating system clock...adjtimex: Invalid argument
 for this kernel:
    USER_HZ = 1024 (nominally 1024 ticks per second)
    878 <= tick <= 1074
    -32768000 <= frequency <= 32768000
 done.
 Loading kernel module tcp_diag.
 Loading device-mapper support.
 Generating udev events for MD arrays...done.
 Setting up LVM Volume Groups  Reading all physical volumes.  This may take a while...
   Found volume group "vg01" using metadata type lvm2
   Found volume group "vg00" using metadata type lvm2
   6 logical volume(s) in volume group "vg01" now active
   5 logical volume(s) in volume group "vg00" now active
 .
 Will now check all file systems.
 fsck 1.41.3 (12-Oct-2008)
 Checking all file systems.
 [/sbin/fsck.ext3 (1) -- /var] fsck.ext3 -a -C0 /dev/vg00/varvol 
 var: clean, 99490/196608 files, 324377/393216 blocks
 [/sbin/fsck.ext3 (1) -- /usr] fsck.ext3 -a -C0 /dev/vg00/usrvol 
 usr: clean, 49118/262144 files, 268952/524288 blocks
 [/sbin/fsck.ext3 (1) -- /boot] fsck.ext3 -a -C0 /dev/md0 
 /dev/md0: clean, 29/86400 files, 67834/362816 blocks
 [/sbin/fsck.ext3 (1) -- /home] fsck.ext3 -a -C0 /dev/vg01/homevol 
 home: clean, 9022/2490368 files, 4154258/4966400 blocks
 [/sbin/fsck.ext3 (1) -- /export/decpatch] fsck.ext3 -a -C0 /dev/vg01/decvol 
 decpatch: clean, 2996/1507328 files, 2500601/3000320 blocks
 [/sbin/fsck.ext3 (1) -- /var/lib/bacula] fsck.ext3 -a -C0 /dev/vg01/bdbvol 
 /dev/vg01/bdbvol: clean, 33/61440 files, 13980/245760 blocks
 [/sbin/fsck.ext3 (1) -- /var/lib/postgresql] fsck.ext3 -a -C0 /dev/vg01/pgdbvol 
 /dev/vg01/pgdbvol: clean, 683/757248 files, 1005840/1566720 blocks
 [/sbin/fsck.ext3 (1) -- /var/lib/postgresql/8.1/main/pg_xlog] fsck.ext3 -a -C0 /dev/vg00/pglgvol 
 /dev/vg00/pglgvol: clean, 20/131072 files, 158668/524288 blocks
 [/sbin/fsck.ext4 (1) -- /var/spool/backup] fsck.ext4 -a -C0 /dev/vg01/spoolvol 
 /dev/vg01/spoolvol: clean, 11/327680 files, 55902/1310720 blocks
 [/sbin/fsck.ext3 (1) -- /export/hummingbird11] fsck.ext3 -a -C0 /dev/vg01/h11vol 
 /dev/vg01/h11vol: clean, 5815/66560 files, 87091/133120 blocks
 Done checking file systems. A log is being saved in /var/log/fsck/checkfs if that location is writable..
 Setting kernel variables (/etc/sysctl.conf)...done.
 Will now mount local filesystems:[  414.812287] kjournald starting.  Commit interval 5 seconds
 [  414.850373] EXT3 FS on md0, internal journal
 [  414.850373] EXT3-fs: mounted filesystem with ordered data mode.
 [  415.036896] kjournald starting.  Commit interval 5 seconds
 [  415.112092] EXT3 FS on dm-1, internal journal
 [  415.164826] EXT3-fs: mounted filesystem with ordered data mode.
 [  415.270295] kjournald starting.  Commit interval 5 seconds
 [  415.300568] EXT3 FS on dm-0, internal journal
 [  415.300568] EXT3-fs: mounted filesystem with ordered data mode.
 [  415.561310] kjournald starting.  Commit interval 5 seconds
 [  415.613068] EXT3 FS on dm-5, internal journal
 [  415.613068] EXT3-fs: mounted filesystem with ordered data mode.
 [  415.885529] kjournald starting.  Commit interval 5 seconds
 [  415.919708] EXT3 FS on dm-7, internal journal
 [  415.920685] EXT3-fs: mounted filesystem with ordered data mode.
 [  416.231232] kjournald starting.  Commit interval 5 seconds
 [  416.281036] EXT3 FS on dm-8, internal journal
 [  416.281036] EXT3-fs: mounted filesystem with ordered data mode.
 [  416.449982] kjournald starting.  Commit interval 5 seconds
 [  416.551544] EXT3 FS on dm-9, internal journal
 [  416.604278] EXT3-fs: mounted filesystem with ordered data mode.
 [  416.735138] kjournald starting.  Commit interval 5 seconds
 [  416.782989] EXT3 FS on dm-3, internal journal
 [  416.782989] EXT3-fs: mounted filesystem with ordered data mode.
 [  417.241973] EXT4-fs: barriers enabled
 [  417.297637] kjournald2 starting: pid 2704, dev dm-6:8, commit interval 5 seconds
 [  417.346466] EXT4 FS on dm-6, internal journal on dm-6:8
 [  417.346466] EXT4-fs: delayed allocation enabled
 [  417.346466] EXT4-fs: file extents enabled
 [  417.349395] EXT4-fs: mballoc enabled
 [  417.349395] EXT4-fs: mounted filesystem dm-6 with ordered data mode
 [  417.697051] kjournald starting.  Commit interval 5 seconds
 [  417.740020] EXT3 FS on dm-10, internal journal
 [  417.740020] EXT3-fs: mounted filesystem with ordered data mode.
 .
 Will now activate swapfile swap:done.
 Checking quotas...done.
 Turning on quotas...done.
 Cleaning /tmp...done.
 Cleaning /var/run...done.
 Cleaning /var/lock...done.
 Checking minimum space in /tmp...done.
 Setting up resolvconf...done.
 Setting up networking....
 Configuring network interfaces...[  440.523211] eth0: Setting half-duplex based on MII#5 link partner capability of 0000.
 done.
 Starting portmap daemon....
 Starting NFS common utilities: statd[  455.953868] RPC: Registered udp transport module.
 [  456.010508] RPC: Registered tcp transport module.
 [  456.229258] Slow work thread pool: Starting up
 [  456.282969] Slow work thread pool: Ready
 [  456.330821] FS-Cache: Loaded
 [  456.577891] FS-Cache: Netfs 'nfs' registered for caching
 [  456.803477] Installing knfsd (copyright (C) 1996 okir@monad.swb.de).
  idmapd.
 Loading the saved-state of the serial devices... 
 /dev/ttyS0 at 0x03f8 (irq = 4) is a 16550A
 /dev/ttyS1 at 0x02f8 (irq = 3) is a 16550A
 Setting console screen modes and fonts.
 Initializing random number generator...done.
 Recovering nvi editor sessions...done.
 Setting up X server socket directory /tmp/.X11-unix....
 Setting up ICE socket directory /tmp/.ICE-unix....
 INIT: Entering runlevel: 2
 Starting system log daemon....
 Starting kernel log daemon....
 Starting system message bus: dbus.
 Starting Avahi mDNS/DNS-SD Daemon: avahi-daemon.
 Starting domain name service...: bind9.
 Starting domain name service: lwresd.
 Starting OpenBSD Secure Shell server: sshd.
 Starting portmap daemon...Already running..
 Starting atop system monitor: atop.
 Starting ClamAV daemon: clamd LibClamAV Warning: ***********************************************************
 LibClamAV Warning: ***  This version of the ClamAV engine is outdated.     ***
 LibClamAV Warning: *** DON'T PANIC! Read http://www.clamav.net/support/faq ***
 LibClamAV Warning: ***********************************************************
 LibClamAV Warning: ***********************************************************
 LibClamAV Warning: ***  This version of the ClamAV engine is outdated.     ***
 LibClamAV Warning: *** DON'T PANIC! Read http://www.clamav.net/support/faq ***
 LibClamAV Warning: ***********************************************************
 .
 Starting ClamAV virus database updater: freshclam.
 Starting Common Unix Printing System: cupsd[  484.426509] parport0: PC-style at 0x3bc [PCSPP]
 [  484.577876] lp0: using parport0 (polling).
 [  484.847408] ppdev: user-space parallel port driver
 .
 Starting file alteration monitor: FAM.
 Starting SMP IRQ Balancer: irqbalance.
 Starting kerneloops:
 Starting Mailman master qrunner: mailmanctl.
 Starting NFS common utilities: statd idmapd.
 Exporting directories for NFS kernel daemon...exportfs: Warning: /usr/local/src does not exist
 .
 Starting NFS kernel daemon: nfsd[  499.949939] NFSD: Using /var/lib/nfs/v4recovery as the NFSv4 state recovery directory
 [  500.154040] NFSD: starting 90-second grace period
  mountd.
 Starting internet superserver: inetd.
 Starting PostgreSQL 8.1 database server: main.
 Starting rsync daemon: rsync.
 Starting Samba daemons: nmbd smbd.
 To enable saslauthd, edit /etc/default/saslauthd and set START=yes (warning).
 Starting network management services: snmpd.
 Starting the system activity data collector: sadc.
 tftpd-hpa disabled in /etc/default/tftpd-hpa
 Starting the Winbind daemon: winbind.
 Starting quota service: rpc.rquotad.
 Starting Mail Transport Agent (MTA): sendmail.
 Starting NTP server: ntpd.
 Starting MD monitoring service: mdadm --monitor.
 Starting DHCP server: dhcpd3[  531.177462] warning: `ntpd' uses 32-bit capabilities (legacy support in use)
 .
 Starting deferred execution scheduler: atd.
 Starting periodic command scheduler: crond.
 Running local boot scripts (/etc/rc.local)\nEnabling tape hardware compression
 /dev/nst0: No such file or directory
  failed!
 Starting Bacula Storage daemon: /dev/nst0: No such file or directory
 Starting apache 1.3 web server....
 Starting Bacula File daemon: bacula-fd.
 Starting Bacula Director: bacula-dir.
 Edit /etc/default/jackd to start jackd
 
 Debian GNU/Linux 5.0 hamster ttyS0
 
 hamster login: 

--- End Message ---
--- Begin Message ---
Version: 2.6.32-1

On Fri, Mar 19, 2010 at 12:47:52PM +0000, Bailey, Scott (Server Management & Virtualization) wrote:
> Moritz,
> 
> I just tested with the 2.6.32-3-alpha-smp kernel and the firmware images
> load beautifully.
> 
> Unfortunately, the system appears to live-lock towards the end of the boot
> sequence :-p but that clearly is unrelated to this problem. Bug 539406 can
> be closed! 

Thanks, marking this bug as closed, then.

Cheers,
        Moritz


--- End Message ---

Reply to: