search

8devices / qcacld-2.0

Drivers for BLUE bean and RED bean modules
8 stars 13 forks source link

module load fail for qcacld-usb.ko #19

Open Hiroshi-tnk opened 1 year ago

Hiroshi-tnk commented 1 year ago

Thank you for developers.

module load fail for qcacld-usb.ko. Do you have any idea what might lead to this error?

We use branch: linux-5.14.y/CNSS.LEA.NRT_3.1 kernel: 5.15.71-rt51-intel-pk-preempt-rt (with yocto custom kernel) wlan module : QCA9377-7 with usb connector type

related lsmod: ID 0cf3:9378 Qualcom atheros communications USBWLAN ID 0cf3:e500 Qualcom atheros communications

dmesg show below:

usb 1-1.2: USB disconnect, device number 13
usb 1-1.2.1: USB disconnect, device number 14
usb 1-1.2.2: USB disconnect, device number 15
usb 1-1.2: new high-speed USB device number 16 using xhci_hcd
hub 1-1.2:1.0: USB hub found
hub 1-1.2:1.0: 2 ports detected
usb 1-1.2.1: new full-speed USB device number 17 using xhci_hcd
usb 1-1.2.2: new high-speed USB device number 18 using xhci_hcd
qcacld_usb: loading driver v4.5.25.50
hif_usb_probe
Enter:hif_usb_disable_lpm,Line:242
hif_usb_disable_lpm: LPM isn't enabled
Exit:hif_usb_disable_lpm,Line:269
BCDDevice : 300
RX Bulk Ep:0x81 maxpktsz:512
athusb: alloc resources lpipe:4 hpipe:0xC0409280 urbs:32
RX Bulk Ep:0x82 maxpktsz:512
athusb: alloc resources lpipe:5 hpipe:0xC0411280 urbs:32
RX Bulk Ep:0x83 maxpktsz:512
athusb: alloc resources lpipe:6 hpipe:0xC0419280 urbs:32
RX Bulk Ep:0x84 maxpktsz:512
athusb: alloc resources lpipe:7 hpipe:0xC0421280 urbs:32
TX Bulk Ep:0x01 maxpktsz:512
athusb: alloc resources lpipe:0 hpipe:0xC0009200 urbs:32
TX Bulk Ep:0x02 maxpktsz:512
athusb: alloc resources lpipe:1 hpipe:0xC0011200 urbs:32
TX Bulk Ep:0x03 maxpktsz:512
athusb: alloc resources lpipe:2 hpipe:0xC0019200 urbs:32
TX Bulk Ep:0x04 maxpktsz:512
athusb: alloc resources lpipe:3 hpipe:0xC0021200 urbs:32
R0: wlan: [14527:E :HDD] hdd_apply_cfg_ini: Reg Parameter gRrmOperChanMax > allowed Maximum [8 > 7]. Enforcing Default= 4
R0: wlan: [14527:E :HDD] hdd_apply_cfg_ini: Reg Parameter gRrmNonOperChanMax > allowed Maximum [8 > 7]. Enforcing Default= 4
R0: [udevd][02:54:49.087570]  wlan: [14527:E :VOS] __ol_transfer_bin_file: transferring file: otp.bin size 25057 bytes done!
ol_download_firmware: chip_id:0x5020001 board_id:0x0
Board extended Data download address: 0x0
R0: [udevd][02:54:49.102737]  wlan: [14527:E :VOS] __ol_transfer_bin_file: transferring file: fakeboar.bin size 8124 bytes done!
__ol_transfer_bin_file: Loading setup file athsetup.bin
usb 1-1.2.2: Direct firmware load for athsetup.bin failed with error -2
__ol_transfer_bin_file: Failed to get athsetup.bin:-2
R0: [udevd][02:54:50.940075]  wlan: [14527:E :VOS] __ol_transfer_bin_file: transferring file: athwlan.bin size 620112 bytes done!
R0: [udevd][02:54:50.941699]  wlan: [14527:F :WDA] WMA --> wmi_unified_attach - success
R0: [udevd][02:54:50.942241]  wlan: [14527:E :SAP] dfs_init_radar_filters[217]: Unknown dfs domain 0 
Target Ready! : transmit resources : 3 size:1792, MaxMsgsPerHTCBundle = 8
 Target failed service 0x301 connect request (status:1)
TX HTT OFF, ep -1 size 0
R0: [udevd][02:54:50.958378]  wlan: [14527:F :WDA] WMA --> wmi_unified_connect_htc_service - success
R0: [VosMCThread][02:54:50.958459]  wlan: [14531:F :WDA] McThread: WNI_CFG_DNLD_REQ
R0: [kworker/0:2][02:54:50.962141]  wlan: [3426:F :WDA] WMA <-- WMI_SERVICE_AVAILABLE_EVENTID
R0: [kworker/0:2][02:54:50.962179]  wlan: [3426:F :WDA] WMA <-- WMI_SERVICE_READY_EVENTID
R0: [kworker/0:2][02:54:50.962194]  wlan: [3426:E :WDA] wma_rx_service_ready_event: Firmware build version : 0000006f
R0: [kworker/0:2][02:54:50.962203]  wlan: [3426:E :WDA] wma_rx_service_ready_event: Board version: 0.21014003
R0: [kworker/0:2][02:54:50.962231]  wlan: [3426:F :WDA] WMA --> WMI_INIT_CMDID
Enter:usb_hif_start_recv_pipes,Line:954 
Post URBs to RX_DATA_PIPE: 32
Exit:usb_hif_start_recv_pipes,Line:990 
Firmware crash detected...

Host SW version: 4.5.25.50
FW version: 0.0.0.0
ol_ramdump_handler: Loading/Unloading is in progress, ignore!
Firmware stack dump:
Stack start address = 0x40ab98
Firmware DRAM dump:
R0: [udevd][02:54:52.984640]  wlan: [14527:F :WDA] wma_wait_for_ready_event: Timeout waiting for ready event from FW
R0: [udevd][02:54:52.984662]  wlan: [14527:F :SYS] Failed to get ready event from target firmware
urb_context is NULL
urb_context is NULL
urb_context is NULL
urb_context is NULL
urb_context is NULL
urb_context is NULL
urb_context is NULL
urb_context is NULL
VOS ASSERT in vos_preStart Line 1008
------------[ cut here ]------------
WARNING: CPU: 0 PID: 14527 at /home/tnk/src/qca9377/8devices/qcacld-2.0_v5.15/CORE/VOSS/src/vos_api.c:1008 vos_preStart+0x2a8/0x3f0 [qcacld_usb]
Modules linked in: qcacld_usb(O+) xt_tcpudp xt_state nf_conntrack nf_defrag_ipv4 iptable_filter ip_tables x_tables iwlwifi cfg80211 intel_rapl_msr i915 intel_rapl_common x86_pkg_temp_thermal intel_powerclamp at24 input_leds coretemp led_class regmap_i2c drm_buddy drm_display_helper drm_kms_helper syscopyarea sysfillrect sysimgblt fb_sys_fops firmware_class mei_me video ttm backlight mei
CPU: 0 PID: 14527 Comm: udevd Tainted: G        W  O      5.15.71-rt51-intel-pk-preempt-rt #1
Hardware name: Default string Default string/Default string, BIOS 5.12 12/29/2017
RIP: 0010:vos_preStart+0x2a8/0x3f0 [qcacld_usb]
Code: 8b 05 64 bc 22 00 48 8b b8 48 da 06 00 e8 90 74 08 00 ba f0 03 00 00 48 c7 c6 a0 58 77 c0 48 c7 c7 49 60 84 c0 e8 07 82 81 e8 <0f> 0b 41 bd 10 00 00 00 e9 6b fe ff ff 48 c7 c2 c6 61 84 c0 be 01
RSP: 0018:ffffa0ed446d7940 EFLAGS: 00010246
RAX: 0000000000000024 RBX: 000000000000ffff RCX: 0000000000000000
RDX: 0000000000000000 RSI: ffffffffa972f17d RDI: 00000000ffffffff
RBP: ffffa0ed446d7950 R08: 0000000000000024 R09: 0000000000000003
R10: ffffffffffffffff R11: ffffffffa9e04016 R12: ffff903406ccd800
R13: 0000000000000010 R14: 0000000000000000 R15: ffff903406ccd800
FS:  00007f2d04766780(0000) GS:ffff90347ac00000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 0000556fedd7aafc CR3: 00000000036be000 CR4: 00000000003506f0
Call Trace:
 <TASK>
 hdd_wlan_startup+0xcfa/0x2b70 [qcacld_usb]
 ? vos_timer_get_system_time+0x25/0x70 [qcacld_usb]
 ? vos_mem_malloc+0x4e/0x100 [qcacld_usb]
 hif_usb_probe+0x2d0/0x390 [qcacld_usb]
 ? hif_usb_probe+0x2d0/0x390 [qcacld_usb]
 usb_probe_interface+0xdf/0x250
 really_probe.part.0+0xc1/0x2c0
 __driver_probe_device+0x96/0x130
 driver_probe_device+0x24/0xf0
 __driver_attach+0x77/0x190
 ? __device_attach_driver+0x110/0x110
 bus_for_each_dev+0x7f/0xd0
 driver_attach+0x1e/0x30
 bus_add_driver+0x12c/0x1e0
 driver_register+0x95/0x100
 usb_register_driver+0x89/0x130
 ? 0xffffffffc0a27000
 hif_register_driver+0x62/0xd0 [qcacld_usb]
 ? 0xffffffffc0a27000
 hdd_hif_register_driver+0x3e/0x120 [qcacld_usb]
 ? 0xffffffffc0a27000
 hdd_module_init+0x14f/0x1000 [qcacld_usb]
 ? 0xffffffffc0a27000
 do_one_initcall+0x52/0x210
 ? kmem_cache_alloc_trace+0x44/0x450
 do_init_module+0x52/0x260
 load_module+0x251e/0x2820
 ? kernel_read_file+0x232/0x290
 __do_sys_finit_module+0xb5/0x100
 ? __do_sys_finit_module+0xb5/0x100
 __x64_sys_finit_module+0x18/0x20
 do_syscall_64+0x43/0x90
 entry_SYSCALL_64_after_hwframe+0x61/0xcb
RIP: 0033:0x7f2d048b808d
Code: 5b 41 5c c3 66 0f 1f 84 00 00 00 00 00 f3 0f 1e fa 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d 63 ad 0e 00 f7 d8 64 89 01 48
RSP: 002b:00007ffd758fb708 EFLAGS: 00000246 ORIG_RAX: 0000000000000139
RAX: ffffffffffffffda RBX: 0000555d23a1e380 RCX: 00007f2d048b808d
RDX: 0000000000000000 RSI: 00007f2d049c336b RDI: 0000000000000008
RBP: 0000000000020000 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000008 R11: 0000000000000246 R12: 00007f2d049c336b
R13: 0000000000000000 R14: 00007ffd758fbc80 R15: 0000555d23a1e380
 </TASK>
---[ end trace 9594233719928203 ]---
R0: [udevd][02:54:53.512649]  wlan: [14527:F :HDD] hdd_wlan_startup: vos_preStart failed
R0: [VosMCThread][02:54:53.512790]  wlan: [14531:E :VOS] VosMCThread: MC Thread exiting!!!!
R0: [VosTlshimRxThre][02:54:53.513000]  wlan: [14532:E :VOS] VosTlshimRxThread: Shutting down tl shim Tlshim rx thread
R0: [VosTlshimRxThre][02:54:53.513016]  wlan: [14532:E :VOS] VosTlshimRxThread: Exiting VOSS Tlshim rx thread
urb_context is NULL
urb_context is NULL
urb_context is NULL
urb_context is NULL
urb_context is NULL
urb_context is NULL
urb_context is NULL
urb_context is NULL
urb_context is NULL
urb_context is NULL
urb_context is NULL
urb_context is NULL
urb_context is NULL
urb_context is NULL
urb_context is NULL
urb_context is NULL
urb_context is NULL
urb_context is NULL
urb_context is NULL
urb_context is NULL
urb_context is NULL
urb_context is NULL
urb_context is NULL
urb_context is NULL
R0: [udevd][02:54:53.514976]  wlan: [14527:E :VOS] vos_get_context: Module ID 17 context is Null
------------[ cut here ]------------
WARNING: CPU: 0 PID: 14527 at kernel/workqueue.c:3083 __flush_work.isra.0+0x20e/0x220
Modules linked in: qcacld_usb(O+) xt_tcpudp xt_state nf_conntrack nf_defrag_ipv4 iptable_filter ip_tables x_tables iwlwifi cfg80211 intel_rapl_msr i915 intel_rapl_common x86_pkg_temp_thermal intel_powerclamp at24 input_leds coretemp led_class regmap_i2c drm_buddy drm_display_helper drm_kms_helper syscopyarea sysfillrect sysimgblt fb_sys_fops firmware_class mei_me video ttm backlight mei
CPU: 0 PID: 14527 Comm: udevd Tainted: G        W  O      5.15.71-rt51-intel-pk-preempt-rt #1
Hardware name: Default string Default string/Default string, BIOS 5.12 12/29/2017
RIP: 0010:__flush_work.isra.0+0x20e/0x220
Code: 0c 24 49 8b 54 24 08 89 ce 48 c1 e9 04 83 e6 08 83 e1 0f 83 ce 02 89 c8 49 0f ba 2c 24 03 e9 25 ff ff ff 0f 0b e9 4b ff ff ff <0f> 0b 45 31 f6 e9 41 ff ff ff e8 f3 61 a2 00 0f 1f 00 0f 1f 44 00
RSP: 0018:ffffa0ed446d7830 EFLAGS: 00010246
RAX: 0000000000000000 RBX: 0000000000000000 RCX: 0000000000000000
RDX: 0000000000000001 RSI: 0000000000000000 RDI: ffffffffc0939410
RBP: ffffa0ed446d78a8 R08: ffffa0ed446d7649 R09: 0000000000000005
R10: ffffffffffffffff R11: ffffa0ed446d7649 R12: ffffffffc0939410
R13: 0000000000000000 R14: 0000000000000001 R15: ffff903406ccd800
FS:  00007f2d04766780(0000) GS:ffff90347ac00000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 0000555d23a82120 CR3: 00000000036be000 CR4: 00000000003506f0
Call Trace:
 <TASK>
 ? debug_smp_processor_id+0x17/0x20
 ? free_unref_page+0xcf/0x110
 __cancel_work_timer+0x109/0x190
 ? preempt_count_add+0x82/0xc0
 cancel_work_sync+0x10/0x20
 vos_wdthread_flush_timer_work+0x26/0x50 [qcacld_usb]
 vos_close+0x14d/0x410 [qcacld_usb]
 hdd_wlan_startup+0x1e04/0x2b70 [qcacld_usb]
 ? vos_timer_get_system_time+0x25/0x70 [qcacld_usb]
 ? vos_mem_malloc+0x4e/0x100 [qcacld_usb]
 hif_usb_probe+0x2d0/0x390 [qcacld_usb]
 ? hif_usb_probe+0x2d0/0x390 [qcacld_usb]
 usb_probe_interface+0xdf/0x250
 really_probe.part.0+0xc1/0x2c0
 __driver_probe_device+0x96/0x130
 driver_probe_device+0x24/0xf0
 __driver_attach+0x77/0x190
 ? __device_attach_driver+0x110/0x110
 bus_for_each_dev+0x7f/0xd0
 driver_attach+0x1e/0x30
 bus_add_driver+0x12c/0x1e0
 driver_register+0x95/0x100
 usb_register_driver+0x89/0x130
 ? 0xffffffffc0a27000
 hif_register_driver+0x62/0xd0 [qcacld_usb]
 ? 0xffffffffc0a27000
 hdd_hif_register_driver+0x3e/0x120 [qcacld_usb]
 ? 0xffffffffc0a27000
 hdd_module_init+0x14f/0x1000 [qcacld_usb]
 ? 0xffffffffc0a27000
 do_one_initcall+0x52/0x210
 ? kmem_cache_alloc_trace+0x44/0x450
 do_init_module+0x52/0x260
 load_module+0x251e/0x2820
 ? kernel_read_file+0x232/0x290
 __do_sys_finit_module+0xb5/0x100
 ? __do_sys_finit_module+0xb5/0x100
 __x64_sys_finit_module+0x18/0x20
 do_syscall_64+0x43/0x90
 entry_SYSCALL_64_after_hwframe+0x61/0xcb
RIP: 0033:0x7f2d048b808d
Code: 5b 41 5c c3 66 0f 1f 84 00 00 00 00 00 f3 0f 1e fa 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d 63 ad 0e 00 f7 d8 64 89 01 48
RSP: 002b:00007ffd758fb708 EFLAGS: 00000246 ORIG_RAX: 0000000000000139
RAX: ffffffffffffffda RBX: 0000555d23a1e380 RCX: 00007f2d048b808d
RDX: 0000000000000000 RSI: 00007f2d049c336b RDI: 0000000000000008
RBP: 0000000000020000 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000008 R11: 0000000000000246 R12: 00007f2d049c336b
R13: 0000000000000000 R14: 00007ffd758fbc80 R15: 0000555d23a1e380
 </TASK>
---[ end trace 9594233719928204 ]---
usb_hif_submit_ctrl_out failed,result = -110
hif_usb: probe of 1-1.2.2:1.0 failed with error -5
usbcore: registered new interface driver hif_usb
R0: wlan: [14527:E :HDD] hdd_hif_register_driver: 18373: HIF registration failed
R0: wlan: [14527:F :HDD] hdd_driver_init: WLAN Driver Initialization failed
Try to unregister hif_driver
usbcore: deregistering interface driver hif_usb
hif_unregister_driver!!!!!!
Hiroshi-tnk commented 1 year ago

working fine with next condition

branch: linux-5.4.y/CNSS.LEA.NRT_3.0 kernel: 5.4.209-rt77-intel-pk-preempt-rt (with yocto custom kernel) wlan module : QCA9377-7 with usb connector type (same device)

valinskas commented 1 year ago

My guess that is a result between target firmware (binary blob provided by vendor: athwlan.bin, etc, .ini files) and driver version. I refer to the part Firmware crash detected... message.

valinskas commented 1 year ago

I tried to compile and run 3.1 on 5.4.0-139 (ubuntu 20.04/LTS) linux kernel. I cant load and run 3.1 either. but i dont get any firmware crash errors and etc:

[ 2298.492631] wlan: loading driver v4.5.25.50
[ 2298.492672] hif_usb_probe
[ 2298.493026] hif_usb_probe[322]

[ 2298.493958] Enter:hif_usb_disable_lpm,Line:242
[ 2298.493959] hif_usb_disable_lpm: LPM isn't enabled
[ 2298.493959] Exit:hif_usb_disable_lpm,Line:269
[ 2298.493960] BCDDevice : 300
[ 2298.493962] RX Bulk Ep:0x81 maxpktsz:512
[ 2298.493970] athusb: alloc resources lpipe:4 hpipe:0xC0408B80 urbs:32
[ 2298.493970] RX Bulk Ep:0x82 maxpktsz:512
[ 2298.493993] athusb: alloc resources lpipe:5 hpipe:0xC0410B80 urbs:32
[ 2298.493993] RX Bulk Ep:0x83 maxpktsz:512
[ 2298.493998] athusb: alloc resources lpipe:6 hpipe:0xC0418B80 urbs:32
[ 2298.493999] RX Bulk Ep:0x84 maxpktsz:512
[ 2298.494004] athusb: alloc resources lpipe:7 hpipe:0xC0420B80 urbs:32
[ 2298.494004] TX Bulk Ep:0x01 maxpktsz:512
[ 2298.494009] athusb: alloc resources lpipe:0 hpipe:0xC0008B00 urbs:32
[ 2298.494009] TX Bulk Ep:0x02 maxpktsz:512
[ 2298.494016] athusb: alloc resources lpipe:1 hpipe:0xC0010B00 urbs:32
[ 2298.494016] TX Bulk Ep:0x03 maxpktsz:512
[ 2298.494021] athusb: alloc resources lpipe:2 hpipe:0xC0018B00 urbs:32
[ 2298.494022] TX Bulk Ep:0x04 maxpktsz:512
[ 2298.494028] athusb: alloc resources lpipe:3 hpipe:0xC0020B00 urbs:32
[ 2298.494800] R0: wlan: [13100:I :VOS] VosWDThread: Watchdog Thread 13100 (VosWDThread) starting up
[ 2298.494829] R0: wlan: [13098:I :VOS] Initializing the VOSS timer module
[ 2298.495475] R0: wlan: [13101:I :VOS] VosMCThread: MC Thread 13101 (VosMCThread) starting up
[ 2298.495636] usb_hif_submit_ctrl_out failed,result = -71
[ 2298.495637] Unable to get target information from the device
[ 2298.495638] R0: wlan: [13098:F :VOS] vos_open: BMI failed to download target
[ 2298.495648] R0: wlan: [13101:I :VOS] VosMCThread: MC thread signaled to shutdown
[ 2298.495707] R0: wlan: [13098:I :VOS] Flushing the MC Thread message queue
[ 2298.495920] R0: wlan: [13098:F :HDD] hdd_wlan_startup: vos_open failed
[ 2298.495924] R0: wlan: [13100:I :VOS] VosWDThread: Watchdog thread signaled to shutdown
[ 2298.495925] R0: wlan: [13100:I :VOS] VosWDThread: Watchdog Thread exiting !!!!
[ 2298.496071] usb_hif_submit_ctrl_out failed,result = -71
[ 2298.496076] hif_usb: probe of 1-4.1:1.0 failed with error -5
[ 2298.496093] usbcore: registered new interface driver hif_usb
[ 2301.553633] R0: wlan: [13098:E :HDD] hdd_hif_register_driver: 18362: HIF registration failed
[ 2301.553639] R0: wlan: [13098:F :HDD] hdd_driver_init: WLAN Driver Initialization failed
[ 2301.553640] Try to unregister hif_driver
[ 2301.553643] usbcore: deregistering interface driver hif_usb
[ 2301.553703] hif_unregister_driver!!!!!!

relevant OS info:

lab@ubnt-ap01:~/qcacld-2.0$ uname -a
Linux ubnt-ap01 5.4.0-139-generic #156-Ubuntu SMP Fri Jan 20 17:27:18 UTC 2023 x86_64 x86_64 x86_64 GNU/Linux
lab@ubnt-ap01:~/qcacld-2.0$ lsb_release -a
No LSB modules are available.
Distributor ID: Ubuntu
Description:    Ubuntu 20.04.5 LTS
Release:    20.04
Codename:   focal
valinskas commented 1 year ago

Even if i tried compiling and running driver from origin/linux-5.4.y/CNSS.LEA.NRT_3.0 branch i still can't get it working:

[ 2792.385244] BCDDevice : 300
[ 2792.385245] RX Bulk Ep:0x81 maxpktsz:512
[ 2792.385251] athusb: alloc resources lpipe:4 hpipe:0xC0408B80 urbs:32
[ 2792.385252] RX Bulk Ep:0x82 maxpktsz:512
[ 2792.385257] athusb: alloc resources lpipe:5 hpipe:0xC0410B80 urbs:32
[ 2792.385258] RX Bulk Ep:0x83 maxpktsz:512
[ 2792.385262] athusb: alloc resources lpipe:6 hpipe:0xC0418B80 urbs:32
[ 2792.385263] RX Bulk Ep:0x84 maxpktsz:512
[ 2792.385267] athusb: alloc resources lpipe:7 hpipe:0xC0420B80 urbs:32
[ 2792.385268] TX Bulk Ep:0x01 maxpktsz:512
[ 2792.385272] athusb: alloc resources lpipe:0 hpipe:0xC0008B00 urbs:32
[ 2792.385273] TX Bulk Ep:0x02 maxpktsz:512
[ 2792.385279] athusb: alloc resources lpipe:1 hpipe:0xC0010B00 urbs:32
[ 2792.385279] TX Bulk Ep:0x03 maxpktsz:512
[ 2792.385283] athusb: alloc resources lpipe:2 hpipe:0xC0018B00 urbs:32
[ 2792.385284] TX Bulk Ep:0x04 maxpktsz:512
[ 2792.385289] athusb: alloc resources lpipe:3 hpipe:0xC0020B00 urbs:32
[ 2792.385293] /proc/cld/athdiagpfs created
[ 2792.385755] wlan: [22584:E :HDD] wlan_hdd_cfg80211_init: wiphy->bands[i] is NULL, i = 2
[ 2792.386944] usb_hif_submit_ctrl_out failed,result = -71
[ 2792.386945] Unable to get target information from the device
[ 2792.386946] wlan: [22584:F :VOS] vos_open: BMI failed to download target
[ 2792.387275] wlan: [22584:F :HDD] hdd_wlan_startup: vos_open failed
[ 2792.387287] /proc/cld/athdiagpfs removed
[ 2792.387288] /proc/cld removed
[ 2792.387348] usb_hif_submit_ctrl_out failed,result = -71
[ 2792.387353] hif_usb: probe of 1-4.1:1.0 failed with error -5
[ 2792.387375] usbcore: registered new interface driver hif_usb
[ 2794.425650] wlan: [22584:F :HDD] hdd_driver_init: WLAN Driver Initialization failed
[ 2794.425655] Try to unregister hif_driver
[ 2794.425657] usbcore: deregistering interface driver hif_usb
[ 2794.425710] hif_unregister_driver!!!!!!
[ 2794.425713] wlan_usb: driver load failure

Some URB requests are failing.

valinskas commented 1 year ago

Funny enough, i took 9337 and moved from one usb port to another, and it worked (3.0 version).

[ 3128.877827] BCDDevice : 300
[ 3128.877829] RX Bulk Ep:0x81 maxpktsz:512
[ 3128.877840] athusb: alloc resources lpipe:4 hpipe:0xC0408D80 urbs:32
[ 3128.877841] RX Bulk Ep:0x82 maxpktsz:512
[ 3128.877861] athusb: alloc resources lpipe:5 hpipe:0xC0410D80 urbs:32
[ 3128.877862] RX Bulk Ep:0x83 maxpktsz:512
[ 3128.877868] athusb: alloc resources lpipe:6 hpipe:0xC0418D80 urbs:32
[ 3128.877868] RX Bulk Ep:0x84 maxpktsz:512
[ 3128.877873] athusb: alloc resources lpipe:7 hpipe:0xC0420D80 urbs:32
[ 3128.877873] TX Bulk Ep:0x01 maxpktsz:512
[ 3128.877886] athusb: alloc resources lpipe:0 hpipe:0xC0008D00 urbs:32
[ 3128.877887] TX Bulk Ep:0x02 maxpktsz:512
[ 3128.877891] athusb: alloc resources lpipe:1 hpipe:0xC0010D00 urbs:32
[ 3128.877892] TX Bulk Ep:0x03 maxpktsz:512
[ 3128.877897] athusb: alloc resources lpipe:2 hpipe:0xC0018D00 urbs:32
[ 3128.877897] TX Bulk Ep:0x04 maxpktsz:512
[ 3128.877902] athusb: alloc resources lpipe:3 hpipe:0xC0020D00 urbs:32
[ 3128.877905] /proc/cld/athdiagpfs created
[ 3128.878330] wlan: [22785:E :HDD] wlan_hdd_cfg80211_init: wiphy->bands[i] is NULL, i = 2
[ 3128.879715] NUM_DEV=1 FWMODE=0x2 FWSUBMODE=0x0 FWBR_BUF 0
[ 3128.880196] Board extended Data download address: 0x0
[ 3128.890726] wlan: [22785:E :VOS] ol_transfer_bin_file: transferring file: fakeboar.bin size 8124 bytes done!
[ 3128.890893] ol_download_firmware: Using 0x1234 for the remainder of init
[ 3128.921481] wlan: [22785:E :VOS] ol_transfer_bin_file: transferring file: otp.bin size 24037 bytes done!
[ 3128.922044] ol_transfer_bin_file: Loading setup file athsetup.bin
[ 3128.922093] usb 1-5.1: Direct firmware load for athsetup.bin failed with error -2
[ 3128.922097] ol_transfer_bin_file: Failed to get athsetup.bin
[ 3129.681126] wlan: [22785:E :VOS] ol_transfer_bin_file: transferring file: athwlan.bin size 591880 bytes done!
[ 3129.681687] +HTCCreate ..  HIF :00000000ff1331aa
[ 3129.681703] -HTCCreate (0x000000007a2e5fc1)
[ 3129.681822] WDA_open-4688: WMA --> wmi_unified_attach - success
[ 3129.681838] ol_if_dfs_attach: called; ptr=00000000363552a0, radar_info=000000001f41c120
[ 3129.682029] wlan: [22785:E :SAP] dfs_init_radar_filters[201]: Unknown dfs domain 0
[ 3129.682054] +HWT
[ 3129.686660] Target Ready! : transmit resources : 3 size:1792, MaxMsgsPerHTCBundle = 8
[ 3129.686664] HTC Service Index : 1 TX : 0x100 : alloc:3
[ 3129.686668] HTC Service:0x0001, ULpipe:0 DLpipe:5 id:0 Ready
[ 3129.686669] -HWT
[ 3129.686753] is_full_reorder_offloaded? 0
[ 3129.686756] HTC Service TX : 0x300 : allocation is zero!
[ 3129.686942] HTC Service:0x0300, ULpipe:1 DLpipe:5 id:1 Ready
[ 3129.686945] HTC Service:0x0300 ep:1 TX flow control disabled
[ 3129.686948] HTC Service TX : 0x301 : allocation is zero!
[ 3129.687072]  Target failed service 0x301 connect request (status:1)
[ 3129.687076] TX HTT OFF, ep -1 size 0
[ 3129.687104] htt_tx_attach:htt_desc_start:0x00000000c365a331 htt_desc_end:0x0000000074e8e384
[ 3129.687554] HTC Service:0x0100, ULpipe:0 DLpipe:5 id:2 Ready
[ 3129.687557] HTC Service:0x0100 ep:2 TX flow control disabled
[ 3129.687560] wma_pre_start-5056: WMA --> wmi_unified_connect_htc_service - success
[ 3129.687613] wma_mc_process_msg-21967: McThread: WNI_CFG_DNLD_REQ
[ 3129.687817] HTC will not use TX credit flow control
[ 3129.688371] __wmi_control_rx: WMI UNIFIED SERVICE READY event
[ 3129.688376] wma_rx_service_ready_event-24799: WMA <-- WMI_SERVICE_READY_EVENTID
[ 3129.688381] wlan: [12914:E :WDA] wma_rx_service_ready_event: Firmware build version : 00000029
[ 3129.688388] wlan: [12914:E :WDA] wma_rx_service_ready_event: Board version: 0.21014003
[ 3129.688395] wma_rx_service_ready_event-24914: WMA --> WMI_INIT_CMDID
[ 3129.695071] __wmi_control_rx:  WMI UNIFIED READY event
[ 3129.695076] wma_rx_ready_event-24943: WMA <-- WMI_READY_EVENTID
[ 3129.695497] wlan: [22785:E :VOS] error: wiphy->bands is NULL, i = 2
[ 3129.695507] wlan: [22785:F :HDD] pAdapter is null !!
[ 3129.695746] wlan: [22785:E :SME] csr_init_chan_list: 326: init time country code 00
[ 3129.696007] usb 1-5.1: Direct firmware load for wlan/wlan_mac.bin failed with error -2
[ 3129.696018] wlan: [22785:E :WDA] MCC TX Pause Event Handler register
[ 3129.696024] wlan: [22785:E :WDA] Target does not support batch scan feature
[ 3129.696234] session id - 0, AddSta session - 0
[ 3129.696288] Enter:usb_hif_start_recv_pipes,Line:958
[ 3129.696291] Post URBs to RX_DATA_PIPE: 32
[ 3129.696544] Exit:usb_hif_start_recv_pipes,Line:994
[ 3129.699097] wlan: [22787:E :WDA] wma_unified_vdev_create_send: ID = 0 VAP Addr = c4:93:00:27:4f:6e
[ 3129.699112] wma_vdev_attach-5904: vdev_id 0, txrx_vdev_handle = 00000000fcd7edbb
[ 3129.699183] wlan: [22787:E :SME] No Pending command waiting
[ 3129.700220] wlan: [22785:E :HDD] wlan_hdd_tdls_init TDLS Implicit trigger not enabled!
[ 3129.700790] wlan: [22785:E :HDD] wlan_hdd_validate_context: Unloading/Loading in Progress. Ignore!!!
[ 3129.700797] wlan: [22785:E :HDD] wlan_hdd_cfg80211_get_txpower: HDD context is not valid
[ 3129.700938] session id - 1, AddSta session - 0
[ 3129.701126] wlan: [22787:E :WDA] Invalid wda_cli_set pdev command/Not yet implemented 0x34
[ 3129.701132] wlan: [22787:E :WDA] wma_unified_vdev_create_send: ID = 1 VAP Addr = c6:93:00:aa:4f:6e
[ 3129.701135] wma_vdev_attach-5904: vdev_id 1, txrx_vdev_handle = 00000000698c7cd8
[ 3129.701136] wma_vdev_attach-5969: P2P Device: creating self peer c6:93:00:aa:4f:6e, vdev_id 1
[ 3129.701140] wlan: [22787:E :WDA] wma_create_peer: Created peer with peer_addr c6:93:00:aa:4f:6e vdev_id 1, peer_count - 1
[ 3129.701154] wlan: [22787:E :SME] No Pending command waiting
[ 3129.701279] wlan: [22785:E :HDD] wlan_hdd_validate_context: Unloading/Loading in Progress. Ignore!!!
[ 3129.701281] wlan: [22785:E :HDD] wlan_hdd_cfg80211_get_txpower: HDD context is not valid
[ 3129.701356] wlan: [22787:E :WDA] Invalid wda_cli_set pdev command/Not yet implemented 0x34
[ 3129.701629] target uses HTT version 3.27; host uses 3.23
[ 3129.701630] *** Warning: host/target HTT versions are different, though compatible!
[ 3129.706396] TXRX: ol_txrx_peer_find_add_id: Delete Peer 00000000a4a44d9f
[ 3129.706601] Host SW:4.5.20.037, FW:0.0.0.41, HW:QCA9377_REV1_1
[ 3129.706621] wlan_logging_sock_activate_svc: Initalizing FEConsoleLog = 0 NumBuff = 32
[ 3129.708973] wlan_logging_sock_activate_svc: Activated wlan_logging svc
[ 3129.709006] wlan: [22785:E :HDD] hdd_wlan_startup: 12534: set tsf GPIO failed
[ 3129.709009] wlan: [22787:E :WDA] TM sending the following to firmware: min 0 max 110 enable 1
[ 3129.709012] wlan: [22787:E :WDA] TM Sending thermal mgmt cmd: low temp 0, upper temp 110, enabled 1
[ 3129.709052] usbcore: registered new interface driver hif_usb
[ 3129.709052] wlan_usb: driver loaded
[ 3129.709927] usb 1-5.1 wlxc69300aa4f6e: renamed from p2p0
lab@ubnt-ap01:~/qcacld-2.0$ [ 3129.726366] wlan: [22817:E :HDD] wlan_hdd_get_classAstats: Unable to retrieve Class A statistics
[ 3129.726527] wlan: [22817:E :HDD] wlan_hdd_get_classAstats: Unable to retrieve Class A statistics
[ 3129.726827] wlan: [784:E :HDD] wlan_hdd_get_classAstats: Unable to retrieve Class A statistics
[ 3129.727541] wlan: [784:E :HDD] wlan_hdd_get_classAstats: Unable to retrieve Class A statistics
[ 3129.727793] usb 1-5.1 wlxc49300274f6e: renamed from wlan0
[ 3129.745215] wlan: [22824:E :HDD] wlan_hdd_get_classAstats: Unable to retrieve Class A statistics
[ 3129.745931] wlan: [22824:E :HDD] wlan_hdd_get_classAstats: Unable to retrieve Class A statistics
[ 3129.759996] wlan: [22833:E :HDD] wlan_hdd_get_classAstats: Unable to retrieve Class A statistics
[ 3129.760323] wlan: [22833:E :HDD] wlan_hdd_get_classAstats: Unable to retrieve Class A statistics
[ 3129.776184] wlan: [784:E :SME] PmcOffloadEnableStaModePowerSave: 3819: Failed to Queue Sta Mode Ps Request
[ 3129.776265] wlan: [784:E :HDD] wlan_hdd_get_classAstats: Unable to retrieve Class A statistics
[ 3129.780536] wlan: [340:E :HDD] wlan_hdd_get_classAstats: Unable to retrieve Class A statistics
[ 3129.791856] wlan: [813:E :HDD] wlan_hdd_get_classAstats: Unable to retrieve Class A statistics
[ 3129.791884] wlan: [813:E :HDD] wlan_hdd_get_classAstats: Unable to retrieve Class A statistics
[ 3129.792127] wlan: [813:E :HDD] wlan_hdd_get_classAstats: Unable to retrieve Class A statistics
[ 3129.792153] wlan: [813:E :HDD] wlan_hdd_get_classAstats: Unable to retrieve Class A statistics
[ 3129.792471] wlan: [813:E :HDD] wlan_hdd_get_classAstats: Unable to retrieve Class A statistics
[ 3129.798406] wlan: [340:E :HDD] wlan_hdd_get_classAstats: Unable to retrieve Class A statistics
[ 3129.852838] wlan: [813:E :HDD] received scan request
[ 3129.852859] wlan: [813:E :SME] No Pending command waiting
[ 3129.852930] wlan: [22787:E :WDA] scan_id a001, vdev_id 0, scan type 0, msg_type 1103
[ 3133.332921] wlan: [12914:E :WDA]  scan complete - scan_id a001, vdev_id 0
[ 3133.333150] wlan: [22787:E :SME] No Pending command waiting
[ 3133.333266] wlan: [22787:E :SME] Found 20 BSS
[ 3133.333805] wlan: [22787:E :SME] No Pending command waiting
[ 3133.333817] wlan: [22787:E :SME] No Pending command waiting
[ 3133.334074] wlan: [22787:E :SME] PmcOffloadEnableStaModePowerSave: 3832: sta mode power save already enabled
[ 3133.334081] wlan: [22787:E :SME] No Pending command waiting
valinskas commented 1 year ago

driver built from linux-5.4.y/CNSS.LEA.NRT_3.1

lab@ubnt-ap01:~/qcacld-2.0$ sudo insmod ./wlan.ko
[ 3914.711192] wlan: loading driver v4.5.25.50
[ 3914.711245] hif_usb_probe
[ 3914.712071] Enter:hif_usb_disable_lpm,Line:242
[ 3914.712071] hif_usb_disable_lpm: LPM isn't enabled
[ 3914.712072] Exit:hif_usb_disable_lpm,Line:269
[ 3914.712072] BCDDevice : 300
[ 3914.712074] RX Bulk Ep:0x81 maxpktsz:512
[ 3914.712081] athusb: alloc resources lpipe:4 hpipe:0xC0409180 urbs:32
[ 3914.712081] RX Bulk Ep:0x82 maxpktsz:512
[ 3914.712088] athusb: alloc resources lpipe:5 hpipe:0xC0411180 urbs:32
[ 3914.712089] RX Bulk Ep:0x83 maxpktsz:512
[ 3914.712097] athusb: alloc resources lpipe:6 hpipe:0xC0419180 urbs:32
[ 3914.712097] RX Bulk Ep:0x84 maxpktsz:512
[ 3914.712106] athusb: alloc resources lpipe:7 hpipe:0xC0421180 urbs:32
[ 3914.712106] TX Bulk Ep:0x01 maxpktsz:512
[ 3914.712112] athusb: alloc resources lpipe:0 hpipe:0xC0009100 urbs:32
[ 3914.712113] TX Bulk Ep:0x02 maxpktsz:512
[ 3914.712118] athusb: alloc resources lpipe:1 hpipe:0xC0011100 urbs:32
[ 3914.712119] TX Bulk Ep:0x03 maxpktsz:512
[ 3914.712123] athusb: alloc resources lpipe:2 hpipe:0xC0019100 urbs:32
[ 3914.712123] TX Bulk Ep:0x04 maxpktsz:512
[ 3914.712128] athusb: alloc resources lpipe:3 hpipe:0xC0021100 urbs:32
[ 3914.746955] ol_download_firmware: chip_id:0x5020001 board_id:0x0
[ 3914.747411] Board extended Data download address: 0x0
[ 3914.757921] __ol_transfer_bin_file: Loading setup file athsetup.bin
[ 3914.757935] usb 1-5.1: Direct firmware load for athsetup.bin failed with error -2
[ 3914.757936] __ol_transfer_bin_file: Failed to get athsetup.bin:-2
[ 3915.059326] R0: wlan: [27783:E :SAP] dfs_init_radar_filters[217]: Unknown dfs domain 0
[ 3915.066992] Target Ready! : transmit resources : 3 size:1792, MaxMsgsPerHTCBundle = 8
[ 3915.067247]  Target failed service 0x301 connect request (status:1)
[ 3915.067248] TX HTT OFF, ep -1 size 0
[ 3915.080516] Enter:usb_hif_start_recv_pipes,Line:954
[ 3915.080517] Post URBs to RX_DATA_PIPE: 32
[ 3915.080608] Exit:usb_hif_start_recv_pipes,Line:990
[ 3915.080619] R0: wlan: [22716:I :HDD] hdd_update_tgt_cfg: 9508: hw update mac addr
[ 3915.080630] R0: wlan: [22716:I :HDD] enable2x2 0
[ 3915.080631] R0: wlan: [22716:I :HDD] hdd_update_tgt_cfg: 9542: Current antenna mode: 1
[ 3915.080633] R0: wlan: [22716:I :HDD] hdd_update_tgt_cfg: 9546: fine_time_measurement_cap: 0xd
[ 3915.080634] R0: wlan: [22716:I :HDD] hdd_update_tgt_cfg: 9549: Target BPF 0 Host BPF 1
[ 3915.080636] R0: wlan: [22716:I :HDD] hdd_nan_datapath_target_config: 104: enable_nan_datapath: 0
[ 3915.080678] R0: wlan: [27783:I :HDD] wlan_hdd_set_wow_pulse: 16511: wow pulse enable flag is 1
[ 3915.080687] R0: wlan: [27783:I :HDD] hdd_set_fine_time_meas_cap: 7289: fine time meas capability - INI: 000d Enabled: 000d
[ 3915.080719] R0: wlan: [27783:I :HDD] Enter:wlan_hdd_cfg80211_register
[ 3915.080818] R0: wlan: [27783:I :HDD] Enter:vos_update_band
[ 3915.080821] R0: wlan: [27783:F :HDD] pAdapter is null !!
[ 3915.080892] R0: wlan: [27783:I :HDD] Exit:wlan_hdd_cfg80211_register
[ 3915.081555] R0: wlan: [27783:I :HDD] hdd_cnss_wlan_mac: 16768: Platform Driver Doesn't have wlan mac addresses
[ 3915.081575] usb 1-5.1: Direct firmware load for wlan/wlan_mac.bin failed with error -2
[ 3915.081579] R0: wlan: [27783:I :HDD] hw update mac addr[0] from 00:0a:f5:89:89:80 to c4:93:00:27:4f:6e
[ 3915.081581] R0: wlan: [27783:I :HDD] hw update mac addr[1] from 00:0a:f5:89:89:81
[ 3915.081583] R0: wlan: [27783:I :HDD]  to c6:93:00:aa:4f:6e
[ 3915.081585] R0: wlan: [27783:I :HDD] cfg_ini->intfMacAddr[1]: c6:93:00:aa:4f:6e
[ 3915.081586] R0: wlan: [27783:I :HDD] hw update mac addr[2] from 00:0a:f5:89:89:82
[ 3915.081588] R0: wlan: [27783:I :HDD]  to c6:93:00:ab:4f:6e
[ 3915.081590] R0: wlan: [27783:I :HDD] cfg_ini->intfMacAddr[2]: c6:93:00:ab:4f:6e
[ 3915.081591] R0: wlan: [27783:I :HDD] hw update mac addr[3] from 00:0a:f5:89:89:83
[ 3915.081593] R0: wlan: [27783:I :HDD]  to c6:93:00:ac:4f:6e
[ 3915.081594] R0: wlan: [27783:I :HDD] cfg_ini->intfMacAddr[3]: c6:93:00:ac:4f:6e
[ 3915.081596] R0: wlan: [27783:I :HDD] hdd_initialize_mac_address: 16837: wlan_mac.bin update mac addr
[ 3915.082219] target uses HTT version 3.60; host uses 3.28
[ 3915.082220] *** Warning: host/target HTT versions are different, though compatible!
[ 3915.082320] R0: wlan: [27786:I :HDD] hdd_smeRoamCallback: 4683: session 0 opened
[ 3915.082325] R0: wlan: [27783:I :HDD] Enter:hdd_register_wext
[ 3915.082326] R0: wlan: [27783:I :HDD] Enter:hdd_set_wext
[ 3915.082327] R0: wlan: [27783:I :HDD] Enter:hdd_clearRoamProfileIe
[ 3915.082329] R0: wlan: [27783:I :HDD] Exit:hdd_clearRoamProfileIe
[ 3915.082330] R0: wlan: [27783:I :HDD] Exit:hdd_set_wext
[ 3915.082331] R0: wlan: [27783:I :HDD] Exit:hdd_register_wext
[ 3915.082407] R0: wlan: [27783:I :HDD] hdd_connSetConnectionState: 227: hdd_init_station_mode+0x10d/0x370 [wlan] Changed connectionState from oldState:0 to State:0
[ 3915.082464] R0: wlan: [12833:I :HDD] wlan_hdd_validate_context: 1323: wlan_hdd_roc_request_dequeue+0x30/0x1a0 [wlan] loading: 1 unloading:0 in Progress. Ignore!!!
[ 3915.086779] R0: wlan: [27783:I :HDD] Enter:__wlan_hdd_cfg80211_get_txpower
[ 3915.086877] R0: wlan: [27783:I :HDD] wlan_hdd_validate_context: 1323: wlan_hdd_cfg80211_get_txpower+0x57/0x140 [wlan] loading: 1 unloading:0 in Progress. Ignore!!!
[ 3915.086913] R0: wlan: [27783:I :HDD] hdd_open_adapter: 12200: Disabling queues
[ 3915.086914] R0: wlan: [27783:I :HDD] wlan_hdd_netif_queue_control: 1749: action is 7 reason is 1
[ 3915.086925] R0: wlan: [27783:I :HDD] wlan_hdd_set_concurrency_mode: 19094: concurrency_mode = 0x1, Number of open sessions for mode 0 = 1
[ 3915.086927] R0: wlan: [27783:I :HDD] hdd_get_concurrency_mode: concurrency_mode = 0x1
[ 3915.086952] R0: wlan: [27783:I :HDD] hdd_open_adapter: 12498: SET AMSDU num 1
[ 3915.087027] DEBUGFS PEER MAC = 0xc6:0x93:0x0:0xaa:0x4f:0x6e
[ 3915.087091] R0: wlan: [27786:I :HDD] hdd_smeRoamCallback: 4683: session 1 opened
[ 3915.087095] R0: wlan: [27783:I :HDD] Enter:hdd_register_wext
[ 3915.087097] R0: wlan: [27783:I :HDD] Enter:hdd_set_wext
[ 3915.087097] R0: wlan: [27783:I :HDD] Enter:hdd_clearRoamProfileIe
[ 3915.087098] R0: wlan: [27783:I :HDD] Exit:hdd_clearRoamProfileIe
[ 3915.087099] R0: wlan: [27783:I :HDD] Exit:hdd_set_wext
[ 3915.087100] R0: wlan: [27783:I :HDD] Exit:hdd_register_wext
[ 3915.087157] R0: wlan: [27783:I :HDD] hdd_connSetConnectionState: 227: hdd_init_station_mode+0x10d/0x370 [wlan] Changed connectionState from oldState:0 to State:0
[ 3915.087196] R0: wlan: [27569:I :HDD] wlan_hdd_validate_context: 1323: wlan_hdd_roc_request_dequeue+0x30/0x1a0 [wlan] loading: 1 unloading:0 in Progress. Ignore!!!
[ 3915.087325] R0: wlan: [27783:I :HDD] Enter:__wlan_hdd_cfg80211_get_txpower
[ 3915.087359] R0: wlan: [27783:I :HDD] wlan_hdd_validate_context: 1323: wlan_hdd_cfg80211_get_txpower+0x57/0x140 [wlan] loading: 1 unloading:0 in Progress. Ignore!!!
[ 3915.087386] R0: wlan: [27783:I :HDD] hdd_open_adapter: 12200: Disabling queues
[ 3915.087387] R0: wlan: [27783:I :HDD] wlan_hdd_netif_queue_control: 1749: action is 7 reason is 1
[ 3915.087391] R0: wlan: [27783:I :HDD] wlan_hdd_set_concurrency_mode: 19094: concurrency_mode = 0x1, Number of open sessions for mode 7 = 0
[ 3915.087392] R0: wlan: [27783:I :HDD] hdd_get_concurrency_mode: concurrency_mode = 0x1
[ 3915.087395] R0: wlan: [27783:I :HDD] hdd_open_adapter: 12498: SET AMSDU num 1
[ 3915.088870] Host SW:4.5.25.50, FW:0.0.0.111, HW:QCA93x7_REV1_1
[ 3915.088891] R0: wlan: [27783:I :HDD] hddDevTmRegisterNotifyCallback: Register TM Handler
[ 3915.088896] R0: wlan: [27783:I :HDD] Enter:wlan_hdd_cfg80211_register_frames
[ 3915.088915] R0: wlan: [27783:I :HDD] __hdd_netdev_notifier_call: wlan0 New Net Device State = 5
[ 3915.088917] R0: wlan: [27783:I :HDD] __hdd_netdev_notifier_call: p2p0 New Net Device State = 5
[ 3915.088959] R0: wlan: [27783:I :HDD] hdd_set_idle_ps_config: Enter Val 1 pconfig ffff908aae972000
[ 3915.088968] R0: wlan: [27783:I :HDD] hdd_wlan_register_ip6_notifier: 14702: Registered IPv6 notifier
[ 3915.088970] R0: wlan: [27783:I :HDD] hdd_wlan_startup: 18117: Registered IPv4 notifier
lab@ubnt-ap01:~/qcacld-2.0$ [ 3915.088979] ENTER sme_set_btc_coex_dutycycle = 30
[ 3915.088980] ENTER sme_set_btc_coex_dutycycle =30
[ 3915.088983] R0: wlan: [27783:I :HDD] vos_thread_stuck_timer_init: 1081: Successfully started thread stuck timer
[ 3915.088986] R0: wlan: [27783:I :HDD] Exit:hdd_wlan_startup
[ 3915.089008] usbcore: registered new interface driver hif_usb
[ 3915.089009] wlan: driver loaded in 376000
[ 3915.089690] R0: wlan: [784:I :HDD] Enter:__wlan_hdd_cfg80211_get_txpower
[ 3915.089695] R0: wlan: [784:I :HDD] Exit:__wlan_hdd_cfg80211_get_txpower
[ 3915.090173] usb 1-5.1 wlxc49300274f6e: renamed from wlan0
[ 3915.122057] R0: wlan: [784:I :HDD] Enter:__wlan_hdd_cfg80211_get_txpower
[ 3915.122065] R0: wlan: [784:I :HDD] Exit:__wlan_hdd_cfg80211_get_txpower
[ 3915.122766] R0: wlan: [27790:I :HDD] Enter:__wlan_hdd_cfg80211_get_txpower
[ 3915.122771] R0: wlan: [27790:I :HDD] Exit:__wlan_hdd_cfg80211_get_txpower
[ 3915.122789] R0: wlan: [27790:I :HDD] Enter:__wlan_hdd_cfg80211_get_station
[ 3915.122791] R0: wlan: [27790:I :HDD] __wlan_hdd_cfg80211_get_station: Not associated
[ 3915.122976] R0: wlan: [27790:I :HDD] Enter:__wlan_hdd_cfg80211_get_txpower
[ 3915.122979] R0: wlan: [27790:I :HDD] Exit:__wlan_hdd_cfg80211_get_txpower
[ 3915.122992] R0: wlan: [27790:I :HDD] Enter:__wlan_hdd_cfg80211_get_station
[ 3915.122993] R0: wlan: [27790:I :HDD] __wlan_hdd_cfg80211_get_station: Not associated
[ 3915.124715] usb 1-5.1 wlxc69300aa4f6e: renamed from p2p0
[ 3915.138741] R0: wlan: [27795:I :HDD] Enter:__wlan_hdd_cfg80211_get_txpower
[ 3915.138748] R0: wlan: [27795:I :HDD] Exit:__wlan_hdd_cfg80211_get_txpower
[ 3915.138766] R0: wlan: [27795:I :HDD] Enter:__wlan_hdd_cfg80211_get_station
[ 3915.138768] R0: wlan: [27795:I :HDD] __wlan_hdd_cfg80211_get_station: Not associated
[ 3915.138952] R0: wlan: [27795:I :HDD] Enter:__wlan_hdd_cfg80211_get_txpower
[ 3915.138955] R0: wlan: [27795:I :HDD] Exit:__wlan_hdd_cfg80211_get_txpower
[ 3915.138968] R0: wlan: [27795:I :HDD] Enter:__wlan_hdd_cfg80211_get_station
[ 3915.138969] R0: wlan: [27795:I :HDD] __wlan_hdd_cfg80211_get_station: Not associated
[ 3915.145125] R0: wlan: [27805:I :HDD] Enter:__wlan_hdd_cfg80211_get_txpower
[ 3915.145131] R0: wlan: [27805:I :HDD] Exit:__wlan_hdd_cfg80211_get_txpower
[ 3915.145149] R0: wlan: [27805:I :HDD] Enter:__wlan_hdd_cfg80211_get_station
[ 3915.145150] R0: wlan: [27805:I :HDD] __wlan_hdd_cfg80211_get_station: Not associated
[ 3915.145348] R0: wlan: [27805:I :HDD] Enter:__wlan_hdd_cfg80211_get_txpower
[ 3915.145351] R0: wlan: [27805:I :HDD] Exit:__wlan_hdd_cfg80211_get_txpower
[ 3915.145365] R0: wlan: [27805:I :HDD] Enter:__wlan_hdd_cfg80211_get_station
[ 3915.145366] R0: wlan: [27805:I :HDD] __wlan_hdd_cfg80211_get_station: Not associated
[ 3915.153989] R0: wlan: [0:I :HDD] Enter:__hdd_set_multicast_list
[ 3915.154065] R0: wlan: [0:I :HDD] Enter:__hdd_set_multicast_list
[ 3915.154069] R0: wlan: [784:I :HDD] Enter:__wlan_hdd_cfg80211_set_power_mgmt
[ 3915.154078] R0: wlan: [784:I :HDD] Exit:__wlan_hdd_cfg80211_set_power_mgmt
[ 3915.154157] R0: wlan: [784:I :HDD] Enter:__wlan_hdd_cfg80211_get_txpower
[ 3915.154161] R0: wlan: [784:I :HDD] Exit:__wlan_hdd_cfg80211_get_txpower
[ 3915.163152] R0: wlan: [340:I :HDD] Enter:__wlan_hdd_cfg80211_get_txpower
[ 3915.163159] R0: wlan: [340:I :HDD] Exit:__wlan_hdd_cfg80211_get_txpower
[ 3915.163175] R0: wlan: [340:I :HDD] Enter:__wlan_hdd_cfg80211_get_station
[ 3915.163176] R0: wlan: [340:I :HDD] __wlan_hdd_cfg80211_get_station: Not associated
[ 3915.164090] R0: wlan: [813:I :HDD] Enter:__wlan_hdd_cfg80211_get_txpower
[ 3915.164095] R0: wlan: [813:I :HDD] Exit:__wlan_hdd_cfg80211_get_txpower
[ 3915.164112] R0: wlan: [813:I :HDD] Enter:__wlan_hdd_cfg80211_get_txpower
[ 3915.164114] R0: wlan: [813:I :HDD] Exit:__wlan_hdd_cfg80211_get_txpower
[ 3915.164243] R0: wlan: [813:I :HDD] Enter:__is_driver_dfs_capable
[ 3915.164265] R0: wlan: [813:I :HDD] Enter:__wlan_hdd_cfg80211_get_txpower
[ 3915.164268] R0: wlan: [813:I :HDD] Exit:__wlan_hdd_cfg80211_get_txpower
[ 3915.164279] R0: wlan: [813:I :HDD] Enter:__wlan_hdd_cfg80211_get_txpower
[ 3915.164281] R0: wlan: [813:I :HDD] Exit:__wlan_hdd_cfg80211_get_txpower
[ 3915.164566] R0: wlan: [813:I :HDD] Enter:__wlan_hdd_cfg80211_get_txpower
[ 3915.164568] R0: wlan: [813:I :HDD] Exit:__wlan_hdd_cfg80211_get_txpower
[ 3915.166411] R0: wlan: [784:I :HDD] __hdd_open: 9777: chip already out of standby
[ 3915.166414] R0: wlan: [0:I :HDD] Enter:__hdd_set_multicast_list
[ 3915.166476] R0: wlan: [0:I :HDD] Enter:__hdd_set_multicast_list
[ 3915.166480] R0: wlan: [784:I :HDD] Enter:__wlan_hdd_cfg80211_set_power_mgmt
[ 3915.166489] R0: wlan: [784:I :HDD] Exit:__wlan_hdd_cfg80211_set_power_mgmt
[ 3915.166563] R0: wlan: [784:I :HDD] Enter:__wlan_hdd_cfg80211_get_txpower
[ 3915.166568] R0: wlan: [784:I :HDD] Exit:__wlan_hdd_cfg80211_get_txpower
[ 3915.173663] R0: wlan: [340:I :HDD] Enter:__wlan_hdd_cfg80211_get_txpower
[ 3915.173670] R0: wlan: [340:I :HDD] Exit:__wlan_hdd_cfg80211_get_txpower
[ 3915.173688] R0: wlan: [340:I :HDD] Enter:__wlan_hdd_cfg80211_get_station
[ 3915.173689] R0: wlan: [340:I :HDD] __wlan_hdd_cfg80211_get_station: Not associated
[ 3915.182056] R0: wlan: [813:I :HDD] Enter:__wlan_hdd_cfg80211_flush_pmksa
[ 3915.182059] R0: wlan: [813:I :HDD] Exit:__wlan_hdd_cfg80211_flush_pmksa
[ 3915.203924] R0: wlan: [813:I :HDD] Enter:__wlan_hdd_cfg80211_get_txpower
[ 3915.203942] R0: wlan: [813:I :HDD] Exit:__wlan_hdd_cfg80211_get_txpower
[ 3915.204007] R0: wlan: [813:I :HDD] Enter:__wlan_hdd_cfg80211_get_txpower
[ 3915.204017] R0: wlan: [813:I :HDD] Exit:__wlan_hdd_cfg80211_get_txpower
[ 3915.204493] R0: wlan: [813:I :HDD] Enter:__is_driver_dfs_capable
[ 3915.204585] R0: wlan: [813:I :HDD] Enter:__wlan_hdd_cfg80211_get_txpower
[ 3915.204596] R0: wlan: [813:I :HDD] Exit:__wlan_hdd_cfg80211_get_txpower
[ 3915.204641] R0: wlan: [813:I :HDD] Enter:__wlan_hdd_cfg80211_get_txpower
[ 3915.204650] R0: wlan: [813:I :HDD] Exit:__wlan_hdd_cfg80211_get_txpower
[ 3915.206246] R0: wlan: [813:I :HDD] Enter:__wlan_hdd_cfg80211_get_txpower
[ 3915.206261] R0: wlan: [813:I :HDD] Exit:__wlan_hdd_cfg80211_get_txpower
[ 3915.226214] R0: wlan: [813:I :HDD] Enter:__wlan_hdd_cfg80211_flush_pmksa
[ 3915.226227] R0: wlan: [813:I :HDD] Exit:__wlan_hdd_cfg80211_flush_pmksa
[ 3915.291612] R0: wlan: [813:I :HDD] Enter:__wlan_hdd_cfg80211_scan
[ 3915.291624] R0: wlan: [813:I :HDD] __wlan_hdd_cfg80211_scan: 22928: Device_mode WLAN_HDD_INFRA_STATION(0)
[ 3915.291631] R0: wlan: [813:I :HDD] Enter:wlan_hdd_tdls_scan_callback
[ 3915.291637] R0: wlan: [813:I :HDD] hdd_check_connection_status: 22633: Adapter with device mode WLAN_HDD_INFRA_STATION(0) exists
[ 3915.291642] R0: wlan: [813:I :HDD] hdd_check_connection_status: 22633: Adapter with device mode WLAN_HDD_P2P_DEVICE(7) exists
[ 3915.291663] R0: wlan: [813:I :HDD] No of Scan Channels: 37
[ 3915.291667] R0: wlan: [813:I :HDD] Channel-List: 1 2 3 4 5 6 7 8 9 10 11 36 40 44 48 52 56 60 64 100 104 108 112 116 120 124 128 132 136 140 144 149 153 157 161 165 173
[ 3915.291733] R0: wlan: [813:I :HDD] Exit:__wlan_hdd_cfg80211_scan
[ 3917.974013] R0: wlan: [27786:I :HDD] Enter:hdd_cfg80211_scan_done_callback
[ 3917.974024] R0: wlan: [27786:I :HDD] hdd_cfg80211_scan_done_callback called with halHandle = ffff908aaefb0000, pContext = ffff908aaf580000,scanID = 1, returned status = 0
[ 3917.974028] R0: wlan: [27786:I :HDD] Enter:wlan_hdd_cfg80211_update_bss
[ 3917.974085] R0: wlan: [27786:I :HDD] BSSID: c8:08:73:55:2d:fc Channel:56 RSSI:-45
[ 3917.974095] R0: wlan: [27786:I :HDD] BSSID: c8:08:73:15:2d:fc Channel:56 RSSI:-45
[ 3917.974103] R0: wlan: [27786:I :HDD] BSSID: c8:08:73:55:2d:f8 Channel:6 RSSI:-46
[ 3917.974110] R0: wlan: [27786:I :HDD] BSSID: c8:08:73:15:2d:f8 Channel:6 RSSI:-46
[ 3917.974118] R0: wlan: [27786:I :HDD] BSSID: 2e:76:10:0b:ee:92 Channel:5 RSSI:-50
[ 3917.974125] R0: wlan: [27786:I :HDD] BSSID: 28:76:10:0b:ee:92 Channel:5 RSSI:-50
[ 3917.974133] R0: wlan: [27786:I :HDD] BSSID: 28:76:10:16:e2:4e Channel:48 RSSI:-54
[ 3917.974141] R0: wlan: [27786:I :HDD] BSSID: 28:76:10:0c:72:22 Channel:100 RSSI:-60
[ 3917.974148] R0: wlan: [27786:I :HDD] BSSID: 32:76:10:0c:72:22 Channel:100 RSSI:-61
[ 3917.974162] R0: wlan: [27786:I :HDD] BSSID: 2e:76:10:0c:72:22 Channel:100 RSSI:-61
[ 3917.974170] R0: wlan: [27786:I :HDD] BSSID: 2e:76:10:0b:ee:96 Channel:104 RSSI:-63
[ 3917.974177] R0: wlan: [27786:I :HDD] BSSID: 28:76:10:0b:ee:96 Channel:104 RSSI:-63
[ 3917.974185] R0: wlan: [27786:I :HDD] BSSID: 2e:76:10:0c:72:23 Channel:11 RSSI:-65
[ 3917.974193] R0: wlan: [27786:I :HDD] BSSID: 28:76:10:0c:72:23 Channel:11 RSSI:-65
[ 3917.974202] R0: wlan: [27786:I :HDD] BSSID: 8c:fe:74:9c:f5:28 Channel:6 RSSI:-68
[ 3917.974210] R0: wlan: [27786:I :HDD] BSSID: 8c:fe:74:dc:f5:28 Channel:6 RSSI:-69
[ 3917.974219] R0: wlan: [27786:I :HDD] BSSID: 8c:fe:74:9c:f5:2c Channel:116 RSSI:-81
[ 3917.974227] R0: wlan: [27786:I :HDD] BSSID: 8c:fe:74:dc:f5:2c Channel:116 RSSI:-82
[ 3917.974236] R0: wlan: [27786:I :HDD] BSSID: c4:93:00:0e:fe:e0 Channel:1 RSSI:-81
[ 3917.974249] R0: wlan: [27786:I :HDD] Exit:wlan_hdd_cfg80211_update_bss
[ 3917.974266] R0: wlan: [27786:I :HDD] Exit:hdd_cfg80211_scan_done_callback
[ 3917.974782] R0: wlan: [813:I :HDD] Enter:__wlan_hdd_cfg80211_dump_survey
[ 3917.974788] R0: wlan: [813:I :HDD] __wlan_hdd_cfg80211_dump_survey: 31227: dump survey index:0
[ 3917.978300] R0: wlan: [813:I :HDD] Enter:__wlan_hdd_cfg80211_dump_survey
[ 3917.978306] R0: wlan: [813:I :HDD] __wlan_hdd_cfg80211_dump_survey: 31227: dump survey index:0
[ 3917.980393] R0: wlan: [813:I :HDD] Enter:__wlan_hdd_cfg80211_scan
[ 3917.980396] R0: wlan: [813:I :HDD] __wlan_hdd_cfg80211_scan: 22928: Device_mode WLAN_HDD_P2P_DEVICE(7)
[ 3917.980398] R0: wlan: [813:I :HDD] Enter:wlan_hdd_tdls_scan_callback
[ 3917.980400] R0: wlan: [813:I :HDD] hdd_check_connection_status: 22633: Adapter with device mode WLAN_HDD_INFRA_STATION(0) exists
[ 3917.980401] R0: wlan: [813:I :HDD] hdd_check_connection_status: 22633: Adapter with device mode WLAN_HDD_P2P_DEVICE(7) exists
[ 3917.980407] R0: wlan: [813:I :HDD] No of Scan Channels: 37
[ 3917.980408] R0: wlan: [813:I :HDD] Channel-List: 1 2 3 4 5 6 7 8 9 10 11 36 40 44 48 52 56 60 64 100 104 108 112 116 120 124 128 132 136 140 144 149 153 157 161 165 173
[ 3917.980427] R0: wlan: [813:I :HDD] Exit:__wlan_hdd_cfg80211_scan
[ 3920.662001] R0: wlan: [27786:I :HDD] Enter:hdd_cfg80211_scan_done_callback
[ 3920.662011] R0: wlan: [27786:I :HDD] hdd_cfg80211_scan_done_callback called with halHandle = ffff908aaefb0000, pContext = ffff908a41800000,scanID = 3, returned status = 0
[ 3920.662015] R0: wlan: [27786:I :HDD] Enter:wlan_hdd_cfg80211_update_bss
[ 3920.662066] R0: wlan: [27786:I :HDD] BSSID: c8:08:73:55:2d:fc Channel:56 RSSI:-48
[ 3920.662077] R0: wlan: [27786:I :HDD] BSSID: c8:08:73:15:2d:fc Channel:56 RSSI:-48
[ 3920.662085] R0: wlan: [27786:I :HDD] BSSID: 2e:76:10:0b:ee:92 Channel:5 RSSI:-50
[ 3920.662093] R0: wlan: [27786:I :HDD] BSSID: 28:76:10:0b:ee:92 Channel:5 RSSI:-50
[ 3920.662100] R0: wlan: [27786:I :HDD] BSSID: c8:08:73:55:2d:f8 Channel:6 RSSI:-52
[ 3920.662107] R0: wlan: [27786:I :HDD] BSSID: c8:08:73:15:2d:f8 Channel:6 RSSI:-52
[ 3920.662116] R0: wlan: [27786:I :HDD] BSSID: 28:76:10:16:e2:4e Channel:48 RSSI:-58
[ 3920.662124] R0: wlan: [27786:I :HDD] BSSID: 32:76:10:0c:72:22 Channel:100 RSSI:-62
[ 3920.662131] R0: wlan: [27786:I :HDD] BSSID: 28:76:10:0c:72:22 Channel:100 RSSI:-62
[ 3920.662138] R0: wlan: [27786:I :HDD] BSSID: 2e:76:10:0c:72:22 Channel:100 RSSI:-63
[ 3920.662147] R0: wlan: [27786:I :HDD] BSSID: 2e:76:10:0b:ee:96 Channel:104 RSSI:-66
[ 3920.662155] R0: wlan: [27786:I :HDD] BSSID: 28:76:10:0b:ee:96 Channel:104 RSSI:-66
[ 3920.662163] R0: wlan: [27786:I :HDD] BSSID: 2e:76:10:0c:72:23 Channel:11 RSSI:-70
[ 3920.662171] R0: wlan: [27786:I :HDD] BSSID: 28:76:10:0c:72:23 Channel:11 RSSI:-72
[ 3920.662179] R0: wlan: [27786:I :HDD] BSSID: 8c:fe:74:9c:f5:28 Channel:6 RSSI:-74
[ 3920.662188] R0: wlan: [27786:I :HDD] BSSID: 8c:fe:74:dc:f5:28 Channel:6 RSSI:-75
[ 3920.662196] R0: wlan: [27786:I :HDD] BSSID: 8c:fe:74:dc:f5:2c Channel:116 RSSI:-83
[ 3920.662204] R0: wlan: [27786:I :HDD] BSSID: 8c:fe:74:9c:f5:2c Channel:116 RSSI:-84
[ 3920.662217] R0: wlan: [27786:I :HDD] BSSID: c4:93:00:0e:fe:e0 Channel:1 RSSI:-81
[ 3920.662229] R0: wlan: [27786:I :HDD] Exit:wlan_hdd_cfg80211_update_bss
[ 3920.662246] R0: wlan: [27786:I :HDD] Exit:hdd_cfg80211_scan_done_callback
[ 3920.662774] R0: wlan: [813:I :HDD] Enter:__wlan_hdd_cfg80211_dump_survey
[ 3920.662780] R0: wlan: [813:I :HDD] __wlan_hdd_cfg80211_dump_survey: 31227: dump survey index:0
[ 3920.663390] R0: wlan: [813:I :HDD] Enter:__wlan_hdd_cfg80211_dump_survey
[ 3920.663395] R0: wlan: [813:I :HDD] __wlan_hdd_cfg80211_dump_survey: 31227: dump survey index:0
[ 3920.663772] R0: wlan: [813:I :HDD] Enter:__wlan_hdd_cfg80211_scan
[ 3920.663782] R0: wlan: [813:I :HDD] __wlan_hdd_cfg80211_scan: 22928: Device_mode WLAN_HDD_INFRA_STATION(0)
[ 3920.663789] R0: wlan: [813:I :HDD] Enter:wlan_hdd_tdls_scan_callback
[ 3920.663794] R0: wlan: [813:I :HDD] hdd_check_connection_status: 22633: Adapter with device mode WLAN_HDD_INFRA_STATION(0) exists
[ 3920.663800] R0: wlan: [813:I :HDD] hdd_check_connection_status: 22633: Adapter with device mode WLAN_HDD_P2P_DEVICE(7) exists
[ 3920.663820] R0: wlan: [813:I :HDD] No of Scan Channels: 37
[ 3920.663824] R0: wlan: [813:I :HDD] Channel-List: 1 2 3 4 5 6 7 8 9 10 11 36 40 44 48 52 56 60 64 100 104 108 112 116 120 124 128 132 136 140 144 149 153 157 161 165 173
[ 3920.663891] R0: wlan: [813:I :HDD] Exit:__wlan_hdd_cfg80211_scan
[ 3923.345985] R0: wlan: [27786:I :HDD] Enter:hdd_cfg80211_scan_done_callback
[ 3923.345995] R0: wlan: [27786:I :HDD] hdd_cfg80211_scan_done_callback called with halHandle = ffff908aaefb0000, pContext = ffff908aaf580000,scanID = 5, returned status = 0
[ 3923.345999] R0: wlan: [27786:I :HDD] Enter:wlan_hdd_cfg80211_update_bss
[ 3923.346058] R0: wlan: [27786:I :HDD] BSSID: c8:08:73:15:2d:fc Channel:56 RSSI:-49
[ 3923.346069] R0: wlan: [27786:I :HDD] BSSID: c8:08:73:55:2d:fc Channel:56 RSSI:-50
[ 3923.346077] R0: wlan: [27786:I :HDD] BSSID: c8:08:73:55:2d:f8 Channel:6 RSSI:-53
[ 3923.346084] R0: wlan: [27786:I :HDD] BSSID: c8:08:73:15:2d:f8 Channel:6 RSSI:-53
[ 3923.346092] R0: wlan: [27786:I :HDD] BSSID: 28:76:10:0b:ee:92 Channel:5 RSSI:-54
[ 3923.346100] R0: wlan: [27786:I :HDD] BSSID: 2e:76:10:0b:ee:92 Channel:5 RSSI:-55
[ 3923.346107] R0: wlan: [27786:I :HDD] BSSID: 28:76:10:16:e2:4e Channel:48 RSSI:-58
[ 3923.346115] R0: wlan: [27786:I :HDD] BSSID: 32:76:10:0c:72:22 Channel:100 RSSI:-63
[ 3923.346124] R0: wlan: [27786:I :HDD] BSSID: 2e:76:10:0c:72:22 Channel:100 RSSI:-63
[ 3923.346131] R0: wlan: [27786:I :HDD] BSSID: 28:76:10:0c:72:22 Channel:100 RSSI:-63
[ 3923.346139] R0: wlan: [27786:I :HDD] BSSID: 2e:76:10:0b:ee:96 Channel:104 RSSI:-65
[ 3923.346147] R0: wlan: [27786:I :HDD] BSSID: 28:76:10:0b:ee:96 Channel:104 RSSI:-65
[ 3923.346155] R0: wlan: [27786:I :HDD] BSSID: 2e:76:10:0c:72:23 Channel:11 RSSI:-72
[ 3923.346163] R0: wlan: [27786:I :HDD] BSSID: 28:76:10:0c:72:23 Channel:11 RSSI:-72
[ 3923.346171] R0: wlan: [27786:I :HDD] BSSID: 8c:fe:74:9c:f5:28 Channel:6 RSSI:-75
[ 3923.346179] R0: wlan: [27786:I :HDD] BSSID: 8c:fe:74:dc:f5:28 Channel:6 RSSI:-76
[ 3923.346187] R0: wlan: [27786:I :HDD] BSSID: 8c:fe:74:dc:f5:2c Channel:116 RSSI:-83
[ 3923.346196] R0: wlan: [27786:I :HDD] BSSID: 8c:fe:74:9c:f5:2c Channel:116 RSSI:-84
[ 3923.346203] R0: wlan: [27786:I :HDD] BSSID: c4:93:00:0e:fe:e0 Channel:1 RSSI:-81
[ 3923.346211] R0: wlan: [27786:I :HDD] BSSID: c8:08:73:15:2a:28 Channel:1 RSSI:-85
[ 3923.346220] R0: wlan: [27786:I :HDD] BSSID: c8:08:73:55:2a:28 Channel:1 RSSI:-86
[ 3923.346233] R0: wlan: [27786:I :HDD] Exit:wlan_hdd_cfg80211_update_bss
[ 3923.346247] R0: wlan: [27786:I :HDD] Exit:hdd_cfg80211_scan_done_callback
[ 3923.346798] R0: wlan: [813:I :HDD] Enter:__wlan_hdd_cfg80211_dump_survey
[ 3923.346804] R0: wlan: [813:I :HDD] __wlan_hdd_cfg80211_dump_survey: 31227: dump survey index:0
[ 3923.347783] R0: wlan: [813:I :HDD] Enter:__wlan_hdd_cfg80211_dump_survey
[ 3923.347788] R0: wlan: [813:I :HDD] __wlan_hdd_cfg80211_dump_survey: 31227: dump survey index:0

it works too. I had just: 

$ sudo cp -i firmware_bin/*.bin /lib/firmware/
$ sudo cp firmware_bin/qcom_cfg.ini /lib/firmware/wlan/qcom_cfg.ini

to increase debug verbosity i edited qcom_cfg.init and replaced with line:

# This file allows user to override the factory

# defaults for the WLAN Driver

#Host module debug
vosTraceEnableHDD=9 <--- changed from 0->9
vosTraceEnableWDA=0
vosTraceEnableWDI=0
vosTraceEnableSME=0
vosTraceEnablePE=0
...
valinskas commented 1 year ago

Can you try enabling higher debug level and make sure firmware files including .ini are copied under /lib/firmware/ note configuration file goes under /lib/firmware/wlan/ folder ! And send me full logs you get from dmesg during insmod ?

valinskas commented 1 year ago

i will 5.15.x linux kenrel on linux/x86 that comes with 22.04.1 LTS on monday (up to date) and will let you know if it works.

Hiroshi-tnk commented 1 year ago

I tried vosTraceEnableHDD. but, dmesg are almost same.

add below settings to .ini

#Host module debug
vosTraceEnableHDD=9
vosTraceEnableWDA=0
vosTraceEnableWDI=0
vosTraceEnableSME=0
vosTraceEnablePE=0

and more informations driver dir /lib/modules/5.15.71-rt51-intel-pk-preempt-rt/kernel/drivers/net/wireless/qcacld-usb.ko

firmware and setting files

$ sudo cp -i firmware_bin/*.bin /lib/firmware/
$ sudo cp firmware_bin/WCNSS_qcom_cfg.usb.ini /lib/firmware/wlan/qcacld-usb/qcom_cfg.ini

Makefile changes

+KBUILD_OPTIONS += MODNAME?=qcacld-usb
+KBUILD_OPTIONS += CONFIG_ROME_IF=usb
+KBUILD_OPTIONS += CONFIG_CLD_HL_USB_CORE=y
+#KBUILD_OPTIONS += CONFIG_ROME_IF=pci

git log for branch commit 6b2a8bcebfa3c91c847d2c69511e82edbd4e34ca (HEAD -> linux-5.14.y/CNSS.LEA.NRT_3.1, origin/linux-5.14.y/CNSS.LEA.NRT_3.1)

valinskas commented 1 year ago

Hi It could be power issues, maybe qca/9377 draws too much on start up and crashes ? So far i was not able to recreate. Can you try the same qca/9377 on standard linux pc and check if it works this way instead ? Although that does not explain why 3.0 work (as i understood) but 3.1 - does not. I tried both versions and as you could see from the log files i posted it both versions do work for me.

Just to double check, sudo cp firmware_bin/qcom_cfg.ini /lib/firmware/wlan/qcom_cfg.ini note that on 3.1 branch i copied qcom_cfg.ini instead of WCNSS_qcom_cfg.usb.ini. Can you try with qcom_cfg.ini instead ? To see if that helps ?

Hiroshi-tnk commented 1 year ago

"firmware_bin/qcom_cfg.ini" does not included in branch "linux-5.14.y/CNSS.LEA.NRT_3.1". So I copied "firmware_bin/WCNSS_qcom_cfg.usb.ini".

Hiroshi-tnk commented 1 year ago

I tried another usb port. kernel 5.15 + NRT_3.1

1st time, firmware crashed same part. 2nd time, not crashed, but fail registration. (by auto retry)

dmesg below:

qcacld_usb: loading driver v4.5.25.50
hif_usb_probe
hif_usb_probe[322]
Enter:hif_usb_disable_lpm,Line:242
hif_usb_disable_lpm: LPM isn't enabled
Exit:hif_usb_disable_lpm,Line:269
BCDDevice : 300
RX Bulk Ep:0x81 maxpktsz:512
athusb: alloc resources lpipe:4 hpipe:0xC0408580 urbs:32
RX Bulk Ep:0x82 maxpktsz:512
athusb: alloc resources lpipe:5 hpipe:0xC0410580 urbs:32
RX Bulk Ep:0x83 maxpktsz:512
athusb: alloc resources lpipe:6 hpipe:0xC0418580 urbs:32
RX Bulk Ep:0x84 maxpktsz:512
athusb: alloc resources lpipe:7 hpipe:0xC0420580 urbs:32
TX Bulk Ep:0x01 maxpktsz:512
athusb: alloc resources lpipe:0 hpipe:0xC0008500 urbs:32
TX Bulk Ep:0x02 maxpktsz:512
athusb: alloc resources lpipe:1 hpipe:0xC0010500 urbs:32
TX Bulk Ep:0x03 maxpktsz:512
athusb: alloc resources lpipe:2 hpipe:0xC0018500 urbs:32
TX Bulk Ep:0x04 maxpktsz:512
athusb: alloc resources lpipe:3 hpipe:0xC0020500 urbs:32
R0: wlan: firstConnect[211:E :HDD] hdd_apply_cfg_ini: Reg Parameter gRrmOperChanMax > allowed Maximum [8 > 7]. Enforcing Default= 4
R0: wlan: [211:E :HDD] hdd_apply_cfg_ini: Reg Parameter gRrmNonOperChanMax > allowed Maximum [8 > 7]. Enforcing Default= 4
usb_hif_submit_ctrl_out failed,result = -110
Unable to get target information from the device
R0: [modprobe][01:18:56.695572]  wlan: [211:F :VOS] vos_open: BMI failed to download target
R0: [VosMCThread][01:18:56.695608]  wlan: [215:E :VOS] VosMCThread: MC Thread exiting!!!!
R0: [VosTlshimRxThre][01:18:56.695682]  wlan: [216:E :VOS] VosTlshimRxThread: Shutting down tl shim Tlshim rx thread
R0: [VosTlshimRxThre][01:18:56.695692]  wlan: [216:E :VOS] VosTlshimRxThread: Exiting VOSS Tlshim rx thread
R0: [modprobe][01:18:56.696995]  wlan: [211:F :HDD] hdd_wlan_startup: vos_open failed
usb_hif_submit_ctrl_out failed,result = -71
hif_usb: probe of 1-8:1.0 failed with error -5
usbcore: registered new interface driver hif_usb
usbcore: registered new interface driver hif_usb
R0: wlan: [211:E :HDD] hdd_hif_register_driver: 18373: HIF registration failed
R0: wlan: [211:F :HDD] hdd_driver_init: WLAN Driver Initialization failed
Try to unregister hif_driver
usbcore: deregistering interface driver hif_usb
hif_unregister_driver!!!!!!

I will try Standard pc + 5.15.

Hiroshi-tnk commented 1 year ago

use firmware_bin/qcom_cfg.ini in branch linux-5.4.y/CNSS.LEA.NRT_3.1.

same result

valinskas commented 1 year ago 
TX Bulk Ep:0x04 maxpktsz:512
athusb: alloc resources lpipe:3 hpipe:0xC0020500 urbs:32
R0: wlan: firstConnect[211:E :HDD] hdd_apply_cfg_ini: Reg Parameter gRrmOperChanMax > allowed Maximum [8 > 7]. Enforcing Default= 4
R0: wlan: [211:E :HDD] hdd_apply_cfg_ini: Reg Parameter gRrmNonOperChanMax > allowed Maximum [8 > 7]. Enforcing Default= 4
usb_hif_submit_ctrl_out failed,result = -110
Unable to get target information from the device
R0: [modprobe][01:18:56.695572]  wlan: [211:F :VOS] vos_open: BMI failed to download target

For some reason you are getting USB/layer errors: -110, as a result BMI errors that in essence mean that firmware loaded on 9377 is failing to start (quite possible it crashes on when it is executed). I am inclined to think that 9377 at blame maybe.

I will try 5.15.x linux kernel later today, on standard linux/PC - i cant explain what is going on yet

Hiroshi-tnk commented 1 year ago

I tried standard pc. insmod error. It is possible that my operation in the wrong way...

Makefile

KBUILD_OPTIONS += CONFIG_ROME_IF=usb
#KBUILD_OPTIONS += CONFIG_ROME_IF=pci

$ make $ sudo insmod wlan.ko insmod: ERROR: could not insert module ./wlan.ko: No such device

$ sudo dmesg

[ 1699.253820] wlan: loading driver v4.5.25.50
[ 1699.253868] usbcore: registered new interface driver hif_usb
[ 1702.311268] R0: wlan: [7163:E :HDD] hdd_hif_register_driver: 18373: HIF registration failed
[ 1702.311275] R0: wlan: [7163:F :HDD] hdd_driver_init: WLAN Driver Initialization failed
[ 1702.311277] Try to unregister hif_driver
[ 1702.311278] usbcore: deregistering interface driver hif_usb
[ 1702.311310] hif_unregister_driver!!!!!!
Hiroshi-tnk commented 1 year ago

I cant fix kernel 5.15 + NRT_3.1 problem.

so, I tried porting linux-5.4.y/CNSS.LEA.NRT_3.0 to linux-5.15.y/CNSS.LEA.NRT_3.0 After build error fix, it looks working fine.

kernel: 5.15.71-rt51-intel-pk-preempt-rt

modprobe dmesg below:

qcacld_usb: loading driver v4.5.20.037
hif_usb_probe
Enter:hif_usb_disable_lpm,Line:127
hif_usb_disable_lpm: LPM isn't enabled
Exit:hif_usb_disable_lpm,Line:154
NUM_DEV=1 FWMODE=0x2 FWSUBMODE=0x0 FWBR_BUF 0
Board extended Data download address: 0x0
ol_download_firmware: Using 0x1234 for the remainder of init
ol_transfer_bin_file: Loading setup file athsetup.bin
usb 1-8: Direct firmware load for athsetup.bin failed with error -2
ol_transfer_bin_file: Failed to get athsetup.bin
WDA_open-4688: WMA --> wmi_unified_attach - success
ol_if_dfs_attach: called; ptr=000000008fe8c056, radar_info=00000000d4c11fe4
is_full_reorder_offloaded? 0
TX HTT OFF, ep -1 size 0
htt_tx_attach:htt_desc_start:0x00000000d831852c htt_desc_end:0x000000004568d957
wma_pre_start-5056: WMA --> wmi_unified_connect_htc_service - success
wma_mc_process_msg-21967: McThread: WNI_CFG_DNLD_REQ
__wmi_control_rx: WMI UNIFIED SERVICE READY event
wma_rx_service_ready_event-24799: WMA <-- WMI_SERVICE_READY_EVENTID
wma_rx_service_ready_event-24914: WMA --> WMI_INIT_CMDID
__wmi_control_rx:  WMI UNIFIED READY event
wma_rx_ready_event-24943: WMA <-- WMI_READY_EVENTID
usb 1-8: Direct firmware load for wlan/wlan_mac.bin failed with error -2
Enter:usb_hif_start_recv_pipes,Line:958 
Post URBs to RX_DATA_PIPE: 32
Exit:usb_hif_start_recv_pipes,Line:994 
target uses HTT version 3.27; host uses 3.23
*** Warning: host/target HTT versions are different, though compatible!
session id - 0, AddSta session - 0
wma_vdev_attach-5904: vdev_id 0, txrx_vdev_handle = 00000000c8872387
session id - 1, AddSta session - 0
wma_vdev_attach-5904: vdev_id 1, txrx_vdev_handle = 000000009ecbca36
wma_vdev_attach-5969: P2P Device: creating self peer 86:25:3f:52:95:88, vdev_id 1
TXRX: ol_txrx_peer_find_add_id: Delete Peer 0000000096bbc198
Host SW:4.5.20.037, FW:0.0.0.41, HW:QCA9377_REV1_1
wlan_logging_sock_activate_svc: Initalizing FEConsoleLog = 0 NumBuff = 32
wlan_logging_sock_activate_svc: Activated wlan_logging svc
usbcore: registered new interface driver hif_usb
qcacld_usb: driver loaded
TXRX: ol_txrx_peer_find_add_id: Delete Peer 000000007222d94f
wlan: 84:25:3f:cd:95:88 connected to ffffff88:1f:ffffffa1:35:19:ffffff91
valinskas commented 1 year ago

@Hiroshi-tnk san,

I am sidetracked on other projects. At the moment i cant spare much time on this. Can you share the changes you have made ? I can try them on my setup too. Maybe I can spot something you had missed during the changes.

Hiroshi-tnk commented 1 year ago

Thank you for co-operation.

I'm not use to github. I will try to push my changed cord (local branch: linux-5.15.y/CNSS.LEA.NRT_3.0), but fail.

$ git push origin linux-5.15.y/CNSS.LEA.NRT_3.0
remote: Permission to 8devices/qcacld-2.0.git denied to Hiroshi-tnk.
fatal: unable to access 'https://github.com/8devices/qcacld-2.0.git/': The requested URL returned error: 403

Please advise for push.

valinskas commented 1 year ago

Just attach diff/patch to this issue. No problem.

Hiroshi-tnk commented 1 year ago

$ git diff linux-5.4.y/CNSS.LEA.NRT_3.0

diff_5.4_5.15.txt