[SeaBIOS] USB timeout on ALIX.2C2 (CS5536)

Thu Jan 12 15:53:32 CET 2017

On Thu, Jan 12, 2017 at 4:45 PM, Kevin O'Connor <kevin at koconnor.net> wrote:

> On Wed, Jan 11, 2017 at 09:23:00AM +0200, Евгени Димитров wrote:
> > On Tue, Jan 10, 2017 at 7:14 PM, Kevin O'Connor <kevin at koconnor.net>
> wrote:
> >
> > > On Mon, Jan 09, 2017 at 09:31:22AM +0200, Евгени Димитров wrote:
> > > > On Fri, Jan 6, 2017 at 4:46 PM, Kevin O'Connor <kevin at koconnor.net>
> > > wrote:
> > > > > Are you trying to boot from the "Multimedia Card Reader" or from a
> > > > > regular USB flash drive?  If you're not booting from the card
> reader,
> > > > > does the patch below help?
> > > >
> > > > I was trying to boot from whatever USB devices I can get my hands on.
> > > > Ultimately my goal is to boot from a regular flash drive. The patch
> > > doesn't
> > > > help.
> > >
> > > I'm not sure what is happening - it looks like the controller is
> > > shutting down, but it's unclear why.  What do you get with the patch
> > > below?
>
> The additional debugging reports the controller is running and not
> reporting an error (which is in addition to the transfer descriptor
> reporting that it is also running without error).  I'm not sure what
> is going on.  Can you try disabling CONFIG_MALLOC_UPPERMEMORY and
> retry?
>
> -Kevin
>

That did it. Do you think it's safe to just leave this option off?
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://www.coreboot.org/pipermail/seabios/attachments/20170112/faf6cab8/attachment.html>
-------------- next part --------------
SeaBIOS (version rel-1.10.0-10-g9332965-dirty-20170112_164929-cactus)
init usb
Copying data 8 at 0xfffad1b8 to 8 at 0x00006ebc
phys_alloc zone=0x0f773ed0 size=32 align=10 ret=f7688c0 (detail=0x0f768890)
EHCI init on dev 00:0f.5 (regs=0xfe017010)
phys_alloc zone=0x0f773ed0 size=4096 align=1000 ret=f767000 (detail=0x0f768860)
/0f767000\ Start thread
|0f767000| phys_alloc zone=0x0f773edc size=4096 align=1000 ret=f7b3000 (detail=0x0f768830)
|0f767000| phys_alloc zone=0x0f773edc size=68 align=80 ret=f7b2f80 (detail=0x0f768800)
|0f767000| phys_alloc zone=0x0f773edc size=68 align=80 ret=f7b2f00 (detail=0x0f7687d0)
phys_alloc zone=0x0f773ed0 size=20 align=10 ret=f7687b0 (detail=0x0f768780)
OHCI init on dev 00:0f.4 (regs=0xfe016000)
phys_alloc zone=0x0f773ed0 size=4096 align=1000 ret=f766000 (detail=0x0f768750)
/0f766000\ Start thread
|0f766000| phys_alloc zone=0x0f773edc size=256 align=100 ret=f7b2e00 (detail=0x0f768720)
|0f766000| phys_alloc zone=0x0f773edc size=16 align=10 ret=f7b2ff0 (detail=0x0f7686f0)
|0f767000| phys_alloc zone=0x0f773ed0 size=28 align=10 ret=f7686d0 (detail=0x0f7686a0)
|0f767000| phys_alloc zone=0x0f773ed0 size=4096 align=1000 ret=f765000 (detail=0x0f768670)
/0f765000\ Start thread
init ps2port
phys_alloc zone=0x0f773ed0 size=4096 align=1000 ret=f764000 (detail=0x0f768640)
/0f764000\ Start thread
|0f764000| i8042_flush
|0f764000| i8042 flushed ff (status=ff)
|0f764000| i8042 flushed ff (status=ff)
|0f764000| i8042 flushed ff (status=ff)
|0f764000| i8042 flushed ff (status=ff)
|0f764000| i8042 flushed ff (status=ff)
|0f764000| i8042 flushed ff (status=ff)
|0f764000| i8042 flushed ff (status=ff)
|0f764000| i8042 flushed ff (status=ff)
|0f764000| i8042 flushed ff (status=ff)
|0f764000| i8042 flushed ff (status=ff)
|0f764000| i8042 flushed ff (status=ff)
|0f764000| i8042 flushed ff (status=ff)
|0f764000| i8042 flushed ff (status=ff)
|0f764000| i8042 flushed ff (status=ff)
|0f764000| i8042 flushed ff (status=ff)
|0f764000| i8042 flushed ff (status=ff)
|0f764000| WARNING - Timeout at i8042_flush:71!
\0f764000/ End thread
phys_free f764000 (detail=0x0f768640)
|0f767000| phys_alloc zone=0x0f773ed0 size=28 align=10 ret=f768650 (detail=0x0f768620)
|0f767000| phys_alloc zone=0x0f773ed0 size=4096 align=1000 ret=f764000 (detail=0x0f7685f0)
/0f764000\ Start thread
init floppy drives
init hard drives
phys_alloc zone=0x0f773ed8 size=20 align=10 ret=f6000 (detail=0x0f7685c0)
ATA controller 1 at 1f0/3f4/0 (irq 14 dev 7a)
phys_alloc zone=0x0f773ed0 size=4096 align=1000 ret=f763000 (detail=0x0f768590)
/0f763000\ Start thread
|0f763000| powerup iobase=1f0 st=50
|0f763000| powerup iobase=1f0 st=50
|0f763000| ata_detect ata0-0: sc=55 sn=aa dh=a0
|0f763000| ata_reset drive=0x0f763dc0
|0f766000| phys_alloc zone=0x0f773ed0 size=28 align=10 ret=f768570 (detail=0x0f768540)
|0f766000| phys_alloc zone=0x0f773ed0 size=4096 align=1000 ret=f762000 (detail=0x0f768510)
/0f762000\ Start thread
|0f767000| phys_alloc zone=0x0f773ed0 size=28 align=10 ret=f7684f0 (detail=0x0f7684c0)
|0f767000| phys_alloc zone=0x0f773ed0 size=4096 align=1000 ret=f761000 (detail=0x0f768490)
/0f761000\ Start thread
phys_alloc zone=0x0f773ed8 size=20 align=10 ret=f5fe0 (detail=0x0f768460)
ATA controller 2 at 170/374/0 (irq 15 dev 7a)
phys_alloc zone=0x0f773ed0 size=4096 align=1000 ret=f760000 (detail=0x0f768430)
/0f760000\ Start thread
|0f760000| powerup IDE floating
|0f760000| powerup IDE floating
|0f760000| ata_detect ata1-0: sc=ff sn=ff dh=ff
|0f760000| powerup IDE floating
|0f760000| powerup IDE floating
|0f760000| ata_detect ata1-1: sc=ff sn=ff dh=ff
\0f760000/ End thread
phys_free f760000 (detail=0x0f768430)
|0f763000| ata_reset exit status=50
|0f766000| phys_alloc zone=0x0f773ed0 size=28 align=10 ret=f768440 (detail=0x0f768410)
|0f766000| phys_alloc zone=0x0f773ed0 size=4096 align=1000 ret=f760000 (detail=0x0f7683e0)
/0f760000\ Start thread
|0f767000| phys_alloc zone=0x0f773ed0 size=28 align=10 ret=f7683c0 (detail=0x0f768390)
|0f767000| phys_alloc zone=0x0f773ed0 size=4096 align=1000 ret=f75f000 (detail=0x0f768360)
/0f75f000\ Start thread
init ahci
init megasas
init lpt
Found 0 lpt ports
init serial
Found 2 serial ports
|0f763000| send_cmd : read error (status=51 err=04)
|0f766000| phys_alloc zone=0x0f773ed0 size=28 align=10 ret=f768340 (detail=0x0f768310)
|0f766000| phys_alloc zone=0x0f773ed0 size=4096 align=1000 ret=f75e000 (detail=0x0f7682e0)
/0f75e000\ Start thread
|0f764000| set_address 0x0f7688c0
|0f766000| phys_alloc zone=0x0f773ed0 size=28 align=10 ret=f7682c0 (detail=0x0f768290)
|0f766000| phys_alloc zone=0x0f773ed0 size=4096 align=1000 ret=f75d000 (detail=0x0f768260)
/0f75d000\ Start thread
|0f764000| ehci_alloc_async_pipe 0x0f7688c0 0
|0f764000| phys_alloc zone=0x0f773ed0 size=92 align=80 ret=f768200 (detail=0x0f7681d0)
|0f764000| ehci_send_pipe qh=0x0f768200 dir=0 data=0x00000000 size=0
|0f764000| ehci_alloc_async_pipe 0x0f7688c0 0
|0f764000| config_usb: 0x0f768250
|0f764000| ehci_send_pipe qh=0x0f768200 dir=128 data=0x0f764fb6 size=8
|0f764000| device rev=0210 cls=00 sub=00 proto=00 size=64
|0f764000| ehci_alloc_async_pipe 0x0f7688c0 0
|0f764000| ehci_send_pipe qh=0x0f768200 dir=128 data=0x0f764fc8 size=9
|0f763000| phys_alloc zone=0x0f773ed8 size=44 align=10 ret=f5fb0 (detail=0x0f7681a0)
|0f763000| phys_alloc zone=0x0f773ed0 size=80 align=10 ret=f768150 (detail=0x0f768120)
|0f763000| ata0-0: STI Flash 8.0.0 ATA-0 Hard-Disk (61 MiBytes)
|0f763000| Searching bootorder for: /pci at i0cf8/*@f,2/drive at 0/disk at 0
|0f763000| phys_alloc zone=0x0f773ed0 size=24 align=10 ret=f768100 (detail=0x0f7680d0)
|0f763000| Registering bootable: ata0-0: STI Flash 8.0.0 ATA-0 Hard-Disk (61 MiBytes) (type:2 prio:103 data:f5fb0)
|0f763000| ata_detect resetresult=0000
|0f763000| powerup iobase=1f0 st=50
|0f763000| powerup iobase=1f0 st=0
|0f763000| ata_detect ata0-1: sc=55 sn=aa dh=b0
|0f763000| send_cmd : DRQ not set (status 00)
\0f763000/ End thread
phys_free f763000 (detail=0x0f768590)
|0f764000| phys_alloc zone=0x0f773ed0 size=32 align=10 ret=f7685a0 (detail=0x0f7680a0)
|0f764000| ehci_send_pipe qh=0x0f768200 dir=128 data=0x0f7685a0 size=32
|0f764000| ehci_send_pipe qh=0x0f768200 dir=0 data=0x00000000 size=0
|0f764000| ehci_alloc_async_pipe 0x0f7688c0 2
|0f764000| phys_alloc zone=0x0f773ee0 size=92 align=80 ret=9f700 (detail=0x0f768070)
|0f764000| ehci_alloc_async_pipe 0x0f7688c0 2
|0f764000| phys_alloc zone=0x0f773ee0 size=92 align=80 ret=9f680 (detail=0x0f768040)
|0f764000| ehci_send_pipe qh=0x0f768200 dir=128 data=0x0f764fae size=1
|0f764000| phys_alloc zone=0x0f773ed8 size=48 align=10 ret=f5f80 (detail=0x0f768010)
|0f764000| Searching bootorder for: /pci at i0cf8/usb at f,5/storage at 2/*@0/*@0,0
|0f764000| Searching bootorder for: /pci at i0cf8/usb at f,5/usb-*@2
|0f764000| ehci_send_pipe qh=0x0009f680 dir=0 data=0x0f764e81 size=31
|0f764000| ehci_send_pipe qh=0x0009f700 dir=128 data=0x0f764f4c size=36
|0f764000| ehci_send_pipe qh=0x0009f700 dir=128 data=0x0f764e74 size=13
|0f764000| USB MSC vendor='Kingston' product='DataTraveler 3.0' rev='PMAP' type=0 removable=1
|0f764000| scsi_is_ready (drive=0x000f5f80)
|0f764000| ehci_send_pipe qh=0x0009f680 dir=0 data=0x0f764e45 size=31
|0f764000| ehci_send_pipe qh=0x0009f700 dir=128 data=0x0f764e38 size=13
|0f764000| ehci_send_pipe qh=0x0009f680 dir=0 data=0x0f764e81 size=31
|0f764000| ehci_send_pipe qh=0x0009f700 dir=128 data=0x0f764f06 size=8
|0f764000| ehci_send_pipe qh=0x0009f700 dir=128 data=0x0f764e74 size=13
|0f764000| USB MSC blksize=512 sectors=15138816
|0f764000| phys_alloc zone=0x0f773ed0 size=80 align=10 ret=f763fb0 (detail=0x0f763f80)
|0f764000| phys_alloc zone=0x0f773ed0 size=24 align=10 ret=f763f60 (detail=0x0f763f30)
|0f764000| Registering bootable: USB MSC Drive Kingston DataTraveler 3.0 PMAP (type:2 prio:103 data:f5f80)
|0f764000| phys_free f7685a0 (detail=0x0f7680a0)
|0f764000| phys_free f768650 (detail=0x0f768620)
\0f764000/ End thread
phys_free f764000 (detail=0x0f7685f0)
|0f765000| phys_free f7686d0 (detail=0x0f7686a0)
\0f765000/ End thread
phys_free f765000 (detail=0x0f768670)
|0f75f000| phys_free f7683c0 (detail=0x0f768390)
\0f75f000/ End thread
phys_free f75f000 (detail=0x0f768360)
|0f761000| phys_free f7684f0 (detail=0x0f7684c0)
\0f761000/ End thread
phys_free f761000 (detail=0x0f768490)
|0f767000| ehci_free_pipes 0x0f7688c0
|0f767000| phys_free f768200 (detail=0x0f7681d0)
\0f767000/ End thread
phys_free f767000 (detail=0x0f768860)
|0f75d000| phys_free f7682c0 (detail=0x0f768290)
\0f75d000/ End thread
phys_free f75d000 (detail=0x0f768260)
|0f75e000| phys_free f768340 (detail=0x0f768310)
\0f75e000/ End thread
phys_free f75e000 (detail=0x0f7682e0)
|0f760000| phys_free f768440 (detail=0x0f768410)
\0f760000/ End thread
phys_free f760000 (detail=0x0f7683e0)
|0f762000| phys_free f768570 (detail=0x0f768540)
\0f762000/ End thread
phys_free f762000 (detail=0x0f768510)
|0f766000| ohci_free_pipes 0x0f7687b0
|0f766000| phys_free f7b2e00 (detail=0x0f768720)
|0f766000| phys_free f7b2ff0 (detail=0x0f7686f0)
\0f766000/ End thread
phys_free f766000 (detail=0x0f768750)
All threads complete.
Scan for option roms
Attempting to init PCI bdf 00:01.0 (vd 1022:2080)
Attempting to map option rom on dev 00:01.0
Option rom sizing returned 0 0
Attempting to init PCI bdf 00:01.2 (vd 1022:2082)
Attempting to map option rom on dev 00:01.2
Option rom sizing returned 0 0
Attempting to init PCI bdf 00:09.0 (vd 1106:3053)
Attempting to map option rom on dev 00:09.0
Option rom sizing returned 0 0
Attempting to init PCI bdf 00:0b.0 (vd 1006:3053)
Attempting to map option rom on dev 00:0b.0
Option rom sizing returned 0 0
Attempting to init PCI bdf 00:0f.0 (vd 1022:2090)
Attempting to map option rom on dev 00:0f.0
Option rom sizing returned 0 0
Attempting to init PCI bdf 00:0f.2 (vd 1022:209a)
Attempting to map option rom on dev 00:0f.2
Option rom sizing returned 0 0

Press ESC for boot menu.

Select boot device:

1. ata0-0: STI Flash 8.0.0 ATA-0 Hard-Disk (61 MiBytes)
2. USB MSC Drive Kingston DataTraveler 3.0 PMAP