Attachment 149669 Details for Bug 231581 – messages from dmesg (relevant tail of its output), with annotations

messages from dmesg (relevant tail of its output), with annotations

dmesg.toattach (text/plain; charset=UTF-8), 8.06 KB, created by David Baron on 2007-03-09 05:38:04 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: David Baron

Created: 2007-03-09 05:38:04 UTC

Size: 8.06 KB

patch

obsolete

>===ANNOTATION===> Not sure what triggered these:
>
>ADDRCONF(NETDEV_UP): eth1: link is not ready
>hermes @ 00014100: Timeout waiting for command 0x0002 completion.
>eth1: Unable to disable port while reconfiguring card
>eth1: Resetting instead...
>eth1: New link status: Disconnected (0002)
>orinoco_cs 0.0: suspend
>ADDRCONF(NETDEV_UP): eth0: link is not ready
>orinoco_cs 0.0: resuming
>orinoco_cs 0.0: resuming
>b44: eth0: Link is up at 100 Mbps, full duplex.
>b44: eth0: Flow control is off for TX and off for RX.
>ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
>orinoco_cs 0.0: suspend
>orinoco_cs 0.0: resuming
>orinoco_cs 0.0: resuming
>orinoco_cs 0.0: suspend
>orinoco_cs 0.0: resuming
>orinoco_cs 0.0: resuming
>orinoco_cs 0.0: suspend
>orinoco_cs 0.0: resuming
>orinoco_cs 0.0: resuming
>orinoco_cs 0.0: suspend
>orinoco_cs 0.0: resuming
>orinoco_cs 0.0: resuming
>eth0: no IPv6 routers present
>orinoco_cs 0.0: suspend
>orinoco_cs 0.0: resuming
>orinoco_cs 0.0: resuming
>orinoco_cs 0.0: suspend
>orinoco_cs 0.0: resuming
>orinoco_cs 0.0: resuming
>orinoco_cs 0.0: suspend
>orinoco_cs 0.0: resuming
>orinoco_cs 0.0: resuming
>b44: eth0: Link is down.
>orinoco_cs 0.0: suspend
>orinoco_cs 0.0: resuming
>orinoco_cs 0.0: resuming
>b44: eth0: Link is up at 100 Mbps, full duplex.
>b44: eth0: Flow control is off for TX and off for RX.
>ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
>b44: eth0: Link is down.
>orinoco_cs 0.0: suspend
>orinoco_cs 0.0: resuming
>orinoco_cs 0.0: resuming
>orinoco_cs 0.0: suspend
>orinoco_cs 0.0: resuming
>orinoco_cs 0.0: resuming
>orinoco_cs 0.0: suspend
>orinoco_cs 0.0: resuming
>orinoco_cs 0.0: resuming
>orinoco_cs 0.0: suspend
>orinoco_cs 0.0: resuming
>orinoco_cs 0.0: resuming
>ADDRCONF(NETDEV_UP): eth1: link is not ready
>b44: eth0: Link is up at 100 Mbps, full duplex.
>b44: eth0: Flow control is off for TX and off for RX.
>ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
>eth0: no IPv6 routers present
>orinoco_cs 0.0: suspend
>orinoco_cs 0.0: resuming
>orinoco_cs 0.0: resuming
>orinoco_cs 0.0: suspend
>orinoco_cs 0.0: resuming
>orinoco_cs 0.0: resuming
>orinoco_cs 0.0: suspend
>orinoco_cs 0.0: resuming
>orinoco_cs 0.0: resuming
>orinoco_cs 0.0: suspend
>orinoco_cs 0.0: resuming
>orinoco_cs 0.0: resuming
>orinoco_cs 0.0: suspend
>orinoco_cs 0.0: resuming
>orinoco_cs 0.0: resuming
>eth0: no IPv6 routers present
>pccard: card ejected from slot 0
>
>=======================================================
>[ INFO: possible circular locking dependency detected ]
>2.6.20-1.2975.fc7 #1
>-------------------------------------------------------
>pccardd/297 is trying to acquire lock:
> (rtnl_mutex){--..}, at: [<c061443a>] mutex_lock+0x21/0x24
>
>but task is already holding lock:
> (&socket->skt_mutex){--..}, at: [<c061443a>] mutex_lock+0x21/0x24
>
>which lock already depends on the new lock.
>
>
>the existing dependency chain (in reverse order) is:
>
>-> #1 (&socket->skt_mutex){--..}:
>       [<c04427f9>] __lock_acquire+0xa19/0xba4
>       [<c0442d76>] lock_acquire+0x56/0x6f
>       [<c06142a2>] __mutex_lock_slowpath+0xf7/0x26e
>       [<c061443a>] mutex_lock+0x21/0x24
>       [<c0567f01>] pccard_reset_card+0x1a/0x9d
>       [<f89ec129>] orinoco_cs_hard_reset+0x16/0x32 [orinoco_cs]
>       [<f8a64df3>] orinoco_reset+0xb6/0x185 [orinoco]
>       [<f8a65623>] orinoco_ioctl_commit+0x2f/0x100 [orinoco]
>       [<c060fa83>] ioctl_standard_call+0x2ae/0x2e5
>       [<c060fbaa>] wireless_process_ioctl+0x59/0x321
>       [<c060ed57>] wext_ioctl+0x4e/0x8d
>       [<c05b468d>] dev_ioctl+0x405/0x424
>       [<c05a9833>] sock_ioctl+0x1be/0x1c9
>       [<c04882a2>] do_ioctl+0x22/0x67
>       [<c0488539>] vfs_ioctl+0x252/0x265
>       [<c0488595>] sys_ioctl+0x49/0x64
>       [<c040507c>] syscall_call+0x7/0xb
>       [<ffffffff>] 0xffffffff
>
>-> #0 (rtnl_mutex){--..}:
>       [<c04426dd>] __lock_acquire+0x8fd/0xba4
>       [<c0442d76>] lock_acquire+0x56/0x6f
>       [<c06142a2>] __mutex_lock_slowpath+0xf7/0x26e
>       [<c061443a>] mutex_lock+0x21/0x24
>       [<c05ba243>] rtnl_lock+0xd/0xf
>       [<c05b3855>] unregister_netdev+0xb/0x1a
>       [<f89ec101>] orinoco_cs_detach+0x1a/0x2c [orinoco_cs]
>       [<c056bc39>] pcmcia_device_remove+0x53/0xb9
>       [<c0561a92>] __device_release_driver+0x74/0x90
>       [<c0561f11>] device_release_driver+0x35/0x4c
>       [<c056149f>] bus_remove_device+0x73/0x82
>       [<c055faf9>] device_del+0x16e/0x1cb
>       [<c055fb61>] device_unregister+0xb/0x15
>       [<c056b85d>] pcmcia_card_remove+0x5a/0x7d
>       [<c056c456>] ds_event+0x59/0x8b
>       [<c0567ece>] send_event+0x40/0x59
>       [<c05680b9>] socket_remove_drivers+0x12/0x14
>       [<c05680ca>] socket_shutdown+0xf/0xb5
>       [<c0568196>] socket_remove+0x26/0x2b
>       [<c056876d>] pccardd+0x12a/0x1e6
>       [<c0438257>] kthread+0xb3/0xdc
>       [<c0405cd7>] kernel_thread_helper+0x7/0x10
>       [<ffffffff>] 0xffffffff
>
>other info that might help us debug this:
>
>1 lock held by pccardd/297:
> #0:  (&socket->skt_mutex){--..}, at: [<c061443a>] mutex_lock+0x21/0x24
>
>stack backtrace:
> [<c04061ed>] show_trace_log_lvl+0x1a/0x2f
> [<c04067b1>] show_trace+0x12/0x14
> [<c0406835>] dump_stack+0x16/0x18
> [<c0440ef0>] print_circular_bug_tail+0x5f/0x68
> [<c04426dd>] __lock_acquire+0x8fd/0xba4
> [<c0442d76>] lock_acquire+0x56/0x6f
> [<c06142a2>] __mutex_lock_slowpath+0xf7/0x26e
> [<c061443a>] mutex_lock+0x21/0x24
> [<c05ba243>] rtnl_lock+0xd/0xf
> [<c05b3855>] unregister_netdev+0xb/0x1a
> [<f89ec101>] orinoco_cs_detach+0x1a/0x2c [orinoco_cs]
> [<c056bc39>] pcmcia_device_remove+0x53/0xb9
> [<c0561a92>] __device_release_driver+0x74/0x90
> [<c0561f11>] device_release_driver+0x35/0x4c
> [<c056149f>] bus_remove_device+0x73/0x82
> [<c055faf9>] device_del+0x16e/0x1cb
> [<c055fb61>] device_unregister+0xb/0x15
> [<c056b85d>] pcmcia_card_remove+0x5a/0x7d
> [<c056c456>] ds_event+0x59/0x8b
> [<c0567ece>] send_event+0x40/0x59
> [<c05680b9>] socket_remove_drivers+0x12/0x14
> [<c05680ca>] socket_shutdown+0xf/0xb5
> [<c0568196>] socket_remove+0x26/0x2b
> [<c056876d>] pccardd+0x12a/0x1e6
> [<c0438257>] kthread+0xb3/0xdc
> [<c0405cd7>] kernel_thread_helper+0x7/0x10
> =======================
>PM: Removing info for No Bus:eth1
>PM: Removing info for pcmcia:0.0
>pccard: PCMCIA card inserted into slot 0
>pcmcia: registering new device pcmcia0.0
>PM: Adding info for pcmcia:0.0
>eth1: Hardware identity 0001:0001:0004:0000
>eth1: Station identity  001f:0001:0007:001c
>eth1: Firmware determined as Lucent/Agere 7.28
>eth1: Ad-hoc demo mode supported
>eth1: IEEE standard IBSS ad-hoc mode supported
>eth1: WEP supported, 104-bit key
>eth1: MAC address 00:02:2D:01:F6:A6
>eth1: Station name "HERMES I"
>eth1: ready
>PM: Adding info for No Bus:eth1
>eth1: orinoco_cs at 0.0, irq 3, io 0x4100-0x413f
>ADDRCONF(NETDEV_UP): eth1: link is not ready
>eth1: New link status: Disconnected (0002)
>pccard: card ejected from slot 0
>PM: Removing info for No Bus:eth1
>PM: Removing info for pcmcia:0.0
>
>===ANNOTATION===> I inserted the card, and:
>
>pccard: PCMCIA card inserted into slot 0
>pcmcia: registering new device pcmcia0.0
>PM: Adding info for pcmcia:0.0
>eth1: Hardware identity 0001:0001:0004:0000
>eth1: Station identity  001f:0001:0007:001c
>eth1: Firmware determined as Lucent/Agere 7.28
>eth1: Ad-hoc demo mode supported
>eth1: IEEE standard IBSS ad-hoc mode supported
>eth1: WEP supported, 104-bit key
>eth1: MAC address 00:02:2D:01:F6:A6
>eth1: Station name "HERMES I"
>eth1: ready
>PM: Adding info for No Bus:eth1
>eth1: orinoco_cs at 0.0, irq 3, io 0x4100-0x413f
>ADDRCONF(NETDEV_UP): eth1: link is not ready
>
>===ANNOTATION===> And then I did /sbin/ifup eth0 and:
>
>ADDRCONF(NETDEV_UP): eth1: link is not ready
>
>===ANNOTATION===> And then I started NetworkManager and tried to connect to the network:
>
>b44: eth0: Link is down.
>ADDRCONF(NETDEV_UP): eth1: link is not ready
>eth1: New link status: Disconnected (0002)
>
>===ANNOTATION===> And then I stopped network manager and did /sbin/iwlist eth1 scan:
>
>ADDRCONF(NETDEV_UP): eth1: link is not ready
>eth1: New link status: Disconnected (0002)
>hermes @ 00014100: Timeout waiting for command 0x0002 completion.
>eth1: Unable to disable port while reconfiguring card
>eth1: Resetting instead...
>orinoco_cs 0.0: suspend
>orinoco_cs 0.0: resuming
>orinoco_cs 0.0: resuming
>
>===ANNOTATION===> And then I ejected the card:
>
>pccard: card ejected from slot 0
>PM: Removing info for No Bus:eth1
>PM: Removing info for pcmcia:0.0

Actions: View

Attachments on bug 231581: 149669