Dear SeaBIOS folks,
as per request by Kevin I am moving the discussion of thread on the coreboot list [1] to the SeaBIOS list.
Am Sonntag, den 14.09.2014, 10:10 +0200 schrieb Paul Menzel:
testing the SSD Crucial m4 SSD 2.5 256 GB SATA 6 Gb/s on the Lenovo X60t, the payload SeaBIOS 1.7.5-40-g5109366 does not detect the drive.
[…] 32.705: |7f673000| WARNING - Timeout at ahci_port_setup:466! 32.705: |7f673000| AHCI/0: device not ready (tf 0x80) 33.205: |7f673000| WARNING - Timeout at ahci_port_reset:336! […]
Hitting Ctrl + Alt + Delete, the drive is detected.
It is also reproducible on the Lenovo T60 with coreboot from four years ago and SeaBIOS 1.7.0-91-g7a39e72.
The drive is detected correctly on the ASRock E350M1 with coreboot and SeaBIOS 1.7.5.
Please find the whole serial log from SeaBIOS below.
Does that look like a coreboot or SeaBIOS problem?
From the replies on the coreboot mailing list, I was told coreboot and SeaBIOS are too fast for the SSD and it needs at least 500 ms for its initialization.
Though looking at the code in `src/hw/ahci.c`, it should have 32 seconds to initialize.
[…] #define AHCI_REQUEST_TIMEOUT 32000 // 32 seconds max for IDE ops […] /* clear error status */ err = ahci_port_readl(ctrl, pnr, PORT_SCR_ERR); if (err) ahci_port_writel(ctrl, pnr, PORT_SCR_ERR, err);
/* wait for device becoming ready */ end = timer_calc(AHCI_REQUEST_TIMEOUT); for (;;) { tf = ahci_port_readl(ctrl, pnr, PORT_TFDATA); if (!(tf & (ATA_CB_STAT_BSY | ATA_CB_STAT_DRQ))) break; if (timer_check(end)) { warn_timeout(); dprintf(1, "AHCI/%d: device not ready (tf 0x%x)\n", port->pnr, tf); return -1; } yield(); } […]
So it could still be a chipset problem, because it works on the ASRock E350M1. But Sven Schnelle reported it also happens with his Chromebook.
Thanks,
Paul
[1] http://www.coreboot.org/pipermail/coreboot/2014-September/thread.html#78607
$ ./scripts/readserial.py /dev/ttyUSB0 115200
======= Sun Sep 14 09:54:52 2014 (adjust=86.8us) 00.000: <00> 01.376: Changing serial settings was 0/0 now 3/0 01.376: SeaBIOS (version rel-1.7.5-40-g5109366-20140715_011246-my-lenovo-x60t) 01.376: Attempting to find coreboot table 01.376: Found coreboot table forwarder. 01.376: Now attempting to find coreboot memory map 01.376: SeaBIOS (version rel-1.7.5-40-g5109366-20140715_011246-my-lenovo-x60t) 01.376: Found coreboot cbmem console @ 7f7de000 01.376: Found mainboard Lenovo ThinkPad X60 / X60s 01.376: malloc preinit 01.376: Relocating init from 0x000e6c20 to 0x7f679220 (size 44320) 01.376: malloc init 01.376: Found CBFS header at 0xfffffa50 01.376: Add romfile: cmos_layout.bin (size=1828) 01.376: Add romfile: pci8086,27a2.rom (size=65536) 01.376: Add romfile: cmos.default (size=256) 01.376: Add romfile: cpu_microcode_blob.bin (size=94208) 01.377: Add romfile: etc/ps2-keyboard-spinup (size=8) 01.377: Add romfile: config (size=4221) 01.377: Add romfile: (size=29976) 01.377: Add romfile: fallback/romstage (size=50939) 01.377: Add romfile: fallback/ramstage (size=68308) 01.377: Add romfile: fallback/payload (size=55644) 01.377: Add romfile: (size=1723928) 01.377: init ivt 01.377: init bda 01.377: init bios32 01.377: init PMM 01.377: init PNPBIOS table 01.377: init keyboard 01.377: init mouse 01.377: init pic 01.377: math cp init 01.378: CPU Mhz=1663 01.379: init timer 01.379: PCI probe 01.379: PCI device 00:00.0 (vd=8086:27a0 c=0600) 01.379: PCI device 00:02.0 (vd=8086:27a2 c=0300) 01.379: PCI device 00:02.1 (vd=8086:27a6 c=0380) 01.379: PCI device 00:1b.0 (vd=8086:27d8 c=0403) 01.379: PCI device 00:1c.0 (vd=8086:27d0 c=0604) 01.379: PCI device 00:1c.1 (vd=8086:27d2 c=0604) 01.379: PCI device 00:1c.2 (vd=8086:27d4 c=0604) 01.379: PCI device 00:1c.3 (vd=8086:27d6 c=0604) 01.379: PCI device 00:1d.0 (vd=8086:27c8 c=0c03) 01.379: PCI device 00:1d.1 (vd=8086:27c9 c=0c03) 01.379: PCI device 00:1d.2 (vd=8086:27ca c=0c03) 01.379: PCI device 00:1d.3 (vd=8086:27cb c=0c03) 01.379: PCI device 00:1d.7 (vd=8086:27cc c=0c03) 01.379: PCI device 00:1e.0 (vd=8086:2448 c=0604) 01.379: PCI device 00:1f.0 (vd=8086:27b9 c=0601) 01.379: PCI device 00:1f.1 (vd=8086:27df c=0101) 01.379: PCI device 00:1f.2 (vd=8086:27c5 c=0106) 01.379: PCI device 00:1f.3 (vd=8086:27da c=0c05) 01.379: PCI device 01:00.0 (vd=8086:109a c=0200) 01.379: PCI device 02:00.0 (vd=8086:4227 c=0280) 01.380: PCI device 05:00.0 (vd=1180:0476 c=0607) 01.379: PCI device 05:00.1 (vd=1180:0552 c=0c00) 01.380: PCI device 05:00.2 (vd=1180:0822 c=0805) 01.380: Found 23 PCI devices (max PCI bus is 06) 01.380: Relocating coreboot bios tables 01.380: Copying SMBIOS entry point from 0x7f7cc000 to 0x000f1920 01.381: Copying ACPI RSDP from 0x7f7cd000 to 0x000f18f0 01.381: Copying MPTABLE from 0x7f7d9000/7f7d9010 to 0x000f1720 01.381: rsdp=0x000f18f0 01.381: rsdt=0x7f7cd030 01.381: fadt=0x7f7d0510 01.381: pm_tmr_blk=508 01.381: Using pmtimer, ioport 0x508 01.381: Scan for VGA option rom 01.381: Attempting to init PCI bdf 00:02.0 (vd 8086:27a2) 01.381: Copying data 65536@0xffe007b8 to 65536@0x000c0000 01.415: Running option rom at c000:0003 01.462: unimplemented handle_155fXX:26: 01.462: a=80005f34 b=0000078f c=00000002 d=00000002 ds=0000 es=c000 ss=e000 01.462: si=00000994 di=00000080 bp=50a06e0c sp=0000ffe8 cs=c000 ip=4a6e f=0046 01.509: Turning on vga text mode console 01.540: SeaBIOS (version rel-1.7.5-40-g5109366-20140715_011246-my-lenovo-x60t) 01.540: Machine UUID c09ecb7b-2a1f-dc11-b88a-942d40962902 01.540: /7f677000\ Start thread 01.541: |7f677000| init usb 01.541: |7f677000| EHCI init on dev 00:1d.7 (regs=0xe4444020) 01.541: /7f676000\ Start thread 01.541: init ps2port 01.541: /7f674000\ Start thread 01.542: |7f674000| Copying data 8@0xffe27978 to 8@0x7f674fc8 01.542: /7f673000\ Start thread 01.542: init lpt 01.542: Found 0 lpt ports 01.542: init serial 01.542: Found 1 serial ports 01.542: init hard drives 01.542: ATA controller 1 at 1f0/3f4/0 (irq 14 dev f9) 01.542: /7f672000\ Start thread 01.542: /7f671000\ Start thread 01.542: ATA controller 2 at 170/374/0 (irq 15 dev f9) 01.542: /7f670000\ Start thread 01.542: |7f670000| powerup IDE floating 01.542: |7f670000| powerup IDE floating 01.542: |7f670000| powerup IDE floating 01.542: |7f670000| powerup IDE floating 01.542: \7f670000/ End thread 01.543: /7f670000\ Start thread 01.543: \7f671000/ End thread 01.543: \7f673000/ End thread 01.543: init ahci 01.542: AHCI controller at 1f.2, iobase e4444400, irq 0 01.543: AHCI: cap 0xdf12ff03, ports_impl 0x1 01.543: /7f673000\ Start thread 01.543: |7f673000| AHCI/0: probing 01.543: /7f671000\ Start thread 01.543: |7f673000| AHCI/0: link up 01.543: |7f672000| DVD/CD [ata0-0: DVD/CDRW UJDA775 ATAPI-5 DVD/CD] 01.543: |7f672000| Searching bootorder for: /pci@i0cf8/*@1f,1/drive@0/disk@0 01.543: |7f672000| Registering bootable: DVD/CD [ata0-0: DVD/CDRW UJDA775 ATAPI-5 DVD/CD] (type:3 prio:102 data:f16b0) 01.543: \7f672000/ End thread 01.543: |7f674000| Got ps2 nak (status=51) 01.543: |7f674000| ps2 command 2ff failed (aux=0) 01.543: /7f672000\ Start thread 01.544: \7f671000/ End thread 01.544: \7f670000/ End thread 01.544: /7f671000\ Start thread 01.544: /7f670000\ Start thread 01.544: |7f674000| Got ps2 nak (status=51) 01.544: |7f674000| ps2 command 2ff failed (aux=0) 01.544: /7f66f000\ Start thread 01.546: \7f672000/ End thread 01.546: |7f674000| Got ps2 nak (status=51) 01.546: |7f674000| ps2 command 2ff failed (aux=0) 01.546: \7f670000/ End thread 01.549: |7f674000| Got ps2 nak (status=51) 01.549: |7f674000| ps2 command 2ff failed (aux=0) 01.549: \7f66f000/ End thread 01.551: |7f674000| Got ps2 nak (status=51) 01.551: |7f674000| ps2 command 2ff failed (aux=0) 01.553: |7f674000| Got ps2 nak (status=51) 01.553: |7f674000| ps2 command 2ff failed (aux=0) 01.555: |7f674000| Got ps2 nak (status=51) 01.555: |7f674000| ps2 command 2ff failed (aux=0) 01.557: |7f674000| Got ps2 nak (status=51) 01.557: |7f674000| ps2 command 2ff failed (aux=0) 01.559: |7f674000| Got ps2 nak (status=51) 01.559: |7f674000| ps2 command 2ff failed (aux=0) 01.561: |7f671000| set_address 0x7f678090 01.561: |7f674000| Got ps2 nak (status=51) 01.561: |7f674000| ps2 command 2ff failed (aux=0) 01.561: |7f677000| UHCI init on dev 00:1d.0 (io=5000) 01.561: /7f672000\ Start thread 01.561: /7f670000\ Start thread 01.561: \7f670000/ End thread 01.562: |7f671000| ehci_control 0x7f675450 (dir=0 cmd=8 data=0) 01.562: |7f677000| UHCI init on dev 00:1d.1 (io=5020) 01.562: /7f670000\ Start thread 01.562: /7f66f000\ Start thread 01.562: \7f66f000/ End thread 01.562: /7f66f000\ Start thread 01.562: \7f66f000/ End thread 01.562: |7f677000| UHCI init on dev 00:1d.2 (io=5040) 01.562: /7f66f000\ Start thread 01.562: /7f66e000\ Start thread 01.562: \7f66e000/ End thread 01.562: /7f66e000\ Start thread 01.562: \7f66e000/ End thread 01.562: |7f671000| config_usb: 0x7f675450 01.562: |7f671000| ehci_control 0x7f675450 (dir=128 cmd=8 data=8) 01.562: |7f674000| Got ps2 nak (status=51) 01.562: |7f674000| ps2 command 2ff failed (aux=0) 01.562: |7f677000| UHCI init on dev 00:1d.3 (io=5060) 01.562: /7f66e000\ Start thread 01.562: /7f66c000\ Start thread 01.563: \7f66c000/ End thread 01.562: /7f66c000\ Start thread 01.562: \7f66c000/ End thread 01.563: \7f672000/ End thread 01.563: |7f671000| device rev=0200 cls=09 sub=00 proto=02 size=64 01.563: |7f671000| ehci_control 0x7f675450 (dir=128 cmd=8 data=9) 01.563: \7f677000/ End thread 01.563: /7f672000\ Start thread 01.563: \7f672000/ End thread 01.563: \7f670000/ End thread 01.563: |7f671000| ehci_control 0x7f675450 (dir=128 cmd=8 data=41) 01.563: \7f66f000/ End thread 01.563: |7f671000| ehci_control 0x7f675450 (dir=0 cmd=8 data=0) 01.563: |7f674000| Got ps2 nak (status=51) 01.563: |7f674000| ps2 command 2ff failed (aux=0) 01.563: \7f66e000/ End thread 01.563: |7f671000| ehci_control 0x7f675450 (dir=128 cmd=8 data=7) 01.563: /7f672000\ Start thread 01.563: |7f672000| ehci_control 0x7f675450 (dir=0 cmd=8 data=0) 01.564: /7f670000\ Start thread 01.564: |7f674000| Got ps2 nak (status=51) 01.564: |7f674000| ps2 command 2ff failed (aux=0) 01.564: /7f66f000\ Start thread 01.564: |7f66f000| ehci_control 0x7f675450 (dir=0 cmd=8 data=0) 01.564: /7f66e000\ Start thread 01.564: |7f670000| ehci_control 0x7f675450 (dir=0 cmd=8 data=0) 01.565: |7f66e000| ehci_control 0x7f675450 (dir=0 cmd=8 data=0) 01.565: |7f674000| Got ps2 nak (status=51) 01.565: |7f674000| ps2 command 2ff failed (aux=0) 01.566: |7f674000| Got ps2 nak (status=51) 01.567: |7f674000| ps2 command 2ff failed (aux=0) 01.569: |7f674000| Got ps2 nak (status=51) 01.569: |7f674000| ps2 command 2ff failed (aux=0) 01.572: |7f674000| Got ps2 nak (status=51) 01.572: |7f674000| ps2 command 2ff failed (aux=0) 01.574: |7f674000| Got ps2 nak (status=51) 01.574: |7f674000| ps2 command 2ff failed (aux=0) 01.576: |7f674000| Got ps2 nak (status=51) 01.576: |7f674000| ps2 command 2ff failed (aux=0) 01.577: |7f674000| Got ps2 nak (status=51) 01.578: |7f674000| ps2 command 2ff failed (aux=0) 01.580: |7f674000| Got ps2 nak (status=51) 01.580: |7f674000| ps2 command 2ff failed (aux=0) 01.582: |7f674000| Got ps2 nak (status=51) 01.583: |7f674000| ps2 command 2ff failed (aux=0) 01.583: |7f672000| ehci_control 0x7f675450 (dir=128 cmd=8 data=4) 01.584: |7f674000| Got ps2 nak (status=51) 01.585: |7f674000| ps2 command 2ff failed (aux=0) 01.585: |7f66f000| ehci_control 0x7f675450 (dir=128 cmd=8 data=4) 01.586: |7f670000| ehci_control 0x7f675450 (dir=128 cmd=8 data=4) 01.586: |7f672000| ehci_control 0x7f675450 (dir=128 cmd=8 data=4) 01.586: |7f674000| Got ps2 nak (status=51) 01.586: |7f674000| ps2 command 2ff failed (aux=0) 01.586: |7f66e000| ehci_control 0x7f675450 (dir=128 cmd=8 data=4) 01.587: |7f66f000| ehci_control 0x7f675450 (dir=128 cmd=8 data=4) 01.587: |7f674000| Got ps2 nak (status=51) 01.587: |7f674000| ps2 command 2ff failed (aux=0) 01.587: |7f670000| ehci_control 0x7f675450 (dir=128 cmd=8 data=4) 01.587: |7f672000| ehci_control 0x7f675450 (dir=128 cmd=8 data=4) 01.588: |7f66e000| ehci_control 0x7f675450 (dir=128 cmd=8 data=4) 01.588: |7f674000| Got ps2 nak (status=51) 01.588: |7f674000| ps2 command 2ff failed (aux=0) 01.588: |7f66f000| ehci_control 0x7f675450 (dir=128 cmd=8 data=4) 01.588: |7f670000| ehci_control 0x7f675450 (dir=128 cmd=8 data=4) 01.588: |7f672000| ehci_control 0x7f675450 (dir=128 cmd=8 data=4) 01.588: |7f674000| Got ps2 nak (status=51) 01.589: |7f674000| ps2 command 2ff failed (aux=0) 01.589: \7f672000/ End thread 01.589: |7f66e000| ehci_control 0x7f675450 (dir=128 cmd=8 data=4) 01.589: |7f66f000| ehci_control 0x7f675450 (dir=128 cmd=8 data=4) 01.589: |7f674000| Got ps2 nak (status=51) 01.589: |7f674000| ps2 command 2ff failed (aux=0) 01.589: \7f66f000/ End thread 01.589: |7f670000| ehci_control 0x7f675450 (dir=128 cmd=8 data=4) 01.589: \7f670000/ End thread 01.589: |7f66e000| ehci_control 0x7f675450 (dir=128 cmd=8 data=4) 01.590: |7f674000| Got ps2 nak (status=51) 01.590: |7f674000| ps2 command 2ff failed (aux=0) 01.590: \7f66e000/ End thread 01.590: |7f671000| Initialized USB HUB (0 ports used) 01.590: \7f671000/ End thread 01.590: |7f674000| Got ps2 nak (status=51) 01.591: |7f674000| ps2 command 2ff failed (aux=0) 01.591: \7f676000/ End thread 01.593: |7f674000| Got ps2 nak (status=51) 01.594: |7f674000| ps2 command 2ff failed (aux=0) 01.596: |7f674000| Got ps2 nak (status=51) 01.596: |7f674000| ps2 command 2ff failed (aux=0) 01.599: |7f674000| Got ps2 nak (status=51) 01.600: |7f674000| ps2 command 2ff failed (aux=0) 01.602: |7f674000| Got ps2 nak (status=51) 01.602: |7f674000| ps2 command 2ff failed (aux=0) 01.605: |7f674000| Got ps2 nak (status=51) 01.605: |7f674000| ps2 command 2ff failed (aux=0) 01.609: |7f674000| Got ps2 nak (status=51) 01.609: |7f674000| ps2 command 2ff failed (aux=0) 01.610: |7f674000| Got ps2 nak (status=51) 01.611: |7f674000| ps2 command 2ff failed (aux=0) 01.614: |7f674000| Got ps2 nak (status=51) 01.614: |7f674000| ps2 command 2ff failed (aux=0) 01.616: |7f674000| Got ps2 nak (status=51) 01.617: |7f674000| ps2 command 2ff failed (aux=0) 01.619: |7f674000| Got ps2 nak (status=51) 01.620: |7f674000| ps2 command 2ff failed (aux=0) 01.622: |7f674000| Got ps2 nak (status=51) 01.623: |7f674000| ps2 command 2ff failed (aux=0) 01.625: |7f674000| Got ps2 nak (status=51) 01.626: |7f674000| ps2 command 2ff failed (aux=0) 01.628: |7f674000| Got ps2 nak (status=51) 01.629: |7f674000| ps2 command 2ff failed (aux=0) 01.632: |7f674000| Got ps2 nak (status=51) 01.632: |7f674000| ps2 command 2ff failed (aux=0) 01.636: |7f674000| Got ps2 nak (status=51) 01.637: |7f674000| ps2 command 2ff failed (aux=0) 01.639: |7f674000| Got ps2 nak (status=51) 01.639: |7f674000| ps2 command 2ff failed (aux=0) 01.640: |7f674000| Got ps2 nak (status=51) 01.641: |7f674000| ps2 command 2ff failed (aux=0) 01.643: |7f674000| Got ps2 nak (status=51) 01.643: |7f674000| ps2 command 2ff failed (aux=0) 01.645: |7f674000| Got ps2 nak (status=51) 01.646: |7f674000| ps2 command 2ff failed (aux=0) 01.648: |7f674000| Got ps2 nak (status=51) 01.649: |7f674000| ps2 command 2ff failed (aux=0) 01.652: |7f674000| Got ps2 nak (status=51) 01.652: |7f674000| ps2 command 2ff failed (aux=0) 01.654: |7f674000| Got ps2 nak (status=51) 01.654: |7f674000| ps2 command 2ff failed (aux=0) 01.656: |7f674000| Got ps2 nak (status=51) 01.656: |7f674000| ps2 command 2ff failed (aux=0) 01.658: |7f674000| Got ps2 nak (status=51) 01.659: |7f674000| ps2 command 2ff failed (aux=0) 01.661: |7f674000| Got ps2 nak (status=51) 01.663: |7f674000| ps2 command 2ff failed (aux=0) 01.663: |7f674000| Got ps2 nak (status=51) 01.664: |7f674000| ps2 command 2ff failed (aux=0) 01.665: |7f674000| Got ps2 nak (status=51) 01.666: |7f674000| ps2 command 2ff failed (aux=0) 01.668: |7f674000| Got ps2 nak (status=51) 01.669: |7f674000| ps2 command 2ff failed (aux=0) 01.670: |7f674000| Got ps2 nak (status=51) 01.670: |7f674000| ps2 command 2ff failed (aux=0) 01.672: |7f674000| Got ps2 nak (status=51) 01.672: |7f674000| ps2 command 2ff failed (aux=0) 01.675: |7f674000| Got ps2 nak (status=51) 01.675: |7f674000| ps2 command 2ff failed (aux=0) 01.676: |7f674000| Got ps2 nak (status=51) 01.677: |7f674000| ps2 command 2ff failed (aux=0) 01.679: |7f674000| Got ps2 nak (status=51) 01.679: |7f674000| ps2 command 2ff failed (aux=0) 01.680: |7f674000| Got ps2 nak (status=51) 01.682: |7f674000| ps2 command 2ff failed (aux=0) 01.682: |7f674000| Got ps2 nak (status=51) 01.683: |7f674000| ps2 command 2ff failed (aux=0) 01.686: |7f674000| Got ps2 nak (status=51) 01.686: |7f674000| ps2 command 2ff failed (aux=0) 01.687: |7f674000| Got ps2 nak (status=51) 01.688: |7f674000| ps2 command 2ff failed (aux=0) 01.690: |7f674000| Got ps2 nak (status=51) 01.691: |7f674000| ps2 command 2ff failed (aux=0) 01.692: |7f674000| Got ps2 nak (status=51) 01.693: |7f674000| ps2 command 2ff failed (aux=0) 01.694: |7f674000| Got ps2 nak (status=51) 01.695: |7f674000| ps2 command 2ff failed (aux=0) 01.696: |7f674000| Got ps2 nak (status=51) 01.697: |7f674000| ps2 command 2ff failed (aux=0) 01.699: |7f674000| Got ps2 nak (status=51) 01.699: |7f674000| ps2 command 2ff failed (aux=0) 01.701: |7f674000| Got ps2 nak (status=51) 01.701: |7f674000| ps2 command 2ff failed (aux=0) 01.704: |7f674000| Got ps2 nak (status=51) 01.704: |7f674000| ps2 command 2ff failed (aux=0) 01.706: |7f674000| Got ps2 nak (status=51) 01.707: |7f674000| ps2 command 2ff failed (aux=0) 01.708: |7f674000| Got ps2 nak (status=51) 01.709: |7f674000| ps2 command 2ff failed (aux=0) 01.710: |7f674000| Got ps2 nak (status=51) 01.711: |7f674000| ps2 command 2ff failed (aux=0) 01.712: |7f674000| Got ps2 nak (status=51) 01.713: |7f674000| ps2 command 2ff failed (aux=0) 01.716: |7f674000| Got ps2 nak (status=51) 01.716: |7f674000| ps2 command 2ff failed (aux=0) 01.718: |7f674000| Got ps2 nak (status=51) 01.719: |7f674000| ps2 command 2ff failed (aux=0) 01.720: |7f674000| Got ps2 nak (status=51) 01.720: |7f674000| ps2 command 2ff failed (aux=0) 01.722: |7f674000| Discarding ps2 data aa (status=11) 02.335: |7f674000| PS2 keyboard initialized 02.335: \7f674000/ End thread 32.705: |7f673000| WARNING - Timeout at ahci_port_setup:466! 32.705: |7f673000| AHCI/0: device not ready (tf 0x80) 33.205: |7f673000| WARNING - Timeout at ahci_port_reset:336! 33.205: \7f673000/ End thread 33.206: All threads complete. 33.205: Scan for option roms 33.206: Attempting to init PCI bdf 00:00.0 (vd 8086:27a0) 33.206: Attempting to init PCI bdf 00:02.1 (vd 8086:27a6) 33.205: Attempting to init PCI bdf 00:1b.0 (vd 8086:27d8) 33.206: Attempting to init PCI bdf 00:1c.0 (vd 8086:27d0) 33.206: Attempting to init PCI bdf 00:1c.1 (vd 8086:27d2) 33.205: Attempting to init PCI bdf 00:1c.2 (vd 8086:27d4) 33.206: Attempting to init PCI bdf 00:1c.3 (vd 8086:27d6) 33.206: Attempting to init PCI bdf 00:1d.0 (vd 8086:27c8) 33.206: Attempting to init PCI bdf 00:1d.1 (vd 8086:27c9) 33.206: Attempting to init PCI bdf 00:1d.2 (vd 8086:27ca) 33.206: Attempting to init PCI bdf 00:1d.3 (vd 8086:27cb) 33.206: Attempting to init PCI bdf 00:1d.7 (vd 8086:27cc) 33.205: Attempting to init PCI bdf 00:1e.0 (vd 8086:2448) 33.205: Attempting to init PCI bdf 00:1f.0 (vd 8086:27b9) 33.206: Attempting to init PCI bdf 00:1f.2 (vd 8086:27c5) 33.206: Attempting to init PCI bdf 00:1f.3 (vd 8086:27da) 33.205: Attempting to init PCI bdf 01:00.0 (vd 8086:109a) 33.205: Attempting to init PCI bdf 02:00.0 (vd 8086:4227) 33.205: Attempting to init PCI bdf 05:00.0 (vd 1180:0476) 33.206: Attempting to init PCI bdf 05:00.1 (vd 1180:0552) 33.206: Attempting to init PCI bdf 05:00.2 (vd 1180:0822) 33.206: 33.206: Press F12 for boot menu. 33.206: 33.206: Checking for bootsplash 35.774: Searching bootorder for: HALT 35.774: Mapping cd drive 0x000f16b0 35.774: finalize PMM 35.774: malloc finalize 35.775: Space available for UMB: cf000-ee800, f0000-f1680 35.775: Returned 262144 bytes of ZoneHigh 35.775: e820 map has 6 items: 35.775: 0: 0000000000000000 - 000000000009fc00 = 1 RAM 35.774: 1: 000000000009fc00 - 00000000000a0000 = 2 RESERVED 35.774: 2: 00000000000f0000 - 0000000000100000 = 2 RESERVED 35.775: 3: 0000000000100000 - 000000007f6c4000 = 1 RAM 35.774: 4: 000000007f6c4000 - 0000000080000000 = 2 RESERVED 35.774: 5: 00000000f0000000 - 00000000f4000000 = 2 RESERVED 35.775: Jump to int19 35.775: enter handle_19: 35.775: NULL 35.776: Booting from DVD/CD... 35.777: Device reports MEDIUM NOT PRESENT 35.777: scsi_is_ready returned -1 35.777: Boot failed: Could not read from CDROM (code 0003) 35.777: enter handle_18: 35.777: NULL 35.777: Booting from Floppy... 35.777: invalid handle_legacy_disk:696: 35.777: a=00000201 b=00000000 c=00000001 d=00000000 ds=0000 es=07c0 ss=e000 35.777: si=00000000 di=00000000 bp=00000000 sp=0000ffe8 cs=f000 ip=d066 f=0202 35.777: Boot failed: could not read the boot disk 35.777: 35.777: enter handle_18: 35.777: NULL 35.777: Booting from Hard Disk... 35.777: invalid handle_legacy_disk:696: 35.778: a=00000201 b=00000000 c=00000001 d=00000080 ds=0000 es=07c0 ss=e000 35.777: si=00000000 di=00000000 bp=00000000 sp=0000ffe8 cs=f000 ip=d066 f=0202 35.777: Boot failed: could not read the boot disk 35.777: 35.777: enter handle_18: 35.777: NULL 35.777: No bootable device. Retrying in 60 seconds. 41.647: In resume (status=0) 41.647: In 32bit resume 41.647: Attempting a hard reboot 41.873: <00> 42.313: <00> 43.046: Changing serial settings was 0/0 now 3/0 43.046: SeaBIOS (version rel-1.7.5-40-g5109366-20140715_011246-my-lenovo-x60t) 43.046: Attempting to find coreboot table 43.046: Found coreboot table forwarder. 43.046: Now attempting to find coreboot memory map 43.047: SeaBIOS (version rel-1.7.5-40-g5109366-20140715_011246-my-lenovo-x60t) 43.046: Found coreboot cbmem console @ 7f7de000 43.046: Found mainboard Lenovo ThinkPad X60 / X60s 43.047: malloc preinit 43.047: Relocating init from 0x000e6c20 to 0x7f679220 (size 44320) 43.046: malloc init 43.047: Found CBFS header at 0xfffffa50 43.046: Add romfile: cmos_layout.bin (size=1828) 43.047: Add romfile: pci8086,27a2.rom (size=65536) 43.046: Add romfile: cmos.default (size=256) 43.046: Add romfile: cpu_microcode_blob.bin (size=94208) 43.047: Add romfile: etc/ps2-keyboard-spinup (size=8) 43.047: Add romfile: config (size=4221) 43.047: Add romfile: (size=29976) 43.047: Add romfile: fallback/romstage (size=50939) 43.047: Add romfile: fallback/ramstage (size=68308) 43.047: Add romfile: fallback/payload (size=55644) 43.047: Add romfile: (size=1723928) 43.048: init ivt 43.048: init bda 43.047: init bios32 43.047: init PMM 43.047: init PNPBIOS table 43.047: init keyboard 43.047: init mouse 43.047: init pic 43.047: math cp init 43.048: CPU Mhz=1664 43.049: init timer 43.049: PCI probe 43.049: PCI device 00:00.0 (vd=8086:27a0 c=0600) 43.049: PCI device 00:02.0 (vd=8086:27a2 c=0300) 43.049: PCI device 00:02.1 (vd=8086:27a6 c=0380) 43.049: PCI device 00:1b.0 (vd=8086:27d8 c=0403) 43.049: PCI device 00:1c.0 (vd=8086:27d0 c=0604) 43.049: PCI device 00:1c.1 (vd=8086:27d2 c=0604) 43.049: PCI device 00:1c.2 (vd=8086:27d4 c=0604) 43.049: PCI device 00:1c.3 (vd=8086:27d6 c=0604) 43.049: PCI device 00:1d.0 (vd=8086:27c8 c=0c03) 43.049: PCI device 00:1d.1 (vd=8086:27c9 c=0c03) 43.049: PCI device 00:1d.2 (vd=8086:27ca c=0c03) 43.049: PCI device 00:1d.3 (vd=8086:27cb c=0c03) 43.049: PCI device 00:1d.7 (vd=8086:27cc c=0c03) 43.049: PCI device 00:1e.0 (vd=8086:2448 c=0604) 43.049: PCI device 00:1f.0 (vd=8086:27b9 c=0601) 43.049: PCI device 00:1f.1 (vd=8086:27df c=0101) 43.049: PCI device 00:1f.2 (vd=8086:27c5 c=0106) 43.049: PCI device 00:1f.3 (vd=8086:27da c=0c05) 43.049: PCI device 01:00.0 (vd=8086:109a c=0200) 43.049: PCI device 02:00.0 (vd=8086:4227 c=0280) 43.049: PCI device 05:00.0 (vd=1180:0476 c=0607) 43.050: PCI device 05:00.1 (vd=1180:0552 c=0c00) 43.049: PCI device 05:00.2 (vd=1180:0822 c=0805) 43.050: Found 23 PCI devices (max PCI bus is 06) 43.050: Relocating coreboot bios tables 43.051: Copying SMBIOS entry point from 0x7f7cc000 to 0x000f1920 43.051: Copying ACPI RSDP from 0x7f7cd000 to 0x000f18f0 43.051: Copying MPTABLE from 0x7f7d9000/7f7d9010 to 0x000f1720 43.051: rsdp=0x000f18f0 43.051: rsdt=0x7f7cd030 43.051: fadt=0x7f7d0510 43.051: pm_tmr_blk=508 43.051: Using pmtimer, ioport 0x508 43.051: Scan for VGA option rom 43.052: Attempting to init PCI bdf 00:02.0 (vd 8086:27a2) 43.051: Copying data 65536@0xffe007b8 to 65536@0x000c0000 43.084: Running option rom at c000:0003 43.132: unimplemented handle_155fXX:26: 43.132: a=80005f34 b=0000078f c=00000002 d=00000002 ds=0000 es=c000 ss=e000 43.132: si=00000994 di=00000080 bp=50a06e0c sp=0000ffe8 cs=c000 ip=4a6e f=0046 43.178: Turning on vga text mode console 43.210: SeaBIOS (version rel-1.7.5-40-g5109366-20140715_011246-my-lenovo-x60t) 43.211: Machine UUID c09ecb7b-2a1f-dc11-b88a-942d40962902 43.211: /7f677000\ Start thread 43.210: |7f677000| init usb 43.211: |7f677000| EHCI init on dev 00:1d.7 (regs=0xe4444020) 43.210: /7f676000\ Start thread 43.211: init ps2port 43.210: /7f674000\ Start thread 43.212: |7f674000| Copying data 8@0xffe27978 to 8@0x7f674fc8 43.211: /7f673000\ Start thread 43.212: init lpt 43.212: Found 0 lpt ports 43.212: init serial 43.212: Found 1 serial ports 43.212: init hard drives 43.212: ATA controller 1 at 1f0/3f4/0 (irq 14 dev f9) 43.212: /7f672000\ Start thread 43.212: /7f671000\ Start thread 43.212: ATA controller 2 at 170/374/0 (irq 15 dev f9) 43.213: /7f670000\ Start thread 43.213: |7f670000| powerup IDE floating 43.212: |7f670000| powerup IDE floating 43.212: |7f670000| powerup IDE floating 43.212: |7f670000| powerup IDE floating 43.212: \7f670000/ End thread 43.212: /7f670000\ Start thread 43.212: \7f671000/ End thread 43.212: \7f673000/ End thread 43.212: init ahci 43.212: AHCI controller at 1f.2, iobase e4444400, irq 0 43.212: AHCI: cap 0xdf12ff03, ports_impl 0x1 43.212: /7f673000\ Start thread 43.212: |7f673000| AHCI/0: probing 43.212: /7f671000\ Start thread 43.213: \7f670000/ End thread 43.213: |7f673000| AHCI/0: link up 43.213: |7f672000| DVD/CD [ata0-0: DVD/CDRW UJDA775 ATAPI-5 DVD/CD] 43.213: |7f672000| Searching bootorder for: /pci@i0cf8/*@1f,1/drive@0/disk@0 43.213: |7f672000| Registering bootable: DVD/CD [ata0-0: DVD/CDRW UJDA775 ATAPI-5 DVD/CD] (type:3 prio:102 data:f16b0) 43.213: \7f672000/ End thread 43.213: /7f672000\ Start thread 43.213: \7f671000/ End thread 43.213: |7f673000| AHCI/0: ... finished, status 0x51, ERROR 0x4 43.213: /7f671000\ Start thread 43.213: |7f673000| Searching bootorder for: /pci@i0cf8/*@1f,2/drive@0/disk@0 43.213: /7f670000\ Start thread 43.213: |7f673000| AHCI/0: registering: "AHCI/0: M4-CT256M4SSD2 ATA-9 Hard-Disk (238 GiBytes)" 43.213: |7f673000| Registering bootable: AHCI/0: M4-CT256M4SSD2 ATA-9 Hard-Disk (238 GiBytes) (type:2 prio:103 data:f1660) 43.213: \7f673000/ End thread 43.213: /7f673000\ Start thread 43.213: \7f670000/ End thread 43.213: \7f672000/ End thread 43.230: \7f673000/ End thread 43.261: |7f671000| set_address 0x7f678090 43.261: |7f677000| UHCI init on dev 00:1d.0 (io=5000) 43.261: /7f673000\ Start thread 43.261: /7f672000\ Start thread 43.262: \7f672000/ End thread 43.261: |7f671000| ehci_control 0x7f675bd0 (dir=0 cmd=8 data=0) 43.261: |7f677000| UHCI init on dev 00:1d.1 (io=5020) 43.262: /7f672000\ Start thread 43.261: /7f670000\ Start thread 43.261: \7f670000/ End thread 43.262: /7f670000\ Start thread 43.261: \7f670000/ End thread 43.261: |7f677000| UHCI init on dev 00:1d.2 (io=5040) 43.262: /7f670000\ Start thread 43.262: /7f66f000\ Start thread 43.262: \7f66f000/ End thread 43.262: /7f66f000\ Start thread 43.262: \7f66f000/ End thread 43.262: |7f671000| config_usb: 0x7f675bd0 43.262: |7f671000| ehci_control 0x7f675bd0 (dir=128 cmd=8 data=8) 43.262: |7f677000| UHCI init on dev 00:1d.3 (io=5060) 43.261: /7f66f000\ Start thread 43.262: /7f66e000\ Start thread 43.262: \7f66e000/ End thread 43.262: /7f66e000\ Start thread 43.262: \7f66e000/ End thread 43.262: \7f673000/ End thread 43.262: |7f671000| device rev=0200 cls=09 sub=00 proto=02 size=64 43.262: |7f671000| ehci_control 0x7f675bd0 (dir=128 cmd=8 data=9) 43.262: \7f677000/ End thread 43.262: /7f673000\ Start thread 43.262: \7f673000/ End thread 43.262: \7f672000/ End thread 43.262: |7f671000| ehci_control 0x7f675bd0 (dir=128 cmd=8 data=41) 43.262: \7f670000/ End thread 43.262: |7f671000| ehci_control 0x7f675bd0 (dir=0 cmd=8 data=0) 43.262: \7f66f000/ End thread 43.262: |7f671000| ehci_control 0x7f675bd0 (dir=128 cmd=8 data=7) 43.262: /7f673000\ Start thread 43.262: |7f673000| ehci_control 0x7f675bd0 (dir=0 cmd=8 data=0) 43.262: /7f672000\ Start thread 43.262: /7f670000\ Start thread 43.262: |7f670000| ehci_control 0x7f675bd0 (dir=0 cmd=8 data=0) 43.262: /7f66f000\ Start thread 43.262: |7f672000| ehci_control 0x7f675bd0 (dir=0 cmd=8 data=0) 43.262: |7f66f000| ehci_control 0x7f675bd0 (dir=0 cmd=8 data=0) 43.343: |7f673000| ehci_control 0x7f675bd0 (dir=128 cmd=8 data=4) 43.347: |7f670000| ehci_control 0x7f675bd0 (dir=128 cmd=8 data=4) 43.348: |7f672000| ehci_control 0x7f675bd0 (dir=128 cmd=8 data=4) 43.347: |7f673000| ehci_control 0x7f675bd0 (dir=128 cmd=8 data=4) 43.347: |7f66f000| ehci_control 0x7f675bd0 (dir=128 cmd=8 data=4) 43.347: |7f670000| ehci_control 0x7f675bd0 (dir=128 cmd=8 data=4) 43.347: |7f672000| ehci_control 0x7f675bd0 (dir=128 cmd=8 data=4) 43.347: |7f673000| ehci_control 0x7f675bd0 (dir=128 cmd=8 data=4) 43.348: |7f66f000| ehci_control 0x7f675bd0 (dir=128 cmd=8 data=4) 43.348: |7f670000| ehci_control 0x7f675bd0 (dir=128 cmd=8 data=4) 43.348: |7f672000| ehci_control 0x7f675bd0 (dir=128 cmd=8 data=4) 43.348: |7f673000| ehci_control 0x7f675bd0 (dir=128 cmd=8 data=4) 43.348: |7f66f000| ehci_control 0x7f675bd0 (dir=128 cmd=8 data=4) 43.348: |7f670000| ehci_control 0x7f675bd0 (dir=128 cmd=8 data=4) 43.348: |7f672000| ehci_control 0x7f675bd0 (dir=128 cmd=8 data=4) 43.348: |7f673000| ehci_control 0x7f675bd0 (dir=128 cmd=8 data=4) 43.348: |7f66f000| ehci_control 0x7f675bd0 (dir=128 cmd=8 data=4) 43.348: |7f670000| ehci_control 0x7f675bd0 (dir=128 cmd=8 data=4) 43.348: |7f672000| ehci_control 0x7f675bd0 (dir=128 cmd=8 data=4) 43.348: |7f673000| ehci_control 0x7f675bd0 (dir=128 cmd=8 data=4) 43.348: \7f673000/ End thread 43.348: |7f66f000| ehci_control 0x7f675bd0 (dir=128 cmd=8 data=4) 43.348: |7f670000| ehci_control 0x7f675bd0 (dir=128 cmd=8 data=4) 43.348: \7f670000/ End thread 43.348: |7f672000| ehci_control 0x7f675bd0 (dir=128 cmd=8 data=4) 43.351: \7f672000/ End thread 43.349: |7f66f000| ehci_control 0x7f675bd0 (dir=128 cmd=8 data=4) 43.349: \7f66f000/ End thread 43.349: |7f671000| Initialized USB HUB (0 ports used) 43.348: \7f671000/ End thread 43.352: \7f676000/ End thread 43.501: |7f674000| PS2 keyboard initialized 43.501: \7f674000/ End thread 43.501: All threads complete. 43.501: Scan for option roms 43.501: Attempting to init PCI bdf 00:00.0 (vd 8086:27a0) 43.501: Attempting to init PCI bdf 00:02.1 (vd 8086:27a6) 43.501: Attempting to init PCI bdf 00:1b.0 (vd 8086:27d8) 43.501: Attempting to init PCI bdf 00:1c.0 (vd 8086:27d0) 43.501: Attempting to init PCI bdf 00:1c.1 (vd 8086:27d2) 43.501: Attempting to init PCI bdf 00:1c.2 (vd 8086:27d4) 43.502: Attempting to init PCI bdf 00:1c.3 (vd 8086:27d6) 43.501: Attempting to init PCI bdf 00:1d.0 (vd 8086:27c8) 43.501: Attempting to init PCI bdf 00:1d.1 (vd 8086:27c9) 43.501: Attempting to init PCI bdf 00:1d.2 (vd 8086:27ca) 43.501: Attempting to init PCI bdf 00:1d.3 (vd 8086:27cb) 43.501: Attempting to init PCI bdf 00:1d.7 (vd 8086:27cc) 43.501: Attempting to init PCI bdf 00:1e.0 (vd 8086:2448) 43.501: Attempting to init PCI bdf 00:1f.0 (vd 8086:27b9) 43.501: Attempting to init PCI bdf 00:1f.2 (vd 8086:27c5) 43.501: Attempting to init PCI bdf 00:1f.3 (vd 8086:27da) 43.501: Attempting to init PCI bdf 01:00.0 (vd 8086:109a) 43.501: Attempting to init PCI bdf 02:00.0 (vd 8086:4227) 43.501: Attempting to init PCI bdf 05:00.0 (vd 1180:0476) 43.501: Attempting to init PCI bdf 05:00.1 (vd 1180:0552) 43.502: Attempting to init PCI bdf 05:00.2 (vd 1180:0822) 43.501: 43.501: Press F12 for boot menu. 43.502: 43.502: Checking for bootsplash 46.035: Searching bootorder for: HALT 46.045: Mapping cd drive 0x000f16b0 46.045: Mapping hd drive 0x000f1660 to 0 46.045: drive 0x000f1660: PCHS=16383/16/63 translation=lba LCHS=1024/255/63 s=500118192 46.045: finalize PMM 46.045: malloc finalize 46.045: Space available for UMB: cf000-ee800, f0000-f1630 46.045: Returned 253952 bytes of ZoneHigh 46.045: e820 map has 6 items: 46.045: 0: 0000000000000000 - 000000000009fc00 = 1 RAM 46.045: 1: 000000000009fc00 - 00000000000a0000 = 2 RESERVED 46.045: 2: 00000000000f0000 - 0000000000100000 = 2 RESERVED 46.045: 3: 0000000000100000 - 000000007f6c2000 = 1 RAM 46.045: 4: 000000007f6c2000 - 0000000080000000 = 2 RESERVED 46.045: 5: 00000000f0000000 - 00000000f4000000 = 2 RESERVED 46.045: Jump to int19 46.045: enter handle_19: 46.045: NULL 46.045: Booting from DVD/CD... 46.045: Device reports MEDIUM NOT PRESENT 46.045: scsi_is_ready returned -1 46.045: Boot failed: Could not read from CDROM (code 0003) 46.045: enter handle_18: 46.045: NULL 46.045: Booting from Hard Disk... 46.045: Booting from 0000:7c00
On Tue, Sep 16, 2014 at 11:34:51PM +0200, Paul Menzel wrote:
Am Sonntag, den 14.09.2014, 10:10 +0200 schrieb Paul Menzel:
testing the SSD Crucial m4 SSD 2.5 256 GB SATA 6 Gb/s on the Lenovo X60t, the payload SeaBIOS 1.7.5-40-g5109366 does not detect the drive.
[…] 32.705: |7f673000| WARNING - Timeout at ahci_port_setup:466! 32.705: |7f673000| AHCI/0: device not ready (tf 0x80) 33.205: |7f673000| WARNING - Timeout at ahci_port_reset:336!
Out of curiosity, what does the patch below return in the failure and success case?
-Kevin
--- a/src/hw/ahci.c +++ b/src/hw/ahci.c @@ -464,12 +464,14 @@ static int ahci_port_setup(struct ahci_port_s *port) break; if (timer_check(end)) { warn_timeout(); - dprintf(1, "AHCI/%d: device not ready (tf 0x%x)\n", port->pnr, tf); + dprintf(1, "AHCI/%d: device not ready (tf 0x%x cmd=%x stat=%x err=%x)\n", port->pnr, tf, ahci_port_readl(ctrl, pnr, PORT_CMD), ahci_port_readl(ctrl, pnr, PORT_SCR_STAT), ahci_port_readl(ctrl, pnr, PORT_SCR_ERR)); return -1; } yield(); }
+ dprintf(1, "AHCI/%d: device ready (tf 0x%x cmd=%x stat=%x err=%x)\n", port->pnr, tf, ahci_port_readl(ctrl, pnr, PORT_CMD), ahci_port_readl(ctrl, pnr, PORT_SCR_STAT), ahci_port_readl(ctrl, pnr, PORT_SCR_ERR)); + /* start device */ cmd |= PORT_CMD_START; ahci_port_writel(ctrl, pnr, PORT_CMD, cmd);
On Tue, Sep 16, 2014 at 09:45:17PM -0400, Kevin O'Connor wrote:
On Tue, Sep 16, 2014 at 11:34:51PM +0200, Paul Menzel wrote:
Am Sonntag, den 14.09.2014, 10:10 +0200 schrieb Paul Menzel:
testing the SSD Crucial m4 SSD 2.5 256 GB SATA 6 Gb/s on the Lenovo X60t, the payload SeaBIOS 1.7.5-40-g5109366 does not detect the drive.
[…] 32.705: |7f673000| WARNING - Timeout at ahci_port_setup:466! 32.705: |7f673000| AHCI/0: device not ready (tf 0x80) 33.205: |7f673000| WARNING - Timeout at ahci_port_reset:336!
Out of curiosity, what does the patch below return in the failure and success case?
Could you use the patch below instead.
-Kevin
--- a/src/hw/ahci.c +++ b/src/hw/ahci.c @@ -464,12 +464,14 @@ static int ahci_port_setup(struct ahci_port_s *port) break; if (timer_check(end)) { warn_timeout(); - dprintf(1, "AHCI/%d: device not ready (tf 0x%x)\n", port->pnr, tf); + dprintf(1, "AHCI/%d: device not ready (tf 0x%x cmd=%x stat=%x ctl=%x err=%x)\n", port->pnr, tf, ahci_port_readl(ctrl, pnr, PORT_CMD), ahci_port_readl(ctrl, pnr, PORT_SCR_STAT), ahci_port_readl(ctrl, pnr, PORT_SCR_CTL), ahci_port_readl(ctrl, pnr, PORT_SCR_ERR)); return -1; } yield(); }
+ dprintf(1, "AHCI/%d: device ready (tf 0x%x cmd=%x stat=%x ctl=%x err=%x)\n", port->pnr, tf, ahci_port_readl(ctrl, pnr, PORT_CMD), ahci_port_readl(ctrl, pnr, PORT_SCR_STAT), ahci_port_readl(ctrl, pnr, PORT_SCR_CTL), ahci_port_readl(ctrl, pnr, PORT_SCR_ERR)); + /* start device */ cmd |= PORT_CMD_START; ahci_port_writel(ctrl, pnr, PORT_CMD, cmd);
Am Dienstag, den 16.09.2014, 22:21 -0400 schrieb Kevin O'Connor:
On Tue, Sep 16, 2014 at 09:45:17PM -0400, Kevin O'Connor wrote:
On Tue, Sep 16, 2014 at 11:34:51PM +0200, Paul Menzel wrote:
Am Sonntag, den 14.09.2014, 10:10 +0200 schrieb Paul Menzel:
testing the SSD Crucial m4 SSD 2.5 256 GB SATA 6 Gb/s on the Lenovo X60t, the payload SeaBIOS 1.7.5-40-g5109366 does not detect the drive.
[…] 32.705: |7f673000| WARNING - Timeout at ahci_port_setup:466! 32.705: |7f673000| AHCI/0: device not ready (tf 0x80) 33.205: |7f673000| WARNING - Timeout at ahci_port_reset:336!
Out of curiosity, what does the patch below return in the failure and success case?
Could you use the patch below instead.
Kevin, thank you for the reply. I attached your patch, rebuild SeaBIOS (the log level is set to 5) and tested it on the Lenovo X60t.
Showing that it is a timing issue, the first try, the SSD was detected correctly.
[…] 01.214: init ahci 01.214: AHCI controller at 1f.2, iobase e4444400, irq 0 01.214: AHCI: cap 0xdf12ff03, ports_impl 0x1 01.214: /7f673000\ Start thread 01.214: |7f673000| AHCI/0: probing 01.215: |7f673000| AHCI/0: link up 01.215: |7f673000| AHCI/0: device ready (tf 0x150 cmd=6016 stat=113 ctl=0 err=0) 01.215: |7f673000| AHCI/0: ... finished, status 0x51, ERROR 0x4 01.215: |7f673000| Searching bootorder for: /pci@i0cf8/*@1f,2/drive@0/disk@0 01.215: |7f673000| AHCI/0: registering: "AHCI/0: M4-CT256M4SSD2 ATA-9 Hard-Disk (238 GiBytes)" 01.216: |7f673000| Registering bootable: AHCI/0: M4-CT256M4SSD2 ATA-9 Hard-Disk (238 GiBytes) (type:2 prio:103 data:f1610) 01.215: \7f673000/ End thread […]
So powering it off and on again, it was not detected.
[…] 01.542: init ahci 01.541: AHCI controller at 1f.2, iobase e4444400, irq 0 01.541: AHCI: cap 0xdf12ff03, ports_impl 0x1 01.541: /7f673000\ Start thread 01.541: |7f673000| AHCI/0: probing 01.542: |7f673000| AHCI/0: link up […] 32.700: |7f673000| WARNING - Timeout at ahci_port_setup:466! 32.700: |7f673000| AHCI/0: device not ready (tf 0x80 cmd=6016 stat=113 ctl=0 err=4050002) 33.201: |7f673000| WARNING - Timeout at ahci_port_reset:336! 33.201: \7f673000/ End thread […]
Doing a warm reset with Ctrl + Alt + Del the SSD was detected again.
[…] 50.649: init ahci 50.649: AHCI controller at 1f.2, iobase e4444400, irq 0 50.649: AHCI: cap 0xdf12ff03, ports_impl 0x1 50.649: /7f673000\ Start thread 50.649: |7f673000| AHCI/0: probing 50.650: |7f673000| AHCI/0: link up 50.649: |7f673000| AHCI/0: device ready (tf 0x150 cmd=6016 stat=113 ctl=0 err=0) 50.650: |7f673000| AHCI/0: ... finished, status 0x51, ERROR 0x4 50.650: |7f673000| Searching bootorder for: /pci@i0cf8/*@1f,2/drive@0/disk@0 50.650: |7f673000| AHCI/0: registering: "AHCI/0: M4-CT256M4SSD2 ATA-9 Hard-Disk (238 GiBytes)" 50.650: |7f673000| Registering bootable: AHCI/0: M4-CT256M4SSD2 ATA-9 Hard-Disk (238 GiBytes) (type:2 prio:103 data:f1610) 50.650: \7f673000/ End thread […]
Please find all the logs pasted at the end of the message.
Thanks,
Paul
$ ./scripts/readserial.py /dev/ttyUSB0 115200
======= Fri Sep 19 08:59:19 2014 (adjust=86.8us) 00.000: <00> 01.047: Changing serial settings was 0/0 now 3/0 01.048: SeaBIOS (version rel-1.7.5-41-g4c32a80-20140919_084257-lenovo-x60t) 01.048: Attempting to find coreboot table 01.048: Found coreboot table forwarder. 01.048: Now attempting to find coreboot memory map 01.048: SeaBIOS (version rel-1.7.5-41-g4c32a80-20140919_084257-lenovo-x60t) 01.048: Found coreboot cbmem console @ 7f7de000 01.048: Found mainboard Lenovo ThinkPad X60 / X60s 01.048: malloc preinit 01.048: Relocating init from 0x000e6af0 to 0x7f679140 (size 44544) 01.048: malloc init 01.048: Found CBFS header at 0xfffffa50 01.048: Add romfile: cmos_layout.bin (size=1828) 01.048: Add romfile: pci8086,27a2.rom (size=65536) 01.048: Add romfile: cmos.default (size=256) 01.048: Add romfile: cpu_microcode_blob.bin (size=94208) 01.048: Add romfile: etc/ps2-keyboard-spinup (size=8) 01.048: Add romfile: config (size=4221) 01.049: Add romfile: (size=29976) 01.049: Add romfile: fallback/romstage (size=50939) 01.048: Add romfile: fallback/ramstage (size=68308) 01.048: Add romfile: fallback/payload (size=55704) 01.048: Add romfile: (size=1723864) 01.049: init ivt 01.049: init bda 01.049: init bios32 01.048: init PMM 01.048: init PNPBIOS table 01.049: init keyboard 01.049: init mouse 01.049: init pic 01.049: math cp init 01.051: CPU Mhz=1663 01.050: init timer 01.050: PCI probe 01.050: PCI device 00:00.0 (vd=8086:27a0 c=0600) 01.051: PCI device 00:02.0 (vd=8086:27a2 c=0300) 01.050: PCI device 00:02.1 (vd=8086:27a6 c=0380) 01.050: PCI device 00:1b.0 (vd=8086:27d8 c=0403) 01.051: PCI device 00:1c.0 (vd=8086:27d0 c=0604) 01.051: PCI device 00:1c.1 (vd=8086:27d2 c=0604) 01.051: PCI device 00:1c.2 (vd=8086:27d4 c=0604) 01.050: PCI device 00:1c.3 (vd=8086:27d6 c=0604) 01.051: PCI device 00:1d.0 (vd=8086:27c8 c=0c03) 01.051: PCI device 00:1d.1 (vd=8086:27c9 c=0c03) 01.051: PCI device 00:1d.2 (vd=8086:27ca c=0c03) 01.051: PCI device 00:1d.3 (vd=8086:27cb c=0c03) 01.051: PCI device 00:1d.7 (vd=8086:27cc c=0c03) 01.051: PCI device 00:1e.0 (vd=8086:2448 c=0604) 01.051: PCI device 00:1f.0 (vd=8086:27b9 c=0601) 01.051: PCI device 00:1f.1 (vd=8086:27df c=0101) 01.051: PCI device 00:1f.2 (vd=8086:27c5 c=0106) 01.051: PCI device 00:1f.3 (vd=8086:27da c=0c05) 01.051: PCI device 01:00.0 (vd=8086:109a c=0200) 01.051: PCI device 02:00.0 (vd=8086:4227 c=0280) 01.051: PCI device 05:00.0 (vd=1180:0476 c=0607) 01.051: PCI device 05:00.1 (vd=1180:0552 c=0c00) 01.051: PCI device 05:00.2 (vd=1180:0822 c=0805) 01.051: Found 23 PCI devices (max PCI bus is 06) 01.051: Relocating coreboot bios tables 01.052: Copying SMBIOS entry point from 0x7f7cc000 to 0x000f18d0 01.052: Copying ACPI RSDP from 0x7f7cd000 to 0x000f18a0 01.052: Copying MPTABLE from 0x7f7d9000/7f7d9010 to 0x000f16d0 01.052: rsdp=0x000f18a0 01.052: rsdt=0x7f7cd030 01.052: fadt=0x7f7d0510 01.052: pm_tmr_blk=508 01.052: Using pmtimer, ioport 0x508 01.052: Scan for VGA option rom 01.053: Attempting to init PCI bdf 00:02.0 (vd 8086:27a2) 01.053: Copying data 65536@0xffe007b8 to 65536@0x000c0000 01.086: Running option rom at c000:0003 01.134: unimplemented handle_155fXX:26: 01.134: a=80005f34 b=0000078f c=00000002 d=00000002 ds=0000 es=c000 ss=e000 01.134: si=00000994 di=00000080 bp=50a06e0c sp=0000ffe8 cs=c000 ip=4a6e f=0046 01.181: Turning on vga text mode console 01.212: SeaBIOS (version rel-1.7.5-41-g4c32a80-20140919_084257-lenovo-x60t) 01.212: Machine UUID c09ecb7b-2a1f-dc11-b88a-942d40962902 01.212: /7f677000\ Start thread 01.212: |7f677000| init usb 01.212: |7f677000| EHCI init on dev 00:1d.7 (regs=0xe4444020) 01.212: /7f675000\ Start thread 01.212: init ps2port 01.212: /7f674000\ Start thread 01.213: |7f674000| Copying data 8@0xffe27978 to 8@0x7f674fc8 01.213: /7f673000\ Start thread 01.214: init lpt 01.213: Found 0 lpt ports 01.213: init serial 01.213: Found 1 serial ports 01.213: init hard drives 01.213: ATA controller 1 at 1f0/3f4/0 (irq 14 dev f9) 01.214: /7f672000\ Start thread 01.213: /7f671000\ Start thread 01.214: ATA controller 2 at 170/374/0 (irq 15 dev f9) 01.214: /7f670000\ Start thread 01.214: |7f670000| powerup IDE floating 01.213: |7f670000| powerup IDE floating 01.213: |7f670000| powerup IDE floating 01.214: |7f670000| powerup IDE floating 01.214: \7f670000/ End thread 01.214: /7f670000\ Start thread 01.214: \7f671000/ End thread 01.214: \7f673000/ End thread 01.214: init ahci 01.214: AHCI controller at 1f.2, iobase e4444400, irq 0 01.214: AHCI: cap 0xdf12ff03, ports_impl 0x1 01.214: /7f673000\ Start thread 01.214: |7f673000| AHCI/0: probing 01.215: /7f671000\ Start thread 01.215: \7f670000/ End thread 01.215: |7f673000| AHCI/0: link up 01.215: |7f673000| AHCI/0: device ready (tf 0x150 cmd=6016 stat=113 ctl=0 err=0) 01.215: |7f672000| DVD/CD [ata0-0: DVD/CDRW UJDA775 ATAPI-5 DVD/CD] 01.215: |7f672000| Searching bootorder for: /pci@i0cf8/*@1f,1/drive@0/disk@0 01.215: |7f672000| Registering bootable: DVD/CD [ata0-0: DVD/CDRW UJDA775 ATAPI-5 DVD/CD] (type:3 prio:102 data:f1660) 01.215: \7f672000/ End thread 01.215: |7f674000| Got ps2 nak (status=51) 01.215: |7f674000| ps2 command 2ff failed (aux=0) 01.215: /7f672000\ Start thread 01.215: \7f671000/ End thread 01.215: |7f673000| AHCI/0: ... finished, status 0x51, ERROR 0x4 01.215: /7f671000\ Start thread 01.215: |7f673000| Searching bootorder for: /pci@i0cf8/*@1f,2/drive@0/disk@0 01.216: /7f670000\ Start thread 01.215: |7f673000| AHCI/0: registering: "AHCI/0: M4-CT256M4SSD2 ATA-9 Hard-Disk (238 GiBytes)" 01.216: |7f673000| Registering bootable: AHCI/0: M4-CT256M4SSD2 ATA-9 Hard-Disk (238 GiBytes) (type:2 prio:103 data:f1610) 01.215: \7f673000/ End thread 01.215: |7f674000| Got ps2 nak (status=51) 01.215: |7f674000| ps2 command 2ff failed (aux=0) 01.215: /7f673000\ Start thread 01.215: \7f670000/ End thread 01.215: \7f672000/ End thread 01.217: |7f674000| Got ps2 nak (status=51) 01.217: |7f674000| ps2 command 2ff failed (aux=0) 01.218: |7f674000| Got ps2 nak (status=51) 01.220: |7f674000| ps2 command 2ff failed (aux=0) 01.220: \7f673000/ End thread 01.222: |7f674000| Got ps2 nak (status=51) 01.222: |7f674000| ps2 command 2ff failed (aux=0) 01.224: |7f674000| Got ps2 nak (status=51) 01.225: |7f674000| ps2 command 2ff failed (aux=0) 01.226: |7f674000| Got ps2 nak (status=51) 01.227: |7f674000| ps2 command 2ff failed (aux=0) 01.228: |7f674000| Got ps2 nak (status=51) 01.229: |7f674000| ps2 command 2ff failed (aux=0) 01.229: |7f671000| set_address 0x7f676fb0 01.230: |7f677000| UHCI init on dev 00:1d.0 (io=5000) 01.230: /7f673000\ Start thread 01.230: /7f672000\ Start thread 01.230: \7f672000/ End thread 01.230: |7f671000| ehci_control 0x7f676ad0 (dir=0 cmd=8 data=0) 01.230: |7f677000| UHCI init on dev 00:1d.1 (io=5020) 01.230: /7f672000\ Start thread 01.230: /7f670000\ Start thread 01.230: \7f670000/ End thread 01.230: /7f670000\ Start thread 01.231: \7f670000/ End thread 01.230: |7f674000| Got ps2 nak (status=51) 01.230: |7f674000| ps2 command 2ff failed (aux=0) 01.230: |7f677000| UHCI init on dev 00:1d.2 (io=5040) 01.231: /7f670000\ Start thread 01.231: /7f66f000\ Start thread 01.230: \7f66f000/ End thread 01.231: /7f66f000\ Start thread 01.231: \7f66f000/ End thread 01.231: |7f671000| config_usb: 0x7f676ad0 01.231: |7f671000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=8) 01.231: |7f677000| UHCI init on dev 00:1d.3 (io=5060) 01.231: /7f66f000\ Start thread 01.231: /7f66e000\ Start thread 01.231: \7f66e000/ End thread 01.231: /7f66e000\ Start thread 01.231: \7f66e000/ End thread 01.231: \7f673000/ End thread 01.231: |7f671000| device rev=0200 cls=09 sub=00 proto=02 size=64 01.231: |7f671000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=9) 01.232: \7f677000/ End thread 01.231: /7f673000\ Start thread 01.231: \7f673000/ End thread 01.231: \7f672000/ End thread 01.231: |7f671000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=41) 01.231: |7f674000| Got ps2 nak (status=51) 01.231: |7f674000| ps2 command 2ff failed (aux=0) 01.232: \7f670000/ End thread 01.232: |7f671000| ehci_control 0x7f676ad0 (dir=0 cmd=8 data=0) 01.232: \7f66f000/ End thread 01.232: |7f671000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=7) 01.232: /7f673000\ Start thread 01.232: |7f673000| ehci_control 0x7f676ad0 (dir=0 cmd=8 data=0) 01.232: |7f674000| Got ps2 nak (status=51) 01.233: |7f674000| ps2 command 2ff failed (aux=0) 01.233: /7f672000\ Start thread 01.232: /7f670000\ Start thread 01.233: |7f670000| ehci_control 0x7f676ad0 (dir=0 cmd=8 data=0) 01.233: /7f66f000\ Start thread 01.233: |7f672000| ehci_control 0x7f676ad0 (dir=0 cmd=8 data=0) 01.233: |7f674000| Got ps2 nak (status=51) 01.233: |7f674000| ps2 command 2ff failed (aux=0) 01.233: |7f66f000| ehci_control 0x7f676ad0 (dir=0 cmd=8 data=0) 01.234: |7f674000| Got ps2 nak (status=51) 01.235: |7f674000| ps2 command 2ff failed (aux=0) 01.237: |7f674000| Got ps2 nak (status=51) 01.238: |7f674000| ps2 command 2ff failed (aux=0) 01.239: |7f674000| Got ps2 nak (status=51) 01.239: |7f674000| ps2 command 2ff failed (aux=0) 01.241: |7f674000| Got ps2 nak (status=51) 01.241: |7f674000| ps2 command 2ff failed (aux=0) 01.243: |7f674000| Got ps2 nak (status=51) 01.244: |7f674000| ps2 command 2ff failed (aux=0) 01.245: |7f674000| Got ps2 nak (status=51) 01.246: |7f674000| ps2 command 2ff failed (aux=0) 01.247: |7f674000| Got ps2 nak (status=51) 01.248: |7f674000| ps2 command 2ff failed (aux=0) 01.249: |7f674000| Got ps2 nak (status=51) 01.250: |7f674000| ps2 command 2ff failed (aux=0) 01.251: |7f673000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 01.252: |7f674000| Got ps2 nak (status=51) 01.252: |7f674000| ps2 command 2ff failed (aux=0) 01.252: |7f670000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 01.252: |7f673000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 01.252: |7f674000| Got ps2 nak (status=51) 01.252: |7f674000| ps2 command 2ff failed (aux=0) 01.253: |7f66f000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 01.253: |7f670000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 01.254: |7f674000| Got ps2 nak (status=51) 01.253: |7f674000| ps2 command 2ff failed (aux=0) 01.253: |7f672000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 01.253: |7f673000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 01.254: |7f66f000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 01.254: |7f674000| Got ps2 nak (status=51) 01.254: |7f674000| ps2 command 2ff failed (aux=0) 01.254: |7f670000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 01.254: |7f672000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 01.254: |7f673000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 01.255: |7f674000| Got ps2 nak (status=51) 01.255: |7f674000| ps2 command 2ff failed (aux=0) 01.255: |7f66f000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 01.255: |7f670000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 01.255: |7f674000| Got ps2 nak (status=51) 01.255: |7f674000| ps2 command 2ff failed (aux=0) 01.255: |7f672000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 01.256: |7f673000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 01.255: \7f673000/ End thread 01.256: |7f674000| Got ps2 nak (status=51) 01.256: |7f674000| ps2 command 2ff failed (aux=0) 01.256: |7f66f000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 01.257: \7f66f000/ End thread 01.256: |7f670000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 01.256: \7f670000/ End thread 01.257: |7f672000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 01.257: |7f674000| Got ps2 nak (status=51) 01.257: |7f674000| ps2 command 2ff failed (aux=0) 01.257: \7f672000/ End thread 01.258: |7f671000| Initialized USB HUB (0 ports used) 01.257: \7f671000/ End thread 01.259: |7f674000| Got ps2 nak (status=51) 01.259: |7f674000| ps2 command 2ff failed (aux=0) 01.259: \7f675000/ End thread 01.261: |7f674000| Got ps2 nak (status=51) 01.262: |7f674000| ps2 command 2ff failed (aux=0) 01.266: |7f674000| Got ps2 nak (status=51) 01.266: |7f674000| ps2 command 2ff failed (aux=0) 01.268: |7f674000| Got ps2 nak (status=51) 01.268: |7f674000| ps2 command 2ff failed (aux=0) 01.271: |7f674000| Got ps2 nak (status=51) 01.272: |7f674000| ps2 command 2ff failed (aux=0) 01.274: |7f674000| Got ps2 nak (status=51) 01.275: |7f674000| ps2 command 2ff failed (aux=0) 01.278: |7f674000| Got ps2 nak (status=51) 01.278: |7f674000| ps2 command 2ff failed (aux=0) 01.282: |7f674000| Got ps2 nak (status=51) 01.281: |7f674000| ps2 command 2ff failed (aux=0) 01.285: |7f674000| Got ps2 nak (status=51) 01.285: |7f674000| ps2 command 2ff failed (aux=0) 01.288: |7f674000| Got ps2 nak (status=51) 01.288: |7f674000| ps2 command 2ff failed (aux=0) 01.291: |7f674000| Got ps2 nak (status=51) 01.291: |7f674000| ps2 command 2ff failed (aux=0) 01.293: |7f674000| Got ps2 nak (status=51) 01.295: |7f674000| ps2 command 2ff failed (aux=0) 01.296: |7f674000| Got ps2 nak (status=51) 01.297: |7f674000| ps2 command 2ff failed (aux=0) 01.298: |7f674000| Got ps2 nak (status=51) 01.299: |7f674000| ps2 command 2ff failed (aux=0) 01.301: |7f674000| Got ps2 nak (status=51) 01.302: |7f674000| ps2 command 2ff failed (aux=0) 01.305: |7f674000| Got ps2 nak (status=51) 01.305: |7f674000| ps2 command 2ff failed (aux=0) 01.308: |7f674000| Got ps2 nak (status=51) 01.308: |7f674000| ps2 command 2ff failed (aux=0) 01.311: |7f674000| Got ps2 nak (status=51) 01.310: |7f674000| ps2 command 2ff failed (aux=0) 01.312: |7f674000| Got ps2 nak (status=51) 01.312: |7f674000| ps2 command 2ff failed (aux=0) 01.314: |7f674000| Got ps2 nak (status=51) 01.315: |7f674000| ps2 command 2ff failed (aux=0) 01.316: |7f674000| Got ps2 nak (status=51) 01.317: |7f674000| ps2 command 2ff failed (aux=0) 01.319: |7f674000| Got ps2 nak (status=51) 01.319: |7f674000| ps2 command 2ff failed (aux=0) 01.321: |7f674000| Got ps2 nak (status=51) 01.322: |7f674000| ps2 command 2ff failed (aux=0) 01.324: |7f674000| Got ps2 nak (status=51) 01.324: |7f674000| ps2 command 2ff failed (aux=0) 01.327: |7f674000| Got ps2 nak (status=51) 01.327: |7f674000| ps2 command 2ff failed (aux=0) 01.328: |7f674000| Got ps2 nak (status=51) 01.329: |7f674000| ps2 command 2ff failed (aux=0) 01.331: |7f674000| Got ps2 nak (status=51) 01.331: |7f674000| ps2 command 2ff failed (aux=0) 01.332: |7f674000| Got ps2 nak (status=51) 01.333: |7f674000| ps2 command 2ff failed (aux=0) 01.334: |7f674000| Got ps2 nak (status=51) 01.335: |7f674000| ps2 command 2ff failed (aux=0) 01.338: |7f674000| Got ps2 nak (status=51) 01.338: |7f674000| ps2 command 2ff failed (aux=0) 01.341: |7f674000| Got ps2 nak (status=51) 01.340: |7f674000| ps2 command 2ff failed (aux=0) 01.342: |7f674000| Got ps2 nak (status=51) 01.343: |7f674000| ps2 command 2ff failed (aux=0) 01.345: |7f674000| Got ps2 nak (status=51) 01.345: |7f674000| ps2 command 2ff failed (aux=0) 01.347: |7f674000| Got ps2 nak (status=51) 01.347: |7f674000| ps2 command 2ff failed (aux=0) 01.349: |7f674000| Got ps2 nak (status=51) 01.349: |7f674000| ps2 command 2ff failed (aux=0) 01.351: |7f674000| Got ps2 nak (status=51) 01.352: |7f674000| ps2 command 2ff failed (aux=0) 01.353: |7f674000| Got ps2 nak (status=51) 01.354: |7f674000| ps2 command 2ff failed (aux=0) 01.356: |7f674000| Got ps2 nak (status=51) 01.357: |7f674000| ps2 command 2ff failed (aux=0) 01.358: |7f674000| Got ps2 nak (status=51) 01.359: |7f674000| ps2 command 2ff failed (aux=0) 01.361: |7f674000| Got ps2 nak (status=51) 01.361: |7f674000| ps2 command 2ff failed (aux=0) 01.363: |7f674000| Got ps2 nak (status=51) 01.364: |7f674000| ps2 command 2ff failed (aux=0) 01.365: |7f674000| Got ps2 nak (status=51) 01.366: |7f674000| ps2 command 2ff failed (aux=0) 01.367: |7f674000| Got ps2 nak (status=51) 01.368: |7f674000| ps2 command 2ff failed (aux=0) 01.369: |7f674000| Got ps2 nak (status=51) 01.370: |7f674000| ps2 command 2ff failed (aux=0) 01.372: |7f674000| Got ps2 nak (status=51) 01.373: |7f674000| ps2 command 2ff failed (aux=0) 01.375: |7f674000| Got ps2 nak (status=51) 01.375: |7f674000| ps2 command 2ff failed (aux=0) 01.377: |7f674000| Got ps2 nak (status=51) 01.378: |7f674000| ps2 command 2ff failed (aux=0) 01.379: |7f674000| Got ps2 nak (status=51) 01.380: |7f674000| ps2 command 2ff failed (aux=0) 01.381: |7f674000| Discarding ps2 data aa (status=11) 01.993: |7f674000| PS2 keyboard initialized 01.993: \7f674000/ End thread 01.993: All threads complete. 01.993: Scan for option roms 01.993: Attempting to init PCI bdf 00:00.0 (vd 8086:27a0) 01.993: Attempting to init PCI bdf 00:02.1 (vd 8086:27a6) 01.993: Attempting to init PCI bdf 00:1b.0 (vd 8086:27d8) 01.993: Attempting to init PCI bdf 00:1c.0 (vd 8086:27d0) 01.993: Attempting to init PCI bdf 00:1c.1 (vd 8086:27d2) 01.993: Attempting to init PCI bdf 00:1c.2 (vd 8086:27d4) 01.993: Attempting to init PCI bdf 00:1c.3 (vd 8086:27d6) 01.993: Attempting to init PCI bdf 00:1d.0 (vd 8086:27c8) 01.993: Attempting to init PCI bdf 00:1d.1 (vd 8086:27c9) 01.993: Attempting to init PCI bdf 00:1d.2 (vd 8086:27ca) 01.993: Attempting to init PCI bdf 00:1d.3 (vd 8086:27cb) 01.993: Attempting to init PCI bdf 00:1d.7 (vd 8086:27cc) 01.993: Attempting to init PCI bdf 00:1e.0 (vd 8086:2448) 01.993: Attempting to init PCI bdf 00:1f.0 (vd 8086:27b9) 01.993: Attempting to init PCI bdf 00:1f.2 (vd 8086:27c5) 01.993: Attempting to init PCI bdf 00:1f.3 (vd 8086:27da) 01.994: Attempting to init PCI bdf 01:00.0 (vd 8086:109a) 01.994: Attempting to init PCI bdf 02:00.0 (vd 8086:4227) 01.994: Attempting to init PCI bdf 05:00.0 (vd 1180:0476) 01.993: Attempting to init PCI bdf 05:00.1 (vd 1180:0552) 01.994: Attempting to init PCI bdf 05:00.2 (vd 1180:0822) 01.993: 01.993: Press F12 for boot menu. 01.994: 01.994: Checking for bootsplash 04.525: Searching bootorder for: HALT 04.524: Mapping cd drive 0x000f1660 04.525: Mapping hd drive 0x000f1610 to 0 04.524: drive 0x000f1610: PCHS=16383/16/63 translation=lba LCHS=1024/255/63 s=500118192 04.525: finalize PMM 04.525: malloc finalize 04.525: Space available for UMB: cf000-ee800, f0000-f15e0 04.525: Returned 253952 bytes of ZoneHigh 04.525: e820 map has 6 items: 04.525: 0: 0000000000000000 - 000000000009fc00 = 1 RAM 04.525: 1: 000000000009fc00 - 00000000000a0000 = 2 RESERVED 04.525: 2: 00000000000f0000 - 0000000000100000 = 2 RESERVED 04.525: 3: 0000000000100000 - 000000007f6c2000 = 1 RAM 04.525: 4: 000000007f6c2000 - 0000000080000000 = 2 RESERVED 04.525: 5: 00000000f0000000 - 00000000f4000000 = 2 RESERVED 04.525: Jump to int19 04.526: enter handle_19: 04.526: NULL 04.525: Booting from DVD/CD... 04.526: Device reports MEDIUM NOT PRESENT 04.527: scsi_is_ready returned -1 04.527: Boot failed: Could not read from CDROM (code 0003) 04.527: enter handle_18: 04.527: NULL 04.527: Booting from Hard Disk... 04.527: Booting from 0000:7c00 ^C paul@mattotaupa:~/src/seabios(master) $ ./scripts/readserial.py /dev/ttyUSB0 115200
======= Fri Sep 19 09:00:25 2014 (adjust=86.8us) 00.000: <00> 01.375: Changing serial settings was 0/0 now 3/0 01.375: SeaBIOS (version rel-1.7.5-41-g4c32a80-20140919_084257-lenovo-x60t) 01.375: Attempting to find coreboot table 01.376: Found coreboot table forwarder. 01.376: Now attempting to find coreboot memory map 01.376: SeaBIOS (version rel-1.7.5-41-g4c32a80-20140919_084257-lenovo-x60t) 01.375: Found coreboot cbmem console @ 7f7de000 01.375: Found mainboard Lenovo ThinkPad X60 / X60s 01.375: malloc preinit 01.375: Relocating init from 0x000e6af0 to 0x7f679140 (size 44544) 01.375: malloc init 01.375: Found CBFS header at 0xfffffa50 01.375: Add romfile: cmos_layout.bin (size=1828) 01.375: Add romfile: pci8086,27a2.rom (size=65536) 01.375: Add romfile: cmos.default (size=256) 01.376: Add romfile: cpu_microcode_blob.bin (size=94208) 01.376: Add romfile: etc/ps2-keyboard-spinup (size=8) 01.375: Add romfile: config (size=4221) 01.376: Add romfile: (size=29976) 01.376: Add romfile: fallback/romstage (size=50939) 01.376: Add romfile: fallback/ramstage (size=68308) 01.376: Add romfile: fallback/payload (size=55704) 01.376: Add romfile: (size=1723864) 01.376: init ivt 01.376: init bda 01.376: init bios32 01.376: init PMM 01.376: init PNPBIOS table 01.376: init keyboard 01.377: init mouse 01.377: init pic 01.377: math cp init 01.377: CPU Mhz=1664 01.378: init timer 01.378: PCI probe 01.378: PCI device 00:00.0 (vd=8086:27a0 c=0600) 01.378: PCI device 00:02.0 (vd=8086:27a2 c=0300) 01.378: PCI device 00:02.1 (vd=8086:27a6 c=0380) 01.378: PCI device 00:1b.0 (vd=8086:27d8 c=0403) 01.378: PCI device 00:1c.0 (vd=8086:27d0 c=0604) 01.378: PCI device 00:1c.1 (vd=8086:27d2 c=0604) 01.378: PCI device 00:1c.2 (vd=8086:27d4 c=0604) 01.378: PCI device 00:1c.3 (vd=8086:27d6 c=0604) 01.378: PCI device 00:1d.0 (vd=8086:27c8 c=0c03) 01.378: PCI device 00:1d.1 (vd=8086:27c9 c=0c03) 01.379: PCI device 00:1d.2 (vd=8086:27ca c=0c03) 01.378: PCI device 00:1d.3 (vd=8086:27cb c=0c03) 01.378: PCI device 00:1d.7 (vd=8086:27cc c=0c03) 01.378: PCI device 00:1e.0 (vd=8086:2448 c=0604) 01.378: PCI device 00:1f.0 (vd=8086:27b9 c=0601) 01.378: PCI device 00:1f.1 (vd=8086:27df c=0101) 01.378: PCI device 00:1f.2 (vd=8086:27c5 c=0106) 01.378: PCI device 00:1f.3 (vd=8086:27da c=0c05) 01.378: PCI device 01:00.0 (vd=8086:109a c=0200) 01.378: PCI device 02:00.0 (vd=8086:4227 c=0280) 01.378: PCI device 05:00.0 (vd=1180:0476 c=0607) 01.378: PCI device 05:00.1 (vd=1180:0552 c=0c00) 01.378: PCI device 05:00.2 (vd=1180:0822 c=0805) 01.378: Found 23 PCI devices (max PCI bus is 06) 01.379: Relocating coreboot bios tables 01.380: Copying SMBIOS entry point from 0x7f7cc000 to 0x000f18d0 01.379: Copying ACPI RSDP from 0x7f7cd000 to 0x000f18a0 01.380: Copying MPTABLE from 0x7f7d9000/7f7d9010 to 0x000f16d0 01.380: rsdp=0x000f18a0 01.380: rsdt=0x7f7cd030 01.380: fadt=0x7f7d0510 01.380: pm_tmr_blk=508 01.380: Using pmtimer, ioport 0x508 01.380: Scan for VGA option rom 01.380: Attempting to init PCI bdf 00:02.0 (vd 8086:27a2) 01.380: Copying data 65536@0xffe007b8 to 65536@0x000c0000 01.413: Running option rom at c000:0003 01.460: unimplemented handle_155fXX:26: 01.461: a=80005f34 b=0000078f c=00000002 d=00000002 ds=0000 es=c000 ss=e000 01.461: si=00000994 di=00000080 bp=50a06e0c sp=0000ffe8 cs=c000 ip=4a6e f=0046 01.507: Turning on vga text mode console 01.539: SeaBIOS (version rel-1.7.5-41-g4c32a80-20140919_084257-lenovo-x60t) 01.539: Machine UUID c09ecb7b-2a1f-dc11-b88a-942d40962902 01.539: /7f677000\ Start thread 01.539: |7f677000| init usb 01.539: |7f677000| EHCI init on dev 00:1d.7 (regs=0xe4444020) 01.539: /7f675000\ Start thread 01.539: init ps2port 01.540: /7f674000\ Start thread 01.540: |7f674000| Copying data 8@0xffe27978 to 8@0x7f674fc8 01.541: /7f673000\ Start thread 01.541: init lpt 01.541: Found 0 lpt ports 01.541: init serial 01.541: Found 1 serial ports 01.541: init hard drives 01.541: ATA controller 1 at 1f0/3f4/0 (irq 14 dev f9) 01.541: /7f672000\ Start thread 01.541: /7f671000\ Start thread 01.542: ATA controller 2 at 170/374/0 (irq 15 dev f9) 01.541: /7f670000\ Start thread 01.541: |7f670000| powerup IDE floating 01.541: |7f670000| powerup IDE floating 01.541: |7f670000| powerup IDE floating 01.541: |7f670000| powerup IDE floating 01.541: \7f670000/ End thread 01.541: /7f670000\ Start thread 01.542: \7f671000/ End thread 01.541: \7f673000/ End thread 01.542: init ahci 01.541: AHCI controller at 1f.2, iobase e4444400, irq 0 01.541: AHCI: cap 0xdf12ff03, ports_impl 0x1 01.541: /7f673000\ Start thread 01.541: |7f673000| AHCI/0: probing 01.542: /7f671000\ Start thread 01.542: |7f673000| AHCI/0: link up 01.542: |7f672000| DVD/CD [ata0-0: DVD/CDRW UJDA775 ATAPI-5 DVD/CD] 01.542: |7f672000| Searching bootorder for: /pci@i0cf8/*@1f,1/drive@0/disk@0 01.543: |7f672000| Registering bootable: DVD/CD [ata0-0: DVD/CDRW UJDA775 ATAPI-5 DVD/CD] (type:3 prio:102 data:f1660) 01.542: \7f672000/ End thread 01.542: |7f674000| Got ps2 nak (status=51) 01.542: |7f674000| ps2 command 2ff failed (aux=0) 01.542: /7f672000\ Start thread 01.542: \7f671000/ End thread 01.542: \7f670000/ End thread 01.542: /7f671000\ Start thread 01.542: /7f670000\ Start thread 01.543: |7f674000| Got ps2 nak (status=51) 01.543: |7f674000| ps2 command 2ff failed (aux=0) 01.543: /7f66f000\ Start thread 01.544: \7f672000/ End thread 01.545: |7f674000| Got ps2 nak (status=51) 01.545: |7f674000| ps2 command 2ff failed (aux=0) 01.545: \7f670000/ End thread 01.548: |7f674000| Got ps2 nak (status=51) 01.548: |7f674000| ps2 command 2ff failed (aux=0) 01.548: \7f66f000/ End thread 01.548: |7f674000| Got ps2 nak (status=51) 01.549: |7f674000| ps2 command 2ff failed (aux=0) 01.551: |7f674000| Got ps2 nak (status=51) 01.551: |7f674000| ps2 command 2ff failed (aux=0) 01.554: |7f674000| Got ps2 nak (status=51) 01.554: |7f674000| ps2 command 2ff failed (aux=0) 01.555: |7f674000| Got ps2 nak (status=51) 01.555: |7f674000| ps2 command 2ff failed (aux=0) 01.557: |7f674000| Got ps2 nak (status=51) 01.558: |7f674000| ps2 command 2ff failed (aux=0) 01.560: |7f674000| Got ps2 nak (status=51) 01.560: |7f674000| ps2 command 2ff failed (aux=0) 01.560: |7f671000| set_address 0x7f676fb0 01.560: |7f677000| UHCI init on dev 00:1d.0 (io=5000) 01.560: /7f672000\ Start thread 01.560: /7f670000\ Start thread 01.560: \7f670000/ End thread 01.560: |7f671000| ehci_control 0x7f676350 (dir=0 cmd=8 data=0) 01.560: |7f677000| UHCI init on dev 00:1d.1 (io=5020) 01.560: /7f670000\ Start thread 01.560: /7f66f000\ Start thread 01.560: \7f66f000/ End thread 01.560: /7f66f000\ Start thread 01.560: \7f66f000/ End thread 01.560: |7f674000| Got ps2 nak (status=51) 01.561: |7f674000| ps2 command 2ff failed (aux=0) 01.561: |7f677000| UHCI init on dev 00:1d.2 (io=5040) 01.561: /7f66f000\ Start thread 01.561: /7f66e000\ Start thread 01.561: \7f66e000/ End thread 01.561: /7f66e000\ Start thread 01.561: \7f66e000/ End thread 01.561: |7f671000| config_usb: 0x7f676350 01.561: |7f671000| ehci_control 0x7f676350 (dir=128 cmd=8 data=8) 01.561: |7f677000| UHCI init on dev 00:1d.3 (io=5060) 01.561: /7f66d000\ Start thread 01.561: /7f66c000\ Start thread 01.561: \7f66c000/ End thread 01.561: /7f66c000\ Start thread 01.561: \7f66c000/ End thread 01.561: \7f672000/ End thread 01.562: |7f671000| device rev=0200 cls=09 sub=00 proto=02 size=64 01.561: |7f671000| ehci_control 0x7f676350 (dir=128 cmd=8 data=9) 01.561: \7f677000/ End thread 01.561: /7f66c000\ Start thread 01.561: \7f66c000/ End thread 01.561: \7f670000/ End thread 01.562: |7f671000| ehci_control 0x7f676350 (dir=128 cmd=8 data=41) 01.561: |7f674000| Got ps2 nak (status=51) 01.561: |7f674000| ps2 command 2ff failed (aux=0) 01.562: \7f66f000/ End thread 01.562: |7f671000| ehci_control 0x7f676350 (dir=0 cmd=8 data=0) 01.562: \7f66d000/ End thread 01.562: |7f671000| ehci_control 0x7f676350 (dir=128 cmd=8 data=7) 01.562: /7f672000\ Start thread 01.562: |7f672000| ehci_control 0x7f676350 (dir=0 cmd=8 data=0) 01.563: |7f674000| Got ps2 nak (status=51) 01.562: |7f674000| ps2 command 2ff failed (aux=0) 01.564: /7f670000\ Start thread 01.564: /7f66f000\ Start thread 01.564: |7f66f000| ehci_control 0x7f676350 (dir=0 cmd=8 data=0) 01.563: /7f66e000\ Start thread 01.563: |7f670000| ehci_control 0x7f676350 (dir=0 cmd=8 data=0) 01.563: |7f674000| Got ps2 nak (status=51) 01.564: |7f674000| ps2 command 2ff failed (aux=0) 01.564: |7f66e000| ehci_control 0x7f676350 (dir=0 cmd=8 data=0) 01.565: |7f674000| Got ps2 nak (status=51) 01.565: |7f674000| ps2 command 2ff failed (aux=0) 01.566: |7f674000| Got ps2 nak (status=51) 01.567: |7f674000| ps2 command 2ff failed (aux=0) 01.568: |7f674000| Got ps2 nak (status=51) 01.570: |7f674000| ps2 command 2ff failed (aux=0) 01.572: |7f674000| Got ps2 nak (status=51) 01.573: |7f674000| ps2 command 2ff failed (aux=0) 01.575: |7f674000| Got ps2 nak (status=51) 01.575: |7f674000| ps2 command 2ff failed (aux=0) 01.576: |7f674000| Got ps2 nak (status=51) 01.577: |7f674000| ps2 command 2ff failed (aux=0) 01.578: |7f674000| Got ps2 nak (status=51) 01.579: |7f674000| ps2 command 2ff failed (aux=0) 01.580: |7f674000| Got ps2 nak (status=51) 01.581: |7f674000| ps2 command 2ff failed (aux=0) 01.581: |7f672000| ehci_control 0x7f676350 (dir=128 cmd=8 data=4) 01.582: |7f674000| Got ps2 nak (status=51) 01.582: |7f674000| ps2 command 2ff failed (aux=0) 01.583: |7f66f000| ehci_control 0x7f676350 (dir=128 cmd=8 data=4) 01.583: |7f672000| ehci_control 0x7f676350 (dir=128 cmd=8 data=4) 01.583: |7f674000| Got ps2 nak (status=51) 01.583: |7f674000| ps2 command 2ff failed (aux=0) 01.584: |7f66e000| ehci_control 0x7f676350 (dir=128 cmd=8 data=4) 01.584: |7f66f000| ehci_control 0x7f676350 (dir=128 cmd=8 data=4) 01.584: |7f674000| Got ps2 nak (status=51) 01.584: |7f674000| ps2 command 2ff failed (aux=0) 01.584: |7f670000| ehci_control 0x7f676350 (dir=128 cmd=8 data=4) 01.585: |7f672000| ehci_control 0x7f676350 (dir=128 cmd=8 data=4) 01.584: |7f66e000| ehci_control 0x7f676350 (dir=128 cmd=8 data=4) 01.584: |7f674000| Got ps2 nak (status=51) 01.584: |7f674000| ps2 command 2ff failed (aux=0) 01.584: |7f66f000| ehci_control 0x7f676350 (dir=128 cmd=8 data=4) 01.585: |7f670000| ehci_control 0x7f676350 (dir=128 cmd=8 data=4) 01.585: |7f672000| ehci_control 0x7f676350 (dir=128 cmd=8 data=4) 01.585: |7f674000| Got ps2 nak (status=51) 01.586: |7f674000| ps2 command 2ff failed (aux=0) 01.586: |7f66e000| ehci_control 0x7f676350 (dir=128 cmd=8 data=4) 01.586: |7f66f000| ehci_control 0x7f676350 (dir=128 cmd=8 data=4) 01.587: |7f674000| Got ps2 nak (status=51) 01.586: |7f674000| ps2 command 2ff failed (aux=0) 01.586: |7f670000| ehci_control 0x7f676350 (dir=128 cmd=8 data=4) 01.587: |7f672000| ehci_control 0x7f676350 (dir=128 cmd=8 data=4) 01.587: \7f672000/ End thread 01.587: |7f674000| Got ps2 nak (status=51) 01.587: |7f674000| ps2 command 2ff failed (aux=0) 01.587: |7f66e000| ehci_control 0x7f676350 (dir=128 cmd=8 data=4) 01.588: \7f66e000/ End thread 01.587: |7f66f000| ehci_control 0x7f676350 (dir=128 cmd=8 data=4) 01.588: \7f66f000/ End thread 01.588: |7f670000| ehci_control 0x7f676350 (dir=128 cmd=8 data=4) 01.588: |7f674000| Got ps2 nak (status=51) 01.588: |7f674000| ps2 command 2ff failed (aux=0) 01.588: \7f670000/ End thread 01.588: |7f671000| Initialized USB HUB (0 ports used) 01.589: \7f671000/ End thread 01.590: |7f674000| Got ps2 nak (status=51) 01.591: |7f674000| ps2 command 2ff failed (aux=0) 01.591: \7f675000/ End thread 01.592: |7f674000| Got ps2 nak (status=51) 01.593: |7f674000| ps2 command 2ff failed (aux=0) 01.596: |7f674000| Got ps2 nak (status=51) 01.597: |7f674000| ps2 command 2ff failed (aux=0) 01.600: |7f674000| Got ps2 nak (status=51) 01.601: |7f674000| ps2 command 2ff failed (aux=0) 01.604: |7f674000| Got ps2 nak (status=51) 01.660: |7f674000| ps2 command 2ff failed (aux=0) 01.660: |7f674000| Got ps2 nak (status=51) 01.660: |7f674000| ps2 command 2ff failed (aux=0) 01.660: |7f674000| Got ps2 nak (status=51) 01.660: |7f674000| ps2 command 2ff failed (aux=0) 01.660: |7f674000| Got ps2 nak (status=51) 01.660: |7f674000| ps2 command 2ff failed (aux=0) 01.660: |7f674000| Got ps2 nak (status=51) 01.660: |7f674000| ps2 command 2ff failed (aux=0) 01.660: |7f674000| Got ps2 nak (status=51) 01.660: |7f674000| ps2 command 2ff failed (aux=0) 01.660: |7f674000| Got ps2 nak (status=51) 01.660: |7f674000| ps2 command 2ff failed (aux=0) 01.660: |7f674000| Got ps2 nak (status=51) 01.660: |7f674000| ps2 command 2ff failed (aux=0) 01.660: |7f674000| Got ps2 nak (status=51) 01.660: |7f674000| ps2 command 2ff failed (aux=0) 01.660: |7f674000| Got ps2 nak (status=51) 01.660: |7f674000| ps2 command 2ff failed (aux=0) 01.660: |7f674000| Got ps2 nak (status=51) 01.660: |7f674000| ps2 command 2ff failed (aux=0) 01.660: |7f674000| Got ps2 nak (status=51) 01.660: |7f674000| ps2 command 2ff failed (aux=0) 01.660: |7f674000| Got ps2 nak (status=51) 01.660: |7f674000| ps2 command 2ff failed (aux=0) 01.660: |7f674000| Got ps2 nak (status=51) 01.660: |7f674000| ps2 command 2ff failed (aux=0) 01.660: |7f674000| Got ps2 nak (status=51) 01.660: |7f674000| ps2 command 2ff failed (aux=0) 01.660: |7f674000| Got ps2 nak (status=51) 01.660: |7f674000| ps2 command 2ff failed (aux=0) 01.660: |7f674000| Got ps2 nak (status=51) 01.660: |7f674000| ps2 command 2ff failed (aux=0) 01.660: |7f674000| Got ps2 nak (status=51) 01.660: |7f674000| ps2 command 2ff failed (aux=0) 01.660: |7f674000| Got ps2 nak (status=51) 01.660: |7f674000| ps2 command 2ff failed (aux=0) 01.660: |7f674000| Got ps2 nak (status=51) 01.660: |7f674000| ps2 command 2ff failed (aux=0) 01.660: |7f674000| Got ps2 nak (status=51) 01.661: |7f674000| ps2 command 2ff failed (aux=0) 01.662: |7f674000| Got ps2 nak (status=51) 01.663: |7f674000| ps2 command 2ff failed (aux=0) 01.665: |7f674000| Got ps2 nak (status=51) 01.665: |7f674000| ps2 command 2ff failed (aux=0) 01.667: |7f674000| Got ps2 nak (status=51) 01.667: |7f674000| ps2 command 2ff failed (aux=0) 01.669: |7f674000| Got ps2 nak (status=51) 01.670: |7f674000| ps2 command 2ff failed (aux=0) 01.671: |7f674000| Got ps2 nak (status=51) 01.672: |7f674000| ps2 command 2ff failed (aux=0) 01.674: |7f674000| Got ps2 nak (status=51) 01.674: |7f674000| ps2 command 2ff failed (aux=0) 01.677: |7f674000| Got ps2 nak (status=51) 01.677: |7f674000| ps2 command 2ff failed (aux=0) 01.680: |7f674000| Got ps2 nak (status=51) 01.681: |7f674000| ps2 command 2ff failed (aux=0) 01.682: |7f674000| Got ps2 nak (status=51) 01.683: |7f674000| ps2 command 2ff failed (aux=0) 01.684: |7f674000| Got ps2 nak (status=51) 01.685: |7f674000| ps2 command 2ff failed (aux=0) 01.686: |7f674000| Got ps2 nak (status=51) 01.687: |7f674000| ps2 command 2ff failed (aux=0) 01.689: |7f674000| Got ps2 nak (status=51) 01.689: |7f674000| ps2 command 2ff failed (aux=0) 01.692: |7f674000| Got ps2 nak (status=51) 01.692: |7f674000| ps2 command 2ff failed (aux=0) 01.695: |7f674000| Got ps2 nak (status=51) 01.695: |7f674000| ps2 command 2ff failed (aux=0) 01.697: |7f674000| Got ps2 nak (status=51) 01.697: |7f674000| ps2 command 2ff failed (aux=0) 01.699: |7f674000| Got ps2 nak (status=51) 01.700: |7f674000| ps2 command 2ff failed (aux=0) 01.701: |7f674000| Got ps2 nak (status=51) 01.702: |7f674000| ps2 command 2ff failed (aux=0) 01.703: |7f674000| Got ps2 nak (status=51) 01.704: |7f674000| ps2 command 2ff failed (aux=0) 01.705: |7f674000| Got ps2 nak (status=51) 01.706: |7f674000| ps2 command 2ff failed (aux=0) 01.708: |7f674000| Got ps2 nak (status=51) 01.709: |7f674000| ps2 command 2ff failed (aux=0) 01.710: |7f674000| Got ps2 nak (status=51) 01.711: |7f674000| ps2 command 2ff failed (aux=0) 01.712: |7f674000| Got ps2 nak (status=51) 01.713: |7f674000| ps2 command 2ff failed (aux=0) 01.715: |7f674000| Got ps2 nak (status=51) 01.715: |7f674000| ps2 command 2ff failed (aux=0) 01.716: |7f674000| Got ps2 nak (status=51) 01.717: |7f674000| ps2 command 2ff failed (aux=0) 01.719: |7f674000| Got ps2 nak (status=51) 01.720: |7f674000| ps2 command 2ff failed (aux=0) 01.721: |7f674000| Discarding ps2 data aa (status=13) 02.334: |7f674000| PS2 keyboard initialized 02.334: \7f674000/ End thread 32.700: |7f673000| WARNING - Timeout at ahci_port_setup:466! 32.700: |7f673000| AHCI/0: device not ready (tf 0x80 cmd=6016 stat=113 ctl=0 err=4050002) 33.201: |7f673000| WARNING - Timeout at ahci_port_reset:336! 33.201: \7f673000/ End thread 33.201: All threads complete. 33.201: Scan for option roms 33.201: Attempting to init PCI bdf 00:00.0 (vd 8086:27a0) 33.201: Attempting to init PCI bdf 00:02.1 (vd 8086:27a6) 33.201: Attempting to init PCI bdf 00:1b.0 (vd 8086:27d8) 33.201: Attempting to init PCI bdf 00:1c.0 (vd 8086:27d0) 33.201: Attempting to init PCI bdf 00:1c.1 (vd 8086:27d2) 33.201: Attempting to init PCI bdf 00:1c.2 (vd 8086:27d4) 33.201: Attempting to init PCI bdf 00:1c.3 (vd 8086:27d6) 33.201: Attempting to init PCI bdf 00:1d.0 (vd 8086:27c8) 33.201: Attempting to init PCI bdf 00:1d.1 (vd 8086:27c9) 33.201: Attempting to init PCI bdf 00:1d.2 (vd 8086:27ca) 33.201: Attempting to init PCI bdf 00:1d.3 (vd 8086:27cb) 33.201: Attempting to init PCI bdf 00:1d.7 (vd 8086:27cc) 33.201: Attempting to init PCI bdf 00:1e.0 (vd 8086:2448) 33.201: Attempting to init PCI bdf 00:1f.0 (vd 8086:27b9) 33.201: Attempting to init PCI bdf 00:1f.2 (vd 8086:27c5) 33.201: Attempting to init PCI bdf 00:1f.3 (vd 8086:27da) 33.201: Attempting to init PCI bdf 01:00.0 (vd 8086:109a) 33.201: Attempting to init PCI bdf 02:00.0 (vd 8086:4227) 33.201: Attempting to init PCI bdf 05:00.0 (vd 1180:0476) 33.201: Attempting to init PCI bdf 05:00.1 (vd 1180:0552) 33.201: Attempting to init PCI bdf 05:00.2 (vd 1180:0822) 33.200: 33.200: Press F12 for boot menu. 33.201: 33.201: Checking for bootsplash 35.766: Searching bootorder for: HALT 35.767: Mapping cd drive 0x000f1660 35.767: finalize PMM 35.766: malloc finalize 35.767: Space available for UMB: cf000-ee800, f0000-f1630 35.767: Returned 262144 bytes of ZoneHigh 35.767: e820 map has 6 items: 35.767: 0: 0000000000000000 - 000000000009fc00 = 1 RAM 35.767: 1: 000000000009fc00 - 00000000000a0000 = 2 RESERVED 35.767: 2: 00000000000f0000 - 0000000000100000 = 2 RESERVED 35.767: 3: 0000000000100000 - 000000007f6c4000 = 1 RAM 35.767: 4: 000000007f6c4000 - 0000000080000000 = 2 RESERVED 35.767: 5: 00000000f0000000 - 00000000f4000000 = 2 RESERVED 35.767: Jump to int19 35.768: enter handle_19: 35.767: NULL 35.767: Booting from DVD/CD... 35.768: Device reports MEDIUM NOT PRESENT 35.769: scsi_is_ready returned -1 35.769: Boot failed: Could not read from CDROM (code 0003) 35.769: enter handle_18: 35.769: NULL 35.769: Booting from Floppy... 35.770: invalid handle_legacy_disk:696: 35.769: a=00000201 b=00000000 c=00000001 d=00000000 ds=0000 es=07c0 ss=e000 35.769: si=00000000 di=00000000 bp=00000000 sp=0000ffe8 cs=f000 ip=d066 f=0202 35.769: Boot failed: could not read the boot disk 35.769: 35.769: enter handle_18: 35.769: NULL 35.769: Booting from Hard Disk... 35.769: invalid handle_legacy_disk:696: 35.769: a=00000201 b=00000000 c=00000001 d=00000080 ds=0000 es=07c0 ss=e000 35.769: si=00000000 di=00000000 bp=00000000 sp=0000ffe8 cs=f000 ip=d066 f=0202 35.769: Boot failed: could not read the boot disk 35.769: 35.769: enter handle_18: 35.769: NULL 35.769: No bootable device. Retrying in 60 seconds. 49.082: In resume (status=0) 49.082: In 32bit resume 49.082: Attempting a hard reboot 49.308: <00> 49.748: <00> 50.483: Changing serial settings was 0/0 now 3/0 50.483: SeaBIOS (version rel-1.7.5-41-g4c32a80-20140919_084257-lenovo-x60t) 50.483: Attempting to find coreboot table 50.484: Found coreboot table forwarder. 50.484: Now attempting to find coreboot memory map 50.484: SeaBIOS (version rel-1.7.5-41-g4c32a80-20140919_084257-lenovo-x60t) 50.483: Found coreboot cbmem console @ 7f7de000 50.483: Found mainboard Lenovo ThinkPad X60 / X60s 50.483: malloc preinit 50.483: Relocating init from 0x000e6af0 to 0x7f679140 (size 44544) 50.483: malloc init 50.483: Found CBFS header at 0xfffffa50 50.483: Add romfile: cmos_layout.bin (size=1828) 50.483: Add romfile: pci8086,27a2.rom (size=65536) 50.483: Add romfile: cmos.default (size=256) 50.483: Add romfile: cpu_microcode_blob.bin (size=94208) 50.483: Add romfile: etc/ps2-keyboard-spinup (size=8) 50.483: Add romfile: config (size=4221) 50.483: Add romfile: (size=29976) 50.483: Add romfile: fallback/romstage (size=50939) 50.483: Add romfile: fallback/ramstage (size=68308) 50.483: Add romfile: fallback/payload (size=55704) 50.484: Add romfile: (size=1723864) 50.483: init ivt 50.483: init bda 50.484: init bios32 50.484: init PMM 50.484: init PNPBIOS table 50.484: init keyboard 50.484: init mouse 50.484: init pic 50.484: math cp init 50.485: CPU Mhz=1665 50.485: init timer 50.486: PCI probe 50.485: PCI device 00:00.0 (vd=8086:27a0 c=0600) 50.485: PCI device 00:02.0 (vd=8086:27a2 c=0300) 50.485: PCI device 00:02.1 (vd=8086:27a6 c=0380) 50.486: PCI device 00:1b.0 (vd=8086:27d8 c=0403) 50.486: PCI device 00:1c.0 (vd=8086:27d0 c=0604) 50.486: PCI device 00:1c.1 (vd=8086:27d2 c=0604) 50.486: PCI device 00:1c.2 (vd=8086:27d4 c=0604) 50.486: PCI device 00:1c.3 (vd=8086:27d6 c=0604) 50.486: PCI device 00:1d.0 (vd=8086:27c8 c=0c03) 50.486: PCI device 00:1d.1 (vd=8086:27c9 c=0c03) 50.486: PCI device 00:1d.2 (vd=8086:27ca c=0c03) 50.486: PCI device 00:1d.3 (vd=8086:27cb c=0c03) 50.486: PCI device 00:1d.7 (vd=8086:27cc c=0c03) 50.486: PCI device 00:1e.0 (vd=8086:2448 c=0604) 50.486: PCI device 00:1f.0 (vd=8086:27b9 c=0601) 50.486: PCI device 00:1f.1 (vd=8086:27df c=0101) 50.486: PCI device 00:1f.2 (vd=8086:27c5 c=0106) 50.486: PCI device 00:1f.3 (vd=8086:27da c=0c05) 50.486: PCI device 01:00.0 (vd=8086:109a c=0200) 50.486: PCI device 02:00.0 (vd=8086:4227 c=0280) 50.486: PCI device 05:00.0 (vd=1180:0476 c=0607) 50.486: PCI device 05:00.1 (vd=1180:0552 c=0c00) 50.486: PCI device 05:00.2 (vd=1180:0822 c=0805) 50.486: Found 23 PCI devices (max PCI bus is 06) 50.486: Relocating coreboot bios tables 50.487: Copying SMBIOS entry point from 0x7f7cc000 to 0x000f18d0 50.487: Copying ACPI RSDP from 0x7f7cd000 to 0x000f18a0 50.487: Copying MPTABLE from 0x7f7d9000/7f7d9010 to 0x000f16d0 50.488: rsdp=0x000f18a0 50.488: rsdt=0x7f7cd030 50.488: fadt=0x7f7d0510 50.488: pm_tmr_blk=508 50.488: Using pmtimer, ioport 0x508 50.488: Scan for VGA option rom 50.488: Attempting to init PCI bdf 00:02.0 (vd 8086:27a2) 50.488: Copying data 65536@0xffe007b8 to 65536@0x000c0000 50.522: Running option rom at c000:0003 50.568: unimplemented handle_155fXX:26: 50.568: a=80005f34 b=0000078f c=00000002 d=00000002 ds=0000 es=c000 ss=e000 50.569: si=00000994 di=00000080 bp=50a06e0c sp=0000ffe8 cs=c000 ip=4a6e f=0046 50.615: Turning on vga text mode console 50.646: SeaBIOS (version rel-1.7.5-41-g4c32a80-20140919_084257-lenovo-x60t) 50.647: Machine UUID c09ecb7b-2a1f-dc11-b88a-942d40962902 50.647: /7f677000\ Start thread 50.647: |7f677000| init usb 50.647: |7f677000| EHCI init on dev 00:1d.7 (regs=0xe4444020) 50.647: /7f675000\ Start thread 50.647: init ps2port 50.647: /7f674000\ Start thread 50.648: |7f674000| Copying data 8@0xffe27978 to 8@0x7f674fc8 50.648: /7f673000\ Start thread 50.648: init lpt 50.648: Found 0 lpt ports 50.648: init serial 50.648: Found 1 serial ports 50.648: init hard drives 50.648: ATA controller 1 at 1f0/3f4/0 (irq 14 dev f9) 50.649: /7f672000\ Start thread 50.649: /7f671000\ Start thread 50.649: ATA controller 2 at 170/374/0 (irq 15 dev f9) 50.648: /7f670000\ Start thread 50.648: |7f670000| powerup IDE floating 50.648: |7f670000| powerup IDE floating 50.648: |7f670000| powerup IDE floating 50.648: |7f670000| powerup IDE floating 50.648: \7f670000/ End thread 50.649: /7f670000\ Start thread 50.649: \7f671000/ End thread 50.649: \7f673000/ End thread 50.649: init ahci 50.649: AHCI controller at 1f.2, iobase e4444400, irq 0 50.649: AHCI: cap 0xdf12ff03, ports_impl 0x1 50.649: /7f673000\ Start thread 50.649: |7f673000| AHCI/0: probing 50.650: /7f671000\ Start thread 50.650: \7f670000/ End thread 50.650: |7f673000| AHCI/0: link up 50.649: |7f673000| AHCI/0: device ready (tf 0x150 cmd=6016 stat=113 ctl=0 err=0) 50.649: |7f672000| DVD/CD [ata0-0: DVD/CDRW UJDA775 ATAPI-5 DVD/CD] 50.650: |7f672000| Searching bootorder for: /pci@i0cf8/*@1f,1/drive@0/disk@0 50.649: |7f672000| Registering bootable: DVD/CD [ata0-0: DVD/CDRW UJDA775 ATAPI-5 DVD/CD] (type:3 prio:102 data:f1660) 50.650: \7f672000/ End thread 50.650: /7f672000\ Start thread 50.650: \7f671000/ End thread 50.650: |7f673000| AHCI/0: ... finished, status 0x51, ERROR 0x4 50.649: /7f671000\ Start thread 50.650: |7f673000| Searching bootorder for: /pci@i0cf8/*@1f,2/drive@0/disk@0 50.650: /7f670000\ Start thread 50.650: |7f673000| AHCI/0: registering: "AHCI/0: M4-CT256M4SSD2 ATA-9 Hard-Disk (238 GiBytes)" 50.650: |7f673000| Registering bootable: AHCI/0: M4-CT256M4SSD2 ATA-9 Hard-Disk (238 GiBytes) (type:2 prio:103 data:f1610) 50.650: \7f673000/ End thread 50.650: /7f673000\ Start thread 50.650: \7f670000/ End thread 50.650: \7f672000/ End thread 50.665: \7f673000/ End thread 50.698: |7f671000| set_address 0x7f676fb0 50.698: |7f677000| UHCI init on dev 00:1d.0 (io=5000) 50.698: /7f673000\ Start thread 50.698: /7f672000\ Start thread 50.698: \7f672000/ End thread 50.698: |7f671000| ehci_control 0x7f676ad0 (dir=0 cmd=8 data=0) 50.698: |7f677000| UHCI init on dev 00:1d.1 (io=5020) 50.698: /7f672000\ Start thread 50.698: /7f670000\ Start thread 50.698: \7f670000/ End thread 50.698: /7f670000\ Start thread 50.698: \7f670000/ End thread 50.698: |7f677000| UHCI init on dev 00:1d.2 (io=5040) 50.698: /7f670000\ Start thread 50.698: /7f66f000\ Start thread 50.698: \7f66f000/ End thread 50.698: /7f66f000\ Start thread 50.698: \7f66f000/ End thread 50.698: |7f671000| config_usb: 0x7f676ad0 50.698: |7f671000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=8) 50.699: |7f677000| UHCI init on dev 00:1d.3 (io=5060) 50.698: /7f66f000\ Start thread 50.698: /7f66e000\ Start thread 50.698: \7f66e000/ End thread 50.698: /7f66e000\ Start thread 50.698: \7f66e000/ End thread 50.699: \7f673000/ End thread 50.698: |7f671000| device rev=0200 cls=09 sub=00 proto=02 size=64 50.698: |7f671000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=9) 50.698: \7f677000/ End thread 50.698: /7f673000\ Start thread 50.698: \7f673000/ End thread 50.699: \7f672000/ End thread 50.698: |7f671000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=41) 50.699: \7f670000/ End thread 50.699: |7f671000| ehci_control 0x7f676ad0 (dir=0 cmd=8 data=0) 50.699: \7f66f000/ End thread 50.698: |7f671000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=7) 50.698: /7f673000\ Start thread 50.699: |7f673000| ehci_control 0x7f676ad0 (dir=0 cmd=8 data=0) 50.699: /7f672000\ Start thread 50.699: /7f670000\ Start thread 50.699: |7f670000| ehci_control 0x7f676ad0 (dir=0 cmd=8 data=0) 50.699: /7f66f000\ Start thread 50.699: |7f672000| ehci_control 0x7f676ad0 (dir=0 cmd=8 data=0) 50.699: |7f66f000| ehci_control 0x7f676ad0 (dir=0 cmd=8 data=0) 50.780: |7f673000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 50.783: |7f670000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 50.784: |7f672000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 50.784: |7f673000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 50.785: |7f66f000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 50.784: |7f670000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 50.784: |7f672000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 50.784: |7f673000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 50.785: |7f66f000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 50.785: |7f670000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 50.784: |7f672000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 50.784: |7f673000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 50.784: |7f66f000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 50.784: |7f670000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 50.784: |7f672000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 50.784: |7f673000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 50.785: |7f66f000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 50.784: |7f670000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 50.784: |7f672000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 50.785: |7f673000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 50.785: \7f673000/ End thread 50.784: |7f66f000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 50.785: |7f670000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 50.785: \7f670000/ End thread 50.785: |7f672000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 50.785: \7f672000/ End thread 50.785: |7f66f000| ehci_control 0x7f676ad0 (dir=128 cmd=8 data=4) 50.785: \7f66f000/ End thread 50.785: |7f671000| Initialized USB HUB (0 ports used) 50.785: \7f671000/ End thread 50.788: \7f675000/ End thread 50.937: |7f674000| PS2 keyboard initialized 50.937: \7f674000/ End thread 50.937: All threads complete. 50.937: Scan for option roms 50.937: Attempting to init PCI bdf 00:00.0 (vd 8086:27a0) 50.938: Attempting to init PCI bdf 00:02.1 (vd 8086:27a6) 50.938: Attempting to init PCI bdf 00:1b.0 (vd 8086:27d8) 50.938: Attempting to init PCI bdf 00:1c.0 (vd 8086:27d0) 50.937: Attempting to init PCI bdf 00:1c.1 (vd 8086:27d2) 50.937: Attempting to init PCI bdf 00:1c.2 (vd 8086:27d4) 50.938: Attempting to init PCI bdf 00:1c.3 (vd 8086:27d6) 50.937: Attempting to init PCI bdf 00:1d.0 (vd 8086:27c8) 50.937: Attempting to init PCI bdf 00:1d.1 (vd 8086:27c9) 50.937: Attempting to init PCI bdf 00:1d.2 (vd 8086:27ca) 50.937: Attempting to init PCI bdf 00:1d.3 (vd 8086:27cb) 50.938: Attempting to init PCI bdf 00:1d.7 (vd 8086:27cc) 50.937: Attempting to init PCI bdf 00:1e.0 (vd 8086:2448) 50.937: Attempting to init PCI bdf 00:1f.0 (vd 8086:27b9) 50.937: Attempting to init PCI bdf 00:1f.2 (vd 8086:27c5) 50.937: Attempting to init PCI bdf 00:1f.3 (vd 8086:27da) 50.937: Attempting to init PCI bdf 01:00.0 (vd 8086:109a) 50.938: Attempting to init PCI bdf 02:00.0 (vd 8086:4227) 50.937: Attempting to init PCI bdf 05:00.0 (vd 1180:0476) 50.937: Attempting to init PCI bdf 05:00.1 (vd 1180:0552) 50.938: Attempting to init PCI bdf 05:00.2 (vd 1180:0822) 50.938: 50.938: Press F12 for boot menu. 50.937: 50.937: Checking for bootsplash 53.465: Searching bootorder for: HALT 53.466: Mapping cd drive 0x000f1660 53.466: Mapping hd drive 0x000f1610 to 0 53.466: drive 0x000f1610: PCHS=16383/16/63 translation=lba LCHS=1024/255/63 s=500118192 53.466: finalize PMM 53.466: malloc finalize 53.466: Space available for UMB: cf000-ee800, f0000-f15e0 53.466: Returned 253952 bytes of ZoneHigh 53.466: e820 map has 6 items: 53.466: 0: 0000000000000000 - 000000000009fc00 = 1 RAM 53.466: 1: 000000000009fc00 - 00000000000a0000 = 2 RESERVED 53.465: 2: 00000000000f0000 - 0000000000100000 = 2 RESERVED 53.466: 3: 0000000000100000 - 000000007f6c2000 = 1 RAM 53.466: 4: 000000007f6c2000 - 0000000080000000 = 2 RESERVED 53.466: 5: 00000000f0000000 - 00000000f4000000 = 2 RESERVED 53.467: Jump to int19 53.466: enter handle_19: 53.466: NULL 53.466: Booting from DVD/CD... 53.467: Device reports MEDIUM NOT PRESENT 53.468: scsi_is_ready returned -1 53.468: Boot failed: Could not read from CDROM (code 0003) 53.468: enter handle_18: 53.468: NULL 53.468: Booting from Hard Disk... 53.468: Booting from 0000:7c00
Paul Menzel wrote:
I was told coreboot and SeaBIOS are too fast for the SSD and it needs at least 500 ms for its initialization.
Though looking at the code in `src/hw/ahci.c`, it should have 32 seconds to initialize.
The SSD can probably not deal with any SATA activity until it has initialized correctly. That's probably an SSD firmware bug.
//Peter
On Fri, Sep 19, 2014 at 09:36:30AM +0200, Paul Menzel wrote:
01.542: init ahci 01.541: AHCI controller at 1f.2, iobase e4444400, irq 0 01.541: AHCI: cap 0xdf12ff03, ports_impl 0x1 01.541: /7f673000\ Start thread 01.541: |7f673000| AHCI/0: probing 01.542: |7f673000| AHCI/0: link up […] 32.700: |7f673000| WARNING - Timeout at ahci_port_setup:466! 32.700: |7f673000| AHCI/0: device not ready (tf 0x80 cmd=6016 stat=113 ctl=0 err=4050002)
The err field indicates the controller thinks the device disconnected and then reconnected. Possibly the firmware on the ssd was resetting itself (or something similar).
Can you see if a more recent firmware version is available for your SSD? Otherwise, it looks like this could be worked around in SeaBIOS, but it wouldn't be particularly nice.
-Kevin
Am Freitag, den 19.09.2014, 11:47 -0400 schrieb Kevin O'Connor:
On Fri, Sep 19, 2014 at 09:36:30AM +0200, Paul Menzel wrote:
01.542: init ahci 01.541: AHCI controller at 1f.2, iobase e4444400, irq 0 01.541: AHCI: cap 0xdf12ff03, ports_impl 0x1 01.541: /7f673000\ Start thread 01.541: |7f673000| AHCI/0: probing 01.542: |7f673000| AHCI/0: link up […] 32.700: |7f673000| WARNING - Timeout at ahci_port_setup:466! 32.700: |7f673000| AHCI/0: device not ready (tf 0x80 cmd=6016 stat=113 ctl=0 err=4050002)
The err field indicates the controller thinks the device disconnected and then reconnected. Possibly the firmware on the ssd was resetting itself (or something similar).
Can you see if a more recent firmware version is available for your SSD?
Upgrading the firmware from 0309 to 070H seems to have fixed the issue. The drive is now detected on cold boot.
Otherwise, it looks like this could be worked around in SeaBIOS, but it wouldn't be particularly nice.
Some message on the screen informing the user about a bad device could be helpful, though currently the Crucial m4 is the only device, this is needed for.
One or several attached drives could not be correctly initialized. This could be a problem with the hardware or the drive firmware. Please check the hardware on a different system or update the firmware and try again.
Thanks,
Paul
Paul Menzel wrote:
Some message on the screen informing the user about a bad device could be helpful,
It is a bad idea for SeaBIOS, or any software really, to try to guess why hardware is not working. Reporting errors is good, pretending to know what they mean is not.
//Peter