There is a bug in the firmware loading code in qla1280, as reported below: it calls request_firmware() while holding a spinlock. I think that it needs to drop ha->host->host_lock around the call to request_firmware() but I'm not sure that's correct. Ben. -------- Forwarded Message -------- From: R. Scott Bailey <scott.bailey@xxxxxxx> Reply-to: "R. Scott Bailey" <scott.bailey@xxxxxxx>, 539406@xxxxxxxxxxxxxxx To: Debian Bug Tracking System <submit@xxxxxxxxxxxxxxx> Subject: Bug#539406: linux-image-2.6.30-1-alpha-smp: fails to load fw for 1st scsi adapter Date: Fri, 31 Jul 2009 11:36:38 -0400 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: -- Ben Hutchings Unix is many things to many people, but it's never been everything to anybody.
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@xxxxxxxxxx) (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@xxxxxxxxxx
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@xxxxxxxxxxxx).
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:
Attachment:
signature.asc
Description: This is a digitally signed message part
