So, with some help from Yinghai today, I finally managed to make my own working LinuxBIOS image, and boot it on the s2881. Fantastic!
It cut boot time roughly in half - and that's without doing any optimizing of the init startup sequence, which now takes up the bulk of the bootup time.
Anyway. Once the system booted, I tested network access and a few other things, and everything seemed to work just fine.
But 10 minutes later the machine was no longer pingable, and I didn't get any response on the serial console anymore either.
I shut it down, and restarted with LinuxBIOS. At this point, it would not boot anymore - as you can see in the attached serial log, it just decides to restart its fallback image just after init starts, which then hangs the box.
Any clues? This is the latest svn revision (2145), with Etherboot 5.4.1 + FILO to boot from the local SATA drive.
I rebooted with the proprietary BIOS, which brought the box up just fine (after complaining that it had to reset the CMOS). It started re-syncing the software RAID array right after boot though, so maybe that is related to the linuxBIOS hang upon boot, which is right after the kernel starts the RAID devices?
I won't be able to work more on the box for the next week or two (holidays...), but I thought I'd better signal this now.
Thanks, Ward.
-- Ward Vandewege ward@fsf.org Free Software Foundation - Senior System Administrator
can you use memtest to valid your memory?
there is one option in memtest to enable support for LinuxBIOS and serial console.....
YH
On 12/15/05, Ward Vandewege ward@gnu.org wrote:
So, with some help from Yinghai today, I finally managed to make my own working LinuxBIOS image, and boot it on the s2881. Fantastic!
It cut boot time roughly in half - and that's without doing any optimizing of the init startup sequence, which now takes up the bulk of the bootup time.
Anyway. Once the system booted, I tested network access and a few other things, and everything seemed to work just fine.
But 10 minutes later the machine was no longer pingable, and I didn't get any response on the serial console anymore either.
I shut it down, and restarted with LinuxBIOS. At this point, it would not boot anymore - as you can see in the attached serial log, it just decides to restart its fallback image just after init starts, which then hangs the box.
Any clues? This is the latest svn revision (2145), with Etherboot 5.4.1 + FILO to boot from the local SATA drive.
I rebooted with the proprietary BIOS, which brought the box up just fine (after complaining that it had to reset the CMOS). It started re-syncing the software RAID array right after boot though, so maybe that is related to the linuxBIOS hang upon boot, which is right after the kernel starts the RAID devices?
I won't be able to work more on the box for the next week or two (holidays...), but I thought I'd better signal this now.
Thanks, Ward.
-- Ward Vandewege ward@fsf.org Free Software Foundation - Senior System Administrator
-- LinuxBIOS mailing list LinuxBIOS@openbios.org http://www.openbios.org/mailman/listinfo/linuxbios
Back from the holidays; hope you all enjoyed yours :)
I've been trying a couple more things to get beyond the linuxbios problems I'm seeing. I've now compiled everything with Gcc 3.4.5, and that did not solve the problem (previously I had compiled etherboot with Gcc 4/linuxbios with 3.4.5).
I've also updated to the latest SVN tree (2148) - no changes there it seems except for a few in the flashrom directory.
I'm attaching a new serial output which shows linuxbios just giving up (resetting?) near the end of the boot sequence (right after the software raid array is loaded, which immediately starts syncing; it is still dirty). Compare with the serial log below that I added to my previous message; there it got slightly further in the boot sequence than this time.
I'm intrigued by how LinuxBIOS seems to reset itself at the start of the boot as well; is this normal? It doesn't do it always, I tried several times, and sometimes it does, sometimes it doesn't.
Debugging suggestions welcome :)
Thanks, Ward.
On Thu, Dec 15, 2005 at 11:30:22PM -0500, Ward Vandewege wrote:
So, with some help from Yinghai today, I finally managed to make my own working LinuxBIOS image, and boot it on the s2881. Fantastic!
It cut boot time roughly in half - and that's without doing any optimizing of the init startup sequence, which now takes up the bulk of the bootup time.
Anyway. Once the system booted, I tested network access and a few other things, and everything seemed to work just fine.
But 10 minutes later the machine was no longer pingable, and I didn't get any response on the serial console anymore either.
I shut it down, and restarted with LinuxBIOS. At this point, it would not boot anymore - as you can see in the attached serial log, it just decides to restart its fallback image just after init starts, which then hangs the box.
Any clues? This is the latest svn revision (2145), with Etherboot 5.4.1 + FILO to boot from the local SATA drive.
I rebooted with the proprietary BIOS, which brought the box up just fine (after complaining that it had to reset the CMOS). It started re-syncing the software RAID array right after boot though, so maybe that is related to the linuxBIOS hang upon boot, which is right after the kernel starts the RAID devices?
I won't be able to work more on the box for the next week or two (holidays...), but I thought I'd better signal this now.
Thanks, Ward.
-- Ward Vandewege ward@fsf.org Free Software Foundation - Senior System Administrator
LinuxBIOS-1.1.8_s2881_Fallback Thu Dec 15 18:45:48 EST 2005 starting... (0,1) link=00 (1,0) link=00 02 nodes initialized. core0: --- { APICID = 02 NODEID = 01 COREID = 00} --- SBLink=02 NC node|link=02 ht reset -
LinuxBIOS-1.1.8_s2881_Fallback Thu Dec 15 18:45:48 EST 2005 starting... (0,1) link=00 (1,0) link=00 02 nodes initialized. core0: --- { APICID = 02 NODEID = 01 COREID = 00} --- SBLink=02 NC node|link=02 Ram1.00 Ram1.01 Ram2.00 Ram2.01 Ram3 Initializing memory: done Initializing memory: done Ram4 v_esp=000cfd40 cpu_reset = 00000000 Clearing initial memory region: No cache as ram now - Use Ram as Stack now - done new_cpu_reset = 00000000 Copying LinuxBIOS to ram. src=fffe0004 dst=00004000 linxbios_ram.bin length = 0001928c Jumping to LinuxBIOS. LinuxBIOS-1.1.8_s2881_Fallback Thu Dec 15 18:45:48 EST 2005 booting... Enumerating buses... APIC_CLUSTER: 0 enabled PCI_DOMAIN: 0000 enabled PCI: 00:18.3 siblings=1 CPU: APIC: 00 enabled CPU: APIC: 01 enabled PCI: 00:19.0 [1022/1100] enabled PCI: 00:19.1 [1022/1101] enabled PCI: 00:19.2 [1022/1102] enabled PCI: 00:19.3 [1022/1103] enabled PCI: 00:19.3 siblings=1 CPU: APIC: 02 enabled CPU: APIC: 03 enabled PCI: pci_scan_bus for bus 0 PCI: 00:18.0 [1022/1100] enabled PCI: 00:18.1 [1022/1101] enabled PCI: 00:18.2 [1022/1102] enabled PCI: 00:18.3 [1022/1103] enabled PCI: 00:19.0 [1022/1100] enabled PCI: 00:19.1 [1022/1101] enabled PCI: 00:19.2 [1022/1102] enabled PCI: 00:19.3 [1022/1103] enabled PCI: 01:00.0 [1022/7450] enabled PCI: 01:01.0 [1022/7450] enabled next_unitid: 0003 PCI: 01:00.0 [1022/7460] enabled PCI: 01:03.0 [1022/7460] enabled next_unitid: 0007 PCI: pci_scan_bus for bus 1 PCI: 01:01.0 [1022/7450] enabled PCI: 01:01.1 [1022/7451] enabled PCI: 01:02.0 [1022/7450] enabled PCI: 01:02.1 [1022/7451] enabled PCI: 01:03.0 [1022/7460] enabled PCI: 01:04.0 [1022/7468] enabled PCI: 01:04.1 [1022/7469] enabled PCI: 01:04.2 [1022/746a] enabled PCI: 01:04.3 [1022/746b] enabled PCI: pci_scan_bus for bus 2 PCI: 02:09.0 [14e4/1648] enabled PCI: 02:09.1 [14e4/1648] enabled Disabling static device: PCI: 02:0a.0 Disabling static device: PCI: 02:0a.1 PCI: pci_scan_bus returning with max=02 PCI: 02: 100MHz PCI-X PCI: pci_scan_bus for bus 3 PCI: pci_scan_bus returning with max=03 PCI: 03: 133MHz PCI-X PCI: pci_scan_bus for bus 4 PCI: 04:00.0 [1022/7464] enabled PCI: 04:00.1 [1022/7464] enabled PCI: 04:05.0 [1095/3114] enabled PCI: 04:06.0 [1002/4752] enabled PCI: pci_scan_bus returning with max=04 PNP: 002e.0 enabled PNP: 002e.1 disabled PNP: 002e.2 enabled PNP: 002e.3 disabled PNP: 002e.5 enabled PNP: 002e.6 disabled PNP: 002e.7 disabled PNP: 002e.8 disabled PNP: 002e.9 disabled PNP: 002e.a disabled PNP: 002e.b enabled smbus: PCI: 01:04.3[0]->I2C: 01:50 enabled smbus: PCI: 01:04.3[0]->I2C: 01:51 enabled smbus: PCI: 01:04.3[0]->I2C: 01:52 enabled smbus: PCI: 01:04.3[0]->I2C: 01:53 enabled smbus: PCI: 01:04.3[0]->I2C: 01:54 enabled smbus: PCI: 01:04.3[0]->I2C: 01:55 enabled smbus: PCI: 01:04.3[0]->I2C: 01:56 enabled smbus: PCI: 01:04.3[0]->I2C: 01:57 enabled smbus: PCI: 01:04.3[0]->I2C: 01:2d enabled smbus: PCI: 01:04.3[0]->I2C: 01:2a enabled smbus: PCI: 01:04.3[0]->I2C: 01:49 enabled smbus: PCI: 01:04.3[0]->I2C: 01:4a enabled PCI: pci_scan_bus returning with max=04 PCI: pci_scan_bus returning with max=04 done Allocating resources... Reading resources... PCI: 01:01.0 1c <- [0x00fffff000 - 0x00ffffefff] bus 2 io PCI: 01:01.0 24 <- [0xfffffffffff00000 - 0xffffffffffefffff] bus 2 prefmem PCI: 01:03.0 24 <- [0x00fff00000 - 0x00ffefffff] bus 4 prefmem Done reading resources. Setting resources... PCI: 00:18.0 1ba <- [0x00fd300000 - 0x00fd2fffff] prefmem <node 0 link 2> PCI: 00:18.0 1c2 <- [0x0000001000 - 0x0000002fff] io <node 0 link 2> PCI: 00:18.0 1b2 <- [0x00fc000000 - 0x00fd2fffff] mem <node 0 link 2> PCI: 01:01.0 20 <- [0x00fd100000 - 0x00fd1fffff] bus 2 mem PCI: 02:09.0 10 <- [0x00fd100000 - 0x00fd10ffff] mem64 PCI: 02:09.0 18 <- [0x00fd110000 - 0x00fd11ffff] mem64 PCI: 02:09.1 10 <- [0x00fd120000 - 0x00fd12ffff] mem64 PCI: 02:09.1 18 <- [0x00fd130000 - 0x00fd13ffff] mem64 PCI: 01:01.1 10 <- [0x00fd200000 - 0x00fd200fff] mem64 PCI: 01:02.1 10 <- [0x00fd201000 - 0x00fd201fff] mem64 PCI: 01:03.0 1c <- [0x0000001000 - 0x0000001fff] bus 4 io PCI: 01:03.0 20 <- [0x00fc000000 - 0x00fd0fffff] bus 4 mem PCI: 04:00.0 10 <- [0x00fd000000 - 0x00fd000fff] mem PCI: 04:00.1 10 <- [0x00fd001000 - 0x00fd001fff] mem PCI: 04:05.0 10 <- [0x0000001410 - 0x0000001417] io PCI: 04:05.0 14 <- [0x0000001430 - 0x0000001433] io PCI: 04:05.0 18 <- [0x0000001420 - 0x0000001427] io PCI: 04:05.0 1c <- [0x0000001440 - 0x0000001443] io PCI: 04:05.0 20 <- [0x0000001400 - 0x000000140f] io PCI: 04:05.0 24 <- [0x00fd003000 - 0x00fd0033ff] mem PCI: 04:06.0 10 <- [0x00fc000000 - 0x00fcffffff] mem PCI: 04:06.0 14 <- [0x0000001000 - 0x00000010ff] io PCI: 04:06.0 18 <- [0x00fd002000 - 0x00fd002fff] mem PCI: 04:06.0 30 <- [0x00fff80000 - 0x00fff9ffff] romem PNP: 002e.0 60 <- [0x00000003f0 - 0x00000003f7] io PNP: 002e.0 70 <- [0x0000000006 - 0x0000000006] irq PNP: 002e.0 74 <- [0x0000000002 - 0x0000000002] drq PNP: 002e.2 60 <- [0x00000003f8 - 0x00000003ff] io PNP: 002e.2 70 <- [0x0000000004 - 0x0000000004] irq PNP: 002e.5 60 <- [0x0000000060 - 0x0000000060] io PNP: 002e.5 62 <- [0x0000000064 - 0x0000000064] io PNP: 002e.5 70 <- [0x0000000001 - 0x0000000001] irq PNP: 002e.5 72 <- [0x000000000c - 0x000000000c] irq PNP: 002e.b 60 <- [0x0000000290 - 0x0000000297] io PNP: 002e.b 70 <- [0x0000000005 - 0x0000000005] irq PCI: 01:04.1 20 <- [0x0000002420 - 0x000000242f] io PCI: 01:04.2 10 <- [0x0000002400 - 0x000000241f] io PCI: 01:04.3 58 <- [0x0000002000 - 0x00000020ff] io PCI: 00:18.3 94 <- [0x00f8000000 - 0x00fbffffff] mem <gart> PCI: 00:19.3 94 <- [0x00f8000000 - 0x00fbffffff] mem <gart> Done setting resources. Done allocating resources. Enabling resourcess... PCI: 00:18.0 cmd <- 140 PCI: 01:01.0 bridge ctrl <- 0003 PCI: 01:01.0 cmd <- 146 PCI: 02:09.0 subsystem <- 10f1/2881 PCI: 02:09.0 cmd <- 142 PCI: 02:09.1 subsystem <- 10f1/2881 PCI: 02:09.1 cmd <- 142 PCI: 01:01.1 subsystem <- 10f1/2881 PCI: 01:01.1 cmd <- 146 PCI: 01:02.1 subsystem <- 10f1/2881 PCI: 01:02.1 cmd <- 146 PCI: 01:03.0 bridge ctrl <- 0003 PCI: 01:03.0 cmd <- 147 PCI: 04:00.0 subsystem <- 10f1/2881 PCI: 04:00.0 cmd <- 142 PCI: 04:00.1 subsystem <- 10f1/2881 PCI: 04:00.1 cmd <- 142 PCI: 04:05.0 subsystem <- 10f1/2881 PCI: 04:05.0 cmd <- 143 PCI: 04:06.0 subsystem <- 10f1/2881 PCI: 04:06.0 cmd <- 1c3 PCI: 01:04.0 subsystem <- 10f1/2881 PCI: 01:04.0 cmd <- 14f w83627hf hwm smbus enabled PCI: 01:04.1 subsystem <- 10f1/2881 PCI: 01:04.1 cmd <- 141 PCI: 01:04.2 subsystem <- 10f1/2881 PCI: 01:04.2 cmd <- 141 PCI: 01:04.3 subsystem <- 10f1/2881 PCI: 01:04.3 cmd <- 141 PCI: 00:18.1 subsystem <- 10f1/2881 PCI: 00:18.1 cmd <- 140 PCI: 00:18.2 subsystem <- 10f1/2881 PCI: 00:18.2 cmd <- 140 PCI: 00:18.3 cmd <- 140 PCI: 00:19.0 cmd <- 140 PCI: 00:19.1 cmd <- 140 PCI: 00:19.2 cmd <- 140 PCI: 00:19.3 cmd <- 140 done. Initializing devices... Root Device init APIC_CLUSTER: 0 init Initializing CPU #0 CPU: vendor AMD device 20f12 Enabling cache
Setting fixed MTRRs(0-88) type: UC Setting fixed MTRRs(0-16) Type: WB, RdMEM, WrMEM Setting fixed MTRRs(24-88) Type: WB, RdMEM, WrMEM DONE fixed MTRRs Setting variable MTRR 0, base: 0MB, range: 4096MB, type WB Setting variable MTRR 1, base: 4096MB, range: 1024MB, type WB Setting variable MTRR 2, base: 3072MB, range: 1024MB, type UC DONE variable MTRRs Clear out the extra MTRR's
MTRR check Fixed MTRRs : Enabled Variable MTRRs: Enabled
microcode: equivalent processor rev id = 0x0210, patch id = 0x00000000 microcode: patch id that want to apply= 0x0000004d microcode: updated to patch id = 0x0000004d success Setting up local apic... apic_id: 0 done. Clearing memory 1024K - 2097152K: ------------------------------- done CPU #0 Initialized start_eip=0x00010000 Initializing CPU #1 CPU: vendor AMD device 20f12 Enabling cache
Setting fixed MTRRs(0-88) type: UC Setting fixed MTRRs(0-16) Type: WB, RdMEM, WrMEM Setting fixed MTRRs(24-88) Type: WB, RdMEM, WrMEM DONE fixed MTRRs Setting variable MTRR 0, base: 0MB, range: 4096MB, type WB Setting variable MTRR 1, base: 4096MB, range: 1024MB, type WB Setting variable MTRR 2, base: 3072MB, range: 1024MB, type UC DONE variable MTRRs Clear out the extra MTRR's
MTRR check Fixed MTRRs : Enabled Variable MTRRs: Enabled
microcode: equivalent processor rev id = 0x0210, patch id = 0x00000000 microcode: patch id that want to apply= 0x0000004d microcode: updated to patch id = 0x0000004d success Setting up local apic... apic_id: 1 done. CPU #1 Initialized start_eip=0x00010000 Initializing CPU #2 CPU: vendor AMD device 20f12 Enabling cache
Setting fixed MTRRs(0-88) type: UC Setting fixed MTRRs(0-16) Type: WB, RdMEM, WrMEM Setting fixed MTRRs(24-88) Type: WB, RdMEM, WrMEM DONE fixed MTRRs Setting variable MTRR 0, base: 0MB, range: 4096MB, type WB Setting variable MTRR 1, base: 4096MB, range: 1024MB, type WB Setting variable MTRR 2, base: 3072MB, range: 1024MB, type UC DONE variable MTRRs Clear out the extra MTRR's
MTRR check Fixed MTRRs : Enabled Variable MTRRs: Enabled
microcode: equivalent processor rev id = 0x0210, patch id = 0x00000000 microcode: patch id that want to apply= 0x0000004d microcode: updated to patch id = 0x0000004d success Setting up local apic... apic_id: 2 done. Clearing memory 2097152K - 5242880K: ----------------++++++++++++++++ done CPU #2 Initialized start_eip=0x00010000 Initializing CPU #3 Waiting for 1 CPUS to stop CPU: vendor AMD device 20f12 Enabling cache
Setting fixed MTRRs(0-88) type: UC Setting fixed MTRRs(0-16) Type: WB, RdMEM, WrMEM Setting fixed MTRRs(24-88) Type: WB, RdMEM, WrMEM DONE fixed MTRRs Setting variable MTRR 0, base: 0MB, range: 4096MB, type WB Setting variable MTRR 1, base: 4096MB, range: 1024MB, type WB Setting variable MTRR 2, base: 3072MB, range: 1024MB, type UC DONE variable MTRRs Clear out the extra MTRR's
MTRR check Fixed MTRRs : Enabled Variable MTRRs: Enabled
microcode: equivalent processor rev id = 0x0210, patch id = 0x00000000 microcode: patch id that want to apply= 0x0000004d microcode: updated to patch id = 0x0000004d success Setting up local apic... apic_id: 3 done. CPU #3 Initialized All AP CPUs stopped PCI: 00:18.0 init PCI: 01:01.0 init PCI: 02:09.0 init PCI: 02:09.1 init PCI: 01:03.0 init PCI: 04:05.0 init PCI: 04:06.0 init PCI: 01:04.0 init RTC Init Invalid CMOS LB checksum enabling HPET @0xfed00000 PNP: 002e.0 init PNP: 002e.2 init PNP: 002e.5 init PNP: 002e.b init PCI: 01:04.1 init IDE1 IDE0 PCI: 01:04.3 init set power on after power fail smbus: PCI: 01:04.3[0]->I2C: 01:2d init PCI: 00:18.1 init PCI: 00:18.2 init PCI: 00:18.3 init NB: Function 3 Misc Control.. done. PCI: 00:19.0 init PCI: 00:19.1 init PCI: 00:19.2 init PCI: 00:19.3 init NB: Function 3 Misc Control.. done. Devices initialized Writing IRQ routing tables to 0xf0000...done. Wrote the mp table end at: 00000020 - 000001f4 Moving GDT to 0x500...ok Wrote linuxbios table at: 00000530 - 00000e1c checksum 2ea0
Welcome to elfboot, the open sourced starter. January 2002, Eric Biederman. Version 1.3
33:stream_init() - rom_stream: 0xfffc0000 - 0xfffdffffFound ELF candiate at offset 0 Loading Etherboot version: 5.4.1 Dropping non PT_LOAD segment New segment addr 0x10000 size 0x49100 offset 0x0 filesize 0x9ac0 (cleaned up) New segment addr 0x10000 size 0x49100 offset 0x0 filesize 0x9ac0 Loading Segment: addr: 0x00000000bff8c000 memsz: 0x0000000000034000 filesz: 0x0000000000009ac0 Clearing Segment: addr: 0x00000000bff95ac0 memsz: 0x000000000002a540 Loading Segment: addr: 0x0000000000044000 memsz: 0x0000000000015100 filesz: 0x0000000000000000 Clearing Segment: addr: 0x0000000000044000 memsz: 0x0000000000015100 Jumping to boot code at 0x100b0 CPU 2063 Mhz Etherboot 5.4.1 (GPL) http://etherboot.org Drivers: TG3 FILO Images: NBI ELF Protocols: DHCP TFTP Relocating _text from: [000101b0,00059100) to [bfeb70b0,bff00000) Boot from (N)etwork (D)isk or (Q)uit? D
Probing pci disk... [FILO]FILO version 0.4.1 (root@countzero.vandewege.net) Thu Dec 15 18:44:50 EST 2005 Press <Enter> for default boot, or <Esc> for boot prompt... 2 1 boot: hde1:/vmlinuz-2.6.12-9-amd64-generic initrd=/initrd.img-2.6.12-9-amd64-generic ro root=/dev/md3 console=tty0 console=ttyS0,115200n8 hde: LBA48: WDC WD740GD-00FLC0 hdf: LBA48: WDC WD740GD-00FLC0 Mounted ext2fs Found Linux version 2.6.12-9-amd64-generic (buildd@king) #1 Mon Oct 10 13:27:39 BST 2005 bzImage. Loading kernel... ok Loading initrd... ok Jumping to entry point... [ 0.000000] Bootdata ok (command line is ro root=/dev/md3 console=tty0 console=ttyS0,115200n8) [ 0.000000] Linux version 2.6.12-9-amd64-generic (buildd@king) (gcc version 3.4.5 20050809 (prerelease) (Ubuntu 3.4.4-6ubuntu8)) #1 Mon Oct 10 13:27:39 BST 2005 [ 0.000000] BIOS-provided physical RAM map: [ 0.000000] BIOS-e820: 0000000000000000 - 0000000000000e7c type 16 [ 0.000000] BIOS-e820: 0000000000000e7c - 00000000000a0000 (usable) [ 0.000000] BIOS-e820: 00000000000f0000 - 00000000000f0400 type 16 [ 0.000000] BIOS-e820: 0000000000100000 - 00000000c0000000 (usable) [ 0.000000] BIOS-e820: 0000000100000000 - 0000000140000000 (usable) [ 0.000000] ACPI: Unable to locate RSDP [ 0.000000] Intel MultiProcessor Specification v1.4 [ 0.000000] Virtual Wire compatibility mode. [ 0.000000] OEM ID: TYAN <6>Product ID: S2881 <6>APIC at: 0xFEE00000 [ 0.000000] Processor #0 15:1 APIC version 16 [ 0.000000] Processor #1 15:1 APIC version 16 [ 0.000000] WARNING: NR_CPUS limit of 1 reached. Processor ignored. [ 0.000000] Processor #2 15:1 APIC version 16 [ 0.000000] WARNING: NR_CPUS limit of 1 reached. Processor ignored. [ 0.000000] Processor #3 15:1 APIC version 16 [ 0.000000] WARNING: NR_CPUS limit of 1 reached. Processor ignored. [ 0.000000] I/O APIC #4 Version 17 at 0xFEC00000. [ 0.000000] I/O APIC #5 Version 17 at 0xFD200000. [ 0.000000] I/O APIC #6 Version 17 at 0xFD201000. [ 0.000000] Setting APIC routing to flat [ 0.000000] Processors: 1 [ 0.000000] Allocating PCI resources starting at c0000000 (gap: c0000000:40000000) [ 0.000000] Checking aperture... [ 0.000000] CPU 0: aperture @ f8000000 size 64 MB [ 0.000000] CPU 1: aperture @ f8000000 size 64 MB [ 0.000000] Built 1 zonelists [ 0.000000] Kernel command line: ro root=/dev/md3 console=tty0 console=ttyS0,115200n8 [ 0.000000] Initializing CPU#0 [ 0.000000] PID hash table entries: 4096 (order: 12, 131072 bytes) [ 0.000000] time.c: Using 1.193182 MHz PIT timer. [ 0.000000] time.c: Detected 1992.086 MHz processor. [ 13.476890] time.c: Using PIT/TSC based timekeeping. [ 13.477331] Console: colour dummy device 80x25 [ 13.697387] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes) [ 13.712991] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes) [ 13.789909] Memory: 4101416k/5242880k available (1620k kernel code, 92332k reserved, 997k data, 136k init) [ 13.819815] Security Framework v1.0.0 initialized [ 13.824992] SELinux: Disabled at boot. [ 13.829226] Mount-cache hash table entries: 256 [ 13.834275] CPU: L1 I Cache: 64K (64 bytes/line), D cache 64K (64 bytes/line) [ 13.842538] CPU: L2 Cache: 1024K (64 bytes/line) [ 13.847866] CPU: stepping 02 [ 13.851414] checking if image is initramfs... it is [ 14.188550] Using IO-APIC 4 [ 14.191771] Using IO-APIC 5 [ 14.194987] Using IO-APIC 6 [ 14.208302] Using local APIC timer interrupts. [ 14.263629] Detected 12.450 MHz APIC timer. [ 14.268446] testing NMI watchdog ... OK. [ 14.282975] NET: Registered protocol family 16 [ 14.288476] PCI: Using configuration type 1 [ 14.293313] mtrr: v2.0 (20020519) [ 14.297419] ACPI: Subsystem revision 20050729 [ 14.302456] ACPI: Interpreter disabled. [ 14.306890] Linux Plug and Play Support v0.97 (c) Adam Belay [ 14.313412] pnp: PnP ACPI: disabled [ 14.317485] usbcore: registered new driver usbfs [ 14.322838] usbcore: registered new driver hub [ 14.328010] PCI: Probing PCI hardware [ 14.332261] PCI: Probing PCI hardware (bus 00) [ 14.338761] PCI: Discovered primary peer bus 01 [IRQ] [ 14.344593] PCI: Using IRQ router default [1022/7468] at 0000:01:04.0 [ 14.352035] PCI->APIC IRQ transform: 0000:01:04.2[D] -> IRQ 19 [ 14.358802] PCI->APIC IRQ transform: 0000:02:09.0[A] -> IRQ 24 [ 14.365533] PCI->APIC IRQ transform: 0000:02:09.1[B] -> IRQ 25 [ 14.372248] PCI->APIC IRQ transform: 0000:04:00.0[D] -> IRQ 19 [ 14.379040] PCI->APIC IRQ transform: 0000:04:00.1[D] -> IRQ 19 [ 14.385808] PCI->APIC IRQ transform: 0000:04:05.0[A] -> IRQ 17 [ 14.392539] PCI->APIC IRQ transform: 0000:04:06.0[A] -> IRQ 18 [ 14.399347] PCI-DMA: Disabling AGP. [ 14.403460] PCI-DMA: aperture base @ f8000000 size 65536 KB [ 14.409947] PCI-DMA: Reserving 64MB of IOMMU area in the AGP aperture [ 14.417699] IA32 emulation $Id: sys_ia32.c,v 1.32 2002/03/24 13:02:28 ak Exp $ [ 14.426219] audit: initializing netlink socket (disabled) [ 14.432466] audit: initialized [ 14.436078] VFS: Disk quotas dquot_6.5.1 [ 14.440654] Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 14.448113] devfs: 2004-01-31 Richard Gooch (rgooch@atnf.csiro.au) [ 14.455261] devfs: boot_options: 0x0 [ 14.459445] Initializing Cryptographic API [ 14.464203] PCI: MSI quirk detected. pci_msi_quirk set. [ 14.470274] PCI: MSI quirk detected. pci_msi_quirk set. [ 14.490389] Linux agpgart interface v0.101 (c) Dave Jones [ 14.496711] PNP: No PS/2 controller found. Probing ports directly. [ 14.505346] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 14.511273] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 14.516994] Serial: 8250/16550 driver $Revision: 1.90 $ 48 ports, IRQ sharing enabled [ 14.526203] ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A [ 14.533322] io scheduler noop registered [ 14.537861] io scheduler anticipatory registered [ 14.543217] io scheduler deadline registered [ 14.548185] io scheduler cfq registered [ 14.552892] RAMDISK driver initialized: 16 RAM disks of 65536K size 1024 blocksize [ 14.561690] NET: Registered protocol family 2 [ 14.576640] IP: routing cache hash table of 65536 buckets, 512Kbytes [ 14.584455] TCP established hash table entries: 524288 (order: 10, 4194304 bytes) [ 14.596145] TCP bind hash table entries: 65536 (order: 7, 524288 bytes) [ 14.604232] TCP: Hash tables configured (established 524288 bind 65536) [ 14.611945] NET: Registered protocol family 8 [ 14.616960] NET: Registered protocol family 20 [ 14.622278] Freeing unused kernel memory: 136k freed Loading, please wait... Begin: Loading modules ... [ 14.645287] input: AT Translated Set 2 keyboard on isa0060/serio0 [ 14.657083] Capability LSM initialized [ 14.669870] NET: Registered protocol family 1 [ 14.686443] Uniform Multi-Platform E-IDE driver Revision: 7.00alpha2 [ 14.693755] ide: Assuming 33MHz system bus speed for PIO modes; override with idebus=xx [ 14.707909] AMD8111: IDE controller at PCI slot 0000:01:04.1 [ 14.714477] AMD8111: chipset revision 3 [ 14.718933] AMD8111: not 100% native mode: will probe irqs later [ 14.725869] AMD8111: 0000:01:04.1 (rev 03) UDMA133 controller [ 14.732469] ide0: BM-DMA at 0x2420-0x2427, BIOS settings: hda:pio, hdb:pio [ 14.740909] ide1: BM-DMA at 0x2428-0x242f, BIOS settings: hdc:pio, hdd:pio [ 15.881489] hdd: CD-224E, ATAPI CD/DVD-ROM drive [ 15.937874] ide1 at 0x170-0x177,0x376 on irq 15 [ 18.513088] hdd: ATAPI 24X CD-ROM drive, 128kB Cache [ 18.518889] Uniform CD-ROM driver Revision: 3.20 [ 18.772153] tg3.c:v3.31 (June 8, 2005) [ 18.780608] eth0: Tigon3 [partno(BCM95704A6) rev 2003 PHY(5704)] (PCIX:100MHz:64-bit) 10/100/1000BaseT Ethernet 00:e0:81:30:a5:24 [ 18.794116] eth0: RXcsums[1] LinkChgREG[0] MIirq[0] ASF[1] Split[0] WireSpeed[1] TSOcap[0] [ 18.803789] eth0: dma_rwctrl[769f4000] [ 18.818576] eth1: Tigon3 [partno(BCM95704A6) rev 2003 PHY(5704)] (PCIX:100MHz:64-bit) 10/100/1000BaseT Ethernet 00:e0:81:30:a5:25 [ 18.832075] eth1: RXcsums[1] LinkChgREG[0] MIirq[0] ASF[0] Split[0] WireSpeed[1] TSOcap[1] [ 18.841730] eth1: dma_rwctrl[769f4000] [ 18.854427] ohci_hcd 0000:04:00.0: Advanced Micro Devices [AMD] AMD-8111 USB [ 18.862741] ohci_hcd 0000:04:00.0: new USB bus registered, assigned bus number 1 [ 18.871275] ohci_hcd 0000:04:00.0: irq 19, io mem 0xfd000000 [ 18.930659] hub 1-0:1.0: USB hub found [ 18.935018] hub 1-0:1.0: 3 ports detected [ 18.942617] ohci_hcd 0000:04:00.1: Advanced Micro Devices [AMD] AMD-8111 USB (#2) [ 18.951303] ohci_hcd 0000:04:00.1: new USB bus registered, assigned bus number 2 [ 18.959848] ohci_hcd 0000:04:00.1: irq 19, io mem 0xfd001000 [ 19.018622] hub 2-0:1.0: USB hub found [ 19.022997] hub 2-0:1.0: 3 ports detected [ 19.040635] SCSI subsystem initialized [ 19.047043] ata1: SATA max UDMA/100 cmd 0xFFFFC20000014080 ctl 0xFFFFC2000001408A bmdma 0xFFFFC20000014000 irq 17 [ 19.058983] ata2: SATA max UDMA/100 cmd 0xFFFFC200000140C0 ctl 0xFFFFC200000140CA bmdma 0xFFFFC20000014008 irq 17 [ 19.070913] ata3: SATA max UDMA/100 cmd 0xFFFFC20000014280 ctl 0xFFFFC2000001428A bmdma 0xFFFFC20000014200 irq 17 [ 19.082807] ata4: SATA max UDMA/100 cmd 0xFFFFC200000142C0 ctl 0xFFFFC200000142CA bmdma 0xFFFFC20000014208 irq 17 [ 19.449906] ata1: dev 0 ATA, max UDMA/133, 145226112 sectors: lba48 [ 19.458221] ata1: dev 0 configured for UDMA/100 [ 19.463445] scsi0 : sata_sil [ 19.821814] ata2: dev 0 ATA, max UDMA/133, 145226112 sectors: lba48 [ 19.830068] ata2: dev 0 configured for UDMA/100 [ 19.835281] scsi1 : sata_sil [ 20.193734] ata3: dev 0 ATA, max UDMA/133, 145226112 sectors: lba48 [ 20.202017] ata3: dev 0 configured for UDMA/100 [ 20.207255] scsi2 : sata_sil [ 20.565656] ata4: dev 0 ATA, max UDMA/133, 145226112 sectors: lba48 [ 20.573948] ata4: dev 0 configured for UDMA/100 [ 20.579205] scsi3 : sata_sil [ 20.582618] Vendor: ATA Model: WDC WD740GD-00FL Rev: 33.0 [ 20.589939] Type: Direct-Access ANSI SCSI revision: 05 [ 20.598797] Vendor: ATA Model: WDC WD740GD-00FL Rev: 33.0 [ 20.606107] Type: Direct-Access ANSI SCSI revision: 05 [ 20.614984] Vendor: ATA Model: WDC WD740GD-00FL Rev: 33.0 [ 20.622302] Type: Direct-Access ANSI SCSI revision: 05 [ 20.631150] Vendor: ATA Model: WDC WD740GD-00FL Rev: 33.0 [ 20.638484] Type: Direct-Access ANSI SCSI revision: 05 [ 22.664450] SCSI device sda: 145226112 512-byte hdwr sectors (74356 MB) [ 22.672077] SCSI device sda: drive cache: write back [ 22.677847] SCSI device sda: 145226112 512-byte hdwr sectors (74356 MB) [ 22.685509] SCSI device sda: drive cache: write back [ 22.691291] /dev/scsi/host0/bus0/target0/lun0: p1 p2 p3 p4 [ 22.706480] Attached scsi disk sda at scsi0, channel 0, id 0, lun 0 [ 22.713735] SCSI device sdb: 145226112 512-byte hdwr sectors (74356 MB) [ 22.721369] SCSI device sdb: drive cache: write back [ 22.727153] SCSI device sdb: 145226112 512-byte hdwr sectors (74356 MB) [ 22.734791] SCSI device sdb: drive cache: write back [ 22.740529] /dev/scsi/host1/bus0/target0/lun0: p1 p2 p3 p4 [ 22.758728] Attached scsi disk sdb at scsi1, channel 0, id 0, lun 0 [ 22.765981] SCSI device sdc: 145226112 512-byte hdwr sectors (74356 MB) [ 22.773675] SCSI device sdc: drive cache: write back [ 22.779461] SCSI device sdc: 145226112 512-byte hdwr sectors (74356 MB) [ 22.787123] SCSI device sdc: drive cache: write back [ 22.792871] /dev/scsi/host2/bus0/target0/lun0: p1 p2 p3 p4 [ 22.812560] Attached scsi disk sdc at scsi2, channel 0, id 0, lun 0 [ 22.819822] SCSI device sdd: 145226112 512-byte hdwr sectors (74356 MB) [ 22.827507] SCSI device sdd: drive cache: write back [ 22.833316] SCSI device sdd: 145226112 512-byte hdwr sectors (74356 MB) [ 22.841024] SCSI device sdd: drive cache: write back [ 22.846788] /dev/scsi/host3/bus0/target0/lun0: p1 p2 p3 p4 [ 22.867064] Attached scsi disk sdd at scsi3, channel 0, id 0, lun 0 Done. Begin: Initializing /dev ... Done. Begin: Running /scripts/init-premount ... FATAL: Error inserting fan (/lib/modules/2.6.12-9-amd64-generic/kernel/drivers/acpi/fan.ko): No such device FATAL: Error inserting thermal (/lib/modules/2.6.12-9-amd64-generic/kernel/drivers/acpi/thermal.ko): No such device Done. Begin: Mounting root file system ... Begin: Running /scripts/local-top ... [ 23.224330] md: md driver 0.90.1 MAX_MD_DEVS=256, MD_SB_DISKS=27 [ 23.233979] md: raid1 personality registered as nr 3 [ 23.249716] raid5: automatically using best checksumming function: generic_sse [ 23.262592] generic_sse: 6044.000 MB/sec [ 23.267530] raid5: using function: generic_sse (6044.000 MB/sec) [ 23.275210] md: raid5 personality registered as nr 4 [ 23.601260] devfs_mk_dev: could not append to parent for md/0 [ 23.609757] md: md0 stopped. [ 23.614044] md: bind<sdb1> [ 23.617323] md: bind<sdc1> [ 23.620564] md: bind<sdd1> [ 23.623805] md: bind<sda1> [ 23.626995] raid1: raid set md0 active with 4 out of 4 mirrors mdadm: /dev/md0 has been started with 4 drives. [ 23.641055] devfs_mk_dev: could not append to parent for md/1 [ 23.649588] md: md1 stopped. [ 23.653883] md: bind<sdb2> [ 23.657143] md: bind<sdc2> [ 23.660419] md: bind<sdd2> [ 23.663659] md: bind<sda2> [ 23.666829] raid5: device sda2 operational as raid disk 0 [ 23.673104] raid5: device sdd2 operational as raid disk 3 [ 23.679316] raid5: device sdc2 operational as raid disk 2 [ 23.685598] raid5: device sdb2 operational as raid disk 1 [ 23.692275] raid5: allocated 4270kB for md1 [ 23.697098] raid5: raid level 5 set md1 active with 4 out of 4 devices, algorithm 2 [ 23.705958] RAID5 conf printout: [ 23.709709] --- rd:4 wd:4 fd:0 [ 23.713348] disk 0, o:1, dev:sda2 [ 23.717272] disk 1, o:1, dev:sdb2 [ 23.721214] disk 2, o:1, dev:sdc2 [ 23.725140] disk 3, o:1, dev:sdd2 mdadm: /dev/md1 has been started with 4 drives. [ 23.740660] devfs_mk_dev: could not append to parent for md/2 [ 23.749195] md: md2 stopped. [ 23.753499] md: bind<sdb3> [ 23.756782] md: bind<sdc3> [ 23.760050] md: bind<sdd3> [ 23.763323] md: bind<sda3> [ 23.766489] raid5: device sda3 operational as raid disk 0 [ 23.772723] raid5: device sdd3 operational as raid disk 3 [ 23.778971] raid5: device sdc3 operational as raid disk 2 [ 23.785209] raid5: device sdb3 operational as raid disk 1 [ 23.791895] raid5: allocated 4270kB for md2 [ 23.796733] raid5: raid level 5 set md2 active with 4 out of 4 devices, algorithm 2 [ 23.805597] RAID5 conf printout: [ 23.809358] --- rd:4 wd:4 fd:0 [ 23.812987] disk 0, o:1, dev:sda3 [ 23.816945] disk 1, o:1, dev:sdb3 [ 23.820871] disk 2, o:1, dev:sdc3 [ 23.824795] disk 3, o:1, dev:sdd3 mdadm: /dev/md2 has been started with 4 drives. [ 23.844303] devfs_mk_dev: could not append to parent for md/3 [ 23.852907] md: md3 stopped. [ 23.857209] md: bind<sdb4> [ 23.860491] md: bind<sdc4> [ 23.863751] md: bind<sdd4> [ 23.867023] md: bind<sda4> [ 23.870187] md: md3: raid array is not clean -- starting background reconstruction [ 23.878970] raid5: device sda4 operational as raid disk 0 [ 23.885236] raid5: device sdd4 operational as raid disk 3 [ 23.891492] raid5: device sdc4 operational as raid disk 2 [ 23.897764] raid5: device sdb4 operational as raid disk 1 [ 23.904458] raid5: allocated 4270kB for md3 [ 23.909322] raid5: raid level 5 set md3 active with 4 out of 4 devices, algorithm 2 [ 23.918195] RAID5 conf printout: [ 23.921952] --- rd:4 wd:4 fd:0 [ 23.925610] disk 0, o:1, dev:sda4 [ 23.929560] disk 1, o:1, dev:sdb4 [ 23.933493] disk 2, o:1, dev:sdc4 [ 23.937443] disk 3, o:1, dev:sdd4 [ 23.941428] ....<6>md: syncing RAID array md3 [ 23.946502] md: minimum _guaranteed_ reconstruction speed: 1000 KB/sec/disc. [ 23.954669] md: using maximum available idle IO bandwith (but not more than 200000 KB/sec) for reconstruction. [ 23.966246] md: using 128k window, over a total of 67657664 blocks. mdadm: /dev/md3 has been started with 4 drives. Done. Begin: Running /scripts/local-premount ... [ 24.000782] Attempting manual resume [ 24.006995] swsusp: Suspend partition has wrong signature? Done. [ 24.115879] kjournald starting. Commit interval 5 seconds [ 24.122230] EXT3-fs: mounted filesystem with ordered data mode. Begin: Running /scripts/local-bottom ... Done. Done. Begin: Running /scripts/init-bottom ... Done.
- version 2.86 booting
- Starting RAID devices... [ ok ]
- Starting hardware event daemon... [ ok ]
- Creating initial device nodes...
LinuxBIOS-1.1.8_s2881_Fallback Thu Dec 15 18:45:48 EST 2005 starting... (0,1) link=00 (1,0) link=00 02 nodes initialized. core0: --- { APICID = 02 NODEID = 01 COREID = 00} --- SBLink=02 NC node|link=02
-- Ward Vandewege ward@fsf.org Free Software Foundation - Senior System Administrator
Ward, ollie will be back tomorrow, we are doing builds for this board so will take a look.
ron
On Tue, Jan 03, 2006 at 04:59:59PM -0700, Ronald G Minnich wrote:
Ward, ollie will be back tomorrow, we are doing builds for this board so will take a look.
Thanks Ron. Looking forward to what you can find out. I'm going to try a few more things today to see if I can pinpoint the problem more accurately.
Ward.
-- Ward Vandewege ward@fsf.org Free Software Foundation - Senior System Administrator
ward, did you ever get the system up or not?
ron
On Thu, Jan 19, 2006 at 03:53:44PM -0700, Ronald G Minnich wrote:
ward, did you ever get the system up or not?
No, still the same issue. Do you have ideas on how to proceed?
I have been writing some documentation about the process though, which I will put in the linuxbios wiki once it is done.
Thanks, Ward.
-- Ward Vandewege ward@fsf.org Free Software Foundation - Senior System Administrator
-
Ronald G Minnich -
Ward Vandewege -
yhlu