Panic while waiting on wlan0
Florian Limberger
flo at snakeoilproductions.net
Wed Nov 25 12:14:05 UTC 2015
Hi,
On 22.11.15 17:52, Adrian Chadd wrote:
> Do this:
>
> * compile in IEEE80211_DEBUG;
> * do "wlandebug +scan"
>
> That way we can see if net80211 is refusing to continue scanning.
As far as I can see it, net8011 (or iwn?) does refuse to scan. These
are the last lines concerning wlan0 from my dmesg:
> wlan0: Ethernet address: 00:24:d7:91:b5:44
> iwn0: iwn_read_firmware: ucode rev=0x09dd0401
> wlan0: link state changed to UP
> wlan0: link state changed to DOWN
> iwn0: device timeout
``wlandebug -i wlan0 +scan`` does nothing, until I restart the interface
(my current workaround: ``ifconfig wlan0 down; sleep 3; ifconfig wlan0
up && wpa_supplicant -B -Dbsd -iwlan0 -c/etc/wpa_supplicant.conf``),
after which I can see the debug output in the dmesg (which you can find
attached).
Regards,
flo
-------------- next part --------------
Copyright (c) 1992-2015 The FreeBSD Project.
Copyright (c) 1979, 1980, 1983, 1986, 1988, 1989, 1991, 1992, 1993, 1994
The Regents of the University of California. All rights reserved.
FreeBSD is a registered trademark of The FreeBSD Foundation.
FreeBSD 11.0-CURRENT #0 r291012+894433c(master): Wed Nov 18 15:00:12 CET 2015
root at nachtschatten.purplekraken.com:/usr/obj/usr/src/sys/GENERIC amd64
FreeBSD clang version 3.7.0 (tags/RELEASE_370/final 246257) 20150906
WARNING: WITNESS option enabled, expect reduced performance.
VT(vga): resolution 640x480
can't re-use a leaf (hwpstate_verbose)!
module_register: cannot register cpu/ichss from kernel; already loaded from cpufreq.ko
Module cpu/ichss failed to register: 17
module_register: cannot register cpu/powernow from kernel; already loaded from cpufreq.ko
Module cpu/powernow failed to register: 17
module_register: cannot register cpu/est from kernel; already loaded from cpufreq.ko
Module cpu/est failed to register: 17
module_register: cannot register cpu/hwpstate from kernel; already loaded from cpufreq.ko
Module cpu/hwpstate failed to register: 17
module_register: cannot register cpu/p4tcc from kernel; already loaded from cpufreq.ko
Module cpu/p4tcc failed to register: 17
CPU: Intel(R) Core(TM) i5 CPU M 560 @ 2.67GHz (2660.06-MHz K8-class CPU)
Origin="GenuineIntel" Id=0x20655 Family=0x6 Model=0x25 Stepping=5
Features=0xbfebfbff<FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR,PGE,MCA,CMOV,PAT,PSE36,CLFLUSH,DTS,ACPI,MMX,FXSR,SSE,SSE2,SS,HTT,TM,PBE>
Features2=0x29ae3ff<SSE3,PCLMULQDQ,DTES64,MON,DS_CPL,VMX,SMX,EST,TM2,SSSE3,CX16,xTPR,PDCM,PCID,SSE4.1,SSE4.2,POPCNT,AESNI>
AMD Features=0x28100800<SYSCALL,NX,RDTSCP,LM>
AMD Features2=0x1<LAHF>
VT-x: PAT,HLT,MTF,PAUSE,EPT,UG,VPID
TSC: P-state invariant, performance statistics
real memory = 4294967296 (4096 MB)
avail memory = 3930210304 (3748 MB)
ACPI APIC Table: <LENOVO TP-6I >
FreeBSD/SMP: Multiprocessor System Detected: 4 CPUs
FreeBSD/SMP: 1 package(s) x 2 core(s) x 2 SMT threads
cpu0 (BSP): APIC ID: 0
cpu1 (AP): APIC ID: 1
cpu2 (AP): APIC ID: 4
cpu3 (AP): APIC ID: 5
random: unblocking device.
ACPI BIOS Warning (bug): 32/64X length mismatch in FADT/Pm1aControlBlock: 16/32 (20150818/tbfadt-649)
ACPI BIOS Warning (bug): Invalid length for FADT/Pm1aControlBlock: 32, using default 16 (20150818/tbfadt-730)
ioapic0: Changing APIC ID to 1
ioapic0 <Version 2.0> irqs 0-23 on motherboard
random: entropy device external interface
kbd1 at kbdmux0
netmap: loaded module
module_register_init: MOD_LOAD (vesa, 0xffffffff80edc3c0, 0) error 19
vtvga0: <VT VGA driver> on motherboard
cryptosoft0: <software crypto> on motherboard
acpi0: <LENOVO TP-6I> on motherboard
acpi_ec0: <Embedded Controller: GPE 0x11, ECDT> port 0x62,0x66 on acpi0
acpi0: Power Button (fixed)
cpu0: <ACPI CPU> on acpi0
cpu1: <ACPI CPU> on acpi0
cpu2: <ACPI CPU> on acpi0
cpu3: <ACPI CPU> on acpi0
attimer0: <AT timer> port 0x40-0x43 irq 0 on acpi0
Timecounter "i8254" frequency 1193182 Hz quality 0
Event timer "i8254" frequency 1193182 Hz quality 100
hpet0: <High Precision Event Timer> iomem 0xfed00000-0xfed003ff on acpi0
Timecounter "HPET" frequency 14318180 Hz quality 950
Event timer "HPET" frequency 14318180 Hz quality 550
Event timer "HPET1" frequency 14318180 Hz quality 440
Event timer "HPET2" frequency 14318180 Hz quality 440
Event timer "HPET3" frequency 14318180 Hz quality 440
Event timer "HPET4" frequency 14318180 Hz quality 440
atrtc0: <AT realtime clock> port 0x70-0x71 irq 8 on acpi0
Event timer "RTC" frequency 32768 Hz quality 0
Timecounter "ACPI-safe" frequency 3579545 Hz quality 850
acpi_timer0: <24-bit timer at 3.579545MHz> port 0x1008-0x100b on acpi0
acpi_lid0: <Control Method Lid Switch> on acpi0
acpi_button0: <Sleep Button> on acpi0
pcib0: <ACPI Host-PCI bridge> on acpi0
pci0: <ACPI PCI bus> on pcib0
pcib1: <ACPI Host-PCI bridge> port 0xcf8-0xcff on acpi0
pci1: <ACPI PCI bus> on pcib1
pcib2: <ACPI PCI-PCI bridge> irq 16 at device 1.0 on pci1
pci2: <ACPI PCI bus> on pcib2
vgapci0: <VGA-compatible display> port 0x2000-0x207f mem 0xcc000000-0xccffffff,0xd0000000-0xdfffffff,0xce000000-0xcfffffff irq 16 at device 0.0 on pci2
nvidia0: <NVS 3100M> on vgapci0
vgapci0: child nvidia0 requested pci_enable_io
vgapci0: child nvidia0 requested pci_enable_io
vgapci0: Boot video device
hdac0: <NVIDIA (0x0be3) HDA Controller> mem 0xcdefc000-0xcdefffff at device 0.1 on pci2
pci1: <simple comms> at device 22.0 (no driver attached)
uart2: <5 Series/3400 Series Chipset KT Controller> port 0x1800-0x1807 mem 0xf2424000-0xf2424fff irq 17 at device 22.3 on pci1
em0: <Intel(R) PRO/1000 Network Connection 7.4.2> port 0x1820-0x183f mem 0xf2400000-0xf241ffff,0xf2425000-0xf2425fff irq 20 at device 25.0 on pci1
em0: Using an MSI interrupt
em0: Ethernet address: f0:de:f1:46:1b:8c
em0: netmap queues/slots: TX 1/1024, RX 1/1024
ehci0: <Intel PCH USB 2.0 controller USB-B> mem 0xf2428000-0xf24283ff irq 23 at device 26.0 on pci1
usbus0: EHCI version 1.0
usbus0 on ehci0
hdac1: <Intel 5 Series/3400 Series HDA Controller> mem 0xf2420000-0xf2423fff irq 17 at device 27.0 on pci1
pcib3: <ACPI PCI-PCI bridge> irq 20 at device 28.0 on pci1
pci3: <ACPI PCI bus> on pcib3
pcib4: <ACPI PCI-PCI bridge> irq 21 at device 28.1 on pci1
pci4: <ACPI PCI bus> on pcib4
iwn0: <Intel Centrino Ultimate-N 6300> mem 0xf2000000-0xf2001fff irq 17 at device 0.0 on pci4
pcib5: <ACPI PCI-PCI bridge> irq 20 at device 28.4 on pci1
pci5: <ACPI PCI bus> on pcib5
sdhci_pci0: <RICOH R5CE822 SD> mem 0xf2100000-0xf21000ff irq 16 at device 0.0 on pci5
sdhci_pci0: 1 slot(s) allocated
ehci1: <Intel PCH USB 2.0 controller USB-A> mem 0xf2428400-0xf24287ff irq 19 at device 29.0 on pci1
usbus1: EHCI version 1.0
usbus1 on ehci1
pcib6: <ACPI PCI-PCI bridge> at device 30.0 on pci1
pci6: <ACPI PCI bus> on pcib6
isab0: <PCI-ISA bridge> at device 31.0 on pci1
isa0: <ISA bus> on isab0
ahci0: <Intel 5 Series/3400 Series AHCI SATA controller> port 0x1818-0x181f,0x180c-0x180f,0x1810-0x1817,0x1808-0x180b,0x1840-0x185f mem 0xf2427000-0xf24277ff irq 16 at device 31.2 on pci1
ahci0: AHCI v1.30 with 6 3Gbps ports, Port Multiplier not supported
ahcich0: <AHCI channel> at channel 0 on ahci0
ahcich1: <AHCI channel> at channel 1 on ahci0
ahcich4: <AHCI channel> at channel 4 on ahci0
ahcich5: <AHCI channel> at channel 5 on ahci0
ahciem0: <AHCI enclosure management bridge> on ahci0
acpi_tz0: <Thermal Zone> on acpi0
atkbdc0: <Keyboard controller (i8042)> port 0x60,0x64 irq 1 on acpi0
atkbd0: <AT Keyboard> irq 1 on atkbdc0
kbd0 at atkbd0
atkbd0: [GIANT-LOCKED]
psm0: <PS/2 Mouse> irq 12 on atkbdc0
psm0: [GIANT-LOCKED]
psm0: model Generic PS/2 mouse, device ID 0
battery0: <ACPI Control Method Battery> on acpi0
acpi_acad0: <AC Adapter> on acpi0
acpi_ibm0: <IBM ThinkPad ACPI Extras> on acpi0
orm0: <ISA Option ROMs> at iomem 0xd0000-0xd0fff,0xd1000-0xd1fff,0xdd000-0xdffff,0xe0000-0xeffff on isa0
ppc0: cannot reserve I/O port range
coretemp0: <CPU On-Die Thermal Sensors> on cpu0
est0: <Enhanced SpeedStep Frequency Control> on cpu0
coretemp1: <CPU On-Die Thermal Sensors> on cpu1
est1: <Enhanced SpeedStep Frequency Control> on cpu1
coretemp2: <CPU On-Die Thermal Sensors> on cpu2
est2: <Enhanced SpeedStep Frequency Control> on cpu2
coretemp3: <CPU On-Die Thermal Sensors> on cpu3
est3: <Enhanced SpeedStep Frequency Control> on cpu3
usbus0: 480Mbps High Speed USB v2.0
Timecounters tick every 10.000 msec
IPsec: Initialized Security Association Processing.
hdacc0: <NVIDIA GT21x HDA CODEC> at cad 0 on hdac0
hdaa0: <NVIDIA GT21x Audio Function Group> at nid 1 on hdacc0
pcm0: <NVIDIA GT21x (HDMI/DP 8ch)> at nid 5 on hdaa0
hdacc1: <NVIDIA GT21x HDA CODEC> at cad 1 on hdac0
hdaa1: <NVIDIA GT21x Audio Function Group> at nid 1 on hdacc1
pcm1: <NVIDIA GT21x (HDMI/DP 8ch)> at nid 5 on hdaa1
hdacc2: <NVIDIA GT21x HDA CODEC> at cad 2 on hdac0
hdaa2: <NVIDIA GT21x Audio Function Group> at nid 1 on hdacc2
pcm2: <NVIDIA GT21x (HDMI/DP 8ch)> at nid 5 on hdaa2
hdacc3: <NVIDIA GT21x HDA CODEC> at cad 3 on hdac0
hdaa3: <NVIDIA GT21x Audio Function Group> at nid 1 on hdacc3
pcm3: <NVIDIA GT21x (HDMI/DP 8ch)> at nid 5 on hdaa3
hdacc4: <Conexant CX20585 HDA CODEC> at cad 0 on hdac1
hdaa4: <Conexant CX20585 Audio Function Group> at nid 1 on hdacc4
pcm4: <Conexant CX20585 (Right Analog)> at nid 25 and 27 on hdaa4
pcm5: <Conexant CX20585 (Internal Analog)> at nid 31 and 35 on hdaa4
usbus1: 480Mbps High Speed USB v2.0
ugen0.1: <Intel> at usbus0
uhub0: <Intel EHCI root HUB, class 9/0, rev 2.00/1.00, addr 1> on usbus0
ugen1.1: <Intel> at usbus1
uhub1: <Intel EHCI root HUB, class 9/0, rev 2.00/1.00, addr 1> on usbus1
ses0 at ahciem0 bus 0 scbus4 target 0 lun 0
ses0: <AHCI SGPIO Enclosure 1.00 0001> SEMB S-E-S 2.00 device
ses0: SEMB SES Device
ada0 at ahcich0 bus 0 scbus0 target 0 lun 0
ada0: <WDC WD3200BEVT-08A23T1 02.01A02> ATA8-ACS SATA 2.x device
ada0: Serial Number WD-WXD1A1154275
ada0: 300.000MB/s transfers (SATA 2.x, UDMA6, PIO 8192bytes)
ada0: Command Queueing enabled
ada0: 305245MB (625142448 512 byte sectors)
cd0 at ahcich1 bus 0 scbus1 target 0 lun 0
cd0: <Optiarc DVD RW AD-7930H 1.D1> Removable CD-ROM SCSI device
cd0: 150.000MB/s transfers (SATA 1.x, UDMA5, ATAPI 12bytes, PIO 8192bytes)
cd0: Attempt to query device size failed: NOT READY, Medium not present - tray closed
SMP: AP CPU #1 Launched!
SMP: AP CPU #3 Launched!
SMP: AP CPU #2 Launched!
Timecounter "TSC-low" frequency 1330030736 Hz quality 1000
WARNING: WITNESS option enabled, expect reduced performance.
Trying to mount root from ufs:/dev/ada0p3 [rw]...
uhub0: 3 ports with 3 removable, self powered
uhub1: 3 ports with 3 removable, self powered
ugen0.2: <vendor 0x8087> at usbus0
uhub2: <vendor 0x8087 product 0x0020, class 9/0, rev 2.00/0.00, addr 2> on usbus0
ugen1.2: <vendor 0x8087> at usbus1
uhub3: <vendor 0x8087 product 0x0020, class 9/0, rev 2.00/0.00, addr 2> on usbus1
uhub2: 6 ports with 6 removable, self powered
uhub3: 8 ports with 8 removable, self powered
ugen0.3: <Broadcom Corp> at usbus0
ugen0.4: <Chicony Electronics Co., Ltd.> at usbus0
wlan0: Ethernet address: 00:24:d7:91:b5:44
iwn0: iwn_read_firmware: ucode rev=0x09dd0401
wlan0: link state changed to UP
ubt0: <Broadcom Corp Broadcom Bluetooth Device, class 224/1, rev 2.00/3.60, addr 3> on usbus0
wlan0: link state changed to DOWN
iwn0: device timeout
WARNING: attempt to domain_add(bluetooth) after domainfinalize()
WARNING: attempt to domain_add(netgraph) after domainfinalize()
wlan0: ieee80211_swscan_cancel_scan: cancel active scan
wlan0: scan_task: loop start; scandone=1
wlan0: scan_task: out
wlan0: scan_task: done, [ticks 2147572967, dwell min 2 scanend 4294909235]
iwn0: iwn_read_firmware: ucode rev=0x09dd0401
wlan0: ieee80211_swscan_cancel_scan: called; F_SCAN=0, vap=match, CANCEL=0
wlan0: ieee80211_scan_flush
iwn0: iwn_read_firmware: ucode rev=0x09dd0401
wlan0: ieee80211_swscan_cancel_scan: called; F_SCAN=0, vap=match, CANCEL=0
wlan0: ieee80211_check_scan: active scan, append
wlan0: sta_pick_bss: no scan candidate
wlan0: ieee80211_swscan_start_scan_locked: active scan, duration 2147483647 mindwell 0 maxdwell 0, desired mode auto, append
wlan0: scan set 1g, 6g, 11g, 7g, 13g, 52a, 56a, 60a, 64a, 36a, 40a, 44a, 48a, 2g, 3g, 4g, 5g, 8g, 9g, 10g, 12g, 100a, 104a, 108a, 112a, 116a, 120a, 124a, 128a, 132a, 136a, 140a dwell min 20ms max 200ms
wlan0: scan_task: loop start; scandone=0
wlan0: scan_task: chan 11n -> 1g [active, dwell min 20ms max 200ms]
wlan0: scan_task: waiting
[88:03:55:46:e4:dd] new probe_resp on chan 1 (bss chan 1) "<NEIGHBOUR0>" rssi 8
[88:03:55:46:e4:dd] caps 0x1411 bintval 100 erp 0x100 country [DE 1-13,20]
wlan0: ieee80211_swscan_scan_next: called
wlan0: scan_task: loop start; scandone=0
wlan0: scan_task: chan 1g -> 6g [active, dwell min 20ms max 200ms]
wlan0: scan_task: waiting
[74:31:70:c6:43:cc] new probe_resp on chan 6 (bss chan 6) "<NEIGHBOUR1>" rssi 23
[74:31:70:c6:43:cc] caps 0x431 bintval 100 erp 0x100 country [DE 1-13,20]
wlan0: ieee80211_swscan_add_scan: chan 6g min dwell met (2147573289 > 18446744071562157609)
[74:31:70:c6:43:cc] new beacon on chan 6 (bss chan 6) "<NEIGHBOUR1>" rssi 23
[74:31:70:c6:43:cc] caps 0x431 bintval 100 erp 0x100 country [DE 1-13,20]
[bc:05:43:cc:6f:63] new beacon on chan 6 (bss chan 6) "<NEIGHBOUR2>" rssi 7
[bc:05:43:cc:6f:63] caps 0x411 bintval 100 erp 0x104
[84:9c:a6:5c:3b:30] new beacon on chan 6 (bss chan 6) "<NEIGHBOUR3>" rssi 9
[84:9c:a6:5c:3b:30] caps 0x431 bintval 100 erp 0x100 country [DE 1-13,20]
[d4:21:22:cc:48:94] new beacon on chan 6 (bss chan 6) "<NEIGHBOUR4>" rssi 13
[d4:21:22:cc:48:94] caps 0x401 bintval 100 erp 0x100 country [DE 1-13,20]
wlan0: ieee80211_swscan_scan_next: called
wlan0: scan_task: loop start; scandone=0
wlan0: scan_task: chan 6g -> 11g [active, dwell min 20ms max 200ms]
wlan0: scan_task: waiting
[bc:05:43:98:15:88] new probe_resp on chan 11 (bss chan 11) "<MY_SSID>" rssi 48
[bc:05:43:98:15:88] caps 0x431 bintval 100 erp 0x100 country [DE 1-13,20]
wlan0: ieee80211_swscan_scan_next: called
wlan0: scan_task: loop start; scandone=0
wlan0: scan_task: chan 11g -> 7g [active, dwell min 20ms max 200ms]
wlan0: scan_task: waiting
wlan0: ieee80211_swscan_scan_next: called
wlan0: scan_task: loop start; scandone=0
wlan0: scan_task: chan 7g -> 13g [passive, dwell min 20ms max 200ms]
wlan0: scan_task: waiting
wlan0: ieee80211_swscan_scan_next: called
wlan0: scan_task: loop start; scandone=0
wlan0: scan_task: chan 13g -> 52a [passive, dwell min 20ms max 200ms]
wlan0: scan_task: waiting
wlan0: ieee80211_swscan_cancel_scan: cancel active scan
wlan0: scan_task: loop start; scandone=1
wlan0: scan_task: out
wlan0: scan_task: done, [ticks 2147573309, dwell min 2 scanend 89637]
wlan0: ieee80211_swscan_cancel_scan: called; F_SCAN=0, vap=match, CANCEL=0
wlan0: ieee80211_scan_flush
iwn0: iwn_read_firmware: ucode rev=0x09dd0401
wlan0: ieee80211_scanreq: flags 0x20052 duration 0x7fffffff mindwell 0 maxdwell 0 nssid 1
wlan0: ieee80211_swscan_cancel_scan: called; F_SCAN=0, vap=match, CANCEL=0
wlan0: ieee80211_check_scan: active scan, append, nojoin, once
wlan0: sta_pick_bss: no scan candidate
wlan0: ieee80211_swscan_start_scan_locked: active scan, duration 2147483647 mindwell 0 maxdwell 0, desired mode auto, append, nojoin, wlan0: scan set 1g, 6g, 11g, 7g, 13g, 52a, 56a, 60a, 64a, 36a, 40a, 44a, 48a, 2g, 3g, 4g, 5g, 8g, 9g, 10g, 12g, 100a, 104a, 108a, 112a, 116a, 120a, 124a, 128a, 132a, 136a, 140a dwell min 20ms max 200ms
wlan0: scan_task: loop start; scandone=0
wlan0: scan_task: chan 11n -> 1g [active, dwell min 20ms max 200ms]
wlan0: scan_task: waiting
[88:03:55:46:e4:dd] new probe_resp on chan 1 (bss chan 1) "<NEIGHBOUR0>" rssi 8
[88:03:55:46:e4:dd] caps 0x1411 bintval 100 erp 0x100 country [DE 1-13,20]
wlan0: ieee80211_swscan_add_scan: chan 1g min dwell met (2147573328 > 18446744071562157648)
wlan0: ieee80211_swscan_scan_next: called
wlan0: scan_task: loop start; scandone=0
wlan0: scan_task: chan 1g -> 6g [active, dwell min 20ms max 200ms]
wlan0: scan_task: waiting
[d4:21:22:cc:48:93] new probe_resp on chan 6 (bss chan 6) "<NEIGHBOUR5>" rssi 17
[d4:21:22:cc:48:93] caps 0x411 bintval 100 erp 0x100 country [DE 1-13,20]
[74:31:70:c6:43:cc] new probe_resp on chan 6 (bss chan 6) "<NEIGHBOUR1>" rssi 23
[74:31:70:c6:43:cc] caps 0x431 bintval 100 erp 0x100 country [DE 1-13,20]
[58:1f:28:a3:44:f6] new probe_resp on chan 6 (bss chan 6) "<NEIGHBOUR6>" rssi 17
[58:1f:28:a3:44:f6] caps 0x411 bintval 100 erp 0x100
wlan0: ieee80211_swscan_add_scan: chan 6g min dwell met (2147573330 > 18446744071562157650)
[d4:21:22:cc:48:93] new probe_resp on chan 6 (bss chan 6) "<NEIGHBOUR5>" rssi 13
[d4:21:22:cc:48:93] caps 0x411 bintval 100 erp 0x100 country [DE 1-13,20]
[74:31:70:c6:43:cc] new probe_resp on chan 6 (bss chan 6) "<NEIGHBOUR1>" rssi 24
[74:31:70:c6:43:cc] caps 0x431 bintval 100 erp 0x100 country [DE 1-13,20]
[d4:21:22:cc:48:93] new beacon on chan 6 (bss chan 6) "<NEIGHBOUR5>" rssi 13
[d4:21:22:cc:48:93] caps 0x411 bintval 100 erp 0x100 country [DE 1-13,20]
[d4:21:22:cc:48:94] new beacon on chan 6 (bss chan 6) "<NEIGHBOUR4>" rssi 13
[d4:21:22:cc:48:94] caps 0x401 bintval 100 erp 0x100 country [DE 1-13,20]
[d4:21:22:cc:48:94] new probe_resp on chan 6 (bss chan 6) "<NEIGHBOUR4>" rssi 13
[d4:21:22:cc:48:94] caps 0x401 bintval 100 erp 0x100 country [DE 1-13,20]
wlan0: ieee80211_swscan_scan_next: called
wlan0: scan_task: loop start; scandone=0
wlan0: scan_task: chan 6g -> 11g [active, dwell min 20ms max 200ms]
wlan0: scan_task: waiting
[bc:05:43:98:15:88] new probe_resp on chan 11 (bss chan 11) "<MY_SSID>" rssi 55
[bc:05:43:98:15:88] caps 0x431 bintval 100 erp 0x100 country [DE 1-13,20]
[bc:05:43:98:15:88] new probe_resp on chan 11 (bss chan 11) "<MY_SSID>" rssi 55
[bc:05:43:98:15:88] caps 0x431 bintval 100 erp 0x100 country [DE 1-13,20]
wlan0: ieee80211_swscan_add_scan: chan 11g min dwell met (2147573335 > 18446744071562157654)
wlan0: ieee80211_swscan_scan_next: called
wlan0: scan_task: loop start; scandone=0
wlan0: scan_task: chan 11g -> 7g [active, dwell min 20ms max 200ms]
wlan0: scan_task: waiting
wlan0: ieee80211_swscan_scan_next: called
wlan0: scan_task: loop start; scandone=0
wlan0: scan_task: chan 7g -> 13g [passive, dwell min 20ms max 200ms]
wlan0: scan_task: waiting
wlan0: ieee80211_swscan_scan_next: called
wlan0: scan_task: loop start; scandone=0
wlan0: scan_task: chan 13g -> 52a [passive, dwell min 20ms max 200ms]
wlan0: scan_task: waiting
wlan0: ieee80211_swscan_scan_next: called
wlan0: scan_task: loop start; scandone=0
wlan0: scan_task: chan 52a -> 56a [passive, dwell min 20ms max 200ms]
wlan0: scan_task: waiting
wlan0: ieee80211_swscan_scan_next: called
wlan0: scan_task: loop start; scandone=0
wlan0: scan_task: chan 56a -> 60a [passive, dwell min 20ms max 200ms]
wlan0: scan_task: waiting
wlan0: ieee80211_swscan_scan_next: called
wlan0: scan_task: loop start; scandone=0
wlan0: scan_task: chan 60a -> 64a [passive, dwell min 20ms max 200ms]
wlan0: scan_task: waiting
wlan0: ieee80211_swscan_scan_next: called
wlan0: scan_task: loop start; scandone=0
wlan0: scan_task: chan 64a -> 36a [passive, dwell min 20ms max 200ms]
wlan0: scan_task: waiting
wlan0: ieee80211_swscan_scan_next: called
wlan0: scan_task: loop start; scandone=0
wlan0: scan_task: chan 36a -> 40a [passive, dwell min 20ms max 200ms]
wlan0: scan_task: waiting
[74:31:70:c6:43:cd] new beacon on chan 40 (bss chan 40) "<NEIGHBOUR1>" rssi 14
[74:31:70:c6:43:cd] caps 0x11 bintval 100 erp 0x0 country [DE 36-39,22 52-55,22 100-108,28]
wlan0: ieee80211_swscan_add_scan: chan 40a min dwell met (2147573362 > 18446744071562157682)
wlan0: ieee80211_swscan_scan_next: called
wlan0: scan_task: loop start; scandone=0
wlan0: scan_task: chan 40a -> 44a [passive, dwell min 20ms max 200ms]
wlan0: scan_task: waiting
wlan0: ieee80211_swscan_scan_next: called
wlan0: scan_task: loop start; scandone=0
wlan0: scan_task: chan 44a -> 48a [passive, dwell min 20ms max 200ms]
wlan0: scan_task: waiting
wlan0: ieee80211_swscan_scan_next: called
wlan0: scan_task: loop start; scandone=0
wlan0: scan_task: chan 48a -> 2g [active, dwell min 20ms max 200ms]
wlan0: scan_task: waiting
wlan0: ieee80211_swscan_scan_next: called
wlan0: scan_task: loop start; scandone=0
wlan0: scan_task: chan 2g -> 3g [active, dwell min 20ms max 200ms]
wlan0: scan_task: waiting
[18:83:bf:1f:00:ec] new probe_resp on chan 3 (bss chan 3) "<NEIGHBOUR7>" rssi 13
[18:83:bf:1f:00:ec] caps 0x411 bintval 100 erp 0x104 country [DE 1-13,16]
[18:83:bf:1f:00:ec] new probe_resp on chan 3 (bss chan 3) "<NEIGHBOUR7>" rssi 16
[18:83:bf:1f:00:ec] caps 0x411 bintval 100 erp 0x104 country [DE 1-13,16]
wlan0: ieee80211_swscan_add_scan: chan 3g min dwell met (2147573375 > 18446744071562157695)
wlan0: ieee80211_swscan_scan_next: called
wlan0: scan_task: loop start; scandone=0
wlan0: scan_task: chan 3g -> 4g [active, dwell min 20ms max 200ms]
wlan0: scan_task: waiting
wlan0: ieee80211_swscan_scan_next: called
wlan0: scan_task: loop start; scandone=0
wlan0: scan_task: chan 4g -> 5g [active, dwell min 20ms max 200ms]
wlan0: scan_task: waiting
wlan0: ieee80211_swscan_scan_next: called
wlan0: scan_task: loop start; scandone=0
wlan0: scan_task: chan 5g -> 8g [active, dwell min 20ms max 200ms]
wlan0: scan_task: waiting
wlan0: ieee80211_swscan_scan_next: called
wlan0: scan_task: loop start; scandone=0
wlan0: scan_task: chan 8g -> 9g [active, dwell min 20ms max 200ms]
wlan0: scan_task: waiting
wlan0: ieee80211_swscan_scan_next: called
wlan0: scan_task: loop start; scandone=0
wlan0: scan_task: chan 9g -> 10g [active, dwell min 20ms max 200ms]
wlan0: scan_task: waiting
wlan0: ieee80211_swscan_scan_next: called
wlan0: scan_task: loop start; scandone=0
wlan0: scan_task: chan 10g -> 12g [passive, dwell min 20ms max 200ms]
wlan0: scan_task: waiting
wlan0: ieee80211_swscan_scan_next: called
wlan0: scan_task: loop start; scandone=0
wlan0: scan_task: chan 12g -> 100a [passive, dwell min 20ms max 200ms]
wlan0: scan_task: waiting
wlan0: ieee80211_swscan_scan_next: called
wlan0: scan_task: loop start; scandone=0
wlan0: scan_task: chan 100a -> 104a [passive, dwell min 20ms max 200ms]
wlan0: scan_task: waiting
wlan0: ieee80211_swscan_scan_next: called
wlan0: scan_task: loop start; scandone=0
wlan0: scan_task: chan 104a -> 108a [passive, dwell min 20ms max 200ms]
wlan0: scan_task: waiting
wlan0: ieee80211_swscan_scan_next: called
wlan0: scan_task: loop start; scandone=0
wlan0: scan_task: chan 108a -> 112a [passive, dwell min 20ms max 200ms]
wlan0: scan_task: waiting
wlan0: ieee80211_swscan_scan_next: called
wlan0: scan_task: loop start; scandone=0
wlan0: scan_task: chan 112a -> 116a [passive, dwell min 20ms max 200ms]
wlan0: scan_task: waiting
wlan0: ieee80211_swscan_scan_next: called
wlan0: scan_task: loop start; scandone=0
wlan0: scan_task: chan 116a -> 120a [passive, dwell min 20ms max 200ms]
wlan0: scan_task: waiting
wlan0: ieee80211_swscan_scan_next: called
wlan0: scan_task: loop start; scandone=0
wlan0: scan_task: chan 120a -> 124a [passive, dwell min 20ms max 200ms]
wlan0: scan_task: waiting
wlan0: ieee80211_swscan_scan_next: called
wlan0: scan_task: loop start; scandone=0
wlan0: scan_task: chan 124a -> 128a [passive, dwell min 20ms max 200ms]
wlan0: scan_task: waiting
wlan0: ieee80211_swscan_scan_next: called
wlan0: scan_task: loop start; scandone=0
wlan0: scan_task: chan 128a -> 132a [passive, dwell min 20ms max 200ms]
wlan0: scan_task: waiting
wlan0: ieee80211_swscan_scan_next: called
wlan0: scan_task: loop start; scandone=0
wlan0: scan_task: chan 132a -> 136a [passive, dwell min 20ms max 200ms]
wlan0: scan_task: waiting
wlan0: ieee80211_swscan_scan_next: called
wlan0: scan_task: loop start; scandone=0
wlan0: scan_task: chan 136a -> 140a [passive, dwell min 20ms max 200ms]
wlan0: scan_task: waiting
wlan0: ieee80211_swscan_scan_next: called
wlan0: scan_task: loop start; scandone=1
wlan0: scan_task: out
wlan0: macaddr bssid chan rssi rate flag wep essid
- 88:03:55:46:e4:dd 88:03:55:46:e4:dd 1 8 54M ess wep "<NEIGHBOUR0>"!
- d4:21:22:cc:48:93 d4:21:22:cc:48:93 6 16 54M ess wep "<NEIGHBOUR5>"!
- 74:31:70:c6:43:cc 74:31:70:c6:43:cc 6 23 54M ess wep "<NEIGHBOUR1>"!
- 58:1f:28:a3:44:f6 58:1f:28:a3:44:f6 6 17 54M ess wep "<NEIGHBOUR6>"!
- d4:21:22:cc:48:94 d4:21:22:cc:48:94 6 13 54M ess no! "<NEIGHBOUR4>"!
- bc:05:43:98:15:88 bc:05:43:98:15:88 11 55 54M ess wep "<MY_SSID>"!
- 74:31:70:c6:43:cd 74:31:70:c6:43:cd 40 14 54M ess wep "<NEIGHBOUR1>"!
- 18:83:bf:1f:00:ec 18:83:bf:1f:00:ec 3 13 54M ess wep "<NEIGHBOUR7>"!
wlan0: scan_task: done, [ticks 2147573436, dwell min 2 scanend 89677]
wlan0: notify scan done
wlan0: ieee80211_swscan_cancel_scan: called; F_SCAN=0, vap=match, CANCEL=0
wlan0: ieee80211_swscan_cancel_scan: called; F_SCAN=0, vap=match, CANCEL=0
wlan0: [bc:05:43:98:15:88] ieee80211_scan_assoc_success
wlan0: link state changed to UP
lock order reversal:
1st 0xfffffe00ecc2c0d0 bufwait (bufwait) @ /usr/src/sys/kern/vfs_bio.c:3476
2nd 0xfffff80003f3b400 dirhash (dirhash) @ /usr/src/sys/ufs/ufs/ufs_dirhash.c:281
KDB: stack backtrace:
db_trace_self_wrapper() at db_trace_self_wrapper+0x2b/frame 0xfffffe01173c3400
witness_checkorder() at witness_checkorder+0xe79/frame 0xfffffe01173c3480
_sx_xlock() at _sx_xlock+0x72/frame 0xfffffe01173c34c0
ufsdirhash_add() at ufsdirhash_add+0x3d/frame 0xfffffe01173c3520
ufs_direnter() at ufs_direnter+0x62f/frame 0xfffffe01173c35f0
ufs_makeinode() at ufs_makeinode+0x5f3/frame 0xfffffe01173c37b0
ufs_create() at ufs_create+0x2d/frame 0xfffffe01173c37d0
VOP_CREATE_APV() at VOP_CREATE_APV+0xf1/frame 0xfffffe01173c3800
vn_open_cred() at vn_open_cred+0x2f8/frame 0xfffffe01173c3970
kern_openat() at kern_openat+0x25c/frame 0xfffffe01173c3ae0
amd64_syscall() at amd64_syscall+0x2de/frame 0xfffffe01173c3bf0
Xfast_syscall() at Xfast_syscall+0xfb/frame 0xfffffe01173c3bf0
--- syscall (499, FreeBSD ELF64, sys_openat), rip = 0x80125af0a, rsp = 0x7fffffffdfc8, rbp = 0x7fffffffe0b0 ---
acquiring duplicate lock of same type: "os.lock_sx"
1st os.lock_sx @ nvidia_os.c:603
2nd os.lock_sx @ nvidia_os.c:603
KDB: stack backtrace:
db_trace_self_wrapper() at db_trace_self_wrapper+0x2b/frame 0xfffffe011738c630
witness_checkorder() at witness_checkorder+0xe79/frame 0xfffffe011738c6b0
_sx_xlock() at _sx_xlock+0x72/frame 0xfffffe011738c6f0
os_acquire_mutex() at os_acquire_mutex+0x32/frame 0xfffffe011738c710
_nv013366rm() at _nv013366rm+0x18/frame 0xfffffe0002280e90
dmapbase() at 0xfffff800535a6180/frame 0xdeadc0dedeadc0de
ACPI Warning: \134_SB_.PCI0.PEG_.VID_._DSM: Argument #4 type mismatch - Found [Buffer], ACPI requires [Package] (20150818/nsarguments-97)
ACPI Warning: \134_SB_.PCI0.PEG_.VID_._DSM: Argument #4 type mismatch - Found [Buffer], ACPI requires [Package] (20150818/nsarguments-97)
ACPI Warning: \134_SB_.PCI0.PEG_.VID_._DSM: Argument #4 type mismatch - Found [Buffer], ACPI requires [Package] (20150818/nsarguments-97)
ACPI Warning: \134_SB_.PCI0.PEG_.VID_._DSM: Argument #4 type mismatch - Found [Buffer], ACPI requires [Package] (20150818/nsarguments-97)
ACPI Warning: \134_SB_.PCI0.PEG_.VID_._DSM: Argument #4 type mismatch - Found [Buffer], ACPI requires [Package] (20150818/nsarguments-97)
ACPI Warning: \134_SB_.PCI0.PEG_.VID_._DSM: Argument #4 type mismatch - Found [Buffer], ACPI requires [Package] (20150818/nsarguments-97)
ACPI Warning: \134_SB_.PCI0.PEG_.VID_._DSM: Argument #4 type mismatch - Found [Buffer], ACPI requires [Package] (20150818/nsarguments-97)
ACPI Warning: \134_SB_.PCI0.PEG_.VID_._DSM: Argument #4 type mismatch - Found [Buffer], ACPI requires [Package] (20150818/nsarguments-97)
ACPI Warning: \134_SB_.PCI0.PEG_.VID_._DSM: Argument #4 type mismatch - Found [Buffer], ACPI requires [Package] (20150818/nsarguments-97)
acquiring duplicate lock of same type: "os.lock_mtx"
1st os.lock_mtx @ nvidia_os.c:777
2nd os.lock_mtx @ nvidia_os.c:777
KDB: stack backtrace:
db_trace_self_wrapper() at db_trace_self_wrapper+0x2b/frame 0xfffffe011738c300
witness_checkorder() at witness_checkorder+0xe79/frame 0xfffffe011738c380
__mtx_lock_flags() at __mtx_lock_flags+0xa4/frame 0xfffffe011738c3d0
os_acquire_spinlock() at os_acquire_spinlock+0x1b/frame 0xfffffe011738c3e0
_nv015308rm() at _nv015308rm+0xce5/frame 0xfffffe0002283ee8
NVRM: GPU at PCI:0000:01:00: GPU-29a322f4-74c9-1c99-3dbb-0048333ae34a
NVRM: Xid (PCI:0000:01:00): 57, Failed shmoo sddr3 link training
lock order reversal:
1st 0xfffff8005383d040 filedesc structure (filedesc structure) @ /usr/src/sys/kern/kern_descrip.c:1231
2nd 0xfffff80053fa2d50 ufs (ufs) @ /usr/src/sys/kern/vfs_subr.c:4542
KDB: stack backtrace:
db_trace_self_wrapper() at db_trace_self_wrapper+0x2b/frame 0xfffffe01173477e0
witness_checkorder() at witness_checkorder+0xe79/frame 0xfffffe0117347860
__lockmgr_args() at __lockmgr_args+0xd3b/frame 0xfffffe0117347910
ffs_lock() at ffs_lock+0xa6/frame 0xfffffe0117347960
VOP_LOCK1_APV() at VOP_LOCK1_APV+0x100/frame 0xfffffe0117347990
_vn_lock() at _vn_lock+0x9a/frame 0xfffffe0117347a00
knlist_remove_kq() at knlist_remove_kq+0x7e/frame 0xfffffe0117347a30
filt_vfsdetach() at filt_vfsdetach+0x28/frame 0xfffffe0117347a50
knote_fdclose() at knote_fdclose+0xc7/frame 0xfffffe0117347aa0
closefp() at closefp+0x65/frame 0xfffffe0117347ae0
amd64_syscall() at amd64_syscall+0x2de/frame 0xfffffe0117347bf0
Xfast_syscall() at Xfast_syscall+0xfb/frame 0xfffffe0117347bf0
--- syscall (6, FreeBSD ELF64, sys_close), rip = 0x805024ffa, rsp = 0x7fffffffd8f8, rbp = 0x7fffffffd910 ---
pid 1183 (owncloud), uid 1001: exited on signal 11 (core dumped)
lock order reversal:
1st 0xfffff800718379a0 ufs (ufs) @ /usr/src/sys/kern/vfs_subr.c:2231
2nd 0xfffffe00ecf32040 bufwait (bufwait) @ /usr/src/sys/ufs/ffs/ffs_vnops.c:263
3rd 0xfffff80071a44418 ufs (ufs) @ /usr/src/sys/kern/vfs_subr.c:2231
KDB: stack backtrace:
db_trace_self_wrapper() at db_trace_self_wrapper+0x2b/frame 0xfffffe01175804b0
witness_checkorder() at witness_checkorder+0xe79/frame 0xfffffe0117580530
__lockmgr_args() at __lockmgr_args+0xd3b/frame 0xfffffe01175805e0
ffs_lock() at ffs_lock+0xa6/frame 0xfffffe0117580630
VOP_LOCK1_APV() at VOP_LOCK1_APV+0x100/frame 0xfffffe0117580660
_vn_lock() at _vn_lock+0x9a/frame 0xfffffe01175806d0
vget() at vget+0x63/frame 0xfffffe0117580720
vfs_hash_get() at vfs_hash_get+0xcc/frame 0xfffffe0117580770
ffs_vgetf() at ffs_vgetf+0x40/frame 0xfffffe0117580800
softdep_sync_buf() at softdep_sync_buf+0xad1/frame 0xfffffe01175808e0
ffs_syncvnode() at ffs_syncvnode+0x256/frame 0xfffffe0117580960
softdep_fsync() at softdep_fsync+0x4ba/frame 0xfffffe0117580a10
ffs_fsync() at ffs_fsync+0x60/frame 0xfffffe0117580a40
VOP_FSYNC_APV() at VOP_FSYNC_APV+0xf7/frame 0xfffffe0117580a70
sys_fsync() at sys_fsync+0x170/frame 0xfffffe0117580ae0
amd64_syscall() at amd64_syscall+0x2de/frame 0xfffffe0117580bf0
Xfast_syscall() at Xfast_syscall+0xfb/frame 0xfffffe0117580bf0
--- syscall (95, FreeBSD ELF64, sys_fsync), rip = 0x8014c675a, rsp = 0x7fffdb5b7b88, rbp = 0x7fffdb5b7ba0 ---
More information about the freebsd-current
mailing list