Bug#454661: linux-image-2.6.22-3-686: locks up or crashes, errors in tg3, psmouse and usb (2.6.22-2 worked fine)
On Sat, 8 Dec 2007 14:24:07 +0100, maximilian attems <max@stro.at> wrote:
> hmm did you run memtest on your box?
Yes, the memory is fine. But see below...
> > So 2.6.23 seems to work better than 2.6.22-3, but it still produces this
> > strange error that I did not experience before with 2.6.22-2 or earlier
> > kernels.
>
> hmm above warants an entry in bugzilla.kernel.org for tg3
> please tell us the resulting bugnumber.
After several more days of testing, the crashes or sudden freezes became
more frequent with 2.6.22-3 or 2.6.23. And then I tried again with 2.6.22-2
and I managed to get the same problem. I found that if I pushed a bit on the
side of the keyboard or if I attempted to move the laptop slightly while it
was in its docking station, then I could get a crash most of the time.
Conclusion: this is not a kernel problem. This is a hardware problem and it
was apparently a pure coincidence that it occurred first just after upgrading
my kernel. It was also just pure luck that it did not occur again while I
reverted to the older version, but it came back when I tried another time with
the newer kernels (2.6.22-3 or 2.6.23). I suspect that the hardware became
sentient and was actively trying to confuse me. But now that I found a way
to reproduce the problem at will with a light twist of the laptop's frame, I
know that the hardware is the culprit.
I think that you can close this bug report because it was not Debian's fault
and it is unlikely that others will be affected by the same problem. I will
get a replacement laptop in a few days and get rid of the current one that
had served me faithfully during the last three years (until last week).
But just in case someone would still look at this bug report, here is another
example of scary messages that I got while the machine was misbehaving. I am
including this just for the entertainment value. Note hat the timestamps are
unreliable because when this problem occurs, it looks like the whole CPU is
locked for a while and this resulted in the clock being off by several
minutes at the end of the test.
-Raphaël
Dec 13 12:04:59 bora-bora -- MARK --
Dec 13 12:24:59 bora-bora -- MARK --
Dec 13 12:31:57 bora-bora kernel: tg3: eth0: Link is down.
Dec 13 12:31:57 bora-bora kernel: tg3: eth0: The system may be re-ordering memory-mapped I/O cycles to the network device, attempting to recover. Please report the problem to the driver maintainer and include system chipset information.
Dec 13 12:31:57 bora-bora kernel: Clocksource tsc unstable (delta = 149987751981 ns)
Dec 13 12:32:12 bora-bora kernel: tg3: eth0: No firmware running.
Dec 13 12:32:12 bora-bora kernel:
Dec 13 12:32:12 bora-bora kernel: Pid: 6, comm: events/0
Dec 13 12:32:12 bora-bora kernel: EIP: 0060:[<f8be31ec>] CPU: 0
Dec 13 12:32:12 bora-bora kernel: EIP is at tg3_read32+0x5/0x6 [tg3]
Dec 13 12:32:12 bora-bora kernel: EFLAGS: 00000282 Tainted: P (2.6.23-1-686 #1)
Dec 13 12:32:12 bora-bora kernel: EAX: ffffffff EBX: 000012b7 ECX: 00000000 EDX: f8ba044c
Dec 13 12:32:12 bora-bora kernel: ESI: dfac9420 EDI: c18eff00 EBP: 000203fe DS: 007b ES: 007b FS: 00d8
Dec 13 12:32:12 bora-bora kernel: CR0: 8005003b CR2: b7f98000 CR3: 1fbee000 CR4: 000006d0
Dec 13 12:32:12 bora-bora kernel: DR0: 00000000 DR1: 00000000 DR2: 00000000 DR3: 00000000
Dec 13 12:32:12 bora-bora kernel: DR6: ffff0ff0 DR7: 00000400
Dec 13 12:32:12 bora-bora kernel: [<f8bdbb23>] tg3_readphy+0x78/0xd5 [tg3]
Dec 13 12:32:12 bora-bora kernel: [<f8bdcf32>] tg3_setup_copper_phy+0x30b/0x9e6 [tg3]
Dec 13 12:32:12 bora-bora kernel: [<c010655b>] do_IRQ+0x5a/0x6f
Dec 13 12:32:12 bora-bora kernel: [<c014eece>] handle_level_irq+0xad/0xb7
Dec 13 12:32:12 bora-bora kernel: [<f8bde27f>] tg3_setup_phy+0xc72/0xd33 [tg3]
Dec 13 12:32:12 bora-bora kernel: [<f8bdaf3a>] _tw32_flush+0x3f/0x51 [tg3]
Dec 13 12:32:12 bora-bora kernel: [<f8bdcaab>] tg3_write_mem+0xcf/0xe7 [tg3]
Dec 13 12:32:12 bora-bora kernel: [<f8be05d2>] tg3_reset_hw+0xdbd/0x1064 [tg3]
Dec 13 12:32:12 bora-bora kernel: [<c01d5c0a>] __delay+0x6/0x7
Dec 13 12:32:12 bora-bora kernel: [<f8bdc8f8>] tg3_switch_clocks+0x8f/0x93 [tg3]
Dec 13 12:32:12 bora-bora kernel: [<f8be73de>] tg3_reset_task+0xea/0x13c [tg3]
Dec 13 12:32:12 bora-bora kernel: [<f8be72f4>] tg3_reset_task+0x0/0x13c [tg3]
Dec 13 12:32:12 bora-bora kernel: [<c0130ced>] run_workqueue+0x7d/0x109
Dec 13 12:32:12 bora-bora kernel: [<c0131563>] worker_thread+0x0/0xc5
Dec 13 12:32:12 bora-bora kernel: [<c013161d>] worker_thread+0xba/0xc5
Dec 13 12:32:12 bora-bora kernel: [<c0133cfd>] autoremove_wake_function+0x0/0x35
Dec 13 12:32:12 bora-bora kernel: [<c0133c34>] kthread+0x38/0x60
Dec 13 12:32:12 bora-bora kernel: [<c0133bfc>] kthread+0x0/0x60
Dec 13 12:32:12 bora-bora kernel: [<c0104ac7>] kernel_thread_helper+0x7/0x10
Dec 13 12:32:12 bora-bora kernel: =======================
Dec 13 12:32:13 bora-bora dhcdbd: dhco_parse_option_settings: bad option setting: old_server_name =
Dec 13 12:32:13 bora-bora dhcdbd: dhclient 3794 down (9) but si_code == 0 and releasing==0 !
Dec 13 12:32:28 bora-bora kernel:
Dec 13 12:32:28 bora-bora kernel: Pid: 707, comm: ifconfig
Dec 13 12:32:28 bora-bora kernel: EIP: 0060:[<f8be31ec>] CPU: 0
Dec 13 12:32:28 bora-bora kernel: EIP is at tg3_read32+0x5/0x6 [tg3]
Dec 13 12:32:28 bora-bora kernel: EFLAGS: 00000282 Tainted: P (2.6.23-1-686 #1)
Dec 13 12:32:28 bora-bora kernel: EAX: ffffffff EBX: 0000081c ECX: 00000000 EDX: f8ba044c
Dec 13 12:32:28 bora-bora kernel: ESI: dfac9420 EDI: dccfbe24 EBP: 0000004c DS: 007b ES: 007b FS: 00d8
Dec 13 12:32:28 bora-bora kernel: CR0: 8005003b CR2: 0812c000 CR3: 1fafe000 CR4: 000006d0
Dec 13 12:32:28 bora-bora kernel: DR0: 00000000 DR1: 00000000 DR2: 00000000 DR3: 00000000
Dec 13 12:32:28 bora-bora kernel: DR6: ffff0ff0 DR7: 00000400
Dec 13 12:32:28 bora-bora kernel: [<f8bdbb23>] tg3_readphy+0x78/0xd5 [tg3]
Dec 13 12:32:28 bora-bora kernel: [<f8bdcf32>] tg3_setup_copper_phy+0x30b/0x9e6 [tg3]
Dec 13 12:32:28 bora-bora kernel: [<f8bde27f>] tg3_setup_phy+0xc72/0xd33 [tg3]
Dec 13 12:32:28 bora-bora kernel: [<c0244641>] pci_read+0x29/0x2e
Dec 13 12:32:28 bora-bora kernel: [<c01d8628>] pci_bus_read_config_word+0x62/0x6c
Dec 13 12:32:28 bora-bora kernel: [<f8bde9f9>] tg3_set_power_state+0x17b/0x75f [tg3]
Dec 13 12:32:28 bora-bora kernel: [<f8be3135>] tg3_free_consistent+0x14e/0x15e [tg3]
Dec 13 12:32:28 bora-bora kernel: [<f8be6b36>] tg3_close+0xd1/0xe0 [tg3]
Dec 13 12:32:28 bora-bora kernel: [<c024fce6>] dev_close+0x4b/0x67
Dec 13 12:32:28 bora-bora kernel: [<c024f17e>] dev_change_flags+0x9d/0x14e
Dec 13 12:32:28 bora-bora kernel: [<c028d097>] devinet_ioctl+0x224/0x532
Dec 13 12:32:28 bora-bora kernel: [<c0250763>] dev_ifsioc+0x113/0x396
Dec 13 12:32:28 bora-bora kernel: [<c024563b>] sock_ioctl+0x0/0x1be
Dec 13 12:32:28 bora-bora kernel: [<c02457da>] sock_ioctl+0x19f/0x1be
Dec 13 12:32:28 bora-bora kernel: [<c024563b>] sock_ioctl+0x0/0x1be
Dec 13 12:32:28 bora-bora kernel: [<c0177147>] do_ioctl+0x1f/0x62
Dec 13 12:32:28 bora-bora kernel: [<c01773c1>] vfs_ioctl+0x237/0x249
Dec 13 12:32:28 bora-bora kernel: [<c017741f>] sys_ioctl+0x4c/0x65
Dec 13 12:32:28 bora-bora kernel: [<c0103e8e>] syscall_call+0x7/0xb
Dec 13 12:32:28 bora-bora kernel: [<c02a0000>] __unix_insert_socket+0x41/0x51
Dec 13 12:32:28 bora-bora kernel: =======================
Dec 13 12:32:44 bora-bora kernel:
Dec 13 12:32:44 bora-bora kernel: Pid: 3046, comm: ifd
Dec 13 12:32:44 bora-bora kernel: EIP: 0060:[<c01d5c4d>] CPU: 0
Dec 13 12:32:44 bora-bora kernel: EIP is at delay_tsc+0x21/0x3d
Dec 13 12:32:44 bora-bora kernel: EFLAGS: 00000297 Tainted: P (2.6.23-1-686 #1)
Dec 13 12:32:44 bora-bora kernel: EAX: 7a0b878f EBX: 00000f37 ECX: 00000000 EDX: 00000dc1
Dec 13 12:32:44 bora-bora kernel: ESI: 7a0b8750 EDI: f7cd1e0c EBP: 7a0b81ff DS: 007b ES: 007b FS: 00d8
Dec 13 12:32:44 bora-bora kernel: CR0: 8005003b CR2: b7f3d000 CR3: 0198a000 CR4: 000006d0
Dec 13 12:32:44 bora-bora kernel: DR0: 00000000 DR1: 00000000 DR2: 00000000 DR3: 00000000
Dec 13 12:32:44 bora-bora kernel: DR6: ffff0ff0 DR7: 00000400
Dec 13 12:32:44 bora-bora kernel: [<c01d5c0a>] __delay+0x6/0x7
Dec 13 12:32:44 bora-bora kernel: [<f8bdbb19>] tg3_readphy+0x6e/0xd5 [tg3]
Dec 13 12:32:44 bora-bora kernel: [<f8bdcf24>] tg3_setup_copper_phy+0x2fd/0x9e6 [tg3]
Dec 13 12:32:44 bora-bora kernel: [<c010655b>] do_IRQ+0x5a/0x6f
Dec 13 12:32:44 bora-bora kernel: [<c014eece>] handle_level_irq+0xad/0xb7
Dec 13 12:32:44 bora-bora kernel: [<f8bde27f>] tg3_setup_phy+0xc72/0xd33 [tg3]
Dec 13 12:32:44 bora-bora kernel: [<f8bdaf3a>] _tw32_flush+0x3f/0x51 [tg3]
Dec 13 12:32:44 bora-bora kernel: [<f8bdcaab>] tg3_write_mem+0xcf/0xe7 [tg3]
Dec 13 12:32:44 bora-bora kernel: [<f8be05d2>] tg3_reset_hw+0xdbd/0x1064 [tg3]
Dec 13 12:32:44 bora-bora kernel: [<c01d5c0a>] __delay+0x6/0x7
Dec 13 12:32:44 bora-bora kernel: [<f8bdc8f8>] tg3_switch_clocks+0x8f/0x93 [tg3]
Dec 13 12:32:44 bora-bora kernel: [<f8be6787>] tg3_open+0x25a/0x538 [tg3]
Dec 13 12:32:44 bora-bora kernel: [<c0250e75>] dev_open+0x2e/0x68
Dec 13 12:32:44 bora-bora kernel: [<c024f17e>] dev_change_flags+0x9d/0x14e
Dec 13 12:32:44 bora-bora kernel: [<c028d097>] devinet_ioctl+0x224/0x532
Dec 13 12:32:44 bora-bora kernel: [<c0250763>] dev_ifsioc+0x113/0x396
Dec 13 12:32:44 bora-bora kernel: [<c024563b>] sock_ioctl+0x0/0x1be
Dec 13 12:32:44 bora-bora kernel: [<c02457da>] sock_ioctl+0x19f/0x1be
Dec 13 12:32:44 bora-bora kernel: [<c024563b>] sock_ioctl+0x0/0x1be
Dec 13 12:32:44 bora-bora kernel: [<c0177147>] do_ioctl+0x1f/0x62
Dec 13 12:32:44 bora-bora kernel: [<c01773c1>] vfs_ioctl+0x237/0x249
Dec 13 12:32:44 bora-bora kernel: [<c017741f>] sys_ioctl+0x4c/0x65
Dec 13 12:32:44 bora-bora kernel: [<c0103e8e>] syscall_call+0x7/0xb
Dec 13 12:32:44 bora-bora kernel: =======================
Dec 13 12:32:44 bora-bora kernel: ADDRCONF(NETDEV_UP): eth0: link is not ready
Dec 13 12:46:58 bora-bora -- MARK --
Dec 13 13:06:58 bora-bora -- MARK --
Dec 13 13:08:46 bora-bora shutdown[3800]: shutting down for system reboot
Dec 13 13:09:03 bora-bora kernel:
Dec 13 13:09:03 bora-bora kernel: Pid: 3744, comm: NetworkManager
Dec 13 13:09:03 bora-bora kernel: EIP: 0060:[<c01d5c4b>] CPU: 0
Dec 13 13:09:03 bora-bora kernel: EIP is at delay_tsc+0x1f/0x3d
Dec 13 13:09:03 bora-bora kernel: EFLAGS: 00000282 Tainted: P (2.6.23-1-686 #1)
Dec 13 13:09:03 bora-bora kernel: EAX: cc9b565e EBX: 00000089 ECX: 00000000 EDX: 000010b7
Dec 13 13:09:03 bora-bora kernel: ESI: cc9b565e EDI: f7ac5b34 EBP: cc9b565e DS: 007b ES: 007b FS: 00d8
Dec 13 13:09:03 bora-bora kernel: CR0: 8005003b CR2: b7eda070 CR3: 1faae000 CR4: 000006d0
Dec 13 13:09:03 bora-bora kernel: DR0: 00000000 DR1: 00000000 DR2: 00000000 DR3: 00000000
Dec 13 13:09:03 bora-bora kernel: DR6: ffff0ff0 DR7: 00000400
Dec 13 13:09:03 bora-bora kernel: [<c01d5c0a>] __delay+0x6/0x7
Dec 13 13:09:03 bora-bora kernel: [<f8bdbb19>] tg3_readphy+0x6e/0xd5 [tg3]
Dec 13 13:09:03 bora-bora kernel: [<f8bdcf32>] tg3_setup_copper_phy+0x30b/0x9e6 [tg3]
Dec 13 13:09:03 bora-bora kernel: [<f8bde27f>] tg3_setup_phy+0xc72/0xd33 [tg3]
Dec 13 13:09:03 bora-bora kernel: [<c0244641>] pci_read+0x29/0x2e
Dec 13 13:09:03 bora-bora kernel: [<c01d8628>] pci_bus_read_config_word+0x62/0x6c
Dec 13 13:09:03 bora-bora kernel: [<f8bde9f9>] tg3_set_power_state+0x17b/0x75f [tg3]
Dec 13 13:09:03 bora-bora kernel: [<f8be3135>] tg3_free_consistent+0x14e/0x15e [tg3]
Dec 13 13:09:03 bora-bora kernel: [<f8be6b36>] tg3_close+0xd1/0xe0 [tg3]
Dec 13 13:09:03 bora-bora kernel: [<c024fce6>] dev_close+0x4b/0x67
Dec 13 13:09:03 bora-bora kernel: [<c024f17e>] dev_change_flags+0x9d/0x14e
Dec 13 13:09:03 bora-bora kernel: [<c02566fe>] do_setlink+0x1b5/0x27c
Dec 13 13:09:03 bora-bora kernel: [<c025774e>] rtnl_setlink+0x0/0xeb
Dec 13 13:09:03 bora-bora kernel: [<c025781e>] rtnl_setlink+0xd0/0xeb
Dec 13 13:09:03 bora-bora kernel: [<c0264d98>] netlink_dump_start+0xf9/0x11c
Dec 13 13:09:03 bora-bora kernel: [<c025715b>] rtnetlink_rcv_msg+0x1a1/0x1bb
Dec 13 13:09:03 bora-bora kernel: [<c0256e94>] rtnl_dump_ifinfo+0x0/0x7d
Dec 13 13:09:03 bora-bora kernel: [<c0263c90>] netlink_run_queue+0x5c/0xd2
Dec 13 13:09:03 bora-bora kernel: [<c0256fba>] rtnetlink_rcv_msg+0x0/0x1bb
Dec 13 13:09:03 bora-bora kernel: [<c0256f4a>] rtnetlink_rcv+0x25/0x3d
Dec 13 13:09:03 bora-bora kernel: [<c02640f8>] netlink_data_ready+0x12/0x4c
Dec 13 13:09:03 bora-bora kernel: [<c02630b2>] netlink_sendskb+0x19/0x30
Dec 13 13:09:03 bora-bora kernel: [<c026398f>] netlink_unicast+0x1a5/0x1b1
Dec 13 13:09:03 bora-bora kernel: [<c02640da>] netlink_sendmsg+0x267/0x273
Dec 13 13:09:03 bora-bora kernel: [<c0245fb8>] sock_sendmsg+0xd0/0xeb
Dec 13 13:09:03 bora-bora kernel: [<c0133cfd>] autoremove_wake_function+0x0/0x35
Dec 13 13:09:03 bora-bora last message repeated 2 times
Dec 13 13:09:03 bora-bora kernel: [<c0246165>] sys_sendmsg+0x192/0x1f7
Dec 13 13:09:03 bora-bora kernel: [<c0246b01>] sys_recvmsg+0x1bc/0x1d0
Dec 13 13:09:03 bora-bora kernel: [<c026330f>] netlink_insert+0x10f/0x119
Dec 13 13:09:03 bora-bora kernel: [<c015d384>] handle_mm_fault+0x65f/0x6da
Dec 13 13:09:03 bora-bora kernel: [<c0246dca>] sys_getsockname+0x9f/0xb0
Dec 13 13:09:03 bora-bora kernel: [<c0247a0c>] release_sock+0x12/0x8e
Dec 13 13:09:03 bora-bora kernel: [<c02491d9>] sock_setsockopt+0x4d1/0x4e9
Dec 13 13:09:03 bora-bora kernel: [<c017bfa8>] d_alloc+0x138/0x17b
Dec 13 13:09:03 bora-bora kernel: [<c02471cf>] sys_socketcall+0x223/0x242
Dec 13 13:09:03 bora-bora kernel: [<c011ac62>] do_page_fault+0x0/0x5f2
Dec 13 13:09:03 bora-bora kernel: [<c0103e8e>] syscall_call+0x7/0xb
Dec 13 13:09:03 bora-bora kernel: [<c02a0000>] __unix_insert_socket+0x41/0x51
Dec 13 13:09:03 bora-bora kernel: =======================
Dec 13 13:09:19 bora-bora kernel:
Dec 13 13:09:19 bora-bora kernel: Pid: 3046, comm: ifd
Dec 13 13:09:19 bora-bora kernel: EIP: 0060:[<c01d5c4d>] CPU: 0
Dec 13 13:09:19 bora-bora kernel: EIP is at delay_tsc+0x21/0x3d
Dec 13 13:09:19 bora-bora kernel: EFLAGS: 00000293 Tainted: P (2.6.23-1-686 #1)
Dec 13 13:09:19 bora-bora kernel: EAX: d79a623b EBX: 0000005d ECX: 00000000 EDX: 000010bd
Dec 13 13:09:19 bora-bora kernel: ESI: d79a61ff EDI: f7cd1e0c EBP: d79a5d29 DS: 007b ES: 007b FS: 00d8
Dec 13 13:09:19 bora-bora kernel: CR0: 80050033 CR2: b7f3d000 CR3: 0198a000 CR4: 000006d0
Dec 13 13:09:19 bora-bora kernel: DR0: 00000000 DR1: 00000000 DR2: 00000000 DR3: 00000000
Dec 13 13:09:19 bora-bora kernel: DR6: ffff0ff0 DR7: 00000400
Dec 13 13:09:19 bora-bora kernel: [<c01d5c0a>] __delay+0x6/0x7
Dec 13 13:09:19 bora-bora kernel: [<f8bdbb19>] tg3_readphy+0x6e/0xd5 [tg3]
Dec 13 13:09:19 bora-bora kernel: [<f8bdcf32>] tg3_setup_copper_phy+0x30b/0x9e6 [tg3]
Dec 13 13:09:19 bora-bora kernel: [<c010655b>] do_IRQ+0x5a/0x6f
Dec 13 13:09:19 bora-bora kernel: [<f8bde27f>] tg3_setup_phy+0xc72/0xd33 [tg3]
Dec 13 13:09:19 bora-bora kernel: [<f8bdaf3a>] _tw32_flush+0x3f/0x51 [tg3]
Dec 13 13:09:19 bora-bora kernel: [<f8bdcaab>] tg3_write_mem+0xcf/0xe7 [tg3]
Dec 13 13:09:19 bora-bora kernel: [<f8be05d2>] tg3_reset_hw+0xdbd/0x1064 [tg3]
Dec 13 13:09:19 bora-bora kernel: [<c01d5c0a>] __delay+0x6/0x7
Dec 13 13:09:19 bora-bora kernel: [<f8bdc8f8>] tg3_switch_clocks+0x8f/0x93 [tg3]
Dec 13 13:09:19 bora-bora kernel: [<f8be6787>] tg3_open+0x25a/0x538 [tg3]
Dec 13 13:09:19 bora-bora kernel: [<c0250e75>] dev_open+0x2e/0x68
Dec 13 13:09:19 bora-bora kernel: [<c024f17e>] dev_change_flags+0x9d/0x14e
Dec 13 13:09:19 bora-bora kernel: [<c028d097>] devinet_ioctl+0x224/0x532
Dec 13 13:09:19 bora-bora kernel: [<c0250763>] dev_ifsioc+0x113/0x396
Dec 13 13:09:19 bora-bora kernel: [<c024563b>] sock_ioctl+0x0/0x1be
Dec 13 13:09:19 bora-bora kernel: [<c02457da>] sock_ioctl+0x19f/0x1be
Dec 13 13:09:19 bora-bora kernel: [<c024563b>] sock_ioctl+0x0/0x1be
Dec 13 13:09:19 bora-bora kernel: [<c0177147>] do_ioctl+0x1f/0x62
Dec 13 13:09:19 bora-bora kernel: [<c01773c1>] vfs_ioctl+0x237/0x249
Dec 13 13:09:19 bora-bora kernel: [<c017741f>] sys_ioctl+0x4c/0x65
Dec 13 13:09:19 bora-bora kernel: [<c0103e8e>] syscall_call+0x7/0xb
Dec 13 13:09:19 bora-bora kernel: =======================
Dec 13 13:09:19 bora-bora kernel: ADDRCONF(NETDEV_UP): eth0: link is not ready
Dec 13 13:09:27 bora-bora kernel: Kernel logging (proc) stopped.
Dec 13 13:09:27 bora-bora kernel: Kernel log daemon terminating.
Dec 13 13:09:28 bora-bora exiting on signal 15
Reply to: