Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

module load fail for qcacld-usb.ko #19

Open
Hiroshi-tnk opened this issue Feb 16, 2023 · 20 comments
Open

module load fail for qcacld-usb.ko #19

Hiroshi-tnk opened this issue Feb 16, 2023 · 20 comments

Comments

@Hiroshi-tnk
Copy link

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
Copy link
Author

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
Copy link
Member

valinskas commented Feb 17, 2023

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
Copy link
Member

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
Copy link
Member

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
Copy link
Member

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
Copy link
Member

valinskas commented Feb 17, 2023

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
Copy link
Member

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
Copy link
Member

valinskas commented Feb 17, 2023

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
Copy link
Author

Hiroshi-tnk commented Feb 20, 2023

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
Copy link
Member

valinskas commented Feb 21, 2023

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
Copy link
Author

"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
Copy link
Author

Hiroshi-tnk commented Feb 22, 2023

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
Copy link
Author

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

same result

@valinskas
Copy link
Member

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
Copy link
Author

Hiroshi-tnk commented Feb 24, 2023

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

  • Ubuntu 22.04.2 LTS (GNU/Linux 5.15.0-60-generic x86_64)
  • Linux dali04 5.15.0-60-generic #66-Ubuntu SMP Fri Jan 20 14:29:49 UTC 2023 x86_64 x86_64 x86_64 GNU/Linux
  • commit 6b2a8bc (HEAD, origin/linux-5.14.y/CNSS.LEA.NRT_3.1)

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
Copy link
Author

Hiroshi-tnk commented Mar 1, 2023

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
Copy link
Member

@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
Copy link
Author

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
Copy link
Member

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

@Hiroshi-tnk
Copy link
Author

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

diff_5.4_5.15.txt

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
None yet
Projects
None yet
Development

No branches or pull requests

2 participants