Hello all,
First of all, I'd like to say that I've used Travelmate for a while with other devices and it works great. I'm working on custom hardware, and want to use Travelmate so that it can automatically cycle through added networks incase it fails to connect to one.
If I connect with the base OpenWrt systems (enable in /etc/wireless) it works; however, if I use Travelmate it will connect for a short time (btwn 10 and 45 seconds maybe) and then disconnect until Travelmate marks it as a faulty station.
Snipped log output around the issue
...
Wed Oct 27 19:59:04 2021 kern.info kernel: wlan: [6157:E :SME] No Pending command waiting
Wed Oct 27 19:59:04 2021 kern.info kernel: wlan: [2903:E :WDA] scan_id a006, vdev_id 0, scan type 0, msg_type 1103
Wed Oct 27 19:59:04 2021 daemon.info : 15[KNL] interface br-wlan0 deleted
Wed Oct 27 19:59:04 2021 daemon.info : 16[KNL] creating roam job due to address/link change
Wed Oct 27 19:59:04 2021 user.notice ModemManager: hotplug: remove network interface br-wlan0: event processed
Wed Oct 27 19:59:04 2021 user.notice ModemManager: hotplug: event reported: action=remove, name=br-wlan0, subsystem=net
Wed Oct 27 19:59:04 2021 daemon.notice netifd: Interface 'wan' is enabled
Wed Oct 27 19:59:04 2021 user.notice ModemManager: hotplug: add network interface br-wlan0: event processed
Wed Oct 27 19:59:04 2021 user.notice ModemManager: hotplug: event reported: action=add, name=br-wlan0, subsystem=net
Wed Oct 27 19:59:04 2021 user.notice ModemManager: hotplug: error: parent device sysfspath not found
Wed Oct 27 19:59:06 2021 kern.info kernel: wlan: [3990:E :WDA] scan complete - scan_id a006, vdev_id 0
Wed Oct 27 19:59:06 2021 kern.info kernel: wlan: [2903:E :SME] Found 9 BSS
Wed Oct 27 19:59:06 2021 kern.info kernel: wlan: [2903:E :SME] No Pending command waiting
Wed Oct 27 19:59:06 2021 kern.info kernel: wlan: [2903:E :SME] No Pending command waiting
Wed Oct 27 19:59:06 2021 kern.info kernel: wlan: [2903:E :SME] PmcOffloadEnableStaModePowerSave: 3795: STA Mode PowerSave is not enabled in ini
Wed Oct 27 19:59:06 2021 kern.info kernel: wlan: [2903:E :SME] No Pending command waiting
Wed Oct 27 19:59:06 2021 daemon.notice wpa_supplicant[6157]: wlan0: Trying to associate with SSID 'TP-Link_E0F6'
Wed Oct 27 19:59:06 2021 kern.info kernel: wlan: [6157:E :HDD] wlan_hdd_cfg80211_set_ie Set UNKNOWN IE 3B
Wed Oct 27 19:59:06 2021 kern.info kernel: wlan: [2903:E :WDA] wma_create_peer: Created peer with peer_addr d8:07:b6:42:e0:f6 vdev_id 0, peer_count - 1
Wed Oct 27 19:59:06 2021 kern.warn kernel: TXRX: ol_txrx_peer_find_add_id: Delete Peer 876cb000
Wed Oct 27 19:59:06 2021 kern.info kernel: wlan: [2903:E :PE ] wlan_cfgGetInt: 333: Not valid cfg id 1
Wed Oct 27 19:59:06 2021 kern.info kernel: wlan: [2903:E :WDA] wma_add_sta_req_sta_mode: statype 0 vdev_id 0 aid 3 bssid d8:07:b6:42:e0:f6 staIdx 0 status 0
Wed Oct 27 19:59:06 2021 kern.info kernel: wlan: 00:22:a3:01:fd:cf connected to ffffffd8:07:ffffffb6:42:ffffffe0:fffffff6
Wed Oct 27 19:59:06 2021 kern.info kernel: wlan: [2903:E :HDD] MODE 0, CH 7, LWM 0, HWM 0, TXQDEP 1500
Wed Oct 27 19:59:06 2021 kern.info kernel: wlan: [2903:E :HDD] wlan(7) d8:07:b6:42:e0:f6 Standalone
Wed Oct 27 19:59:07 2021 daemon.notice netifd: Network device 'wlan0' link is up
Wed Oct 27 19:59:07 2021 daemon.notice netifd: Interface 'wan' has link connectivity
Wed Oct 27 19:59:07 2021 daemon.notice netifd: Interface 'wan' is setting up now
Wed Oct 27 19:59:07 2021 kern.info kernel: wlan: [2903:E :SME] sme_UpdateDSCPtoUPMapping: QOS Mapping IE not present
Wed Oct 27 19:59:07 2021 kern.info kernel: wlan: [2903:E :SME] No Pending command waiting
Wed Oct 27 19:59:07 2021 daemon.notice wpa_supplicant[6157]: wlan0: Associated with d8:07:b6:42:e0:f6
Wed Oct 27 19:59:07 2021 daemon.notice wpa_supplicant[6157]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Wed Oct 27 19:59:07 2021 kern.info kernel: wlan: [6157:E :SME] Active list command waiting
Wed Oct 27 19:59:07 2021 kern.info kernel: wlan: [2903:E :SME] csrNeighborRoamIndicateConnect: 4764: Connect event received in invalid state eCSR_NEIGHBOR_ROAM_STATE_CONNECTED..Ignoring...
Wed Oct 27 19:59:07 2021 kern.info kernel: wlan: [2903:E :SME] PmcOffloadEnableDeferredStaModePowerSave: 4338: STA Mode Config PowerSave is not enabled
Wed Oct 27 19:59:07 2021 kern.info kernel: wlan: [2903:E :SME] No Pending command waiting
Wed Oct 27 19:59:07 2021 daemon.notice wpa_supplicant[6157]: wlan0: WPA: Key negotiation completed with d8:07:b6:42:e0:f6 [PTK=CCMP GTK=CCMP]
Wed Oct 27 19:59:07 2021 daemon.notice wpa_supplicant[6157]: wlan0: CTRL-EVENT-CONNECTED - Connection to d8:07:b6:42:e0:f6 completed [id=0 id_str=]
Wed Oct 27 19:59:07 2021 kern.info kernel: IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
Wed Oct 27 19:59:07 2021 daemon.notice netifd: wan (6226): udhcpc: started, v1.30.1
Wed Oct 27 19:59:07 2021 daemon.notice netifd: wan (6226): udhcpc: sending discover
Wed Oct 27 19:59:07 2021 daemon.notice netifd: wan (6226): udhcpc: sending select for 192.168.0.102
Wed Oct 27 19:59:07 2021 daemon.notice netifd: wan (6226): udhcpc: lease of 192.168.0.102 obtained, lease time 7200
Wed Oct 27 19:59:08 2021 daemon.info : 14[KNL] 192.168.0.102 appeared on wlan0
Wed Oct 27 19:59:08 2021 daemon.notice netifd: Interface 'wan' is now up
Wed Oct 27 19:59:08 2021 daemon.info dnsmasq[2114]: reading /tmp/resolv.conf.auto
Wed Oct 27 19:59:08 2021 daemon.info dnsmasq[2114]: using local addresses only for domain test
Wed Oct 27 19:59:08 2021 daemon.info dnsmasq[2114]: using local addresses only for domain onion
Wed Oct 27 19:59:08 2021 daemon.info dnsmasq[2114]: using local addresses only for domain localhost
Wed Oct 27 19:59:08 2021 daemon.info dnsmasq[2114]: using local addresses only for domain local
Wed Oct 27 19:59:08 2021 daemon.info dnsmasq[2114]: using local addresses only for domain invalid
Wed Oct 27 19:59:08 2021 daemon.info dnsmasq[2114]: using local addresses only for domain bind
Wed Oct 27 19:59:08 2021 daemon.info dnsmasq[2114]: using local addresses only for domain lan
Wed Oct 27 19:59:08 2021 daemon.info dnsmasq[2114]: using nameserver 192.168.0.1#53
Wed Oct 27 19:59:08 2021 daemon.info : 08[KNL] creating roam job due to address/link change
Wed Oct 27 19:59:08 2021 daemon.info : 11[KNL] fe80::222:a3ff:fe01:fdcf appeared on wlan0
Wed Oct 27 19:59:08 2021 user.notice firewall: Reloading firewall due to ifup of wan (wlan0)
Wed Oct 27 19:59:08 2021 daemon.info : 14[KNL] creating roam job due to address/link change
Wed Oct 27 19:59:43 2021 user.debug travelmate-1.5.4[3123]: f_check ::: mode: sta, name: wlan0, status: false, connection: -, wait: 31, max_wait: 30, min_quality: 35, captive: 1, netcheck: 0
Wed Oct 27 19:59:43 2021 daemon.notice netifd: Interface 'wan' is disabled
Wed Oct 27 19:59:43 2021 daemon.notice netifd: Interface 'wan' has link connectivity loss
Wed Oct 27 19:59:44 2021 daemon.notice netifd: wan (6226): udhcpc: received SIGTERM
Wed Oct 27 19:59:44 2021 daemon.notice netifd: Interface 'wan' is now down
Wed Oct 27 19:59:44 2021 daemon.info : 05[KNL] 192.168.0.102 disappeared from wlan0
Wed Oct 27 19:59:44 2021 daemon.warn dnsmasq[2114]: no servers found in /tmp/resolv.conf.auto, will retry
Wed Oct 27 19:59:44 2021 daemon.info : 09[KNL] creating roam job due to address/link change
Wed Oct 27 19:59:44 2021 kern.warn kernel: TXRX: ol_txrx_peer_detach:peer 876cb000 (d8:07:b6:42:e0:f6)
Wed Oct 27 19:59:44 2021 kern.info kernel: wlan: [2903:E :WDA] wma_remove_peer: Removed peer with peer_addr d8:07:b6:42:e0:f6 vdevid 0 peer_count 0
Wed Oct 27 19:59:44 2021 kern.info kernel: wlan: [2903:E :WDA] wmi_unified_vdev_down_send: vdev_id 0
Wed Oct 27 19:59:44 2021 kern.info kernel: wlan: disconnected
Wed Oct 27 19:59:44 2021 kern.info kernel: wlan: [2903:E :HDD] wlan(0) 00:00:00:00:00:00 Standalone
Wed Oct 27 19:59:44 2021 kern.info kernel: wlan: [2903:E :SME] No Pending command waiting
Wed Oct 27 19:59:44 2021 kern.warn kernel: TXRX: ol_rx_peer_unmap_handler: Remove the ID 44 reference to peer 876cb000
Wed Oct 27 19:59:44 2021 kern.warn kernel: TXRX: ol_rx_peer_unmap_handler: Remove the ID 60 reference to peer 876cb000
Wed Oct 27 19:59:44 2021 kern.warn kernel: TXRX: ol_rx_peer_unmap_handler: Remove the ID 63 reference to peer 876cb000
Wed Oct 27 19:59:44 2021 kern.warn kernel: TXRX: Deleting peer 876cb000 (d8:07:b6:42:e0:f6)
Wed Oct 27 19:59:44 2021 daemon.notice wpa_supplicant[6157]: wlan0: CTRL-EVENT-DISCONNECTED bssid=d8:07:b6:42:e0:f6 reason=3 locally_generated=1
Wed Oct 27 19:59:44 2021 daemon.notice wpa_supplicant[6157]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0
Wed Oct 27 19:59:44 2021 daemon.notice wpa_supplicant[6157]: wlan0: CTRL-EVENT-TERMINATING
Wed Oct 27 19:59:44 2021 daemon.notice netifd: Network device 'wlan0' link is down
Wed Oct 27 19:59:44 2021 daemon.info : 05[KNL] interface wlan0 deactivated
Wed Oct 27 19:59:44 2021 daemon.info : 09[KNL] fe80::222:a3ff:fe01:fdcf disappeared from wlan0
Wed Oct 27 19:59:44 2021 kern.info kernel: wma_vdev_detach-5319: vdev_id:0 vdev_hdl:80f3ba00
Wed Oct 27 19:59:44 2021 kern.info kernel: wlan: [0:E :WDA] Call txrx detach with callback for vdev 0
Wed Oct 27 19:59:44 2021 kern.info kernel: wlan: [2903:E :SME] No Pending command waiting
Wed Oct 27 19:59:44 2021 daemon.info : 11[KNL] creating roam job due to address/link change
Wed Oct 27 19:59:44 2021 kern.info kernel: wlan: [6632:E :HDD] wlan_hdd_get_classAstats: Unable to retrieve Class A statistics
Wed Oct 27 19:59:44 2021 daemon.info : 13[KNL] interface wlan0 deleted
Wed Oct 27 19:59:44 2021 daemon.info : 14[KNL] creating roam job due to address/link change
...
I always notice this line in particular :
Wed Oct 27 19:59:44 2021 kern.info kernel: wlan: [2903:E :HDD] wlan(0) 00:00:00:00:00:00 Standalone
Not certain what that means, but I have to set the macadress manually in /etc/config/wireless so I wonder if that has to do with it.
I would appreciate any help at identifying the cause of the disconnect.
Thanks for any help you can give!