Hi,
a few more details.
On Sun, 16 Sep 2007, Gavin McCullagh wrote:
> I have a linksys WPC54GS pcmcia wifi card. lspci details below. I tried
> it with the latest firmware and Ubuntu gutsy's 2.6.22-10-generic and
> 2.6.22-11-generic kernels.
> I went onto the IRC channel and noted the suggestion that I try the
> wireless-dev tree (2.6.23-rc4). So I did and I'm glad to say successfully.
> I'm using it now and have been for the past 6-8 hours on and off without
> any reboot or problems.
A little more feedback on my experiences with this driver.
The first time I booted up, logged in (to gnome) and then popped in the
pcmcia card. The key manager prompted for password to unlock it and I got
straight onto the WPA wifi network (192.168.10.0/24). This worked fine and
continues to.
Later I tried to boot up with the card in. I logged in and network-manager
connected to an unencrypted network (192.168.182.0/24). Not wanting that,
I clicked on the network manager and selected the WPA network. Nothing
much happened, according to the applet and the ip address and essid didn't
change according to iwconfig/ifconfig. Eventually the applet disappeared
and restarting it didn't work. In syslog, it showed that NetworkManager
had crashed. A full log is below.
It seems there is a problem switching network but as long as I start it on
the WPA one, all is fine. I realise this driver is still experimental so
perhaps this behaviour is normal and as I know how to make it work reliably
it's okay. However, if you need more information let me know. It seems
pretty reproducible.
Gavin
> [EMAIL PROTECTED]:~$ lspci -v -s 02:00.0
> 02:00.0 Network controller: Broadcom Corporation BCM4318 [AirForce One 54g]
> 802.11g Wireless LAN Controller (rev 02)
> Subsystem: Linksys Unknown device 0049
> Flags: bus master, fast devsel, latency 64, IRQ 10
> Memory at 24000000 (32-bit, non-prefetchable) [size=8K]
>
> [EMAIL PROTECTED]:~$ lspci -vn -s 02:00.0
> 02:00.0 0280: 14e4:4318 (rev 02)
> Subsystem: 1737:0049
> Flags: bus master, fast devsel, latency 64, IRQ 10
> Memory at 24000000 (32-bit, non-prefetchable) [size=8K]
Sep 17 20:17:28 tilly kernel: [ 106.569612] lo: Disabled Privacy Extensions
Sep 17 20:17:28 tilly kernel: [ 106.570443] ADDRCONF(NETDEV_UP): eth0: link is
not ready
Sep 17 20:17:28 tilly kernel: [ 106.570500] ADDRCONF(NETDEV_UP): eth1: link is
not ready
Sep 17 20:17:33 tilly hcid[4838]: Default passkey agent (:1.14,
/org/bluez/passkey) registered
Sep 17 20:17:33 tilly hcid[4838]: Default authorization agent (:1.14,
/org/bluez/auth) registered
Sep 17 20:17:48 tilly NetworkManager: <info> Updating allowed wireless network
lists.
Sep 17 20:17:48 tilly NetworkManager: <info> SWITCH: no current connection,
found better connection 'eth1'.
Sep 17 20:17:48 tilly dhcdbd: message_handler: message handler not found under
/com/redhat/dhcp/eth1 for sub-path eth1.dbus.get.reason
Sep 17 20:17:48 tilly NetworkManager: <info> Will activate connection
'eth1/FON_TEST'.
Sep 17 20:17:48 tilly NetworkManager: <info> Device eth1 activation
scheduled...
Sep 17 20:17:48 tilly NetworkManager: <info> Activation (eth1) started...
Sep 17 20:17:48 tilly NetworkManager: <info> Activation (eth1) Stage 1 of 5
(Device Prepare) scheduled...
Sep 17 20:17:48 tilly NetworkManager: <info> Activation (eth1) Stage 1 of 5
(Device Prepare) started...
Sep 17 20:17:48 tilly NetworkManager: <info> Activation (eth1) Stage 2 of 5
(Device Configure) scheduled...
Sep 17 20:17:48 tilly NetworkManager: <info> Activation (eth1) Stage 1 of 5
(Device Prepare) complete.
Sep 17 20:17:48 tilly NetworkManager: <info> Activation (eth1) Stage 2 of 5
(Device Configure) starting...
Sep 17 20:17:48 tilly NetworkManager: <info> Activation (eth1/wireless):
access point 'FON_TEST' is unencrypted, no key needed.
Sep 17 20:17:48 tilly NetworkManager: <info> Old device 'eth1' activating,
won't change.
Sep 17 20:17:49 tilly NetworkManager: <info> supplicant_interface_init() -
connect to global ctrl socket (0/10).
Sep 17 20:17:49 tilly NetworkManager: <info> supplicant_interface_init() -
connect to global ctrl socket (1/10).
Sep 17 20:17:50 tilly NetworkManager: <info> supplicant_interface_init() -
connect to global ctrl socket (2/10).
Sep 17 20:17:50 tilly NetworkManager: <info> supplicant_interface_init() -
connect to global ctrl socket (3/10).
Sep 17 20:17:50 tilly NetworkManager: <info> supplicant_interface_init() -
connect to global ctrl socket (4/10).
Sep 17 20:17:50 tilly NetworkManager: <info> SUP: sending command
'INTERFACE_ADD eth1^I^Iwext^I/var/run/wpa_supplicant2^I'
Sep 17 20:17:50 tilly kernel: [ 122.379900] NET: Registered protocol family 17
Sep 17 20:17:50 tilly NetworkManager: <info> SUP: response was 'OK'
Sep 17 20:17:50 tilly NetworkManager: <info> supplicant_init() - connect to
device ctrl socket (6/10).
Sep 17 20:17:50 tilly NetworkManager: <info> SUP: sending command 'AP_SCAN 1'
Sep 17 20:17:50 tilly NetworkManager: <info> SUP: response was 'OK'
Sep 17 20:17:50 tilly NetworkManager: <info> SUP: sending command
'ADD_NETWORK'
Sep 17 20:17:50 tilly NetworkManager: <info> SUP: response was '0'
Sep 17 20:17:50 tilly NetworkManager: <info> SUP: sending command 'SET_NETWORK
0 ssid 464f4e5f474156'
Sep 17 20:17:50 tilly NetworkManager: <info> SUP: response was 'OK'
Sep 17 20:17:50 tilly NetworkManager: <info> SUP: sending command 'SET_NETWORK
0 key_mgmt NONE'
Sep 17 20:17:50 tilly NetworkManager: <info> SUP: response was 'OK'
Sep 17 20:17:50 tilly NetworkManager: <info> SUP: sending command
'ENABLE_NETWORK 0'
Sep 17 20:17:50 tilly NetworkManager: <info> SUP: response was 'OK'
Sep 17 20:17:50 tilly NetworkManager: <info> Activation (eth1) Stage 2 of 5
(Device Configure) complete.
Sep 17 20:17:51 tilly kernel: [ 122.725655] SoftMAC: Open Authentication
completed with 00:18:84:11:78:d5
Sep 17 20:17:51 tilly NetworkManager: <info> Activation (eth1/wireless) Stage
2 of 5 (Device Configure) successful. Connected to access point 'FON_TEST'.
Sep 17 20:17:51 tilly NetworkManager: <info> Activation (eth1) Stage 3 of 5
(IP Configure Start) scheduled.
Sep 17 20:17:51 tilly NetworkManager: <info> Activation (eth1) Stage 3 of 5
(IP Configure Start) started...
Sep 17 20:17:51 tilly kernel: [ 122.739431] ADDRCONF(NETDEV_CHANGE): eth1:
link becomes ready
Sep 17 20:17:52 tilly NetworkManager: <info> Activation (eth1) Beginning DHCP
transaction.
Sep 17 20:17:52 tilly NetworkManager: <info> Activation (eth1) Stage 3 of 5
(IP Configure Start) complete.
Sep 17 20:17:52 tilly NetworkManager: <info> DHCP daemon state is now 12
(successfully started) for interface eth1
Sep 17 20:17:52 tilly avahi-daemon[4797]: Registering new address record for
fe80::21c:10ff:fe11:5a53 on eth1.*.
Sep 17 20:17:54 tilly NetworkManager: <info> DHCP daemon state is now 1
(starting) for interface eth1
Sep 17 20:17:56 tilly NetworkManager: <info> Old device 'eth1' activating,
won't change.
Sep 17 20:17:57 tilly dhclient: DHCPREQUEST on eth1 to 255.255.255.255 port 67
Sep 17 20:17:57 tilly dhclient: DHCPNAK from 192.168.182.1
Sep 17 20:17:57 tilly avahi-autoipd(eth1)[5311]: Found user 'avahi-autoipd'
(UID 109) and group 'avahi-autoipd' (GID 119).
Sep 17 20:17:57 tilly avahi-autoipd(eth1)[5311]: Successfully called chroot().
Sep 17 20:17:57 tilly avahi-autoipd(eth1)[5311]: Successfully dropped root
privileges.
Sep 17 20:17:57 tilly avahi-autoipd(eth1)[5311]: Starting with address
169.254.3.119
Sep 17 20:18:01 tilly kernel: [ 133.303557] eth1: no IPv6 routers present
Sep 17 20:18:02 tilly avahi-autoipd(eth1)[5311]: Callout BIND, address
169.254.3.119 on interface eth1
Sep 17 20:18:02 tilly avahi-daemon[4797]: Joining mDNS multicast group on
interface eth1.IPv4 with address 169.254.3.119.
Sep 17 20:18:02 tilly avahi-daemon[4797]: New relevant interface eth1.IPv4 for
mDNS.
Sep 17 20:18:02 tilly avahi-daemon[4797]: Registering new address record for
169.254.3.119 on eth1.IPv4.
Sep 17 20:18:06 tilly avahi-autoipd(eth1)[5311]: Successfully claimed IP
address 169.254.3.119
Sep 17 20:18:06 tilly NetworkManager: <info> DHCP daemon state is now 10
(unknown) for interface eth1
Sep 17 20:18:06 tilly avahi-autoipd(eth1)[5311]: Got SIGTERM, quitting.
Sep 17 20:18:06 tilly avahi-autoipd(eth1)[5311]: Callout STOP, address
169.254.3.119 on interface eth1
Sep 17 20:18:06 tilly avahi-daemon[4797]: Withdrawing address record for
169.254.3.119 on eth1.
Sep 17 20:18:06 tilly avahi-daemon[4797]: Leaving mDNS multicast group on
interface eth1.IPv4 with address 169.254.3.119.
Sep 17 20:18:06 tilly avahi-daemon[4797]: Interface eth1.IPv4 no longer
relevant for mDNS.
Sep 17 20:18:06 tilly avahi-autoipd(eth1)[5312]: client: RTNETLINK answers: No
such process
Sep 17 20:18:08 tilly NetworkManager: <info> DHCP daemon state is now 1
(starting) for interface eth1
Sep 17 20:18:08 tilly dhclient: DHCPDISCOVER on eth1 to 255.255.255.255 port 67
interval 6
Sep 17 20:18:08 tilly dhclient: DHCPOFFER from 192.168.182.1
Sep 17 20:18:08 tilly dhclient: DHCPREQUEST on eth1 to 255.255.255.255 port 67
Sep 17 20:18:08 tilly dhclient: DHCPACK from 192.168.182.1
Sep 17 20:18:08 tilly avahi-daemon[4797]: Joining mDNS multicast group on
interface eth1.IPv4 with address 192.168.182.5.
Sep 17 20:18:08 tilly avahi-daemon[4797]: New relevant interface eth1.IPv4 for
mDNS.
Sep 17 20:18:08 tilly avahi-daemon[4797]: Registering new address record for
192.168.182.5 on eth1.IPv4.
Sep 17 20:18:08 tilly NetworkManager: <info> DHCP daemon state is now 2
(bound) for interface eth1
Sep 17 20:18:08 tilly NetworkManager: <info> Activation (eth1) Stage 4 of 5
(IP Configure Get) scheduled...
Sep 17 20:18:08 tilly NetworkManager: <info> Activation (eth1) Stage 4 of 5
(IP Configure Get) started...
Sep 17 20:18:08 tilly dhclient: bound to 192.168.182.5 -- renewal in 289
seconds.
Sep 17 20:18:08 tilly dhcdbd: message_handler: message handler not found under
/com/redhat/dhcp/eth1 for sub-path eth1.dbus.get.host_name
Sep 17 20:18:08 tilly dhcdbd: message_handler: message handler not found under
/com/redhat/dhcp/eth1 for sub-path eth1.dbus.get.nis_domain
Sep 17 20:18:08 tilly dhcdbd: message_handler: message handler not found under
/com/redhat/dhcp/eth1 for sub-path eth1.dbus.get.nis_servers
Sep 17 20:18:08 tilly NetworkManager: <info> Retrieved the following IP4
configuration from the DHCP daemon:
Sep 17 20:18:08 tilly NetworkManager: <info> address 192.168.182.5
Sep 17 20:18:08 tilly NetworkManager: <info> netmask 255.255.255.0
Sep 17 20:18:08 tilly NetworkManager: <info> broadcast 192.168.182.255
Sep 17 20:18:08 tilly NetworkManager: <info> gateway 192.168.182.1
Sep 17 20:18:08 tilly NetworkManager: <info> nameserver 192.168.10.1
Sep 17 20:18:08 tilly NetworkManager: <info> nameserver 192.168.10.1
Sep 17 20:18:08 tilly NetworkManager: <info> domain name
'key.chillispot.org'
Sep 17 20:18:08 tilly NetworkManager: <info> Activation (eth1) Stage 5 of 5
(IP Configure Commit) scheduled...
Sep 17 20:18:08 tilly NetworkManager: <info> Activation (eth1) Stage 4 of 5
(IP Configure Get) complete.
Sep 17 20:18:08 tilly NetworkManager: <info> Activation (eth1) Stage 5 of 5
(IP Configure Commit) started...
Sep 17 20:18:08 tilly avahi-daemon[4797]: Withdrawing address record for
192.168.182.5 on eth1.
Sep 17 20:18:08 tilly avahi-daemon[4797]: Leaving mDNS multicast group on
interface eth1.IPv4 with address 192.168.182.5.
Sep 17 20:18:08 tilly avahi-daemon[4797]: Interface eth1.IPv4 no longer
relevant for mDNS.
Sep 17 20:18:08 tilly avahi-daemon[4797]: Withdrawing address record for
fe80::21c:10ff:fe11:5a53 on eth1.
Sep 17 20:18:08 tilly avahi-daemon[4797]: Joining mDNS multicast group on
interface eth1.IPv4 with address 192.168.182.5.
Sep 17 20:18:08 tilly avahi-daemon[4797]: New relevant interface eth1.IPv4 for
mDNS.
Sep 17 20:18:08 tilly avahi-daemon[4797]: Registering new address record for
192.168.182.5 on eth1.IPv4.
Sep 17 20:18:09 tilly NetworkManager: <info> Clearing nscd hosts cache.
Sep 17 20:18:09 tilly NetworkManager: <WARN> nm_spawn_process():
nm_spawn_process('/usr/sbin/nscd -i hosts'): could not spawn process. (Failed
to execute child process "/usr/sbin/nscd" (No such file or directory))
Sep 17 20:18:09 tilly NetworkManager: <info> Activation (eth1) successful,
device activated.
Sep 17 20:18:09 tilly NetworkManager: <info> Activation (eth1) Finish handler
scheduled.
Sep 17 20:18:09 tilly NetworkManager: <info> Activation (eth1) Stage 5 of 5
(IP Configure Commit) complete.
Sep 17 20:18:11 tilly avahi-daemon[4797]: Registering new address record for
fe80::21c:10ff:fe11:5a53 on eth1.*.
Sep 17 20:18:14 tilly ntpdate[5403]: no server suitable for synchronization
found
Sep 17 20:18:20 tilly kernel: [ 142.125999] eth1: no IPv6 routers present
Sep 17 20:18:37 tilly NetworkManager: <debug> [1190056717.239899]
nm_device_802_11_wireless_get_activation_ap(): Forcing AP 'TEST'
Sep 17 20:18:37 tilly NetworkManager: <info> User Switch:
/org/freedesktop/NetworkManager/Devices/eth1 / TEST
Sep 17 20:18:37 tilly NetworkManager: <info> Deactivating device eth1.
Sep 17 20:18:37 tilly dhclient: There is already a pid file
/var/run/dhclient.eth1.pid with pid 5279
Sep 17 20:18:37 tilly dhclient: killed old client process, removed PID file
Sep 17 20:18:37 tilly dhclient: DHCPRELEASE on eth1 to 192.168.182.1 port 67
Sep 17 20:18:37 tilly avahi-daemon[4797]: Withdrawing address record for
192.168.182.5 on eth1.
Sep 17 20:18:37 tilly avahi-daemon[4797]: Leaving mDNS multicast group on
interface eth1.IPv4 with address 192.168.182.5.
Sep 17 20:18:37 tilly avahi-daemon[4797]: Interface eth1.IPv4 no longer
relevant for mDNS.
Sep 17 20:18:38 tilly NetworkManager: <info> SUP: sending command
'DISABLE_NETWORK 0'
Sep 17 20:18:48 tilly kernel: [ 145.904515] pccard: card ejected from slot 0
Sep 17 20:18:48 tilly kernel: [ 145.910081] bcm43xx: Failed to switch to core 0
Sep 17 20:18:48 tilly kernel: [ 145.910755] bcm43xx: Failed to switch to core 2
Sep 17 20:18:48 tilly kernel: [ 145.910763] bcm43xx: gpio error: Neither
ChipCommon nor PCI core available!
Sep 17 20:18:48 tilly kernel: [ 145.921468] bcm43xx: Error: Wait on DMA RX
status timed out.
Sep 17 20:18:48 tilly kernel: [ 145.942884] bcm43xx: Error: Wait on DMA TX
status timed out.
Sep 17 20:18:48 tilly kernel: [ 145.964157] bcm43xx: Error: Wait on DMA TX
status timed out.
Sep 17 20:18:48 tilly kernel: [ 145.985452] bcm43xx: Error: Wait on DMA TX
status timed out.
Sep 17 20:18:48 tilly kernel: [ 146.006738] bcm43xx: Error: Wait on DMA TX
status timed out.
Sep 17 20:18:48 tilly kernel: [ 146.028020] bcm43xx: Error: Wait on DMA TX
status timed out.
Sep 17 20:18:48 tilly kernel: [ 146.049315] bcm43xx: Error: Wait on DMA TX
status timed out.
Sep 17 20:18:48 tilly kernel: [ 146.049995] bcm43xx: Failed to switch to core 0
Sep 17 20:18:48 tilly avahi-daemon[4797]: Withdrawing address record for
fe80::21c:10ff:fe11:5a53 on eth1.
Sep 17 20:18:48 tilly kernel: [ 146.074167] bcm43xx: Failed to switch to core 0
Sep 17 20:18:48 tilly kernel: [ 146.074848] bcm43xx: Failed to switch to core 0
Sep 17 20:18:48 tilly kernel: [ 146.076909] ACPI: PCI interrupt for device
0000:02:00.0 disabled
Sep 17 20:18:50 tilly NetworkManager: <info> SUP: response was 'TIMEOUT[CLI]'
Sep 17 20:18:50 tilly NetworkManager: <WARN>
nm_utils_supplicant_request_with_check(): supplicant_cleanup: supplicant error
for 'DISABLE_NETWORK 0'. Response: 'TIMEOUT[CLI]'
Sep 17 20:18:50 tilly NetworkManager: <WARN> supplicant_cleanup():
supplicant_cleanup - couldn't disable network in supplicant_cleanup
Sep 17 20:18:50 tilly NetworkManager: <info> SUP: sending command 'AP_SCAN 0'
Sep 17 20:19:02 tilly NetworkManager: <info> SUP: response was 'TIMEOUT[CLI]'
Sep 17 20:19:02 tilly NetworkManager: <WARN>
nm_utils_supplicant_request_with_check(): supplicant_cleanup: supplicant error
for 'AP_SCAN 0'. Response: 'TIMEOUT[CLI]'
Sep 17 20:19:02 tilly NetworkManager: <WARN> supplicant_cleanup():
supplicant_cleanup - couldn't set AP_SCAN 0
Sep 17 20:19:02 tilly NetworkManager: <info> SUP: sending command 'TERMINATE'
Sep 17 20:19:14 tilly NetworkManager: <info> SUP: response was 'TIMEOUT[CLI]'
Sep 17 20:19:14 tilly NetworkManager: <WARN>
nm_utils_supplicant_request_with_check(): supplicant_cleanup: supplicant error
for 'TERMINATE'. Response: 'TIMEOUT[CLI]'
Sep 17 20:19:14 tilly NetworkManager: <WARN> supplicant_cleanup():
supplicant_cleanup - couldn't terminate wpasupplicant cleanly.
Sep 17 20:19:16 tilly NetworkManager: <WARN>
nm_device_802_11_wireless_get_mode(): error getting card mode on eth1: No such
device
Sep 17 20:19:16 tilly NetworkManager: <info> Device eth1 activation
scheduled...
Sep 17 20:19:16 tilly NetworkManager: <debug> [1190056756.468285]
nm_hal_device_removed(): Device removed (hal udi is
'/org/freedesktop/Hal/devices/net_00_1c_10_11_5a_53').
Sep 17 20:19:16 tilly NetworkManager: <info> Deactivating device eth1.
Sep 17 20:19:17 tilly NetworkManager: <WARN>
nm_device_802_11_wireless_get_mode(): error getting card mode on eth1: No such
device
Sep 17 20:19:17 tilly NetworkManager: <debug> [1190056757.483675]
nm_hal_device_removed(): Device removed (hal udi is
'/org/freedesktop/Hal/devices/pci_14e4_4318').
Sep 17 20:19:17 tilly NetworkManager: <info> User request to disable wireless.
Sep 17 20:19:17 tilly NetworkManager: <info> Activation (eth1) started...
Sep 17 20:19:17 tilly NetworkManager: <info> Activation (eth1) Stage 1 of 5
(Device Prepare) scheduled...
Sep 17 20:19:24 tilly kernel: [ 158.623219] pccard: CardBus card inserted into
slot 0
Sep 17 20:19:24 tilly kernel: [ 158.624465] PCI: Enabling device 0000:02:00.0
(0000 -> 0002)
Sep 17 20:19:24 tilly kernel: [ 158.625223] ACPI: PCI Interrupt
0000:02:00.0[A] -> Link [LNKA] -> GSI 10 (level, low) -> IRQ 10
Sep 17 20:19:24 tilly kernel: [ 158.625261] PCI: Setting latency timer of
device 0000:02:00.0 to 64
Sep 17 20:19:24 tilly NetworkManager: <debug> [1190056764.645110]
nm_hal_device_added(): New device added (hal udi is
'/org/freedesktop/Hal/devices/pci_14e4_4318').
Sep 17 20:19:24 tilly NetworkManager: <debug> [1190056764.718135]
nm_hal_device_added(): New device added (hal udi is
'/org/freedesktop/Hal/devices/net_00_1c_10_11_5a_53').
Sep 17 20:19:25 tilly kernel: [ 159.286209] ADDRCONF(NETDEV_UP): eth1: link is
not ready
Sep 17 20:19:25 tilly NetworkManager: <info> eth1: Device is fully-supported
using driver 'bcm43xx'.
Sep 17 20:19:25 tilly NetworkManager: <info> nm_device_init(): waiting for
device's worker thread to start
Sep 17 20:19:25 tilly NetworkManager: <info> nm_device_init(): device's worker
thread started, continuing.
Sep 17 20:19:25 tilly NetworkManager: <info> Now managing wireless (802.11)
device 'eth1'.
Sep 17 20:19:25 tilly NetworkManager: <info> Deactivating device eth1.
Sep 17 20:19:25 tilly kernel: [ 159.611548] SoftMAC: Open Authentication
completed with 00:18:84:11:78:d5
Sep 17 20:19:25 tilly kernel: [ 159.625887] ADDRCONF(NETDEV_CHANGE): eth1:
link becomes ready
Sep 17 20:19:27 tilly avahi-daemon[4797]: Registering new address record for
fe80::21c:10ff:fe11:5a53 on eth1.*.
Sep 17 20:19:36 tilly kernel: [ 164.541817] eth1: no IPv6 routers present
Sep 17 20:19:39 tilly NetworkManager: <info> User request to enable wireless.
Sep 17 20:19:39 tilly NetworkManager: <info> SWITCH: no current connection,
found better connection 'eth1'.
Sep 17 20:19:39 tilly NetworkManager: <info> Will activate connection
'eth1/TEST'.
Sep 17 20:19:39 tilly NetworkManager: <info> Device eth1 activation
scheduled...
Sep 17 20:19:39 tilly NetworkManager: <info> Activation (eth1) started...
Sep 17 20:19:39 tilly NetworkManager: <info> Activation (eth1) Stage 1 of 5
(Device Prepare) scheduled...
Sep 17 20:19:39 tilly NetworkManager: <info> Activation (eth1) Stage 1 of 5
(Device Prepare) started...
Sep 17 20:19:39 tilly NetworkManager: <info> Activation (eth1) Stage 2 of 5
(Device Configure) scheduled...
Sep 17 20:19:39 tilly NetworkManager: <info> Activation (eth1) Stage 1 of 5
(Device Prepare) complete.
Sep 17 20:19:39 tilly NetworkManager: <info> Activation (eth1) Stage 2 of 5
(Device Configure) starting...
Sep 17 20:19:39 tilly NetworkManager: <info> Activation (eth1/wireless):
access point 'TEST' is encrypted, but NO valid key exists. New key needed.
Sep 17 20:19:39 tilly NetworkManager: <info> Activation (eth1) New wireless
user key requested for network 'TEST'.
Sep 17 20:19:39 tilly NetworkManager: <info> Activation (eth1) Stage 2 of 5
(Device Configure) complete.
Sep 17 20:19:45 tilly NetworkManager: <info> Activation (eth1) New wireless
user key for network 'TEST' received.
Sep 17 20:19:45 tilly NetworkManager: <info> Activation (eth1) Stage 1 of 5
(Device Prepare) scheduled...
Sep 17 20:19:45 tilly NetworkManager: <info> Activation (eth1) Stage 1 of 5
(Device Prepare) started...
Sep 17 20:19:45 tilly NetworkManager: <info> Activation (eth1) Stage 2 of 5
(Device Configure) scheduled...
Sep 17 20:19:45 tilly NetworkManager: <info> Activation (eth1) Stage 1 of 5
(Device Prepare) complete.
Sep 17 20:19:45 tilly NetworkManager: <info> Activation (eth1) Stage 2 of 5
(Device Configure) starting...
Sep 17 20:19:45 tilly NetworkManager: <info> Activation (eth1/wireless):
access point 'TEST' is encrypted, and a key exists. No new key needed.
Sep 17 20:19:46 tilly NetworkManager: <info> supplicant_interface_init() -
connect to global ctrl socket (0/10).
Sep 17 20:19:46 tilly NetworkManager: <info> supplicant_interface_init() -
connect to global ctrl socket (1/10).
Sep 17 20:19:46 tilly NetworkManager: <info> SUP: sending command
'INTERFACE_ADD eth1^I^Iwext^I/var/run/wpa_supplicant3^I'
Sep 17 20:19:46 tilly NetworkManager: <info> SUP: response was 'OK'
Sep 17 20:19:46 tilly NetworkManager: <info> supplicant_init() - connect to
device ctrl socket (3/10).
Sep 17 20:19:46 tilly NetworkManager: <info> SUP: sending command 'AP_SCAN 1'
Sep 17 20:19:46 tilly NetworkManager: <info> SUP: response was 'OK'
Sep 17 20:19:46 tilly NetworkManager: <info> SUP: sending command
'ADD_NETWORK'
Sep 17 20:19:46 tilly NetworkManager: <info> SUP: response was '0'
Sep 17 20:19:46 tilly NetworkManager: <info> SUP: sending command 'SET_NETWORK
0 ssid 474156'
Sep 17 20:19:46 tilly NetworkManager: <info> SUP: response was 'OK'
Sep 17 20:19:46 tilly NetworkManager: <info> SUP: sending command 'SET_NETWORK
0 proto WPA'
Sep 17 20:19:46 tilly NetworkManager: <info> SUP: response was 'OK'
Sep 17 20:19:46 tilly NetworkManager: <info> SUP: sending command 'SET_NETWORK
0 key_mgmt WPA-PSK'
Sep 17 20:19:46 tilly NetworkManager: <info> SUP: response was 'OK'
Sep 17 20:19:46 tilly NetworkManager: <info> SUP: sending command 'SET_NETWORK
0 psk <key>'
Sep 17 20:19:46 tilly NetworkManager: <info> SUP: response was 'OK'
Sep 17 20:19:46 tilly NetworkManager: <info> SUP: sending command
'ENABLE_NETWORK 0'
Sep 17 20:19:46 tilly NetworkManager: <info> SUP: response was 'OK'
Sep 17 20:19:46 tilly NetworkManager: <info> Activation (eth1) Stage 2 of 5
(Device Configure) complete.
Sep 17 20:19:52 tilly NetworkManager: <info> Old device 'eth1' activating,
won't change.
Sep 17 20:20:23 tilly last message repeated 3 times
Sep 17 20:20:44 tilly last message repeated 2 times
Sep 17 20:20:46 tilly NetworkManager: <info> Activation (eth1/wireless):
association took too long (>60s), failing activation.
Sep 17 20:20:46 tilly NetworkManager: <info> Activation (eth1) failure
scheduled...
Sep 17 20:20:46 tilly NetworkManager: <info> Activation (eth1) failed for
access point (TEST)
Sep 17 20:20:46 tilly NetworkManager: <info> Activation (eth1) failed.
Sep 17 20:20:46 tilly NetworkManager: <info> Deactivating device eth1.
Sep 17 20:20:46 tilly NetworkManager: <info> SUP: sending command
'DISABLE_NETWORK 0'
Sep 17 20:20:47 tilly kernel: [ 194.295258] SoftMAC: Authentication timed out
with 00:18:84:11:78:d6
Sep 17 20:20:50 tilly NetworkManager: <info> SUP: response was 'OK'
Sep 17 20:20:50 tilly NetworkManager: <info> SUP: sending command 'AP_SCAN 0'
Sep 17 20:20:55 tilly NetworkManager: <info> SUP: response was 'OK'
Sep 17 20:20:55 tilly NetworkManager: <info> SUP: sending command 'TERMINATE'
Sep 17 20:20:56 tilly avahi-daemon[4797]: Withdrawing address record for
fe80::21c:10ff:fe11:5a53 on eth1.
Sep 17 20:20:58 tilly kernel: [ 195.992783] ADDRCONF(NETDEV_UP): eth1: link is
not ready
Sep 17 20:20:58 tilly NetworkManager: <WARN>
nm_utils_supplicant_request_with_check(): nm_device_802_11_wireless_scan:
supplicant error for 'SCAN'. Response: '$'
Sep 17 20:20:58 tilly NetworkManager: <WARN> nm_device_802_11_wireless_scan():
could not trigger wireless scan on device eth1: Connection refused
Sep 17 20:20:59 tilly NetworkManager: <WARN>
nm_utils_supplicant_request_with_check(): nm_device_802_11_wireless_scan:
supplicant error for 'SCAN'. Response: '$'
Sep 17 20:20:59 tilly NetworkManager: <WARN> nm_device_802_11_wireless_scan():
could not trigger wireless scan on device eth1: Transport endpoint is not
connected
Sep 17 20:21:07 tilly NetworkManager: <info> SUP: response was 'TIMEOUT[CLI]'
Sep 17 20:21:07 tilly NetworkManager: <WARN>
nm_utils_supplicant_request_with_check(): supplicant_cleanup: supplicant error
for 'TERMINATE'. Response: 'TIMEOUT[CLI]'
Sep 17 20:21:07 tilly NetworkManager: <WARN> supplicant_cleanup():
supplicant_cleanup - couldn't terminate wpasupplicant cleanly.
Sep 17 20:21:07 tilly NetworkManager: <info> SWITCH: no current connection,
found better connection 'eth1'.
Sep 17 20:21:07 tilly NetworkManager: <info> Will activate connection
'eth1/FON_TEST'.
Sep 17 20:21:07 tilly NetworkManager: <info> Device eth1 activation
scheduled...
Sep 17 20:21:07 tilly NetworkManager: <info> Activation (eth1) started...
Sep 17 20:21:07 tilly NetworkManager: <info> Activation (eth1) Stage 1 of 5
(Device Prepare) scheduled...
Sep 17 20:21:07 tilly NetworkManager: <info> Activation (eth1) Stage 1 of 5
(Device Prepare) started...
Sep 17 20:21:07 tilly NetworkManager: <info> Activation (eth1) Stage 2 of 5
(Device Configure) scheduled...
Sep 17 20:21:07 tilly NetworkManager: <info> Activation (eth1) Stage 1 of 5
(Device Prepare) complete.
Sep 17 20:21:07 tilly NetworkManager: <info> Activation (eth1) Stage 2 of 5
(Device Configure) starting...
Sep 17 20:21:07 tilly NetworkManager: <info> Activation (eth1/wireless):
access point 'FON_TEST' is unencrypted, no key needed.
Sep 17 20:21:07 tilly kernel: [ 197.103896] SoftMAC: Open Authentication
completed with 00:18:84:11:78:d5
Sep 17 20:21:07 tilly kernel: [ 197.114962] ADDRCONF(NETDEV_CHANGE): eth1:
link becomes ready
Sep 17 20:21:08 tilly NetworkManager: <info> supplicant_interface_init() -
connect to global ctrl socket (0/10).
Sep 17 20:21:08 tilly NetworkManager: <info> SUP: sending command
'INTERFACE_ADD eth1^I^Iwext^I/var/run/wpa_supplicant5^I'
Sep 17 20:21:08 tilly NetworkManager: <info> SUP: response was 'OK'
Sep 17 20:21:08 tilly NetworkManager: <info> supplicant_init() - connect to
device ctrl socket (2/10).
Sep 17 20:21:08 tilly NetworkManager: <info> SUP: sending command 'AP_SCAN 1'
Sep 17 20:21:08 tilly NetworkManager: <info> SUP: response was 'OK'
Sep 17 20:21:08 tilly NetworkManager: <info> SUP: sending command
'ADD_NETWORK'
Sep 17 20:21:08 tilly NetworkManager: <info> SUP: response was '0'
Sep 17 20:21:08 tilly NetworkManager: <info> SUP: sending command 'SET_NETWORK
0 ssid 464f4e5f474156'
Sep 17 20:21:08 tilly NetworkManager: <info> SUP: response was 'OK'
Sep 17 20:21:08 tilly NetworkManager: <info> SUP: sending command 'SET_NETWORK
0 key_mgmt NONE'
Sep 17 20:21:08 tilly NetworkManager: <info> SUP: response was 'OK'
Sep 17 20:21:08 tilly NetworkManager: <info> SUP: sending command
'ENABLE_NETWORK 0'
Sep 17 20:21:08 tilly NetworkManager: <info> SUP: response was 'OK'
Sep 17 20:21:08 tilly NetworkManager: <info> Activation (eth1) Stage 2 of 5
(Device Configure) complete.
Sep 17 20:21:09 tilly avahi-daemon[4797]: Registering new address record for
fe80::21c:10ff:fe11:5a53 on eth1.*.
Sep 17 20:21:12 tilly NetworkManager: <info> Old device 'eth1' activating,
won't change.
Sep 17 20:21:18 tilly kernel: [ 198.441579] eth1: no IPv6 routers present
Sep 17 20:21:24 tilly NetworkManager: <info> Old device 'eth1' activating,
won't change.
Sep 17 20:21:55 tilly last message repeated 3 times
Sep 17 20:22:05 tilly NetworkManager: <info> Old device 'eth1' activating,
won't change.
Sep 17 20:22:08 tilly NetworkManager: <info> Activation (eth1/wireless):
association took too long (>60s), failing activation.
Sep 17 20:22:08 tilly NetworkManager: <info> Activation (eth1) failure
scheduled...
Sep 17 20:22:08 tilly NetworkManager: <info> Activation (eth1) failed for
access point (FON_TEST)
Sep 17 20:22:08 tilly NetworkManager: <info> Activation (eth1) failed.
Sep 17 20:22:08 tilly NetworkManager: <info> Deactivating device eth1.
Sep 17 20:22:08 tilly NetworkManager: <info> SUP: sending command
'DISABLE_NETWORK 0'
Sep 17 20:22:14 tilly NetworkManager: <info> SUP: response was 'OK'
Sep 17 20:22:14 tilly NetworkManager: <info> SUP: sending command 'AP_SCAN 0'
Sep 17 20:22:15 tilly NetworkManager: <info> SUP: response was 'OK'
Sep 17 20:22:15 tilly NetworkManager: <info> SUP: sending command 'TERMINATE'
Sep 17 20:22:15 tilly NetworkManager: <info> SUP: response was 'OK'
Sep 17 20:22:15 tilly avahi-daemon[4797]: Withdrawing address record for
fe80::21c:10ff:fe11:5a53 on eth1.
Sep 17 20:22:15 tilly kernel: [ 202.623088] SoftMAC: Open Authentication
completed with 00:18:84:11:78:d5
Sep 17 20:22:15 tilly kernel: [ 202.633574] ADDRCONF(NETDEV_CHANGE): eth1:
link becomes ready
Sep 17 20:22:24 tilly NetworkManager: <debug> [1190056944.585952]
nm_device_802_11_wireless_get_activation_ap(): Forcing AP 'TEST'
Sep 17 20:22:24 tilly NetworkManager: <info> User Switch:
/org/freedesktop/NetworkManager/Devices/eth1 / TEST
Sep 17 20:22:24 tilly NetworkManager: <info> Deactivating device eth1.
Sep 17 20:22:24 tilly NetworkManager: <info> Device eth1 activation
scheduled...
Sep 17 20:22:24 tilly NetworkManager: <info> Activation (eth1) started...
Sep 17 20:22:24 tilly NetworkManager: <info> Activation (eth1) Stage 1 of 5
(Device Prepare) scheduled...
Sep 17 20:22:25 tilly kernel: [ 203.519055] ADDRCONF(NETDEV_UP): eth1: link is
not ready
Sep 17 20:22:27 tilly NetworkManager: <WARN> nm_signal_handler(): Caught
signal 11. Generating backtrace...
Sep 17 20:22:27 tilly NetworkManager: ******************* START
**********************************
Sep 17 20:22:27 tilly NetworkManager: (no debugging symbols found)
Sep 17 20:22:28 tilly NetworkManager: Using host libthread_db library
"/lib/tls/i686/cmov/libthread_db.so.1".
Sep 17 20:22:28 tilly NetworkManager: (no debugging symbols found)
Sep 17 20:22:28 tilly last message repeated 13 times
Sep 17 20:22:28 tilly NetworkManager: [Thread debugging using libthread_db
enabled]
Sep 17 20:22:28 tilly NetworkManager: [New Thread -1212696912 (LWP 4417)]
Sep 17 20:22:28 tilly NetworkManager: [New Thread -1221092464 (LWP 5534)]
Sep 17 20:22:28 tilly NetworkManager: [New Thread -1229485168 (LWP 5267)]
Sep 17 20:22:28 tilly NetworkManager: [New Thread -1212699760 (LWP 4531)]
Sep 17 20:22:28 tilly NetworkManager: (no debugging symbols found)
Sep 17 20:22:28 tilly last message repeated 3 times
Sep 17 20:22:28 tilly NetworkManager: 0xffffe410 in __kernel_vsyscall ()
Sep 17 20:22:28 tilly NetworkManager: ******************* END
**********************************
_______________________________________________
Bcm43xx-dev mailing list
[email protected]
https://lists.berlios.de/mailman/listinfo/bcm43xx-dev
