Hi,
I was experiencing random system hangs (about twice a day) on a headless
router I have at home so I decided to attach a serial console to it.
Sorry for not cleaning it up a bit more, I've got syslog-ng and kernel
console dumping on the serial line so syslog messages are interweaved
with kernel messages.
I also got hangs with version 2.0.0 but I haven't got them registered.
I thinks it's and eagle-usb bug (or usb-uhci) so I decided to post it
here to see if it would help. Please email me if you need the full log
(I have more than 10 panics registered) or for any assistance to help
hunt down the bug.
If it's not an eagle bug I would appreciate any help to solve it, Oh, my
modem is a Sagem Fast 800 E2T .
This is what I've got:
NETDEV WATCHDOG: eth2: transmit timed out
[Eagle-usb] Transmission timed out!
Unable to handle kernel NULL pointer dereference at virtual address
00000050
printing eip:
c020ef0f
*pde = 00000000
Oops: 0000
CPU: 0
EIP: 0010:[<c020ef0f>] Not tainted
EFLAGS: 00010202
eax: 0000004c ebx: c2e41928 ecx: 00000002 edx: 00000001
esi: c37aa360 edi: c2e41928 ebp: c10ca260 esp: c02e5bf4
ds: 0018 es: 0018 ss: 0018
Process swapper (pid: 0, stackpage=c02e5000)
Stack: c37aa360 c116f2e0 00000003 c10ca260 c10ca260 00000293 c2e41a00
c37aa360
c2e419e0 c2e41900 c116f2e0 00000000 c020d9e6 c10ca260 c37aa360
00000002
c10ca27c c10ca260 00000008 00000000 0000062e c10ca260 00000000
c020f815
Call Trace: [<c020d9e6>] [<c020f815>] [<c0109b03>] [<c0109c7e>]
[<c010be68>]
[<c01d486e>] [<c022740a>] [<c021e2c1>] [<c023481d>] [<c0234784>]
[<c0225ec6>]
[<c0231dcc>] [<c0233192>] [<c0234784>] [<c0231dcc>] [<c0231e1a>]
[<c0225ec6>]
[<c0231d74>] [<c0231dcc>] [<c0230f39>] [<c0225fe9>] [<c48990f6>]
[<c022740a>]
[<c4899205>] [<c0225d72>] [<c0230d78>] [<c0225eb3>] [<c48996d0>]
[<c0230d78>]
[<c48996d0>] [<c0230c06>] [<c0230d78>] [<c021e82b>] [<c021e8be>]
[<c021e9d4>]
[<c011a73a>] [<c0109cad>] [<c0106e20>] [<c010be68>] [<c0106e20>]
[<c0106e43>]
[<c0106ea7>] [<c0105000>] [<c0105027>]
Code: 8b 34 90 8b 44 24 28 d3 ee 83 e6 01 c7 44 24 14 00 00 00 00
<0>Kernel panic: Aiee, killing interrupt handler!
In interrupt handler - not syncing
Here's another:
Mar 1 23[EAGLE-USB] Ctrl Urb Watcher expired. About to remove URB c37475e0
host/usb-uhci.c: ENXIO 80000300, flags 0, urb c3747560, burb c37475e0
[EAGLE-USB] Failed to send pending ctrl urb (c3747560) with err=-6
[EAGLE-USB] Let's retry in 100ms
:08:32 nodo13 [eagle-usb] Modem operational !!
Mar 1 23:08:32 nodo13 [EAGLE-USB] Ctrl Urb Watc[Eagle-usb] faulty urb
not at beginning of list !
Unable to handle kernel paging request at virtual address 00012b00
printing eip:
c02031f7
*pde = 00000000
Oops: 0000
CPU: 0
EIP: 0010:[<c02031f7>] Not tainted
EFLAGS: 00010002
eax: 00012a20 ebx: c3993000 ecx: c313a000 edx: c37475e0
esi: 00000246 edi: 00000000 ebp: c02fc5a0 esp: c313bc2c
ds: 0018 es: 0018 ss: 0018
Process start-stop-daem (pid: 2072, stackpage=c313b000)
Stack: c483c1fd c37475e0 c3993000 c483c16c c011dfdc c3993000 00000000
c02fc580
00000000 c02fc5a0 c313bcc0 20000001 00000000 c313bcc0 20000001
c399332c
c399332c c011a9e6 c011a926 00000000 00000001 c02fc5a0 fffffffe
c011a73a
Call Trace: [<c483c1fd>] [<c483c16c>] [<c011dfdc>] [<c011a9e6>]
[<c011a926>]
[<c011a73a>] [<c0109cad>] [<c010be68>] [<c012bbe3>] [<c014e6a7>]
[<c014dd2c>]
[<c013b047>] [<c013b2d8>] [<c013b2ef>] [<c01074a3>] [<c0108763>]
Code: 8b 80 e0 00 00 00 85 c0 74 11 8b 40 1c 85 c0 74 0a 52 8b 40
her expired. Abo<0>Kernel panic: Aiee, killing interrupt handler!
ut to remove URBIn interrupt handler - not syncing
c37475e0
Mar 1 23:08:32 nodo13 host/usb-uhci.c: ENXIO 80000300, flags 0, urb
c3747560, burb c37475e0
Mar 1 23:08:32 nodo13 [EAGLE-USB] Failed to send pending ctrl urb
(c3747560) with err=-6
Mar 1 23:08:32 nodo13 [EAGLE-USB] Let's retry in 100ms
and another:
<5>__alloc_pages: 2-order allocation failed (gfp=0x20/0)
[EAGLE-USB] Not enough mem to allocate read buffer.
__alloc_pages: 2-order allocation failed (gfp=0x20/0)
[EAGLE-USB] Not enough mem to allocate read buffer.
__alloc_pages: 2-order allocation failed (gfp=0x20/0)
[EAGLE-USB] Not enough mem to allocate read buffer.
Unable to handle kernel NULL pointer dereference at virtual address
00000008
printing eip:
c483cc17
*pde = 00000000
Oops: 0002
CPU: 0
EIP: 0010:[<c483cc17>] Not tainted
EFLAGS: 00010246
eax: 00000000 ebx: 00000000 ecx: 00000000 edx: 00000000
esi: 00000000 edi: c1180600 ebp: c36d9000 esp: c02e5c90
ds: 0018 es: 0018 ss: 0018
Process swapper (pid: 0, stackpage=c02e5000)
Stack: 00000000 c1180600 00000005 c11c5e00 c36d93bc c36d93f8 c020f712
c1180600
c1180808 c10ca260 00000003 00000000 00000000 00000001 00000000
c020f7cf
c10ca260 c1180608 c10b5ee0 04000001 00000009 c02e5d3c c10ca27c
fca25d3c
Call Trace: [<c020f712>] [<c020f7cf>] [<c0109b03>] [<c0109c7e>]
[<c010be68>]
[<c0116880>] [<c011954c>] [<c0113390>] [<c0108d89>] [<c0113737>]
[<c0113390>]
[<c0200d9a>] [<c020c755>] [<c020c8f8>] [<c0108874>] [<c020d1b8>]
[<c0109c9c>]
[<c010be68>] [<c020e385>] [<c020320e>] [<c483d0a1>] [<c4842181>]
[<c022740a>]
[<c021e710>] [<c011a73a>] [<c0109cad>] [<c0106e20>] [<c010be68>]
[<c0106e20>]
[<c0106e43>] [<c0106ea7>] [<c0105000>] [<c0105027>]
Code: 89 44 19 08 8b 44 17 64 89 44 19 0c c7 44 17 68 00 00 00 00
<0>Kernel panic: Aiee, killing interrupt handler!
In interrupt handler - not syncing
Here are the kernel boot messages (plus a bit of syslog) see if it helps:
Linux version 2.4.29router-imq ([EMAIL PROTECTED]) (gcc version 2.95.4 20011002
(Debian prerelease)) #1 Sun Feb 27 12:04:56 CET 2005
BIOS-provided physical RAM map:
BIOS-e820: 0000000000000000 - 000000000009fc00 (usable)
BIOS-e820: 000000000009fc00 - 00000000000a0000 (reserved)
BIOS-e820: 00000000000f24b0 - 0000000000100000 (reserved)
BIOS-e820: 0000000000100000 - 0000000004000000 (usable)
BIOS-e820: 00000000ffff24b0 - 0000000100000000 (reserved)
64MB LOWMEM available.
On node 0 totalpages: 16384
zone(0): 4096 pages.
zone(1): 12288 pages.
zone(2): 0 pages.
DMI not present.
Kernel command line: auto BOOT_IMAGE=Linux ro root=301 pci=biosirq
console=ttyS0,9600
No local APIC present or hardware disabled
Initializing CPU#0
Detected 166.194 MHz processor.
Calibrating delay loop... 331.77 BogoMIPS
Memory: 62196k/65536k available (1428k kernel code, 2952k reserved,
505k data, 80k init, 0k highmem)
Dentry cache hash table entries: 8192 (order: 4, 65536 bytes)
Inode cache hash table entries: 4096 (order: 3, 32768 bytes)
Mount cache hash table entries: 512 (order: 0, 4096 bytes)
Buffer cache hash table entries: 4096 (order: 2, 16384 bytes)
Page-cache hash table entries: 16384 (order: 4, 65536 bytes)
Intel Pentium with F0 0F bug - workaround enabled.
CPU: Intel Pentium MMX stepping 03
Checking 'hlt' instruction... OK.
POSIX conformance testing by UNIFIX
PCI: PCI BIOS revision 2.10 entry at 0xf7830, last bus=0
PCI: Using configuration type 1
PCI: Probing PCI hardware
PCI: Probing PCI hardware (bus 00)
PCI: Using BIOS Interrupt Routing Table
PCI: Using BIOS for IRQ routing
Limiting direct PCI/PCI transfers.
Activating ISA DMA hang workarounds.
Linux NET4.0 for Linux 2.4
Based upon Swansea University Computer Society NET3.039
Initializing RT netlink socket
Starting kswapd
SGI XFS with no debug enabled
pty: 256 Unix98 ptys configured
Serial driver version 5.05c (2001-07-08) with MANY_PORTS SHARE_IRQ
SERIAL_PCI enabled
ttyS00 at 0x03f8 (irq = 4) is a 16550A
ttyS01 at 0x02f8 (irq = 3) is a 16550A
RAMDISK driver initialized: 16 RAM disks of 4096K size 1024 blocksize
PCI: Assigned IRQ 9 for device 00:14.0
PCI: Sharing IRQ 9 with 00:07.2
PCI: Sharing IRQ 9 with 00:08.0
3c59x: Donald Becker and others. www.scyld.com/network/vortex.html
00:14.0: 3Com PCI 3c905 Boomerang 100baseTx at 0xfcc0. Vers LK1.1.18
eth0: Dropping NETIF_F_SG since no checksum feature.
8139too Fast Ethernet driver 0.9.26
PCI: Assigned IRQ 11 for device 00:13.0
eth1: RealTek RTL8139 at 0xc4800c00, 00:c0:26:a0:ef:01, IRQ 11
Uniform Multi-Platform E-IDE driver Revision: 7.00beta4-2.4
ide: Assuming 33MHz system bus speed for PIO modes; override with idebus=xx
PIIX3: IDE controller at PCI slot 00:07.1
PIIX3: chipset revision 0
PIIX3: not 100% native mode: will probe irqs later
ide0: BM-DMA at 0xfc90-0xfc97, BIOS settings: hda:DMA, hdb:pio
ide1: BM-DMA at 0xfc98-0xfc9f, BIOS settings: hdc:pio, hdd:pio
hda: ST32122A, ATA DISK drive
blk: queue c0321f00, I/O limit 4095Mb (mask 0xffffffff)
ide0 at 0x1f0-0x1f7,0x3f6 on irq 14
hda: attached ide-disk driver.
hda: 4124736 sectors (2112 MB) w/128KiB Cache, CHS=4092/16/63, (U)DMA
Partition check:
hda: [PTBL] [1023/64/63] hda1 hda2
SCSI subsystem driver Revision: 1.00
kmod: failed to exec /sbin/modprobe -s -k scsi_hostadapter, errno = 2
usb.c: registered new driver usbdevfs
usb.c: registered new driver hub
host/usb-uhci.c: $Revision: 1.275 $ time 12:05:46 Feb 27 2005
host/usb-uhci.c: High bandwidth mode enabled
PCI: Assigned IRQ 9 for device 00:07.2
PCI: Sharing IRQ 9 with 00:08.0
PCI: Sharing IRQ 9 with 00:14.0
host/usb-uhci.c: USB UHCI at I/O 0xfca0, IRQ 9
host/usb-uhci.c: Detected 2 ports
usb.c: new USB bus registered, assigned bus number 1
hub.c: USB hub found
hub.c: 2 ports detected
host/usb-uhci.c: v1.275:USB Universal Host Controller Interface driver
Initializing USB Mass Storage driver...
usb.c: registered new driver usb-storage
USB Mass Storage support registered.
Initializing Cryptographic API
NET4: Linux TCP/IP 1.0 for NET4.0
IP Protocols: ICMP, UDP, TCP, IGMP
IP: routing cache hash table of 512 buckets, 4Kbytes
TCP: Hash tables configured (established 4096 bind 4096)
IPv4 over IPv4 tunneling driver
NET4: Unix domain sockets 1.0/SMP for Linux NET4.0.
XFS mounting filesystem ide0(3,1)
hub.c: new USB device 00:07.2-1, assigned address 2
usb.c: USB device 2 (vend/prod 0x1110/0x9022) is not claimed by any
active driver.
Starting XFS recovery on filesystem: ide0(3,1) (dev: ide0(3,1))
Ending XFS recovery on filesystem: ide0(3,1) (dev: ide0(3,1))
VFS: Mounted root (xfs filesystem) readonly.
Freeing unused kernel memory: 80k freed
modprobe: modprobe: cannot create /var/log/ksymoops/20050302.log
Read-only file system
modprobe: modprobe: Can't locate module char-major-4
modprobe: modprobe: cannot create /var/log/ksymoops/20050302.log
Read-only file system
INIT: version 2.84 booting
Loading /etc/console/boottime.kmap.gz
modprobe: modprobe: cannot create /var/log/ksymoops/20050302.log
Read-only file system
modprobe: modprobe: Can't locate module char-major-4
modprobe: modprobe: cannot create /var/log/ksymoops/20050302.log
Read-only file system
CouldntAdding Swap: 304408k swap-space (priority -1)
get a file descriptor referring to the console
Activating swap.
System time was Wed Mar 2 08:21:58 UTC 2005.
Setting the System Clock using the Hardware Clock as reference...
modprobe: modprobe: Can't locate module char-major-10-135
modprobe: modprobe: Can't locate module char-major-4
modprobe: modprobe: Can't locate module char-major-10-135
modprobe: modprobe: Can't locate module char-major-4
System Clock set. System local time is now Wed Mar 2 08:22:00 UTC 2005.
Calculating module dependencies... done.
Loading modules: 3c59x modprobe: Can't locate module 3c59x
usb-uhci modprobe: Can't locate module usb-uhci
8139too modprobe: Can't locate module 8139too
usb-storage modprobe: Can't locate module usb-storage
yenta_socket Linux Kernel Card Services 3.1.22
options: [pci] [cardbus]
/lib/modules/2.4.29routercasa-imq/kernel/drivers/pcmcia/yenta_socket.o:
init_module: No such device
Hint: insmounloading Kernel Card Services
d errors can be caused by incorrect module parameters, including
invalid IO or IRQ parameters
/lib/modules/2.4.29routercasa-imq/kernel/drivers/pcmcia/yenta_socket.o:
insmod
/lib/modules/2.4.29routercasa-imq/kernel/drivers/pcmcia/yenta_socket.o
failed
/lib/modules/2.4.29routercasa-imq/kernel/drivers/pcmcia/yenta_socket.o:
insmod yenta_socket failed
hostap_cs modprobe: Can't locate module hostap_cs
sch_ingress cls_u32 sch_sfq sch_dsmark cls_tcindex sch_htb
Checking all file systems...
fsck 1.27 (8-Mar-2002)
Setting kernel variables.
Loading the saved-state of the serial devices...
/dev/ttyS0 at 0x03f8 (irq = 4) is a 16550A
/dev/ttyS1 at 0x02f8 (irq = 3) is a 16550A
Mounting local filesystems...
usbdevfs on /proc/bus/usb type usbdevfs (rw)
Running 0dns-down to make sure resolv.conf is ok...done.
Cleaning: /etc/network/ifstate.
Setting up IP spoofing protection: rp_filter.
Configuring network interfaces: eth1: link up, 100Mbps, full-duplex, lpa
0x45E1
done.
Setting the System Clock using the Hardware Clock as reference...
modprobe: modprobe: Can't locate module char-major-10-135
modprobe: modprobe: Can't locate module char-major-4
System Clock set. Local time: Wed Mar 2 09:22:10 CET 2005
Running ntpdate to synchronize clock.
Cleaning: /tmp /var/lock /var/run.
Initializing random number generator... done.
Initializing random number generator... done.
INIT: Entering runlevel: 2
Starting hotplug subsystem: usbmodprobe: modprobe: Can't locate module
usbcore
[eagle-usb] driver V2.1.1 loaded
usb.c: registered new driver eagle-usb
[eagle-usb] New pre-firmware modem detected
[eagle-usb] Uploading firmware..
[eagle-usb] Binding eu_instance_t to USB 001/002
usb.c: USB disconnect on device 00:07.2-1 address 2
[eagle-usb] Pre-firmware modem removed
cannot open /proc/bus/usb/001/002, No such file or directory (2)
hub.c: new USB device 00:07.2-1, assigned address 3
[eagle-usb] New USB ADSL device detected, waiting for DSP code...
hint[eagle-usb] created proc entry at : /proc/driver/eagle-usb/001-003
[eagle-usb] ioctl EU_IO_OPTIONS received
Alberto Valverde
