Well, three steps forward, two steps back!
Fixed my issue when booting in a virtual machine. I had copied Arclight.sfs from my old mythtv 0.25/themes directory into the themes directory of 0.27. Once I switched to a different theme, boots right up. (How do you get new themes now, btw?)
On a real ion machine, though, turns out my problem was... CPU usage??!?? If I leave the machine alone for
a good long time (talking like five to ten minutes!), it
eventually will boot up and is reachable over the network.
Only problem is, kworker is taking up 99-100% of the CPU!
I was able to eventually telnet in and copy off the logs, but not seeing anything jump out at me in them. (attached) note that these logs are from when I was trying to use arclight, which I've since changed to blootube-wide, but to no effect.
minimyth.log
Code: Select all
modprobe: FATAL: Module rtc not found.
Simple mixer control 'Master',0
Capabilities: pvolume pvolume-joined pswitch pswitch-joined
Playback channels: Mono
Limits: Playback 0 - 31
Mono: Playback 28 [90%] [-4.50dB] [on]
Simple mixer control 'Speaker',0
Capabilities: pvolume pswitch
Playback channels: Front Left - Front Right
Limits: Playback 0 - 31
Mono:
Front Left: Playback 28 [90%] [-4.50dB] [on]
Front Right: Playback 28 [90%] [-4.50dB] [on]
Simple mixer control 'PCM',0
Capabilities: pvolume pswitch
Playback channels: Front Left - Front Right
Limits: Playback 0 - 31
Mono:
Front Left: Playback 28 [90%] [-4.50dB] [on]
Front Right: Playback 28 [90%] [-4.50dB] [on]
messages
Code: Select all
Dec 3 00:51:15 (none) syslog.info syslogd started: BusyBox v1.20.2
Dec 3 00:51:18 (none) daemon.info init: Entering runlevel: 5
Dec 3 00:51:19 (none) local0.info minimyth: starting splash screen
Dec 3 00:51:20 (none) local0.info minimyth: configuring shared libraries ...
Dec 3 00:51:20 (none) local0.info minimyth: starting loopback network interface ...
Dec 3 00:51:20 (none) daemon.err rpcbind[331]: cannot bind 127.0.0.1 on udp: Address already in use
Dec 3 00:51:20 (none) local0.info minimyth: configuring network interface (one shot) ...
Dec 3 00:51:20 (none) local0.info minimyth: running DHCP client command '/sbin/udhcpc -S -o -O subnet -O router -O dns -O logsrv -O hostname -O domain -O broadcast -O ntpsrv -O tcode -p /var/run/udhcpc.pid -s /etc/udhcpc.script -i eth0 -q > /var/log/udhcpc 2>&1'.
Dec 3 00:51:20 (none) daemon.info udhcpc[369]: udhcpc (v1.20.2) started
Dec 3 00:51:20 (none) daemon.info udhcpc[369]: Sending discover...
Dec 3 00:51:24 (none) daemon.info udhcpc[369]: Sending discover...
Dec 3 00:51:27 (none) daemon.info udhcpc[369]: Sending discover...
Dec 3 00:51:50 (none) daemon.info udhcpc[369]: Sending discover...
Dec 3 00:51:53 (none) daemon.info udhcpc[369]: Sending discover...
Dec 3 00:51:57 (none) daemon.info udhcpc[369]: Sending discover...
Dec 3 00:51:58 (none) daemon.info udhcpc[369]: Sending select for 172.18.0.107...
Dec 3 00:52:02 (none) daemon.info udhcpc[369]: Sending select for 172.18.0.107...
Dec 3 00:52:05 (none) daemon.info udhcpc[369]: Sending select for 172.18.0.107...
Dec 3 00:52:28 (none) daemon.info udhcpc[369]: Sending discover...
Dec 3 00:52:32 (none) daemon.info udhcpc[369]: Sending discover...
Dec 3 00:52:32 (none) daemon.info udhcpc[369]: Sending select for 172.18.0.107...
Dec 3 00:52:35 (none) daemon.info udhcpc[369]: Sending select for 172.18.0.107...
Dec 3 00:52:38 (none) daemon.info udhcpc[369]: Sending select for 172.18.0.107...
Dec 3 00:53:02 (none) daemon.info udhcpc[369]: Sending discover...
Dec 3 00:53:05 (none) daemon.info udhcpc[369]: Sending discover...
Dec 3 00:53:08 (none) daemon.info udhcpc[369]: Sending discover...
Dec 3 00:53:31 (none) daemon.info udhcpc[369]: Sending discover...
Dec 3 00:53:34 (none) daemon.info udhcpc[369]: Sending select for 172.18.0.107...
Dec 3 00:53:38 (none) daemon.info udhcpc[369]: Sending select for 172.18.0.107...
Dec 3 00:53:41 (none) daemon.info udhcpc[369]: Sending select for 172.18.0.107...
Dec 3 00:53:41 (none) daemon.info udhcpc[369]: Lease of 172.18.0.107 obtained, lease time 86400
Dec 3 00:53:41 (none) local0.info minimyth: fetching configuration file ...
Dec 3 00:53:41 (none) local0.info minimyth: fetching 'confro:/minimyth.conf': local file will be '/etc/minimyth.d/minimyth.conf'.
Dec 3 00:53:46 (none) local0.info minimyth: fetching 'confro:/minimyth.conf': URL 'tftp://172.18.0.50//conf/Bedroom-1/minimyth.conf' fetched.
Dec 3 00:53:46 (none) local0.info minimyth: checking for obsolete variables ...
Dec 3 00:53:46 (none) local0.info minimyth: fetching configuration package ...
Dec 3 00:53:46 (none) local0.info minimyth: fetching 'confro:/minimyth.pm': local file will be '/etc/minimyth.d/minimyth.pm'.
Dec 3 00:54:05 (none) local0.info minimyth: fetching 'confro:/minimyth.pm': URL 'tftp://172.18.0.50//conf/Bedroom-1/minimyth.pm' fetched.
Dec 3 00:54:05 (none) local0.info minimyth: running configuration package ...
Dec 3 00:54:05 (none) local0.info minimyth: Processing DHCP override variables ...
Dec 3 00:54:06 (none) local0.info minimyth: configuring network interface ...
Dec 3 00:54:06 (none) local0.info minimyth: running DHCP client command '/sbin/udhcpc -S -o -O subnet -O router -O dns -O logsrv -O hostname -O domain -O broadcast -O ntpsrv -O tcode -p /var/run/udhcpc.pid -s /etc/udhcpc.script -i eth0 -r 172.18.0.107 > /var/log/udhcp
Dec 3 00:54:06 (none) daemon.info udhcpc[551]: udhcpc (v1.20.2) started
Dec 3 00:54:06 (none) daemon.info udhcpc[551]: Sending discover...
Dec 3 00:54:09 (none) daemon.info udhcpc[551]: Sending discover...
Dec 3 00:54:12 (none) daemon.info udhcpc[551]: Sending discover...
Dec 3 00:54:36 (none) daemon.info udhcpc[551]: Sending discover...
Dec 3 00:54:36 (none) daemon.info udhcpc[551]: Sending select for 172.18.0.107...
Dec 3 00:54:39 (none) daemon.info udhcpc[551]: Sending select for 172.18.0.107...
Dec 3 00:54:42 (none) daemon.info udhcpc[551]: Sending select for 172.18.0.107...
Dec 3 00:55:06 (none) daemon.info udhcpc[551]: Sending discover...
Dec 3 00:55:09 (none) daemon.info udhcpc[551]: Sending discover...
Dec 3 00:55:09 (none) daemon.info udhcpc[551]: Sending select for 172.18.0.107...
Dec 3 00:55:11 (none) daemon.info udhcpc[551]: Lease of 172.18.0.107 obtained, lease time 86400
Dec 2 18:55:13 (none) local0.info minimyth: Fetching firmware files ...
Dec 2 18:55:13 (none) local0.info minimyth: loading kernel modules (automatic) ...
Dec 2 18:55:14 (none) local0.info minimyth: loading kernel modules (manual) ...
Dec 2 18:55:16 (none) local0.info minimyth: processing configuration file ...
Dec 2 18:55:16 (none) local0.info minimyth: fetching 'confro:/lircrc': local file will be '/etc/lirc/lircrc'.
Dec 2 18:55:22 (none) local0.info minimyth: fetching 'confro:/lircrc': URL 'tftp://172.18.0.50//conf/Bedroom-1/lircrc' fetched.
Dec 2 18:55:22 (none) local0.info minimyth: fetched MiniMyth read-only configuration file '/lircrc'
Dec 2 18:55:22 (none) local0.info minimyth: by fetching 'tftp://172.18.0.50//conf/Bedroom-1/lircrc'
Dec 2 18:55:22 (none) local0.info minimyth: to local file '/etc/lirc/lircrc'.
Dec 2 18:55:25 (none) local0.warn minimyth: 'unknown audio device. assuming audio gain is '90'.
Dec 2 18:55:25 (none) local0.warn minimyth: 'unknown audio device. assuming audio device number is '0'.
Dec 2 18:55:25 (none) local0.warn minimyth: 'unknown audio card. assuming audio card number is '0'.
Dec 2 18:55:25 (none) local0.info minimyth: fetching 'confro:/credentials_cifs': local file will be '/etc/cifs/credentials_cifs'.
Dec 2 18:55:31 (none) local0.info minimyth: fetching 'confro:/credentials_cifs': URL 'tftp://172.18.0.50//conf/Bedroom-1/credentials_cifs' fetched.
Dec 2 18:55:31 (none) local0.info minimyth: fetched MiniMyth read-only configuration file '/credentials_cifs'
Dec 2 18:55:31 (none) local0.info minimyth: by fetching 'tftp://172.18.0.50//conf/Bedroom-1/credentials_cifs'
Dec 2 18:55:31 (none) local0.info minimyth: to local file '/etc/cifs/credentials_cifs'.
Dec 2 18:55:31 (none) local0.info minimyth: starting system logging ...
Dec 2 18:55:31 (none) user.notice kernel: klogd started: BusyBox v1.20.2 (2015-08-15 20:27:06 PDT)
Dec 2 18:55:31 (none) user.info kernel: pci 0000:00:10.0: bridge window [mem 0xe0000000-0xf9ffffff 64bit pref]
Dec 2 18:55:31 (none) user.info kernel: pci 0000:00:15.0: PCI bridge to [bus 04]
Dec 2 18:55:31 (none) user.info kernel: pci 0000:00:16.0: PCI bridge to [bus 05]
Dec 2 18:55:31 (none) user.info kernel: pci 0000:00:16.0: bridge window [io 0xe000-0xefff]
Dec 2 18:55:31 (none) user.info kernel: pci 0000:00:16.0: bridge window [mem 0xfea00000-0xfeafffff]
Dec 2 18:55:31 (none) user.info kernel: pci 0000:00:17.0: PCI bridge to [bus 06]
Dec 2 18:55:31 (none) user.info kernel: pci 0000:00:17.0: bridge window [mem 0xfeb00000-0xfebfffff]
Dec 2 18:55:31 (none) user.info kernel: pci 0000:00:18.0: PCI bridge to [bus 07]
Dec 2 18:55:31 (none) user.debug kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7]
Dec 2 18:55:31 (none) user.debug kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff]
Dec 2 18:55:31 (none) user.debug kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff]
Dec 2 18:55:31 (none) user.debug kernel: pci_bus 0000:00: resource 7 [mem 0x000d0000-0x000dffff]
Dec 2 18:55:31 (none) user.debug kernel: pci_bus 0000:00: resource 8 [mem 0xe0000000-0xfbffffff]
Dec 2 18:55:31 (none) user.debug kernel: pci_bus 0000:00: resource 9 [mem 0xfe000000-0xfebfffff]
Dec 2 18:55:31 (none) user.debug kernel: pci_bus 0000:01: resource 4 [io 0x0000-0x0cf7]
Dec 2 18:55:31 (none) user.debug kernel: pci_bus 0000:01: resource 5 [io 0x0d00-0xffff]
Dec 2 18:55:31 (none) user.debug kernel: pci_bus 0000:01: resource 6 [mem 0x000a0000-0x000bffff]
Dec 2 18:55:31 (none) user.debug kernel: pci_bus 0000:01: resource 7 [mem 0x000d0000-0x000dffff]
Dec 2 18:55:31 (none) user.debug kernel: pci_bus 0000:01: resource 8 [mem 0xe0000000-0xfbffffff]
Dec 2 18:55:31 (none) user.debug kernel: pci_bus 0000:01: resource 9 [mem 0xfe000000-0xfebfffff]
Dec 2 18:55:31 (none) user.debug kernel: pci_bus 0000:03: resource 0 [io 0xd000-0xdfff]
Dec 2 18:55:31 (none) user.debug kernel: pci_bus 0000:03: resource 1 [mem 0xfaf00000-0xfbffffff]
Dec 2 18:55:31 (none) user.debug kernel: pci_bus 0000:03: resource 2 [mem 0xe0000000-0xf9ffffff 64bit pref]
Dec 2 18:55:31 (none) user.debug kernel: pci_bus 0000:05: resource 0 [io 0xe000-0xefff]
Dec 2 18:55:31 (none) user.debug kernel: pci_bus 0000:05: resource 1 [mem 0xfea00000-0xfeafffff]
Dec 2 18:55:31 (none) user.debug kernel: pci_bus 0000:06: resource 1 [mem 0xfeb00000-0xfebfffff]
Dec 2 18:55:31 (none) user.info kernel: NET: Registered protocol family 2
Dec 2 18:55:31 (none) user.info kernel: TCP established hash table entries: 8192 (order: 3, 32768 bytes)
Dec 2 18:55:31 (none) user.info kernel: TCP bind hash table entries: 8192 (order: 4, 65536 bytes)
Dec 2 18:55:31 (none) user.info kernel: TCP: Hash tables configured (established 8192 bind 8192)
Dec 2 18:55:31 (none) user.info kernel: TCP: reno registered
Dec 2 18:55:31 (none) user.info kernel: UDP hash table entries: 512 (order: 2, 16384 bytes)
Dec 2 18:55:31 (none) user.info kernel: UDP-Lite hash table entries: 512 (order: 2, 16384 bytes)
Dec 2 18:55:31 (none) user.info kernel: NET: Registered protocol family 1
Dec 2 18:55:31 (none) user.info kernel: RPC: Registered named UNIX socket transport module.
Dec 2 18:55:31 (none) user.info kernel: RPC: Registered udp transport module.
Dec 2 18:55:31 (none) user.info kernel: RPC: Registered tcp transport module.
Dec 2 18:55:31 (none) user.info kernel: RPC: Registered tcp NFSv4.1 backchannel transport module.
Dec 2 18:55:31 (none) user.warn kernel: ACPI: PCI Interrupt Link [LUB0] enabled at IRQ 23
Dec 2 18:55:31 (none) user.warn kernel: ACPI: PCI Interrupt Link [LUB2] enabled at IRQ 22
Dec 2 18:55:31 (none) user.warn kernel: ACPI: PCI Interrupt Link [UB11] enabled at IRQ 21
Dec 2 18:55:31 (none) user.warn kernel: ACPI: PCI Interrupt Link [UB12] enabled at IRQ 20
Dec 2 18:55:31 (none) user.debug kernel: pci 0000:03:00.0: Video device with shadowed ROM
Dec 2 18:55:31 (none) user.debug kernel: PCI: CLS 64 bytes, default 64
Dec 2 18:55:31 (none) user.info kernel: Trying to unpack rootfs image as initramfs...
Dec 2 18:55:31 (none) user.info kernel: rootfs image is not initramfs (junk in compressed archive); looks like an initrd
Dec 2 18:55:31 (none) user.info kernel: Freeing initrd memory: 122264K (f0098000 - f77fe000)
Dec 2 18:55:31 (none) user.info kernel: futex hash table entries: 1024 (order: 3, 32768 bytes)
Dec 2 18:55:31 (none) user.info kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher
Dec 2 18:55:31 (none) user.notice kernel: NFS: Registering the id_resolver key type
Dec 2 18:55:31 (none) user.notice kernel: Key type id_resolver registered
Dec 2 18:55:31 (none) user.notice kernel: Key type id_legacy registered
Dec 2 18:55:31 (none) user.info kernel: nfs4filelayout_init: NFSv4 File Layout Driver Registering...
Dec 2 18:55:31 (none) user.info kernel: msgmni has been set to 1708
Dec 2 18:55:31 (none) user.info kernel: bounce: pool size: 64 pages
Dec 2 18:55:31 (none) user.info kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252)
Dec 2 18:55:31 (none) user.info kernel: io scheduler noop registered
Dec 2 18:55:31 (none) user.info kernel: io scheduler cfq registered (default)
Dec 2 18:55:31 (none) user.warn kernel: ACPI: PCI Interrupt Link [LRP0] enabled at IRQ 23
Dec 2 18:55:31 (none) user.warn kernel: ACPI: PCI Interrupt Link [LRP3] enabled at IRQ 22
Dec 2 18:55:31 (none) user.warn kernel: ACPI: PCI Interrupt Link [LRP4] enabled at IRQ 21
Dec 2 18:55:31 (none) user.warn kernel: ACPI: PCI Interrupt Link [LRP5] enabled at IRQ 20
Dec 2 18:55:31 (none) user.warn kernel: ACPI: PCI Interrupt Link [LRP6] enabled at IRQ 23
Dec 2 18:55:31 (none) user.info kernel: vesafb: mode is 640x480x32, linelength=2560, pages=1
Dec 2 18:55:31 (none) user.info kernel: vesafb: protected mode interface info at c000:cbd0
Dec 2 18:55:31 (none) user.info kernel: vesafb: pmi: set display start = c00ccc33, set palette = c00ccc8e
Dec 2 18:55:31 (none) user.info kernel: vesafb: pmi: ports = 3b4 3b5 3ba 3c0 3c1 3c4 3c5 3c6 3c7 3c8 3c9 3cc 3ce 3cf 3d0 3d1 3d2 3d3 3d4 3d5 3da
Dec 2 18:55:31 (none) user.info kernel: vesafb: scrolling: redraw
Dec 2 18:55:31 (none) user.info kernel: vesafb: Truecolor: size=8:8:8:8, shift=24:16:8:0
Dec 2 18:55:31 (none) user.info kernel: vesafb: framebuffer at 0xf9000000, mapped to 0xf8080000, using 2400k, total 14336k
Dec 2 18:55:31 (none) user.info kernel: Console: switching to colour frame buffer device 80x30
Dec 2 18:55:31 (none) user.info kernel: fb0: VESA VGA frame buffer device
Dec 2 18:55:31 (none) user.info kernel: brd: module loaded
Dec 2 18:55:31 (none) user.info kernel: pcnet32: pcnet32.c:v1.35 21.Apr.2008 tsbogend@alpha.franken.de
Dec 2 18:55:31 (none) user.info kernel: Atheros(R) L2 Ethernet Driver - version 2.2.3
Dec 2 18:55:31 (none) user.info kernel: Copyright (c) 2007 Atheros Corporation.
Dec 2 18:55:31 (none) user.warn kernel: ACPI: PCI Interrupt Link [LN4A] enabled at IRQ 19
Dec 2 18:55:31 (none) user.info kernel: atl1c 0000:05:00.0: version 1.0.1.1-NAPI
Dec 2 18:55:31 (none) user.info kernel: e100: Intel(R) PRO/100 Network Driver, 3.5.24-k2-NAPI
Dec 2 18:55:31 (none) user.info kernel: e100: Copyright(c) 1999-2006 Intel Corporation
Dec 2 18:55:31 (none) user.info kernel: e1000: Intel(R) PRO/1000 Network Driver - version 7.3.21-k8-NAPI
Dec 2 18:55:31 (none) user.info kernel: e1000: Copyright (c) 1999-2006 Intel Corporation.
Dec 2 18:55:31 (none) user.info kernel: e1000e: Intel(R) PRO/1000 Network Driver - 2.3.2-k
Dec 2 18:55:31 (none) user.info kernel: e1000e: Copyright(c) 1999 - 2014 Intel Corporation.
Dec 2 18:55:31 (none) user.info kernel: jme: JMicron JMC2XX ethernet driver version 1.0.8
Dec 2 18:55:31 (none) user.info kernel: sky2: driver version 1.30
Dec 2 18:55:31 (none) user.info kernel: ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
Dec 2 18:55:31 (none) user.info kernel: ehci-pci: EHCI PCI platform driver
Dec 2 18:55:31 (none) user.info kernel: ehci-pci 0000:00:04.1: EHCI Host Controller
Dec 2 18:55:31 (none) user.info kernel: ehci-pci 0000:00:04.1: new USB bus registered, assigned bus number 1
Dec 2 18:55:31 (none) user.info kernel: ehci-pci 0000:00:04.1: debug port 1
Dec 2 18:55:31 (none) user.debug kernel: ehci-pci 0000:00:04.1: cache line size of 64 is not supported
Dec 2 18:55:31 (none) user.info kernel: ehci-pci 0000:00:04.1: irq 22, io mem 0xfae7ec00
Dec 2 18:55:31 (none) user.info kernel: ehci-pci 0000:00:04.1: USB 2.0 started, EHCI 1.00
Dec 2 18:55:31 (none) user.info kernel: hub 1-0:1.0: USB hub found
Dec 2 18:55:31 (none) user.info kernel: hub 1-0:1.0: 6 ports detected
Dec 2 18:55:31 (none) user.info kernel: ehci-pci 0000:00:06.1: EHCI Host Controller
Dec 2 18:55:31 (none) user.info kernel: ehci-pci 0000:00:06.1: new USB bus registered, assigned bus number 2
Dec 2 18:55:31 (none) user.info kernel: ehci-pci 0000:00:06.1: debug port 1
Dec 2 18:55:31 (none) user.debug kernel: ehci-pci 0000:00:06.1: cache line size of 64 is not supported
Dec 2 18:55:31 (none) user.info kernel: ehci-pci 0000:00:06.1: irq 20, io mem 0xfae7e800
Dec 2 18:55:31 (none) user.info kernel: ehci-pci 0000:00:06.1: USB 2.0 started, EHCI 1.00
Dec 2 18:55:31 (none) user.info kernel: hub 2-0:1.0: USB hub found
Dec 2 18:55:31 (none) user.info kernel: hub 2-0:1.0: 6 ports detected
Dec 2 18:55:31 (none) user.info kernel: ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
Dec 2 18:55:31 (none) user.info kernel: ohci-pci: OHCI PCI platform driver
Dec 2 18:55:31 (none) user.info kernel: ohci-pci 0000:00:04.0: OHCI PCI host controller
Dec 2 18:55:31 (none) user.info kernel: ohci-pci 0000:00:04.0: new USB bus registered, assigned bus number 3
Dec 2 18:55:31 (none) user.info kernel: ohci-pci 0000:00:04.0: irq 23, io mem 0xfae7f000
Dec 2 18:55:31 (none) user.info kernel: hub 3-0:1.0: USB hub found
Dec 2 18:55:31 (none) user.info kernel: hub 3-0:1.0: 6 ports detected
Dec 2 18:55:31 (none) user.info kernel: ohci-pci 0000:00:06.0: OHCI PCI host controller
Dec 2 18:55:31 (none) user.info kernel: ohci-pci 0000:00:06.0: new USB bus registered, assigned bus number 4
Dec 2 18:55:31 (none) user.info kernel: ohci-pci 0000:00:06.0: irq 21, io mem 0xfae7d000
Dec 2 18:55:31 (none) user.info kernel: hub 4-0:1.0: USB hub found
Dec 2 18:55:31 (none) user.info kernel: hub 4-0:1.0: 6 ports detected
Dec 2 18:55:31 (none) user.info kernel: uhci_hcd: USB Universal Host Controller Interface driver
Dec 2 18:55:31 (none) user.info kernel: usbcore: registered new interface driver usb-storage
Dec 2 18:55:31 (none) user.info kernel: i8042: PNP: PS/2 Controller [PNP0303:PS2K,PNP0f03:PS2M] at 0x60,0x64 irq 1,12
Dec 2 18:55:31 (none) user.info kernel: i8042: Detected active multiplexing controller, rev 1.1
Dec 2 18:55:31 (none) user.info kernel: serio: i8042 KBD port at 0x60,0x64 irq 1
Dec 2 18:55:31 (none) user.info kernel: serio: i8042 AUX0 port at 0x60,0x64 irq 12
Dec 2 18:55:31 (none) user.info kernel: serio: i8042 AUX1 port at 0x60,0x64 irq 12
Dec 2 18:55:31 (none) user.info kernel: serio: i8042 AUX2 port at 0x60,0x64 irq 12
Dec 2 18:55:31 (none) user.info kernel: serio: i8042 AUX3 port at 0x60,0x64 irq 12
Dec 2 18:55:31 (none) user.info kernel: mousedev: PS/2 mouse device common for all mice
Dec 2 18:55:31 (none) user.info kernel: TCP: cubic registered
Dec 2 18:55:31 (none) user.notice kernel: Key type dns_resolver registered
Dec 2 18:55:31 (none) user.info kernel: Using IPI No-Shortcut mode
Dec 2 18:55:31 (none) user.info kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
Dec 2 18:55:31 (none) user.notice kernel: RAMDISK: squashfs filesystem found at block 0
Dec 2 18:55:31 (none) user.notice kernel: RAMDISK: Loading 122263KiB [1 disk] into ram disk... |^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H
Dec 2 18:55:31 (none) user.info kernel: usb 2-3: new high-speed USB device number 2 using ehci-pci
Dec 2 18:55:31 (none) user.err kernel: /^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-
Dec 2 18:55:31 (none) user.info kernel: usb-storage 2-3:1.0: USB Mass Storage device detected
Dec 2 18:55:31 (none) user.err kernel: |^H/^H
Dec 2 18:55:31 (none) user.info kernel: scsi host0: usb-storage 2-3:1.0
Dec 2 18:55:31 (none) user.err kernel: -^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\
Dec 2 18:55:31 (none) user.info kernel: usb 3-2: new full-speed USB device number 2 using ohci-pci
Dec 2 18:55:31 (none) user.err kernel: |^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/
Dec 2 18:55:31 (none) user.info kernel: tsc: Refined TSC clocksource calibration: 1599.992 MHz
Dec 2 18:55:31 (none) user.info kernel: Switched to clocksource tsc
Dec 2 18:55:31 (none) user.err kernel: /^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-^H\^H|^H/^H-
Dec 2 18:55:31 (none) user.info kernel: VFS: Mounted root (squashfs filesystem) readonly on device 1:0.
Dec 2 18:55:31 (none) user.info kernel: Freeing unused kernel memory: 400K (c1557000 - c15bb000)
Dec 2 18:55:31 (none) user.notice kernel: scsi 0:0:0:0: Direct-Access Generic STORAGE DEVICE 9732 PQ: 0 ANSI: 0
Dec 2 18:55:31 (none) user.notice kernel: scsi 0:0:0:1: Direct-Access Generic STORAGE DEVICE 9732 PQ: 0 ANSI: 0
Dec 2 18:55:31 (none) user.notice kernel: sd 0:0:0:0: [sda] Attached SCSI removable disk
Dec 2 18:55:31 (none) user.notice kernel: scsi 0:0:0:2: Direct-Access Generic STORAGE DEVICE 9732 PQ: 0 ANSI: 0
Dec 2 18:55:31 (none) user.notice kernel: sd 0:0:0:1: [sdb] Attached SCSI removable disk
Dec 2 18:55:31 (none) user.notice kernel: scsi 0:0:0:3: Direct-Access Generic STORAGE DEVICE 9732 PQ: 0 ANSI: 0
Dec 2 18:55:31 (none) user.notice kernel: sd 0:0:0:2: [sdc] Attached SCSI removable disk
Dec 2 18:55:31 (none) user.notice kernel: scsi 0:0:0:4: Direct-Access Generic STORAGE DEVICE 9732 PQ: 0 ANSI: 0
Dec 2 18:55:31 (none) user.notice kernel: sd 0:0:0:3: [sdd] Attached SCSI removable disk
Dec 2 18:55:31 (none) user.notice kernel: sd 0:0:0:4: [sde] Attached SCSI removable disk
Dec 2 18:55:31 (none) user.err kernel: 0>udevd[107]: starting version 182
Dec 2 18:55:31 (none) user.notice kernel: random: rc.pl urandom read with 14 bits of entropy available
Dec 2 18:55:31 (none) user.err kernel: atl1c 0000:05:00.0: Unable to allocate MSI interrupt Error: -38
Dec 2 18:55:31 (none) user.info kernel: atl1c 0000:05:00.0: atl1c: eth0 NIC Link is Up<1000 Mbps Full Duplex>
Dec 2 18:55:31 (none) user.info kernel: NET: Registered protocol family 17
Dec 2 18:55:31 (none) user.notice kernel: random: nonblocking pool is initialized
Dec 2 18:55:31 (none) user.info kernel: loop: module loaded
Dec 2 18:55:31 (none) user.info kernel: ppdev: user-space parallel port driver
Dec 2 18:55:31 (none) user.info kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input5
Dec 2 18:55:31 (none) user.info kernel: ACPI: Power Button [PWRB]
Dec 2 18:55:31 (none) user.info kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input6
Dec 2 18:55:31 (none) user.info kernel: ACPI: Power Button [PWRF]
Dec 2 18:55:31 (none) user.info kernel: i2c i2c-0: nForce2 SMBus adapter at 0x4d00
Dec 2 18:55:31 (none) user.err kernel: ACPI Warning: SystemIO range 0x0000000000004E00-0x0000000000004E3F conflicts with OpRegion 0x0000000000004E00-0x0000000000004E3F (\_SB_.PCI0.SM00) (20140926/utaddress-254)
Dec 2 18:55:31 (none) user.info kernel: ACPI: If an ACPI driver is available for this device, you should use it instead of the native driver
Dec 2 18:55:31 (none) user.info kernel: wmi: Mapper loaded
Dec 2 18:55:31 (none) user.info kernel: Registered IR keymap rc-rc6-mce
Dec 2 18:55:31 (none) user.info kernel: input: Media Center Ed. eHome Infrared Remote Transceiver (1784:0011) as /devices/pci0000:00/0000:00:04.0/usb3/3-2/3-2:1.0/rc/rc0/input7
Dec 2 18:55:31 (none) user.info kernel: rc0: Media Center Ed. eHome Infrared Remote Transceiver (1784:0011) as /devices/pci0000:00/0000:00:04.0/usb3/3-2/3-2:1.0/rc/rc0
Dec 2 18:55:31 (none) user.info kernel: IR NEC protocol handler initialized
Dec 2 18:55:31 (none) user.warn kernel: ACPI: PCI Interrupt Link [LAZA] enabled at IRQ 22
Dec 2 18:55:31 (none) user.info kernel: snd_hda_intel 0000:00:08.0: Disabling MSI
Dec 2 18:55:31 (none) user.info kernel: IR RC5(x/sz) protocol handler initialized
Dec 2 18:55:31 (none) user.info kernel: IR RC6 protocol handler initialized
Dec 2 18:55:31 (none) user.info kernel: IR JVC protocol handler initialized
Dec 2 18:55:31 (none) user.info kernel: IR Sony protocol handler initialized
Dec 2 18:55:31 (none) user.info kernel: IR Sharp protocol handler initialized
Dec 2 18:55:31 (none) user.info kernel: IR SANYO protocol handler initialized
Dec 2 18:55:31 (none) user.info kernel: IR MCE Keyboard/mouse protocol handler initialized
Dec 2 18:55:31 (none) user.info kernel: lirc_dev: IR Remote Control driver registered, major 251
Dec 2 18:55:31 (none) user.info kernel: IR XMP protocol handler initialized
Dec 2 18:55:31 (none) user.info kernel: IR LIRC bridge handler initialized
Dec 2 18:55:31 (none) user.info kernel: input: MCE IR Keyboard/Mouse (mceusb) as /devices/virtual/input/input10
Dec 2 18:55:31 (none) user.info kernel: rc rc0: lirc_dev: driver ir-lirc-codec (mceusb) registered at minor = 0
Dec 2 18:55:31 (none) user.info kernel: mceusb 3-2:1.0: Registered Topseed Technology Corp. eHome Infrared Transceiver with mce emulator interface version 2
Dec 2 18:55:31 (none) user.info kernel: mceusb 3-2:1.0: 2 tx ports (0x0 cabled) and 2 rx sensors (0x1 active)
Dec 2 18:55:31 (none) user.info kernel: usbcore: registered new interface driver mceusb
Dec 2 18:55:31 (none) user.info kernel: Linux agpgart interface v0.103
Dec 2 18:55:31 (none) user.info kernel: [drm] Initialized drm 1.1.0 20060810
Dec 2 18:55:31 (none) user.info kernel: sound hdaudioC0D0: autoconfig: line_outs=1 (0x14/0x0/0x0/0x0/0x0) type:line
Dec 2 18:55:31 (none) user.info kernel: sound hdaudioC0D0: speaker_outs=1 (0x17/0x0/0x0/0x0/0x0)
Dec 2 18:55:31 (none) user.info kernel: sound hdaudioC0D0: hp_outs=1 (0x1b/0x0/0x0/0x0/0x0)
Dec 2 18:55:31 (none) user.info kernel: sound hdaudioC0D0: mono: mono_out=0x0
Dec 2 18:55:31 (none) user.info kernel: sound hdaudioC0D0: dig-out=0x1e/0x0
Dec 2 18:55:31 (none) user.info kernel: sound hdaudioC0D0: inputs:
Dec 2 18:55:31 (none) user.info kernel: sound hdaudioC0D0: Mic=0x19
Dec 2 18:55:31 (none) user.info kernel: sound hdaudioC0D0: dig-in=0x1f
Dec 2 18:55:31 (none) user.warn kernel: nvidia: module license 'NVIDIA' taints kernel.
Dec 2 18:55:31 (none) user.warn kernel: Disabling lock debugging due to kernel taint
Dec 2 18:55:31 (none) user.warn kernel: ACPI: PCI Interrupt Link [LPMU] enabled at IRQ 21
Dec 2 18:55:31 (none) user.warn kernel: ACPI: PCI Interrupt Link [SGRU] enabled at IRQ 11
Dec 2 18:55:31 (none) user.info kernel: vgaarb: device changed decodes: PCI:0000:03:00.0,olddecodes=io+mem,decodes=none:owns=io+mem
Dec 2 18:55:31 (none) user.info kernel: [drm] Initialized nvidia-drm 0.0.0 20140818 for 0000:03:00.0 on minor 0
Dec 2 18:55:31 (none) user.err kernel: NVRM: loading NVIDIA UNIX x86 Kernel Module 304.125 Mon Dec 1 19:55:52 PST 2014
Dec 2 18:55:31 (none) local0.info minimyth: starting CPU frequency scaling ...
Dec 2 18:55:31 (none) local0.info minimyth: starting virtual console ...
Dec 2 18:55:31 (none) local0.info minimyth: starting telnet server ...
Dec 2 18:55:31 (none) local0.info minimyth: configuring ssh server ...
Dec 2 18:55:31 (none) local0.info minimyth: enabling udev hotplug scripts ...
Dec 2 18:55:32 (none) daemon.notice lircd-0.9.1-git[1736]: lircd(default) ready, using /var/run/lirc/lircd-lirc0
Dec 2 18:55:33 (none) local0.info minimyth: starting cron ...
Dec 2 18:55:33 (none) local0.info minimyth: configuring MythTV master backend communication ...
Dec 2 18:56:00 (none) local0.info minimyth: installing binary codecs ...
Dec 2 18:56:00 (none) local0.info minimyth: fetching 'confrw:codecs.32.sfs': local file will be '/initrd/rw/loopfs/~usr~lib~codecs/image.sfs'.
Dec 2 18:56:06 (none) local0.info minimyth: fetching 'confrw:codecs.32.sfs': URL 'tftp://172.18.0.50//conf-rw/Bedroom-1+codecs.32.sfs' not fetched (it may not exist).
Dec 2 18:56:06 (none) local0.info minimyth: installing binary Adobe Flash Player ...
Dec 2 18:56:06 (none) local0.info minimyth: fetching 'confrw:libflashplayer.32.so': local file will be '/usr/lib/browser/plugins/libflashplayer.so'.
Dec 2 18:56:13 (none) local0.info minimyth: fetching 'confrw:libflashplayer.32.so': URL 'tftp://172.18.0.50//conf-rw/Bedroom-1+libflashplayer.32.so' not fetched (it may not exist).
Dec 2 18:56:13 (none) local0.info minimyth: installing extras ...
Dec 2 18:56:13 (none) local0.info minimyth: fetching 'confro:extras.sfs': local file will be '/initrd/rw/loopfs/~usr~local/image.sfs'.
Dec 2 18:56:18 (none) local0.info minimyth: fetching 'confro:extras.sfs': URL 'tftp://172.18.0.50//conf/Bedroom-1/extras.sfs' fetched.
Dec 2 18:56:18 (none) local0.info minimyth: checking sensors ...
Dec 2 18:56:19 (none) local0.info minimyth: starting ACPI ...
Dec 2 18:56:19 (none) daemon.info acpid: starting up with netlink and the input layer
Dec 2 18:56:19 (none) daemon.info acpid: 1 rule loaded
Dec 2 18:56:19 (none) daemon.info acpid: waiting for events: event logging is off
Dec 2 18:56:19 (none) local0.info minimyth: setting time ...
Dec 2 18:56:25 (none) daemon.notice ntpdate[1834]: step time server 172.18.0.50 offset 0.223488 sec
Dec 2 18:56:25 (none) local0.info minimyth: starting NTP daemon ...
Dec 2 18:56:25 (none) daemon.notice ntpd[1840]: ntpd 4.2.6p5@1.2349 Sun Aug 16 06:45:47 UTC 2015 (1)
Dec 2 18:56:25 (none) daemon.notice ntpd[1841]: proto: precision = 1.103 usec
Dec 2 18:56:25 (none) daemon.debug ntpd[1841]: ntp_io: estimated max descriptors: 1024, initial socket boundary: 16
Dec 2 18:56:25 (none) daemon.info ntpd[1841]: Listen and drop on 0 v4wildcard 0.0.0.0 UDP 123
Dec 2 18:56:25 (none) daemon.info ntpd[1841]: Listen normally on 1 lo 127.0.0.1 UDP 123
Dec 2 18:56:25 (none) daemon.info ntpd[1841]: Listen normally on 2 eth0 172.18.0.107 UDP 123
Dec 2 18:56:25 (none) daemon.info ntpd[1841]: peers refreshed
Dec 2 18:56:25 (none) daemon.info ntpd[1841]: Listening on routing socket on fd #19 for interface updates
Dec 2 18:56:25 (none) local0.info minimyth: starting web server ...
Dec 2 18:56:26 (none) daemon.err lighttpd[1851]: (log.c.164) server started
Dec 2 18:56:26 (none) daemon.err lighttpd[1854]: (log.c.164) server started
Dec 2 18:56:26 (none) local0.info minimyth: initializing dbus ...
Dec 2 18:56:26 (none) local0.info minimyth: starting dbus daemon ...
Dec 2 18:56:26 (none) local0.info minimyth: mounting media shares ...
Dec 2 18:56:52 (none) auth.notice su: + none root:minimyth
Dec 2 18:56:52 (none) local0.info minimyth: configuring audio ...
Dec 2 18:56:53 (none) local0.info minimyth: configuring video ...
Dec 2 18:59:42 (none) local0.info minimyth: starting remote control(s) ...
Dec 2 18:59:42 (none) local0.info minimyth: starting LCD/VFD ...
Dec 2 19:00:25 (none) local0.info minimyth: configuring MythTV ...
Dec 2 19:01:15 (none) local0.info minimyth: fetching 'hunt:themes/Arclight.sfs': local file will be '/initrd/rw/loopfs/~home~minimyth~.mythtv~themes~Arclight/image.sfs'.
Dec 2 19:01:47 (none) local0.info minimyth: fetching 'hunt:themes/Arclight.sfs': URL 'tftp://172.18.0.50//conf-rw/Bedroom-1+themes+Arclight.sfs' not fetched (it may not exist).
Dec 2 19:01:58 (none) local0.info minimyth: fetching 'hunt:themes/Arclight.sfs': URL 'tftp://172.18.0.50//conf/Bedroom-1/themes/Arclight.sfs' not fetched (it may not exist).
Dec 2 19:02:01 (none) local0.info minimyth: fetching 'hunt:themes/Arclight.sfs': URL 'tftp://172.18.0.50//conf/default/themes/Arclight.sfs' not fetched (it may not exist).
Dec 2 19:05:32 (none) user.err kernel: CIFS VFS: Server 172.18.0.50 has not responded in 120 seconds. Reconnecting...
Dec 2 19:08:12 (none) auth.info login[2012]: root login on 'pts/0'
(And the x64 version crashes, on both virtual and real hardware, always, with a kernel panic.)