=== POST-WIFI-RECONNECT CAPTURE === Sat Aug 15 16:19:45 CST 2026 16:19:45 up 56 min, load average: 0.01, 0.07, 0.07 === CONFIG INTEGRITY === b1a98277188b0c1bd40daf88b16231e78d876f4004f5bfdc8216a27ca6c5c4b5 /etc/config/qmodem 5213d7efd90c5c46084e860d4ef378f7bf6c4fad79f80f9e8ed317878e4009ae /etc/config/network --- uci changes === PROCESS === 10704 root 2028 S {modem_dial.sh} /bin/sh /usr/share/qmodem/modem_dial.sh 2_1 dial 10937 root 2088 S /usr/bin/ubus-at-daemon 11571 root 1416 S quectel-CM-M -4 -6 -s cbnet -i wwan0 -d -M 11 -f /var/run/qmodem/2_1_dir/dial_log === INTERFACE === { "up": true, "pending": false, "available": true, "autostart": true, "dynamic": false, "uptime": 265, "l3_device": "wwan0_1", "proto": "dhcp", "device": "wwan0_1", "updated": [ "addresses", "routes", "data" ], "metric": 11, "dns_metric": 0, "delegation": true, "ipv4-address": [ { "address": "10.0.214.192", "mask": 25 } ], "ipv6-address": [ ], "ipv6-prefix": [ ], "ipv6-prefix-assignment": [ ], "route": [ { "target": "0.0.0.0", "mask": 0, "nexthop": "10.0.214.193", "source": "10.0.214.192/32" } ], "dns-server": [ "43.239.172.1", "43.239.172.2" ], "dns-search": [ ], "neighbors": [ ], "inactive": { "ipv4-address": [ ], "ipv6-address": [ ], "route": [ ], "dns-server": [ ], "dns-search": [ ], "neighbors": [ ] }, "data": { "dhcpserver": "10.0.214.193", "hostname": "Bpi-R3mini", "leasetime": 7200 } } { "up": true, "pending": false, "available": true, "autostart": true, "dynamic": false, "uptime": 254, "l3_device": "wwan0_1", "proto": "dhcpv6", "device": "wwan0_1", "updated": [ "addresses", "routes", "prefixes" ], "metric": 11, "dns_metric": 0, "delegation": true, "ipv4-address": [ ], "ipv6-address": [ { "address": "240a:4282:4800:16c2:544c:5828:6e93:889a", "mask": 64 } ], "ipv6-prefix": [ { "address": "240a:4282:4800:16c2::", "mask": 64, "class": "2_1v6", "assigned": { "lan": { "address": "240a:4282:4800:16c2::", "mask": 64 } } } ], "ipv6-prefix-assignment": [ ], "route": [ { "target": "::", "mask": 0, "nexthop": "fe80::e438:e99c:c64:c7e7", "metric": 512, "valid": 65271, "source": "240a:4282:4800:16c2:544c:5828:6e93:889a/64" } ], "dns-server": [ "2409:8080:2000:3::1", "2409:8080:2000:3::2" ], "dns-search": [ ], "neighbors": [ ], "inactive": { "ipv4-address": [ ], "ipv6-address": [ ], "route": [ ], "dns-server": [ ], "dns-search": [ ], "neighbors": [ ] }, "data": { } } === COUNTERS === wwan0 tx_errors=0 rx_errors=0 wwan0_1 tx_errors=0 rx_errors=0 qmi_message_timeouts=1 watchdogs=0 usb_disconnects=0 === CONNECTIVITY === PING 1.1.1.1 (1.1.1.1): 56 data bytes 64 bytes from 1.1.1.1: seq=0 ttl=47 time=104.354 ms 64 bytes from 1.1.1.1: seq=1 ttl=47 time=114.417 ms 64 bytes from 1.1.1.1: seq=2 ttl=47 time=73.029 ms 64 bytes from 1.1.1.1: seq=3 ttl=47 time=74.208 ms 64 bytes from 1.1.1.1: seq=4 ttl=47 time=98.010 ms --- 1.1.1.1 ping statistics --- 5 packets transmitted, 5 packets received, 0% packet loss round-trip min/avg/max = 73.029/92.803/114.417 ms PING 2606:4700:4700::1111 (2606:4700:4700::1111): 56 data bytes 64 bytes from 2606:4700:4700::1111: seq=0 ttl=51 time=218.683 ms 64 bytes from 2606:4700:4700::1111: seq=1 ttl=51 time=222.078 ms 64 bytes from 2606:4700:4700::1111: seq=2 ttl=51 time=262.923 ms --- 2606:4700:4700::1111 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 218.683/234.561/262.923 ms === AT FINAL === --- AT+C5GREG? AT+C5GREG? +C5GREG: 0,1 OK --- AT+CGATT? AT+CGATT? +CGATT: 1 OK --- AT+CGACT? AT+CGACT? +CGACT: 1,1 +CGACT: 2,0 +CGACT: 3,0 +CGACT: 4,0 +CGACT: 5,0 OK --- AT+CGPADDR AT+CGPADDR +CGPADDR: 1,"10.0.214.192","36.10.66.130.72.0.22.194.24.203.236.129.250.18.179.199" +CGPADDR: 2,"0.0.0.0","0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0" +CGPADDR: 3,"0.0.0.0","0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0" +CGPADDR: 4,"0.0.0.0","0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0" +CGPADDR: 5,"0.0.0.0","0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0" OK --- AT+CGCONTRDP AT+CGCONTRDP +CGCONTRDP: 1,0,"cbnet","10.0.214.192","36.10.66.130.72.0.22.194.24.203.236.129.250.18.179.199", "254.128.0.0.0.0.0.0.228.56.233.156.12.100.199.231","43.239.172.1" "36.9.128.128.32.0.0.3.0.0.0.0.0.0.0.1","43.239.172.2" "36.9.128.128.32.0.0.3.0.0.0.0.0.0.0.2" OK --- AT+QENG="servingcell" AT+QENG="servingcell" +QENG: "servingcell","NOCONN","NR5G-SA","TDD",460,15,1507FC003,506,200045,504990,41,12,-91,-3,17,1,- OK --- AT+QCAINFO AT+QCAINFO +QCAINFO: "PCC",504990,10,"NR5G BAND 41",506 +QCAINFO: "SCC",155770,3,"NR5G BAND 28",1,98,0,-,- OK --- AT+QRSRP AT+QRSRP +QRSRP: -92,-92,-91,-97,NR5G OK === DIAL LOG FULL === [2026-08-15 07:34:27] modem_dial:modem_path=/sys/bus/usb/devices/2-1/,driver=qmi,interface=2_1,at_port=/dev/ttyUSB2,using_sim_slot:1,dns_list:,bridge_enabled:0,bridge_ports:,bridge_management_ip: [2026-08-15 07:34:32] modem_dial:info sim card is ready [2026-08-15 07:34:32] modem_dial:interface 2_1 already set to wwan0_1 [2026-08-15 07:34:32] modem_dial:dialing /sys/bus/usb/devices/2-1/ driver qmi [2026-08-15 07:34:32] modem_dial:dialing: quectel-CM-M -4 -6 -s cbnet -i wwan0 -d -M 11 -f /var/run/qmodem/2_1_dir/dial_log [2026-08-15 07:34:32] modem_dial:pid: 11571 [08-15_07:34:32:815] Find /sys/bus/usb/devices/2-1 idVendor=0x2c7c idProduct=0x801, bus=0x002, dev=0x002 [08-15_07:34:32:815] Auto find qmichannel = /dev/cdc-wdm0 [08-15_07:34:32:815] Auto find usbnet_adapter = wwan0 [08-15_07:34:32:816] netcard driver = qmi_wwan_q, driver version = V1.5.0 [08-15_07:34:32:816] qmap_mode = 1, qmap_version = 9, qmap_size = 31744, muxid = 0x81, qmap_netcard = wwan0_1 [08-15_07:34:32:816] Modem works in QMI mode [08-15_07:34:32:822] cdc_wdm_fd = 8 [08-15_07:34:33:823] QmiWwanInit message timeout [08-15_07:34:35:098] Get clientWDS = 14 [08-15_07:34:35:130] Get clientWDS = 15 [08-15_07:34:35:162] Get clientDMS = 1 [08-15_07:34:35:194] Get clientNAS = 2 [08-15_07:34:35:226] Get clientUIM = 2 [08-15_07:34:35:257] Get clientWDA = 1 [08-15_07:34:35:290] requestBaseBandVersion RM520NGLAAR01A08M4G [08-15_07:34:35:290] Modem model RM520NGLAAR01A08M4G does not require FCC authentication [08-15_07:34:35:322] qmap_settings.rx_urb_size = 31744 [08-15_07:34:35:322] qmap_settings.ul_data_aggregation_max_datagrams = 11 [08-15_07:34:35:322] qmap_settings.ul_data_aggregation_max_size = 8192 [08-15_07:34:35:322] qmap_settings.dl_minimum_padding = 0 [08-15_07:34:35:482] Skipping FCC authentication - not required for this modem model [08-15_07:34:35:514] requestGetSIMStatus SIMStatus: SIM_READY [08-15_07:34:35:577] requestGetProfile[pdp:1 index:1] cbnet///0/IPV4V6 [08-15_07:34:35:578] requestSetProfile[pdp:1 index:1] cbnet///0/IPV4V6 [08-15_07:34:35:578] no need to set skip the rest [08-15_07:34:35:610] requestRegistrationState2 MCC: 460, MNC: 15, PS: Attached, DataCap: 5G_SA [08-15_07:34:35:641] requestQueryDataCall IPv4ConnectionStatus: DISCONNECTED [08-15_07:34:35:673] requestQueryDataCall IPv6ConnectionStatus: DISCONNECTED [08-15_07:34:35:674] ip link set dev wwan0 down [08-15_07:34:35:677] ip addr flush dev wwan0_1 [08-15_07:34:35:680] ip link set dev wwan0_1 down [08-15_07:34:36:760] requestSetupDataCall WdsConnectionIPv4Handle: 0x45b3e0b0 [08-15_07:34:36:856] requestSetupDataCall WdsConnectionIPv6Handle: 0x45b47810 [08-15_07:34:37:020] ip link set dev wwan0 up [08-15_07:34:37:045] ip link set dev wwan0_1 up [08-15_07:34:37:065] ip -4 address flush dev wwan0_1 [08-15_07:34:37:068] ip -4 address add 10.3.229.193/30 dev wwan0_1 [08-15_07:34:37:072] ip -4 route add default via 10.3.229.194 dev wwan0_1 metric 11 [08-15_07:34:37:075] ip -6 address flush dev wwan0_1 [08-15_07:34:37:079] ip -6 address add 240a:4282:4802:175f:961:fbf5:4cd3:6a2a/64 dev wwan0_1 [08-15_07:34:37:082] ip -6 route add default dev wwan0_1 metric 11 [08-15_16:15:01:554] requestQueryDataCall IPv4ConnectionStatus: DISCONNECTED [08-15_16:15:01:586] requestQueryDataCall IPv6ConnectionStatus: DISCONNECTED [08-15_16:15:01:591] ip link set dev wwan0 down [08-15_16:15:01:809] ip addr flush dev wwan0_1 [08-15_16:15:01:820] ip link set dev wwan0_1 down [08-15_16:15:02:483] requestRegistrationState2 MCC: 460, MNC: 1, PS: Detached, DataCap: UNKNOW [08-15_16:15:17:876] requestRegistrationState2 MCC: 460, MNC: 1, PS: Detached, DataCap: UNKNOW [08-15_16:15:19:316=== LOGREAD 16:14-16:20 RELEVANT === Sat Aug 15 07:33:54 2026 daemon.notice netifd: bridge 'br-lan' link is down Sat Aug 15 07:33:54 2026 daemon.notice netifd: Interface 'lan' has link connectivity loss Sat Aug 15 07:33:54 2026 daemon.notice netifd: Network device 'eth0' link is up Sat Aug 15 07:33:54 2026 daemon.notice netifd: bridge 'br-lan' link is up Sat Aug 15 07:33:54 2026 daemon.notice netifd: Interface 'lan' has link connectivity Sat Aug 15 07:33:54 2026 daemon.notice netifd: Network device 'lo' link is up Sat Aug 15 07:33:54 2026 daemon.notice netifd: Interface 'loopback' has link connectivity Sat Aug 15 07:33:54 2026 daemon.notice netifd: Network device 'eth1' link is up Sat Aug 15 07:33:54 2026 daemon.notice netifd: Interface 'wan' has link connectivity Sat Aug 15 07:33:54 2026 daemon.notice netifd: Interface 'wan' is setting up now Sat Aug 15 07:33:54 2026 daemon.notice netifd: Interface 'wan6' has link connectivity Sat Aug 15 07:33:54 2026 daemon.notice netifd: Interface 'wan6' is setting up now Sat Aug 15 07:33:54 2026 user.notice netifd-mtwifi: up: MT7986_1_1 Sat Aug 15 07:33:54 2026 daemon.notice netifd: wan (3140): udhcpc: started, v1.36.1 Sat Aug 15 07:33:54 2026 daemon.notice netifd: wan (3140): udhcpc: broadcasting discover Sat Aug 15 07:33:54 2026 daemon.notice netifd: MT7986_1_1 (3106): sh: startwapp.sh: not found Sat Aug 15 07:34:00 2026 user.notice modem_hotplug: net slot: /devices/platform/soc/11200000.usb/usb2/2-1/2-1:1.4/net/wwan0 action: add Sat Aug 15 07:34:00 2026 user.notice modem_hotplug: net slot: /devices/platform/soc/11200000.usb/usb2/2-1/2-1:1.4/net/wwan0/net/wwan0_1 action: add Sat Aug 15 07:34:04 2026 daemon.notice netifd: Interface 'wireguard' is now down Sat Aug 15 07:34:04 2026 daemon.notice netifd: wan (3140): udhcpc: broadcasting discover Sat Aug 15 07:34:04 2026 daemon.notice netifd: wan (3140): udhcpc: broadcasting discover Sat Aug 15 07:34:14 2026 daemon.notice netifd: MT7986_1_1 (3106): sh: startwapp.sh: not found Sat Aug 15 07:34:14 2026 user.notice netifd-mtwifi: add ra0 to vifidx 0 Sat Aug 15 07:34:14 2026 daemon.notice netifd: Wireless device 'MT7986_1_1' is now up Sat Aug 15 07:34:14 2026 daemon.notice netifd: Network device 'ra0' link is up Sat Aug 15 07:34:14 2026 user.notice netifd-mtwifi: up: MT7986_1_2 Sat Aug 15 07:34:15 2026 daemon.notice netifd: MT7986_1_2 (6030): sh: startwapp.sh: not found Sat Aug 15 07:34:15 2026 daemon.notice netifd: MT7986_1_2 (6030): sh: startwapp.sh: not found Sat Aug 15 07:34:15 2026 user.notice netifd-mtwifi: add rax0 to vifidx 0 Sat Aug 15 07:34:15 2026 daemon.notice netifd: Wireless device 'MT7986_1_2' is now up Sat Aug 15 07:34:15 2026 daemon.notice netifd: Network device 'rax0' link is up Sat Aug 15 07:34:27 2026 user.notice qmodem_network: cfg:2_1 current:0;target:1 Sat Aug 15 07:34:27 2026 user.notice qmodem_network: Modem 2_1 Start Dial Now Sat Aug 15 07:34:27 2026 user.notice qmodem_network: update modem cfg: 2_1 dial:1 Sat Aug 15 07:34:27 2026 daemon.notice procd: /etc/rc.d/S99qmodem_network: Command failed: ubus call service set { } (Invalid argument) Sat Aug 15 07:34:27 2026 daemon.notice procd: /etc/rc.d/S99qmodem_network: Usage: ubus [] [arguments...] Sat Aug 15 07:34:27 2026 daemon.notice procd: /etc/rc.d/S99qmodem_network: Options: Sat Aug 15 07:34:27 2026 daemon.notice procd: /etc/rc.d/S99qmodem_network: -s : Set the unix domain socket to connect to Sat Aug 15 07:34:27 2026 daemon.notice procd: /etc/rc.d/S99qmodem_network: -t : Set the timeout (in seconds) for a command to complete Sat Aug 15 07:34:27 2026 daemon.notice procd: /etc/rc.d/S99qmodem_network: -S: Use simplified output (for scripts) Sat Aug 15 07:34:27 2026 daemon.notice procd: /etc/rc.d/S99qmodem_network: -v: More verbose output Sat Aug 15 07:34:27 2026 daemon.notice procd: /etc/rc.d/S99qmodem_network: -m : (for monitor): include a specific message type Sat Aug 15 07:34:27 2026 daemon.notice procd: /etc/rc.d/S99qmodem_network: (can be used more than once) Sat Aug 15 07:34:27 2026 daemon.notice procd: /etc/rc.d/S99qmodem_network: -M (for monitor): only capture received or transmitted traffic Sat Aug 15 07:34:27 2026 daemon.notice procd: /etc/rc.d/S99qmodem_network: Sat Aug 15 07:34:27 2026 daemon.notice procd: /etc/rc.d/S99qmodem_network: - list [] List objects Sat Aug 15 07:34:27 2026 daemon.notice procd: /etc/rc.d/S99qmodem_network: - call [] Call an object method Sat Aug 15 07:34:27 2026 daemon.notice procd: /etc/rc.d/S99qmodem_network: - subscribe [...] Subscribe to object(s) notifications Sat Aug 15 07:34:27 2026 daemon.notice procd: /etc/rc.d/S99qmodem_network: - listen [...] Listen for events Sat Aug 15 07:34:27 2026 daemon.notice procd: /etc/rc.d/S99qmodem_network: - send [] Send an event Sat Aug 15 07:34:27 2026 daemon.notice procd: /etc/rc.d/S99qmodem_network: - wait_for [...] Wait for multiple objects to appear on ubus Sat Aug 15 07:34:27 2026 daemon.notice procd: /etc/rc.d/S99qmodem_network: - monitor Monitor ubus traffic Sat Aug 15 07:34:27 2026 daemon.notice procd: /etc/rc.d/S99qmodem_network: Sat Aug 15 07:34:35 2026 kern.info kernel: [ 62.198710] net wwan0: ul_data_aggregation_max_datagrams=11, ul_data_aggregation_max_size=8192, dl_minimum_padding=0 Sat Aug 15 07:34:37 2026 kern.info kernel: [ 63.892709] net wwan0: link_state 0x0 -> 0x1 Sat Aug 15 07:34:37 2026 kern.info kernel: [ 63.911452] extif_set_dev prefix match (wwan0) Sat Aug 15 07:34:37 2026 daemon.notice netifd: Network device 'wwan0_1' link is up Sat Aug 15 07:34:37 2026 daemon.notice netifd: Interface '2_1' has link connectivity Sat Aug 15 07:34:37 2026 daemon.notice netifd: Interface '2_1' is setting up now Sat Aug 15 07:34:37 2026 kern.info kernel: [ 63.936349] extif_set_dev prefix match (wwan0_1) Sat Aug 15 07:34:37 2026 daemon.notice netifd: 2_1 (11978): udhcpc: started, v1.36.1 Sat Aug 15 07:34:37 2026 daemon.notice netifd: 2_1 (11978): udhcpc: broadcasting discover Sat Aug 15 07:34:37 2026 daemon.notice netifd: 2_1 (11978): udhcpc: broadcasting select for 10.3.229.193, server 10.3.229.194 Sat Aug 15 07:34:37 2026 daemon.notice netifd: 2_1 (11978): udhcpc: lease of 10.3.229.193 obtained from 10.3.229.194, lease time 7200 Sat Aug 15 07:34:37 2026 daemon.notice netifd: Interface 'wireguard' is setting up now Sat Aug 15 07:34:37 2026 daemon.notice netifd: Interface '2_1v6' is enabled Sat Aug 15 07:34:37 2026 daemon.notice netifd: Network alias 'wwan0_1' link is up Sat Aug 15 07:34:37 2026 daemon.notice netifd: Interface '2_1v6' has link connectivity Sat Aug 15 07:34:37 2026 daemon.notice netifd: Interface '2_1v6' is setting up now Sat Aug 15 07:34:37 2026 daemon.notice netifd: Interface '2_1' is now up Sat Aug 15 07:34:37 2026 daemon.notice netifd: Interface 'wireguard' is now up Sat Aug 15 07:34:37 2026 daemon.notice netifd: Network device 'wireguard' link is up Sat Aug 15 07:34:37 2026 user.notice firewall: Reloading firewall due to ifup of 2_1 (wwan0_1) Sat Aug 15 15:24:06 2026 user.notice hotplug: QModem WWAN LED: wwan0_1 / Action: ifup set led. Sat Aug 15 15:24:06 2026 user.notice wrtbwmon: Restart for ifup of 2_1 (wwan0_1) Sat Aug 15 15:24:09 2026 daemon.notice netifd: Interface '2_1v6' is now up Sat Aug 15 15:24:16 2026 user.notice firewall: Reloading firewall due to ifup of 2_1v6 (wwan0_1) Sat Aug 15 15:24:25 2026 user.notice hotplug: QModem WWAN LED: wwan0_1 / Action: ifup set led. Sat Aug 15 15:24:25 2026 user.notice wrtbwmon: Restart for ifup of 2_1v6 (wwan0_1) Sat Aug 15 16:15:01 2026 authpriv.info dropbear[19455]: Child connection from 10.100.101.228:55715 Sat Aug 15 16:15:01 2026 authpriv.notice dropbear[19455]: Password auth succeeded for 'root' from 10.100.101.228:55715 Sat Aug 15 16:15:01 2026 kern.info kernel: [ 3124.225505] net wwan0: link_state 0x1 -> 0x0 Sat Aug 15 16:15:01 2026 kern.info kernel: [ 3124.234243] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 Sat Aug 15 16:15:01 2026 daemon.notice netifd: Network device 'wwan0_1' link is down Sat Aug 15 16:15:01 2026 daemon.notice netifd: Network alias 'wwan0_1' link is down Sat Aug 15 16:15:01 2026 daemon.notice netifd: Interface '2_1v6' has link connectivity loss Sat Aug 15 16:15:01 2026 daemon.notice netifd: Interface '2_1' has link connectivity loss Sat Aug 15 16:15:01 2026 kern.info kernel: [ 3124.421124] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 Sat Aug 15 16:15:01 2026 kern.info kernel: [ 3124.427151] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 Sat Aug 15 16:15:01 2026 daemon.notice netifd: 2_1 (11978): udhcpc: received SIGTERM Sat Aug 15 16:15:01 2026 daemon.notice netifd: 2_1 (11978): udhcpc: unicasting a release of 10.3.229.193 to 10.3.229.194 Sat Aug 15 16:15:01 2026 daemon.notice netifd: 2_1 (11978): udhcpc: sending release Sat Aug 15 16:15:01 2026 daemon.notice netifd: 2_1 (11978): udhcpc: entering released state Sat Aug 15 16:15:01 2026 kern.info kernel: [ 3124.432851] extif_put_dev(wwan0) Sat Aug 15 16:15:01 2026 daemon.notice ttyd[10804]: [2026/08/15 16:15:01:8021] N: rops_handle_POLLIN_netlink: DELADDR Sat Aug 15 16:15:01 2026 kern.info kernel: [ 3124.441213] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 Sat Aug 15 16:15:01 2026 daemon.notice ttyd[10804]: [2026/08/15 16:15:01:8161] N: rops_handle_POLLIN_netlink: DELADDR Sat Aug 15 16:15:01 2026 daemon.notice netifd: 2_1 (11978): Command failed: ubus call network.interface notify_proto { "action": 0, "link-up": false, "keep": false, "interface": "2_1" } (Permission denied) Sat Aug 15 16:15:01 2026 daemon.notice ttyd[10804]: [2026/08/15 16:15:01:8167] N: rops_handle_POLLIN_netlink: DELADDR Sat Aug 15 16:15:01 2026 daemon.notice ttyd[10804]: [2026/08/15 16:15:01:8169] N: rops_handle_POLLIN_netlink: DELADDR Sat Aug 15 16:15:01 2026 daemon.notice ttyd[10804]: [2026/08/15 16:15:01:8171] N: rops_handle_POLLIN_netlink: DELADDR Sat Aug 15 16:15:01 2026 daemon.notice netifd: Interface '2_1' is now down Sat Aug 15 16:15:01 2026 daemon.notice netifd: Interface 'wireguard' has lost the connection Sat Aug 15 16:15:01 2026 daemon.notice ttyd[10804]: [2026/08/15 16:15:01:8255] N: rops_handle_POLLIN_netlink: DELADDR Sat Aug 15 16:15:01 2026 kern.info kernel: [ 3124.464734] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 Sat Aug 15 16:15:01 2026 kern.info kernel: [ 3124.470444] extif_put_dev(wwan0_1) Sat Aug 15 16:15:01 2026 kern.info kernel: [ 3124.482745] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 Sat Aug 15 16:15:01 2026 kern.info kernel: [ 3124.488719] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 Sat Aug 15 16:15:01 2026 daemon.notice netifd: Interface '2_1v6' is disabled Sat Aug 15 16:15:01 2026 daemon.notice netifd: Network device 'wireguard' link is down Sat Aug 15 16:15:01 2026 kern.info kernel: [ 3124.600057] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 Sat Aug 15 16:15:01 2026 kern.info kernel: [ 3124.620005] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 Sat Aug 15 16:15:01 2026 kern.info kernel: [ 3124.625820] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 Sat Aug 15 16:15:02 2026 user.notice modem_hotplug: net slot: /devices/virtual/net/wireguard action: remove Sat Aug 15 16:15:02 2026 user.notice mtk_smp: board=bananapi,bpi-r3-mini, wifi_num=2, cpu_num=4, usbnet=1 Sat Aug 15 16:15:02 2026 daemon.err odhcp6c[12010]: Failed to send SOLICIT message to ff02::1:2 (Network unreachable) Sat Aug 15 16:15:02 2026 daemon.notice netifd: Interface '2_1v6' is now down Sat Aug 15 16:15:02 2026 daemon.notice netifd: Interface 'wireguard' is now down Sat Aug 15 16:15:02 2026 daemon.notice netifd: Interface 'wireguard' is setting up now Sat Aug 15 16:15:02 2026 kern.info kernel: [ 3125.123690] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 Sat Aug 15 16:15:02 2026 kern.info kernel: [ 3125.129960] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 Sat Aug 15 16:15:02 2026 user.notice modem_hotplug: net slot: /devices/virtual/net/wireguard action: add Sat Aug 15 16:15:02 2026 kern.info kernel: [ 3125.183325] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 Sat Aug 15 16:15:02 2026 kern.info kernel: [ 3125.189229] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 Sat Aug 15 16:15:02 2026 user.notice modem_hotplug: net slot: /devices/virtual/net/wireguard action: remove Sat Aug 15 16:15:02 2026 user.notice mtk_smp: board=bananapi,bpi-r3-mini, wifi_num=2, cpu_num=4, usbnet=1 Sat Aug 15 16:15:02 2026 daemon.notice netifd: Interface 'wireguard' is now down Sat Aug 15 16:15:03 2026 user.notice mtk_smp: board=bananapi,bpi-r3-mini, wifi_num=2, cpu_num=4, usbnet=1 Sat Aug 15 16:15:03 2026 user.notice mtk_smp: board=bananapi,bpi-r3-mini, wifi_num=2, cpu_num=4, usbnet=1 Sat Aug 15 16:15:03 2026 daemon.warn odhcpd[4176]: rfc9096: br-lan: stale 240a:4282:4802:175f::1/64 Sat Aug 15 16:15:03 2026 daemon.warn odhcpd[4176]: No default route present, setting ra_lifetime to 0! Sat Aug 15 16:15:03 2026 daemon.warn odhcpd[4176]: rfc9096: br-lan: piofile updated Sat Aug 15 16:15:20 2026 kern.info kernel: [ 3143.309030] net wwan0: link_state 0x0 -> 0x1 Sat Aug 15 16:15:20 2026 kern.info kernel: [ 3143.316085] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 Sat Aug 15 16:15:20 2026 kern.info kernel: [ 3143.321990] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 Sat Aug 15 16:15:20 2026 kern.info kernel: [ 3143.327765] extif_set_dev(wwan0) Sat Aug 15 16:15:20 2026 kern.info kernel: [ 3143.331140] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 Sat Aug 15 16:15:20 2026 kern.info kernel: [ 3143.337158] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 Sat Aug 15 16:15:20 2026 daemon.notice netifd: Network device 'wwan0_1' link is up Sat Aug 15 16:15:20 2026 daemon.notice netifd: Interface '2_1' has link connectivity Sat Aug 15 16:15:20 2026 daemon.notice netifd: Interface '2_1' is setting up now Sat Aug 15 16:15:20 2026 kern.info kernel: [ 3143.342957] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 Sat Aug 15 16:15:20 2026 kern.info kernel: [ 3143.348635] extif_set_dev(wwan0_1) Sat Aug 15 16:15:20 2026 daemon.notice netifd: 2_1 (21550): udhcpc: started, v1.36.1 Sat Aug 15 16:15:20 2026 daemon.notice netifd: 2_1 (21550): udhcpc: broadcasting discover Sat Aug 15 16:15:20 2026 daemon.notice netifd: 2_1 (21550): udhcpc: broadcasting select for 10.0.214.192, server 10.0.214.193 Sat Aug 15 16:15:21 2026 daemon.notice netifd: 2_1 (21550): udhcpc: lease of 10.0.214.192 obtained from 10.0.214.193, lease time 7200 Sat Aug 15 16:15:21 2026 daemon.notice netifd: Interface 'wireguard' is setting up now Sat Aug 15 16:15:21 2026 daemon.notice netifd: Interface '2_1v6' is enabled Sat Aug 15 16:15:21 2026 daemon.notice netifd: Network alias 'wwan0_1' link is up Sat Aug 15 16:15:21 2026 daemon.notice netifd: Interface '2_1v6' has link connectivity Sat Aug 15 16:15:21 2026 daemon.notice netifd: Interface '2_1v6' is setting up now Sat Aug 15 16:15:21 2026 daemon.notice netifd: Interface '2_1' is now up Sat Aug 15 16:15:21 2026 kern.info kernel: [ 3143.797105] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 Sat Aug 15 16:15:21 2026 kern.info kernel: [ 3143.803458] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 Sat Aug 15 16:15:21 2026 user.notice firewall: Reloading firewall due to ifup of 2_1 (wwan0_1) Sat Aug 15 16:15:21 2026 user.notice modem_hotplug: net slot: /devices/virtual/net/wireguard action: add Sat Aug 15 16:15:21 2026 daemon.notice netifd: Interface 'wireguard' is now up Sat Aug 15 16:15:21 2026 daemon.notice netifd: Network device 'wireguard' link is up Sat Aug 15 16:15:21 2026 kern.info kernel: [ 3143.853216] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 Sat Aug 15 16:15:21 2026 kern.info kernel: [ 3143.859974] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 Sat Aug 15 16:15:21 2026 kern.info kernel: [ 3144.397331] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 Sat Aug 15 16:15:28 2026 user.notice mtk_smp: board=bananapi,bpi-r3-mini, wifi_num=2, cpu_num=4, usbnet=1 Sat Aug 15 16:15:28 2026 kern.info kernel: [ 3151.334215] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 Sat Aug 15 16:15:28 2026 user.notice hotplug: QModem WWAN LED: wwan0_1 / Action: ifup set led. Sat Aug 15 16:15:28 2026 user.notice wrtbwmon: Restart for ifup of 2_1 (wwan0_1) Sat Aug 15 16:15:29 2026 user.notice firewall: Reloading firewall due to ifup of wireguard (wireguard) Sat Aug 15 16:15:31 2026 daemon.notice netifd: Interface '2_1v6' is now up Sat Aug 15 16:15:32 2026 daemon.warn odhcpd[4176]: rfc9096: br-lan: piofile updated Sat Aug 15 16:15:38 2026 user.notice mtk_smp: board=bananapi,bpi-r3-mini, wifi_num=2, cpu_num=4, usbnet=1 Sat Aug 15 16:15:38 2026 user.notice wrtbwmon: Restart for ifup of wireguard (wireguard) Sat Aug 15 16:15:38 2026 user.notice firewall: Reloading firewall due to ifup of 2_1v6 (wwan0_1) Sat Aug 15 16:15:47 2026 user.notice mtk_smp: board=bananapi,bpi-r3-mini, wifi_num=2, cpu_num=4, usbnet=1 Sat Aug 15 16:15:48 2026 user.notice hotplug: QModem WWAN LED: wwan0_1 / Action: ifup set led. Sat Aug 15 16:15:48 2026 user.notice wrtbwmon: Restart for ifup of 2_1v6 (wwan0_1) Sat Aug 15 16:16:38 2026 kern.warn kernel: [ 3220.537812] 7986@C01L2,wifi_sys_disconn_act() 1002: wdev_idx=1 Sat Aug 15 16:16:38 2026 kern.notice kernel: [ 3220.545382] 7986@C08L3,hw_ctrl_flow_v2_disconnt_act() 172: wdev_idx=1 Sat Aug 15 16:16:38 2026 kern.warn kernel: [ 3220.552430] 7986@C13L2,MacTableDeleteEntry() 1793: Del Sta:b8:f7:75:77:76:7b Sat Aug 15 16:16:38 2026 kern.notice kernel: [ 3220.559572] 7986@C08L3,ap_peer_deauth_action() 427: AUTH - receive DE-AUTH(seq-13) from b8:f7:75:77:76:7b, reason=1 Sat Aug 15 16:18:18 2026 kern.notice kernel: [ 3321.194388] 7986@C08L3,ap_peer_auth_req_at_idle_action() 713: AUTH - MBSS(1), Rcv AUTH seq#1, Alg=3, Status=126 from [wcid=1023]b8:f7:75:77:76:7b Sat Aug 15 16:18:18 2026 kern.notice kernel: [ 3321.265540] 7986@C08L3,ap_peer_auth_req_at_idle_action() 713: AUTH - MBSS(1), Rcv AUTH seq#2, Alg=3, Status=0 from [wcid=1023]b8:f7:75:77:76:7b Sat Aug 15 16:18:18 2026 kern.debug kernel: [ 3321.278451] entrytb_aid_aquire(): found non-occupied aid:2, allocated from:2 Sat Aug 15 16:18:18 2026 kern.warn kernel: [ 3321.285495] 7986@C13L2,MacTableInsertEntry() 1537: New Sta:b8:f7:75:77:76:7b Sat Aug 15 16:18:18 2026 kern.err kernel: [ 3321.292566] 7986@C08L1,PeerAssocReqCmmSanity() 984: DSCPPolicyEnable = 1 Sat Aug 15 16:18:18 2026 kern.err kernel: [ 3321.299248] 7986@C08L1,PeerAssocReqCmmSanity() 1445: IE_WLAN_EXTENSION: no handler for extension_id:137 Sat Aug 15 16:18:18 2026 kern.notice kernel: [ 3321.308622] 7986@C08L3,ap_cmm_peer_assoc_req_action() 1645: Recv Assoc from STA - b8:f7:75:77:76:7b Sat Aug 15 16:18:18 2026 kern.notice kernel: [ 3321.317931] 7986@C08L3,ap_cmm_peer_assoc_req_action() 2168: ASSOC Send ASSOC response (Status=0)... Sat Aug 15 16:18:18 2026 kern.notice kernel: [ 3321.326991] 7986@C01L3,wifi_sys_conn_act() 1115: wdev idx = 1 Sat Aug 15 16:18:18 2026 kern.notice kernel: [ 3321.333029] 7986@C08L3,hw_ctrl_flow_v2_connt_act() 215: wdev_idx=1 Sat Aug 15 16:18:19 2026 kern.notice kernel: [ 3321.472386] 7986@C15L3,WPABuildPairMsg1() 5278: <=== send Msg1 of 4-way Sat Aug 15 16:18:19 2026 kern.notice kernel: [ 3321.485979] 7986@C15L3,PeerPairMsg2Action() 6197: ===>Receive msg 2 Sat Aug 15 16:18:19 2026 kern.notice kernel: [ 3321.492765] 7986@C15L3,WPABuildPairMsg3() 5555: <=== send Msg3 of 4-way Sat Aug 15 16:18:19 2026 kern.notice kernel: [ 3321.499361] 7986@C15L3,PeerPairMsg4Action() 6627: ===>Receive msg 4 Sat Aug 15 16:18:19 2026 kern.warn kernel: [ 3321.510820] 7986@C15L2,PeerPairMsg4Action() 6982: AP SETKEYS DONE(rax0) - AKMMap=WPA3PSK, PairwiseCipher=AES, GroupCipher=AES, wcid=1 from b8:f7:75:77:76:7b Sat Aug 15 16:18:19 2026 kern.warn kernel: [ 3321.510820] Sat Aug 15 16:19:45 2026 authpriv.info dropbear[29445]: Child connection from 10.100.101.228:58633 Sat Aug 15 16:19:45 2026 authpriv.notice dropbear[29445]: Password auth succeeded for 'root' from 10.100.101.228:58633 === DMESG TAIL === [ 36.979386] WiFi@C23L3,RadarStateCheck() 243: Zero Wait State: 0 [ 36.985380] WiFi@C23L3,operate_loader_phy() 387: oper_cfg: prim_ch(0), ht_bw(1), extcha(1), vht_bw(0), cen_ch_2(0), PhyMode=78! [ 36.996831] phy_freq_adjust : no prim_ch value for adjust! [ 37.002298] WiFi@C23L1,operate_loader_phy() 397: phy_freq_adjust failed! [ 37.002537] WiFi@C00L2,dump_ht_cap() 29: Caller: wlan_operate_init+0xa4/0x148 [mt_wifi] [ 37.017203] wdev_attr_update(): wdevId0 = ee:00:9a:01:27:2b [ 37.022777] WiFi@C12L1,wifi_sys_open() 902: wifi_sys_open():band0 group_idx[0]=0, bw_grp=16 omac=0 [ 37.031729] WiFi@C08L3,hw_ctrl_flow_v2_open() 13: wdev_idx=0 [ 37.037532] WiFi@C23L1,HcGetBandByChannel() 1229: No hdev parking on channel:0, just return a default band_idx 0! [ 37.047881] WiFi@C02L2,AsicRadioOnOffCtrl() 2338: DbdcIdx=0 RadioOn [ 37.054705] WiFi@C00L2,ApAutoChannelAtBootUp() 333: -----------------> [ 37.061307] WiFi@C03L1,MtCmdSetMacTxRx() 10245: (ret = 0) [ 37.066785] WiFi@C03L1,MtCmdSetMacTxRx() 10245: (ret = 0) [ 37.072450] WiFi@C08L1,UpdateBeaconHandler() 1889: wdev(0) bss not ready (state:0, caller:MTAPAutoSelectChannel+0xf4/0x3e8 [mt_wifi])!! [ 37.084678] WiFi@C00L1,mt7986_apply_dpd_flatness_data() 620: eeprom 0x19a bit 0 is 0, do runtime cal [ 37.093792] WiFi@C03L3,MtCmdChannelSwitch() 2534: ctrl_chl=1, ctrl_ch2=0, cent_ch=1 DBDCIdx=0, ChBand=0, BW=0, TXStream=2, RXStream=2, scan(1) [ 37.142238] WiFi@C03L3,MtCmdSetTxRxPath() 2795: ctrl_chl=1, ctrl_ch2=0, cent_ch=1, RxPath=3, BandIdx=0, ChBand=0, BW=0,TXStream=2, RXStream=3, scan(1) [ 37.374302] WiFi@C00L1,mt7986_apply_dpd_flatness_data() 620: eeprom 0x19a bit 0 is 0, do runtime cal [ 37.383413] WiFi@C03L3,MtCmdChannelSwitch() 2534: ctrl_chl=2, ctrl_ch2=0, cent_ch=2 DBDCIdx=0, ChBand=0, BW=0, TXStream=2, RXStream=2, scan(1) [ 37.431857] WiFi@C03L3,MtCmdSetTxRxPath() 2795: ctrl_chl=2, ctrl_ch2=0, cent_ch=2, RxPath=3, BandIdx=0, ChBand=0, BW=0,TXStream=2, RXStream=3, scan(1) [ 37.664295] WiFi@C00L1,mt7986_apply_dpd_flatness_data() 620: eeprom 0x19a bit 0 is 0, do runtime cal [ 37.673405] WiFi@C03L3,MtCmdChannelSwitch() 2534: ctrl_chl=3, ctrl_ch2=0, cent_ch=3 DBDCIdx=0, ChBand=0, BW=0, TXStream=2, RXStream=2, scan(1) [ 37.721841] WiFi@C03L3,MtCmdSetTxRxPath() 2795: ctrl_chl=3, ctrl_ch2=0, cent_ch=3, RxPath=3, BandIdx=0, ChBand=0, BW=0,TXStream=2, RXStream=3, scan(1) [ 37.954311] WiFi@C00L1,mt7986_apply_dpd_flatness_data() 620: eeprom 0x19a bit 0 is 0, do runtime cal [ 37.963428] WiFi@C03L3,MtCmdChannelSwitch() 2534: ctrl_chl=4, ctrl_ch2=0, cent_ch=4 DBDCIdx=0, ChBand=0, BW=0, TXStream=2, RXStream=2, scan(1) [ 38.011866] WiFi@C03L3,MtCmdSetTxRxPath() 2795: ctrl_chl=4, ctrl_ch2=0, cent_ch=4, RxPath=3, BandIdx=0, ChBand=0, BW=0,TXStream=2, RXStream=3, scan(1) [ 38.244309] WiFi@C00L1,mt7986_apply_dpd_flatness_data() 620: eeprom 0x19a bit 0 is 0, do runtime cal [ 38.253423] WiFi@C03L3,MtCmdChannelSwitch() 2534: ctrl_chl=5, ctrl_ch2=0, cent_ch=5 DBDCIdx=0, ChBand=0, BW=0, TXStream=2, RXStream=2, scan(1) [ 38.301876] WiFi@C03L3,MtCmdSetTxRxPath() 2795: ctrl_chl=5, ctrl_ch2=0, cent_ch=5, RxPath=3, BandIdx=0, ChBand=0, BW=0,TXStream=2, RXStream=3, scan(1) [ 38.534304] WiFi@C00L1,mt7986_apply_dpd_flatness_data() 620: eeprom 0x19a bit 0 is 0, do runtime cal [ 38.543417] WiFi@C03L3,MtCmdChannelSwitch() 2534: ctrl_chl=6, ctrl_ch2=0, cent_ch=6 DBDCIdx=0, ChBand=0, BW=0, TXStream=2, RXStream=2, scan(1) [ 38.591863] WiFi@C03L3,MtCmdSetTxRxPath() 2795: ctrl_chl=6, ctrl_ch2=0, cent_ch=6, RxPath=3, BandIdx=0, ChBand=0, BW=0,TXStream=2, RXStream=3, scan(1) [ 38.824289] WiFi@C00L1,mt7986_apply_dpd_flatness_data() 620: eeprom 0x19a bit 0 is 0, do runtime cal [ 38.833398] WiFi@C03L3,MtCmdChannelSwitch() 2534: ctrl_chl=7, ctrl_ch2=0, cent_ch=7 DBDCIdx=0, ChBand=0, BW=0, TXStream=2, RXStream=2, scan(1) [ 38.881784] WiFi@C03L3,MtCmdSetTxRxPath() 2795: ctrl_chl=7, ctrl_ch2=0, cent_ch=7, RxPath=3, BandIdx=0, ChBand=0, BW=0,TXStream=2, RXStream=3, scan(1) [ 38.984539] WiFi@C08L1,UpdateBeaconHandler() 1889: wdev(0) bss not ready (state:0, caller:ApUpdateCapabilityAndErpIe+0x350/0x44c [mt_wifi])!! [ 39.114328] WiFi@C00L1,mt7986_apply_dpd_flatness_data() 620: eeprom 0x19a bit 0 is 0, do runtime cal [ 39.123443] WiFi@C03L3,MtCmdChannelSwitch() 2534: ctrl_chl=8, ctrl_ch2=0, cent_ch=8 DBDCIdx=0, ChBand=0, BW=0, TXStream=2, RXStream=2, scan(1) [ 39.171854] WiFi@C03L3,MtCmdSetTxRxPath() 2795: ctrl_chl=8, ctrl_ch2=0, cent_ch=8, RxPath=3, BandIdx=0, ChBand=0, BW=0,TXStream=2, RXStream=3, scan(1) [ 39.404290] WiFi@C00L1,mt7986_apply_dpd_flatness_data() 620: eeprom 0x19a bit 0 is 0, do runtime cal [ 39.413400] WiFi@C03L3,MtCmdChannelSwitch() 2534: ctrl_chl=9, ctrl_ch2=0, cent_ch=9 DBDCIdx=0, ChBand=0, BW=0, TXStream=2, RXStream=2, scan(1) [ 39.461833] WiFi@C03L3,MtCmdSetTxRxPath() 2795: ctrl_chl=9, ctrl_ch2=0, cent_ch=9, RxPath=3, BandIdx=0, ChBand=0, BW=0,TXStream=2, RXStream=3, scan(1) [ 39.694287] WiFi@C00L1,mt7986_apply_dpd_flatness_data() 620: eeprom 0x19a bit 0 is 0, do runtime cal [ 39.703397] WiFi@C03L3,MtCmdChannelSwitch() 2534: ctrl_chl=10, ctrl_ch2=0, cent_ch=10 DBDCIdx=0, ChBand=0, BW=0, TXStream=2, RXStream=2, scan(1) [ 39.751955] WiFi@C03L3,MtCmdSetTxRxPath() 2795: ctrl_chl=10, ctrl_ch2=0, cent_ch=10, RxPath=3, BandIdx=0, ChBand=0, BW=0,TXStream=2, RXStream=3, scan(1) [ 39.984314] WiFi@C00L1,mt7986_apply_dpd_flatness_data() 620: eeprom 0x19a bit 0 is 0, do runtime cal [ 39.993432] WiFi@C03L3,MtCmdChannelSwitch() 2534: ctrl_chl=11, ctrl_ch2=0, cent_ch=11 DBDCIdx=0, ChBand=0, BW=0, TXStream=2, RXStream=2, scan(1) [ 40.042074] WiFi@C03L3,MtCmdSetTxRxPath() 2795: ctrl_chl=11, ctrl_ch2=0, cent_ch=11, RxPath=3, BandIdx=0, ChBand=0, BW=0,TXStream=2, RXStream=3, scan(1) [ 40.274312] WiFi@C00L1,mt7986_apply_dpd_flatness_data() 620: eeprom 0x19a bit 0 is 0, do runtime cal [ 40.283431] WiFi@C03L3,MtCmdChannelSwitch() 2534: ctrl_chl=12, ctrl_ch2=0, cent_ch=12 DBDCIdx=0, ChBand=0, BW=0, TXStream=2, RXStream=2, scan(1) [ 40.332049] WiFi@C03L3,MtCmdSetTxRxPath() 2795: ctrl_chl=12, ctrl_ch2=0, cent_ch=12, RxPath=3, BandIdx=0, ChBand=0, BW=0,TXStream=2, RXStream=3, scan(1) [ 40.564299] WiFi@C00L1,mt7986_apply_dpd_flatness_data() 620: eeprom 0x19a bit 0 is 0, do runtime cal [ 40.573411] WiFi@C03L3,MtCmdChannelSwitch() 2534: ctrl_chl=13, ctrl_ch2=0, cent_ch=13 DBDCIdx=0, ChBand=0, BW=0, TXStream=2, RXStream=2, scan(1) [ 40.621993] WiFi@C03L3,MtCmdSetTxRxPath() 2795: ctrl_chl=13, ctrl_ch2=0, cent_ch=13, RxPath=3, BandIdx=0, ChBand=0, BW=0,TXStream=2, RXStream=3, scan(1) [ 40.854516] WiFi@C08L1,UpdateBeaconHandler() 1889: wdev(0) bss not ready (state:0, caller:MTAPAutoSelectChannel+0x234/0x3e8 [mt_wifi])!! [ 40.866760] WiFi@C23L3,SelectClearChannelBusyTime() 1880: ==================================================================== [ 40.878153] WiFi@C23L3,SelectClearChannelBusyTime() 1883: Channel 1 : Busy Time = 920, Skip Channel = FALSE, BwCap = TRUE [ 40.889540] WiFi@C23L3,SelectClearChannelBusyTime() 1883: Channel 2 : Busy Time = 579, Skip Channel = FALSE, BwCap = TRUE [ 40.900911] WiFi@C23L3,SelectClearChannelBusyTime() 1883: Channel 3 : Busy Time = 2643, Skip Channel = FALSE, BwCap = TRUE [ 40.912276] WiFi@C23L3,SelectClearChannelBusyTime() 1883: Channel 4 : Busy Time = 4202, Skip Channel = FALSE, BwCap = TRUE [ 40.923642] WiFi@C23L3,SelectClearChannelBusyTime() 1883: Channel 5 : Busy Time = 2975, Skip Channel = FALSE, BwCap = TRUE [ 40.935007] WiFi@C23L3,SelectClearChannelBusyTime() 1883: Channel 6 : Busy Time = 3620, Skip Channel = FALSE, BwCap = TRUE [ 40.946371] WiFi@C23L3,SelectClearChannelBusyTime() 1883: Channel 7 : Busy Time = 25988, Skip Channel = FALSE, BwCap = TRUE [ 40.957735] WiFi@C23L3,SelectClearChannelBusyTime() 1883: Channel 8 : Busy Time = 29935, Skip Channel = FALSE, BwCap = TRUE [ 40.969099] WiFi@C23L3,SelectClearChannelBusyTime() 1883: Channel 9 : Busy Time = 1254, Skip Channel = FALSE, BwCap = TRUE [ 40.980467] WiFi@C23L3,SelectClearChannelBusyTime() 1883: Channel 10 : Busy Time = 915, Skip Channel = FALSE, BwCap = TRUE [ 40.991832] WiFi@C23L3,SelectClearChannelBusyTime() 1883: Channel 11 : Busy Time = 8074, Skip Channel = FALSE, BwCap = TRUE [ 41.003197] WiFi@C23L3,SelectClearChannelBusyTime() 1883: Channel 12 : Busy Time = 1190, Skip Channel = FALSE, BwCap = TRUE [ 41.014562] WiFi@C23L3,SelectClearChannelBusyTime() 1883: Channel 13 : Busy Time = 15715, Skip Channel = FALSE, BwCap = TRUE [ 41.025926] WiFi@C23L3,SelectClearChannelBusyTime() 1889: ==================================================================== [ 41.037300] WiFi@C23L3,SelectClearChannelBusyTime() 2124: Rule 3 Channel Busy time value : Select Primary Channel 2 [ 41.047712] WiFi@C23L3,SelectClearChannelBusyTime() 2126: Rule 3 Channel Busy time value : Min Channel Busy = 579 [ 41.057950] WiFi@C23L3,SelectClearChannelBusyTime() 2128: Rule 3 Channel Busy time value : BW = 20 [ 41.066888] WiFi@C23L3,SelectClearChannelBusyTime() 2166: [SelectClearChannelBusyTime] - band0 END [ 41.075838] WiFi@C23L3,operate_loader_phy() 387: oper_cfg: prim_ch(2), ht_bw(1), extcha(1), vht_bw(0), cen_ch_2(0), PhyMode=78! [ 41.087294] WiFi@C23L3,operate_loader_phy() 402: oper_dev after adjust: bw(1), prim_ch(2), cen_ch_1(4), cen_ch_2(0),ext_cha(1)! [ 41.098755] WiFi@C23L3,operate_loader_phy() 423: oper_radio after decision: bw(1), prim_ch(2), cen_ch_1(4), cen_ch_2(0)! [ 41.109684] WiFi@C00L1,mt7986_apply_dpd_flatness_data() 620: eeprom 0x19a bit 0 is 0, do runtime cal [ 41.118806] WiFi@C03L3,MtCmdChannelSwitch() 2534: ctrl_chl=2, ctrl_ch2=0, cent_ch=4 DBDCIdx=0, ChBand=0, BW=1, TXStream=2, RXStream=2, scan(0) [ 41.272549] WiFi@C03L3,MtCmdSetTxRxPath() 2795: ctrl_chl=2, ctrl_ch2=0, cent_ch=4, RxPath=3, BandIdx=0, ChBand=0, BW=1,TXStream=2, RXStream=3, scan(0) [ 41.286114] WiFi@C12L1,EDCCAInit() 21135: EDCCA compensation: uni_compensation=0, bw_compensation=0, final compensation=0 [ 41.297065] WiFi@C23L1,DfsBuildChannelList() 3663: [RDM]: wdev is not 5G. [ 41.303832] WiFi@C23L3,zero_wait_dfs_switch_ch() 924: outband ch 0, ch_stat 0 [ 41.311204] WiFi@C08L2,APStartUpForMbss() 983: ===>(caller:ap_inf_open+0x10c/0x4c0 [mt_wifi]), mbss_idx:0, CfgMode:0 [ 41.321711] WiFi@C15L2,APPMFInit() 130: [PMF] apidx=0, MFPC=1, MFPR=0, SHA256=0 [ 41.367527] WiFi@C18L3,BuildChannelList() 484: [ 41.372293] WiFi@C00L2,dump_ht_cap() 29: Caller: dump_ht_cap+0x10/0x1c [mt_wifi] [ 41.379905] WiFi@C08L2,ap_link_up() 7166: (caller:wdev_do_linkup+0x20/0x34 [mt_wifi]), wdev(0) [ 41.388505] WiFi@C01L3,wifi_sys_linkup() 1231: wdev idx = 0 [ 41.444740] WiFi@C00L3,wtc_acquire_groupkey_wcid() 81: Found a non-occupied wtbl_idx:543 for WDEV_TYPE:1 [ 41.444740] LinkToOmacIdx = 0, LinkToWdevType = 1 [ 41.459091] WiFi@C08L3,hw_ctrl_flow_v2_link_up() 72: wdev_idx=0 [ 41.479355] WiFi@C08L3,UpdateBeaconHandler() 1910: BCN_UPDATE_INIT, OmacIdx = 0 (ra0) [ 41.487184] WiFi@C08L2,bcn_buf_init() 169: BcnPkt is allocated!, bcn offload=1 [ 41.494404] WiFi@C08L3,UpdateBeaconHandler() 1923: Band0 BcnInitedRnd = 42 [ 41.501381] WiFi@C00L1,TxCCKStreamCtrl() 20601: set wrong parameters [ 41.516216] PrintSrCmd: [ 41.516216] u1CmdSubId = 1, u1ArgNum = 0, u1DbdcIdx = 0, u1Status = 0 [ 41.516216] u1DropTaIdx = 0, u1StaIdx = 0, u4Value = 1 [ 41.530189] PrintSrCmd: [ 41.530189] u1CmdSubId = 5, u1ArgNum = 0, u1DbdcIdx = 0, u1Status = 0 [ 41.530189] u1DropTaIdx = 0, u1StaIdx = 0, u4Value = 0 [ 41.544159] PrintSrCmd: [ 41.544159] u1CmdSubId = 3, u1ArgNum = 0, u1DbdcIdx = 0, u1Status = 0 [ 41.544159] u1DropTaIdx = 0, u1StaIdx = 0, u4Value = 1 [ 41.558128] PrintSrCmd: [ 41.558128] u1CmdSubId = 23, u1ArgNum = 0, u1DbdcIdx = 0, u1Status = 0 [ 41.558128] u1DropTaIdx = 0, u1StaIdx = 0, u4Value = 0 [ 41.572183] PrintSrCmd: [ 41.572183] u1CmdSubId = 31, u1ArgNum = 0, u1DbdcIdx = 0, u1Status = 0 [ 41.572183] u1DropTaIdx = 0, u1StaIdx = 0, u4Value = 0 [ 41.586238] PrintSrCmd: [ 41.586238] u1CmdSubId = 33, u1ArgNum = 0, u1DbdcIdx = 0, u1Status = 0 [ 41.586238] u1DropTaIdx = 0, u1StaIdx = 0, u4Value = 0 [ 41.600303] WiFi@C12L1,EDCCAInit() 21135: EDCCA compensation: uni_compensation=0, bw_compensation=0, final compensation=0 [ 41.611241] WiFi@C03L3,MtCmdTxPwrShowInfo() 13745: ucTxPowerInfoCatg: 2, BandIdx: 0 [ 41.618971] WiFi@C03L3,MtCmdTxPwrShowInfo() 13774: (ret = 0) [ 41.619061] [mtf_txpower_all_rate_info] band_idx:0 pwr:49 ChBand:2G ePAGain:0 [ 41.624630] extif_set_dev(ra0) [ 41.634765] mtk_ppe_dev_register_hook : ineterface ra0 register (1) [ 41.641128] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 41.651926] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 41.700075] br-lan: port 2(ra0) entered blocking state [ 41.705273] br-lan: port 2(ra0) entered disabled state [ 41.710443] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 41.716167] ra0: entered allmulticast mode [ 41.720364] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 41.726279] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 41.731947] ra0: entered promiscuous mode [ 41.736247] br-lan: port 2(ra0) entered blocking state [ 41.741389] br-lan: port 2(ra0) entered forwarding state [ 41.883580] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 41.889362] 7986@C08L2,mbss_virtual_if_open() 133: ===> rax0 [ 41.895189] 7986@C01L2,RTMP_COM_IoctlHandle() 1510: -> CMD_RTPRIV_IOCTL_VIRTUAL_INF_INIT [ 41.903271] 7986@C01L2,RTMP_COM_IoctlHandle() 1487: -> CMD_RTPRIV_IOCTL_VIRTUAL_INF_UP [ 41.911341] WiFi@C01L3,wifi_sys_open() 855: wdev idx = 1 [ 41.917118] 7986@C18L3,BuildChannelList() 484: [ 41.921665] 7986@C00L3,BuildChannelList() 512: BandIdx = 1, PhyMode = 177, ChListNum = 13: [ 41.930006] 7986@C23L3,DfsBuildChannelList() 3708: Done [ 41.935317] 7986@C23L3,RadarStateCheck() 243: Zero Wait State: 0 [ 41.941318] 7986@C23L3,RadarStateCheck() 290:  RD_NORMAL_MODE  [ 41.948154] 7986@C23L3,operate_loader_phy() 387: oper_cfg: prim_ch(36), ht_bw(1), extcha(1), vht_bw(2), cen_ch_2(0), PhyMode=177! [ 41.959845] 7986@C23L3,operate_loader_phy() 402: oper_dev after adjust: bw(3), prim_ch(36), cen_ch_1(50), cen_ch_2(0),ext_cha(1)! [ 41.971545] 7986@C23L3,operate_loader_phy() 423: oper_radio after decision: bw(3), prim_ch(36), cen_ch_1(50), cen_ch_2(0)! [ 41.982738] 7986@C00L1,mt7986_apply_dpd_flatness_data() 620: eeprom 0x19a bit 0 is 0, do runtime cal [ 41.991929] 7986@C03L3,MtCmdChannelSwitch() 2534: ctrl_chl=36, ctrl_ch2=0, cent_ch=50 DBDCIdx=1, ChBand=1, BW=3, TXStream=3, RXStream=3, scan(0) [ 42.246524] 7986@C03L3,MtCmdSetTxRxPath() 2795: ctrl_chl=36, ctrl_ch2=0, cent_ch=50, RxPath=7, BandIdx=1, ChBand=1, BW=3,TXStream=3, RXStream=7, scan(0) [ 42.265295] 7986@C12L1,EDCCAInit() 21135: EDCCA compensation: uni_compensation=0, bw_compensation=0, final compensation=0 [ 42.276610] WiFi@C00L2,dump_ht_cap() 29: Caller: wlan_operate_init+0xa4/0x148 [mt_wifi] [ 42.284678] wdev_attr_update(): wdevId1 = ee:00:9a:11:27:2b [ 42.290299] WiFi@C12L1,wifi_sys_open() 902: wifi_sys_open():band1 group_idx[1]=4, bw_grp=16 omac=0 [ 42.299322] 7986@C08L3,hw_ctrl_flow_v2_open() 13: wdev_idx=1 [ 42.306229] 7986@C02L2,AsicRadioOnOffCtrl() 2338: DbdcIdx=1 RadioOn [ 42.313098] 7986@C00L2,ApAutoChannelAtBootUp() 333: -----------------> [ 42.319640] BcnCheck start after 4200 ms (ra0) [ 42.320096] 7986@C08L1,UpdateBeaconHandler() 1889: wdev(1) bss not ready (state:0, caller:update_ap_qload_to_bcn+0xa8/0xd4 [mt_wifi])!! [ 42.337276] 7986@C03L1,MtCmdSetMacTxRx() 10245: (ret = 0) [ 42.342814] 7986@C03L1,MtCmdSetMacTxRx() 10245: (ret = 0) [ 42.348252] 7986@C00L1,ApAutoChannelAtBootUp() 490: zero-wait DFS is not enabled [ 42.355653] 7986@C08L1,ap_run_at_boot() 622:  ACS is disable !! [ 42.362615] 7986@C08L2,APStartUpForMbss() 983: ===>(caller:ap_inf_open+0x10c/0x4c0 [mt_wifi]), mbss_idx:1, CfgMode:0 [ 42.373176] 7986@C15L2,APPMFInit() 130: [PMF] apidx=1, MFPC=1, MFPR=0, SHA256=0 [ 42.419121] 7986@C18L3,BuildChannelList() 484: [ 42.423958] WiFi@C00L2,dump_ht_cap() 29: Caller: dump_ht_cap+0x10/0x1c [mt_wifi] [ 42.431610] WiFi@C08L2,ap_link_up() 7166: (caller:wdev_do_linkup+0x20/0x34 [mt_wifi]), wdev(1) [ 42.440207] 7986@C01L3,wifi_sys_linkup() 1231: wdev idx = 1 [ 42.496570] 7986@C00L3,wtc_acquire_groupkey_wcid() 81: Found a non-occupied wtbl_idx:542 for WDEV_TYPE:1 [ 42.496570] LinkToOmacIdx = 0, LinkToWdevType = 1 [ 42.510919] 7986@C08L3,hw_ctrl_flow_v2_link_up() 72: wdev_idx=1 [ 42.523627] 7986@C08L3,UpdateBeaconHandler() 1910: BCN_UPDATE_INIT, OmacIdx = 0 (rax0) [ 42.531533] 7986@C08L3,UpdateBeaconHandler() 1923: Band1 BcnInitedRnd = 51 [ 42.549627] PrintSrCmd: [ 42.549627] u1CmdSubId = 1, u1ArgNum = 0, u1DbdcIdx = 1, u1Status = 0 [ 42.549627] u1DropTaIdx = 0, u1StaIdx = 0, u4Value = 1 [ 42.563635] PrintSrCmd: [ 42.563635] u1CmdSubId = 5, u1ArgNum = 0, u1DbdcIdx = 1, u1Status = 0 [ 42.563635] u1DropTaIdx = 0, u1StaIdx = 0, u4Value = 0 [ 42.577617] PrintSrCmd: [ 42.577617] u1CmdSubId = 3, u1ArgNum = 0, u1DbdcIdx = 1, u1Status = 0 [ 42.577617] u1DropTaIdx = 0, u1StaIdx = 0, u4Value = 1 [ 42.591606] PrintSrCmd: [ 42.591606] u1CmdSubId = 23, u1ArgNum = 0, u1DbdcIdx = 1, u1Status = 0 [ 42.591606] u1DropTaIdx = 0, u1StaIdx = 0, u4Value = 0 [ 42.605667] PrintSrCmd: [ 42.605667] u1CmdSubId = 31, u1ArgNum = 0, u1DbdcIdx = 1, u1Status = 0 [ 42.605667] u1DropTaIdx = 0, u1StaIdx = 0, u4Value = 0 [ 42.619728] PrintSrCmd: [ 42.619728] u1CmdSubId = 33, u1ArgNum = 0, u1DbdcIdx = 1, u1Status = 0 [ 42.619728] u1DropTaIdx = 0, u1StaIdx = 0, u4Value = 0 [ 42.633822] 7986@C12L1,EDCCAInit() 21135: EDCCA compensation: uni_compensation=0, bw_compensation=0, final compensation=0 [ 42.644771] 7986@C03L3,MtCmdTxPwrShowInfo() 13745: ucTxPowerInfoCatg: 2, BandIdx: 1 [ 42.652500] 7986@C03L3,MtCmdTxPwrShowInfo() 13774: (ret = 0) [ 42.658152] [mtf_txpower_all_rate_info] band_idx:1 pwr:50 ChBand:5G ePAGain:0 [ 42.665297] mtk_ppe_dev_register_hook : ineterface rax0 register (2) [ 42.671948] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 42.709850] br-lan: port 3(rax0) entered blocking state [ 42.715097] br-lan: port 3(rax0) entered disabled state [ 42.720342] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 42.726050] rax0: entered allmulticast mode [ 42.730328] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 42.736158] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 42.741831] rax0: entered promiscuous mode [ 42.746189] br-lan: port 3(rax0) entered blocking state [ 42.751416] br-lan: port 3(rax0) entered forwarding state [ 43.082063] S90turboacc (5789): drop_caches: 3 [ 45.064074] BcnCheck start after 1700 ms (ra0) [ 45.068540] BcnCheck start after 2600 ms (ra0) [ 47.264902] pci_bus 0000:00: scanning bus [ 47.269590] pci_bus 0000:00: bus scan returning with max=00 [ 47.844060] BcnCheck start after 100 ms (ra0) [ 55.851429] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 55.857588] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 55.864201] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 55.870025] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 55.876489] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 55.882526] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 62.198710] net wwan0: ul_data_aggregation_max_datagrams=11, ul_data_aggregation_max_size=8192, dl_minimum_padding=0 [ 63.892709] net wwan0: link_state 0x0 -> 0x1 [ 63.899749] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 63.905798] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 63.911452] extif_set_dev prefix match (wwan0) [ 63.916051] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 63.924793] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 63.930615] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 63.936349] extif_set_dev prefix match (wwan0_1) [ 64.499401] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 64.505531] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 64.561708] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 64.567970] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 64.954290] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 72.183986] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 72.195690] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 132.233924] 7986@C08L3,ap_peer_auth_req_at_idle_action() 713: AUTH - MBSS(1), Rcv AUTH seq#1, Alg=3, Status=126 from [wcid=1023]b8:f7:75:77:76:7b [ 132.304833] 7986@C08L3,ap_peer_auth_req_at_idle_action() 713: AUTH - MBSS(1), Rcv AUTH seq#2, Alg=3, Status=0 from [wcid=1023]b8:f7:75:77:76:7b [ 132.317728] entrytb_aid_aquire(): found non-occupied aid:2, allocated from:2 [ 132.324765] 7986@C13L2,MacTableInsertEntry() 1537: New Sta:b8:f7:75:77:76:7b [ 132.331835] 7986@C08L1,PeerAssocReqCmmSanity() 984: DSCPPolicyEnable = 1 [ 132.338525] 7986@C08L1,PeerAssocReqCmmSanity() 1445: IE_WLAN_EXTENSION: no handler for extension_id:137 [ 132.347898] 7986@C08L3,ap_cmm_peer_assoc_req_action() 1645: Recv Assoc from STA - b8:f7:75:77:76:7b [ 132.357182] 7986@C08L3,ap_cmm_peer_assoc_req_action() 2168: ASSOC Send ASSOC response (Status=0)... [ 132.366241] 7986@C01L3,wifi_sys_conn_act() 1115: wdev idx = 1 [ 132.372266] 7986@C08L3,hw_ctrl_flow_v2_connt_act() 215: wdev_idx=1 [ 132.496243] 7986@C15L3,WPABuildPairMsg1() 5278: <=== send Msg1 of 4-way [ 132.514198] 7986@C15L3,PeerPairMsg2Action() 6197: ===>Receive msg 2 [ 132.521120] 7986@C15L3,WPABuildPairMsg3() 5555: <=== send Msg3 of 4-way [ 132.527759] 7986@C15L3,PeerPairMsg4Action() 6627: ===>Receive msg 4 [ 132.539218] 7986@C15L2,PeerPairMsg4Action() 6982: AP SETKEYS DONE(rax0) - AKMMap=WPA3PSK, PairwiseCipher=AES, GroupCipher=AES, wcid=1 from b8:f7:75:77:76:7b [ 132.539218] [ 732.342212] WiFi@C15L1,RTMPDeletePMKIDCache() 1245: IF(1), del PMKID CacheIdx=0 [ 3124.225505] net wwan0: link_state 0x1 -> 0x0 [ 3124.234243] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 3124.421124] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 3124.427151] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 3124.432851] extif_put_dev(wwan0) [ 3124.441213] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 3124.464734] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 3124.470444] extif_put_dev(wwan0_1) [ 3124.482745] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 3124.488719] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 3124.600057] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 3124.620005] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 3124.625820] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 3125.123690] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 3125.129960] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 3125.183325] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 3125.189229] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 3143.309030] net wwan0: link_state 0x0 -> 0x1 [ 3143.316085] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 3143.321990] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 3143.327765] extif_set_dev(wwan0) [ 3143.331140] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 3143.337158] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 3143.342957] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 3143.348635] extif_set_dev(wwan0_1) [ 3143.797105] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 3143.803458] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 3143.853216] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 3143.859974] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 3144.397331] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 3151.334215] ppd_dev_setting : now rx dev: eth0, tx dev: eth0 [ 3220.537812] 7986@C01L2,wifi_sys_disconn_act() 1002: wdev_idx=1 [ 3220.545382] 7986@C08L3,hw_ctrl_flow_v2_disconnt_act() 172: wdev_idx=1 [ 3220.552430] 7986@C13L2,MacTableDeleteEntry() 1793: Del Sta:b8:f7:75:77:76:7b [ 3220.559572] 7986@C08L3,ap_peer_deauth_action() 427: AUTH - receive DE-AUTH(seq-13) from b8:f7:75:77:76:7b, reason=1 [ 3321.194388] 7986@C08L3,ap_peer_auth_req_at_idle_action() 713: AUTH - MBSS(1), Rcv AUTH seq#1, Alg=3, Status=126 from [wcid=1023]b8:f7:75:77:76:7b [ 3321.265540] 7986@C08L3,ap_peer_auth_req_at_idle_action() 713: AUTH - MBSS(1), Rcv AUTH seq#2, Alg=3, Status=0 from [wcid=1023]b8:f7:75:77:76:7b [ 3321.278451] entrytb_aid_aquire(): found non-occupied aid:2, allocated from:2 [ 3321.285495] 7986@C13L2,MacTableInsertEntry() 1537: New Sta:b8:f7:75:77:76:7b [ 3321.292566] 7986@C08L1,PeerAssocReqCmmSanity() 984: DSCPPolicyEnable = 1 [ 3321.299248] 7986@C08L1,PeerAssocReqCmmSanity() 1445: IE_WLAN_EXTENSION: no handler for extension_id:137 [ 3321.308622] 7986@C08L3,ap_cmm_peer_assoc_req_action() 1645: Recv Assoc from STA - b8:f7:75:77:76:7b [ 3321.317931] 7986@C08L3,ap_cmm_peer_assoc_req_action() 2168: ASSOC Send ASSOC response (Status=0)... [ 3321.326991] 7986@C01L3,wifi_sys_conn_act() 1115: wdev idx = 1 [ 3321.333029] 7986@C08L3,hw_ctrl_flow_v2_connt_act() 215: wdev_idx=1 [ 3321.472386] 7986@C15L3,WPABuildPairMsg1() 5278: <=== send Msg1 of 4-way [ 3321.485979] 7986@C15L3,PeerPairMsg2Action() 6197: ===>Receive msg 2 [ 3321.492765] 7986@C15L3,WPABuildPairMsg3() 5555: <=== send Msg3 of 4-way [ 3321.499361] 7986@C15L3,PeerPairMsg4Action() 6627: ===>Receive msg 4 [ 3321.510820] 7986@C15L2,PeerPairMsg4Action() 6982: AP SETKEYS DONE(rax0) - AKMMap=WPA3PSK, PairwiseCipher=AES, GroupCipher=AES, wcid=1 from b8:f7:75:77:76:7b [ 3321.510820]