SDIO error while using command wifi client start


#1

Hello,

While using the command wifi client scan i am getting the following message from logread

Jan 6 05:08:40 swi-mdm9x15 user.debug Legato: DBUG | wifiService[537]/framework T=main | LE_FILENAME ExtractFileDescriptor() 33 | Received fd (10).
Jan 6 05:08:40 swi-mdm9x15 user.debug Legato: DBUG | wifiService[537]/framework T=main | LE_FILENAME ExtractFileDescriptor() 33 | Received fd (11).
Jan 6 05:08:40 swi-mdm9x15 user.debug Legato: DBUG | wifiService[537]/daemon T=main | le_wifiClient.c le_wifiClient_Start() 560 | Client starts
Jan 6 05:08:40 swi-mdm9x15 user.info Legato: INFO | wifiService[537]/daemon T=main | pa_wifi_client_ti.c pa_wifiClient_Start() 306 | WiFi client starts
Jan 6 05:08:40 swi-mdm9x15 user.debug Legato: DBUG | wifiService[537]/framework T=main | LE_FILENAME le_mem_ForceAlloc() 841 | Memory pool ‘framework.DestructorObjs’ overflowed. Expanded to 2 blocks.
Jan 6 05:08:40 swi-mdm9x15 user.debug Legato: DBUG | wifiService[537]/framework T=WifiClientPaThread | LE_FILENAME PThreadStartRoutine() 362 | Set nice level to 0.
Jan 6 05:08:40 swi-mdm9x15 user.debug Legato: DBUG | wifiService[537]/framework T=WifiClientPaThread | LE_FILENAME le_mem_ForceAlloc() 841 | Memory pool ‘framework.DestructorObjs’ overflowed. Expanded to 3 blocks.
Jan 6 05:08:40 swi-mdm9x15 user.info Legato: INFO | wifiService[537]/daemon T=WifiClientPaThread | pa_wifi_client_ti.c WifiClientPaThreadMain() 211 | Started!
Jan 6 05:08:40 swi-mdm9x15 user.info Legato: INFO | wifiService[537]/daemon T=WifiClientPaThread | pa_wifi_client_ti.c WifiClientPaThreadMain() 228 | PARSING:WIFI_SET_EVENT : len:15
Jan 6 05:08:40 swi-mdm9x15 user.info Legato: INFO | wifiService[537] | WIFI_START
Jan 6 05:08:40 swi-mdm9x15 user.info kernel: [ 134.425331] Loading modules backported from Linux version R8.5
Jan 6 05:08:40 swi-mdm9x15 user.info kernel: [ 134.441355] Backport generated by backports.git R8.5
Jan 6 05:08:40 swi-mdm9x15 user.info kernel: [ 134.592705] gpio_sync_ri: RI owner is Modem
Jan 6 05:08:40 swi-mdm9x15 user.debug kernel: [ 134.595910] ->gpio16 = 0
Jan 6 05:08:40 swi-mdm9x15 user.debug kernel: [ 134.595910] ->gpio17 = 0
Jan 6 05:08:40 swi-mdm9x15 user.debug kernel: [ 134.595940] ->gpio18 = 0
Jan 6 05:08:40 swi-mdm9x15 user.debug kernel: [ 134.595940] ->gpio19 = 0
Jan 6 05:08:40 swi-mdm9x15 user.info kernel: [ 134.717320] cfg80211: Calling CRDA to update world regulatory domain
Jan 6 05:08:41 swi-mdm9x15 user.info kernel: [ 135.019105] cfg80211: World regulatory domain updated:
Jan 6 05:08:41 swi-mdm9x15 user.info kernel: [ 135.023256] cfg80211: DFS Master region: unset
Jan 6 05:08:41 swi-mdm9x15 user.info kernel: [ 135.028139] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time)
Jan 6 05:08:41 swi-mdm9x15 user.info kernel: [ 135.037784] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
Jan 6 05:08:41 swi-mdm9x15 user.info kernel: [ 135.045292] cfg80211: (2457000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
Jan 6 05:08:41 swi-mdm9x15 user.info kernel: [ 135.053624] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A)
Jan 6 05:08:41 swi-mdm9x15 user.info kernel: [ 135.061498] cfg80211: (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A)
Jan 6 05:08:41 swi-mdm9x15 user.info kernel: [ 135.070959] cfg80211: (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s)
Jan 6 05:08:41 swi-mdm9x15 user.info kernel: [ 135.080390] cfg80211: (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s)
Jan 6 05:08:41 swi-mdm9x15 user.info kernel: [ 135.088478] cfg80211: (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A)
Jan 6 05:08:41 swi-mdm9x15 user.info kernel: [ 135.096261] cfg80211: (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A)
Jan 6 05:08:41 swi-mdm9x15 user.info Legato: INFO | wifiService[537]/daemon T=WifiClientPaThread | pa_wifi_client_ti.c WifiClientPaThreadMain() 228 | PARSING:phy #0: regulatory domain change: set to world roaming by the wireless core upon initialization request : len:104
Jan 6 05:08:41 swi-mdm9x15 user.info kernel: [ 135.749641] gpio_sync_ri: RI owner is Modem
Jan 6 05:08:41 swi-mdm9x15 user.debug kernel: [ 135.752846] ->gpio16 = 0
Jan 6 05:08:41 swi-mdm9x15 user.debug kernel: [ 135.752846] ->gpio17 = 0
Jan 6 05:08:41 swi-mdm9x15 user.debug kernel: [ 135.752876] ->gpio18 = 0
Jan 6 05:08:41 swi-mdm9x15 user.debug kernel: [ 135.752876] ->gpio19 = 0
Jan 6 05:08:41 swi-mdm9x15 user.info kernel: [ 135.755104] gpio_sync_ri: RI owner is Modem
Jan 6 05:08:41 swi-mdm9x15 user.debug kernel: [ 135.766854] ->gpio16 = 0
Jan 6 05:08:41 swi-mdm9x15 user.debug kernel: [ 135.766885] ->gpio17 = 0
Jan 6 05:08:41 swi-mdm9x15 user.debug kernel: [ 135.766885] ->gpio18 = 0
Jan 6 05:08:41 swi-mdm9x15 user.debug kernel: [ 135.766915] ->gpio19 = 0
Jan 6 05:08:42 swi-mdm9x15 user.info kernel: [ 135.818464] mmc0: mci-version: 18
Jan 6 05:08:42 swi-mdm9x15 user.info kernel: [ 135.836746] mmc0: bam physical base=0x12182000
Jan 6 05:08:42 swi-mdm9x15 user.info kernel: [ 135.840164] mmc0: bam virtual base=0xd0708000
Jan 6 05:08:42 swi-mdm9x15 user.info kernel: [ 135.844529] sps:BAM 0x12182000 is registered.
Jan 6 05:08:42 swi-mdm9x15 user.info kernel: [ 135.866137] mmc0: BAM device registered. bam_handle=0xcdcba800<6>[ 135.871905] sps:REVISION of BAM 0xd0708000 is 0x5.
Jan 6 05:08:42 swi-mdm9x15 user.info kernel: [ 135.876300] mmc0: Qualcomm MSM SDCC-BAM at 0x0000000012182000 irq 130
Jan 6 05:08:42 swi-mdm9x15 user.info kernel: [ 135.882679] mmc0: Qualcomm MSM SDCC-DML at 0x0000000012180800
Jan 6 05:08:42 swi-mdm9x15 user.err kernel: [ 135.888478] mmc0: No card detect facilities available
Jan 6 05:08:42 swi-mdm9x15 user.info kernel: [ 135.897787] mmc0: Qualcomm MSM SDCC-core at 0x0000000012180000 irq 136,0 dma -1 dmacrcri -1
Jan 6 05:08:42 swi-mdm9x15 user.info kernel: [ 135.916648] mmc0: 8 bit data mode disabled
Jan 6 05:08:42 swi-mdm9x15 user.info kernel: [ 135.920433] mmc0: 4 bit data mode enabled
Jan 6 05:08:42 swi-mdm9x15 user.info kernel: [ 135.923729] mmc0: polling status mode disabled
Jan 6 05:08:42 swi-mdm9x15 user.info kernel: [ 135.937128] mmc0: MMC clock 400000 -> 48000000 Hz, PCLK 0 Hz
Jan 6 05:08:42 swi-mdm9x15 user.warn kernel: [ 135.958400] mmc0: card claims to support voltages below the defined range. These will be ignored.
Jan 6 05:08:42 swi-mdm9x15 user.info kernel: [ 135.976346] mmc0: Slot eject status = 0
Jan 6 05:08:42 swi-mdm9x15 user.info kernel: [ 135.980314] mmc0: Power save feature enable = 1
Jan 6 05:08:42 swi-mdm9x15 user.info kernel: [ 135.983915] mmc0: SPS-BAM data transfer mode available
Jan 6 05:08:42 swi-mdm9x15 user.warn kernel: [ 136.104654] mmc0: queuing unknown CIS tuple 0x91 (3 bytes)
Jan 6 05:08:42 swi-mdm9x15 user.info kernel: [ 136.184068] mmc0: new high speed SDIO card at address 0001
Jan 6 05:08:45 swi-mdm9x15 user.err kernel: [ 138.989714] mmc0: CMD53: Data timeout. DAT0 => 1
Jan 6 05:08:45 swi-mdm9x15 user.err kernel: [ 138.993346] mmc0: SDCC PWR is ON
Jan 6 05:08:45 swi-mdm9x15 user.err kernel: [ 138.996551] mmc0: SDCC clks are ON, MCLK rate=48000000
Jan 6 05:08:45 swi-mdm9x15 user.err kernel: [ 139.001648] mmc0: SDCC irq is enabled
Jan 6 05:08:45 swi-mdm9x15 user.err kernel: [ 139.005310] ===== SDCC-CORE: Register Dumps @phys_base=0x12180000, @virt_base=0xd04fe000 =====
Jan 6 05:08:45 swi-mdm9x15 user.err kernel: [ 139.013917] Reg=0x00: 0x00000001, 0x01009b00, 0xa7ff8804, 0x00001475
Jan 6 05:08:45 swi-mdm9x15 user.err kernel: [ 139.020234] Reg=0x10: 0x00000035, 0x00001000, 0x00000000, 0x00000000
Jan 6 05:08:45 swi-mdm9x15 user.err kernel: [ 139.026583] Reg=0x20: 0x00000000, 0x05b8d800, 0x00000004, 0x00080041
Jan 6 05:08:45 swi-mdm9x15 user.err kernel: [ 139.032900] Reg=0x30: 0x00000000, 0x000c0000, 0x00000000, 0x408001ff
Jan 6 05:08:45 swi-mdm9x15 user.err kernel: [ 139.039249] Reg=0x40: 0x00000000, 0x00000000, 0x00000000, 0x00000000
Jan 6 05:08:45 swi-mdm9x15 user.err kernel: [ 139.045597] Reg=0x50: 0x00000018, 0x00000000, 0x00000000, 0x00000000
Jan 6 05:08:45 swi-mdm9x15 user.err kernel: [ 139.051915] Reg=0x60: 0x60006400, 0x00000000, 0x00000000, 0x00000000
Jan 6 05:08:45 swi-mdm9x15 user.err kernel: [ 139.058263] mmc0: MCI_TEST_INPUT = 0x0000003e
Jan 6 05:08:45 swi-mdm9x15 user.err kernel: [ 139.062597] mmc0: PIO mode
Jan 6 05:08:45 swi-mdm9x15 user.err kernel: [ 139.065283] mmc0: xfer_size=4, data_xfered=4, xfer_remain=0
Jan 6 05:08:45 swi-mdm9x15 user.err kernel: [ 139.070837] mmc0: got_dataend=0, prog_enable=0, wait_for_auto_prog_done=1, got_auto_prog_done=0, req_tout_ms=10000
Jan 6 05:08:45 swi-mdm9x15 user.err kernel: [ 139.081184] mmc0: PM: sdcc_suspended=0, pending_resume=0, sdcc_suspending=0
Jan 6 05:08:45 swi-mdm9x15 user.err kernel: [ 139.088112] mmc0: RPM: runtime_status=0, usage_count=1, is_suspended=0, disable_depth=0, runtime_error=0, request_pending=0, request=0
Jan 6 05:08:45 swi-mdm9x15 user.warn kernel: [ 139.100320] ------------[ cut here ]------------
Jan 6 05:08:45 swi-mdm9x15 user.warn kernel: [ 139.104806] WARNING: CPU: 0 PID: 4 at /home/gsmbuild/tags/buildscripts/SWI9X15Y_07.12.09.00-yocto/build_src/tmp/work/swi_mdm9x15-poky-linux-gnueabi/ti-compat-wireless/1.0-r0/ti-compat-wireless/src/compat_wireless/drivers/net
Jan 6 05:08:45 swi-mdm9x15 user.warn kernel: [ 139.134045] Modules linked in: wl18xx(O) wlcore_sdio(O) wlcore(O) mac80211(O) msm_sdcc cfg80211(O) compat(O) xt_hl nf_conntrack_ipv6 nf_defrag_ipv6 ip6table_filter ip6_tables nf_conntrack_ipv4 nf_defrag_ipv4 xt_tcpudp ipv6 x
Jan 6 05:08:45 swi-mdm9x15 user.warn kernel: [ 139.163070] CPU: 0 PID: 4 Comm: kworker/0:0 Tainted: G O 3.14.29ltsi-961ca71325_ab5094eade #2
Jan 6 05:08:45 swi-mdm9x15 user.warn kernel: [ 139.172836] Workqueue: events request_firmware_work_func
Jan 6 05:08:45 swi-mdm9x15 user.warn kernel: [ 139.177781] [] (unwind_backtrace) from [] (show_stack+0x20/0x24)
Jan 6 05:08:45 swi-mdm9x15 user.warn kernel: [ 139.185472] [] (show_stack) from [] (dump_stack+0x20/0x28)
Jan 6 05:08:45 swi-mdm9x15 user.warn kernel: [ 139.193163] [] (dump_stack) from [] (warn_slowpath_common+0x7c/0x9c)
Jan 6 05:08:45 swi-mdm9x15 user.warn kernel: [ 139.201037] [] (warn_slowpath_common) from [] (warn_slowpath_null+0x2c/0x34)
Jan 6 05:08:45 swi-mdm9x15 user.warn kernel: [ 139.209766] [] (warn_slowpath_null) from [] (wl12xx_sdio_raw_write+0x140/0x184 [wlcore_sdio])
Jan 6 05:08:45 swi-mdm9x15 user.warn kernel: [ 139.220112] [] (wl12xx_sdio_raw_write [wlcore_sdio]) from [] (wlcore_set_partition+0x144/0x4b0 [wlcore])
Jan 6 05:08:45 swi-mdm9x15 user.warn kernel: [ 139.231374] [] (wlcore_set_partition [wlcore]) from [] (wl12xx_set_power_on+0x88/0x15c [wlcore])
Jan 6 05:08:45 swi-mdm9x15 user.warn kernel: [ 139.241812] [] (wl12xx_set_power_on [wlcore]) from [] (wlcore_nvs_cb+0x248/0x964 [wlcore])
Jan 6 05:08:45 swi-mdm9x15 user.warn kernel: [ 139.251732] [] (wlcore_nvs_cb [wlcore]) from [] (request_firmware_work_func+0x40/0x60)
Jan 6 05:08:45 swi-mdm9x15 user.warn kernel: [ 139.261315] [] (request_firmware_work_func) from [] (process_one_work+0x294/0x44c)
Jan 6 05:08:45 swi-mdm9x15 user.warn kernel: [ 139.270593] [] (process_one_work) from [] (worker_thread+0x440/0x560)
Jan 6 05:08:45 swi-mdm9x15 user.warn kernel: [ 139.278742] [] (worker_thread) from [] (kthread+0xd0/0xe4)
Jan 6 05:08:45 swi-mdm9x15 user.warn kernel: [ 139.285731] [] (kthread) from [] (ret_from_fork+0x14/0x20)
Jan 6 05:08:45 swi-mdm9x15 user.warn kernel: [ 139.293239] —[ end trace 241d541d414bca86 ]—
Jan 6 05:08:45 swi-mdm9x15 user.err kernel: [ 139.297756] wl1271_sdio mmc0:0001:2: sdio write failed (-110)
Jan 6 05:08:45 swi-mdm9x15 user.err kernel: [ 139.307126] wlcore: ERROR couldn’t get hw info
Jan 6 05:08:47 swi-mdm9x15 user.info Legato: INFO | wifiService[537] | Failed to start TI wifi
Jan 6 05:08:47 swi-mdm9x15 user.err Legato: =ERR= | wifiService[537]/daemon T=main | pa_wifi_client_ti.c pa_wifiClient_Start() 329 | WiFi Client Command Failed: (23296)wlan0 WIFI_START
Jan 6 05:08:47 swi-mdm9x15 user.err Legato: =ERR= | wifiService[537]/daemon T=main | le_wifiClient.c le_wifiClient_Start() 573 | ERROR: pa_wifiClient_Start returns -6
Jan 6 05:08:47 swi-mdm9x15 user.debug Legato: DBUG | wifiService[537]/framework T=main | le_wifiClient_server.c Handle_le_wifiClient_Start() 557 | Sending response to client session 0x27d3c : 4 bytes sent
Jan 6 05:08:48 swi-mdm9x15 user.debug Legato: DBUG | wifiService[537]/daemon T=main | le_wifiClient.c CloseSessionEventHandler() 414 | sessionRef 0x27d3c GetFirstSessionRef (nil)
Jan 6 05:08:48 swi-mdm9x15 user.debug Legato: DBUG | wifiService[537]/framework T=main | le_wifiClient_server.c CleanupClientData() 195 | Client 0x27d3c is closed !!!
Jan 6 05:08:48 swi-mdm9x15 user.debug Legato: DBUG | wifiService[537]/framework T=main | le_wifiAp_server.c CleanupClientData() 195 | Client 0x27cac is closed !!!

Any ideas why this is happening ?