RM5511E-GL Running On OpenWRT Randmonly Stops Drops/Stops Communicating With Router

[slazinger_7]

We have a RM5511E-GL running on OpenWRT, and OpenWRT seems to periodically drop our router (set up with an Asus iMesh network) from its routing table whereby all the devices connected to the router will no longer have internet access, yet when we remote in to QuecManager via Tailscale, internet speed tests are just fine (i.e., the data communications between the modem and tower are just fine).

During these disconnects, we noticed in Luci that the router IP would disappear from the Active DHCP Leases list in Luci, but the lease was not necessarily ending (rather the disconnects were triggered by other events - see below). We set static IP on the router, in Luci, and even disabled DHCP and IPv6 in Luci, but none of these changes completely fixed the problem (we seem to get less disconnects when setting static IP in both Luci and the router).

We’ve noticed that the drops occur most frequently (but not always) when making VoIP calls through softphone (MicroSIP and Zoiper) and a VTech hardphone, along with browsing websites like Zillow, RedFine, and Amazon. The disconnects don’t seem to occur when streaming, including that things are fine in 4k.

These disconnects can last anywhere from a few seconds to 10-20 minutes. During this time, the logs show the following repeated:

Thu Aug 21 12:10:35 2025 user.notice QCMAP: 2025-08-21 12:10:35 [ippt.sh][ql_update_ippt_dhcp_host][2204] vlan:0; MAC: cc:28:aa:e7:5e:f0
Thu Aug 21 12:10:36 2025 user.notice root: ippt.sh:2666:Invalid option
Thu Aug 21 12:10:36 2025 user.notice root: ippt.sh:2666:Invalid option
Thu Aug 21 12:10:36 2025 user.notice root: Invalid option
Thu Aug 21 12:10:36 2025 user.notice QCMAP: 2025-08-21 12:10:36 [ippt.sh][ql_update_ippt_dhcp_host][2204] vlan:0; MAC: cc:28:aa:e7:5e:f0
Thu Aug 21 12:10:37 2025 user.notice root: ippt.sh:2666:Invalid option
Thu Aug 21 12:10:37 2025 user.notice root: ippt.sh:2666:Invalid option
Thu Aug 21 12:10:37 2025 user.notice root: Invalid option
Thu Aug 21 12:10:37 2025 user.notice QCMAP: 2025-08-21 12:10:37 [ippt.sh][ql_update_ippt_dhcp_host][2204] vlan:0; MAC: cc:28:aa:e7:5e:f0
Thu Aug 21 12:10:38 2025 user.notice root: ippt.sh:2666:Invalid option
Thu Aug 21 12:10:38 2025 user.notice root: ippt.sh:2666:Invalid option
Thu Aug 21 12:10:38 2025 user.notice root: Invalid option
Thu Aug 21 12:10:38 2025 user.notice QCMAP: 2025-08-21 12:10:38 [ippt.sh][ql_update_ippt_dhcp_host][2204] vlan:0; MAC: cc:28:aa:e7:5e:f0
Thu Aug 21 12:10:39 2025 user.notice root: ippt.sh:2666:Invalid option
Thu Aug 21 12:10:39 2025 user.notice root: ippt.sh:2666:Invalid option
Thu Aug 21 12:10:39 2025 user.notice root: Invalid option

The MAC address is the router.

As a more detailed example, we experienced a disconnect around 08/21/2025 12:04:54 PM, and the router reconnected about 6 minutes later at 08/21/2025 12:11:01 PM. The expanded logs show the following:

Thu Aug 21 12:04:01 2025 daemon.debug at_queue: Queue processing paused, token held by FETCH_DATA_1755803040_19826
Thu Aug 21 12:04:06 2025 daemon.debug at_queue: Queue processing paused, token held by FETCH_DATA_1755803045_20437
Thu Aug 21 12:04:11 2025 daemon.debug at_queue: Queue processing paused, token held by FETCH_DATA_1755803051_21045
Thu Aug 21 12:04:14 2025 user.info LocSvc_LocationIntegrationApiIm[6668]: proc:459] >-- onReceive Rcvd msg id: 99, sockname: locapiservice, payload size: 160
Thu Aug 21 12:04:14 2025 user.warn LocSvc_LocationIntegrationApiIm[6668]: proc:600] <<< unknown message 99
Thu Aug 21 12:04:14 2025 user.info LocSvc_LocationClientApi[6668]: proc:3286] >-- onReceive Rcvd msg id: 99 E_LOCAPI_PINGTEST_MSG_ID, sockname: locapiservice, payload size: 160
Thu Aug 21 12:04:16 2025 daemon.debug at_queue: Queue processing paused, token held by FETCH_DATA_1755803055_21640
Thu Aug 21 12:04:18 2025 daemon.err at_queue_manager.sh[10069]: cat: can’t open ‘/tmp/at_queue/token’: No such file or directory
Thu Aug 21 12:04:18 2025 daemon.err at_queue_manager.sh[10069]: Failed to parse json data: unexpected end of data
Thu Aug 21 12:04:18 2025 daemon.warn at_queue: Removing expired token from FETCH_DATA_1755803058_21922
Thu Aug 21 12:04:19 2025 daemon.info at_queue: Processing all metrics with token METRICS_1755803059_10070
Thu Aug 21 12:04:21 2025 daemon.debug at_queue: Queue processing paused, token held by METRICS_1755803059_10070
Thu Aug 21 12:04:21 2025 daemon.info at_queue: Metrics processing completed
Thu Aug 21 12:04:26 2025 daemon.debug at_queue: Queue processing paused, token held by FETCH_DATA_1755803066_23238
Thu Aug 21 12:04:31 2025 daemon.debug at_queue: Queue processing paused, token held by FETCH_DATA_1755803071_23845
Thu Aug 21 12:04:36 2025 daemon.debug at_queue: Queue processing paused, token held by FETCH_DATA_1755803076_24451
Thu Aug 21 12:04:41 2025 daemon.debug at_queue: Queue processing paused, token held by FETCH_DATA_1755803081_25050
Thu Aug 21 12:04:43 2025 daemon.err at_queue_manager.sh[10069]: cat: can’t open ‘/tmp/at_queue/token’: No such file or directory
Thu Aug 21 12:04:43 2025 daemon.err at_queue_manager.sh[10069]: Failed to parse json data: unexpected end of data
Thu Aug 21 12:04:43 2025 daemon.err at_queue_manager.sh[10069]: cat: can’t open ‘/tmp/at_queue/token’: No such file or directory
Thu Aug 21 12:04:43 2025 daemon.err at_queue_manager.sh[10069]: Failed to parse json data: unexpected end of data
Thu Aug 21 12:04:43 2025 daemon.warn at_queue: Removing expired token from
Thu Aug 21 12:04:46 2025 daemon.debug at_queue: Queue processing paused, token held by FETCH_DATA_1755803086_25662
Thu Aug 21 12:04:48 2025 daemon.err at_queue_manager.sh[10069]: cat: can’t open ‘/tmp/at_queue/token’: No such file or directory
Thu Aug 21 12:04:48 2025 daemon.err at_queue_manager.sh[10069]: Failed to parse json data: unexpected end of data
Thu Aug 21 12:04:48 2025 daemon.err at_queue_manager.sh[10069]: cat: can’t open ‘/tmp/at_queue/token’: No such file or directory
Thu Aug 21 12:04:48 2025 daemon.err at_queue_manager.sh[10069]: Failed to parse json data: unexpected end of data
Thu Aug 21 12:04:48 2025 daemon.warn at_queue: Removing expired token from
Thu Aug 21 12:04:52 2025 daemon.info quecprofiles_daemon: Performing profile check (forced=0)
Thu Aug 21 12:04:52 2025 daemon.info quecprofiles_daemon: Fetching all modem data at once
Thu Aug 21 12:04:53 2025 daemon.debug quecprofiles_daemon: Attempting to acquire AT queue token with priority 3
Thu Aug 21 12:04:53 2025 daemon.debug quecprofiles_daemon: Successfully acquired token with ID QUECPROFILES_1755803092_16199
Thu Aug 21 12:04:53 2025 daemon.debug at_queue: Queue processing paused, token held by QUECPROFILES_1755803092_16199
Thu Aug 21 12:04:53 2025 daemon.debug quecprofiles_daemon: Executing command: AT+ICCID
Thu Aug 21 12:04:53 2025 daemon.debug quecprofiles_daemon: Executing AT command: AT+ICCID (timeout: 5s)
Thu Aug 21 12:04:53 2025 daemon.debug quecprofiles_daemon: AT command executed, status: 0
Thu Aug 21 12:04:53 2025 daemon.debug quecprofiles_daemon: Executing command: AT+CGDCONT?
Thu Aug 21 12:04:53 2025 daemon.debug quecprofiles_daemon: Executing AT command: AT+CGDCONT? (timeout: 5s)
Thu Aug 21 12:04:53 2025 daemon.debug quecprofiles_daemon: AT command executed, status: 0
Thu Aug 21 12:04:53 2025 daemon.debug quecprofiles_daemon: Executing command: AT+QNWPREFCFG=“mode_pref”
Thu Aug 21 12:04:53 2025 daemon.debug quecprofiles_daemon: Executing AT command: AT+QNWPREFCFG=“mode_pref” (timeout: 5s)
Thu Aug 21 12:04:53 2025 daemon.debug quecprofiles_daemon: AT command executed, status: 0
Thu Aug 21 12:04:53 2025 daemon.debug quecprofiles_daemon: Executing command: AT+QNWPREFCFG=“lte_band”
Thu Aug 21 12:04:53 2025 daemon.debug quecprofiles_daemon: Executing AT command: AT+QNWPREFCFG=“lte_band” (timeout: 5s)
Thu Aug 21 12:04:53 2025 daemon.debug quecprofiles_daemon: AT command executed, status: 0
Thu Aug 21 12:04:53 2025 daemon.debug quecprofiles_daemon: Executing command: AT+QNWPREFCFG=“nsa_nr5g_band”
Thu Aug 21 12:04:53 2025 daemon.debug quecprofiles_daemon: Executing AT command: AT+QNWPREFCFG=“nsa_nr5g_band” (timeout: 5s)
Thu Aug 21 12:04:53 2025 daemon.debug quecprofiles_daemon: AT command executed, status: 0
Thu Aug 21 12:04:53 2025 daemon.debug quecprofiles_daemon: Executing command: AT+QNWPREFCFG=“nr5g_band”
Thu Aug 21 12:04:53 2025 daemon.debug quecprofiles_daemon: Executing AT command: AT+QNWPREFCFG=“nr5g_band” (timeout: 5s)
Thu Aug 21 12:04:53 2025 daemon.debug quecprofiles_daemon: AT command executed, status: 0
Thu Aug 21 12:04:53 2025 daemon.debug quecprofiles_daemon: Executing command: AT+CGSN
Thu Aug 21 12:04:53 2025 daemon.debug quecprofiles_daemon: Executing AT command: AT+CGSN (timeout: 5s)
Thu Aug 21 12:04:53 2025 daemon.debug quecprofiles_daemon: AT command executed, status: 0
Thu Aug 21 12:04:53 2025 daemon.err at_queue_manager.sh[10069]: cat: can’t open ‘/tmp/at_queue/token’: No such file or directory
Thu Aug 21 12:04:53 2025 daemon.err at_queue_manager.sh[10069]: Failed to parse json data: unexpected end of data
Thu Aug 21 12:04:53 2025 daemon.debug quecprofiles_daemon: Released token QUECPROFILES_1755803092_16199
Thu Aug 21 12:04:53 2025 daemon.warn at_queue: Removing expired token from QUECPROFILES_1755803092_16199
Thu Aug 21 12:04:53 2025 daemon.info quecprofiles_daemon: Extracted ICCID: 89148000010618448245
Thu Aug 21 12:04:53 2025 daemon.info quecprofiles_daemon: Current ICCID: 89148000010618448245
Thu Aug 21 12:04:53 2025 daemon.info quecprofiles_daemon: Looking for profile with ICCID: 89148000010618448245
Thu Aug 21 12:04:53 2025 daemon.info quecprofiles_daemon: Found matching profile: @profile[0]
Thu Aug 21 12:04:53 2025 daemon.debug quecprofiles_daemon: Found valid profile index: @profile[0]
Thu Aug 21 12:04:53 2025 daemon.info quecprofiles_daemon: Found profile: Visible for ICCID: 89148000010618448245
Thu Aug 21 12:04:53 2025 daemon.info quecprofiles_daemon: Profile settings: network_type=LTE, lte_bands=, sa_nr5g_bands=, nsa_nr5g_bands=, apn=vzwinternet, pdp_type=IP, imei=353050682779648, ttl=64
Thu Aug 21 12:04:53 2025 daemon.info quecprofiles_daemon: Profile ‘Visible’ already applied at Tue Aug 19 20:00:17 PDT 2025
Thu Aug 21 12:04:53 2025 daemon.info quecprofiles_daemon: Profile ‘Visible’ is already applied, skipping
Thu Aug 21 12:04:53 2025 daemon.info quecprofiles_daemon: Status updated: success - Profile already applied (from flag) (100%)
Thu Aug 21 12:04:53 2025 daemon.info quecprofiles_daemon: Sleeping for 60 seconds
Thu Aug 21 12:05:14 2025 user.info LocSvc_LocationClientApi[6668]: proc:3286] >-- onReceive Rcvd msg id: 99 E_LOCAPI_PINGTEST_MSG_ID, sockname: locapiservice, payload size: 160
Thu Aug 21 12:05:14 2025 user.info LocSvc_LocationIntegrationApiIm[6668]: proc:459] >-- onReceive Rcvd msg id: 99, sockname: locapiservice, payload size: 160
Thu Aug 21 12:05:14 2025 user.warn LocSvc_LocationIntegrationApiIm[6668]: proc:600] <<< unknown message 99
Thu Aug 21 12:05:16 2025 user.notice root: ippt.sh:2666:Invalid option
Thu Aug 21 12:05:16 2025 user.notice root: ippt.sh:2666:Invalid option
Thu Aug 21 12:05:16 2025 user.notice root: Invalid option
Thu Aug 21 12:05:16 2025 user.notice QCMAP: 2025-08-21 12:05:16 [ippt.sh][ql_update_ippt_dhcp_host][2204] vlan:0; MAC: cc:28:aa:e7:5e:f0
Thu Aug 21 12:05:17 2025 user.notice root: ippt.sh:2666:Invalid option
Thu Aug 21 12:05:17 2025 user.notice root: ippt.sh:2666:Invalid option
Thu Aug 21 12:05:17 2025 user.notice root: Invalid option
Thu Aug 21 12:05:17 2025 user.notice QCMAP: 2025-08-21 12:05:17 [ippt.sh][ql_update_ippt_dhcp_host][2204] vlan:0; MAC: cc:28:aa:e7:5e:f0
…
Thu Aug 21 12:05:21 2025 daemon.info at_queue: Processing all metrics with token METRICS_1755803121_10070
Thu Aug 21 12:05:21 2025 daemon.debug at_queue: Queue processing paused, token held by METRICS_1755803121_10070
…
Thu Aug 21 12:09:17 2025 daemon.info dnsmasq-dhcp[2723]: DHCPRELEASE(br-lan) 192.168.227.15 cc:28:aa:e7:5e:f0 unknown lease
Thu Aug 21 12:09:17 2025 user.notice QCMAP: 2025-08-21 12:09:17 [ippt.sh][ql_update_ippt_dhcp_host][2204] vlan:0; MAC: cc:28:aa:e7:5e:f0
Thu Aug 21 12:09:17 2025 user.notice QCMAP: 2025-08-21 12:09:17 [lanUtils.sh][util_dhcp_release][2160] interface=br-lan:ip_addr=192.168.227.15:mac_addr=cc:28:aa:e7:5e:f0
Thu Aug 21 12:09:17 2025 user.notice QCMAP: 2025-08-21 12:09:17 [lanUtils.sh][util_dhcp_release][2204] IPPT is not active on profile_idx=0, return
Thu Aug 21 12:09:18 2025 user.notice root: ippt.sh:2666:Invalid option
Thu Aug 21 12:09:18 2025 user.notice root: ippt.sh:2666:Invalid option
Thu Aug 21 12:09:18 2025 user.notice root: Invalid option
Thu Aug 21 12:09:18 2025 user.notice QCMAP: 2025-08-21 12:09:18 [ippt.sh][ql_update_ippt_dhcp_host][2204] vlan:0; MAC: cc:28:aa:e7:5e:f0
…
Thu Aug 21 12:10:32 2025 user.notice QCMAP: 2025-08-21 12:10:32 [ippt.sh][ql_update_ippt_dhcp_host][2204] vlan:0; MAC: cc:28:aa:e7:5e:f0
Thu Aug 21 12:10:33 2025 daemon.info at_queue: Processing all metrics with token METRICS_1755803433_10070
Thu Aug 21 12:10:33 2025 daemon.debug at_queue: Queue processing paused, token held by METRICS_1755803433_10070
Thu Aug 21 12:10:33 2025 daemon.info dnsmasq-dhcp[2723]: DHCPRELEASE(br-lan) 192.168.227.15 cc:28:aa:e7:5e:f0 unknown lease
Thu Aug 21 12:10:33 2025 user.notice QCMAP: 2025-08-21 12:10:33 [lanUtils.sh][util_dhcp_release][2160] interface=br-lan:ip_addr=192.168.227.15:mac_addr=cc:28:aa:e7:5e:f0
Thu Aug 21 12:10:33 2025 user.notice QCMAP: 2025-08-21 12:10:33 [lanUtils.sh][util_dhcp_release][2204] IPPT is not active on profile_idx=0, return
Thu Aug 21 12:10:33 2025 user.notice root: ippt.sh:2666:Invalid option
Thu Aug 21 12:10:33 2025 user.notice root: ippt.sh:2666:Invalid option
Thu Aug 21 12:10:33 2025 user.notice root: Invalid option
Thu Aug 21 12:10:33 2025 user.notice QCMAP: 2025-08-21 12:10:33 [ippt.sh][ql_update_ippt_dhcp_host][2204] vlan:0; MAC: cc:28:aa:e7:5e:f0
…
Thu Aug 21 12:10:34 2025 user.notice QCMAP: 2025-08-21 12:10:34 [ippt.sh][ql_update_ippt_dhcp_host][2204] vlan:0; MAC: cc:28:aa:e7:5e:f0
Thu Aug 21 12:10:35 2025 user.warn kernel: [163205.668323][ T9471] Deleting Client Conntrack IP:192.168.227.15
Thu Aug 21 12:10:35 2025 daemon.info at_queue: Metrics processing completed
Thu Aug 21 12:10:35 2025 daemon.err at_queue_manager.sh[10069]: cat: can’t open ‘/tmp/at_queue/token’: No such file or directory
Thu Aug 21 12:10:35 2025 daemon.err at_queue_manager.sh[10069]: Failed to parse json data: unexpected end of data
Thu Aug 21 12:10:35 2025 daemon.err at_queue_manager.sh[10069]: cat: can’t open ‘/tmp/at_queue/token’: No such file or directory
Thu Aug 21 12:10:35 2025 daemon.err at_queue_manager.sh[10069]: Failed to parse json data: unexpected end of data
Thu Aug 21 12:10:35 2025 daemon.warn at_queue: Removing expired token from
Thu Aug 21 12:10:35 2025 user.notice root: ippt.sh:2666:Invalid option
Thu Aug 21 12:10:35 2025 user.notice root: ippt.sh:2666:Invalid option
Thu Aug 21 12:10:35 2025 user.notice root: Invalid option
Thu Aug 21 12:10:35 2025 user.notice QCMAP: 2025-08-21 12:10:35 [ippt.sh][ql_update_ippt_dhcp_host][2204] vlan:0; MAC: cc:28:aa:e7:5e:f0
…
Thu Aug 21 12:10:45 2025 user.notice QCMAP: 2025-08-21 12:10:45 [ippt.sh][ql_update_ippt_dhcp_host][2204] vlan:0; MAC: cc:28:aa:e7:5e:f0
Thu Aug 21 12:10:46 2025 user.notice root: ippt.sh:2666:Invalid option
Thu Aug 21 12:10:46 2025 user.notice root: ippt.sh:2666:Invalid option
Thu Aug 21 12:10:46 2025 user.notice root: Invalid option
Thu Aug 21 12:10:46 2025 user.notice QCMAP: 2025-08-21 12:10:46 [ippt.sh][ql_update_ippt_dhcp_host][2204] vlan:0; MAC: cc:28:aa:e7:5e:f0
Thu Aug 21 12:10:48 2025 user.debug LOWI-9.0.1.68[11874]: [LOWINetlinkSocketReceiver] unpackRTMLinkMessage: RTM_NEWLINK - ifname eth0, flags 0x1003 ([UP])
Thu Aug 21 12:10:48 2025 kern.info kernel: [163218.991359][T14949] br-lan: port 1(eth0) entered disabled state
Thu Aug 21 12:10:48 2025 user.debug LOWI-9.0.1.68[11874]: [LOWINetlinkSocketReceiver] unpackRTMLinkMessage: RTM_NEWLINK - ifname eth0, flags 0x1003 ([UP])
Thu Aug 21 12:10:48 2025 kern.info kernel: [163219.001731][T15196] r8125: eth0: link down
Thu Aug 21 12:10:48 2025 user.warn kernel: [163219.003944][T11187] QCMAP:LINK_DOWN message posted
Thu Aug 21 12:10:48 2025 user.warn kernel: [163219.004030][T11188] QCMAP:LINK_DOWN message posted
Thu Aug 21 12:10:48 2025 daemon.notice ttyd[16411]: rops_handle_POLLIN_netlink: DELADDR
Thu Aug 21 12:10:48 2025 kern.info kernel: [163219.032037][T29850] r8125_ioss 0000:01:00.0-ioss: ioss:cfg:(eth0) Unmapped RX-1 event 0x00000000810018a0 → 0x0000000003e188a0
Thu Aug 21 12:10:48 2025 user.warn kernel: [163219.034338][T11204] Deleting Client Conntrack IP:192.168.227.15
Thu Aug 21 12:10:48 2025 kern.info kernel: [163219.046248][T29850] r8125_ioss 0000:01:00.0-ioss: ioss:cfg:(eth0) Unmapped TX-1 event 0x0000000081002d20 → 0x0000000003e18d20
Thu Aug 21 12:10:48 2025 user.notice root: tethering.sh:2666:Invalid option
Thu Aug 21 12:10:48 2025 daemon.info dnsmasq-dhcp[2723]: DHCPRELEASE(br-lan) 192.168.227.15 cc:28:aa:e7:5e:f0 unknown lease
Thu Aug 21 12:10:48 2025 kern.warn kernel: [163219.081937][ T3220] __ipa_add_flt_get_ep_idx: 1 callbacks suppressed
Thu Aug 21 12:10:48 2025 kern.err kernel: [163219.081949][ T3220] ipa __ipa_add_flt_get_ep_idx:1248 ep not connected ep_idx=8
Thu Aug 21 12:10:48 2025 user.notice QCMAP: 2025-08-21 12:10:48 [tethering.sh][639][delete_macsec_from_bridge] macsec not enabled
Thu Aug 21 12:10:48 2025 user.notice QCMAP: 2025-08-21 12:10:48 [lanUtils.sh][util_dhcp_release][2160] interface=br-lan:ip_addr=192.168.227.15:mac_addr=cc:28:aa:e7:5e:f0
Thu Aug 21 12:10:48 2025 user.notice QCMAP: 2025-08-21 12:10:48 [lanUtils.sh][util_dhcp_release][2204] IPPT is not active on profile_idx=0, return
Thu Aug 21 12:10:48 2025 kern.info kernel: [163219.342637][T29850] eth0: 0xffffffc009cb0000, ca:59:6a:74:2f:8c, IRQ 38
Thu Aug 21 12:10:49 2025 user.debug LOWI-9.0.1.68[11874]: [LOWINetlinkSocketReceiver] unpackRTMLinkMessage: RTM_NEWLINK - ifname br-lan, flags 0x1003 ([UP])
Thu Aug 21 12:10:50 2025 user.warn kernel: [163221.109212][T11435] QCMAP:LINK_DOWN Processed
Thu Aug 21 12:10:52 2025 kern.info kernel: [163223.276008][T15196] r8125: eth0: link up
Thu Aug 21 12:10:52 2025 kern.info kernel: [163223.280668][T15196] br-lan: port 1(eth0) entered blocking state
Thu Aug 21 12:10:52 2025 kern.info kernel: [163223.286908][T15196] br-lan: port 1(eth0) entered forwarding state
Thu Aug 21 12:10:52 2025 user.debug LOWI-9.0.1.68[11874]: [LOWINetlinkSocketReceiver] unpackRTMLinkMessage: RTM_NEWLINK - ifname eth0, flags 0x11043 ([UP][RUNNING])
Thu Aug 21 12:10:52 2025 user.debug LOWI-9.0.1.68[11874]: [LOWINetlinkSocketReceiver] unpackRTMLinkMessage: RTM_NEWLINK - ifname eth0, flags 0x11043 ([UP][RUNNING])
Thu Aug 21 12:10:52 2025 user.debug LOWI-9.0.1.68[11874]: [LOWINetlinkSocketReceiver] unpackRTMLinkMessage: RTM_NEWLINK - ifname eth0, flags 0x11043 ([UP][RUNNING])
Thu Aug 21 12:10:52 2025 user.warn kernel: [163223.297564][T11596] QCMAP:ETH mode
Thu Aug 21 12:10:52 2025 user.warn kernel: [163223.297729][T11597] QCMAP:ETH mode
Thu Aug 21 12:10:52 2025 user.debug LOWI-9.0.1.68[11874]: [LOWINetlinkSocketReceiver] unpackRTMLinkMessage: RTM_NEWLINK - ifname br-lan, flags 0x11043 ([UP][RUNNING])
Thu Aug 21 12:10:52 2025 user.warn kernel: [163223.306587][T11601] QCMAP:LINK_UP message posted
Thu Aug 21 12:10:52 2025 kern.info kernel: [163223.312801][T11219] r8125_ioss 0000:01:00.0-ioss: ioss:cfg:(eth0) Voted for IPA bandwidth of 2500 Mbps
Thu Aug 21 12:10:52 2025 user.warn kernel: [163223.314894][T11605] QCMAP:LINK_UP message posted
Thu Aug 21 12:10:52 2025 kern.info kernel: [163223.325456][T11219] r8125_ioss 0000:01:00.0-ioss: ioss:cfg:(eth0) Mapped RX-1 event 0x00000000810018a0 → 0x0000000003e188a0
Thu Aug 21 12:10:52 2025 kern.info kernel: [163223.343799][T11219] r8125_ioss 0000:01:00.0-ioss: ioss:cfg:(eth0) Mapped TX-1 event 0x0000000081002d20 → 0x0000000003e18d20
Thu Aug 21 12:10:52 2025 user.notice root: tethering.sh:2666:Invalid option
Thu Aug 21 12:10:52 2025 user.notice QCMAP: 2025-08-21 12:10:52 [tethering.sh][460][start_macsec] macsec not enabled
Thu Aug 21 12:10:52 2025 user.notice QCMAP: 2025-08-21 12:10:52 [lanUtils.sh][util_inc_dec_restart_link_count][2045] Enter : increment=0 :device_type=4
Thu Aug 21 12:10:52 2025 user.notice QCMAP: 2025-08-21 12:10:52 [lanUtils.sh][util_get_restart_link_count][2023] Enter function
Thu Aug 21 12:10:53 2025 user.notice QCMAP: 2025-08-21 12:10:53 [lanUtils.sh][util_inc_dec_restart_link_count][2049] restart_link_count=0
Thu Aug 21 12:10:53 2025 user.notice QCMAP: 2025-08-21 12:10:53 [lanUtils.sh][util_inc_dec_restart_link_count][2055] Invalid restart_link_count: restart_link_count=0
Thu Aug 21 12:10:54 2025 kern.warn kernel: [163225.298778][ T3220] __ipa3_del_rt_rule: 2 callbacks suppressed
Thu Aug 21 12:10:54 2025 kern.err kernel: [163225.298789][ T3220] ipa __ipa3_del_rt_rule:1823 bad params
Thu Aug 21 12:10:54 2025 kern.warn kernel: [163225.310953][ T3220] ipa3_del_rt_rule: 5 callbacks suppressed
Thu Aug 21 12:10:54 2025 kern.err kernel: [163225.310962][ T3220] ipa ipa3_del_rt_rule:1906 failed to del rt rule 1
Thu Aug 21 12:10:54 2025 kern.warn kernel: [163225.324188][ T3220] __ipa3_del_rt_rule: 2 callbacks suppressed
Thu Aug 21 12:10:54 2025 kern.err kernel: [163225.324198][ T3220] ipa __ipa3_del_rt_rule:1818 lookup failed
Thu Aug 21 12:10:54 2025 user.notice root: ippt.sh:2666:Invalid option
Thu Aug 21 12:10:54 2025 user.notice radio: :QCMAP_ConnectionManager: DecRestartLinkCount: Deleted successfully
Thu Aug 21 12:10:54 2025 user.warn kernel: [163225.377466][T11850] QCMAP:LINK_UP Processed
Thu Aug 21 12:10:55 2025 user.notice root: ippt.sh:2666:Invalid option
Thu Aug 21 12:10:55 2025 user.notice root: Invalid option
Thu Aug 21 12:10:55 2025 user.notice QCMAP: 2025-08-21 12:10:55 [ippt.sh][ql_update_ippt_dhcp_host][2204] vlan:0; MAC: cc:28:aa:e7:5e:f0
Thu Aug 21 12:10:55 2025 user.warn kernel: [163225.471838][T11926] QCMAP:bringup v6
Thu Aug 21 12:10:55 2025 user.notice root: ippt.sh:2666:Invalid option
Thu Aug 21 12:10:55 2025 user.notice root: ippt.sh:2666:Invalid option
Thu Aug 21 12:10:55 2025 user.notice root: Invalid option
Thu Aug 21 12:10:55 2025 user.notice QCMAP: 2025-08-21 12:10:55 [ippt.sh][ql_update_ippt_dhcp_host][2204] vlan:0; MAC: cc:28:aa:e7:5e:f0
Thu Aug 21 12:10:55 2025 user.notice root: ippt.sh:2666:Invalid option
Thu Aug 21 12:10:55 2025 user.notice root: ippt.sh:2666:Invalid option
Thu Aug 21 12:10:55 2025 user.notice root: Invalid option
Thu Aug 21 12:10:55 2025 user.notice QCMAP: 2025-08-21 12:10:55 [ippt.sh][ql_update_ippt_dhcp_host][2204] vlan:0; MAC: cc:28:aa:e7:5e:f0
Thu Aug 21 12:10:56 2025 user.warn kernel: [163226.503350][T12072] QCMAP:bringup v6
Thu Aug 21 12:10:56 2025 user.warn kernel: [163226.565922][T12079] QCMAP:bringup v6
Thu Aug 21 12:10:56 2025 user.warn kernel: [163226.613942][T12087] QCMAP:bringup v6
Thu Aug 21 12:10:56 2025 user.warn kernel: [163226.656424][T12093] QCMAP:bringup v6
Thu Aug 21 12:10:56 2025 daemon.info quecprofiles_daemon: Performing profile check (forced=0)
Thu Aug 21 12:10:56 2025 daemon.info quecprofiles_daemon: Fetching all modem data at once
Thu Aug 21 12:10:56 2025 daemon.debug quecprofiles_daemon: Attempting to acquire AT queue token with priority 3
Thu Aug 21 12:10:56 2025 daemon.debug at_queue: Queue processing paused, token held by QUECPROFILES_1755803456_16199
Thu Aug 21 12:10:56 2025 daemon.debug quecprofiles_daemon: Successfully acquired token with ID QUECPROFILES_1755803456_16199
Thu Aug 21 12:10:56 2025 daemon.debug quecprofiles_daemon: Executing command: AT+ICCID
Thu Aug 21 12:10:56 2025 daemon.debug quecprofiles_daemon: Executing AT command: AT+ICCID (timeout: 5s)
Thu Aug 21 12:10:56 2025 daemon.debug quecprofiles_daemon: AT command executed, status: 0
Thu Aug 21 12:10:56 2025 daemon.debug quecprofiles_daemon: Executing command: AT+CGDCONT?
Thu Aug 21 12:10:56 2025 daemon.debug quecprofiles_daemon: Executing AT command: AT+CGDCONT? (timeout: 5s)
Thu Aug 21 12:10:56 2025 daemon.debug quecprofiles_daemon: AT command executed, status: 0
Thu Aug 21 12:10:56 2025 daemon.debug quecprofiles_daemon: Executing command: AT+QNWPREFCFG=“mode_pref”
Thu Aug 21 12:10:56 2025 daemon.debug quecprofiles_daemon: Executing AT command: AT+QNWPREFCFG=“mode_pref” (timeout: 5s)
Thu Aug 21 12:10:56 2025 daemon.debug quecprofiles_daemon: AT command executed, status: 0
Thu Aug 21 12:10:56 2025 daemon.debug quecprofiles_daemon: Executing command: AT+QNWPREFCFG=“lte_band”
Thu Aug 21 12:10:56 2025 daemon.debug quecprofiles_daemon: Executing AT command: AT+QNWPREFCFG=“lte_band” (timeout: 5s)
Thu Aug 21 12:10:56 2025 daemon.debug quecprofiles_daemon: AT command executed, status: 0
Thu Aug 21 12:10:56 2025 daemon.debug quecprofiles_daemon: Executing command: AT+QNWPREFCFG=“nsa_nr5g_band”
Thu Aug 21 12:10:56 2025 daemon.debug quecprofiles_daemon: Executing AT command: AT+QNWPREFCFG=“nsa_nr5g_band” (timeout: 5s)
Thu Aug 21 12:10:56 2025 daemon.debug quecprofiles_daemon: AT command executed, status: 0
Thu Aug 21 12:10:56 2025 daemon.debug quecprofiles_daemon: Executing command: AT+QNWPREFCFG=“nr5g_band”
Thu Aug 21 12:10:57 2025 daemon.debug quecprofiles_daemon: Executing AT command: AT+QNWPREFCFG=“nr5g_band” (timeout: 5s)
Thu Aug 21 12:10:57 2025 daemon.debug quecprofiles_daemon: AT command executed, status: 0
Thu Aug 21 12:10:57 2025 daemon.debug quecprofiles_daemon: Executing command: AT+CGSN
Thu Aug 21 12:10:57 2025 daemon.debug quecprofiles_daemon: Executing AT command: AT+CGSN (timeout: 5s)
Thu Aug 21 12:10:57 2025 daemon.debug quecprofiles_daemon: AT command executed, status: 0
Thu Aug 21 12:10:57 2025 daemon.debug quecprofiles_daemon: Released token QUECPROFILES_1755803456_16199
Thu Aug 21 12:10:57 2025 daemon.info quecprofiles_daemon: Extracted ICCID: 89148000010618448245
Thu Aug 21 12:10:57 2025 daemon.info quecprofiles_daemon: Current ICCID: 89148000010618448245
Thu Aug 21 12:10:57 2025 daemon.info quecprofiles_daemon: Looking for profile with ICCID: 89148000010618448245
Thu Aug 21 12:10:57 2025 daemon.info quecprofiles_daemon: Found matching profile: @profile[0]
Thu Aug 21 12:10:57 2025 daemon.debug quecprofiles_daemon: Found valid profile index: @profile[0]
Thu Aug 21 12:10:57 2025 daemon.info quecprofiles_daemon: Found profile: Visible for ICCID: 89148000010618448245
Thu Aug 21 12:10:57 2025 daemon.info quecprofiles_daemon: Profile settings: network_type=LTE, lte_bands=, sa_nr5g_bands=, nsa_nr5g_bands=, apn=vzwinternet, pdp_type=IP, imei=353050682779648, ttl=64
Thu Aug 21 12:10:57 2025 daemon.info quecprofiles_daemon: Profile ‘Visible’ already applied at Tue Aug 19 20:00:17 PDT 2025
Thu Aug 21 12:10:57 2025 daemon.info quecprofiles_daemon: Profile ‘Visible’ is already applied, skipping
Thu Aug 21 12:10:57 2025 daemon.info quecprofiles_daemon: Status updated: success - Profile already applied (from flag) (100%)
Thu Aug 21 12:10:57 2025 daemon.info quecprofiles_daemon: Sleeping for 60 seconds
Thu Aug 21 12:10:57 2025 user.warn kernel: [163227.690301][T12398] QCMAP:bringup v6
Thu Aug 21 12:10:59 2025 user.warn kernel: [163229.726125][T12577] QCMAP:bringup v6
Thu Aug 21 12:11:01 2025 user.debug LOWI-9.0.1.68[11874]: [LOWINetlinkSocketReceiver] unpackRTMLinkMessage: RTM_NEWLINK - ifname eth0, flags 0x11043 ([UP][RUNNING])
Thu Aug 21 12:11:03 2025 user.warn kernel: [163233.762509][T12953] QCMAP:bringup v6
Thu Aug 21 12:11:09 2025 daemon.debug at_queue: Cleaned up old tracking files
Thu Aug 21 12:11:09 2025 daemon.info at_queue: Cleanup: Removed files older than 1 hour
Thu Aug 21 12:11:11 2025 user.warn kernel: [163241.804383][T13660] QCMAP:bringup v6
Thu Aug 21 12:11:14 2025 user.info LocSvc_LocationIntegrationApiIm[6668]: proc:459] >-- onReceive Rcvd msg id: 99, sockname: locapiservice, payload size: 160
Thu Aug 21 12:11:14 2025 user.warn LocSvc_LocationIntegrationApiIm[6668]: proc:600] <<< unknown message 99
Thu Aug 21 12:11:14 2025 user.info LocSvc_LocationClientApi[6668]: proc:3286] >-- onReceive Rcvd msg id: 99 E_LOCAPI_PINGTEST_MSG_ID, sockname: locapiservice, payload size: 160
Thu Aug 21 12:11:27 2025 user.warn kernel: [163257.838948][T15029] QCMAP:bringup v6
Thu Aug 21 12:11:30 2025 daemon.debug at_queue: Queue processing paused, token held by FETCH_DATA_1755803490_15324
Thu Aug 21 12:11:31 2025 daemon.err at_queue_manager.sh[10069]: cat: can’t open ‘/tmp/at_queue/token’: No such file or directory
Thu Aug 21 12:11:31 2025 daemon.err at_queue_manager.sh[10069]: Failed to parse json data: unexpected end of data
Thu Aug 21 12:11:31 2025 daemon.warn at_queue: Removing expired token from FETCH_DATA_1755803490_15324
Thu Aug 21 12:11:35 2025 daemon.info at_queue: Processing all metrics with token METRICS_1755803495_10070
Thu Aug 21 12:11:35 2025 daemon.debug at_queue: Queue processing paused, token held by METRICS_1755803495_10070
Thu Aug 21 12:11:35 2025 user.info : luci: accepted login on /admin/status/logs for root from 192.168.227.15
Thu Aug 21 12:11:36 2025 daemon.err at_queue_manager.sh[10069]: cat: can’t open ‘/tmp/at_queue/token’: No such file or directory
Thu Aug 21 12:11:36 2025 daemon.err at_queue_manager.sh[10069]: Failed to parse json data: unexpected end of data
Thu Aug 21 12:11:36 2025 daemon.warn at_queue: Removing expired token from FETCH_DATA_1755803495_16026
Thu Aug 21 12:11:37 2025 daemon.info at_queue: Metrics processing completed
Thu Aug 21 12:11:40 2025 daemon.debug at_queue: Queue processing paused, token held by FETCH_DATA_1755803500_16724

I believe the firmware we are running is below:

Powered by LuCI luci/luci/openwrt-22.03 branch (git-23.093.57104-ce20b4a) / RM551EGL00AAR01A04M8G_2025_8_4_iamromulan_full r20134-5f15225c1e

Any help would be GREATLY appreciated.

[Semsem]

How are you connecting the modem to the router? Via USB or via M.2 to Ethernet boards? What protocol you’re using? QMI, MBIM, or ECM? I was experiencing frequent drops(2-3 times a day, or even more) when I was using my RM521F-GL inside an M.2 to Ethernet board and once I switched to connecting the modem to the USB 3.0 port of my openwrt router( with QMI protocol) I didn’t have a single drop in two weeks.

[slazinger_7]

I’m not exactly sure - this is what the inside looks like:

I think openwrt might be running directly on the quectel modem.

I have an Ethernet cable running from the silver box in the upper left hand corner of the picture to a POE injector, and another Ethernet cable that runs from the POE injector to the WAN port on my Asus BT10 router.

In QuecManager under Advance >> Connectivity >> USB Modem Protocol >> ECM (Recommend) is selected.

Other options are RMNET, MBIM, and RNDIS. I don’t see an option for QMI protocol. Do you recall what errors you were receiving with the drops?

The board does have a USB 3.0 connector on it underneath the V1.1 on the board (just to the left of the RM5511E-GL). I used that recently to flash new firmware from iamromulan hoping that would fix the issue. Since that’s not plugged in, maybe that’s why the QMI protocol is not showing up in QuecManager?

If I wanted to change my setup to what you have, what would I need to do?

[Semsem]

Yes I have almost the same M.2 to rj45 board and had the same issues with drops when using the Ethernet cable. If you want to switch to USB for data, you will need an openwrt-running router with a USB 3.0 port sitting between this board and your home router. I recently purchased a N1 Pro mini pc from AliExpress and it has two 2.5gb Ethernet ports. You can get it for $106 with the Back to School sale currently going. You can then plug the USB 3.0 cable from your board into it, flash it with OpenWrt and have one of the Ethernet ports go into your home router. I know using the Ethernet connection directly from the board is a lot cleaner and more convenient but unfortunately until these issues can be investigated and fixed it’s a No go for me because unreliable internet is so frustrating to use.

RMNI or NDIS both refer to the same thing as the QMI protocol and it is usbnet 0.

[slazinger_7]

How did you get the modem to talk with your mini pc? I have a spare RPI4 at the house and I loaded the latest OpenWRT, plugged the modem in via USB 3.0, and powered the modem by a barrel jack, but I don’t think the RPI4 is seeing the modem.

I also changed the “USB Modem Protocol” setting in QuecManager to RMNI

[Semsem]

If you have already set the usbnet to 0 on the modem, did you then install luci-app-qmi on openwrt on the RPi4 and configured the interface?

[slazinger_7]

I have not - this is all a bit new to me. I’ll get the package installed and see if I can configure the interface. If you have any suggestions here, or if there is anything I need to do to prep the router/OpenWRT to run with the modem, please let me know.

Appreciate the help.

[Semsem]

After I imstalling the package, you need to reboot your RPi4 in order for the QMI cellular to show up as a protocol option when setting up a new interface. In the Interface options make sure to type your APN as some carriers need that, and on the top the firewall, link it with the WAN/WAN6.

[slazinger_7]

I was able to install a version of Rooter and OpenWRT on an RPI4, and I was able to get the internet working. I was also able to connect the modem to my Asus router, and the router was able to identify the modem (and internet worked).

I haven’t had enough time to thoroughly test these new setups, but I did notice today that in each of these setups, the router (RPI4 or Asus) is getting an IP from the modem (running its own OpenWRT) like it was before when I had the ethernet from the modem going into the WAN port on my Asus router. Just wanted to see if this is the setup you were suggesting might resolve the issue?

Data is definitely transmitting over USB now as the only thing the ethernet is doing is providing POE to the modem.

I was thinking the router (RPI4 running OpenWRT or Rooter) would step into the place of OpenWRT on the modem, but it doesn’t look like that’s the case (or maybe I didn’t set it up right). Any thoughts?

[Semsem]

Have you disabled PCIe mode when connecting your board to the RPi by USB? You mentioned that the RPi4 is getting an IP in the same format as when you were using the Ethernet(PCIe) mode. Is the IP a NAT address? Or is it a public or CGNAT IP address you’re getting on the RPi4? I always removed Ethernet cable from the board when using USB for data; don’t know if it works solely for POE or interfers with anything.