2009-09-24 10:13:46

by Kristoffer Ericson

[permalink] [raw]
Subject: Disassociating atheros wlan with 2.6.31

Greetings,

When moving from vanilla 2.6.30->2.6.31 I noticed that I get dissasociated from
my wlan hub with regular intervalls. This did not happen on 2.6.30.
I cant see any pattern aside from that it happens at regular intervalls
(around 10-15mins). It works again when I re-identifies myself.

Got an Asus 1000HE with Atheros chipset.
Havent had time to bisect it, just wanted to check
if this is an known issue. Ive ruled out faulty wlan hub
since everything works fine when going back to 2.6.30.

nothing much on dmesg:
uhci_hcd 0000:00:1d.1: UHCI Host Controller
uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3
uhci_hcd 0000:00:1d.1: irq 19, io base 0x0000d480
usb usb3: configuration #1 chosen from 1 choice
hub 3-0:1.0: USB hub found
hub 3-0:1.0: 2 ports detected
uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18
uhci_hcd 0000:00:1d.2: setting latency timer to 64
uhci_hcd 0000:00:1d.2: UHCI Host Controller
uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4
uhci_hcd 0000:00:1d.2: irq 18, io base 0x0000d800
usb usb4: configuration #1 chosen from 1 choice
hub 4-0:1.0: USB hub found
hub 4-0:1.0: 2 ports detected
uhci_hcd 0000:00:1d.3: PCI INT D -> GSI 16 (level, low) -> IRQ 16
uhci_hcd 0000:00:1d.3: setting latency timer to 64
uhci_hcd 0000:00:1d.3: UHCI Host Controller
uhci_hcd 0000:00:1d.3: new USB bus registered, assigned bus number 5
uhci_hcd 0000:00:1d.3: irq 16, io base 0x0000d880
usb usb5: configuration #1 chosen from 1 choice
hub 5-0:1.0: USB hub found
hub 5-0:1.0: 2 ports detected
input: ETPS/2 Elantech Touchpad as /devices/platform/i8042/serio1/input/input7
usb 1-4: new high speed USB device using ehci_hcd and address 3
usb 1-4: configuration #1 chosen from 1 choice
hub 1-4:1.0: USB hub found
hub 1-4:1.0: 4 ports detected
usb 1-5: new high speed USB device using ehci_hcd and address 4
usb 1-5: configuration #1 chosen from 1 choice
usb 1-8: new high speed USB device using ehci_hcd and address 6
usb 1-8: configuration #1 chosen from 1 choice
Initializing USB Mass Storage driver...
scsi4 : SCSI emulation for USB Mass Storage devices
usbcore: registered new interface driver usb-storage
USB Mass Storage support registered.
usb-storage: device found at 4
usb-storage: waiting for device to settle before scanning
HDA Intel 0000:00:1b.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
HDA Intel 0000:00:1b.0: setting latency timer to 64
usb 2-2: new full speed USB device using uhci_hcd and address 2
ath9k 0000:01:00.0: PCI INT A -> GSI 19 (level, low) -> IRQ 19
ath9k 0000:01:00.0: setting latency timer to 64
usb 2-2: configuration #1 chosen from 1 choice
input: HDA Digital PCBeep as /devices/pci0000:00/0000:00:1b.0/input/input8
usbcore: registered new interface driver usbserial
USB Serial support registered for generic
usb 5-1: new full speed USB device using uhci_hcd and address 2
usb 5-1: configuration #1 chosen from 1 choice
usb 1-4.1: new full speed USB device using ehci_hcd and address 7
ath: EEPROM regdomain: 0x60
ath: EEPROM indicates we should expect a direct regpair map
ath: Country alpha2 being used: 00
ath: Regpair used: 0x60
Bluetooth: Core ver 2.15
NET: Registered protocol family 31
Bluetooth: HCI device and connection manager initialized
Bluetooth: HCI socket layer initialized
Bluetooth: Generic Bluetooth USB driver ver 0.5
usb 1-4.1: configuration #1 chosen from 1 choice
usb 1-4.2: new low speed USB device using ehci_hcd and address 8
usb 1-4.2: configuration #1 chosen from 1 choice
usb 1-4.4: new low speed USB device using ehci_hcd and address 9
usbcore: registered new interface driver hiddev
input: HID 04d9:1203 as /devices/pci0000:00/0000:00:1d.7/usb1/1-4/1-4.2/1-4.2:1.0/input/input9
generic-usb 0003:04D9:1203.0001: input,hidraw0: USB HID v1.11 Keyboard [HID 04d9:1203] on usb-0000:00:1d.7-4.2/input0
input: HID 04d9:1203 as /devices/pci0000:00/0000:00:1d.7/usb1/1-4/1-4.2/1-4.2:1.1/input/input10
generic-usb 0003:04D9:1203.0002: input,hidraw1: USB HID v1.11 Device [HID 04d9:1203] on usb-0000:00:1d.7-4.2/input1
usbcore: registered new interface driver usbhid
usbhid: v2.6:USB HID core driver
usb 1-4.4: configuration #1 chosen from 1 choice
input: B16_b_02 USB-PS/2 Optical Mouse as /devices/pci0000:00/0000:00:1d.7/usb1/1-4/1-4.4/1-4.4:1.0/input/input11
generic-usb 0003:046D:C025.0003: input,hidraw2: USB HID v1.10 Mouse [B16_b_02 USB-PS/2 Optical Mouse] on usb-0000:00:1d.7-4.4/input0
usbcore: registered new interface driver btusb
usbcore: registered new interface driver usbserial_generic
usbserial: USB Serial Driver core
USB Serial support registered for GSM modem (1-port)
option 2-2:1.0: GSM modem (1-port) converter detected
usb 2-2: GSM modem (1-port) converter now attached to ttyUSB0
option 2-2:1.1: GSM modem (1-port) converter detected
usb 2-2: GSM modem (1-port) converter now attached to ttyUSB1
usbcore: registered new interface driver option
option: v0.7.2:USB Driver for GSM modems
USB Serial support registered for pl2303
pl2303 1-4.1:1.0: pl2303 converter detected
usb 1-4.1: pl2303 converter now attached to ttyUSB2
usbcore: registered new interface driver pl2303
pl2303: Prolific PL2303 USB to serial adaptor driver
phy0: Selected rate control algorithm 'ath9k_rate_control'
Registered led device: ath9k-phy0::radio
Registered led device: ath9k-phy0::assoc
Registered led device: ath9k-phy0::tx
Registered led device: ath9k-phy0::rx
phy0: Atheros AR9280 MAC/BB Rev:2 AR5133 RF Rev:d0: mem=0xf8880000, irq=19
scsi 4:0:0:0: Direct-Access Single Flash Reader 1.00 PQ: 0 ANSI: 0
sd 4:0:0:0: Attached scsi generic sg1 type 0
sd 4:0:0:0: [sdb] 15954944 512-byte logical blocks: (8.16 GB/7.60 GiB)
usb-storage: device scan complete
sd 4:0:0:0: [sdb] Write Protect is off
sd 4:0:0:0: [sdb] Mode Sense: 03 00 00 00
sd 4:0:0:0: [sdb] Assuming drive cache: write through
sd 4:0:0:0: [sdb] Assuming drive cache: write through
sdb: sdb1
sd 4:0:0:0: [sdb] Assuming drive cache: write through
sd 4:0:0:0: [sdb] Attached SCSI removable disk
EXT3-fs warning: maximal mount count reached, running e2fsck is recommended
EXT3 FS on sda1, internal journal
Bluetooth: L2CAP ver 2.13
Bluetooth: L2CAP socket layer initialized
Bluetooth: SCO (Voice Link) ver 0.6
Bluetooth: SCO socket layer initialized
Bluetooth: BNEP (Ethernet Emulation) ver 1.3
Bridge firewalling registered
Bluetooth: RFCOMM TTY layer initialized
Bluetooth: RFCOMM socket layer initialized
Bluetooth: RFCOMM ver 1.11
ATL1E 0000:03:00.0: irq 27 for MSI/MSI-X
fuse init (API version 7.12)
ip_tables: (C) 2000-2006 Netfilter Core Team
nf_conntrack version 0.5.0 (16384 buckets, 65536 max)
CONFIG_NF_CT_ACCT is deprecated and will be removed soon. Please use
nf_conntrack.acct=1 kernel parameter, acct=1 nf_conntrack module option or
sysctl net.netfilter.nf_conntrack_acct=1 to enable it.
wlan0: authenticate with AP 00:14:7c:ae:d1:90
wlan0: authenticated
wlan0: associate with AP 00:14:7c:ae:d1:90
wlan0: RX AssocResp from 00:14:7c:ae:d1:90 (capab=0x431 status=0 aid=5)
wlan0: associated
PPP generic driver version 2.4.2
NET: Registered protocol family 10
lo: Disabled Privacy Extensions
ADDRCONF(NETDEV_UP): eth0: link is not ready
PPP BSD Compression module registered
PPP Deflate Compression module registered
wlan0: no IPv6 routers present
CE: hpet increasing min_delta_ns to 15000 nsec
wlan0: no probe response from AP 00:14:7c:ae:d1:90 - disassociating
wlan0: authenticate with AP 00:14:7c:ae:d1:90
wlan0: authenticated
wlan0: associate with AP 00:14:7c:ae:d1:90
wlan0: RX AssocResp from 00:14:7c:ae:d1:90 (capab=0x431 status=0 aid=5)
wlan0: associated
wlan0: authenticate with AP 00:14:7c:ae:d1:90
wlan0: authenticated
wlan0: associate with AP 00:14:7c:ae:d1:90
wlan0: RX AssocResp from 00:14:7c:ae:d1:90 (capab=0x431 status=0 aid=5)
wlan0: associated
[kristoffer@boggieman wine.git]$


--
Kristoffer Ericson <[email protected]>


2009-09-24 18:26:32

by Justin P. Mattock

[permalink] [raw]
Subject: Re: Disassociating atheros wlan with 2.6.31

Kristoffer Ericson wrote:
> Greetings,
>
> When moving from vanilla 2.6.30->2.6.31 I noticed that I get dissasociated from
> my wlan hub with regular intervalls. This did not happen on 2.6.30.
> I cant see any pattern aside from that it happens at regular intervalls
> (around 10-15mins). It works again when I re-identifies myself.
>
> Got an Asus 1000HE with Atheros chipset.
> Havent had time to bisect it, just wanted to check
> if this is an known issue. Ive ruled out faulty wlan hub
> since everything works fine when going back to 2.6.30.
>
> nothing much on dmesg:
> uhci_hcd 0000:00:1d.1: UHCI Host Controller
> uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3
> uhci_hcd 0000:00:1d.1: irq 19, io base 0x0000d480
> usb usb3: configuration #1 chosen from 1 choice
> hub 3-0:1.0: USB hub found
> hub 3-0:1.0: 2 ports detected
> uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18
> uhci_hcd 0000:00:1d.2: setting latency timer to 64
> uhci_hcd 0000:00:1d.2: UHCI Host Controller
> uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4
> uhci_hcd 0000:00:1d.2: irq 18, io base 0x0000d800
> usb usb4: configuration #1 chosen from 1 choice
> hub 4-0:1.0: USB hub found
> hub 4-0:1.0: 2 ports detected
> uhci_hcd 0000:00:1d.3: PCI INT D -> GSI 16 (level, low) -> IRQ 16
> uhci_hcd 0000:00:1d.3: setting latency timer to 64
> uhci_hcd 0000:00:1d.3: UHCI Host Controller
> uhci_hcd 0000:00:1d.3: new USB bus registered, assigned bus number 5
> uhci_hcd 0000:00:1d.3: irq 16, io base 0x0000d880
> usb usb5: configuration #1 chosen from 1 choice
> hub 5-0:1.0: USB hub found
> hub 5-0:1.0: 2 ports detected
> input: ETPS/2 Elantech Touchpad as /devices/platform/i8042/serio1/input/input7
> usb 1-4: new high speed USB device using ehci_hcd and address 3
> usb 1-4: configuration #1 chosen from 1 choice
> hub 1-4:1.0: USB hub found
> hub 1-4:1.0: 4 ports detected
> usb 1-5: new high speed USB device using ehci_hcd and address 4
> usb 1-5: configuration #1 chosen from 1 choice
> usb 1-8: new high speed USB device using ehci_hcd and address 6
> usb 1-8: configuration #1 chosen from 1 choice
> Initializing USB Mass Storage driver...
> scsi4 : SCSI emulation for USB Mass Storage devices
> usbcore: registered new interface driver usb-storage
> USB Mass Storage support registered.
> usb-storage: device found at 4
> usb-storage: waiting for device to settle before scanning
> HDA Intel 0000:00:1b.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
> HDA Intel 0000:00:1b.0: setting latency timer to 64
> usb 2-2: new full speed USB device using uhci_hcd and address 2
> ath9k 0000:01:00.0: PCI INT A -> GSI 19 (level, low) -> IRQ 19
> ath9k 0000:01:00.0: setting latency timer to 64
> usb 2-2: configuration #1 chosen from 1 choice
> input: HDA Digital PCBeep as /devices/pci0000:00/0000:00:1b.0/input/input8
> usbcore: registered new interface driver usbserial
> USB Serial support registered for generic
> usb 5-1: new full speed USB device using uhci_hcd and address 2
> usb 5-1: configuration #1 chosen from 1 choice
> usb 1-4.1: new full speed USB device using ehci_hcd and address 7
> ath: EEPROM regdomain: 0x60
> ath: EEPROM indicates we should expect a direct regpair map
> ath: Country alpha2 being used: 00
> ath: Regpair used: 0x60
> Bluetooth: Core ver 2.15
> NET: Registered protocol family 31
> Bluetooth: HCI device and connection manager initialized
> Bluetooth: HCI socket layer initialized
> Bluetooth: Generic Bluetooth USB driver ver 0.5
> usb 1-4.1: configuration #1 chosen from 1 choice
> usb 1-4.2: new low speed USB device using ehci_hcd and address 8
> usb 1-4.2: configuration #1 chosen from 1 choice
> usb 1-4.4: new low speed USB device using ehci_hcd and address 9
> usbcore: registered new interface driver hiddev
> input: HID 04d9:1203 as /devices/pci0000:00/0000:00:1d.7/usb1/1-4/1-4.2/1-4.2:1.0/input/input9
> generic-usb 0003:04D9:1203.0001: input,hidraw0: USB HID v1.11 Keyboard [HID 04d9:1203] on usb-0000:00:1d.7-4.2/input0
> input: HID 04d9:1203 as /devices/pci0000:00/0000:00:1d.7/usb1/1-4/1-4.2/1-4.2:1.1/input/input10
> generic-usb 0003:04D9:1203.0002: input,hidraw1: USB HID v1.11 Device [HID 04d9:1203] on usb-0000:00:1d.7-4.2/input1
> usbcore: registered new interface driver usbhid
> usbhid: v2.6:USB HID core driver
> usb 1-4.4: configuration #1 chosen from 1 choice
> input: B16_b_02 USB-PS/2 Optical Mouse as /devices/pci0000:00/0000:00:1d.7/usb1/1-4/1-4.4/1-4.4:1.0/input/input11
> generic-usb 0003:046D:C025.0003: input,hidraw2: USB HID v1.10 Mouse [B16_b_02 USB-PS/2 Optical Mouse] on usb-0000:00:1d.7-4.4/input0
> usbcore: registered new interface driver btusb
> usbcore: registered new interface driver usbserial_generic
> usbserial: USB Serial Driver core
> USB Serial support registered for GSM modem (1-port)
> option 2-2:1.0: GSM modem (1-port) converter detected
> usb 2-2: GSM modem (1-port) converter now attached to ttyUSB0
> option 2-2:1.1: GSM modem (1-port) converter detected
> usb 2-2: GSM modem (1-port) converter now attached to ttyUSB1
> usbcore: registered new interface driver option
> option: v0.7.2:USB Driver for GSM modems
> USB Serial support registered for pl2303
> pl2303 1-4.1:1.0: pl2303 converter detected
> usb 1-4.1: pl2303 converter now attached to ttyUSB2
> usbcore: registered new interface driver pl2303
> pl2303: Prolific PL2303 USB to serial adaptor driver
> phy0: Selected rate control algorithm 'ath9k_rate_control'
> Registered led device: ath9k-phy0::radio
> Registered led device: ath9k-phy0::assoc
> Registered led device: ath9k-phy0::tx
> Registered led device: ath9k-phy0::rx
> phy0: Atheros AR9280 MAC/BB Rev:2 AR5133 RF Rev:d0: mem=0xf8880000, irq=19
> scsi 4:0:0:0: Direct-Access Single Flash Reader 1.00 PQ: 0 ANSI: 0
> sd 4:0:0:0: Attached scsi generic sg1 type 0
> sd 4:0:0:0: [sdb] 15954944 512-byte logical blocks: (8.16 GB/7.60 GiB)
> usb-storage: device scan complete
> sd 4:0:0:0: [sdb] Write Protect is off
> sd 4:0:0:0: [sdb] Mode Sense: 03 00 00 00
> sd 4:0:0:0: [sdb] Assuming drive cache: write through
> sd 4:0:0:0: [sdb] Assuming drive cache: write through
> sdb: sdb1
> sd 4:0:0:0: [sdb] Assuming drive cache: write through
> sd 4:0:0:0: [sdb] Attached SCSI removable disk
> EXT3-fs warning: maximal mount count reached, running e2fsck is recommended
> EXT3 FS on sda1, internal journal
> Bluetooth: L2CAP ver 2.13
> Bluetooth: L2CAP socket layer initialized
> Bluetooth: SCO (Voice Link) ver 0.6
> Bluetooth: SCO socket layer initialized
> Bluetooth: BNEP (Ethernet Emulation) ver 1.3
> Bridge firewalling registered
> Bluetooth: RFCOMM TTY layer initialized
> Bluetooth: RFCOMM socket layer initialized
> Bluetooth: RFCOMM ver 1.11
> ATL1E 0000:03:00.0: irq 27 for MSI/MSI-X
> fuse init (API version 7.12)
> ip_tables: (C) 2000-2006 Netfilter Core Team
> nf_conntrack version 0.5.0 (16384 buckets, 65536 max)
> CONFIG_NF_CT_ACCT is deprecated and will be removed soon. Please use
> nf_conntrack.acct=1 kernel parameter, acct=1 nf_conntrack module option or
> sysctl net.netfilter.nf_conntrack_acct=1 to enable it.
> wlan0: authenticate with AP 00:14:7c:ae:d1:90
> wlan0: authenticated
> wlan0: associate with AP 00:14:7c:ae:d1:90
> wlan0: RX AssocResp from 00:14:7c:ae:d1:90 (capab=0x431 status=0 aid=5)
> wlan0: associated
> PPP generic driver version 2.4.2
> NET: Registered protocol family 10
> lo: Disabled Privacy Extensions
> ADDRCONF(NETDEV_UP): eth0: link is not ready
> PPP BSD Compression module registered
> PPP Deflate Compression module registered
> wlan0: no IPv6 routers present
> CE: hpet increasing min_delta_ns to 15000 nsec
> wlan0: no probe response from AP 00:14:7c:ae:d1:90 - disassociating
> wlan0: authenticate with AP 00:14:7c:ae:d1:90
> wlan0: authenticated
> wlan0: associate with AP 00:14:7c:ae:d1:90
> wlan0: RX AssocResp from 00:14:7c:ae:d1:90 (capab=0x431 status=0 aid=5)
> wlan0: associated
> wlan0: authenticate with AP 00:14:7c:ae:d1:90
> wlan0: authenticated
> wlan0: associate with AP 00:14:7c:ae:d1:90
> wlan0: RX AssocResp from 00:14:7c:ae:d1:90 (capab=0x431 status=0 aid=5)
> wlan0: associated
> [kristoffer@boggieman wine.git]$
>
>
>
yeah I'm seeing this with my macbook pro(ath9k)
while streaming music, all of a sudden things just crap out.
(not sure if this is why, or something else).

Justin P. Mattock

2009-09-24 19:55:49

by Stefan Lippers-Hollmann

[permalink] [raw]
Subject: Re: Disassociating atheros wlan with 2.6.31

Hi

CCing [email protected], as it's not very likely to get
noticed here by wireless developers.

On Thursday 24 September 2009, Justin P. Mattock wrote:
> Kristoffer Ericson wrote:
> > Greetings,
> >
> > When moving from vanilla 2.6.30->2.6.31 I noticed that I get dissasociated from
> > my wlan hub with regular intervalls. This did not happen on 2.6.30.
> > I cant see any pattern aside from that it happens at regular intervalls
> > (around 10-15mins). It works again when I re-identifies myself.
> >
> > Got an Asus 1000HE with Atheros chipset.
> > Havent had time to bisect it, just wanted to check
> > if this is an known issue. Ive ruled out faulty wlan hub
> > since everything works fine when going back to 2.6.30.
> >
> > nothing much on dmesg:
> > uhci_hcd 0000:00:1d.1: UHCI Host Controller
> > uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3
> > uhci_hcd 0000:00:1d.1: irq 19, io base 0x0000d480
> > usb usb3: configuration #1 chosen from 1 choice
> > hub 3-0:1.0: USB hub found
> > hub 3-0:1.0: 2 ports detected
> > uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18
> > uhci_hcd 0000:00:1d.2: setting latency timer to 64
> > uhci_hcd 0000:00:1d.2: UHCI Host Controller
> > uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4
> > uhci_hcd 0000:00:1d.2: irq 18, io base 0x0000d800
> > usb usb4: configuration #1 chosen from 1 choice
> > hub 4-0:1.0: USB hub found
> > hub 4-0:1.0: 2 ports detected
> > uhci_hcd 0000:00:1d.3: PCI INT D -> GSI 16 (level, low) -> IRQ 16
> > uhci_hcd 0000:00:1d.3: setting latency timer to 64
> > uhci_hcd 0000:00:1d.3: UHCI Host Controller
> > uhci_hcd 0000:00:1d.3: new USB bus registered, assigned bus number 5
> > uhci_hcd 0000:00:1d.3: irq 16, io base 0x0000d880
> > usb usb5: configuration #1 chosen from 1 choice
> > hub 5-0:1.0: USB hub found
> > hub 5-0:1.0: 2 ports detected
> > input: ETPS/2 Elantech Touchpad as /devices/platform/i8042/serio1/input/input7
> > usb 1-4: new high speed USB device using ehci_hcd and address 3
> > usb 1-4: configuration #1 chosen from 1 choice
> > hub 1-4:1.0: USB hub found
> > hub 1-4:1.0: 4 ports detected
> > usb 1-5: new high speed USB device using ehci_hcd and address 4
> > usb 1-5: configuration #1 chosen from 1 choice
> > usb 1-8: new high speed USB device using ehci_hcd and address 6
> > usb 1-8: configuration #1 chosen from 1 choice
> > Initializing USB Mass Storage driver...
> > scsi4 : SCSI emulation for USB Mass Storage devices
> > usbcore: registered new interface driver usb-storage
> > USB Mass Storage support registered.
> > usb-storage: device found at 4
> > usb-storage: waiting for device to settle before scanning
> > HDA Intel 0000:00:1b.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
> > HDA Intel 0000:00:1b.0: setting latency timer to 64
> > usb 2-2: new full speed USB device using uhci_hcd and address 2
> > ath9k 0000:01:00.0: PCI INT A -> GSI 19 (level, low) -> IRQ 19
> > ath9k 0000:01:00.0: setting latency timer to 64
> > usb 2-2: configuration #1 chosen from 1 choice
> > input: HDA Digital PCBeep as /devices/pci0000:00/0000:00:1b.0/input/input8
> > usbcore: registered new interface driver usbserial
> > USB Serial support registered for generic
> > usb 5-1: new full speed USB device using uhci_hcd and address 2
> > usb 5-1: configuration #1 chosen from 1 choice
> > usb 1-4.1: new full speed USB device using ehci_hcd and address 7
> > ath: EEPROM regdomain: 0x60
> > ath: EEPROM indicates we should expect a direct regpair map
> > ath: Country alpha2 being used: 00
> > ath: Regpair used: 0x60
> > Bluetooth: Core ver 2.15
> > NET: Registered protocol family 31
> > Bluetooth: HCI device and connection manager initialized
> > Bluetooth: HCI socket layer initialized
> > Bluetooth: Generic Bluetooth USB driver ver 0.5
> > usb 1-4.1: configuration #1 chosen from 1 choice
> > usb 1-4.2: new low speed USB device using ehci_hcd and address 8
> > usb 1-4.2: configuration #1 chosen from 1 choice
> > usb 1-4.4: new low speed USB device using ehci_hcd and address 9
> > usbcore: registered new interface driver hiddev
> > input: HID 04d9:1203 as /devices/pci0000:00/0000:00:1d.7/usb1/1-4/1-4.2/1-4.2:1.0/input/input9
> > generic-usb 0003:04D9:1203.0001: input,hidraw0: USB HID v1.11 Keyboard [HID 04d9:1203] on usb-0000:00:1d.7-4.2/input0
> > input: HID 04d9:1203 as /devices/pci0000:00/0000:00:1d.7/usb1/1-4/1-4.2/1-4.2:1.1/input/input10
> > generic-usb 0003:04D9:1203.0002: input,hidraw1: USB HID v1.11 Device [HID 04d9:1203] on usb-0000:00:1d.7-4.2/input1
> > usbcore: registered new interface driver usbhid
> > usbhid: v2.6:USB HID core driver
> > usb 1-4.4: configuration #1 chosen from 1 choice
> > input: B16_b_02 USB-PS/2 Optical Mouse as /devices/pci0000:00/0000:00:1d.7/usb1/1-4/1-4.4/1-4.4:1.0/input/input11
> > generic-usb 0003:046D:C025.0003: input,hidraw2: USB HID v1.10 Mouse [B16_b_02 USB-PS/2 Optical Mouse] on usb-0000:00:1d.7-4.4/input0
> > usbcore: registered new interface driver btusb
> > usbcore: registered new interface driver usbserial_generic
> > usbserial: USB Serial Driver core
> > USB Serial support registered for GSM modem (1-port)
> > option 2-2:1.0: GSM modem (1-port) converter detected
> > usb 2-2: GSM modem (1-port) converter now attached to ttyUSB0
> > option 2-2:1.1: GSM modem (1-port) converter detected
> > usb 2-2: GSM modem (1-port) converter now attached to ttyUSB1
> > usbcore: registered new interface driver option
> > option: v0.7.2:USB Driver for GSM modems
> > USB Serial support registered for pl2303
> > pl2303 1-4.1:1.0: pl2303 converter detected
> > usb 1-4.1: pl2303 converter now attached to ttyUSB2
> > usbcore: registered new interface driver pl2303
> > pl2303: Prolific PL2303 USB to serial adaptor driver
> > phy0: Selected rate control algorithm 'ath9k_rate_control'
> > Registered led device: ath9k-phy0::radio
> > Registered led device: ath9k-phy0::assoc
> > Registered led device: ath9k-phy0::tx
> > Registered led device: ath9k-phy0::rx
> > phy0: Atheros AR9280 MAC/BB Rev:2 AR5133 RF Rev:d0: mem=0xf8880000, irq=19
> > scsi 4:0:0:0: Direct-Access Single Flash Reader 1.00 PQ: 0 ANSI: 0
> > sd 4:0:0:0: Attached scsi generic sg1 type 0
> > sd 4:0:0:0: [sdb] 15954944 512-byte logical blocks: (8.16 GB/7.60 GiB)
> > usb-storage: device scan complete
> > sd 4:0:0:0: [sdb] Write Protect is off
> > sd 4:0:0:0: [sdb] Mode Sense: 03 00 00 00
> > sd 4:0:0:0: [sdb] Assuming drive cache: write through
> > sd 4:0:0:0: [sdb] Assuming drive cache: write through
> > sdb: sdb1
> > sd 4:0:0:0: [sdb] Assuming drive cache: write through
> > sd 4:0:0:0: [sdb] Attached SCSI removable disk
> > EXT3-fs warning: maximal mount count reached, running e2fsck is recommended
> > EXT3 FS on sda1, internal journal
> > Bluetooth: L2CAP ver 2.13
> > Bluetooth: L2CAP socket layer initialized
> > Bluetooth: SCO (Voice Link) ver 0.6
> > Bluetooth: SCO socket layer initialized
> > Bluetooth: BNEP (Ethernet Emulation) ver 1.3
> > Bridge firewalling registered
> > Bluetooth: RFCOMM TTY layer initialized
> > Bluetooth: RFCOMM socket layer initialized
> > Bluetooth: RFCOMM ver 1.11
> > ATL1E 0000:03:00.0: irq 27 for MSI/MSI-X
> > fuse init (API version 7.12)
> > ip_tables: (C) 2000-2006 Netfilter Core Team
> > nf_conntrack version 0.5.0 (16384 buckets, 65536 max)
> > CONFIG_NF_CT_ACCT is deprecated and will be removed soon. Please use
> > nf_conntrack.acct=1 kernel parameter, acct=1 nf_conntrack module option or
> > sysctl net.netfilter.nf_conntrack_acct=1 to enable it.
> > wlan0: authenticate with AP 00:14:7c:ae:d1:90
> > wlan0: authenticated
> > wlan0: associate with AP 00:14:7c:ae:d1:90
> > wlan0: RX AssocResp from 00:14:7c:ae:d1:90 (capab=0x431 status=0 aid=5)
> > wlan0: associated
> > PPP generic driver version 2.4.2
> > NET: Registered protocol family 10
> > lo: Disabled Privacy Extensions
> > ADDRCONF(NETDEV_UP): eth0: link is not ready
> > PPP BSD Compression module registered
> > PPP Deflate Compression module registered
> > wlan0: no IPv6 routers present
> > CE: hpet increasing min_delta_ns to 15000 nsec
> > wlan0: no probe response from AP 00:14:7c:ae:d1:90 - disassociating
> > wlan0: authenticate with AP 00:14:7c:ae:d1:90
> > wlan0: authenticated
> > wlan0: associate with AP 00:14:7c:ae:d1:90
> > wlan0: RX AssocResp from 00:14:7c:ae:d1:90 (capab=0x431 status=0 aid=5)
> > wlan0: associated
> > wlan0: authenticate with AP 00:14:7c:ae:d1:90
> > wlan0: authenticated
> > wlan0: associate with AP 00:14:7c:ae:d1:90
> > wlan0: RX AssocResp from 00:14:7c:ae:d1:90 (capab=0x431 status=0 aid=5)
> > wlan0: associated
> > [kristoffer@boggieman wine.git]$
> >
> >
> >
> yeah I'm seeing this with my macbook pro(ath9k)
> while streaming music, all of a sudden things just crap out.
> (not sure if this is why, or something else).
>
> Justin P. Mattock

I'm getting similar reports for iwl3945 and 2.6.31.[01], but can't confirm
this on my own (non-iwl{3945,agn}, non-ath9k) hardware yet.

Regards
Stefan Lippers-Hollmann

2009-09-24 20:07:17

by Justin P. Mattock

[permalink] [raw]
Subject: Re: Disassociating atheros wlan with 2.6.31

Stefan Lippers-Hollmann wrote:
> Hi
>
> CCing [email protected], as it's not very likely to get
> noticed here by wireless developers.
>
> On Thursday 24 September 2009, Justin P. Mattock wrote:
>
>> Kristoffer Ericson wrote:
>>
>>> Greetings,
>>>
>>> When moving from vanilla 2.6.30->2.6.31 I noticed that I get dissasociated from
>>> my wlan hub with regular intervalls. This did not happen on 2.6.30.
>>> I cant see any pattern aside from that it happens at regular intervalls
>>> (around 10-15mins). It works again when I re-identifies myself.
>>>
>>> Got an Asus 1000HE with Atheros chipset.
>>> Havent had time to bisect it, just wanted to check
>>> if this is an known issue. Ive ruled out faulty wlan hub
>>> since everything works fine when going back to 2.6.30.
>>>
>>> nothing much on dmesg:
>>> uhci_hcd 0000:00:1d.1: UHCI Host Controller
>>> uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3
>>> uhci_hcd 0000:00:1d.1: irq 19, io base 0x0000d480
>>> usb usb3: configuration #1 chosen from 1 choice
>>> hub 3-0:1.0: USB hub found
>>> hub 3-0:1.0: 2 ports detected
>>> uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18
>>> uhci_hcd 0000:00:1d.2: setting latency timer to 64
>>> uhci_hcd 0000:00:1d.2: UHCI Host Controller
>>> uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4
>>> uhci_hcd 0000:00:1d.2: irq 18, io base 0x0000d800
>>> usb usb4: configuration #1 chosen from 1 choice
>>> hub 4-0:1.0: USB hub found
>>> hub 4-0:1.0: 2 ports detected
>>> uhci_hcd 0000:00:1d.3: PCI INT D -> GSI 16 (level, low) -> IRQ 16
>>> uhci_hcd 0000:00:1d.3: setting latency timer to 64
>>> uhci_hcd 0000:00:1d.3: UHCI Host Controller
>>> uhci_hcd 0000:00:1d.3: new USB bus registered, assigned bus number 5
>>> uhci_hcd 0000:00:1d.3: irq 16, io base 0x0000d880
>>> usb usb5: configuration #1 chosen from 1 choice
>>> hub 5-0:1.0: USB hub found
>>> hub 5-0:1.0: 2 ports detected
>>> input: ETPS/2 Elantech Touchpad as /devices/platform/i8042/serio1/input/input7
>>> usb 1-4: new high speed USB device using ehci_hcd and address 3
>>> usb 1-4: configuration #1 chosen from 1 choice
>>> hub 1-4:1.0: USB hub found
>>> hub 1-4:1.0: 4 ports detected
>>> usb 1-5: new high speed USB device using ehci_hcd and address 4
>>> usb 1-5: configuration #1 chosen from 1 choice
>>> usb 1-8: new high speed USB device using ehci_hcd and address 6
>>> usb 1-8: configuration #1 chosen from 1 choice
>>> Initializing USB Mass Storage driver...
>>> scsi4 : SCSI emulation for USB Mass Storage devices
>>> usbcore: registered new interface driver usb-storage
>>> USB Mass Storage support registered.
>>> usb-storage: device found at 4
>>> usb-storage: waiting for device to settle before scanning
>>> HDA Intel 0000:00:1b.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
>>> HDA Intel 0000:00:1b.0: setting latency timer to 64
>>> usb 2-2: new full speed USB device using uhci_hcd and address 2
>>> ath9k 0000:01:00.0: PCI INT A -> GSI 19 (level, low) -> IRQ 19
>>> ath9k 0000:01:00.0: setting latency timer to 64
>>> usb 2-2: configuration #1 chosen from 1 choice
>>> input: HDA Digital PCBeep as /devices/pci0000:00/0000:00:1b.0/input/input8
>>> usbcore: registered new interface driver usbserial
>>> USB Serial support registered for generic
>>> usb 5-1: new full speed USB device using uhci_hcd and address 2
>>> usb 5-1: configuration #1 chosen from 1 choice
>>> usb 1-4.1: new full speed USB device using ehci_hcd and address 7
>>> ath: EEPROM regdomain: 0x60
>>> ath: EEPROM indicates we should expect a direct regpair map
>>> ath: Country alpha2 being used: 00
>>> ath: Regpair used: 0x60
>>> Bluetooth: Core ver 2.15
>>> NET: Registered protocol family 31
>>> Bluetooth: HCI device and connection manager initialized
>>> Bluetooth: HCI socket layer initialized
>>> Bluetooth: Generic Bluetooth USB driver ver 0.5
>>> usb 1-4.1: configuration #1 chosen from 1 choice
>>> usb 1-4.2: new low speed USB device using ehci_hcd and address 8
>>> usb 1-4.2: configuration #1 chosen from 1 choice
>>> usb 1-4.4: new low speed USB device using ehci_hcd and address 9
>>> usbcore: registered new interface driver hiddev
>>> input: HID 04d9:1203 as /devices/pci0000:00/0000:00:1d.7/usb1/1-4/1-4.2/1-4.2:1.0/input/input9
>>> generic-usb 0003:04D9:1203.0001: input,hidraw0: USB HID v1.11 Keyboard [HID 04d9:1203] on usb-0000:00:1d.7-4.2/input0
>>> input: HID 04d9:1203 as /devices/pci0000:00/0000:00:1d.7/usb1/1-4/1-4.2/1-4.2:1.1/input/input10
>>> generic-usb 0003:04D9:1203.0002: input,hidraw1: USB HID v1.11 Device [HID 04d9:1203] on usb-0000:00:1d.7-4.2/input1
>>> usbcore: registered new interface driver usbhid
>>> usbhid: v2.6:USB HID core driver
>>> usb 1-4.4: configuration #1 chosen from 1 choice
>>> input: B16_b_02 USB-PS/2 Optical Mouse as /devices/pci0000:00/0000:00:1d.7/usb1/1-4/1-4.4/1-4.4:1.0/input/input11
>>> generic-usb 0003:046D:C025.0003: input,hidraw2: USB HID v1.10 Mouse [B16_b_02 USB-PS/2 Optical Mouse] on usb-0000:00:1d.7-4.4/input0
>>> usbcore: registered new interface driver btusb
>>> usbcore: registered new interface driver usbserial_generic
>>> usbserial: USB Serial Driver core
>>> USB Serial support registered for GSM modem (1-port)
>>> option 2-2:1.0: GSM modem (1-port) converter detected
>>> usb 2-2: GSM modem (1-port) converter now attached to ttyUSB0
>>> option 2-2:1.1: GSM modem (1-port) converter detected
>>> usb 2-2: GSM modem (1-port) converter now attached to ttyUSB1
>>> usbcore: registered new interface driver option
>>> option: v0.7.2:USB Driver for GSM modems
>>> USB Serial support registered for pl2303
>>> pl2303 1-4.1:1.0: pl2303 converter detected
>>> usb 1-4.1: pl2303 converter now attached to ttyUSB2
>>> usbcore: registered new interface driver pl2303
>>> pl2303: Prolific PL2303 USB to serial adaptor driver
>>> phy0: Selected rate control algorithm 'ath9k_rate_control'
>>> Registered led device: ath9k-phy0::radio
>>> Registered led device: ath9k-phy0::assoc
>>> Registered led device: ath9k-phy0::tx
>>> Registered led device: ath9k-phy0::rx
>>> phy0: Atheros AR9280 MAC/BB Rev:2 AR5133 RF Rev:d0: mem=0xf8880000, irq=19
>>> scsi 4:0:0:0: Direct-Access Single Flash Reader 1.00 PQ: 0 ANSI: 0
>>> sd 4:0:0:0: Attached scsi generic sg1 type 0
>>> sd 4:0:0:0: [sdb] 15954944 512-byte logical blocks: (8.16 GB/7.60 GiB)
>>> usb-storage: device scan complete
>>> sd 4:0:0:0: [sdb] Write Protect is off
>>> sd 4:0:0:0: [sdb] Mode Sense: 03 00 00 00
>>> sd 4:0:0:0: [sdb] Assuming drive cache: write through
>>> sd 4:0:0:0: [sdb] Assuming drive cache: write through
>>> sdb: sdb1
>>> sd 4:0:0:0: [sdb] Assuming drive cache: write through
>>> sd 4:0:0:0: [sdb] Attached SCSI removable disk
>>> EXT3-fs warning: maximal mount count reached, running e2fsck is recommended
>>> EXT3 FS on sda1, internal journal
>>> Bluetooth: L2CAP ver 2.13
>>> Bluetooth: L2CAP socket layer initialized
>>> Bluetooth: SCO (Voice Link) ver 0.6
>>> Bluetooth: SCO socket layer initialized
>>> Bluetooth: BNEP (Ethernet Emulation) ver 1.3
>>> Bridge firewalling registered
>>> Bluetooth: RFCOMM TTY layer initialized
>>> Bluetooth: RFCOMM socket layer initialized
>>> Bluetooth: RFCOMM ver 1.11
>>> ATL1E 0000:03:00.0: irq 27 for MSI/MSI-X
>>> fuse init (API version 7.12)
>>> ip_tables: (C) 2000-2006 Netfilter Core Team
>>> nf_conntrack version 0.5.0 (16384 buckets, 65536 max)
>>> CONFIG_NF_CT_ACCT is deprecated and will be removed soon. Please use
>>> nf_conntrack.acct=1 kernel parameter, acct=1 nf_conntrack module option or
>>> sysctl net.netfilter.nf_conntrack_acct=1 to enable it.
>>> wlan0: authenticate with AP 00:14:7c:ae:d1:90
>>> wlan0: authenticated
>>> wlan0: associate with AP 00:14:7c:ae:d1:90
>>> wlan0: RX AssocResp from 00:14:7c:ae:d1:90 (capab=0x431 status=0 aid=5)
>>> wlan0: associated
>>> PPP generic driver version 2.4.2
>>> NET: Registered protocol family 10
>>> lo: Disabled Privacy Extensions
>>> ADDRCONF(NETDEV_UP): eth0: link is not ready
>>> PPP BSD Compression module registered
>>> PPP Deflate Compression module registered
>>> wlan0: no IPv6 routers present
>>> CE: hpet increasing min_delta_ns to 15000 nsec
>>> wlan0: no probe response from AP 00:14:7c:ae:d1:90 - disassociating
>>> wlan0: authenticate with AP 00:14:7c:ae:d1:90
>>> wlan0: authenticated
>>> wlan0: associate with AP 00:14:7c:ae:d1:90
>>> wlan0: RX AssocResp from 00:14:7c:ae:d1:90 (capab=0x431 status=0 aid=5)
>>> wlan0: associated
>>> wlan0: authenticate with AP 00:14:7c:ae:d1:90
>>> wlan0: authenticated
>>> wlan0: associate with AP 00:14:7c:ae:d1:90
>>> wlan0: RX AssocResp from 00:14:7c:ae:d1:90 (capab=0x431 status=0 aid=5)
>>> wlan0: associated
>>> [kristoffer@boggieman wine.git]$
>>>
>>>
>>>
>>>
>> yeah I'm seeing this with my macbook pro(ath9k)
>> while streaming music, all of a sudden things just crap out.
>> (not sure if this is why, or something else).
>>
>> Justin P. Mattock
>>
>
> I'm getting similar reports for iwl3945 and 2.6.31.[01], but can't confirm
> this on my own (non-iwl{3945,agn}, non-ath9k) hardware yet.
>
> Regards
> Stefan Lippers-Hollmann
>
>
I don't mind doing a bisect from 30 - present, but first I need to
do some other stuff.

Justin P. Mattock

2009-09-29 09:13:27

by Kristoffer Ericson

[permalink] [raw]
Subject: Re: Disassociating atheros wlan with 2.6.31

On Thu, 24 Sep 2009 13:07:12 -0700
"Justin P. Mattock" <[email protected]> wrote:

> Stefan Lippers-Hollmann wrote:
> > Hi
> >
> > CCing [email protected], as it's not very likely to get
> > noticed here by wireless developers.
> >
> > On Thursday 24 September 2009, Justin P. Mattock wrote:
> >
> >> Kristoffer Ericson wrote:
> >>
> >>> Greetings,
> >>>
> >>> When moving from vanilla 2.6.30->2.6.31 I noticed that I get dissasociated from
> >>> my wlan hub with regular intervalls. This did not happen on 2.6.30.
> >>> I cant see any pattern aside from that it happens at regular intervalls
> >>> (around 10-15mins). It works again when I re-identifies myself.
> >>>
> >>> Got an Asus 1000HE with Atheros chipset.
> >>> Havent had time to bisect it, just wanted to check
> >>> if this is an known issue. Ive ruled out faulty wlan hub
> >>> since everything works fine when going back to 2.6.30.
> >>>
> >>> nothing much on dmesg:
> >>> uhci_hcd 0000:00:1d.1: UHCI Host Controller
> >>> uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3
> >>> uhci_hcd 0000:00:1d.1: irq 19, io base 0x0000d480
> >>> usb usb3: configuration #1 chosen from 1 choice
> >>> hub 3-0:1.0: USB hub found
> >>> hub 3-0:1.0: 2 ports detected
> >>> uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18
> >>> uhci_hcd 0000:00:1d.2: setting latency timer to 64
> >>> uhci_hcd 0000:00:1d.2: UHCI Host Controller
> >>> uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4
> >>> uhci_hcd 0000:00:1d.2: irq 18, io base 0x0000d800
> >>> usb usb4: configuration #1 chosen from 1 choice
> >>> hub 4-0:1.0: USB hub found
> >>> hub 4-0:1.0: 2 ports detected
> >>> uhci_hcd 0000:00:1d.3: PCI INT D -> GSI 16 (level, low) -> IRQ 16
> >>> uhci_hcd 0000:00:1d.3: setting latency timer to 64
> >>> uhci_hcd 0000:00:1d.3: UHCI Host Controller
> >>> uhci_hcd 0000:00:1d.3: new USB bus registered, assigned bus number 5
> >>> uhci_hcd 0000:00:1d.3: irq 16, io base 0x0000d880
> >>> usb usb5: configuration #1 chosen from 1 choice
> >>> hub 5-0:1.0: USB hub found
> >>> hub 5-0:1.0: 2 ports detected
> >>> input: ETPS/2 Elantech Touchpad as /devices/platform/i8042/serio1/input/input7
> >>> usb 1-4: new high speed USB device using ehci_hcd and address 3
> >>> usb 1-4: configuration #1 chosen from 1 choice
> >>> hub 1-4:1.0: USB hub found
> >>> hub 1-4:1.0: 4 ports detected
> >>> usb 1-5: new high speed USB device using ehci_hcd and address 4
> >>> usb 1-5: configuration #1 chosen from 1 choice
> >>> usb 1-8: new high speed USB device using ehci_hcd and address 6
> >>> usb 1-8: configuration #1 chosen from 1 choice
> >>> Initializing USB Mass Storage driver...
> >>> scsi4 : SCSI emulation for USB Mass Storage devices
> >>> usbcore: registered new interface driver usb-storage
> >>> USB Mass Storage support registered.
> >>> usb-storage: device found at 4
> >>> usb-storage: waiting for device to settle before scanning
> >>> HDA Intel 0000:00:1b.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
> >>> HDA Intel 0000:00:1b.0: setting latency timer to 64
> >>> usb 2-2: new full speed USB device using uhci_hcd and address 2
> >>> ath9k 0000:01:00.0: PCI INT A -> GSI 19 (level, low) -> IRQ 19
> >>> ath9k 0000:01:00.0: setting latency timer to 64
> >>> usb 2-2: configuration #1 chosen from 1 choice
> >>> input: HDA Digital PCBeep as /devices/pci0000:00/0000:00:1b.0/input/input8
> >>> usbcore: registered new interface driver usbserial
> >>> USB Serial support registered for generic
> >>> usb 5-1: new full speed USB device using uhci_hcd and address 2
> >>> usb 5-1: configuration #1 chosen from 1 choice
> >>> usb 1-4.1: new full speed USB device using ehci_hcd and address 7
> >>> ath: EEPROM regdomain: 0x60
> >>> ath: EEPROM indicates we should expect a direct regpair map
> >>> ath: Country alpha2 being used: 00
> >>> ath: Regpair used: 0x60
> >>> Bluetooth: Core ver 2.15
> >>> NET: Registered protocol family 31
> >>> Bluetooth: HCI device and connection manager initialized
> >>> Bluetooth: HCI socket layer initialized
> >>> Bluetooth: Generic Bluetooth USB driver ver 0.5
> >>> usb 1-4.1: configuration #1 chosen from 1 choice
> >>> usb 1-4.2: new low speed USB device using ehci_hcd and address 8
> >>> usb 1-4.2: configuration #1 chosen from 1 choice
> >>> usb 1-4.4: new low speed USB device using ehci_hcd and address 9
> >>> usbcore: registered new interface driver hiddev
> >>> input: HID 04d9:1203 as /devices/pci0000:00/0000:00:1d.7/usb1/1-4/1-4.2/1-4.2:1.0/input/input9
> >>> generic-usb 0003:04D9:1203.0001: input,hidraw0: USB HID v1.11 Keyboard [HID 04d9:1203] on usb-0000:00:1d.7-4.2/input0
> >>> input: HID 04d9:1203 as /devices/pci0000:00/0000:00:1d.7/usb1/1-4/1-4.2/1-4.2:1.1/input/input10
> >>> generic-usb 0003:04D9:1203.0002: input,hidraw1: USB HID v1.11 Device [HID 04d9:1203] on usb-0000:00:1d.7-4.2/input1
> >>> usbcore: registered new interface driver usbhid
> >>> usbhid: v2.6:USB HID core driver
> >>> usb 1-4.4: configuration #1 chosen from 1 choice
> >>> input: B16_b_02 USB-PS/2 Optical Mouse as /devices/pci0000:00/0000:00:1d.7/usb1/1-4/1-4.4/1-4.4:1.0/input/input11
> >>> generic-usb 0003:046D:C025.0003: input,hidraw2: USB HID v1.10 Mouse [B16_b_02 USB-PS/2 Optical Mouse] on usb-0000:00:1d.7-4.4/input0
> >>> usbcore: registered new interface driver btusb
> >>> usbcore: registered new interface driver usbserial_generic
> >>> usbserial: USB Serial Driver core
> >>> USB Serial support registered for GSM modem (1-port)
> >>> option 2-2:1.0: GSM modem (1-port) converter detected
> >>> usb 2-2: GSM modem (1-port) converter now attached to ttyUSB0
> >>> option 2-2:1.1: GSM modem (1-port) converter detected
> >>> usb 2-2: GSM modem (1-port) converter now attached to ttyUSB1
> >>> usbcore: registered new interface driver option
> >>> option: v0.7.2:USB Driver for GSM modems
> >>> USB Serial support registered for pl2303
> >>> pl2303 1-4.1:1.0: pl2303 converter detected
> >>> usb 1-4.1: pl2303 converter now attached to ttyUSB2
> >>> usbcore: registered new interface driver pl2303
> >>> pl2303: Prolific PL2303 USB to serial adaptor driver
> >>> phy0: Selected rate control algorithm 'ath9k_rate_control'
> >>> Registered led device: ath9k-phy0::radio
> >>> Registered led device: ath9k-phy0::assoc
> >>> Registered led device: ath9k-phy0::tx
> >>> Registered led device: ath9k-phy0::rx
> >>> phy0: Atheros AR9280 MAC/BB Rev:2 AR5133 RF Rev:d0: mem=0xf8880000, irq=19
> >>> scsi 4:0:0:0: Direct-Access Single Flash Reader 1.00 PQ: 0 ANSI: 0
> >>> sd 4:0:0:0: Attached scsi generic sg1 type 0
> >>> sd 4:0:0:0: [sdb] 15954944 512-byte logical blocks: (8.16 GB/7.60 GiB)
> >>> usb-storage: device scan complete
> >>> sd 4:0:0:0: [sdb] Write Protect is off
> >>> sd 4:0:0:0: [sdb] Mode Sense: 03 00 00 00
> >>> sd 4:0:0:0: [sdb] Assuming drive cache: write through
> >>> sd 4:0:0:0: [sdb] Assuming drive cache: write through
> >>> sdb: sdb1
> >>> sd 4:0:0:0: [sdb] Assuming drive cache: write through
> >>> sd 4:0:0:0: [sdb] Attached SCSI removable disk
> >>> EXT3-fs warning: maximal mount count reached, running e2fsck is recommended
> >>> EXT3 FS on sda1, internal journal
> >>> Bluetooth: L2CAP ver 2.13
> >>> Bluetooth: L2CAP socket layer initialized
> >>> Bluetooth: SCO (Voice Link) ver 0.6
> >>> Bluetooth: SCO socket layer initialized
> >>> Bluetooth: BNEP (Ethernet Emulation) ver 1.3
> >>> Bridge firewalling registered
> >>> Bluetooth: RFCOMM TTY layer initialized
> >>> Bluetooth: RFCOMM socket layer initialized
> >>> Bluetooth: RFCOMM ver 1.11
> >>> ATL1E 0000:03:00.0: irq 27 for MSI/MSI-X
> >>> fuse init (API version 7.12)
> >>> ip_tables: (C) 2000-2006 Netfilter Core Team
> >>> nf_conntrack version 0.5.0 (16384 buckets, 65536 max)
> >>> CONFIG_NF_CT_ACCT is deprecated and will be removed soon. Please use
> >>> nf_conntrack.acct=1 kernel parameter, acct=1 nf_conntrack module option or
> >>> sysctl net.netfilter.nf_conntrack_acct=1 to enable it.
> >>> wlan0: authenticate with AP 00:14:7c:ae:d1:90
> >>> wlan0: authenticated
> >>> wlan0: associate with AP 00:14:7c:ae:d1:90
> >>> wlan0: RX AssocResp from 00:14:7c:ae:d1:90 (capab=0x431 status=0 aid=5)
> >>> wlan0: associated
> >>> PPP generic driver version 2.4.2
> >>> NET: Registered protocol family 10
> >>> lo: Disabled Privacy Extensions
> >>> ADDRCONF(NETDEV_UP): eth0: link is not ready
> >>> PPP BSD Compression module registered
> >>> PPP Deflate Compression module registered
> >>> wlan0: no IPv6 routers present
> >>> CE: hpet increasing min_delta_ns to 15000 nsec
> >>> wlan0: no probe response from AP 00:14:7c:ae:d1:90 - disassociating
> >>> wlan0: authenticate with AP 00:14:7c:ae:d1:90
> >>> wlan0: authenticated
> >>> wlan0: associate with AP 00:14:7c:ae:d1:90
> >>> wlan0: RX AssocResp from 00:14:7c:ae:d1:90 (capab=0x431 status=0 aid=5)
> >>> wlan0: associated
> >>> wlan0: authenticate with AP 00:14:7c:ae:d1:90
> >>> wlan0: authenticated
> >>> wlan0: associate with AP 00:14:7c:ae:d1:90
> >>> wlan0: RX AssocResp from 00:14:7c:ae:d1:90 (capab=0x431 status=0 aid=5)
> >>> wlan0: associated
> >>> [kristoffer@boggieman wine.git]$
> >>>
> >>>
> >>>
> >>>
> >> yeah I'm seeing this with my macbook pro(ath9k)
> >> while streaming music, all of a sudden things just crap out.
> >> (not sure if this is why, or something else).
> >>
> >> Justin P. Mattock
> >>
> >
> > I'm getting similar reports for iwl3945 and 2.6.31.[01], but can't confirm
> > this on my own (non-iwl{3945,agn}, non-ath9k) hardware yet.
> >
> > Regards
> > Stefan Lippers-Hollmann
> >
> >
> I don't mind doing a bisect from 30 - present, but first I need to
> do some other stuff.

Got any updates on this? Im stuck in doing other kernel stuff and has
left 2.6.31 currently since I need it for internet sharing (through wlan0).
Its a real pain having it drop every 15mins.

>
> Justin P. Mattock


--
Kristoffer Ericson <[email protected]>

2009-09-30 10:51:00

by Kristoffer Ericson

[permalink] [raw]
Subject: Re: Disassociating atheros wlan with 2.6.31

On Thu, 24 Sep 2009 13:07:12 -0700
"Justin P. Mattock" <[email protected]> wrote:

> Stefan Lippers-Hollmann wrote:
> > Hi
> >
> > CCing [email protected], as it's not very likely to get
> > noticed here by wireless developers.
> >
> > On Thursday 24 September 2009, Justin P. Mattock wrote:
> >
> >> Kristoffer Ericson wrote:
> >>
> >>> Greetings,
> >>>
> >>> When moving from vanilla 2.6.30->2.6.31 I noticed that I get dissasociated from
> >>> my wlan hub with regular intervalls. This did not happen on 2.6.30.
> >>> I cant see any pattern aside from that it happens at regular intervalls
> >>> (around 10-15mins). It works again when I re-identifies myself.
> >>>
> >>> Got an Asus 1000HE with Atheros chipset.
> >>> Havent had time to bisect it, just wanted to check
> >>> if this is an known issue. Ive ruled out faulty wlan hub
> >>> since everything works fine when going back to 2.6.30.
> >>>
> >>> nothing much on dmesg:
> >>> uhci_hcd 0000:00:1d.1: UHCI Host Controller
> >>> uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3
> >>> uhci_hcd 0000:00:1d.1: irq 19, io base 0x0000d480
> >>> usb usb3: configuration #1 chosen from 1 choice
> >>> hub 3-0:1.0: USB hub found
> >>> hub 3-0:1.0: 2 ports detected
> >>> uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18
> >>> uhci_hcd 0000:00:1d.2: setting latency timer to 64
> >>> uhci_hcd 0000:00:1d.2: UHCI Host Controller
> >>> uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4
> >>> uhci_hcd 0000:00:1d.2: irq 18, io base 0x0000d800
> >>> usb usb4: configuration #1 chosen from 1 choice
> >>> hub 4-0:1.0: USB hub found
> >>> hub 4-0:1.0: 2 ports detected
> >>> uhci_hcd 0000:00:1d.3: PCI INT D -> GSI 16 (level, low) -> IRQ 16
> >>> uhci_hcd 0000:00:1d.3: setting latency timer to 64
> >>> uhci_hcd 0000:00:1d.3: UHCI Host Controller
> >>> uhci_hcd 0000:00:1d.3: new USB bus registered, assigned bus number 5
> >>> uhci_hcd 0000:00:1d.3: irq 16, io base 0x0000d880
> >>> usb usb5: configuration #1 chosen from 1 choice
> >>> hub 5-0:1.0: USB hub found
> >>> hub 5-0:1.0: 2 ports detected
> >>> input: ETPS/2 Elantech Touchpad as /devices/platform/i8042/serio1/input/input7
> >>> usb 1-4: new high speed USB device using ehci_hcd and address 3
> >>> usb 1-4: configuration #1 chosen from 1 choice
> >>> hub 1-4:1.0: USB hub found
> >>> hub 1-4:1.0: 4 ports detected
> >>> usb 1-5: new high speed USB device using ehci_hcd and address 4
> >>> usb 1-5: configuration #1 chosen from 1 choice
> >>> usb 1-8: new high speed USB device using ehci_hcd and address 6
> >>> usb 1-8: configuration #1 chosen from 1 choice
> >>> Initializing USB Mass Storage driver...
> >>> scsi4 : SCSI emulation for USB Mass Storage devices
> >>> usbcore: registered new interface driver usb-storage
> >>> USB Mass Storage support registered.
> >>> usb-storage: device found at 4
> >>> usb-storage: waiting for device to settle before scanning
> >>> HDA Intel 0000:00:1b.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
> >>> HDA Intel 0000:00:1b.0: setting latency timer to 64
> >>> usb 2-2: new full speed USB device using uhci_hcd and address 2
> >>> ath9k 0000:01:00.0: PCI INT A -> GSI 19 (level, low) -> IRQ 19
> >>> ath9k 0000:01:00.0: setting latency timer to 64
> >>> usb 2-2: configuration #1 chosen from 1 choice
> >>> input: HDA Digital PCBeep as /devices/pci0000:00/0000:00:1b.0/input/input8
> >>> usbcore: registered new interface driver usbserial
> >>> USB Serial support registered for generic
> >>> usb 5-1: new full speed USB device using uhci_hcd and address 2
> >>> usb 5-1: configuration #1 chosen from 1 choice
> >>> usb 1-4.1: new full speed USB device using ehci_hcd and address 7
> >>> ath: EEPROM regdomain: 0x60
> >>> ath: EEPROM indicates we should expect a direct regpair map
> >>> ath: Country alpha2 being used: 00
> >>> ath: Regpair used: 0x60
> >>> Bluetooth: Core ver 2.15
> >>> NET: Registered protocol family 31
> >>> Bluetooth: HCI device and connection manager initialized
> >>> Bluetooth: HCI socket layer initialized
> >>> Bluetooth: Generic Bluetooth USB driver ver 0.5
> >>> usb 1-4.1: configuration #1 chosen from 1 choice
> >>> usb 1-4.2: new low speed USB device using ehci_hcd and address 8
> >>> usb 1-4.2: configuration #1 chosen from 1 choice
> >>> usb 1-4.4: new low speed USB device using ehci_hcd and address 9
> >>> usbcore: registered new interface driver hiddev
> >>> input: HID 04d9:1203 as /devices/pci0000:00/0000:00:1d.7/usb1/1-4/1-4.2/1-4.2:1.0/input/input9
> >>> generic-usb 0003:04D9:1203.0001: input,hidraw0: USB HID v1.11 Keyboard [HID 04d9:1203] on usb-0000:00:1d.7-4.2/input0
> >>> input: HID 04d9:1203 as /devices/pci0000:00/0000:00:1d.7/usb1/1-4/1-4.2/1-4.2:1.1/input/input10
> >>> generic-usb 0003:04D9:1203.0002: input,hidraw1: USB HID v1.11 Device [HID 04d9:1203] on usb-0000:00:1d.7-4.2/input1
> >>> usbcore: registered new interface driver usbhid
> >>> usbhid: v2.6:USB HID core driver
> >>> usb 1-4.4: configuration #1 chosen from 1 choice
> >>> input: B16_b_02 USB-PS/2 Optical Mouse as /devices/pci0000:00/0000:00:1d.7/usb1/1-4/1-4.4/1-4.4:1.0/input/input11
> >>> generic-usb 0003:046D:C025.0003: input,hidraw2: USB HID v1.10 Mouse [B16_b_02 USB-PS/2 Optical Mouse] on usb-0000:00:1d.7-4.4/input0
> >>> usbcore: registered new interface driver btusb
> >>> usbcore: registered new interface driver usbserial_generic
> >>> usbserial: USB Serial Driver core
> >>> USB Serial support registered for GSM modem (1-port)
> >>> option 2-2:1.0: GSM modem (1-port) converter detected
> >>> usb 2-2: GSM modem (1-port) converter now attached to ttyUSB0
> >>> option 2-2:1.1: GSM modem (1-port) converter detected
> >>> usb 2-2: GSM modem (1-port) converter now attached to ttyUSB1
> >>> usbcore: registered new interface driver option
> >>> option: v0.7.2:USB Driver for GSM modems
> >>> USB Serial support registered for pl2303
> >>> pl2303 1-4.1:1.0: pl2303 converter detected
> >>> usb 1-4.1: pl2303 converter now attached to ttyUSB2
> >>> usbcore: registered new interface driver pl2303
> >>> pl2303: Prolific PL2303 USB to serial adaptor driver
> >>> phy0: Selected rate control algorithm 'ath9k_rate_control'
> >>> Registered led device: ath9k-phy0::radio
> >>> Registered led device: ath9k-phy0::assoc
> >>> Registered led device: ath9k-phy0::tx
> >>> Registered led device: ath9k-phy0::rx
> >>> phy0: Atheros AR9280 MAC/BB Rev:2 AR5133 RF Rev:d0: mem=0xf8880000, irq=19
> >>> scsi 4:0:0:0: Direct-Access Single Flash Reader 1.00 PQ: 0 ANSI: 0
> >>> sd 4:0:0:0: Attached scsi generic sg1 type 0
> >>> sd 4:0:0:0: [sdb] 15954944 512-byte logical blocks: (8.16 GB/7.60 GiB)
> >>> usb-storage: device scan complete
> >>> sd 4:0:0:0: [sdb] Write Protect is off
> >>> sd 4:0:0:0: [sdb] Mode Sense: 03 00 00 00
> >>> sd 4:0:0:0: [sdb] Assuming drive cache: write through
> >>> sd 4:0:0:0: [sdb] Assuming drive cache: write through
> >>> sdb: sdb1
> >>> sd 4:0:0:0: [sdb] Assuming drive cache: write through
> >>> sd 4:0:0:0: [sdb] Attached SCSI removable disk
> >>> EXT3-fs warning: maximal mount count reached, running e2fsck is recommended
> >>> EXT3 FS on sda1, internal journal
> >>> Bluetooth: L2CAP ver 2.13
> >>> Bluetooth: L2CAP socket layer initialized
> >>> Bluetooth: SCO (Voice Link) ver 0.6
> >>> Bluetooth: SCO socket layer initialized
> >>> Bluetooth: BNEP (Ethernet Emulation) ver 1.3
> >>> Bridge firewalling registered
> >>> Bluetooth: RFCOMM TTY layer initialized
> >>> Bluetooth: RFCOMM socket layer initialized
> >>> Bluetooth: RFCOMM ver 1.11
> >>> ATL1E 0000:03:00.0: irq 27 for MSI/MSI-X
> >>> fuse init (API version 7.12)
> >>> ip_tables: (C) 2000-2006 Netfilter Core Team
> >>> nf_conntrack version 0.5.0 (16384 buckets, 65536 max)
> >>> CONFIG_NF_CT_ACCT is deprecated and will be removed soon. Please use
> >>> nf_conntrack.acct=1 kernel parameter, acct=1 nf_conntrack module option or
> >>> sysctl net.netfilter.nf_conntrack_acct=1 to enable it.
> >>> wlan0: authenticate with AP 00:14:7c:ae:d1:90
> >>> wlan0: authenticated
> >>> wlan0: associate with AP 00:14:7c:ae:d1:90
> >>> wlan0: RX AssocResp from 00:14:7c:ae:d1:90 (capab=0x431 status=0 aid=5)
> >>> wlan0: associated
> >>> PPP generic driver version 2.4.2
> >>> NET: Registered protocol family 10
> >>> lo: Disabled Privacy Extensions
> >>> ADDRCONF(NETDEV_UP): eth0: link is not ready
> >>> PPP BSD Compression module registered
> >>> PPP Deflate Compression module registered
> >>> wlan0: no IPv6 routers present
> >>> CE: hpet increasing min_delta_ns to 15000 nsec
> >>> wlan0: no probe response from AP 00:14:7c:ae:d1:90 - disassociating
> >>> wlan0: authenticate with AP 00:14:7c:ae:d1:90
> >>> wlan0: authenticated
> >>> wlan0: associate with AP 00:14:7c:ae:d1:90
> >>> wlan0: RX AssocResp from 00:14:7c:ae:d1:90 (capab=0x431 status=0 aid=5)
> >>> wlan0: associated
> >>> wlan0: authenticate with AP 00:14:7c:ae:d1:90
> >>> wlan0: authenticated
> >>> wlan0: associate with AP 00:14:7c:ae:d1:90
> >>> wlan0: RX AssocResp from 00:14:7c:ae:d1:90 (capab=0x431 status=0 aid=5)
> >>> wlan0: associated
> >>> [kristoffer@boggieman wine.git]$
> >>>
> >>>
> >>>
> >>>
> >> yeah I'm seeing this with my macbook pro(ath9k)
> >> while streaming music, all of a sudden things just crap out.
> >> (not sure if this is why, or something else).
> >>
> >> Justin P. Mattock
> >>
> >
> > I'm getting similar reports for iwl3945 and 2.6.31.[01], but can't confirm
> > this on my own (non-iwl{3945,agn}, non-ath9k) hardware yet.
> >
> > Regards
> > Stefan Lippers-Hollmann
> >
> >
> I don't mind doing a bisect from 30 - present, but first I need to
> do some other stuff.
>

Just tried 2.6.31.1 and getting same issues as I got from
2.6.31. Interesting is also that at first disassociation I can
re-activate it by authorizing again with the hub. The second time
around though that doesnt work.


> Justin P. Mattock


--
Kristoffer Ericson <[email protected]>

2009-10-04 15:43:41

by Kristoffer Ericson

[permalink] [raw]
Subject: Re: Disassociating atheros wlan with 2.6.31

Hi,

Did a bisect or more exactly tried to do a bisect. Ive managed to bisect myself
into a deadend so far (must have marked good in wrong place). The disassociation happens
at seemingly regular intervalls but once I started bisecting it started
to be more irregular. Perhaps it was simply due to me not being able
to user internet (and share) since my 3G modem oopsed all the time.
Suspecting its load sensitive.

Anyhow heres what I got so far. The bad versions should be correct
while the good versions might not be. Reason being that I didnt wait
long enough for the disassociation to appear and thus faulty marking
something as good.
Using the bad should however narrow it down somewhat. From what
I can see between my last good and bad is only non-related stuff,
so must be atleast one "good" mistake in there.

git bisect start
# good: [07a2039b8eb0af4ff464efd3dfd95de5c02648c6] Linux 2.6.30
git bisect good 07a2039b8eb0af4ff464efd3dfd95de5c02648c6
# bad: [74fca6a42863ffacaf7ba6f1936a9f228950f657] Linux 2.6.31
git bisect bad 74fca6a42863ffacaf7ba6f1936a9f228950f657
# good: [925d74ae717c9a12d3618eb4b36b9fb632e2cef3] V4L/DVB (11736): videobuf: modify return value of VIDIOC_REQBUFS ioctl
git bisect good 925d74ae717c9a12d3618eb4b36b9fb632e2cef3
# bad: [a380137900fca5c79e6daa9500bdb6ea5649188e] ixgbe: Fix device capabilities of 82599 single speed fiber NICs.
git bisect bad a380137900fca5c79e6daa9500bdb6ea5649188e
# bad: [1dbb5765acc7a6fe4bc1957c001037cc9d02ae03] Staging: android: lowmemorykiller: fix up remaining checkpatch warnings
git bisect bad 1dbb5765acc7a6fe4bc1957c001037cc9d02ae03
# bad: [2b1b62e841867326fa260a581d97941c32abc35b] MIPS: Cavium-Octeon: Add more board type constants.
git bisect bad 2b1b62e841867326fa260a581d97941c32abc35b
# good: [517d08699b250021303f9a7cf0d758b6dc0748ed] Merge branch 'akpm'
git bisect good 517d08699b250021303f9a7cf0d758b6dc0748ed
# good: [5e2c217eee18a4627a32c49f57f47dbac67dcf23] V4L/DVB (11958): usbvision-core.c: vfree does its own NULL check
git bisect good 5e2c217eee18a4627a32c49f57f47dbac67dcf23
# bad: [a9349315f65cd6a16e8fab1f6cf0fd40f379c4db] V4L/DVB (11819): Siano: smscore - fix get_common_buffer bug
git bisect bad a9349315f65cd6a16e8fab1f6cf0fd40f379c4db
# good: [06f837cadbcdedb45f0702cb57c99c404ae921e6] V4L/DVB (11784): cx88: Fix race condition between cx8800 startup and hald
git bisect good 06f837cadbcdedb45f0702cb57c99c404ae921e6
# good: [1339f9108a84710969903e892dcf1849ae1215cf] V4L/DVB (11726): Modify the file license to match all other Siano's files
git bisect good 1339f9108a84710969903e892dcf1849ae1215cf

Best wishes
Kristoffer Ericson

On Thu, 24 Sep 2009 13:07:12 -0700
"Justin P. Mattock" <[email protected]> wrote:

> Stefan Lippers-Hollmann wrote:
> > Hi
> >
> > CCing [email protected], as it's not very likely to get
> > noticed here by wireless developers.
> >
> > On Thursday 24 September 2009, Justin P. Mattock wrote:
> >
> >> Kristoffer Ericson wrote:
> >>
> >>> Greetings,
> >>>
> >>> When moving from vanilla 2.6.30->2.6.31 I noticed that I get dissasociated from
> >>> my wlan hub with regular intervalls. This did not happen on 2.6.30.
> >>> I cant see any pattern aside from that it happens at regular intervalls
> >>> (around 10-15mins). It works again when I re-identifies myself.
> >>>
> >>> Got an Asus 1000HE with Atheros chipset.
> >>> Havent had time to bisect it, just wanted to check
> >>> if this is an known issue. Ive ruled out faulty wlan hub
> >>> since everything works fine when going back to 2.6.30.
> >>>
> >>> nothing much on dmesg:
> >>> uhci_hcd 0000:00:1d.1: UHCI Host Controller
> >>> uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3
> >>> uhci_hcd 0000:00:1d.1: irq 19, io base 0x0000d480
> >>> usb usb3: configuration #1 chosen from 1 choice
> >>> hub 3-0:1.0: USB hub found
> >>> hub 3-0:1.0: 2 ports detected
> >>> uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18
> >>> uhci_hcd 0000:00:1d.2: setting latency timer to 64
> >>> uhci_hcd 0000:00:1d.2: UHCI Host Controller
> >>> uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4
> >>> uhci_hcd 0000:00:1d.2: irq 18, io base 0x0000d800
> >>> usb usb4: configuration #1 chosen from 1 choice
> >>> hub 4-0:1.0: USB hub found
> >>> hub 4-0:1.0: 2 ports detected
> >>> uhci_hcd 0000:00:1d.3: PCI INT D -> GSI 16 (level, low) -> IRQ 16
> >>> uhci_hcd 0000:00:1d.3: setting latency timer to 64
> >>> uhci_hcd 0000:00:1d.3: UHCI Host Controller
> >>> uhci_hcd 0000:00:1d.3: new USB bus registered, assigned bus number 5
> >>> uhci_hcd 0000:00:1d.3: irq 16, io base 0x0000d880
> >>> usb usb5: configuration #1 chosen from 1 choice
> >>> hub 5-0:1.0: USB hub found
> >>> hub 5-0:1.0: 2 ports detected
> >>> input: ETPS/2 Elantech Touchpad as /devices/platform/i8042/serio1/input/input7
> >>> usb 1-4: new high speed USB device using ehci_hcd and address 3
> >>> usb 1-4: configuration #1 chosen from 1 choice
> >>> hub 1-4:1.0: USB hub found
> >>> hub 1-4:1.0: 4 ports detected
> >>> usb 1-5: new high speed USB device using ehci_hcd and address 4
> >>> usb 1-5: configuration #1 chosen from 1 choice
> >>> usb 1-8: new high speed USB device using ehci_hcd and address 6
> >>> usb 1-8: configuration #1 chosen from 1 choice
> >>> Initializing USB Mass Storage driver...
> >>> scsi4 : SCSI emulation for USB Mass Storage devices
> >>> usbcore: registered new interface driver usb-storage
> >>> USB Mass Storage support registered.
> >>> usb-storage: device found at 4
> >>> usb-storage: waiting for device to settle before scanning
> >>> HDA Intel 0000:00:1b.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
> >>> HDA Intel 0000:00:1b.0: setting latency timer to 64
> >>> usb 2-2: new full speed USB device using uhci_hcd and address 2
> >>> ath9k 0000:01:00.0: PCI INT A -> GSI 19 (level, low) -> IRQ 19
> >>> ath9k 0000:01:00.0: setting latency timer to 64
> >>> usb 2-2: configuration #1 chosen from 1 choice
> >>> input: HDA Digital PCBeep as /devices/pci0000:00/0000:00:1b.0/input/input8
> >>> usbcore: registered new interface driver usbserial
> >>> USB Serial support registered for generic
> >>> usb 5-1: new full speed USB device using uhci_hcd and address 2
> >>> usb 5-1: configuration #1 chosen from 1 choice
> >>> usb 1-4.1: new full speed USB device using ehci_hcd and address 7
> >>> ath: EEPROM regdomain: 0x60
> >>> ath: EEPROM indicates we should expect a direct regpair map
> >>> ath: Country alpha2 being used: 00
> >>> ath: Regpair used: 0x60
> >>> Bluetooth: Core ver 2.15
> >>> NET: Registered protocol family 31
> >>> Bluetooth: HCI device and connection manager initialized
> >>> Bluetooth: HCI socket layer initialized
> >>> Bluetooth: Generic Bluetooth USB driver ver 0.5
> >>> usb 1-4.1: configuration #1 chosen from 1 choice
> >>> usb 1-4.2: new low speed USB device using ehci_hcd and address 8
> >>> usb 1-4.2: configuration #1 chosen from 1 choice
> >>> usb 1-4.4: new low speed USB device using ehci_hcd and address 9
> >>> usbcore: registered new interface driver hiddev
> >>> input: HID 04d9:1203 as /devices/pci0000:00/0000:00:1d.7/usb1/1-4/1-4.2/1-4.2:1.0/input/input9
> >>> generic-usb 0003:04D9:1203.0001: input,hidraw0: USB HID v1.11 Keyboard [HID 04d9:1203] on usb-0000:00:1d.7-4.2/input0
> >>> input: HID 04d9:1203 as /devices/pci0000:00/0000:00:1d.7/usb1/1-4/1-4.2/1-4.2:1.1/input/input10
> >>> generic-usb 0003:04D9:1203.0002: input,hidraw1: USB HID v1.11 Device [HID 04d9:1203] on usb-0000:00:1d.7-4.2/input1
> >>> usbcore: registered new interface driver usbhid
> >>> usbhid: v2.6:USB HID core driver
> >>> usb 1-4.4: configuration #1 chosen from 1 choice
> >>> input: B16_b_02 USB-PS/2 Optical Mouse as /devices/pci0000:00/0000:00:1d.7/usb1/1-4/1-4.4/1-4.4:1.0/input/input11
> >>> generic-usb 0003:046D:C025.0003: input,hidraw2: USB HID v1.10 Mouse [B16_b_02 USB-PS/2 Optical Mouse] on usb-0000:00:1d.7-4.4/input0
> >>> usbcore: registered new interface driver btusb
> >>> usbcore: registered new interface driver usbserial_generic
> >>> usbserial: USB Serial Driver core
> >>> USB Serial support registered for GSM modem (1-port)
> >>> option 2-2:1.0: GSM modem (1-port) converter detected
> >>> usb 2-2: GSM modem (1-port) converter now attached to ttyUSB0
> >>> option 2-2:1.1: GSM modem (1-port) converter detected
> >>> usb 2-2: GSM modem (1-port) converter now attached to ttyUSB1
> >>> usbcore: registered new interface driver option
> >>> option: v0.7.2:USB Driver for GSM modems
> >>> USB Serial support registered for pl2303
> >>> pl2303 1-4.1:1.0: pl2303 converter detected
> >>> usb 1-4.1: pl2303 converter now attached to ttyUSB2
> >>> usbcore: registered new interface driver pl2303
> >>> pl2303: Prolific PL2303 USB to serial adaptor driver
> >>> phy0: Selected rate control algorithm 'ath9k_rate_control'
> >>> Registered led device: ath9k-phy0::radio
> >>> Registered led device: ath9k-phy0::assoc
> >>> Registered led device: ath9k-phy0::tx
> >>> Registered led device: ath9k-phy0::rx
> >>> phy0: Atheros AR9280 MAC/BB Rev:2 AR5133 RF Rev:d0: mem=0xf8880000, irq=19
> >>> scsi 4:0:0:0: Direct-Access Single Flash Reader 1.00 PQ: 0 ANSI: 0
> >>> sd 4:0:0:0: Attached scsi generic sg1 type 0
> >>> sd 4:0:0:0: [sdb] 15954944 512-byte logical blocks: (8.16 GB/7.60 GiB)
> >>> usb-storage: device scan complete
> >>> sd 4:0:0:0: [sdb] Write Protect is off
> >>> sd 4:0:0:0: [sdb] Mode Sense: 03 00 00 00
> >>> sd 4:0:0:0: [sdb] Assuming drive cache: write through
> >>> sd 4:0:0:0: [sdb] Assuming drive cache: write through
> >>> sdb: sdb1
> >>> sd 4:0:0:0: [sdb] Assuming drive cache: write through
> >>> sd 4:0:0:0: [sdb] Attached SCSI removable disk
> >>> EXT3-fs warning: maximal mount count reached, running e2fsck is recommended
> >>> EXT3 FS on sda1, internal journal
> >>> Bluetooth: L2CAP ver 2.13
> >>> Bluetooth: L2CAP socket layer initialized
> >>> Bluetooth: SCO (Voice Link) ver 0.6
> >>> Bluetooth: SCO socket layer initialized
> >>> Bluetooth: BNEP (Ethernet Emulation) ver 1.3
> >>> Bridge firewalling registered
> >>> Bluetooth: RFCOMM TTY layer initialized
> >>> Bluetooth: RFCOMM socket layer initialized
> >>> Bluetooth: RFCOMM ver 1.11
> >>> ATL1E 0000:03:00.0: irq 27 for MSI/MSI-X
> >>> fuse init (API version 7.12)
> >>> ip_tables: (C) 2000-2006 Netfilter Core Team
> >>> nf_conntrack version 0.5.0 (16384 buckets, 65536 max)
> >>> CONFIG_NF_CT_ACCT is deprecated and will be removed soon. Please use
> >>> nf_conntrack.acct=1 kernel parameter, acct=1 nf_conntrack module option or
> >>> sysctl net.netfilter.nf_conntrack_acct=1 to enable it.
> >>> wlan0: authenticate with AP 00:14:7c:ae:d1:90
> >>> wlan0: authenticated
> >>> wlan0: associate with AP 00:14:7c:ae:d1:90
> >>> wlan0: RX AssocResp from 00:14:7c:ae:d1:90 (capab=0x431 status=0 aid=5)
> >>> wlan0: associated
> >>> PPP generic driver version 2.4.2
> >>> NET: Registered protocol family 10
> >>> lo: Disabled Privacy Extensions
> >>> ADDRCONF(NETDEV_UP): eth0: link is not ready
> >>> PPP BSD Compression module registered
> >>> PPP Deflate Compression module registered
> >>> wlan0: no IPv6 routers present
> >>> CE: hpet increasing min_delta_ns to 15000 nsec
> >>> wlan0: no probe response from AP 00:14:7c:ae:d1:90 - disassociating
> >>> wlan0: authenticate with AP 00:14:7c:ae:d1:90
> >>> wlan0: authenticated
> >>> wlan0: associate with AP 00:14:7c:ae:d1:90
> >>> wlan0: RX AssocResp from 00:14:7c:ae:d1:90 (capab=0x431 status=0 aid=5)
> >>> wlan0: associated
> >>> wlan0: authenticate with AP 00:14:7c:ae:d1:90
> >>> wlan0: authenticated
> >>> wlan0: associate with AP 00:14:7c:ae:d1:90
> >>> wlan0: RX AssocResp from 00:14:7c:ae:d1:90 (capab=0x431 status=0 aid=5)
> >>> wlan0: associated
> >>> [kristoffer@boggieman wine.git]$
> >>>
> >>>
> >>>
> >>>
> >> yeah I'm seeing this with my macbook pro(ath9k)
> >> while streaming music, all of a sudden things just crap out.
> >> (not sure if this is why, or something else).
> >>
> >> Justin P. Mattock
> >>
> >
> > I'm getting similar reports for iwl3945 and 2.6.31.[01], but can't confirm
> > this on my own (non-iwl{3945,agn}, non-ath9k) hardware yet.
> >
> > Regards
> > Stefan Lippers-Hollmann
> >
> >
> I don't mind doing a bisect from 30 - present, but first I need to
> do some other stuff.
>
> Justin P. Mattock


--
Kristoffer Ericson <[email protected]>

2009-10-05 00:21:08

by Justin P. Mattock

[permalink] [raw]
Subject: Re: Disassociating atheros wlan with 2.6.31

On Sun, Oct 4, 2009 at 8:45 AM, Kristoffer Ericson
<[email protected]> wrote:
> Hi,
>
> Did a bisect or more exactly tried to do a bisect. Ive managed to bisect myself
> into a deadend so far (must have marked good in wrong place). The disassociation happens
> at seemingly regular intervalls but once I started bisecting it started
> to be more irregular. Perhaps it was simply due to me not being able
> to user internet (and share) since my 3G modem oopsed all the time.
> Suspecting its load sensitive.
>
well, as easy as it seems I did at one point forget what was good/bad
on a bisect a few weeks ago.(hey your human).

> Anyhow heres what I got so far. The bad versions should be correct
> while the good versions might not be. Reason being that I didnt wait
> long enough for the disassociation to appear and thus faulty marking
> something as good.
> Using the bad should however narrow it down somewhat. From what
> I can see between my last good and bad is only non-related stuff,
> so must be atleast one "good" mistake in there.
>
> git bisect start
> # good: [07a2039b8eb0af4ff464efd3dfd95de5c02648c6] Linux 2.6.30
> git bisect good 07a2039b8eb0af4ff464efd3dfd95de5c02648c6
> # bad: [74fca6a42863ffacaf7ba6f1936a9f228950f657] Linux 2.6.31
> git bisect bad 74fca6a42863ffacaf7ba6f1936a9f228950f657
> # good: [925d74ae717c9a12d3618eb4b36b9fb632e2cef3] V4L/DVB (11736): videobuf: modify return value of VIDIOC_REQBUFS ioctl
> git bisect good 925d74ae717c9a12d3618eb4b36b9fb632e2cef3
> # bad: [a380137900fca5c79e6daa9500bdb6ea5649188e] ixgbe: Fix device capabilities of 82599 single speed fiber NICs.
> git bisect bad a380137900fca5c79e6daa9500bdb6ea5649188e
> # bad: [1dbb5765acc7a6fe4bc1957c001037cc9d02ae03] Staging: android: lowmemorykiller: fix up remaining checkpatch warnings
> git bisect bad 1dbb5765acc7a6fe4bc1957c001037cc9d02ae03
> # bad: [2b1b62e841867326fa260a581d97941c32abc35b] MIPS: Cavium-Octeon: Add more board type constants.
> git bisect bad 2b1b62e841867326fa260a581d97941c32abc35b
> # good: [517d08699b250021303f9a7cf0d758b6dc0748ed] Merge branch 'akpm'
> git bisect good 517d08699b250021303f9a7cf0d758b6dc0748ed
> # good: [5e2c217eee18a4627a32c49f57f47dbac67dcf23] V4L/DVB (11958): usbvision-core.c: vfree does its own NULL check
> git bisect good 5e2c217eee18a4627a32c49f57f47dbac67dcf23
> # bad: [a9349315f65cd6a16e8fab1f6cf0fd40f379c4db] V4L/DVB (11819): Siano: smscore - fix get_common_buffer bug
> git bisect bad a9349315f65cd6a16e8fab1f6cf0fd40f379c4db
> # good: [06f837cadbcdedb45f0702cb57c99c404ae921e6] V4L/DVB (11784): cx88: Fix race condition between cx8800 startup and hald
> git bisect good 06f837cadbcdedb45f0702cb57c99c404ae921e6
> # good: [1339f9108a84710969903e892dcf1849ae1215cf] V4L/DVB (11726): Modify the file license to match all other Siano's files
> git bisect good 1339f9108a84710969903e892dcf1849ae1215cf
>
> Best wishes
> Kristoffer Ericson
>

When I get a chance I can try a bisect and see.
If you decide to redu and come up with a specific
commit then I guess well go from there.

--
Justin P. Mattock

2009-10-08 01:13:30

by Tim Walberg

[permalink] [raw]
Subject: Re: Disassociating atheros wlan with 2.6.31


Another confirmed instance of this on ath9k - on 2.6.31.2 and 2.6.31.3 - didn't
happen on 2.6.30.6 or 2.6.30.9. A couple other interesting facts:

- it seems to be related (at least in my case) to heavy transmit load -
I can download a kernel tarball without it failing, but if I try to
copy it to another system, it fails within 2 seconds reliably...
- running 'rmmod ath9k ath mac80211 cfg80211' followed by 'modprobe ath9k'
clears it up

No indication in dmesg except:

wlan<n>: no probe response from AP AA:BB:DD:EE:FF:GG - disassociating

and suddenly no packets going in either direction.

I'm in the process of moving back to 2.6.30.x for now...





On 10/04/2009 17:45 +0200, Kristoffer Ericson wrote:
>> Hi,
>>
>> Did a bisect or more exactly tried to do a bisect. Ive managed to bisect myself
>> into a deadend so far (must have marked good in wrong place). The disassociation happens
>> at seemingly regular intervalls but once I started bisecting it started
>> to be more irregular. Perhaps it was simply due to me not being able
>> to user internet (and share) since my 3G modem oopsed all the time.
>> Suspecting its load sensitive.
>>
>> Anyhow heres what I got so far. The bad versions should be correct
>> while the good versions might not be. Reason being that I didnt wait
>> long enough for the disassociation to appear and thus faulty marking
>> something as good.
>> Using the bad should however narrow it down somewhat. From what
>> I can see between my last good and bad is only non-related stuff,
>> so must be atleast one "good" mistake in there.
>>
>> git bisect start
>> # good: [07a2039b8eb0af4ff464efd3dfd95de5c02648c6] Linux 2.6.30
>> git bisect good 07a2039b8eb0af4ff464efd3dfd95de5c02648c6
>> # bad: [74fca6a42863ffacaf7ba6f1936a9f228950f657] Linux 2.6.31
>> git bisect bad 74fca6a42863ffacaf7ba6f1936a9f228950f657
>> # good: [925d74ae717c9a12d3618eb4b36b9fb632e2cef3] V4L/DVB (11736): videobuf: modify return value of VIDIOC_REQBUFS ioctl
>> git bisect good 925d74ae717c9a12d3618eb4b36b9fb632e2cef3
>> # bad: [a380137900fca5c79e6daa9500bdb6ea5649188e] ixgbe: Fix device capabilities of 82599 single speed fiber NICs.
>> git bisect bad a380137900fca5c79e6daa9500bdb6ea5649188e
>> # bad: [1dbb5765acc7a6fe4bc1957c001037cc9d02ae03] Staging: android: lowmemorykiller: fix up remaining checkpatch warnings
>> git bisect bad 1dbb5765acc7a6fe4bc1957c001037cc9d02ae03
>> # bad: [2b1b62e841867326fa260a581d97941c32abc35b] MIPS: Cavium-Octeon: Add more board type constants.
>> git bisect bad 2b1b62e841867326fa260a581d97941c32abc35b
>> # good: [517d08699b250021303f9a7cf0d758b6dc0748ed] Merge branch 'akpm'
>> git bisect good 517d08699b250021303f9a7cf0d758b6dc0748ed
>> # good: [5e2c217eee18a4627a32c49f57f47dbac67dcf23] V4L/DVB (11958): usbvision-core.c: vfree does its own NULL check
>> git bisect good 5e2c217eee18a4627a32c49f57f47dbac67dcf23
>> # bad: [a9349315f65cd6a16e8fab1f6cf0fd40f379c4db] V4L/DVB (11819): Siano: smscore - fix get_common_buffer bug
>> git bisect bad a9349315f65cd6a16e8fab1f6cf0fd40f379c4db
>> # good: [06f837cadbcdedb45f0702cb57c99c404ae921e6] V4L/DVB (11784): cx88: Fix race condition between cx8800 startup and hald
>> git bisect good 06f837cadbcdedb45f0702cb57c99c404ae921e6
>> # good: [1339f9108a84710969903e892dcf1849ae1215cf] V4L/DVB (11726): Modify the file license to match all other Siano's files
>> git bisect good 1339f9108a84710969903e892dcf1849ae1215cf
>>
>> Best wishes
>> Kristoffer Ericson
>>
>> On Thu, 24 Sep 2009 13:07:12 -0700
>> "Justin P. Mattock" <[email protected]> wrote:
>>
>> > Stefan Lippers-Hollmann wrote:
>> > > Hi
>> > >
>> > > CCing [email protected], as it's not very likely to get
>> > > noticed here by wireless developers.
>> > >
>> > > On Thursday 24 September 2009, Justin P. Mattock wrote:
>> > >
>> > >> Kristoffer Ericson wrote:
>> > >>
>> > >>> Greetings,
>> > >>>
>> > >>> When moving from vanilla 2.6.30->2.6.31 I noticed that I get dissasociated from
>> > >>> my wlan hub with regular intervalls. This did not happen on 2.6.30.
>> > >>> I cant see any pattern aside from that it happens at regular intervalls
>> > >>> (around 10-15mins). It works again when I re-identifies myself.
>> > >>>
>> > >>> Got an Asus 1000HE with Atheros chipset.
>> > >>> Havent had time to bisect it, just wanted to check
>> > >>> if this is an known issue. Ive ruled out faulty wlan hub
>> > >>> since everything works fine when going back to 2.6.30.
>> > >>>
>> > >>> nothing much on dmesg:
>> > >>> uhci_hcd 0000:00:1d.1: UHCI Host Controller
>> > >>> uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3
>> > >>> uhci_hcd 0000:00:1d.1: irq 19, io base 0x0000d480
>> > >>> usb usb3: configuration #1 chosen from 1 choice
>> > >>> hub 3-0:1.0: USB hub found
>> > >>> hub 3-0:1.0: 2 ports detected
>> > >>> uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18
>> > >>> uhci_hcd 0000:00:1d.2: setting latency timer to 64
>> > >>> uhci_hcd 0000:00:1d.2: UHCI Host Controller
>> > >>> uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4
>> > >>> uhci_hcd 0000:00:1d.2: irq 18, io base 0x0000d800
>> > >>> usb usb4: configuration #1 chosen from 1 choice
>> > >>> hub 4-0:1.0: USB hub found
>> > >>> hub 4-0:1.0: 2 ports detected
>> > >>> uhci_hcd 0000:00:1d.3: PCI INT D -> GSI 16 (level, low) -> IRQ 16
>> > >>> uhci_hcd 0000:00:1d.3: setting latency timer to 64
>> > >>> uhci_hcd 0000:00:1d.3: UHCI Host Controller
>> > >>> uhci_hcd 0000:00:1d.3: new USB bus registered, assigned bus number 5
>> > >>> uhci_hcd 0000:00:1d.3: irq 16, io base 0x0000d880
>> > >>> usb usb5: configuration #1 chosen from 1 choice
>> > >>> hub 5-0:1.0: USB hub found
>> > >>> hub 5-0:1.0: 2 ports detected
>> > >>> input: ETPS/2 Elantech Touchpad as /devices/platform/i8042/serio1/input/input7
>> > >>> usb 1-4: new high speed USB device using ehci_hcd and address 3
>> > >>> usb 1-4: configuration #1 chosen from 1 choice
>> > >>> hub 1-4:1.0: USB hub found
>> > >>> hub 1-4:1.0: 4 ports detected
>> > >>> usb 1-5: new high speed USB device using ehci_hcd and address 4
>> > >>> usb 1-5: configuration #1 chosen from 1 choice
>> > >>> usb 1-8: new high speed USB device using ehci_hcd and address 6
>> > >>> usb 1-8: configuration #1 chosen from 1 choice
>> > >>> Initializing USB Mass Storage driver...
>> > >>> scsi4 : SCSI emulation for USB Mass Storage devices
>> > >>> usbcore: registered new interface driver usb-storage
>> > >>> USB Mass Storage support registered.
>> > >>> usb-storage: device found at 4
>> > >>> usb-storage: waiting for device to settle before scanning
>> > >>> HDA Intel 0000:00:1b.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
>> > >>> HDA Intel 0000:00:1b.0: setting latency timer to 64
>> > >>> usb 2-2: new full speed USB device using uhci_hcd and address 2
>> > >>> ath9k 0000:01:00.0: PCI INT A -> GSI 19 (level, low) -> IRQ 19
>> > >>> ath9k 0000:01:00.0: setting latency timer to 64
>> > >>> usb 2-2: configuration #1 chosen from 1 choice
>> > >>> input: HDA Digital PCBeep as /devices/pci0000:00/0000:00:1b.0/input/input8
>> > >>> usbcore: registered new interface driver usbserial
>> > >>> USB Serial support registered for generic
>> > >>> usb 5-1: new full speed USB device using uhci_hcd and address 2
>> > >>> usb 5-1: configuration #1 chosen from 1 choice
>> > >>> usb 1-4.1: new full speed USB device using ehci_hcd and address 7
>> > >>> ath: EEPROM regdomain: 0x60
>> > >>> ath: EEPROM indicates we should expect a direct regpair map
>> > >>> ath: Country alpha2 being used: 00
>> > >>> ath: Regpair used: 0x60
>> > >>> Bluetooth: Core ver 2.15
>> > >>> NET: Registered protocol family 31
>> > >>> Bluetooth: HCI device and connection manager initialized
>> > >>> Bluetooth: HCI socket layer initialized
>> > >>> Bluetooth: Generic Bluetooth USB driver ver 0.5
>> > >>> usb 1-4.1: configuration #1 chosen from 1 choice
>> > >>> usb 1-4.2: new low speed USB device using ehci_hcd and address 8
>> > >>> usb 1-4.2: configuration #1 chosen from 1 choice
>> > >>> usb 1-4.4: new low speed USB device using ehci_hcd and address 9
>> > >>> usbcore: registered new interface driver hiddev
>> > >>> input: HID 04d9:1203 as /devices/pci0000:00/0000:00:1d.7/usb1/1-4/1-4.2/1-4.2:1.0/input/input9
>> > >>> generic-usb 0003:04D9:1203.0001: input,hidraw0: USB HID v1.11 Keyboard [HID 04d9:1203] on usb-0000:00:1d.7-4.2/input0
>> > >>> input: HID 04d9:1203 as /devices/pci0000:00/0000:00:1d.7/usb1/1-4/1-4.2/1-4.2:1.1/input/input10
>> > >>> generic-usb 0003:04D9:1203.0002: input,hidraw1: USB HID v1.11 Device [HID 04d9:1203] on usb-0000:00:1d.7-4.2/input1
>> > >>> usbcore: registered new interface driver usbhid
>> > >>> usbhid: v2.6:USB HID core driver
>> > >>> usb 1-4.4: configuration #1 chosen from 1 choice
>> > >>> input: B16_b_02 USB-PS/2 Optical Mouse as /devices/pci0000:00/0000:00:1d.7/usb1/1-4/1-4.4/1-4.4:1.0/input/input11
>> > >>> generic-usb 0003:046D:C025.0003: input,hidraw2: USB HID v1.10 Mouse [B16_b_02 USB-PS/2 Optical Mouse] on usb-0000:00:1d.7-4.4/input0
>> > >>> usbcore: registered new interface driver btusb
>> > >>> usbcore: registered new interface driver usbserial_generic
>> > >>> usbserial: USB Serial Driver core
>> > >>> USB Serial support registered for GSM modem (1-port)
>> > >>> option 2-2:1.0: GSM modem (1-port) converter detected
>> > >>> usb 2-2: GSM modem (1-port) converter now attached to ttyUSB0
>> > >>> option 2-2:1.1: GSM modem (1-port) converter detected
>> > >>> usb 2-2: GSM modem (1-port) converter now attached to ttyUSB1
>> > >>> usbcore: registered new interface driver option
>> > >>> option: v0.7.2:USB Driver for GSM modems
>> > >>> USB Serial support registered for pl2303
>> > >>> pl2303 1-4.1:1.0: pl2303 converter detected
>> > >>> usb 1-4.1: pl2303 converter now attached to ttyUSB2
>> > >>> usbcore: registered new interface driver pl2303
>> > >>> pl2303: Prolific PL2303 USB to serial adaptor driver
>> > >>> phy0: Selected rate control algorithm 'ath9k_rate_control'
>> > >>> Registered led device: ath9k-phy0::radio
>> > >>> Registered led device: ath9k-phy0::assoc
>> > >>> Registered led device: ath9k-phy0::tx
>> > >>> Registered led device: ath9k-phy0::rx
>> > >>> phy0: Atheros AR9280 MAC/BB Rev:2 AR5133 RF Rev:d0: mem=0xf8880000, irq=19
>> > >>> scsi 4:0:0:0: Direct-Access Single Flash Reader 1.00 PQ: 0 ANSI: 0
>> > >>> sd 4:0:0:0: Attached scsi generic sg1 type 0
>> > >>> sd 4:0:0:0: [sdb] 15954944 512-byte logical blocks: (8.16 GB/7.60 GiB)
>> > >>> usb-storage: device scan complete
>> > >>> sd 4:0:0:0: [sdb] Write Protect is off
>> > >>> sd 4:0:0:0: [sdb] Mode Sense: 03 00 00 00
>> > >>> sd 4:0:0:0: [sdb] Assuming drive cache: write through
>> > >>> sd 4:0:0:0: [sdb] Assuming drive cache: write through
>> > >>> sdb: sdb1
>> > >>> sd 4:0:0:0: [sdb] Assuming drive cache: write through
>> > >>> sd 4:0:0:0: [sdb] Attached SCSI removable disk
>> > >>> EXT3-fs warning: maximal mount count reached, running e2fsck is recommended
>> > >>> EXT3 FS on sda1, internal journal
>> > >>> Bluetooth: L2CAP ver 2.13
>> > >>> Bluetooth: L2CAP socket layer initialized
>> > >>> Bluetooth: SCO (Voice Link) ver 0.6
>> > >>> Bluetooth: SCO socket layer initialized
>> > >>> Bluetooth: BNEP (Ethernet Emulation) ver 1.3
>> > >>> Bridge firewalling registered
>> > >>> Bluetooth: RFCOMM TTY layer initialized
>> > >>> Bluetooth: RFCOMM socket layer initialized
>> > >>> Bluetooth: RFCOMM ver 1.11
>> > >>> ATL1E 0000:03:00.0: irq 27 for MSI/MSI-X
>> > >>> fuse init (API version 7.12)
>> > >>> ip_tables: (C) 2000-2006 Netfilter Core Team
>> > >>> nf_conntrack version 0.5.0 (16384 buckets, 65536 max)
>> > >>> CONFIG_NF_CT_ACCT is deprecated and will be removed soon. Please use
>> > >>> nf_conntrack.acct=1 kernel parameter, acct=1 nf_conntrack module option or
>> > >>> sysctl net.netfilter.nf_conntrack_acct=1 to enable it.
>> > >>> wlan0: authenticate with AP 00:14:7c:ae:d1:90
>> > >>> wlan0: authenticated
>> > >>> wlan0: associate with AP 00:14:7c:ae:d1:90
>> > >>> wlan0: RX AssocResp from 00:14:7c:ae:d1:90 (capab=0x431 status=0 aid=5)
>> > >>> wlan0: associated
>> > >>> PPP generic driver version 2.4.2
>> > >>> NET: Registered protocol family 10
>> > >>> lo: Disabled Privacy Extensions
>> > >>> ADDRCONF(NETDEV_UP): eth0: link is not ready
>> > >>> PPP BSD Compression module registered
>> > >>> PPP Deflate Compression module registered
>> > >>> wlan0: no IPv6 routers present
>> > >>> CE: hpet increasing min_delta_ns to 15000 nsec
>> > >>> wlan0: no probe response from AP 00:14:7c:ae:d1:90 - disassociating
>> > >>> wlan0: authenticate with AP 00:14:7c:ae:d1:90
>> > >>> wlan0: authenticated
>> > >>> wlan0: associate with AP 00:14:7c:ae:d1:90
>> > >>> wlan0: RX AssocResp from 00:14:7c:ae:d1:90 (capab=0x431 status=0 aid=5)
>> > >>> wlan0: associated
>> > >>> wlan0: authenticate with AP 00:14:7c:ae:d1:90
>> > >>> wlan0: authenticated
>> > >>> wlan0: associate with AP 00:14:7c:ae:d1:90
>> > >>> wlan0: RX AssocResp from 00:14:7c:ae:d1:90 (capab=0x431 status=0 aid=5)
>> > >>> wlan0: associated
>> > >>> [kristoffer@boggieman wine.git]$
>> > >>>
>> > >>>
>> > >>>
>> > >>>
>> > >> yeah I'm seeing this with my macbook pro(ath9k)
>> > >> while streaming music, all of a sudden things just crap out.
>> > >> (not sure if this is why, or something else).
>> > >>
>> > >> Justin P. Mattock
>> > >>
>> > >
>> > > I'm getting similar reports for iwl3945 and 2.6.31.[01], but can't confirm
>> > > this on my own (non-iwl{3945,agn}, non-ath9k) hardware yet.
>> > >
>> > > Regards
>> > > Stefan Lippers-Hollmann
>> > >
>> > >
>> > I don't mind doing a bisect from 30 - present, but first I need to
>> > do some other stuff.
>> >
>> > Justin P. Mattock
>>
>>
>> --
>> Kristoffer Ericson <[email protected]>
>> --
>> To unsubscribe from this list: send the line "unsubscribe linux-kernel" in
>> the body of a message to [email protected]
>> More majordomo info at http://vger.kernel.org/majordomo-info.html
>> Please read the FAQ at http://www.tux.org/lkml/
End of included message



--
[email protected]


Attachments:
(No filename) (13.81 kB)
(No filename) (197.00 B)
Download all attachments

2009-10-08 01:50:19

by Justin P. Mattock

[permalink] [raw]
Subject: Re: Disassociating atheros wlan with 2.6.31

Tim Walberg wrote:
> Another confirmed instance of this on ath9k - on 2.6.31.2 and 2.6.31.3 - didn't
> happen on 2.6.30.6 or 2.6.30.9. A couple other interesting facts:
>
> - it seems to be related (at least in my case) to heavy transmit load -
> I can download a kernel tarball without it failing, but if I try to
> copy it to another system, it fails within 2 seconds reliably...
> - running 'rmmod ath9k ath mac80211 cfg80211' followed by 'modprobe ath9k'
> clears it up
>
> No indication in dmesg except:
>
> wlan<n>: no probe response from AP AA:BB:DD:EE:FF:GG - disassociating
>
> and suddenly no packets going in either direction.
>
> I'm in the process of moving back to 2.6.30.x for now...
>
>
>
>
>
> On 10/04/2009 17:45 +0200, Kristoffer Ericson wrote:
>
>
>
I get this reliably by simple running a radio station
through mplayer(probably around 5/10 min of running)
when I run this commit:
2.6.31-rc8-00039-g03c3bbc I don't have this at all.
(I might of changed my .config without realizing it)

After running a bisect from this commit to current
I came up with nothing, which led me to believe that I must have through
the confusion changed something in my .config, or messed up
with choosing good/bad with the bisect because I didn't wait long enough for
this to fire off.

In any case either/or I'm still going to give a go at the bisect again
but this time wait longer(10/20 min) to really make sure I don't miss
anything.

BTW: when this hits for you is it pretty bad(no connection) i.g when
this fires off over here
music still plays from mplayer, but did notice that mplayer player all
of a sudden would die out, but
easily connected again.

Justin P. Mattock