I've improved the ec_debug code (and attached the update) so the init
subsystem is reported, and it correctly deals with potential vprintk()
buffer over-runs by flushing the ec_messages buffer in blocks of no more
than 1020 characters. I added a dump_stack() followed by mdelay() but
even with the video camera recording it the reports scroll up the screen
far too fast (and blurred) to be readable even on freeze-frame.

>From a successful session however, here's the relevant part:

[   45.084736] ACPI: bus type pci registered
[   45.084867] PCI: Using configuration type 1
[   45.086043] ACPI: EC:  acpi_init acpi_ec_ecdt_probe()
[   45.086045] ACPI: EC:  acpi_init make_acpi_ec()
[   45.086046] ACPI: EC: Look up EC in DSDT
[   45.092877] ACPI: Interpreter enabled
[   45.092939] ACPI: (supports S0 S3 S4 S5)
[   45.093194] ACPI: Using IOAPIC for interrupt routing
[   45.093362] ACPI: EC:  acpi_scan_init acpi_boot_ec_enable()
[   45.093363] ACPI: EC:  acpi_scan_init acpi_boot_ec_enable() call 
ec_install_handlers(boot_ec)
[   45.093364] ACPI: EC:  acpi_scan_init ec_install_handlers(<ec>) 
ec->handlers_installed=0
[   45.093365] ACPI: EC:  acpi_scan_init ec_install_handlers() 
acpi_install_gpe_handler() succeeded
[   45.093400] ACPI: EC:  acpi_scan_init acpi_ec_space_handler(<args...>)
[   45.093402] ACPI: EC:  acpi_scan_init acpi_ec_read(<ec>, <address>, <data>)
[   45.093403] ACPI: EC:  acpi_scan_init acpi_ec_transaction(<ec>, 128, 
<wdata>, 1, <rdata>, 1, 0)
[   45.093404] ACPI: EC:  acpi_scan_init acpi_ec_wait(<ec>, 2, 0)
[   45.093405] ACPI: EC:  acpi_scan_init acpi_ec_wait() else
[   45.093408] ACPI: EC:  acpi_scan_init acpi_ec_transaction_unlocked(<ec>, 
128, <wdata>, 1, <rdata>, 1, 0)
[   45.093411] ACPI: EC:  acpi_scan_init acpi_ec_wait(<ec>, 2, 0)
[   45.093412] ACPI: EC:  acpi_scan_init acpi_ec_wait() else
[   45.093559] ACPI: EC:  acpi_scan_init acpi_ec_wait(<ec>, 1, 0)
[   45.093560] ACPI: EC:  acpi_scan_init acpi_ec_wait() else
[   45.093618] ACPI: EC:  acpi_scan_init acpi_ec_gpe_handler(<data>)
[   45.093622] ACPI: EC: non-query interrupt received, switching to interrupt 
mode
[   45.093930] ACPI: EC:  acpi_scan_init acpi_ec_gpe_handler(<data>)
[   45.093942] ACPI: EC:  acpi_scan_init acpi_ec_space_handler(<args...>)
[   45.093943] ACPI: EC:  acpi_scan_init acpi_ec_read(<ec>, <address>, <data>)
[   45.093944] ACPI: EC:  acpi_scan_init acpi_ec_transaction(<ec>, 128, 
<wdata>, 1, <rdata>, 1, 0)
[   45.093945] ACPI: EC:  acpi_scan_init acpi_ec_wait(<ec>, 2, 0)
[   45.093948] ACPI: EC:  acpi_scan_init acpi_ec_transaction_unlocked(<ec>, 
128, <wdata>, 1, <rdata>, 1, 0)
[   45.093951] ACPI: EC:  acpi_scan_init acpi_ec_wait(<ec>, 2, 0)
[   45.094339] ACPI: EC:  acpi_scan_init acpi_ec_gpe_handler(<data>)
[   45.094350] ACPI: EC:  acpi_scan_init acpi_ec_wait(<ec>, 1, 0)
[   45.094777] ACPI: EC:  acpi_scan_init acpi_ec_gpe_handler(<data>)
[   45.094800] ACPI: EC:  acpi_scan_init acpi_ec_space_handler(<args...>)
[   45.094801] ACPI: EC:  acpi_scan_init acpi_ec_read(<ec>, <address>, <data>)
[   45.094802] ACPI: EC:  acpi_scan_init acpi_ec_transaction(<ec>, 128, 
<wdata>, 1, <rdata>, 1, 0)
[   45.094803] ACPI: EC:  acpi_scan_init acpi_ec_wait(<ec>, 2, 0)
[   45.094806] ACPI: EC:  acpi_scan_init acpi_ec_transaction_unlocked(<ec>, 
128, <wdata>, 1, <rdata>, 1, 0)
[   45.094809] ACPI: EC:  acpi_scan_init acpi_ec_wait(<ec>, 2, 0)
[   45.095173] ACPI: EC:  acpi_scan_init acpi_ec_gpe_handler(<data>)
[   45.095185] ACPI: EC:  acpi_scan_init acpi_ec_wait(<ec>, 1, 0)
[   45.095484] ACPI: EC:  acpi_scan_init acpi_ec_gpe_handler(<data>)
[   45.095551] ACPI: EC:  acpi_scan_init acpi_ec_space_handler(<args...>)
[   45.095552] ACPI: EC:  acpi_scan_init acpi_ec_read(<ec>, <address>, <data>)
[   45.095553] ACPI: EC:  acpi_scan_init acpi_ec_transaction(<ec>, 128, 
<wdata>, 1, <rdata>, 1, 0)
[   45.095554] ACPI: EC:  acpi_scan_init acpi_ec_wait(<ec>, 2, 0)
[   45.095557] ACPI: EC:  acpi_scan_init acpi_ec_transaction_unlocked(<ec>, 
128, <wdata>, 1, <rdata>, 1, 0)
[   45.095560] ACPI: EC:  acpi_scan_init acpi_ec_wait(<ec>, 2, 0)
[   45.095767] ACPI: EC:  acpi_scan_init acpi_ec_gpe_handler(<data>)
[   45.095778] ACPI: EC:  acpi_scan_init acpi_ec_wait(<ec>, 1, 0)
[   45.096217] ACPI: EC:  acpi_scan_init acpi_ec_gpe_handler(<data>)
[   45.096235] ACPI: EC:  acpi_scan_init acpi_ec_space_handler(<args...>)
[   45.096236] ACPI: EC:  acpi_scan_init acpi_ec_read(<ec>, <address>, <data>)
[   45.096237] ACPI: EC:  acpi_scan_init acpi_ec_transaction(<ec>, 128, 
<wdata>, 1, <rdata>, 1, 0)
[   45.096238] ACPI: EC:  acpi_scan_init acpi_ec_wait(<ec>, 2, 0)
[   45.096241] ACPI: EC:  acpi_scan_init acpi_ec_transaction_unlocked(<ec>, 
128, <wdata>, 1, <rdata>, 1, 0)
[   45.096244] ACPI: EC:  acpi_scan_init acpi_ec_wait(<ec>, 2, 0)
[   45.096598] ACPI: EC:  acpi_scan_init acpi_ec_gpe_handler(<data>)
[   45.096609] ACPI: EC:  acpi_scan_init acpi_ec_wait(<ec>, 1, 0)
[   45.096925] ACPI: EC:  acpi_scan_init acpi_ec_gpe_handler(<data>)
[   45.102523] ACPI: EC:  acpi_scan_init acpi_ec_space_handler(<args...>)
[   45.102524] ACPI: EC:  acpi_scan_init acpi_ec_read(<ec>, <address>, <data>)
[   45.102525] ACPI: EC:  acpi_scan_init acpi_ec_transaction(<ec>, 128, 
<wdata>, 1, <rdata>, 1, 0)
[   45.102526] ACPI: EC:  acpi_scan_init acpi_ec_wait(<ec>, 2, 0)
[   45.102529] ACPI: EC:  acpi_scan_init acpi_ec_transaction_unlocked(<ec>, 
128, <wdata>, 1, <rdata>, 1, 0)
[   45.102532] ACPI: EC:  acpi_scan_init acpi_ec_wait(<ec>, 2, 0)
[   45.102762] ACPI: EC:  acpi_scan_init acpi_ec_gpe_handler(<data>)
[   45.102773] ACPI: EC:  acpi_scan_init acpi_ec_wait(<ec>, 1, 0)
[   45.103199] ACPI: EC:  acpi_scan_init acpi_ec_gpe_handler(<data>)
[   45.110516] ACPI: EC:  acpi_scan_init acpi_ec_space_handler(<args...>)
[   45.110518] ACPI: EC:  acpi_scan_init acpi_ec_read(<ec>, <address>, <data>)
[   45.110518] ACPI: EC:  acpi_scan_init acpi_ec_transaction(<ec>, 128, 
<wdata>, 1, <rdata>, 1, 0)
[   45.110520] ACPI: EC:  acpi_scan_init acpi_ec_wait(<ec>, 2, 0)
[   45.110523] ACPI: EC:  acpi_scan_init acpi_ec_transaction_unlocked(<ec>, 
128, <wdata>, 1, <rdata>, 1, 0)
[   45.110526] ACPI: EC:  acpi_scan_init acpi_ec_wait(<ec>, 2, 0)
[   45.110893] ACPI: EC:  acpi_scan_init acpi_ec_gpe_handler(<data>)
[   45.110904] ACPI: EC:  acpi_scan_init acpi_ec_wait(<ec>, 1, 0)
[   45.111204] ACPI: EC:  acpi_scan_init acpi_ec_gpe_handler(<data>)
[   45.111305] ACPI: EC:  acpi_scan_init acpi_ec_space_handler(<args...>)
[   45.111307] ACPI: EC:  acpi_scan_init acpi_ec_read(<ec>, <address>, <data>)
[   45.111307] ACPI: EC:  acpi_scan_init acpi_ec_transaction(<ec>, 128, 
<wdata>, 1, <rdata>, 1, 0)
[   45.111309] ACPI: EC:  acpi_scan_init acpi_ec_wait(<ec>, 2, 0)
[   45.111312] ACPI: EC:  acpi_scan_init acpi_ec_transaction_unlocked(<ec>, 
128, <wdata>, 1, <rdata>, 1, 0)
[   45.111315] ACPI: EC:  acpi_scan_init acpi_ec_wait(<ec>, 2, 0)
[   45.111567] ACPI: EC:  acpi_scan_init acpi_ec_gpe_handler(<data>)
[   45.115479] ACPI: EC: GPE = 0x17, I/O: command/status = 0x66, data = 0x62
[   45.115544] ACPI: EC: driver started in interrupt mode
[   45.123068] ACPI: PCI Root Bridge [PCI0] (0000:00)
[   45.123898] PCI quirk: region 1000-107f claimed by ICH6 ACPI/GPIO/TCO
[   45.123965] PCI quirk: region 1180-11bf claimed by ICH6 GPIO
[   45.125346] PCI: Transparent bridge - 0000:00:1e.0
[   45.125500] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT]
[   45.125776] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PEGP._PRT]
[   45.125894] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.RP01._PRT]
[   45.126006] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.RP02._PRT]
[   45.126118] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.RP03._PRT]
[   45.126230] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.RP04._PRT]
[   45.126358] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PCIB._PRT]
[   45.132718] ACPI: PCI Interrupt Link [LNKA] (IRQs 1 3 4 5 6 *7 10 12 14 15)
[   45.133425] ACPI: PCI Interrupt Link [LNKB] (IRQs 1 *3 4 5 6 7 11 12 14 15)
[   45.134128] ACPI: PCI Interrupt Link [LNKC] (IRQs 1 3 4 5 6 7 10 12 14 15) 
*11
[   45.134888] ACPI: PCI Interrupt Link [LNKD] (IRQs 1 3 4 5 6 7 11 12 14 15) 
*10
[   45.135642] ACPI: PCI Interrupt Link [LNKE] (IRQs 1 3 4 5 6 7 10 12 14 15) 
*11
[   45.136398] ACPI: PCI Interrupt Link [LNKF] (IRQs 1 3 4 5 6 *7 11 12 14 15)
[   45.137097] ACPI: PCI Interrupt Link [LNKG] (IRQs 1 3 *4 5 6 7 10 12 14 15)
[   45.137799] ACPI: PCI Interrupt Link [LNKH] (IRQs 3 4 *5 6 7 11 12 14 15)
[   45.138526] Linux Plug and Play Support v0.97 (c) Adam Belay
[   45.138620] pnp: PnP ACPI init
[   45.138686] ACPI: bus type pnp registered
[   45.146512] ACPI: EC:  acpi_ec_init acpi_ec_space_handler(<args...>)
[   45.146514] ACPI: EC:  acpi_ec_init acpi_ec_read(<ec>, <address>, <data>)
[   45.146515] ACPI: EC:  acpi_ec_init acpi_ec_transaction(<ec>, 128, <wdata>, 
1, <rdata>, 1, 0)
[   45.146516] ACPI: EC:  acpi_ec_init acpi_ec_wait(<ec>, 2, 0)
[   45.146519] ACPI: EC:  acpi_ec_init acpi_ec_transaction_unlocked(<ec>, 128, 
<wdata>, 1, <rdata>, 1, 0)
[   45.146522] ACPI: EC:  acpi_ec_init acpi_ec_wait(<ec>, 2, 0)
[   45.146807] ACPI: EC:  acpi_ec_init acpi_ec_gpe_handler(<data>)
[   45.146818] ACPI: EC:  acpi_ec_init acpi_ec_wait(<ec>, 1, 0)
[   45.147322] ACPI: EC:  acpi_ec_init acpi_ec_gpe_handler(<data>)
[   45.147383] ACPI: EC:  acpi_ec_init acpi_ec_space_handler(<args...>)
[   45.147384] ACPI: EC:  acpi_ec_init acpi_ec_read(<ec>, <address>, <data>)
[   45.147385] ACPI: EC:  acpi_ec_init acpi_ec_transaction(<ec>, 128, <wdata>, 
1, <rdata>, 1, 0)
[   45.147386] ACPI: EC:  acpi_ec_init acpi_ec_wait(<ec>, 2, 0)
[   45.147389] ACPI: EC:  acpi_ec_init acpi_ec_transaction_unlocked(<ec>, 128, 
<wdata>, 1, <rdata>, 1, 0)
[   45.147392] ACPI: EC:  acpi_ec_init acpi_ec_wait(<ec>, 2, 0)
[   45.147593] ACPI: EC:  acpi_ec_init acpi_ec_gpe_handler(<data>)
[   45.147604] ACPI: EC:  acpi_ec_init acpi_ec_wait(<ec>, 1, 0)
[   45.147917] ACPI: EC:  acpi_ec_init acpi_ec_gpe_handler(<data>)
[   45.149254] pnp: PnP ACPI: found 10 devices
[   45.149316] ACPI: ACPI bus type pnp unregistered

** Attachment added: "ec_debug ACPI EC delayed printk() messaging"
   http://launchpadlibrarian.net/15964921/ec_debug.patch

-- 
[Hardy] ACPI Embedded Controller (EC) stops boot when kernel boot 'quiet' 
option is enabled or AC power is connected
https://bugs.launchpad.net/bugs/191137
You received this bug notification because you are a member of Ubuntu
Bugs, which is subscribed to Ubuntu.

-- 
ubuntu-bugs mailing list
ubuntu-bugs@lists.ubuntu.com
https://lists.ubuntu.com/mailman/listinfo/ubuntu-bugs

Reply via email to