RUTX50 ESM Reject => Requested service option not subscribed

it-mies · December 12, 2024, 2:40pm

Hi!

I’m having issue with random ESM rejects and I have no idea what causes them.
Disabled VoLTE without any change. I’m on latest firmware.

Connection works great, until some random point, it disconnects and URC Event: ESM reject cause => Requested service option not subscribed is logged (see output below).

The connection works most of the time, how can I debug what causes the ESM reject cause?
There is nothing in the logs before it.

I can provide full debug logs if needed.

Logs

6223 Thu Dec 12 16:25:45 2024 daemon.info gsmd[2601]: Modem 2-1 [2c7c:0800] URC Event: ESM reject cause => Requested service option not subscribed
6224 Thu Dec 12 16:28:36 2024 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 IEEE 802.11: authenticated
6225 Thu Dec 12 16:28:36 2024 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 IEEE 802.11: associated (aid 2)
6226 Thu Dec 12 16:28:36 2024 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 IEEE 802.1X: unauthorizing port
6227 Thu Dec 12 16:28:36 2024 daemon.notice hostapd: wlan1-1: STA-OPMODE-SMPS-MODE-CHANGED 78:2b:46:ca:9c:34 off
6228 Thu Dec 12 16:28:36 2024 daemon.notice hostapd: wlan1-1: AP-STA-CONNECTED 78:2b:46:ca:9c:34 auth_alg=open
6229 Thu Dec 12 16:28:36 2024 kern.notice it-lan: WiFi client connected: 78:2B:46:CA:9C:34
6230 Thu Dec 12 16:28:36 2024 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 IEEE 802.1X: authorizing port
6231 Thu Dec 12 16:28:36 2024 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 RADIUS: starting accounting session B3210FE08E69431A
6232 Thu Dec 12 16:28:36 2024 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 WPA: pairwise key handshake completed (RSN)
6233 Thu Dec 12 16:28:36 2024 daemon.notice hostapd: wlan1-1: EAPOL-4WAY-HS-COMPLETED 78:2b:46:ca:9c:34
6234 Thu Dec 12 16:28:38 2024 daemon.info dnsmasq-dhcp[2426]: DHCPREQUEST(br-lan) 10.0.0.169 78:2b:46:ca:9c:34
6235 Thu Dec 12 16:28:38 2024 daemon.info dnsmasq-dhcp[2426]: DHCPACK(br-lan) 10.0.0.169 78:2b:46:ca:9c:34 ultra-win
6236 Thu Dec 12 16:34:18 2024 daemon.notice netifd: mob1s1a1 (13975): Request timed out
6237 Thu Dec 12 16:34:18 2024 daemon.notice netifd: mob1s1a1 (13975): Mobile connection lost!
6238 Thu Dec 12 16:34:18 2024 daemon.notice netifd: Interface ‘mob1s1a1’ has lost the connection
6239 Thu Dec 12 16:34:18 2024 daemon.notice netifd: Network device ‘wwan0’ link is down
6240 Thu Dec 12 16:34:18 2024 daemon.notice netifd: mob1s1a1 (25825): Stopping network mob1s1a1
6241 Thu Dec 12 16:34:18 2024 daemon.notice netifd: Interface ‘mob1s1a1_6’ is now down
6242 Thu Dec 12 16:34:18 2024 daemon.notice netifd: Interface ‘mob1s1a1_6’ has link connectivity loss
6243 Thu Dec 12 16:34:18 2024 daemon.warn dnsmasq[2426]: no servers found in /tmp/resolv.conf.d/resolv.conf.auto, will retry
6244 Thu Dec 12 16:34:18 2024 daemon.notice netifd: mob1s1a1 (25825): Stopping network on /dev/cdc-wdm0!
6245 Thu Dec 12 16:34:18 2024 user.notice netifd: uqmi -s -d /dev/cdc-wdm0 -t 3000 --set-client-id wds,14 --stop-network 0xFFFFFFFF --autoconnect
6246 Thu Dec 12 16:34:18 2024 daemon.notice netifd: Network device ‘qmimux0’ link is down
6247 Thu Dec 12 16:34:18 2024 daemon.notice netifd: Interface ‘mob1s1a1_4’ has link connectivity loss
6248 Thu Dec 12 16:34:18 2024 daemon.notice netifd: Interface ‘mob1s1a1_4’ is disabled
6249 Thu Dec 12 16:34:18 2024 daemon.notice netifd: mob1s1a1 (25825): Command failed: Permission denied
6250 Thu Dec 12 16:34:18 2024 daemon.notice netifd: Interface ‘mob1s1a1’ is now down
6251 Thu Dec 12 16:34:18 2024 daemon.notice netifd: Interface ‘mob1s1a1’ is setting up now
6252 Thu Dec 12 16:34:18 2024 daemon.notice netifd: mob1s1a1_4 (13968): udhcpc: SIOCGIFINDEX: No such device
6253 Thu Dec 12 16:34:18 2024 daemon.notice netifd: mob1s1a1_4 (13968): udhcpc: received SIGTERM
6254 Thu Dec 12 16:34:18 2024 daemon.notice netifd: mob1s1a1_4 (13968): udhcpc: unicasting a release of 176.93.111.64 to 176.93.111.65
6255 Thu Dec 12 16:34:18 2024 daemon.notice netifd: mob1s1a1_4 (13968): udhcpc: sending release
6256 Thu Dec 12 16:34:18 2024 daemon.notice netifd: mob1s1a1_4 (13968): udhcpc: can’t bind to interface qmimux0: No such device
6257 Thu Dec 12 16:34:18 2024 daemon.notice netifd: mob1s1a1_4 (13968): udhcpc: bindtodevice: No such device
6258 Thu Dec 12 16:34:18 2024 daemon.notice netifd: mob1s1a1_4 (13968): udhcpc: entering released state
6259 Thu Dec 12 16:34:18 2024 daemon.notice netifd: mob1s1a1_4 (13968): Command failed: Permission denied
6260 Thu Dec 12 16:34:18 2024 daemon.notice netifd: Interface ‘mob1s1a1_4’ is now down
6261 Thu Dec 12 16:34:19 2024 daemon.notice netifd: mob1s1a1 (25976): wwan[25976] Using wwan usb device on bus 2-1
6262 Thu Dec 12 16:34:19 2024 daemon.notice netifd: mob1s1a1 (25976): wwan[25976] Using proto:qmapv5 device:/dev/cdc-wdm0 iface:wwan0 desc:Quectel RG50X
6263 Thu Dec 12 16:34:19 2024 daemon.info dnsmasq[2426]: read /etc/hosts - 12 names
6264 Thu Dec 12 16:34:19 2024 daemon.info dnsmasq[2426]: read /tmp/hosts/dhcp.cfg01411c - 4 names
6265 Thu Dec 12 16:34:19 2024 daemon.info dnsmasq-dhcp[2426]: read /etc/ethers - 0 addresses
6266 Thu Dec 12 16:34:19 2024 kern.info Mobile data disconnected (internal modem)
6267 Thu Dec 12 16:34:20 2024 daemon.info gsmd[2601]: Modem 2-1 [2c7c:0800] URC Event: ESM reject cause => Requested service option not subscribed
6268 Thu Dec 12 16:34:20 2024 user.notice ddns-scripts[15932]: myddns: pid 15932 terminated by sigterm at 2024-12-12 16:34
6269 Thu Dec 12 16:34:21 2024 user.notice ddns-scripts[26378]: myddns: pid 26378 started at 2024-12-12 16:34
6270 Thu Dec 12 16:34:22 2024 daemon.info dnsmasq[2426]: read /etc/hosts - 12 names
6271 Thu Dec 12 16:34:22 2024 daemon.info dnsmasq[2426]: read /tmp/hosts/dhcp.cfg01411c - 4 names
6272 Thu Dec 12 16:34:22 2024 daemon.info dnsmasq-dhcp[2426]: read /etc/ethers - 0 addresses
6273 Thu Dec 12 16:34:23 2024 user.notice ddns-scripts[26378]: myddns: pid 26378 terminated by sigterm at 2024-12-12 16:34
6274 Thu Dec 12 16:34:24 2024 user.notice ddns-scripts[26956]: myddns: pid 26956 started at 2024-12-12 16:34
6275 Thu Dec 12 16:34:28 2024 daemon.notice hostapd: wlan1-1: AP-STA-DISCONNECTED 78:2b:46:ca:9c:34
6276 Thu Dec 12 16:34:28 2024 kern.notice it-lan: WiFi client disconnected: 78:2B:46:CA:9C:34
6277 Thu Dec 12 16:34:28 2024 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 IEEE 802.1X: unauthorizing port
6278 Thu Dec 12 16:34:28 2024 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 IEEE 802.11: authenticated
6279 Thu Dec 12 16:34:28 2024 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 IEEE 802.11: associated (aid 2)
6280 Thu Dec 12 16:34:28 2024 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 IEEE 802.1X: unauthorizing port
6281 Thu Dec 12 16:34:28 2024 daemon.notice hostapd: wlan1-1: STA-OPMODE-SMPS-MODE-CHANGED 78:2b:46:ca:9c:34 off
6282 Thu Dec 12 16:34:28 2024 daemon.notice hostapd: wlan1-1: AP-STA-CONNECTED 78:2b:46:ca:9c:34 auth_alg=open
6283 Thu Dec 12 16:34:28 2024 kern.notice it-lan: WiFi client connected: 78:2B:46:CA:9C:34
6284 Thu Dec 12 16:34:28 2024 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 IEEE 802.1X: authorizing port
6285 Thu Dec 12 16:34:28 2024 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 RADIUS: starting accounting session 2F4C620D196638E1
6286 Thu Dec 12 16:34:28 2024 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 WPA: pairwise key handshake completed (RSN)
6287 Thu Dec 12 16:34:28 2024 daemon.notice hostapd: wlan1-1: EAPOL-4WAY-HS-COMPLETED 78:2b:46:ca:9c:34
6288 Thu Dec 12 16:34:31 2024 daemon.info dnsmasq-dhcp[2426]: DHCPREQUEST(br-lan) 10.0.0.169 78:2b:46:ca:9c:34
6289 Thu Dec 12 16:34:31 2024 daemon.info dnsmasq-dhcp[2426]: DHCPACK(br-lan) 10.0.0.169 78:2b:46:ca:9c:34 ultra-win
6290 Thu Dec 12 16:34:34 2024 kern.notice IPv4 connectivity started to fail
6291 Thu Dec 12 16:34:35 2024 kern.notice User “admin” successfully authenticated on HTTP from 10.0.0.10 to 10.0.0.1
6292 Thu Dec 12 16:34:35 2024 daemon.err uhttpd[2870]: vuci: accepted login for admin from 10.0.0.10
6293 Thu Dec 12 16:34:35 2024 user.err ddns-scripts[26956]: myddns: BusyBox nslookup error: 1
6294 Thu Dec 12 16:34:37 2024 kern.notice IPv6 connectivity started to fail
6295 Thu Dec 12 16:34:38 2024 daemon.info hostapd: wlan1-1: STA c8:8a:9a:b7:bb:19 IEEE 802.11: authenticated
6296 Thu Dec 12 16:34:38 2024 daemon.info hostapd: wlan1-1: STA c8:8a:9a:b7:bb:19 IEEE 802.11: associated (aid 3)
6297 Thu Dec 12 16:34:38 2024 daemon.info hostapd: wlan1-1: STA c8:8a:9a:b7:bb:19 IEEE 802.1X: unauthorizing port
6298 Thu Dec 12 16:34:38 2024 daemon.notice hostapd: wlan1-1: STA-OPMODE-SMPS-MODE-CHANGED c8:8a:9a:b7:bb:19 off
6299 Thu Dec 12 16:34:38 2024 daemon.notice hostapd: wlan1-1: AP-STA-CONNECTED c8:8a:9a:b7:bb:19 auth_alg=open
6300 Thu Dec 12 16:34:38 2024 kern.notice it-lan: WiFi client connected: C8:8A:9A:B7:BB:19
6301 Thu Dec 12 16:34:38 2024 daemon.info hostapd: wlan1-1: STA c8:8a:9a:b7:bb:19 IEEE 802.1X: authorizing port
6302 Thu Dec 12 16:34:38 2024 daemon.info hostapd: wlan1-1: STA c8:8a:9a:b7:bb:19 RADIUS: starting accounting session 3959EE15F6D6F981
6303 Thu Dec 12 16:34:38 2024 daemon.info hostapd: wlan1-1: STA c8:8a:9a:b7:bb:19 WPA: pairwise key handshake completed (RSN)
6304 Thu Dec 12 16:34:38 2024 daemon.notice hostapd: wlan1-1: EAPOL-4WAY-HS-COMPLETED c8:8a:9a:b7:bb:19
6305 Thu Dec 12 16:34:41 2024 daemon.info dnsmasq-dhcp[2426]: DHCPREQUEST(br-lan) 10.0.0.109 c8:8a:9a:b7:bb:19
6306 Thu Dec 12 16:34:41 2024 daemon.info dnsmasq-dhcp[2426]: DHCPACK(br-lan) 10.0.0.109 c8:8a:9a:b7:bb:19 it-win
6307 Thu Dec 12 16:34:41 2024 user.notice mobile.sh: Received unknown error(1/5): “Unknown error”
6308 Thu Dec 12 16:34:41 2024 user.notice netifd: uqmi -s -d /dev/cdc-wdm0 -t 3000 --set-client-id wds,14 --release-client-id wds
6309 Thu Dec 12 16:34:42 2024 user.notice netifd: uqmi -s -d /dev/cdc-wdm0 -t 3000 --set-client-id wds,15 --stop-network 0xFFFFFFFF --autoconnect
6310 Thu Dec 12 16:34:44 2024 daemon.notice hostapd: wlan1-1: AP-STA-DISCONNECTED 78:2b:46:ca:9c:34
6311 Thu Dec 12 16:34:44 2024 kern.notice it-lan: WiFi client disconnected: 78:2B:46:CA:9C:34
6312 Thu Dec 12 16:34:44 2024 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 IEEE 802.1X: unauthorizing port
6313 Thu Dec 12 16:34:45 2024 user.notice mobile.sh: Received unknown error(1/5): “Unknown error”
6314 Thu Dec 12 16:34:45 2024 user.notice netifd: uqmi -s -d /dev/cdc-wdm0 -t 3000 --set-client-id wds,15 --release-client-id wds
6315 Thu Dec 12 16:34:46 2024 user.err ddns-scripts[26956]: myddns: BusyBox nslookup error: 1
6316 Thu Dec 12 16:34:46 2024 user.warn ddns-scripts[26956]: myddns: Get registered/public IP for itmies.freeddns.org failed - retry 1/0 in 60 seconds
6317 Thu Dec 12 16:34:48 2024 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 IEEE 802.11: authenticated
6318 Thu Dec 12 16:34:48 2024 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 IEEE 802.11: associated (aid 2)
6319 Thu Dec 12 16:34:48 2024 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 IEEE 802.1X: unauthorizing port
6320 Thu Dec 12 16:34:48 2024 daemon.notice hostapd: wlan1-1: STA-OPMODE-SMPS-MODE-CHANGED 78:2b:46:ca:9c:34 off
6321 Thu Dec 12 16:34:48 2024 daemon.notice hostapd: wlan1-1: AP-STA-CONNECTED 78:2b:46:ca:9c:34 auth_alg=open
6322 Thu Dec 12 16:34:48 2024 kern.notice it-lan: WiFi client connected: 78:2B:46:CA:9C:34
6323 Thu Dec 12 16:34:48 2024 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 IEEE 802.1X: authorizing port
6324 Thu Dec 12 16:34:48 2024 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 RADIUS: starting accounting session 81335697F3D16793
6325 Thu Dec 12 16:34:48 2024 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 WPA: pairwise key handshake completed (RSN)
6326 Thu Dec 12 16:34:48 2024 daemon.notice hostapd: wlan1-1: EAPOL-4WAY-HS-COMPLETED 78:2b:46:ca:9c:34
6327 Thu Dec 12 16:34:48 2024 user.notice qmux: mob1s1a1 teardown successful
6328 Thu Dec 12 16:34:49 2024 daemon.notice netifd: mob1s1a1 (25976): Calculated qmimux ifname: qmimux0
6329 Thu Dec 12 16:34:49 2024 user.notice netifd: uqmi -d /dev/cdc-wdm0 --timeout 10000 --set-autoconnect disabled
6330 Thu Dec 12 16:34:50 2024 daemon.notice netifd: mob1s1a1 (25976): Informing driver of raw-ip for wwan0 …
6331 Thu Dec 12 16:34:50 2024 user.notice root: uqmi -d /dev/cdc-wdm0 --timeout 6000 --wda-set-data-format --qos-format 0 --link-layer-protocol raw-ip --endpoint-type hsusb --endpoint-iface-number 4 --ul-protocol qmapv5 --dl-protocol qmapv5 --ul-max-datagrams 11 --ul-datagram-max-size 8192 --dl-max-datagrams 62 --dl-datagram-max-size 31744 --dl-min-padding 0
6332 Thu Dec 12 16:34:50 2024 daemon.info dnsmasq-dhcp[2426]: DHCPREQUEST(br-lan) 10.0.0.169 78:2b:46:ca:9c:34
6333 Thu Dec 12 16:34:50 2024 daemon.info dnsmasq-dhcp[2426]: DHCPACK(br-lan) 10.0.0.169 78:2b:46:ca:9c:34 ultra-win
6334 Thu Dec 12 16:34:50 2024 user.notice netifd: uqmi -d /dev/cdc-wdm0 --timeout 6000 --set-client-id wds,14 --release-client-id wds --modify-profile 3gpp,1 --profile-name 1 --roaming-disallowed-flag no
6335 Thu Dec 12 16:34:50 2024 user.notice netifd: uqmi -d /dev/cdc-wdm0 --timeout 6000 --get-client-id wds
6336 Thu Dec 12 16:34:51 2024 daemon.notice netifd: mob1s1a1 (25976): 14
6337 Thu Dec 12 16:34:51 2024 daemon.notice netifd: mob1s1a1 (25976): cid4: 14
6338 Thu Dec 12 16:34:51 2024 user.notice netifd: uqmi -d /dev/cdc-wdm0 --timeout 6000 --wds-bind-mux-data-port --mux-id 1 --ep-iface-number 4 --set-client-id wds,14
6339 Thu Dec 12 16:34:51 2024 user.notice netifd: uqmi -d /dev/cdc-wdm0 --timeout 6000 --set-ip-family ipv4 --set-client-id wds,14
6340 Thu Dec 12 16:34:51 2024 user.notice netifd: uqmi -d /dev/cdc-wdm0 --timeout 6000 --set-client-id wds,14 --start-network --profile 1 --ip-family ipv4
6341 Thu Dec 12 16:34:51 2024 daemon.notice netifd: mob1s1a1 (25976): pdh4: -1370051104
6342 Thu Dec 12 16:34:51 2024 daemon.notice netifd: mob1s1a1 (25976): -1370051104
6343 Thu Dec 12 16:34:51 2024 user.notice netifd: uqmi -d /dev/cdc-wdm0 --timeout 6000 --get-client-id wds
6344 Thu Dec 12 16:34:51 2024 daemon.notice netifd: mob1s1a1 (25976): 15
6345 Thu Dec 12 16:34:51 2024 daemon.notice netifd: mob1s1a1 (25976): cid6: 15
6346 Thu Dec 12 16:34:51 2024 user.notice netifd: uqmi -d /dev/cdc-wdm0 --timeout 6000 --wds-bind-mux-data-port --mux-id 1 --ep-iface-number 4 --set-client-id wds,15
6347 Thu Dec 12 16:34:51 2024 user.notice netifd: uqmi -d /dev/cdc-wdm0 --timeout 6000 --set-ip-family ipv6 --set-client-id wds,15
6348 Thu Dec 12 16:34:51 2024 user.notice netifd: uqmi -d /dev/cdc-wdm0 --timeout 6000 --set-client-id wds,15 --start-network --ip-family ipv6 --profile 1
6349 Thu Dec 12 16:34:51 2024 daemon.notice netifd: mob1s1a1 (25976): pdh6: -1369603344
6350 Thu Dec 12 16:34:51 2024 daemon.notice netifd: mob1s1a1 (25976): -1369603344
6351 Thu Dec 12 16:34:52 2024 daemon.notice netifd: mob1s1a1 (25976): Setting up qmimux0
6352 Thu Dec 12 16:34:52 2024 daemon.notice netifd: mob1s1a1 (25976): Setting configured MTU: 1500 on qmimux0
6353 Thu Dec 12 16:34:52 2024 daemon.warn dnsmasq[2426]: failed to create listening socket for fe80::ec0a:9ee1:884c:d101%wwan0: Address in use
6354 Thu Dec 12 16:34:52 2024 daemon.notice netifd: Interface ‘mob1s1a1’ is now up
6355 Thu Dec 12 16:34:52 2024 daemon.notice netifd: Network device ‘wwan0’ link is up
6356 Thu Dec 12 16:34:52 2024 daemon.notice netifd: mob1s1a1 (25976): Setting up qmimux0 V4 DCHP
6357 Thu Dec 12 16:34:52 2024 daemon.notice netifd: Interface ‘mob1s1a1_4’ is enabled
6358 Thu Dec 12 16:34:52 2024 daemon.notice netifd: Network device ‘qmimux0’ link is up
6359 Thu Dec 12 16:34:52 2024 daemon.notice netifd: Interface ‘mob1s1a1_4’ has link connectivity
6360 Thu Dec 12 16:34:52 2024 daemon.notice netifd: Interface ‘mob1s1a1_4’ is setting up now
6361 Thu Dec 12 16:34:52 2024 daemon.notice netifd: mob1s1a1 (25976): Setting up qmimux0 V6 static
6362 Thu Dec 12 16:34:52 2024 daemon.notice netifd: mob1s1a1 (25976): {
6363 Thu Dec 12 16:34:52 2024 daemon.notice netifd: mob1s1a1 (25976): “pdp-type”: “ipv4v6”,
6364 Thu Dec 12 16:34:52 2024 daemon.notice netifd: mob1s1a1 (25976): “ip-family”: “ipv6”,
6365 Thu Dec 12 16:34:52 2024 daemon.notice netifd: mob1s1a1 (25976): “mtu”: 1500,
6366 Thu Dec 12 16:34:52 2024 daemon.notice netifd: mob1s1a1 (25976): “ipv4”: {
6367 Thu Dec 12 16:34:52 2024 daemon.notice netifd: mob1s1a1 (25976):
6368 Thu Dec 12 16:34:52 2024 daemon.notice netifd: mob1s1a1 (25976): },
6369 Thu Dec 12 16:34:52 2024 daemon.notice netifd: mob1s1a1 (25976): “ipv6”: {
6370 Thu Dec 12 16:34:52 2024 daemon.notice netifd: mob1s1a1 (25976): “ip”: “2001:14bb:6d4:c962:24df:490c:5696:a2cd”,
6371 Thu Dec 12 16:34:52 2024 daemon.notice netifd: mob1s1a1 (25976): “ip-prefix-length”: 64,
6372 Thu Dec 12 16:34:52 2024 daemon.notice netifd: mob1s1a1 (25976): “gateway”: “2001:14bb:6d4:c962:dd85:e41f:3765:217c”,
6373 Thu Dec 12 16:34:52 2024 daemon.notice netifd: mob1s1a1 (25976): “gw-prefix-length”: 64,
6374 Thu Dec 12 16:34:52 2024 daemon.notice netifd: mob1s1a1 (25976): “dns1”: “2001:14b8:1000::1”,
6375 Thu Dec 12 16:34:52 2024 daemon.notice netifd: mob1s1a1 (25976): “dns2”: “2001:14b8:1000::2”
6376 Thu Dec 12 16:34:52 2024 daemon.notice netifd: mob1s1a1 (25976): },
6377 Thu Dec 12 16:34:52 2024 daemon.notice netifd: mob1s1a1 (25976): “domain-names”: {
6378 Thu Dec 12 16:34:52 2024 daemon.notice netifd: mob1s1a1 (25976):
6379 Thu Dec 12 16:34:52 2024 daemon.notice netifd: mob1s1a1 (25976): }
6380 Thu Dec 12 16:34:52 2024 daemon.notice netifd: mob1s1a1 (25976): }
6381 Thu Dec 12 16:34:52 2024 daemon.notice netifd: mob1s1a1 (25976): uci: Entry not found
6382 Thu Dec 12 16:34:52 2024 daemon.notice netifd: Interface ‘mob1s1a1_6’ is enabled
6383 Thu Dec 12 16:34:52 2024 daemon.notice netifd: Interface ‘mob1s1a1_6’ is setting up now
6384 Thu Dec 12 16:34:52 2024 daemon.notice netifd: Interface ‘mob1s1a1_6’ is now up
6385 Thu Dec 12 16:34:52 2024 daemon.notice netifd: Interface ‘mob1s1a1_6’ has link connectivity
6386 Thu Dec 12 16:34:52 2024 daemon.info dnsmasq[2426]: reading /tmp/resolv.conf.d/resolv.conf.auto
6387 Thu Dec 12 16:34:52 2024 daemon.info dnsmasq[2426]: using nameserver 2001:14b8:1000::1#53
6388 Thu Dec 12 16:34:52 2024 daemon.info dnsmasq[2426]: using nameserver 2001:14b8:1000::2#53
6389 Thu Dec 12 16:34:52 2024 daemon.info dnsmasq[2426]: using only locally-known addresses for test
6390 Thu Dec 12 16:34:52 2024 daemon.info dnsmasq[2426]: using only locally-known addresses for onion
6391 Thu Dec 12 16:34:52 2024 daemon.info dnsmasq[2426]: using only locally-known addresses for localhost
6392 Thu Dec 12 16:34:52 2024 daemon.info dnsmasq[2426]: using only locally-known addresses for local
6393 Thu Dec 12 16:34:52 2024 daemon.info dnsmasq[2426]: using only locally-known addresses for invalid
6394 Thu Dec 12 16:34:52 2024 daemon.info dnsmasq[2426]: using only locally-known addresses for bind
6395 Thu Dec 12 16:34:52 2024 daemon.info dnsmasq[2426]: using only locally-known addresses for lan
6396 Thu Dec 12 16:34:52 2024 daemon.notice netifd: mob1s1a1_4 (27920): udhcpc: started, v1.34.1
6397 Thu Dec 12 16:34:52 2024 daemon.notice netifd: mob1s1a1_4 (27920): udhcpc: broadcasting discover
6398 Thu Dec 12 16:34:52 2024 daemon.notice netifd: mob1s1a1_4 (27920): udhcpc: broadcasting select for 178.55.204.144, server 178.55.204.145
6399 Thu Dec 12 16:34:52 2024 user.notice firewall: Reloading firewall due to ifup of mob1s1a1 (wwan0)
6400 Thu Dec 12 16:34:52 2024 daemon.notice netifd: mob1s1a1_4 (27920): udhcpc: lease of 178.55.204.144 obtained from 178.55.204.145, lease time 7200
6401 Thu Dec 12 16:34:52 2024 daemon.notice netifd: Interface ‘mob1s1a1_4’ is now up
6402 Thu Dec 12 16:34:52 2024 daemon.info dnsmasq[2426]: reading /tmp/resolv.conf.d/resolv.conf.auto
6403 Thu Dec 12 16:34:52 2024 daemon.info dnsmasq[2426]: using nameserver 62.241.198.245#53
6404 Thu Dec 12 16:34:52 2024 daemon.info dnsmasq[2426]: using nameserver 62.241.198.246#53
6405 Thu Dec 12 16:34:52 2024 daemon.info dnsmasq[2426]: using nameserver 2001:14b8:1000::1#53
6406 Thu Dec 12 16:34:52 2024 daemon.info dnsmasq[2426]: using nameserver 2001:14b8:1000::2#53
6407 Thu Dec 12 16:34:52 2024 daemon.info dnsmasq[2426]: using only locally-known addresses for test
6408 Thu Dec 12 16:34:52 2024 daemon.info dnsmasq[2426]: using only locally-known addresses for onion
6409 Thu Dec 12 16:34:52 2024 daemon.info dnsmasq[2426]: using only locally-known addresses for localhost
6410 Thu Dec 12 16:34:52 2024 daemon.info dnsmasq[2426]: using only locally-known addresses for local
6411 Thu Dec 12 16:34:52 2024 daemon.info dnsmasq[2426]: using only locally-known addresses for invalid
6412 Thu Dec 12 16:34:52 2024 daemon.info dnsmasq[2426]: using only locally-known addresses for bind
6413 Thu Dec 12 16:34:52 2024 daemon.info dnsmasq[2426]: using only locally-known addresses for lan
6414 Thu Dec 12 16:34:53 2024 daemon.notice hostapd: wlan1-1: AP-STA-DISCONNECTED c8:8a:9a:b7:bb:19
6415 Thu Dec 12 16:34:53 2024 kern.notice it-lan: WiFi client disconnected: C8:8A:9A:B7:BB:19
6416 Thu Dec 12 16:34:53 2024 daemon.info hostapd: wlan1-1: STA c8:8a:9a:b7:bb:19 IEEE 802.1X: unauthorizing port
6417 Thu Dec 12 16:34:54 2024 daemon.info dnsmasq[2426]: read /etc/hosts - 12 names
6418 Thu Dec 12 16:34:54 2024 daemon.info dnsmasq[2426]: read /tmp/hosts/dhcp.cfg01411c - 4 names
6419 Thu Dec 12 16:34:54 2024 daemon.info dnsmasq-dhcp[2426]: read /etc/ethers - 0 addresses
6420 Thu Dec 12 16:34:55 2024 kern.notice DNS resolution started to fail
6421 Thu Dec 12 16:34:55 2024 user.notice ddns-scripts[26956]: myddns: pid 26956 terminated by sigterm at 2024-12-12 16:34
6422 Thu Dec 12 16:34:56 2024 user.notice firewall: Reloading firewall due to ifup of mob1s1a1_6 (qmimux0)
6423 Thu Dec 12 16:34:56 2024 user.notice ddns-scripts[28556]: myddns: pid 28556 started at 2024-12-12 16:34
6424 Thu Dec 12 16:34:58 2024 kern.info Mobile data connected (internal modem)
6425 Thu Dec 12 16:34:58 2024 kern.info Joined 5G-NSA network (internal modem)
6426 Thu Dec 12 16:34:58 2024 kern.info Connected to DNA DNA operator (internal modem)
6427 Thu Dec 12 16:34:58 2024 user.notice ddns-scripts[28556]: myddns: pid 28556 terminated by sigterm at 2024-12-12 16:34
6428 Thu Dec 12 16:34:59 2024 user.notice firewall: Reloading firewall due to ifup of mob1s1a1_4 (qmimux0)
6429 Thu Dec 12 16:35:00 2024 user.notice ddns-scripts[29050]: myddns: pid 29050 started at 2024-12-12 16:35
6430 Thu Dec 12 16:35:02 2024 daemon.info dnsmasq[2426]: read /etc/hosts - 12 names
6431 Thu Dec 12 16:35:02 2024 daemon.info dnsmasq[2426]: read /tmp/hosts/dhcp.cfg01411c - 4 names
6432 Thu Dec 12 16:35:02 2024 daemon.info dnsmasq-dhcp[2426]: read /etc/ethers - 0 addresses
6433 Thu Dec 12 16:35:02 2024 kern.info Mobile data connected (internal modem)
6434 Thu Dec 12 16:35:02 2024 kern.info Joined 5G-NSA network (internal modem)
6435 Thu Dec 12 16:35:02 2024 kern.info Connected to DNA DNA operator (internal modem)

		esm_error: 33,
		esm_error_enum: 8,

Marija · December 13, 2024, 6:17am

Hello,

I recommend navigating to Network → WAN → Mobile Interface → Edit in the WebUI and manually setting the APN. Then, check if the issue persists.

You can find more information about ESM/EMM reject causes on this website: LTE Release Causes.

Please let me know how it goes!

Best regards,

it-mies · December 13, 2024, 9:45am

I’ve been using manual APN already for public IP address according to the operator instructions.

What can cause the sudden rejection? If the network has been working for hours, then suddenly it rejects and disconnects. Without any modifications to the settings? It automatically reconnects and continues to work for some time.

This device has already been in warranty for similiar issues, but this time the error is different.

Marija · December 13, 2024, 10:34am

I have sent you a form to fill out. Once completed, I will contact you privately regarding the troubleshoot file. Please use the ticket ID “11012”.

Best regards,

it-mies · January 11, 2025, 4:46pm

I sent the debug file in december but have not yet received a response.

The problem still persist and just now got a bigger issue where the modem is unreachable.
Here’s the log:

Logs

12334 Sat Jan 11 18:26:45 2025 daemon.info gsmd[2051]: Modem 2-1 [2c7c:0800] URC Event: ESM reject cause => Requested service option not subscribed
12335 Sat Jan 11 18:26:55 2025 daemon.info hostapd: wlan0-1: STA 00:15:27:c9:2a:df IEEE 802.11: deauthenticated due to inactivity (timer DEAUTH/REMOVE)
12336 Sat Jan 11 18:31:24 2025 kern.info kernel: [184116.955563] usb 2-1: USB disconnect, device number 19
12337 Sat Jan 11 18:31:24 2025 kern.info kernel: [184116.955993] option1 ttyUSB0: GSM modem (1-port) converter now disconnected from ttyUSB0
12338 Sat Jan 11 18:31:24 2025 kern.info kernel: [184116.959919] option 2-1:1.0: device disconnected
12339 Sat Jan 11 18:31:24 2025 kern.info kernel: [184116.968447] option1 ttyUSB1: GSM modem (1-port) converter now disconnected from ttyUSB1
12340 Sat Jan 11 18:31:24 2025 kern.info kernel: [184116.972638] option 2-1:1.1: device disconnected
12341 Sat Jan 11 18:31:24 2025 kern.info kernel: [184116.982865] option1 ttyUSB2: GSM modem (1-port) converter now disconnected from ttyUSB2
12342 Sat Jan 11 18:31:24 2025 kern.info kernel: [184116.985326] option 2-1:1.2: device disconnected
12343 Sat Jan 11 18:31:24 2025 kern.info kernel: [184116.994372] option1 ttyUSB3: GSM modem (1-port) converter now disconnected from ttyUSB3
12344 Sat Jan 11 18:31:24 2025 kern.info kernel: [184117.000894] option 2-1:1.3: device disconnected
12345 Sat Jan 11 18:31:24 2025 daemon.notice netifd: Network device ‘qmimux0’ link is down
12346 Sat Jan 11 18:31:24 2025 daemon.notice netifd: Interface ‘mob1s1a1_4’ has link connectivity loss
12347 Sat Jan 11 18:31:24 2025 daemon.notice netifd: Interface ‘mob1s1a1_6’ has link connectivity loss
12348 Sat Jan 11 18:31:24 2025 daemon.notice netifd: Interface ‘mob1s1a1_6’ is now down
12349 Sat Jan 11 18:31:24 2025 daemon.warn dnsmasq[1898]: no servers found in /tmp/resolv.conf.d/resolv.conf.auto, will retry
12350 Sat Jan 11 18:31:24 2025 user.warn kernel: [184117.040012] [01-serial-symlink.sh] New device ttyUSB0 at /devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1/2-1:1.0/ttyUSB0/tty/ttyUSB0 appeared!
12351 Sat Jan 11 18:31:24 2025 kern.info kernel: [184117.156503] qmi_wwan 2-1:1.4 wwan0: unregister ‘qmi_wwan’ usb-xhci-hcd.0.auto-1, WWAN/QMI device
12352 Sat Jan 11 18:31:25 2025 daemon.info gsmd[2051]: [__write:1300] warning: [CMM] Write to 2-1 [2c7c:0800] modem failed: errno 5
12353 Sat Jan 11 18:31:25 2025 daemon.info gsmd[2051]: [common_write_handle:224] warning: [CMM] Failed to send command (0/11 bytes transferred) to 2-1 [2c7c:0800] modem!
12354 Sat Jan 11 18:31:25 2025 daemon.info gsmd[2051]: [__write:1300] warning: [CMM] Write to 2-1 [2c7c:0800] modem failed: errno 5
12355 Sat Jan 11 18:31:25 2025 daemon.info gsmd[2051]: [common_write_handle:224] warning: [CMM] Failed to send command (0/11 bytes transferred) to 2-1 [2c7c:0800] modem!
12356 Sat Jan 11 18:31:25 2025 daemon.info gsmd[2051]: [__write:1300] warning: [CMM] Write to 2-1 [2c7c:0800] modem failed: errno 5
12357 Sat Jan 11 18:31:25 2025 daemon.info gsmd[2051]: [common_write_handle:224] warning: [CMM] Failed to send command (0/11 bytes transferred) to 2-1 [2c7c:0800] modem!
12358 Sat Jan 11 18:31:25 2025 daemon.info gsmd[2051]: [__write:1300] warning: [CMM] Write to 2-1 [2c7c:0800] modem failed: errno 5
12359 Sat Jan 11 18:31:25 2025 daemon.info gsmd[2051]: [common_write_handle:224] warning: [CMM] Failed to send command (0/11 bytes transferred) to 2-1 [2c7c:0800] modem!
12360 Sat Jan 11 18:31:25 2025 daemon.info gsmd[2051]: [__write:1300] warning: [CMM] Write to 2-1 [2c7c:0800] modem failed: errno 5
12361 Sat Jan 11 18:31:25 2025 daemon.info gsmd[2051]: [common_write_handle:224] warning: [CMM] Failed to send command (0/11 bytes transferred) to 2-1 [2c7c:0800] modem!
12362 Sat Jan 11 18:31:25 2025 daemon.info gsmd[2051]: [__write:1300] warning: [CMM] Write to 2-1 [2c7c:0800] modem failed: errno 5
12363 Sat Jan 11 18:31:25 2025 daemon.info gsmd[2051]: [common_write_handle:224] warning: [CMM] Failed to send command (0/11 bytes transferred) to 2-1 [2c7c:0800] modem!
12364 Sat Jan 11 18:31:25 2025 daemon.info gsmd[2051]: [__write:1300] warning: [CMM] Write to 2-1 [2c7c:0800] modem failed: errno 5
12365 Sat Jan 11 18:31:25 2025 daemon.info gsmd[2051]: [common_write_handle:224] warning: [CMM] Failed to send command (0/11 bytes transferred) to 2-1 [2c7c:0800] modem!
12366 Sat Jan 11 18:31:25 2025 daemon.info gsmd[2051]: [__write:1300] warning: [CMM] Write to 2-1 [2c7c:0800] modem failed: errno 5
12367 Sat Jan 11 18:31:25 2025 daemon.info gsmd[2051]: [common_write_handle:224] warning: [CMM] Failed to send command (0/11 bytes transferred) to 2-1 [2c7c:0800] modem!
12368 Sat Jan 11 18:31:25 2025 daemon.info gsmd[2051]: [__write:1300] warning: [CMM] Write to 2-1 [2c7c:0800] modem failed: errno 5
12369 Sat Jan 11 18:31:25 2025 daemon.info gsmd[2051]: [common_write_handle:224] warning: [CMM] Failed to send command (0/11 bytes transferred) to 2-1 [2c7c:0800] modem!
12370 Sat Jan 11 18:31:25 2025 daemon.info gsmd[2051]: [__write:1300] warning: [CMM] Write to 2-1 [2c7c:0800] modem failed: errno 5
12371 Sat Jan 11 18:31:25 2025 daemon.info gsmd[2051]: [common_write_handle:224] warning: [CMM] Failed to send command (0/11 bytes transferred) to 2-1 [2c7c:0800] modem!
12372 Sat Jan 11 18:31:25 2025 user.warn kernel: [184117.359741] [01-serial-symlink.sh] New device ttyUSB1 at /devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1/2-1:1.1/ttyUSB1/tty/ttyUSB1 appeared!
12373 Sat Jan 11 18:31:25 2025 daemon.notice netifd: Interface ‘mob1s1a1_4’ is disabled
12374 Sat Jan 11 18:31:25 2025 user.warn kernel: [184117.647383] [01-serial-symlink.sh] New device ttyUSB2 at /devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1/2-1:1.2/ttyUSB2/tty/ttyUSB2 appeared!
12375 Sat Jan 11 18:31:25 2025 daemon.notice netifd: Network device ‘wwan0’ link is down
12376 Sat Jan 11 18:31:25 2025 kern.info Mobile data disconnected (internal modem)
12377 Sat Jan 11 18:31:25 2025 user.warn kernel: [184117.852358] [01-serial-symlink.sh] New device ttyUSB3 at /devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1/2-1:1.3/ttyUSB3/tty/ttyUSB3 appeared!
12378 Sat Jan 11 18:31:25 2025 daemon.notice netifd: mob1s1a1_4 (5444): udhcpc: SIOCGIFINDEX: No such device
12379 Sat Jan 11 18:31:25 2025 daemon.notice netifd: mob1s1a1_4 (5444): udhcpc: received SIGTERM
12380 Sat Jan 11 18:31:25 2025 daemon.notice netifd: mob1s1a1_4 (5444): udhcpc: unicasting a release of 178.55.176.173 to 178.55.176.174
12381 Sat Jan 11 18:31:25 2025 daemon.notice netifd: mob1s1a1_4 (5444): udhcpc: sending release
12382 Sat Jan 11 18:31:25 2025 daemon.notice netifd: mob1s1a1_4 (5444): udhcpc: can’t bind to interface qmimux0: No such device
12383 Sat Jan 11 18:31:25 2025 daemon.notice netifd: mob1s1a1_4 (5444): udhcpc: bindtodevice: No such device
12384 Sat Jan 11 18:31:25 2025 daemon.notice netifd: mob1s1a1_4 (5444): udhcpc: entering released state
12385 Sat Jan 11 18:31:25 2025 daemon.notice netifd: mob1s1a1_4 (5444): Command failed: Permission denied
12386 Sat Jan 11 18:31:25 2025 daemon.notice netifd: mob1s1a1 (25121): Stopping network mob1s1a1
12387 Sat Jan 11 18:31:25 2025 daemon.notice netifd: Interface ‘mob1s1a1_4’ is now down
12388 Sat Jan 11 18:31:25 2025 daemon.notice netifd: mob1s1a1 (25121): Command failed: Not found
12389 Sat Jan 11 18:31:25 2025 daemon.notice netifd: mob1s1a1 (25121): Stopping network on /dev/cdc-wdm0!
12390 Sat Jan 11 18:31:25 2025 daemon.notice netifd: mob1s1a1 (25121): Command failed: Not found
12391 Sat Jan 11 18:31:25 2025 user.notice netifd: uqmi -s -d /dev/cdc-wdm0 -t 3000 --set-client-id wds,14 --stop-network 0xFFFFFFFF --autoconnect
12392 Sat Jan 11 18:31:25 2025 daemon.notice netifd: mob1s1a1 (25121): Command failed: Permission denied
12393 Sat Jan 11 18:31:25 2025 daemon.notice netifd: Interface ‘mob1s1a1’ is now down
12394 Sat Jan 11 18:31:25 2025 daemon.notice netifd: Interface ‘mob1s1a1’ is setting up now
12395 Sat Jan 11 18:31:26 2025 daemon.info gsmd[2051]: [__write:1300] warning: [CMM] Write to 2-1 [2c7c:0800] modem failed: errno 5
12396 Sat Jan 11 18:31:26 2025 daemon.info gsmd[2051]: [common_write_handle:224] warning: [CMM] Failed to send command (0/11 bytes transferred) to 2-1 [2c7c:0800] modem!
12397 Sat Jan 11 18:31:26 2025 user.notice netifd: uqmi -s -d /dev/cdc-wdm0 -t 3000 --set-client-id wds,14 --release-client-id wds
12398 Sat Jan 11 18:31:26 2025 daemon.notice netifd: mob1s1a1 (25209): wwan[25209] Searching for a valid wwan usb device…
12399 Sat Jan 11 18:31:26 2025 user.notice ddns-scripts[7352]: myddns: pid 7352 terminated by sigterm at 2025-01-11 18:31
12400 Sat Jan 11 18:31:26 2025 daemon.notice netifd: mob1s1a1 (25285): Stopping network mob1s1a1
12401 Sat Jan 11 18:31:26 2025 daemon.notice netifd: mob1s1a1 (25285): Command failed: Not found
12402 Sat Jan 11 18:31:26 2025 daemon.notice netifd: mob1s1a1 (25285): Command failed: Not found
12403 Sat Jan 11 18:31:26 2025 daemon.notice netifd: mob1s1a1 (25285): Command failed: Permission denied
12404 Sat Jan 11 18:31:26 2025 daemon.notice netifd: Interface ‘mob1s1a1’ is now down
12405 Sat Jan 11 18:31:27 2025 user.notice ddns-scripts[25364]: myddns: pid 25364 started at 2025-01-11 18:31
12406 Sat Jan 11 18:31:28 2025 daemon.info dnsmasq[1898]: read /etc/hosts - 12 names
12407 Sat Jan 11 18:31:28 2025 daemon.info dnsmasq[1898]: read /tmp/hosts/dhcp.cfg01411c - 4 names
12408 Sat Jan 11 18:31:28 2025 daemon.info dnsmasq-dhcp[1898]: read /etc/ethers - 0 addresses
12409 Sat Jan 11 18:31:28 2025 kern.info Mobile data disconnected (internal modem)
12410 Sat Jan 11 18:31:28 2025 user.notice netifd: uqmi -s -d /dev/cdc-wdm0 -t 3000 --set-client-id wds,15 --stop-network 0xFFFFFFFF --autoconnect
12411 Sat Jan 11 18:31:29 2025 user.notice netifd: uqmi -s -d /dev/cdc-wdm0 -t 3000 --set-client-id wds,15 --release-client-id wds
12412 Sat Jan 11 18:31:29 2025 user.notice ddns-scripts[25364]: myddns: pid 25364 terminated by sigterm at 2025-01-11 18:31
12413 Sat Jan 11 18:31:30 2025 user.notice ddns-scripts[26082]: myddns: pid 26082 started at 2025-01-11 18:31
12414 Sat Jan 11 18:31:31 2025 user.notice qmux: mob1s1a1 teardown successful
12415 Sat Jan 11 18:31:32 2025 user.notice qmux: mob1s1a1 teardown successful
12416 Sat Jan 11 18:31:34 2025 kern.info kernel: [184127.036563] usb 2-1: new SuperSpeed Gen 1 USB device number 20 using xhci-hcd
12417 Sat Jan 11 18:31:34 2025 kern.info kernel: [184127.203360] option 2-1:1.0: GSM modem (1-port) converter detected
12418 Sat Jan 11 18:31:34 2025 kern.info kernel: [184127.203742] usb 2-1: GSM modem (1-port) converter now attached to ttyUSB0
12419 Sat Jan 11 18:31:34 2025 kern.info kernel: [184127.209565] option 2-1:1.1: GSM modem (1-port) converter detected
12420 Sat Jan 11 18:31:34 2025 kern.info kernel: [184127.215695] usb 2-1: GSM modem (1-port) converter now attached to ttyUSB1
12421 Sat Jan 11 18:31:34 2025 kern.info kernel: [184127.222419] option 2-1:1.2: GSM modem (1-port) converter detected
12422 Sat Jan 11 18:31:34 2025 kern.info kernel: [184127.228858] usb 2-1: GSM modem (1-port) converter now attached to ttyUSB2
12423 Sat Jan 11 18:31:34 2025 kern.info kernel: [184127.235359] option 2-1:1.3: GSM modem (1-port) converter detected
12424 Sat Jan 11 18:31:34 2025 kern.info kernel: [184127.241923] usb 2-1: GSM modem (1-port) converter now attached to ttyUSB3
12425 Sat Jan 11 18:31:34 2025 kern.info kernel: [184127.265192] qmi_wwan 2-1:1.4: cdc-wdm0: USB WDM device
12426 Sat Jan 11 18:31:34 2025 kern.warn kernel: [184127.265440] QMI_WWAN: extending urb size to 31744
12427 Sat Jan 11 18:31:35 2025 kern.info kernel: [184127.272030] qmi_wwan 2-1:1.4 wwan0: register ‘qmi_wwan’ at usb-xhci-hcd.0.auto-1, WWAN/QMI device, 6e:aa:e3:2d:4a:de
12428 Sat Jan 11 18:31:35 2025 user.warn kernel: [184127.305559] [01-serial-symlink.sh] New device ttyUSB0 at /devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1/2-1:1.0/ttyUSB0/tty/ttyUSB0 appeared!
12429 Sat Jan 11 18:31:35 2025 user.warn kernel: [184127.461032] [01-serial-symlink.sh] New device ttyUSB1 at /devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1/2-1:1.1/ttyUSB1/tty/ttyUSB1 appeared!
12430 Sat Jan 11 18:31:35 2025 user.warn kernel: [184127.616393] [01-serial-symlink.sh] New device ttyUSB2 at /devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1/2-1:1.2/ttyUSB2/tty/ttyUSB2 appeared!
12431 Sat Jan 11 18:31:35 2025 user.warn kernel: [184127.772729] [01-serial-symlink.sh] New device ttyUSB3 at /devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1/2-1:1.3/ttyUSB3/tty/ttyUSB3 appeared!
12432 Sat Jan 11 18:31:36 2025 daemon.notice hostapd: wlan1-1: AP-STA-DISCONNECTED 78:2b:46:ca:9c:34
12433 Sat Jan 11 18:31:36 2025 kern.notice it-lan: WiFi client disconnected: 78:2B:46:CA:9C:34
12434 Sat Jan 11 18:31:36 2025 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 IEEE 802.1X: unauthorizing port
12435 Sat Jan 11 18:31:36 2025 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 IEEE 802.11: authenticated
12436 Sat Jan 11 18:31:36 2025 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 IEEE 802.11: associated (aid 2)
12437 Sat Jan 11 18:31:36 2025 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 IEEE 802.1X: unauthorizing port
12438 Sat Jan 11 18:31:36 2025 daemon.notice hostapd: wlan1-1: STA-OPMODE-SMPS-MODE-CHANGED 78:2b:46:ca:9c:34 off
12439 Sat Jan 11 18:31:36 2025 daemon.notice hostapd: wlan1-1: AP-STA-CONNECTED 78:2b:46:ca:9c:34 auth_alg=open
12440 Sat Jan 11 18:31:36 2025 kern.notice it-lan: WiFi client connected: 78:2B:46:CA:9C:34
12441 Sat Jan 11 18:31:36 2025 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 IEEE 802.1X: authorizing port
12442 Sat Jan 11 18:31:36 2025 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 RADIUS: starting accounting session B196726ECF4F449C
12443 Sat Jan 11 18:31:36 2025 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 WPA: pairwise key handshake completed (RSN)
12444 Sat Jan 11 18:31:36 2025 daemon.notice hostapd: wlan1-1: EAPOL-4WAY-HS-COMPLETED 78:2b:46:ca:9c:34
12445 Sat Jan 11 18:31:39 2025 daemon.info dnsmasq-dhcp[1898]: DHCPREQUEST(br-lan) 10.0.0.169 78:2b:46:ca:9c:34
12446 Sat Jan 11 18:31:39 2025 daemon.info dnsmasq-dhcp[1898]: DHCPACK(br-lan) 10.0.0.169 78:2b:46:ca:9c:34 ultra-win
12447 Sat Jan 11 18:31:42 2025 user.err ddns-scripts[26082]: myddns: BusyBox nslookup error: 1
12448 Sat Jan 11 18:31:50 2025 kern.notice IPv4 connectivity started to fail
12449 Sat Jan 11 18:31:50 2025 daemon.info gsmd[2051]: [ubus_notify_event:299] error: [MODEM_UBUS] Failed to send ubus notify for 2-1 [2c7c:0800] modem!
12450 Sat Jan 11 18:31:50 2025 daemon.info gsmd[2051]: Modem 2-1 [2c7c:0800] URC Event: ESM reject cause => Requested service option not subscribed
12451 Sat Jan 11 18:31:51 2025 daemon.info mobifd: [gsm.modem0] Starting modem settings init
12452 Sat Jan 11 18:31:52 2025 daemon.notice hostapd: wlan1-1: AP-STA-DISCONNECTED 78:2b:46:ca:9c:34
12453 Sat Jan 11 18:31:52 2025 kern.notice it-lan: WiFi client disconnected: 78:2B:46:CA:9C:34
12454 Sat Jan 11 18:31:52 2025 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 IEEE 802.1X: unauthorizing port
12455 Sat Jan 11 18:31:52 2025 user.err ddns-scripts[26082]: myddns: BusyBox nslookup error: 1
12456 Sat Jan 11 18:31:52 2025 user.warn ddns-scripts[26082]: myddns: Get registered/public IP for itmies.freeddns.org failed - retry 1/0 in 60 seconds
12457 Sat Jan 11 18:31:53 2025 daemon.info mobifd: [gsm.modem0] Modem settings init completed
12458 Sat Jan 11 18:31:53 2025 daemon.info mobifd: [gsm.modem0] Starting connection setup
12459 Sat Jan 11 18:31:53 2025 daemon.info mobifd: [gsm.modem0] Attempting to establish connection to operator with “15s” of timeout
12460 Sat Jan 11 18:31:53 2025 daemon.info mobifd: [gsm.modem0] Connected to operator “DNA DNA”
12461 Sat Jan 11 18:31:53 2025 daemon.info mobifd: [gsm.modem0] -CFUN- Functionality: “Full”
12462 Sat Jan 11 18:31:53 2025 daemon.info mobifd: [gsm.modem0] -COPS- Mode: “Auto”, operator: “DNA DNA”
12463 Sat Jan 11 18:31:53 2025 daemon.info mobifd: [gsm.modem0] -CREG- Mode: “Enabled (with location information)”, status: “Registered, home”, LAC: “412”, cell ID: “1957123”, technology: “E-UTRAN-NR”
12464 Sat Jan 11 18:31:53 2025 daemon.info mobifd: [gsm.modem0] -CGREG- Mode: “Enabled (with location information)”, status: “Not registered”, LAC: “”, cell ID: “”, technology: “Unknown”
12465 Sat Jan 11 18:31:53 2025 daemon.info mobifd: [gsm.modem0] -CEREG- Mode: “Enabled (with location information)”, status: “Registered, home”, LAC: “”, cell ID: “1957123”, technology: “E-UTRAN-NR”
12466 Sat Jan 11 18:31:53 2025 daemon.info mobifd: [gsm.modem0] -C5GREG- Mode: “Enabled (with location information)”, status: “Not registered”, LAC: “”, cell ID: “”, technology: “Unknown”
12467 Sat Jan 11 18:31:53 2025 kern.notice IPv6 connectivity started to fail
12468 Sat Jan 11 18:31:54 2025 daemon.info mobifd: [gsm.modem0] IP address on PDP context “1”: “188.67.241.64”
12469 Sat Jan 11 18:31:54 2025 daemon.notice netifd: Interface ‘mob1s1a1’ is setting up now
12470 Sat Jan 11 18:31:54 2025 daemon.notice netifd: mob1s1a1 (26515): wwan[26515] Using wwan usb device on bus 2-1
12471 Sat Jan 11 18:31:54 2025 daemon.notice netifd: mob1s1a1 (26515): wwan[26515] Using proto:qmapv5 device:/dev/cdc-wdm0 iface:wwan0 desc:Quectel RG50X
12472 Sat Jan 11 18:31:55 2025 daemon.notice netifd: mob1s1a1 (26515): Calculated qmimux ifname: qmimux0
12473 Sat Jan 11 18:31:55 2025 user.notice netifd: uqmi -d /dev/cdc-wdm0 --timeout 10000 --set-autoconnect disabled
12474 Sat Jan 11 18:31:55 2025 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 IEEE 802.11: authenticated
12475 Sat Jan 11 18:31:55 2025 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 IEEE 802.11: associated (aid 2)
12476 Sat Jan 11 18:31:55 2025 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 IEEE 802.1X: unauthorizing port
12477 Sat Jan 11 18:31:55 2025 daemon.notice hostapd: wlan1-1: STA-OPMODE-SMPS-MODE-CHANGED 78:2b:46:ca:9c:34 off
12478 Sat Jan 11 18:31:55 2025 daemon.notice hostapd: wlan1-1: AP-STA-CONNECTED 78:2b:46:ca:9c:34 auth_alg=open
12479 Sat Jan 11 18:31:55 2025 kern.notice it-lan: WiFi client connected: 78:2B:46:CA:9C:34
12480 Sat Jan 11 18:31:55 2025 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 IEEE 802.1X: authorizing port
12481 Sat Jan 11 18:31:55 2025 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 RADIUS: starting accounting session A544A42DA0989C7A
12482 Sat Jan 11 18:31:55 2025 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 WPA: pairwise key handshake completed (RSN)
12483 Sat Jan 11 18:31:55 2025 daemon.notice hostapd: wlan1-1: EAPOL-4WAY-HS-COMPLETED 78:2b:46:ca:9c:34
12484 Sat Jan 11 18:31:56 2025 daemon.notice netifd: mob1s1a1 (26515): Informing driver of raw-ip for wwan0 …
12485 Sat Jan 11 18:31:56 2025 kern.info kernel: [184149.005205] qmi_wwan 2-1:1.4 wwan0: mode: raw IP
12486 Sat Jan 11 18:31:56 2025 user.notice root: uqmi -d /dev/cdc-wdm0 --timeout 6000 --wda-set-data-format --qos-format 0 --link-layer-protocol raw-ip --endpoint-type hsusb --endpoint-iface-number 4 --ul-protocol qmapv5 --dl-protocol qmapv5 --ul-max-datagrams 11 --ul-datagram-max-size 8192 --dl-max-datagrams 62 --dl-datagram-max-size 31744 --dl-min-padding 0
12487 Sat Jan 11 18:31:57 2025 user.notice netifd: uqmi -d /dev/cdc-wdm0 --timeout 6000 --set-client-id wds,14 --release-client-id wds --modify-profile 3gpp,1 --profile-name 1 --roaming-disallowed-flag no
12488 Sat Jan 11 18:31:57 2025 user.notice netifd: uqmi -d /dev/cdc-wdm0 --timeout 6000 --get-client-id wds
12489 Sat Jan 11 18:31:57 2025 daemon.notice netifd: mob1s1a1 (26515): 14
12490 Sat Jan 11 18:31:57 2025 daemon.notice netifd: mob1s1a1 (26515): cid4: 14
12491 Sat Jan 11 18:31:57 2025 user.notice netifd: uqmi -d /dev/cdc-wdm0 --timeout 6000 --wds-bind-mux-data-port --mux-id 1 --ep-iface-number 4 --set-client-id wds,14
12492 Sat Jan 11 18:31:57 2025 user.notice netifd: uqmi -d /dev/cdc-wdm0 --timeout 6000 --set-ip-family ipv4 --set-client-id wds,14
12493 Sat Jan 11 18:31:57 2025 daemon.info dnsmasq-dhcp[1898]: DHCPREQUEST(br-lan) 10.0.0.169 78:2b:46:ca:9c:34
12494 Sat Jan 11 18:31:57 2025 daemon.info dnsmasq-dhcp[1898]: DHCPACK(br-lan) 10.0.0.169 78:2b:46:ca:9c:34 ultra-win
12495 Sat Jan 11 18:31:57 2025 user.notice netifd: uqmi -d /dev/cdc-wdm0 --timeout 6000 --set-client-id wds,14 --start-network --profile 1 --ip-family ipv4
12496 Sat Jan 11 18:31:57 2025 daemon.notice netifd: mob1s1a1 (26515): pdh4: 1767223072
12497 Sat Jan 11 18:31:57 2025 daemon.notice netifd: mob1s1a1 (26515): 1767223072
12498 Sat Jan 11 18:31:57 2025 user.notice netifd: uqmi -d /dev/cdc-wdm0 --timeout 6000 --get-client-id wds
12499 Sat Jan 11 18:31:58 2025 daemon.notice netifd: mob1s1a1 (26515): 15
12500 Sat Jan 11 18:31:58 2025 daemon.notice netifd: mob1s1a1 (26515): cid6: 15
12501 Sat Jan 11 18:31:58 2025 user.notice netifd: uqmi -d /dev/cdc-wdm0 --timeout 6000 --wds-bind-mux-data-port --mux-id 1 --ep-iface-number 4 --set-client-id wds,15
12502 Sat Jan 11 18:31:58 2025 user.notice netifd: uqmi -d /dev/cdc-wdm0 --timeout 6000 --set-ip-family ipv6 --set-client-id wds,15
12503 Sat Jan 11 18:31:58 2025 user.notice netifd: uqmi -d /dev/cdc-wdm0 --timeout 6000 --set-client-id wds,15 --start-network --ip-family ipv6 --profile 1
12504 Sat Jan 11 18:31:58 2025 daemon.notice netifd: mob1s1a1 (26515): pdh6: 1767663504
12505 Sat Jan 11 18:31:58 2025 daemon.notice netifd: mob1s1a1 (26515): 1767663504
12506 Sat Jan 11 18:31:58 2025 daemon.notice netifd: mob1s1a1 (26515): Setting up qmimux0
12507 Sat Jan 11 18:31:58 2025 daemon.notice netifd: mob1s1a1 (26515): Setting configured MTU: 1500 on qmimux0
12508 Sat Jan 11 18:31:58 2025 daemon.notice netifd: Interface ‘mob1s1a1’ is now up
12509 Sat Jan 11 18:31:58 2025 daemon.notice netifd: Network device ‘wwan0’ link is up
12510 Sat Jan 11 18:31:58 2025 daemon.notice netifd: mob1s1a1 (26515): Setting up qmimux0 V4 DCHP
12511 Sat Jan 11 18:31:58 2025 daemon.notice netifd: Interface ‘mob1s1a1_4’ is enabled
12512 Sat Jan 11 18:31:58 2025 daemon.notice netifd: Network device ‘qmimux0’ link is up
12513 Sat Jan 11 18:31:58 2025 daemon.notice netifd: Interface ‘mob1s1a1_4’ has link connectivity
12514 Sat Jan 11 18:31:58 2025 daemon.notice netifd: Interface ‘mob1s1a1_4’ is setting up now
12515 Sat Jan 11 18:31:58 2025 daemon.notice netifd: mob1s1a1 (26515): Setting up qmimux0 V6 static
12516 Sat Jan 11 18:31:58 2025 daemon.notice netifd: mob1s1a1 (26515): {
12517 Sat Jan 11 18:31:58 2025 daemon.notice netifd: mob1s1a1 (26515): “pdp-type”: “ipv4v6”,
12518 Sat Jan 11 18:31:58 2025 daemon.notice netifd: mob1s1a1 (26515): “ip-family”: “ipv6”,
12519 Sat Jan 11 18:31:58 2025 daemon.notice netifd: mob1s1a1 (26515): “mtu”: 1500,
12520 Sat Jan 11 18:31:58 2025 daemon.notice netifd: mob1s1a1 (26515): “ipv4”: {
12521 Sat Jan 11 18:31:58 2025 daemon.notice netifd: mob1s1a1 (26515):
12522 Sat Jan 11 18:31:58 2025 daemon.notice netifd: mob1s1a1 (26515): },
12523 Sat Jan 11 18:31:58 2025 daemon.notice netifd: mob1s1a1 (26515): “ipv6”: {
12524 Sat Jan 11 18:31:58 2025 daemon.notice netifd: mob1s1a1 (26515): “ip”: “2001:14bb:1a7:f3ce:1858:31f3:ffe9:cdb5”,
12525 Sat Jan 11 18:31:58 2025 daemon.notice netifd: mob1s1a1 (26515): “ip-prefix-length”: 64,
12526 Sat Jan 11 18:31:58 2025 daemon.notice netifd: mob1s1a1 (26515): “gateway”: “2001:14bb:1a7:f3ce:12d:35f4:e189:9fd1”,
12527 Sat Jan 11 18:31:58 2025 daemon.notice netifd: mob1s1a1 (26515): “gw-prefix-length”: 64,
12528 Sat Jan 11 18:31:58 2025 daemon.notice netifd: mob1s1a1 (26515): “dns1”: “2001:14b8:1000::1”,
12529 Sat Jan 11 18:31:58 2025 daemon.notice netifd: mob1s1a1 (26515): “dns2”: “2001:14b8:1000::2”
12530 Sat Jan 11 18:31:58 2025 daemon.notice netifd: mob1s1a1 (26515): },
12531 Sat Jan 11 18:31:58 2025 daemon.notice netifd: mob1s1a1 (26515): “domain-names”: {
12532 Sat Jan 11 18:31:58 2025 daemon.notice netifd: mob1s1a1 (26515):
12533 Sat Jan 11 18:31:58 2025 daemon.notice netifd: mob1s1a1 (26515): }
12534 Sat Jan 11 18:31:58 2025 daemon.notice netifd: mob1s1a1 (26515): }
12535 Sat Jan 11 18:31:58 2025 daemon.notice netifd: mob1s1a1 (26515): uci: Entry not found
12536 Sat Jan 11 18:31:58 2025 daemon.notice netifd: Interface ‘mob1s1a1_6’ is enabled
12537 Sat Jan 11 18:31:58 2025 daemon.notice netifd: Interface ‘mob1s1a1_6’ is setting up now
12538 Sat Jan 11 18:31:58 2025 daemon.info mobifd: Auto APN is disabled for ‘mob1s1a1’. Skipping Ping To DNS functionality
12539 Sat Jan 11 18:31:58 2025 daemon.notice netifd: Interface ‘mob1s1a1_6’ is now up
12540 Sat Jan 11 18:31:58 2025 daemon.notice netifd: Interface ‘mob1s1a1_6’ has link connectivity
12541 Sat Jan 11 18:31:58 2025 daemon.info dnsmasq[1898]: reading /tmp/resolv.conf.d/resolv.conf.auto
12542 Sat Jan 11 18:31:58 2025 daemon.info mobifd: Connection setup completed for ‘mob1s1a1’
12543 Sat Jan 11 18:31:58 2025 daemon.info mobifd: Connection setup completed for modem: ‘gsm.modem0’
12544 Sat Jan 11 18:31:58 2025 daemon.info dnsmasq[1898]: using nameserver 2001:14b8:1000::1#53
12545 Sat Jan 11 18:31:58 2025 daemon.info dnsmasq[1898]: using nameserver 2001:14b8:1000::2#53
12546 Sat Jan 11 18:31:58 2025 daemon.info dnsmasq[1898]: using only locally-known addresses for test
12547 Sat Jan 11 18:31:58 2025 daemon.info dnsmasq[1898]: using only locally-known addresses for onion
12548 Sat Jan 11 18:31:58 2025 daemon.info dnsmasq[1898]: using only locally-known addresses for localhost
12549 Sat Jan 11 18:31:58 2025 daemon.info dnsmasq[1898]: using only locally-known addresses for local
12550 Sat Jan 11 18:31:58 2025 daemon.info dnsmasq[1898]: using only locally-known addresses for invalid
12551 Sat Jan 11 18:31:58 2025 daemon.info dnsmasq[1898]: using only locally-known addresses for bind
12552 Sat Jan 11 18:31:58 2025 daemon.info dnsmasq[1898]: using only locally-known addresses for lan
12553 Sat Jan 11 18:31:58 2025 daemon.notice netifd: mob1s1a1_4 (26938): udhcpc: started, v1.34.1
12554 Sat Jan 11 18:31:58 2025 daemon.notice netifd: mob1s1a1_4 (26938): udhcpc: broadcasting discover
12555 Sat Jan 11 18:31:59 2025 daemon.notice netifd: mob1s1a1_4 (26938): udhcpc: broadcasting select for 188.67.241.64, server 188.67.241.65
12556 Sat Jan 11 18:31:59 2025 user.notice firewall: Reloading firewall due to ifup of mob1s1a1 (wwan0)
12557 Sat Jan 11 18:31:59 2025 daemon.notice netifd: mob1s1a1_4 (26938): udhcpc: lease of 188.67.241.64 obtained from 188.67.241.65, lease time 7200
12558 Sat Jan 11 18:31:59 2025 daemon.notice netifd: Interface ‘mob1s1a1_4’ is now up
12559 Sat Jan 11 18:31:59 2025 daemon.info dnsmasq[1898]: reading /tmp/resolv.conf.d/resolv.conf.auto
12560 Sat Jan 11 18:31:59 2025 daemon.info dnsmasq[1898]: using nameserver 62.241.198.245#53
12561 Sat Jan 11 18:31:59 2025 daemon.info dnsmasq[1898]: using nameserver 62.241.198.246#53
12562 Sat Jan 11 18:31:59 2025 daemon.info dnsmasq[1898]: using nameserver 2001:14b8:1000::1#53
12563 Sat Jan 11 18:31:59 2025 daemon.info dnsmasq[1898]: using nameserver 2001:14b8:1000::2#53
12564 Sat Jan 11 18:31:59 2025 daemon.info dnsmasq[1898]: using only locally-known addresses for test
12565 Sat Jan 11 18:31:59 2025 daemon.info dnsmasq[1898]: using only locally-known addresses for onion
12566 Sat Jan 11 18:31:59 2025 daemon.info dnsmasq[1898]: using only locally-known addresses for localhost
12567 Sat Jan 11 18:31:59 2025 daemon.info dnsmasq[1898]: using only locally-known addresses for local
12568 Sat Jan 11 18:31:59 2025 daemon.info dnsmasq[1898]: using only locally-known addresses for invalid
12569 Sat Jan 11 18:31:59 2025 daemon.info dnsmasq[1898]: using only locally-known addresses for bind
12570 Sat Jan 11 18:31:59 2025 daemon.info dnsmasq[1898]: using only locally-known addresses for lan
12571 Sat Jan 11 18:32:00 2025 daemon.info dnsmasq[1898]: read /etc/hosts - 12 names
12572 Sat Jan 11 18:32:00 2025 daemon.info dnsmasq[1898]: read /tmp/hosts/dhcp.cfg01411c - 4 names
12573 Sat Jan 11 18:32:00 2025 daemon.info dnsmasq-dhcp[1898]: read /etc/ethers - 0 addresses
12574 Sat Jan 11 18:32:01 2025 user.notice ddns-scripts[26082]: myddns: pid 26082 terminated by sigterm at 2025-01-11 18:32
12575 Sat Jan 11 18:32:02 2025 user.notice firewall: Reloading firewall due to ifup of mob1s1a1_6 (qmimux0)
12576 Sat Jan 11 18:32:03 2025 user.notice ddns-scripts[27580]: myddns: pid 27580 started at 2025-01-11 18:32
12577 Sat Jan 11 18:32:04 2025 kern.info Mobile data connected (internal modem)
12578 Sat Jan 11 18:32:04 2025 kern.info Joined 5G-NSA network (internal modem)
12579 Sat Jan 11 18:32:04 2025 kern.info Connected to DNA DNA operator (internal modem)
12580 Sat Jan 11 18:32:05 2025 user.notice ddns-scripts[27580]: myddns: pid 27580 terminated by sigterm at 2025-01-11 18:32
12581 Sat Jan 11 18:32:06 2025 user.notice firewall: Reloading firewall due to ifup of mob1s1a1_4 (qmimux0)
12582 Sat Jan 11 18:32:06 2025 user.notice ddns-scripts[28083]: myddns: pid 28083 started at 2025-01-11 18:32
12583 Sat Jan 11 18:32:08 2025 daemon.info dnsmasq[1898]: read /etc/hosts - 12 names
12584 Sat Jan 11 18:32:08 2025 daemon.info dnsmasq[1898]: read /tmp/hosts/dhcp.cfg01411c - 4 names
12585 Sat Jan 11 18:32:08 2025 daemon.info dnsmasq-dhcp[1898]: read /etc/ethers - 0 addresses
12586 Sat Jan 11 18:32:09 2025 kern.info Mobile data connected (internal modem)
12587 Sat Jan 11 18:32:09 2025 kern.info Joined 5G-NSA network (internal modem)
12588 Sat Jan 11 18:32:09 2025 kern.info Connected to DNA DNA operator (internal modem)
12589 Sat Jan 11 18:32:11 2025 user.notice ddns-scripts[28847]: myddns: pid 28847 started at 2025-01-11 18:32
12590 Sat Jan 11 18:32:14 2025 kern.info kernel: [184166.516338] usb 2-1: USB disconnect, device number 20
12591 Sat Jan 11 18:32:14 2025 kern.info kernel: [184166.516778] option1 ttyUSB0: GSM modem (1-port) converter now disconnected from ttyUSB0
12592 Sat Jan 11 18:32:14 2025 kern.info kernel: [184166.520599] option 2-1:1.0: device disconnected
12593 Sat Jan 11 18:32:14 2025 kern.info kernel: [184166.529584] option1 ttyUSB1: GSM modem (1-port) converter now disconnected from ttyUSB1
12594 Sat Jan 11 18:32:14 2025 kern.info kernel: [184166.533426] option 2-1:1.1: device disconnected
12595 Sat Jan 11 18:32:14 2025 kern.info kernel: [184166.557265] option1 ttyUSB2: GSM modem (1-port) converter now disconnected from ttyUSB2
12596 Sat Jan 11 18:32:14 2025 kern.info kernel: [184166.557457] option 2-1:1.2: device disconnected
12597 Sat Jan 11 18:32:14 2025 kern.info kernel: [184166.565080] option1 ttyUSB3: GSM modem (1-port) converter now disconnected from ttyUSB3
12598 Sat Jan 11 18:32:14 2025 kern.info kernel: [184166.570021] option 2-1:1.3: device disconnected
12599 Sat Jan 11 18:32:14 2025 user.warn kernel: [184166.571576] [01-serial-symlink.sh] New device ttyUSB0 at /devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1/2-1:1.0/ttyUSB0/tty/ttyUSB0 appeared!
12600 Sat Jan 11 18:32:14 2025 daemon.notice netifd: Network device ‘qmimux0’ link is down
12601 Sat Jan 11 18:32:14 2025 daemon.notice netifd: Interface ‘mob1s1a1_4’ has link connectivity loss
12602 Sat Jan 11 18:32:14 2025 daemon.notice netifd: Interface ‘mob1s1a1_6’ has link connectivity loss
12603 Sat Jan 11 18:32:14 2025 daemon.notice netifd: Interface ‘mob1s1a1_6’ is now down
12604 Sat Jan 11 18:32:14 2025 daemon.warn dnsmasq[1898]: no servers found in /tmp/resolv.conf.d/resolv.conf.auto, will retry
12605 Sat Jan 11 18:32:14 2025 kern.info kernel: [184166.756558] qmi_wwan 2-1:1.4 wwan0: unregister ‘qmi_wwan’ usb-xhci-hcd.0.auto-1, WWAN/QMI device
12606 Sat Jan 11 18:32:14 2025 user.warn kernel: [184166.889173] [01-serial-symlink.sh] New device ttyUSB1 at /devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1/2-1:1.1/ttyUSB1/tty/ttyUSB1 appeared!
12607 Sat Jan 11 18:32:14 2025 daemon.notice netifd: Interface ‘mob1s1a1_4’ is disabled
12608 Sat Jan 11 18:32:14 2025 user.warn kernel: [184167.162546] [01-serial-symlink.sh] New device ttyUSB2 at /devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1/2-1:1.2/ttyUSB2/tty/ttyUSB2 appeared!
12609 Sat Jan 11 18:32:14 2025 daemon.notice netifd: Network device ‘wwan0’ link is down
12610 Sat Jan 11 18:32:14 2025 user.warn kernel: [184167.341815] [01-serial-symlink.sh] New device ttyUSB3 at /devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1/2-1:1.3/ttyUSB3/tty/ttyUSB3 appeared!
12611 Sat Jan 11 18:32:14 2025 kern.info Mobile data disconnected (internal modem)
12612 Sat Jan 11 18:32:15 2025 daemon.notice netifd: mob1s1a1_4 (26938): udhcpc: SIOCGIFINDEX: No such device
12613 Sat Jan 11 18:32:15 2025 daemon.notice netifd: mob1s1a1_4 (26938): udhcpc: received SIGTERM
12614 Sat Jan 11 18:32:15 2025 daemon.notice netifd: mob1s1a1_4 (26938): udhcpc: unicasting a release of 188.67.241.64 to 188.67.241.65
12615 Sat Jan 11 18:32:15 2025 daemon.notice netifd: mob1s1a1_4 (26938): udhcpc: sending release
12616 Sat Jan 11 18:32:15 2025 daemon.notice netifd: mob1s1a1_4 (26938): udhcpc: can’t bind to interface qmimux0: No such device
12617 Sat Jan 11 18:32:15 2025 daemon.notice netifd: mob1s1a1_4 (26938): udhcpc: bindtodevice: No such device
12618 Sat Jan 11 18:32:15 2025 daemon.notice netifd: mob1s1a1_4 (26938): udhcpc: entering released state
12619 Sat Jan 11 18:32:15 2025 daemon.notice netifd: mob1s1a1_4 (26938): Command failed: Permission denied
12620 Sat Jan 11 18:32:15 2025 daemon.notice netifd: Interface ‘mob1s1a1_4’ is now down
12621 Sat Jan 11 18:32:15 2025 daemon.notice netifd: mob1s1a1 (29209): Stopping network mob1s1a1
12622 Sat Jan 11 18:32:15 2025 daemon.notice netifd: mob1s1a1 (29209): Command failed: Not found
12623 Sat Jan 11 18:32:15 2025 daemon.notice netifd: mob1s1a1 (29209): Stopping network on /dev/cdc-wdm0!
12624 Sat Jan 11 18:32:15 2025 user.notice netifd: uqmi -s -d /dev/cdc-wdm0 -t 3000 --set-client-id wds,14 --stop-network 0xFFFFFFFF --autoconnect
12625 Sat Jan 11 18:32:15 2025 daemon.notice netifd: mob1s1a1 (29209): Command failed: Not found
12626 Sat Jan 11 18:32:15 2025 daemon.notice netifd: mob1s1a1 (29209): Failed to open device, errno: 2
12627 Sat Jan 11 18:32:15 2025 daemon.notice netifd: mob1s1a1 (29209): Command failed: Permission denied
12628 Sat Jan 11 18:32:15 2025 daemon.notice netifd: Interface ‘mob1s1a1’ is now down
12629 Sat Jan 11 18:32:15 2025 daemon.notice netifd: Interface ‘mob1s1a1’ is setting up now
12630 Sat Jan 11 18:32:15 2025 user.notice netifd: uqmi -s -d /dev/cdc-wdm0 -t 3000 --set-client-id wds,14 --release-client-id wds
12631 Sat Jan 11 18:32:15 2025 daemon.notice netifd: mob1s1a1 (29303): wwan[29303] Searching for a valid wwan usb device…
12632 Sat Jan 11 18:32:15 2025 daemon.notice netifd: mob1s1a1 (29343): Stopping network mob1s1a1
12633 Sat Jan 11 18:32:15 2025 daemon.notice netifd: mob1s1a1 (29343): Command failed: Not found
12634 Sat Jan 11 18:32:15 2025 daemon.notice netifd: mob1s1a1 (29343): Command failed: Not found
12635 Sat Jan 11 18:32:15 2025 daemon.notice netifd: mob1s1a1 (29343): Command failed: Permission denied
12636 Sat Jan 11 18:32:15 2025 daemon.notice netifd: Interface ‘mob1s1a1’ is now down
12637 Sat Jan 11 18:32:17 2025 user.notice ddns-scripts[29416]: myddns: pid 29416 started at 2025-01-11 18:32
12638 Sat Jan 11 18:32:17 2025 daemon.info dnsmasq[1898]: read /etc/hosts - 12 names
12639 Sat Jan 11 18:32:17 2025 daemon.info dnsmasq[1898]: read /tmp/hosts/dhcp.cfg01411c - 4 names
12640 Sat Jan 11 18:32:17 2025 daemon.info dnsmasq-dhcp[1898]: read /etc/ethers - 0 addresses
12641 Sat Jan 11 18:32:18 2025 kern.info Mobile data disconnected (internal modem)
12642 Sat Jan 11 18:32:18 2025 user.notice netifd: uqmi -s -d /dev/cdc-wdm0 -t 3000 --set-client-id wds,15 --stop-network 0xFFFFFFFF --autoconnect
12643 Sat Jan 11 18:32:18 2025 user.notice netifd: uqmi -s -d /dev/cdc-wdm0 -t 3000 --set-client-id wds,15 --release-client-id wds
12644 Sat Jan 11 18:32:19 2025 user.notice ddns-scripts[29416]: myddns: pid 29416 terminated by sigterm at 2025-01-11 18:32
12645 Sat Jan 11 18:32:19 2025 daemon.info hostapd: wlan1-1: STA c8:8a:9a:b7:bb:19 IEEE 802.11: authenticated
12646 Sat Jan 11 18:32:19 2025 daemon.info hostapd: wlan1-1: STA c8:8a:9a:b7:bb:19 IEEE 802.11: associated (aid 4)
12647 Sat Jan 11 18:32:19 2025 daemon.info hostapd: wlan1-1: STA c8:8a:9a:b7:bb:19 IEEE 802.1X: unauthorizing port
12648 Sat Jan 11 18:32:19 2025 daemon.notice hostapd: wlan1-1: STA-OPMODE-SMPS-MODE-CHANGED c8:8a:9a:b7:bb:19 off
12649 Sat Jan 11 18:32:19 2025 daemon.notice hostapd: wlan1-1: AP-STA-CONNECTED c8:8a:9a:b7:bb:19 auth_alg=open
12650 Sat Jan 11 18:32:19 2025 kern.notice it-lan: WiFi client connected: C8:8A:9A:B7:BB:19
12651 Sat Jan 11 18:32:19 2025 daemon.info hostapd: wlan1-1: STA c8:8a:9a:b7:bb:19 IEEE 802.1X: authorizing port
12652 Sat Jan 11 18:32:19 2025 daemon.info hostapd: wlan1-1: STA c8:8a:9a:b7:bb:19 RADIUS: starting accounting session 01FB512D8413680A
12653 Sat Jan 11 18:32:19 2025 daemon.info hostapd: wlan1-1: STA c8:8a:9a:b7:bb:19 WPA: pairwise key handshake completed (RSN)
12654 Sat Jan 11 18:32:19 2025 daemon.notice hostapd: wlan1-1: EAPOL-4WAY-HS-COMPLETED c8:8a:9a:b7:bb:19
12655 Sat Jan 11 18:32:20 2025 user.notice ddns-scripts[30110]: myddns: pid 30110 started at 2025-01-11 18:32
12656 Sat Jan 11 18:32:21 2025 daemon.info dnsmasq-dhcp[1898]: DHCPREQUEST(br-lan) 10.0.0.109 c8:8a:9a:b7:bb:19
12657 Sat Jan 11 18:32:21 2025 daemon.info dnsmasq-dhcp[1898]: DHCPACK(br-lan) 10.0.0.109 c8:8a:9a:b7:bb:19 it-win
12658 Sat Jan 11 18:32:21 2025 user.notice qmux: mob1s1a1 teardown successful
12659 Sat Jan 11 18:32:21 2025 user.notice qmux: mob1s1a1 teardown successful
12660 Sat Jan 11 18:32:24 2025 kern.info kernel: [184176.716520] usb 2-1: new SuperSpeed Gen 1 USB device number 21 using xhci-hcd
12661 Sat Jan 11 18:32:24 2025 kern.info kernel: [184176.897858] option 2-1:1.0: GSM modem (1-port) converter detected
12662 Sat Jan 11 18:32:24 2025 kern.info kernel: [184176.898245] usb 2-1: GSM modem (1-port) converter now attached to ttyUSB0
12663 Sat Jan 11 18:32:24 2025 kern.info kernel: [184176.904015] option 2-1:1.1: GSM modem (1-port) converter detected
12664 Sat Jan 11 18:32:24 2025 kern.info kernel: [184176.910770] usb 2-1: GSM modem (1-port) converter now attached to ttyUSB1
12665 Sat Jan 11 18:32:24 2025 kern.info kernel: [184176.916879] option 2-1:1.2: GSM modem (1-port) converter detected
12666 Sat Jan 11 18:32:24 2025 kern.info kernel: [184176.924184] usb 2-1: GSM modem (1-port) converter now attached to ttyUSB2
12667 Sat Jan 11 18:32:24 2025 kern.info kernel: [184176.931604] option 2-1:1.3: GSM modem (1-port) converter detected
12668 Sat Jan 11 18:32:24 2025 kern.info kernel: [184176.936847] usb 2-1: GSM modem (1-port) converter now attached to ttyUSB3
12669 Sat Jan 11 18:32:24 2025 kern.info kernel: [184176.961175] qmi_wwan 2-1:1.4: cdc-wdm0: USB WDM device
12670 Sat Jan 11 18:32:24 2025 kern.warn kernel: [184176.962015] QMI_WWAN: extending urb size to 31744
12671 Sat Jan 11 18:32:24 2025 kern.info kernel: [184176.967607] qmi_wwan 2-1:1.4 wwan0: register ‘qmi_wwan’ at usb-xhci-hcd.0.auto-1, WWAN/QMI device, 9a:18:be:a2:6f:2d
12672 Sat Jan 11 18:32:24 2025 user.warn kernel: [184177.003837] [01-serial-symlink.sh] New device ttyUSB0 at /devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1/2-1:1.0/ttyUSB0/tty/ttyUSB0 appeared!
12673 Sat Jan 11 18:32:24 2025 user.warn kernel: [184177.167831] [01-serial-symlink.sh] New device ttyUSB1 at /devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1/2-1:1.1/ttyUSB1/tty/ttyUSB1 appeared!
12674 Sat Jan 11 18:32:24 2025 user.warn kernel: [184177.324103] [01-serial-symlink.sh] New device ttyUSB2 at /devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1/2-1:1.2/ttyUSB2/tty/ttyUSB2 appeared!
12675 Sat Jan 11 18:32:25 2025 user.warn kernel: [184177.484005] [01-serial-symlink.sh] New device ttyUSB3 at /devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1/2-1:1.3/ttyUSB3/tty/ttyUSB3 appeared!
12676 Sat Jan 11 18:32:31 2025 user.err ddns-scripts[30110]: myddns: BusyBox nslookup error: 1
12677 Sat Jan 11 18:32:33 2025 daemon.notice hostapd: wlan1-1: AP-STA-DISCONNECTED 78:2b:46:ca:9c:34
12678 Sat Jan 11 18:32:33 2025 kern.notice it-lan: WiFi client disconnected: 78:2B:46:CA:9C:34
12679 Sat Jan 11 18:32:33 2025 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 IEEE 802.1X: unauthorizing port
12680 Sat Jan 11 18:32:33 2025 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 IEEE 802.11: authenticated
12681 Sat Jan 11 18:32:33 2025 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 IEEE 802.11: associated (aid 2)
12682 Sat Jan 11 18:32:33 2025 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 IEEE 802.1X: unauthorizing port
12683 Sat Jan 11 18:32:33 2025 daemon.notice hostapd: wlan1-1: STA-OPMODE-SMPS-MODE-CHANGED 78:2b:46:ca:9c:34 off
12684 Sat Jan 11 18:32:33 2025 daemon.notice hostapd: wlan1-1: AP-STA-CONNECTED 78:2b:46:ca:9c:34 auth_alg=open
12685 Sat Jan 11 18:32:33 2025 kern.notice it-lan: WiFi client connected: 78:2B:46:CA:9C:34
12686 Sat Jan 11 18:32:33 2025 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 IEEE 802.1X: authorizing port
12687 Sat Jan 11 18:32:33 2025 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 RADIUS: starting accounting session 133588C657C6A07A
12688 Sat Jan 11 18:32:33 2025 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 WPA: pairwise key handshake completed (RSN)
12689 Sat Jan 11 18:32:33 2025 daemon.notice hostapd: wlan1-1: EAPOL-4WAY-HS-COMPLETED 78:2b:46:ca:9c:34
12690 Sat Jan 11 18:32:34 2025 user.info : Starting database size optimization…
12691 Sat Jan 11 18:32:35 2025 daemon.notice hostapd: wlan1-1: AP-STA-DISCONNECTED c8:8a:9a:b7:bb:19
12692 Sat Jan 11 18:32:35 2025 kern.notice it-lan: WiFi client disconnected: C8:8A:9A:B7:BB:19
12693 Sat Jan 11 18:32:35 2025 daemon.info hostapd: wlan1-1: STA c8:8a:9a:b7:bb:19 IEEE 802.1X: unauthorizing port
12694 Sat Jan 11 18:32:35 2025 daemon.info hostapd: wlan1-1: STA c8:8a:9a:b7:bb:19 IEEE 802.11: authenticated
12695 Sat Jan 11 18:32:35 2025 daemon.info hostapd: wlan1-1: STA c8:8a:9a:b7:bb:19 IEEE 802.11: associated (aid 4)
12696 Sat Jan 11 18:32:35 2025 daemon.info hostapd: wlan1-1: STA c8:8a:9a:b7:bb:19 IEEE 802.1X: unauthorizing port
12697 Sat Jan 11 18:32:35 2025 daemon.notice hostapd: wlan1-1: STA-OPMODE-SMPS-MODE-CHANGED c8:8a:9a:b7:bb:19 off
12698 Sat Jan 11 18:32:35 2025 daemon.notice hostapd: wlan1-1: AP-STA-CONNECTED c8:8a:9a:b7:bb:19 auth_alg=open
12699 Sat Jan 11 18:32:35 2025 kern.notice it-lan: WiFi client connected: C8:8A:9A:B7:BB:19
12700 Sat Jan 11 18:32:35 2025 daemon.info hostapd: wlan1-1: STA c8:8a:9a:b7:bb:19 IEEE 802.1X: authorizing port
12701 Sat Jan 11 18:32:35 2025 daemon.info hostapd: wlan1-1: STA c8:8a:9a:b7:bb:19 RADIUS: starting accounting session ADA9020182192CC9
12702 Sat Jan 11 18:32:35 2025 daemon.info hostapd: wlan1-1: STA c8:8a:9a:b7:bb:19 WPA: pairwise key handshake completed (RSN)
12703 Sat Jan 11 18:32:35 2025 daemon.notice hostapd: wlan1-1: EAPOL-4WAY-HS-COMPLETED c8:8a:9a:b7:bb:19
12704 Sat Jan 11 18:32:36 2025 daemon.info dnsmasq-dhcp[1898]: DHCPREQUEST(br-lan) 10.0.0.169 78:2b:46:ca:9c:34
12705 Sat Jan 11 18:32:36 2025 daemon.info dnsmasq-dhcp[1898]: DHCPACK(br-lan) 10.0.0.169 78:2b:46:ca:9c:34 ultra-win
12706 Sat Jan 11 18:32:38 2025 daemon.info dnsmasq-dhcp[1898]: DHCPREQUEST(br-lan) 10.0.0.109 c8:8a:9a:b7:bb:19
12707 Sat Jan 11 18:32:38 2025 daemon.info dnsmasq-dhcp[1898]: DHCPACK(br-lan) 10.0.0.109 c8:8a:9a:b7:bb:19 it-win
12708 Sat Jan 11 18:32:39 2025 daemon.info gsmd[2051]: [ubus_notify_event:299] error: [MODEM_UBUS] Failed to send ubus notify for 2-1 [2c7c:0800] modem!
12709 Sat Jan 11 18:32:40 2025 daemon.info mobifd: [gsm.modem0] Starting modem settings init
12710 Sat Jan 11 18:32:41 2025 user.info : Finished database optimization
12711 Sat Jan 11 18:32:41 2025 user.err ddns-scripts[30110]: myddns: BusyBox nslookup error: 1
12712 Sat Jan 11 18:32:42 2025 user.warn ddns-scripts[30110]: myddns: Get registered/public IP for dns failed - retry 1/0 in 60 seconds
12713 Sat Jan 11 18:32:42 2025 daemon.info mobifd: [gsm.modem0] Modem settings init completed
12714 Sat Jan 11 18:32:42 2025 daemon.info mobifd: [gsm.modem0] Starting connection setup
12715 Sat Jan 11 18:32:42 2025 daemon.info mobifd: [gsm.modem0] Attempting to establish connection to operator with “15s” of timeout
12716 Sat Jan 11 18:32:42 2025 daemon.info mobifd: [gsm.modem0] Connected to operator “DNA DNA”
12717 Sat Jan 11 18:32:42 2025 daemon.info mobifd: [gsm.modem0] -CFUN- Functionality: “Full”
12718 Sat Jan 11 18:32:42 2025 daemon.info mobifd: [gsm.modem0] -COPS- Mode: “Auto”, operator: “DNA DNA”
12719 Sat Jan 11 18:32:42 2025 daemon.info mobifd: [gsm.modem0] -CREG- Mode: “Enabled (with location information)”, status: “Registered, home”, LAC: “412”, cell ID: “1957123”, technology: “E-UTRAN”
12720 Sat Jan 11 18:32:42 2025 daemon.info mobifd: [gsm.modem0] -CGREG- Mode: “Enabled (with location information)”, status: “Not registered”, LAC: “”, cell ID: “”, technology: “Unknown”
12721 Sat Jan 11 18:32:42 2025 daemon.info mobifd: [gsm.modem0] -CEREG- Mode: “Enabled (with location information)”, status: “Registered, home”, LAC: “”, cell ID: “1957123”, technology: “E-UTRAN”
12722 Sat Jan 11 18:32:42 2025 daemon.info mobifd: [gsm.modem0] -C5GREG- Mode: “Enabled (with location information)”, status: “Not registered”, LAC: “”, cell ID: “”, technology: “Unknown”
12723 Sat Jan 11 18:32:42 2025 daemon.info mobifd: [gsm.modem0] IP address on PDP context “1”: “37.33.15.84”
12724 Sat Jan 11 18:32:42 2025 daemon.notice netifd: Interface ‘mob1s1a1’ is setting up now
12725 Sat Jan 11 18:32:43 2025 daemon.notice netifd: mob1s1a1 (30574): wwan[30574] Using wwan usb device on bus 2-1
12726 Sat Jan 11 18:32:43 2025 daemon.notice netifd: mob1s1a1 (30574): wwan[30574] Using proto:qmapv5 device:/dev/cdc-wdm0 iface:wwan0 desc:Quectel RG50X
12727 Sat Jan 11 18:32:43 2025 daemon.notice netifd: mob1s1a1 (30574): Calculated qmimux ifname: qmimux0
12728 Sat Jan 11 18:32:43 2025 user.notice netifd: uqmi -d /dev/cdc-wdm0 --timeout 10000 --set-autoconnect disabled
12729 Sat Jan 11 18:32:45 2025 daemon.notice netifd: mob1s1a1 (30574): Informing driver of raw-ip for wwan0 …
12730 Sat Jan 11 18:32:45 2025 kern.info kernel: [184198.314357] qmi_wwan 2-1:1.4 wwan0: mode: raw IP
12731 Sat Jan 11 18:32:46 2025 user.notice root: uqmi -d /dev/cdc-wdm0 --timeout 6000 --wda-set-data-format --qos-format 0 --link-layer-protocol raw-ip --endpoint-type hsusb --endpoint-iface-number 4 --ul-protocol qmapv5 --dl-protocol qmapv5 --ul-max-datagrams 11 --ul-datagram-max-size 8192 --dl-max-datagrams 62 --dl-datagram-max-size 31744 --dl-min-padding 0
12732 Sat Jan 11 18:32:46 2025 user.notice netifd: uqmi -d /dev/cdc-wdm0 --timeout 6000 --set-client-id wds,14 --release-client-id wds --modify-profile 3gpp,1 --profile-name 1 --roaming-disallowed-flag no
12733 Sat Jan 11 18:32:46 2025 user.notice netifd: uqmi -d /dev/cdc-wdm0 --timeout 6000 --get-client-id wds
12734 Sat Jan 11 18:32:46 2025 daemon.notice netifd: mob1s1a1 (30574): 14
12735 Sat Jan 11 18:32:46 2025 daemon.notice netifd: mob1s1a1 (30574): cid4: 14
12736 Sat Jan 11 18:32:46 2025 user.notice netifd: uqmi -d /dev/cdc-wdm0 --timeout 6000 --wds-bind-mux-data-port --mux-id 1 --ep-iface-number 4 --set-client-id wds,14
12737 Sat Jan 11 18:32:46 2025 user.notice netifd: uqmi -d /dev/cdc-wdm0 --timeout 6000 --set-ip-family ipv4 --set-client-id wds,14
12738 Sat Jan 11 18:32:46 2025 user.notice netifd: uqmi -d /dev/cdc-wdm0 --timeout 6000 --set-client-id wds,14 --start-network --profile 1 --ip-family ipv4
12739 Sat Jan 11 18:32:47 2025 daemon.notice netifd: mob1s1a1 (30574): pdh4: -497631584
12740 Sat Jan 11 18:32:47 2025 daemon.notice netifd: mob1s1a1 (30574): -497631584
12741 Sat Jan 11 18:32:47 2025 user.notice netifd: uqmi -d /dev/cdc-wdm0 --timeout 6000 --get-client-id wds
12742 Sat Jan 11 18:32:47 2025 daemon.notice netifd: mob1s1a1 (30574): 15
12743 Sat Jan 11 18:32:47 2025 daemon.notice netifd: mob1s1a1 (30574): cid6: 15
12744 Sat Jan 11 18:32:47 2025 user.notice netifd: uqmi -d /dev/cdc-wdm0 --timeout 6000 --wds-bind-mux-data-port --mux-id 1 --ep-iface-number 4 --set-client-id wds,15
12745 Sat Jan 11 18:32:47 2025 user.notice netifd: uqmi -d /dev/cdc-wdm0 --timeout 6000 --set-ip-family ipv6 --set-client-id wds,15
12746 Sat Jan 11 18:32:47 2025 user.notice netifd: uqmi -d /dev/cdc-wdm0 --timeout 6000 --set-client-id wds,15 --start-network --ip-family ipv6 --profile 1
12747 Sat Jan 11 18:32:47 2025 daemon.notice netifd: mob1s1a1 (30574): pdh6: -498184368
12748 Sat Jan 11 18:32:47 2025 daemon.notice netifd: mob1s1a1 (30574): -498184368
12749 Sat Jan 11 18:32:47 2025 daemon.info gsmd[2051]: Modem 2-1 [2c7c:0800] URC Event: ESM reject cause => Requested service option not subscribed
12750 Sat Jan 11 18:32:47 2025 daemon.notice netifd: mob1s1a1 (30574): Setting up qmimux0
12751 Sat Jan 11 18:32:47 2025 daemon.notice netifd: mob1s1a1 (30574): Setting configured MTU: 1500 on qmimux0
12752 Sat Jan 11 18:32:47 2025 daemon.notice netifd: Interface ‘mob1s1a1’ is now up
12753 Sat Jan 11 18:32:47 2025 daemon.notice netifd: Network device ‘wwan0’ link is up
12754 Sat Jan 11 18:32:47 2025 daemon.notice netifd: mob1s1a1 (30574): Setting up qmimux0 V4 DCHP
12755 Sat Jan 11 18:32:47 2025 daemon.notice netifd: Interface ‘mob1s1a1_4’ is enabled
12756 Sat Jan 11 18:32:47 2025 daemon.notice netifd: Network device ‘qmimux0’ link is up
12757 Sat Jan 11 18:32:47 2025 daemon.notice netifd: Interface ‘mob1s1a1_4’ has link connectivity
12758 Sat Jan 11 18:32:47 2025 daemon.notice netifd: Interface ‘mob1s1a1_4’ is setting up now
12759 Sat Jan 11 18:32:47 2025 daemon.notice netifd: mob1s1a1 (30574): Setting up qmimux0 V6 static
12760 Sat Jan 11 18:32:47 2025 daemon.notice netifd: mob1s1a1 (30574): {
12761 Sat Jan 11 18:32:47 2025 daemon.notice netifd: mob1s1a1 (30574): “pdp-type”: “ipv4v6”,
12762 Sat Jan 11 18:32:47 2025 daemon.notice netifd: mob1s1a1 (30574): “ip-family”: “ipv6”,
12763 Sat Jan 11 18:32:47 2025 daemon.notice netifd: mob1s1a1 (30574): “mtu”: 1500,
12764 Sat Jan 11 18:32:47 2025 daemon.notice netifd: mob1s1a1 (30574): “ipv4”: {
12765 Sat Jan 11 18:32:47 2025 daemon.notice netifd: mob1s1a1 (30574):
12766 Sat Jan 11 18:32:47 2025 daemon.notice netifd: mob1s1a1 (30574): },
12767 Sat Jan 11 18:32:47 2025 daemon.notice netifd: mob1s1a1 (30574): “ipv6”: {
12768 Sat Jan 11 18:32:47 2025 daemon.notice netifd: mob1s1a1 (30574): “ip”: “2001:14bb:6d8:8223:e90f:bc4e:cb41:e178”,
12769 Sat Jan 11 18:32:47 2025 daemon.notice netifd: mob1s1a1 (30574): “ip-prefix-length”: 64,
12770 Sat Jan 11 18:32:47 2025 daemon.notice netifd: mob1s1a1 (30574): “gateway”: “2001:14bb:6d8:8223:c9a0:13ce:b8ba:b0b8”,
12771 Sat Jan 11 18:32:47 2025 daemon.notice netifd: mob1s1a1 (30574): “gw-prefix-length”: 64,
12772 Sat Jan 11 18:32:47 2025 daemon.notice netifd: mob1s1a1 (30574): “dns1”: “2001:14b8:1000::1”,
12773 Sat Jan 11 18:32:47 2025 daemon.notice netifd: mob1s1a1 (30574): “dns2”: “2001:14b8:1000::2”
12774 Sat Jan 11 18:32:47 2025 daemon.notice netifd: mob1s1a1 (30574): },
12775 Sat Jan 11 18:32:47 2025 daemon.notice netifd: mob1s1a1 (30574): “domain-names”: {
12776 Sat Jan 11 18:32:47 2025 daemon.notice netifd: mob1s1a1 (30574):
12777 Sat Jan 11 18:32:47 2025 daemon.notice netifd: mob1s1a1 (30574): }
12778 Sat Jan 11 18:32:47 2025 daemon.notice netifd: mob1s1a1 (30574): }
12779 Sat Jan 11 18:32:47 2025 daemon.notice netifd: mob1s1a1 (30574): uci: Entry not found
12780 Sat Jan 11 18:32:47 2025 daemon.notice netifd: Interface ‘mob1s1a1_6’ is enabled
12781 Sat Jan 11 18:32:47 2025 daemon.notice netifd: Interface ‘mob1s1a1_6’ is setting up now
12782 Sat Jan 11 18:32:47 2025 daemon.notice netifd: Interface ‘mob1s1a1_6’ is now up
12783 Sat Jan 11 18:32:47 2025 daemon.notice netifd: Interface ‘mob1s1a1_6’ has link connectivity
12784 Sat Jan 11 18:32:47 2025 daemon.info mobifd: Auto APN is disabled for ‘mob1s1a1’. Skipping Ping To DNS functionality
12785 Sat Jan 11 18:32:47 2025 daemon.info mobifd: Connection setup completed for ‘mob1s1a1’
12786 Sat Jan 11 18:32:47 2025 daemon.info mobifd: Connection setup completed for modem: ‘gsm.modem0’
12787 Sat Jan 11 18:32:47 2025 daemon.info dnsmasq[1898]: reading /tmp/resolv.conf.d/resolv.conf.auto
12788 Sat Jan 11 18:32:47 2025 daemon.info dnsmasq[1898]: using nameserver 2001:14b8:1000::1#53
12789 Sat Jan 11 18:32:47 2025 daemon.info dnsmasq[1898]: using nameserver 2001:14b8:1000::2#53
12790 Sat Jan 11 18:32:47 2025 daemon.info dnsmasq[1898]: using only locally-known addresses for test
12791 Sat Jan 11 18:32:47 2025 daemon.info dnsmasq[1898]: using only locally-known addresses for onion
12792 Sat Jan 11 18:32:47 2025 daemon.info dnsmasq[1898]: using only locally-known addresses for localhost
12793 Sat Jan 11 18:32:47 2025 daemon.info dnsmasq[1898]: using only locally-known addresses for local
12794 Sat Jan 11 18:32:47 2025 daemon.info dnsmasq[1898]: using only locally-known addresses for invalid
12795 Sat Jan 11 18:32:47 2025 daemon.info dnsmasq[1898]: using only locally-known addresses for bind
12796 Sat Jan 11 18:32:47 2025 daemon.info dnsmasq[1898]: using only locally-known addresses for lan
12797 Sat Jan 11 18:32:47 2025 daemon.notice netifd: mob1s1a1_4 (30962): udhcpc: started, v1.34.1
12798 Sat Jan 11 18:32:47 2025 daemon.notice netifd: mob1s1a1_4 (30962): udhcpc: broadcasting discover
12799 Sat Jan 11 18:32:48 2025 daemon.notice netifd: mob1s1a1_4 (30962): udhcpc: broadcasting select for 37.33.15.84, server 37.33.15.85
12800 Sat Jan 11 18:32:48 2025 user.notice firewall: Reloading firewall due to ifup of mob1s1a1 (wwan0)
12801 Sat Jan 11 18:32:48 2025 daemon.notice netifd: mob1s1a1_4 (30962): udhcpc: lease of 37.33.15.84 obtained from 37.33.15.85, lease time 7200
12802 Sat Jan 11 18:32:48 2025 daemon.notice netifd: Interface ‘mob1s1a1_4’ is now up
12803 Sat Jan 11 18:32:48 2025 daemon.info dnsmasq[1898]: reading /tmp/resolv.conf.d/resolv.conf.auto
12804 Sat Jan 11 18:32:48 2025 daemon.info dnsmasq[1898]: using nameserver 62.241.198.245#53
12805 Sat Jan 11 18:32:48 2025 daemon.info dnsmasq[1898]: using nameserver 62.241.198.246#53
12806 Sat Jan 11 18:32:48 2025 daemon.info dnsmasq[1898]: using nameserver 2001:14b8:1000::1#53
12807 Sat Jan 11 18:32:48 2025 daemon.info dnsmasq[1898]: using nameserver 2001:14b8:1000::2#53
12808 Sat Jan 11 18:32:48 2025 daemon.info dnsmasq[1898]: using only locally-known addresses for test
12809 Sat Jan 11 18:32:48 2025 daemon.info dnsmasq[1898]: using only locally-known addresses for onion
12810 Sat Jan 11 18:32:48 2025 daemon.info dnsmasq[1898]: using only locally-known addresses for localhost
12811 Sat Jan 11 18:32:48 2025 daemon.info dnsmasq[1898]: using only locally-known addresses for local
12812 Sat Jan 11 18:32:48 2025 daemon.info dnsmasq[1898]: using only locally-known addresses for invalid
12813 Sat Jan 11 18:32:48 2025 daemon.info dnsmasq[1898]: using only locally-known addresses for bind
12814 Sat Jan 11 18:32:48 2025 daemon.info dnsmasq[1898]: using only locally-known addresses for lan
12815 Sat Jan 11 18:32:49 2025 daemon.notice hostapd: wlan1-1: AP-STA-DISCONNECTED 78:2b:46:ca:9c:34
12816 Sat Jan 11 18:32:49 2025 kern.notice it-lan: WiFi client disconnected: 78:2B:46:CA:9C:34
12817 Sat Jan 11 18:32:49 2025 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 IEEE 802.1X: unauthorizing port
12818 Sat Jan 11 18:32:50 2025 daemon.info dnsmasq[1898]: read /etc/hosts - 12 names
12819 Sat Jan 11 18:32:50 2025 daemon.info dnsmasq[1898]: read /tmp/hosts/dhcp.cfg01411c - 4 names
12820 Sat Jan 11 18:32:50 2025 daemon.info dnsmasq-dhcp[1898]: read /etc/ethers - 0 addresses
12821 Sat Jan 11 18:32:51 2025 user.notice ddns-scripts[30110]: myddns: pid 30110 terminated by sigterm at 2025-01-11 18:32
12822 Sat Jan 11 18:32:52 2025 user.notice firewall: Reloading firewall due to ifup of mob1s1a1_6 (qmimux0)
12823 Sat Jan 11 18:32:52 2025 user.notice ddns-scripts[31529]: myddns: pid 31529 started at 2025-01-11 18:32
12824 Sat Jan 11 18:32:53 2025 kern.warn kernel: [184206.118064] ath10k_ahb a800000.wifi: Spurious quick kickout for STA 78:2b:46:ca:9c:34
12825 Sat Jan 11 18:32:54 2025 kern.warn kernel: [184207.122853] ath10k_ahb a800000.wifi: Spurious quick kickout for STA 78:2b:46:ca:9c:34
12826 Sat Jan 11 18:32:54 2025 daemon.notice hostapd: wlan1-1: AP-STA-DISCONNECTED c8:8a:9a:b7:bb:19
12827 Sat Jan 11 18:32:54 2025 kern.notice it-lan: WiFi client disconnected: C8:8A:9A:B7:BB:19
12828 Sat Jan 11 18:32:54 2025 daemon.info hostapd: wlan1-1: STA c8:8a:9a:b7:bb:19 IEEE 802.1X: unauthorizing port
12829 Sat Jan 11 18:32:55 2025 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 IEEE 802.11: authenticated
12830 Sat Jan 11 18:32:55 2025 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 IEEE 802.11: authenticated
12831 Sat Jan 11 18:32:55 2025 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 IEEE 802.11: authenticated
12832 Sat Jan 11 18:32:55 2025 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 IEEE 802.11: authenticated
12833 Sat Jan 11 18:32:55 2025 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 IEEE 802.11: authenticated
12834 Sat Jan 11 18:32:55 2025 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 IEEE 802.11: authenticated
12835 Sat Jan 11 18:32:55 2025 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 IEEE 802.11: associated (aid 2)
12836 Sat Jan 11 18:32:55 2025 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 IEEE 802.1X: unauthorizing port
12837 Sat Jan 11 18:32:55 2025 daemon.notice hostapd: wlan1-1: STA-OPMODE-SMPS-MODE-CHANGED 78:2b:46:ca:9c:34 off
12838 Sat Jan 11 18:32:55 2025 daemon.notice hostapd: wlan1-1: AP-STA-CONNECTED 78:2b:46:ca:9c:34 auth_alg=open
12839 Sat Jan 11 18:32:55 2025 kern.notice it-lan: WiFi client connected: 78:2B:46:CA:9C:34
12840 Sat Jan 11 18:32:55 2025 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 IEEE 802.1X: authorizing port
12841 Sat Jan 11 18:32:55 2025 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 RADIUS: starting accounting session E9AE2213E6E50A33
12842 Sat Jan 11 18:32:55 2025 daemon.info hostapd: wlan1-1: STA 78:2b:46:ca:9c:34 WPA: pairwise key handshake completed (RSN)
12843 Sat Jan 11 18:32:55 2025 daemon.notice hostapd: wlan1-1: EAPOL-4WAY-HS-COMPLETED 78:2b:46:ca:9c:34
12844 Sat Jan 11 18:32:56 2025 kern.info Mobile data connected (internal modem)
12845 Sat Jan 11 18:32:56 2025 kern.info Joined 5G-NSA network (internal modem)
12846 Sat Jan 11 18:32:56 2025 kern.info Connected to DNA DNA operator (internal modem)
12847 Sat Jan 11 18:32:57 2025 user.notice ddns-scripts[31529]: myddns: pid 31529 terminated by sigterm at 2025-01-11 18:32
12848 Sat Jan 11 18:32:57 2025 user.notice firewall: Reloading firewall due to ifup of mob1s1a1_4 (qmimux0)
12849 Sat Jan 11 18:32:58 2025 daemon.info dnsmasq-dhcp[1898]: DHCPREQUEST(br-lan) 10.0.0.169 78:2b:46:ca:9c:34
12850 Sat Jan 11 18:32:58 2025 daemon.info dnsmasq-dhcp[1898]: DHCPACK(br-lan) 10.0.0.169 78:2b:46:ca:9c:34 ultra-win
12851 Sat Jan 11 18:32:58 2025 user.notice ddns-scripts[32118]: myddns: pid 32118 started at 2025-01-11 18:32
12852 Sat Jan 11 18:32:59 2025 kern.notice IPv4 connectivity restored
12853 Sat Jan 11 18:32:59 2025 kern.notice IPv6 connectivity restored
12854 Sat Jan 11 18:32:59 2025 daemon.info dnsmasq[1898]: read /etc/hosts - 12 names
12855 Sat Jan 11 18:32:59 2025 daemon.info dnsmasq[1898]: read /tmp/hosts/dhcp.cfg01411c - 4 names
12856 Sat Jan 11 18:32:59 2025 daemon.info dnsmasq-dhcp[1898]: read /etc/ethers - 0 addresses
12857 Sat Jan 11 18:33:00 2025 kern.info Mobile data connected (internal modem)
12858 Sat Jan 11 18:33:00 2025 kern.info Joined 5G-NSA network (internal modem)
12859 Sat Jan 11 18:33:00 2025 kern.info Connected to DNA DNA operator (internal modem)
12860 Sat Jan 11 18:33:02 2025 user.notice ddns-scripts[32118]: myddns: pid 32118 terminated by sigterm at 2025-01-11 18:33
12861 Sat Jan 11 18:33:02 2025 user.notice ddns-scripts[414]: myddns: pid 414 started at 2025-01-11 18:33
12862 Sat Jan 11 18:33:21 2025 kern.info kernel: [184234.109076] usb 2-1: USB disconnect, device number 21
12863 Sat Jan 11 18:33:21 2025 kern.info kernel: [184234.109491] option1 ttyUSB0: GSM modem (1-port) converter now disconnected from ttyUSB0
12864 Sat Jan 11 18:33:21 2025 kern.info kernel: [184234.113211] option 2-1:1.0: device disconnected
12865 Sat Jan 11 18:33:21 2025 kern.info kernel: [184234.122415] option1 ttyUSB1: GSM modem (1-port) converter now disconnected from ttyUSB1
12866 Sat Jan 11 18:33:21 2025 kern.info kernel: [184234.126144] option 2-1:1.1: device disconnected
12867 Sat Jan 11 18:33:21 2025 kern.info kernel: [184234.135902] option1 ttyUSB2: GSM modem (1-port) converter now disconnected from ttyUSB2
12868 Sat Jan 11 18:33:21 2025 kern.info kernel: [184234.139756] option 2-1:1.2: device disconnected
12869 Sat Jan 11 18:33:21 2025 kern.info kernel: [184234.148072] option1 ttyUSB3: GSM modem (1-port) converter now disconnected from ttyUSB3
12870 Sat Jan 11 18:33:21 2025 kern.info kernel: [184234.151549] option 2-1:1.3: device disconnected
12871 Sat Jan 11 18:33:21 2025 daemon.notice netifd: Network device ‘qmimux0’ link is down
12872 Sat Jan 11 18:33:21 2025 daemon.notice netifd: Interface ‘mob1s1a1_4’ has link connectivity loss
12873 Sat Jan 11 18:33:21 2025 daemon.notice netifd: Interface ‘mob1s1a1_6’ has link connectivity loss
12874 Sat Jan 11 18:33:21 2025 daemon.notice netifd: Interface ‘mob1s1a1_6’ is now down
12875 Sat Jan 11 18:33:21 2025 daemon.warn dnsmasq[1898]: no servers found in /tmp/resolv.conf.d/resolv.conf.auto, will retry
12876 Sat Jan 11 18:33:21 2025 user.warn kernel: [184234.198594] [01-serial-symlink.sh] New device ttyUSB0 at /devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1/2-1:1.0/ttyUSB0/tty/ttyUSB0 appeared!
12877 Sat Jan 11 18:33:21 2025 kern.info kernel: [184234.326499] qmi_wwan 2-1:1.4 wwan0: unregister ‘qmi_wwan’ usb-xhci-hcd.0.auto-1, WWAN/QMI device
12878 Sat Jan 11 18:33:22 2025 user.warn kernel: [184234.526710] [01-serial-symlink.sh] New device ttyUSB1 at /devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1/2-1:1.1/ttyUSB1/tty/ttyUSB1 appeared!
12879 Sat Jan 11 18:33:22 2025 daemon.notice netifd: Interface ‘mob1s1a1_4’ is disabled
12880 Sat Jan 11 18:33:22 2025 user.warn kernel: [184234.777520] [01-serial-symlink.sh] New device ttyUSB2 at /devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1/2-1:1.2/ttyUSB2/tty/ttyUSB2 appeared!
12881 Sat Jan 11 18:33:22 2025 daemon.notice netifd: Network device ‘wwan0’ link is down
12882 Sat Jan 11 18:33:22 2025 user.warn kernel: [184234.946761] [01-serial-symlink.sh] New device ttyUSB3 at /devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1/2-1:1.3/ttyUSB3/tty/ttyUSB3 appeared!
12883 Sat Jan 11 18:33:22 2025 kern.info Mobile data disconnected (internal modem)
12884 Sat Jan 11 18:33:22 2025 daemon.info gsmd[2051]: [__write:1300] warning: [CMM] Write to 2-1 [2c7c:0800] modem failed: errno 5
12885 Sat Jan 11 18:33:22 2025 daemon.info gsmd[2051]: [common_write_handle:224] warning: [CMM] Failed to send command (0/9 bytes transferred) to 2-1 [2c7c:0800] modem!
12886 Sat Jan 11 18:33:22 2025 daemon.info gsmd[2051]: [__write:1300] warning: [CMM] Write to 2-1 [2c7c:0800] modem failed: errno 5
12887 Sat Jan 11 18:33:22 2025 daemon.info gsmd[2051]: [common_write_handle:224] warning: [CMM] Failed to send command (0/9 bytes transferred) to 2-1 [2c7c:0800] modem!
12888 Sat Jan 11 18:33:22 2025 daemon.info gsmd[2051]: [__write:1300] warning: [CMM] Write to 2-1 [2c7c:0800] modem failed: errno 5
12889 Sat Jan 11 18:33:22 2025 daemon.info gsmd[2051]: [common_write_handle:224] warning: [CMM] Failed to send command (0/9 bytes transferred) to 2-1 [2c7c:0800] modem!
12890 Sat Jan 11 18:33:22 2025 daemon.info gsmd[2051]: [__write:1300] warning: [CMM] Write to 2-1 [2c7c:0800] modem failed: errno 5
12891 Sat Jan 11 18:33:22 2025 daemon.info gsmd[2051]: [common_write_handle:224] warning: [CMM] Failed to send command (0/9 bytes transferred) to 2-1 [2c7c:0800] modem!
12892 Sat Jan 11 18:33:22 2025 daemon.info gsmd[2051]: [__write:1300] warning: [CMM] Write to 2-1 [2c7c:0800] modem failed: errno 5
12893 Sat Jan 11 18:33:22 2025 daemon.info gsmd[2051]: [common_write_handle:224] warning: [CMM] Failed to send command (0/9 bytes transferred) to 2-1 [2c7c:0800] modem!
12894 Sat Jan 11 18:33:22 2025 daemon.notice netifd: mob1s1a1_4 (30962): udhcpc: SIOCGIFINDEX: No such device
12895 Sat Jan 11 18:33:22 2025 daemon.notice netifd: mob1s1a1_4 (30962): udhcpc: received SIGTERM
12896 Sat Jan 11 18:33:22 2025 daemon.notice netifd: mob1s1a1_4 (30962): udhcpc: unicasting a release of 37.33.15.84 to 37.33.15.85
12897 Sat Jan 11 18:33:22 2025 daemon.notice netifd: mob1s1a1_4 (30962): udhcpc: sending release
12898 Sat Jan 11 18:33:22 2025 daemon.notice netifd: mob1s1a1_4 (30962): udhcpc: can’t bind to interface qmimux0: No such device
12899 Sat Jan 11 18:33:22 2025 daemon.notice netifd: mob1s1a1_4 (30962): udhcpc: bindtodevice: No such device
12900 Sat Jan 11 18:33:22 2025 daemon.notice netifd: mob1s1a1_4 (30962): udhcpc: entering released state
12901 Sat Jan 11 18:33:22 2025 daemon.notice netifd: mob1s1a1_4 (30962): Command failed: Permission denied
12902 Sat Jan 11 18:33:22 2025 daemon.notice netifd: Interface ‘mob1s1a1_4’ is now down
12903 Sat Jan 11 18:33:22 2025 daemon.notice netifd: mob1s1a1 (864): Stopping network mob1s1a1
12904 Sat Jan 11 18:33:23 2025 daemon.notice netifd: mob1s1a1 (864): Command failed: Not found
12905 Sat Jan 11 18:33:23 2025 daemon.notice netifd: mob1s1a1 (864): Command failed: Not found
12906 Sat Jan 11 18:33:23 2025 daemon.notice netifd: mob1s1a1 (864): Stopping network on /dev/cdc-wdm0!
12907 Sat Jan 11 18:33:23 2025 user.notice netifd: uqmi -s -d /dev/cdc-wdm0 -t 3000 --set-client-id wds,14 --stop-network 0xFFFFFFFF --autoconnect
12908 Sat Jan 11 18:33:23 2025 daemon.notice netifd: mob1s1a1 (864): Command failed: Permission denied
12909 Sat Jan 11 18:33:23 2025 daemon.notice netifd: Interface ‘mob1s1a1’ is now down
12910 Sat Jan 11 18:33:23 2025 daemon.notice netifd: Interface ‘mob1s1a1’ is setting up now
12911 Sat Jan 11 18:33:23 2025 user.notice netifd: uqmi -s -d /dev/cdc-wdm0 -t 3000 --set-client-id wds,14 --release-client-id wds
12912 Sat Jan 11 18:33:23 2025 daemon.notice netifd: mob1s1a1 (952): wwan[952] Searching for a valid wwan usb device…
12913 Sat Jan 11 18:33:23 2025 daemon.notice netifd: mob1s1a1 (1009): Stopping network mob1s1a1
12914 Sat Jan 11 18:33:23 2025 daemon.notice netifd: mob1s1a1 (1009): Command failed: Not found
12915 Sat Jan 11 18:33:23 2025 daemon.notice netifd: mob1s1a1 (1009): Command failed: Not found
12916 Sat Jan 11 18:33:23 2025 user.notice ddns-scripts[414]: myddns: pid 414 terminated by sigterm at 2025-01-11 18:33
12917 Sat Jan 11 18:33:23 2025 daemon.notice netifd: mob1s1a1 (1009): Command failed: Permission denied
12918 Sat Jan 11 18:33:23 2025 daemon.notice netifd: Interface ‘mob1s1a1’ is now down
12919 Sat Jan 11 18:33:24 2025 user.notice ddns-scripts[1094]: myddns: pid 1094 started at 2025-01-11 18:33
12920 Sat Jan 11 18:33:25 2025 daemon.info dnsmasq[1898]: read /etc/hosts - 12 names
12921 Sat Jan 11 18:33:25 2025 daemon.info dnsmasq[1898]: read /tmp/hosts/dhcp.cfg01411c - 4 names
12922 Sat Jan 11 18:33:25 2025 daemon.info dnsmasq-dhcp[1898]: read /etc/ethers - 0 addresses
12923 Sat Jan 11 18:33:25 2025 kern.info Mobile data disconnected (internal modem)
12924 Sat Jan 11 18:33:26 2025 user.notice netifd: uqmi -s -d /dev/cdc-wdm0 -t 3000 --set-client-id wds,15 --stop-network 0xFFFFFFFF --autoconnect
12925 Sat Jan 11 18:33:26 2025 user.notice netifd: uqmi -s -d /dev/cdc-wdm0 -t 3000 --set-client-id wds,15 --release-client-id wds
12926 Sat Jan 11 18:33:26 2025 user.notice ddns-scripts[1094]: myddns: pid 1094 terminated by sigterm at 2025-01-11 18:33
12927 Sat Jan 11 18:33:27 2025 user.notice ddns-scripts[1791]: myddns: pid 1791 started at 2025-01-11 18:33
12928 Sat Jan 11 18:33:29 2025 user.notice qmux: mob1s1a1 teardown successful
12929 Sat Jan 11 18:33:29 2025 user.notice qmux: mob1s1a1 teardown successful
12930 Sat Jan 11 18:33:31 2025 kern.info kernel: [184244.046524] usb 2-1: new SuperSpeed Gen 1 USB device number 22 using xhci-hcd
12931 Sat Jan 11 18:33:31 2025 kern.info kernel: [184244.227482] option 2-1:1.0: GSM modem (1-port) converter detected
12932 Sat Jan 11 18:33:31 2025 kern.info kernel: [184244.227875] usb 2-1: GSM modem (1-port) converter now attached to ttyUSB0
12933 Sat Jan 11 18:33:31 2025 kern.info kernel: [184244.233358] option 2-1:1.1: GSM modem (1-port) converter detected
12934 Sat Jan 11 18:33:31 2025 kern.info kernel: [184244.240077] usb 2-1: GSM modem (1-port) converter now attached to ttyUSB1
12935 Sat Jan 11 18:33:31 2025 kern.info kernel: [184244.246487] option 2-1:1.2: GSM modem (1-port) converter detected
12936 Sat Jan 11 18:33:31 2025 kern.info kernel: [184244.252897] usb 2-1: GSM modem (1-port) converter now attached to ttyUSB2
12937 Sat Jan 11 18:33:31 2025 kern.info kernel: [184244.259744] option 2-1:1.3: GSM modem (1-port) converter detected
12938 Sat Jan 11 18:33:31 2025 kern.info kernel: [184244.265858] usb 2-1: GSM modem (1-port) converter now attached to ttyUSB3
12939 Sat Jan 11 18:33:31 2025 kern.info kernel: [184244.289118] qmi_wwan 2-1:1.4: cdc-wdm0: USB WDM device
12940 Sat Jan 11 18:33:31 2025 kern.warn kernel: [184244.289365] QMI_WWAN: extending urb size to 31744
12941 Sat Jan 11 18:33:31 2025 kern.info kernel: [184244.294609] qmi_wwan 2-1:1.4 wwan0: register ‘qmi_wwan’ at usb-xhci-hcd.0.auto-1, WWAN/QMI device, 56:eb:1c:90:70:da
12942 Sat Jan 11 18:33:31 2025 user.warn kernel: [184244.328738] [01-serial-symlink.sh] New device ttyUSB0 at /devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1/2-1:1.0/ttyUSB0/tty/ttyUSB0 appeared!
12943 Sat Jan 11 18:33:32 2025 user.warn kernel: [184244.485264] [01-serial-symlink.sh] New device ttyUSB1 at /devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1/2-1:1.1/ttyUSB1/tty/ttyUSB1 appeared!
12944 Sat Jan 11 18:33:32 2025 user.warn kernel: [184244.641099] [01-serial-symlink.sh] New device ttyUSB2 at /devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1/2-1:1.2/ttyUSB2/tty/ttyUSB2 appeared!
12945 Sat Jan 11 18:33:32 2025 user.warn kernel: [184244.795934] [01-serial-symlink.sh] New device ttyUSB3 at /devices/platform/soc/8af8800.usb3/8a00000.dwc3/xhci-hcd.0.auto/usb2/2-1/2-1:1.3/ttyUSB3/tty/ttyUSB3 appeared!
12946 Sat Jan 11 18:33:39 2025 user.err ddns-scripts[1791]: myddns: BusyBox nslookup error: 1
12947 Sat Jan 11 18:33:43 2025 daemon.info hostapd: wlan0-1: STA 00:15:27:c9:2a:df IEEE 802.11: authenticated
12948 Sat Jan 11 18:33:48 2025 daemon.info gsmd[2051]: [ubus_notify_event:299] error: [MODEM_UBUS] Failed to send ubus notify for 2-1 [2c7c:0800] modem!
12949 Sat Jan 11 18:33:48 2025 daemon.info mobifd: [gsm.modem0] Starting modem settings init
12950 Sat Jan 11 18:33:49 2025 user.err ddns-scripts[1791]: myddns: BusyBox nslookup error: 1
12951 Sat Jan 11 18:33:49 2025 user.warn ddns-scripts[1791]: myddns: Get registered/public IP for dnsurl failed - retry 1/0 in 60 seconds
12952 Sat Jan 11 18:33:50 2025 daemon.info mobifd: [gsm.modem0] Modem settings init completed
12953 Sat Jan 11 18:33:50 2025 daemon.info mobifd: [gsm.modem0] Starting connection setup
12954 Sat Jan 11 18:33:50 2025 daemon.info mobifd: [gsm.modem0] Attempting to establish connection to operator with “15s” of timeout
12955 Sat Jan 11 18:33:50 2025 daemon.info mobifd: [gsm.modem0] Connected to operator “DNA DNA”
12956 Sat Jan 11 18:33:51 2025 daemon.info mobifd: [gsm.modem0] -CFUN- Functionality: “Full”
12957 Sat Jan 11 18:33:51 2025 daemon.info mobifd: [gsm.modem0] -COPS- Mode: “Auto”, operator: “DNA DNA”
12958 Sat Jan 11 18:33:51 2025 daemon.info mobifd: [gsm.modem0] -CREG- Mode: “Enabled (with location information)”, status: “Registered, home”, LAC: “412”, cell ID: “1957143”, technology: “E-UTRAN”
12959 Sat Jan 11 18:33:51 2025 daemon.info mobifd: [gsm.modem0] -CGREG- Mode: “Enabled (with location information)”, status: “Not registered”, LAC: “”, cell ID: “”, technology: “Unknown”
12960 Sat Jan 11 18:33:51 2025 daemon.info mobifd: [gsm.modem0] -CEREG- Mode: “Enabled (with location information)”, status: “Registered, home”, LAC: “”, cell ID: “1957143”, technology: “E-UTRAN”
12961 Sat Jan 11 18:33:51 2025 daemon.info mobifd: [gsm.modem0] -C5GREG- Mode: “Enabled (with location information)”, status: “Not registered”, LAC: “”, cell ID: “”, technology: “Unknown”
12962 Sat Jan 11 18:33:51 2025 daemon.info mobifd: [gsm.modem0] IP address on PDP context “1”: “37.33.56.193”
12963 Sat Jan 11 18:33:51 2025 daemon.notice netifd: Interface ‘mob1s1a1’ is setting up now
12964 Sat Jan 11 18:33:51 2025 daemon.notice netifd: mob1s1a1 (2201): wwan[2201] Using wwan usb device on bus 2-1
12965 Sat Jan 11 18:33:51 2025 daemon.notice netifd: mob1s1a1 (2201): wwan[2201] Using proto:qmapv5 device:/dev/cdc-wdm0 iface:wwan0 desc:Quectel RG50X
12966 Sat Jan 11 18:33:52 2025 daemon.notice netifd: mob1s1a1 (2201): Calculated qmimux ifname: qmimux0
12967 Sat Jan 11 18:33:52 2025 user.notice netifd: uqmi -d /dev/cdc-wdm0 --timeout 10000 --set-autoconnect disabled
12968 Sat Jan 11 18:33:54 2025 daemon.notice netifd: mob1s1a1 (2201): Informing driver of raw-ip for wwan0 …
12969 Sat Jan 11 18:33:54 2025 kern.info kernel: [184266.476613] qmi_wwan 2-1:1.4 wwan0: mode: raw IP
12970 Sat Jan 11 18:33:54 2025 user.notice root: uqmi -d /dev/cdc-wdm0 --timeout 6000 --wda-set-data-format --qos-format 0 --link-layer-protocol raw-ip --endpoint-type hsusb --endpoint-iface-number 4 --ul-protocol qmapv5 --dl-protocol qmapv5 --ul-max-datagrams 11 --ul-datagram-max-size 8192 --dl-max-datagrams 62 --dl-datagram-max-size 31744 --dl-min-padding 0
12971 Sat Jan 11 18:33:54 2025 user.notice netifd: uqmi -d /dev/cdc-wdm0 --timeout 6000 --set-client-id wds,14 --release-client-id wds --modify-profile 3gpp,1 --profile-name 1 --roaming-disallowed-flag no
12972 Sat Jan 11 18:33:54 2025 user.notice netifd: uqmi -d /dev/cdc-wdm0 --timeout 6000 --get-client-id wds
12973 Sat Jan 11 18:33:54 2025 daemon.notice netifd: mob1s1a1 (2201): 14
12974 Sat Jan 11 18:33:54 2025 daemon.notice netifd: mob1s1a1 (2201): cid4: 14
12975 Sat Jan 11 18:33:54 2025 user.notice netifd: uqmi -d /dev/cdc-wdm0 --timeout 6000 --wds-bind-mux-data-port --mux-id 1 --ep-iface-number 4 --set-client-id wds,14
12976 Sat Jan 11 18:33:54 2025 user.notice netifd: uqmi -d /dev/cdc-wdm0 --timeout 6000 --set-ip-family ipv4 --set-client-id wds,14
12977 Sat Jan 11 18:33:55 2025 user.notice netifd: uqmi -d /dev/cdc-wdm0 --timeout 6000 --set-client-id wds,14 --start-network --profile 1 --ip-family ipv4
12978 Sat Jan 11 18:33:55 2025 daemon.notice netifd: mob1s1a1 (2201): pdh4: 1766736032
12979 Sat Jan 11 18:33:55 2025 daemon.notice netifd: mob1s1a1 (2201): 1766736032
12980 Sat Jan 11 18:33:55 2025 user.notice netifd: uqmi -d /dev/cdc-wdm0 --timeout 6000 --get-client-id wds
12981 Sat Jan 11 18:33:55 2025 daemon.notice netifd: mob1s1a1 (2201): 15
12982 Sat Jan 11 18:33:55 2025 daemon.notice netifd: mob1s1a1 (2201): cid6: 15
12983 Sat Jan 11 18:33:55 2025 user.notice netifd: uqmi -d /dev/cdc-wdm0 --timeout 6000 --wds-bind-mux-data-port --mux-id 1 --ep-iface-number 4 --set-client-id wds,15
12984 Sat Jan 11 18:33:55 2025 user.notice netifd: uqmi -d /dev/cdc-wdm0 --timeout 6000 --set-ip-family ipv6 --set-client-id wds,15
12985 Sat Jan 11 18:33:55 2025 user.notice netifd: uqmi -d /dev/cdc-wdm0 --timeout 6000 --set-client-id wds,15 --start-network --ip-family ipv6 --profile 1
12986 Sat Jan 11 18:33:55 2025 daemon.notice netifd: mob1s1a1 (2201): pdh6: 1767717728
12987 Sat Jan 11 18:33:55 2025 daemon.notice netifd: mob1s1a1 (2201): 1767717728
12988 Sat Jan 11 18:33:55 2025 daemon.notice netifd: mob1s1a1 (2201): Setting up qmimux0
12989 Sat Jan 11 18:33:55 2025 daemon.notice netifd: mob1s1a1 (2201): Setting configured MTU: 1500 on qmimux0
12990 Sat Jan 11 18:33:55 2025 daemon.notice netifd: Interface ‘mob1s1a1’ is now up
12991 Sat Jan 11 18:33:55 2025 daemon.notice netifd: Network device ‘wwan0’ link is up
12992 Sat Jan 11 18:33:55 2025 daemon.info gsmd[2051]: Modem 2-1 [2c7c:0800] URC Event: ESM reject cause => Requested service option not subscribed
12993 Sat Jan 11 18:33:55 2025 daemon.notice netifd: mob1s1a1 (2201): Setting up qmimux0 V4 DCHP
12994 Sat Jan 11 18:33:55 2025 daemon.notice netifd: Interface ‘mob1s1a1_4’ is enabled
12995 Sat Jan 11 18:33:55 2025 daemon.notice netifd: Network device ‘qmimux0’ link is up
12996 Sat Jan 11 18:33:55 2025 daemon.notice netifd: Interface ‘mob1s1a1_4’ has link connectivity
12997 Sat Jan 11 18:33:55 2025 daemon.notice netifd: Interface ‘mob1s1a1_4’ is setting up now
12998 Sat Jan 11 18:33:55 2025 daemon.notice netifd: mob1s1a1 (2201): Setting up qmimux0 V6 static
12999 Sat Jan 11 18:33:55 2025 daemon.notice netifd: mob1s1a1 (2201): {
13000 Sat Jan 11 18:33:55 2025 daemon.notice netifd: mob1s1a1 (2201): “pdp-type”: “ipv4v6”,
13001 Sat Jan 11 18:33:55 2025 daemon.notice netifd: mob1s1a1 (2201): “ip-family”: “ipv6”,
13002 Sat Jan 11 18:33:55 2025 daemon.notice netifd: mob1s1a1 (2201): “mtu”: 1500,
13003 Sat Jan 11 18:33:55 2025 daemon.notice netifd: mob1s1a1 (2201): “ipv4”: {
13004 Sat Jan 11 18:33:55 2025 daemon.notice netifd: mob1s1a1 (2201):
13005 Sat Jan 11 18:33:55 2025 daemon.notice netifd: mob1s1a1 (2201): },
13006 Sat Jan 11 18:33:55 2025 daemon.notice netifd: mob1s1a1 (2201): “ipv6”: {
13007 Sat Jan 11 18:33:55 2025 daemon.notice netifd: mob1s1a1 (2201): “ip”: “2001:14bb:6db:7d0f:3424:1e29:19c8:767e”,
13008 Sat Jan 11 18:33:55 2025 daemon.notice netifd: mob1s1a1 (2201): “ip-prefix-length”: 64,
13009 Sat Jan 11 18:33:55 2025 daemon.notice netifd: mob1s1a1 (2201): “gateway”: “2001:14bb:6db:7d0f:455c:6798:78b9:103a”,
13010 Sat Jan 11 18:33:55 2025 daemon.notice netifd: mob1s1a1 (2201): “gw-prefix-length”: 64,
13011 Sat Jan 11 18:33:55 2025 daemon.notice netifd: mob1s1a1 (2201): “dns1”: “2001:14b8:1000::1”,
13012 Sat Jan 11 18:33:55 2025 daemon.notice netifd: mob1s1a1 (2201): “dns2”: “2001:14b8:1000::2”
13013 Sat Jan 11 18:33:55 2025 daemon.notice netifd: mob1s1a1 (2201): },
13014 Sat Jan 11 18:33:55 2025 daemon.notice netifd: mob1s1a1 (2201): “domain-names”: {
13015 Sat Jan 11 18:33:55 2025 daemon.notice netifd: mob1s1a1 (2201):
13016 Sat Jan 11 18:33:55 2025 daemon.notice netifd: mob1s1a1 (2201): }
13017 Sat Jan 11 18:33:55 2025 daemon.notice netifd: mob1s1a1 (2201): }
13018 Sat Jan 11 18:33:55 2025 daemon.notice netifd: mob1s1a1 (2201): uci: Entry not found
13019 Sat Jan 11 18:33:55 2025 daemon.notice netifd: Interface ‘mob1s1a1_6’ is enabled
13020 Sat Jan 11 18:33:55 2025 daemon.notice netifd: Interface ‘mob1s1a1_6’ is setting up now
13021 Sat Jan 11 18:33:55 2025 daemon.info mobifd: Auto APN is disabled for ‘mob1s1a1’. Skipping Ping To DNS functionality
13022 Sat Jan 11 18:33:55 2025 daemon.notice netifd: Interface ‘mob1s1a1_6’ is now up
13023 Sat Jan 11 18:33:55 2025 daemon.notice netifd: Interface ‘mob1s1a1_6’ has link connectivity
13024 Sat Jan 11 18:33:55 2025 daemon.info dnsmasq[1898]: reading /tmp/resolv.conf.d/resolv.conf.auto

Could not post full logs since reply limit.

The device has already been to warranty maintenance, no idea what they did but did not fix the issues. I wanted to buy a higher end modem to get better performance and reliability, but I got the opposite…

Marija · January 13, 2025, 9:45am

Hello,

Regarding the troubleshoot file, we haven’t received any email from you. Could you please ensure that you press Reply when responding to our email, rather than entering our email address directly into the recipient field?

I have sent you an email once again. Please press Reply and attach the troubleshooting package.

Thank you.

Best regards,

it-mies · January 13, 2025, 9:58am

Oh.
Sent it again just now.