[SeaBIOS] [coreboot] i945: AHCI timeout with Crucial m4 SSD 2.5 in SeaBIOS on cold boot

Paul Menzel paulepanter at users.sourceforge.net
Tue Sep 16 23:34:51 CEST 2014


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 at 0xffe007b8 to 65536 at 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 at 0xffe27978 to 8 at 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 at i0cf8/*@1f,1/drive at 0/disk at 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 at 0xffe007b8 to 65536 at 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 at 0xffe27978 to 8 at 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 at i0cf8/*@1f,1/drive at 0/disk at 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 at i0cf8/*@1f,2/drive at 0/disk at 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
-------------- next part --------------
A non-text attachment was scrubbed...
Name: signature.asc
Type: application/pgp-signature
Size: 181 bytes
Desc: This is a digitally signed message part
URL: <http://www.seabios.org/pipermail/seabios/attachments/20140916/8bff85fa/attachment-0001.asc>


More information about the SeaBIOS mailing list