search

Ysurac / openmptcprouter

OpenMPTCProuter is an open source solution to aggregate multiple internet connections using Multipath TCP (MPTCP) on OpenWrt
https://www.openmptcprouter.com/
GNU General Public License v3.0
1.82k stars 259 forks source link

Random TLS handshake errors #3546

Closed x4rd0o1Vtx closed 3 weeks ago

x4rd0o1Vtx commented 3 weeks ago

Expected Behavior

Reach successfully HTTPS requests on browser / cli.

Current Behavior

Random TLS handshake error and timeout while fetching ressources, a simple retry can result of success but this may happens several times per day...

Browser error : PR_END_OF_FILE_ERROR

Git fetch errors : (seems to occurs on random stage)

Steps to Reproduce the Problem

Because this happens randomly it's difficult to reproduce but the following method works very well:

cd /tmp && git clone https://github.com/Ysurac/openmptcprouter.git && cd openmptcprouter/
while true; do error=$(git fetch 1> /dev/null); [[ -z "$error" ]] && echo -n "." || echo -e "$error"; done

Context (Environment)

One active wan interface (fiber ISP)

Debian GNU/Linux 12 (bookworm) Kernel 6.1.106-3 (2024-08-26) x86_64 GNU/Linux

Specifications

Comments

I've a fresh install on both router & VPS that is only use for that and I didn't notice any RAM/CPU saturation. Everything was working well for several months but this happens since few weeks for no reason because I didn't change anything. Maybe I've just updated the VPS packages (apt update && apt upgrade) but I'm not sure it's related.

The only thing I'm sure about it's related to the VPS proxy part because when I check the "Disable server" option on the router I no longer have any errors.

I've try the following but none of these solve the problem:

I've also found this issue that describe the same behavior but since it's "resolved" just some people comment that they still have the issue but nothing more...

I believed it's was first related to shadowsocks as the issue mention it but I've the right config with LimitNOFILE=99999 & LimitNPROC=99999 and still have the error when I disable shadowsocks proxy on the router so I really don't know.

So frustrating because your work is amazing and it was so stable before I got these errors from nowhere. If someone have some advises to investigate and help me to understand what is happening that would be really great :)

Ysurac commented 3 weeks ago

I don't understand the versions you have... If it's 0.59.1 with 5.4 kernel and VPS 0.1030 with 6.1 kernel then it's not supported (mix of kernels and old release on router).

x4rd0o1Vtx commented 3 weeks ago

You shocked me with your quick response :o and you've just pointed out something I hadn't seen at all... I'm not sure if it was like that since the initial setup or if I've upgraded the VPS kernel without noticed. So I imagine it's better to upgrade the old release on router instead of downgrading the kernel on the VPS server. Thanks again I will try to have the same kernel on both side :)

datapharmer commented 3 weeks ago

I was just about to post that I'm seeing this same issue on the latest .61rc2 as well also when I saw this post. Current settings are proxy: shadowsocks rust 2022 and glorytun tcp but I don't think the issue is specific to the proxy/vpn selection.

I suspect this may be the underlying cause of the websocket issues I mentioned in the other issue I raised about .61rc2

With the server disabled I'm not seeing the same websocket disconnects or tls issues currently but not sure if it is happenstance or not.

I tried lowering MTU to 1412 thinking possibly it was being caused by packet fragmentation but that didn't help. If there are any particular logs I should be checking when this happens let me know!

I noticed that vps running debian12 wasn't using ntp by default and the time seems to have drifted a smidge so I'm curious if that could be the culprit. I just installed ntp and confirmed the time sync matches my client and the router... it may be a good idea to make sure ntp is in the vps script in general though unless time is being maintained another way as that can definitely reek havoc on encrypted connections.

I'll report back if the ntp install fixes this or not.

datapharmer commented 3 weeks ago

Ok, unfortunately that didn't help at all. Started having handshake/tls/websocket issues almost immediately after connecting to the VPS.

Current logs from router: Sep 20 12:24:53 OpenMPTCProuter daemon.info dnsmasq[1]: using nameserver 10.255.255.1#53 Sep 20 12:24:53 OpenMPTCProuter daemon.info dnsmasq[1]: using nameserver 1.1.1.2#53 Sep 20 12:24:53 OpenMPTCProuter daemon.info dnsmasq[1]: using nameserver 1.0.0.2#53 Sep 20 12:24:53 OpenMPTCProuter daemon.info dnsmasq[1]: using nameserver 2606:4700:4700::1002#53 Sep 20 12:24:53 OpenMPTCProuter daemon.info dnsmasq[1]: using nameserver 2606:4700:4700::1112#53 Sep 20 12:24:53 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for test Sep 20 12:24:53 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for onion Sep 20 12:24:53 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for localhost Sep 20 12:24:53 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for local Sep 20 12:24:53 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for invalid Sep 20 12:24:53 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for bind Sep 20 12:24:53 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for use-application-dns.net Sep 20 12:24:53 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for lan Sep 20 12:24:53 OpenMPTCProuter daemon.info dnsmasq[1]: using 1 more local addresses Sep 20 12:24:53 OpenMPTCProuter daemon.info dnsmasq[1]: read /etc/hosts - 12 names Sep 20 12:24:53 OpenMPTCProuter daemon.info dnsmasq[1]: read /tmp/hosts/dhcp.cfg01411c - 4 names Sep 20 12:24:53 OpenMPTCProuter daemon.info dnsmasq[1]: read /tmp/hosts/odhcpd - 0 names Sep 20 12:24:53 OpenMPTCProuter daemon.info dnsmasq-dhcp[1]: read /etc/ethers - 0 addresses Sep 20 12:24:59 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:25:12 OpenMPTCProuter daemon.notice netifd: Interface 'lan' is now down Sep 20 12:25:12 OpenMPTCProuter daemon.notice ttyd[26389]: [2024/09/20 12:25:12:4715] N: rops_handle_POLLIN_netlink: DELADDR Sep 20 12:25:12 OpenMPTCProuter daemon.notice netifd: Interface 'lan' has link connectivity loss Sep 20 12:25:12 OpenMPTCProuter daemon.notice netifd: Interface 'lan' has link connectivity Sep 20 12:25:12 OpenMPTCProuter daemon.notice ttyd[26389]: [2024/09/20 12:25:12:4740] N: rops_handle_POLLIN_netlink: DELADDR Sep 20 12:25:12 OpenMPTCProuter daemon.notice netifd: Interface 'lan' is setting up now Sep 20 12:25:12 OpenMPTCProuter daemon.notice netifd: Interface 'lan' is now up Sep 20 12:25:13 OpenMPTCProuter user.notice firewall: Reloading firewall due to ifup of lan (eth0) Sep 20 12:25:14 OpenMPTCProuter user.notice firewall.omr-server: Firewall reload, set server part firewall reloading Sep 20 12:25:16 OpenMPTCProuter daemon.info omr-tracker-ss: Reload Shadowsocks Rust rules Sep 20 12:25:17 OpenMPTCProuter user.notice firewall.omr-server: Firewall reload, set server part firewall reloading Sep 20 12:25:18 OpenMPTCProuter user.notice omr-bypass: Restart dnsmasq... Sep 20 12:25:18 OpenMPTCProuter daemon.info dnsmasq[1]: exiting on receipt of SIGTERM Sep 20 12:25:19 OpenMPTCProuter daemon.info dnsmasq[1]: started, version 2.90 cachesize 10000 Sep 20 12:25:19 OpenMPTCProuter daemon.info dnsmasq[1]: DNS service limited to local subnets Sep 20 12:25:19 OpenMPTCProuter daemon.info dnsmasq[1]: compile time options: IPv6 GNU-getopt no-DBus UBus no-i18n no-IDN DHCP DHCPv6 no-Lua TFTP conntrack no-ipset nftset auth cryptohash DNSSEC no-ID loop-detect inotify dumpfile Sep 20 12:25:19 OpenMPTCProuter daemon.info dnsmasq[1]: UBus support enabled: connected to system bus Sep 20 12:25:19 OpenMPTCProuter daemon.info dnsmasq-dhcp[1]: DHCP, IP range 192.168.42.100 -- 192.168.42.249, lease time 1h Sep 20 12:25:19 OpenMPTCProuter daemon.info dnsmasq[1]: using nameserver 10.255.255.1#53 Sep 20 12:25:19 OpenMPTCProuter daemon.info dnsmasq[1]: using nameserver 1.1.1.2#53 Sep 20 12:25:19 OpenMPTCProuter daemon.info dnsmasq[1]: using nameserver 1.0.0.2#53 Sep 20 12:25:19 OpenMPTCProuter daemon.info dnsmasq[1]: using nameserver 2606:4700:4700::1002#53 Sep 20 12:25:19 OpenMPTCProuter daemon.info dnsmasq[1]: using nameserver 2606:4700:4700::1112#53 Sep 20 12:25:19 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for test Sep 20 12:25:19 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for onion Sep 20 12:25:19 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for localhost Sep 20 12:25:19 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for local Sep 20 12:25:19 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for invalid Sep 20 12:25:19 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for bind Sep 20 12:25:19 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for use-application-dns.net Sep 20 12:25:19 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for lan Sep 20 12:25:19 OpenMPTCProuter daemon.info dnsmasq[1]: using 1 more local addresses Sep 20 12:25:19 OpenMPTCProuter daemon.info dnsmasq[1]: read /etc/hosts - 12 names Sep 20 12:25:19 OpenMPTCProuter daemon.info dnsmasq[1]: read /tmp/hosts/dhcp.cfg01411c - 4 names Sep 20 12:25:19 OpenMPTCProuter daemon.info dnsmasq[1]: read /tmp/hosts/odhcpd - 0 names Sep 20 12:25:19 OpenMPTCProuter daemon.info dnsmasq-dhcp[1]: read /etc/ethers - 0 addresses Sep 20 12:25:19 OpenMPTCProuter user.notice omr-bypass: OMR-ByPass is running Sep 20 12:25:25 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs4_6 Error: No such file or directory Sep 20 12:25:25 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_4 Error: No such file or directory Sep 20 12:25:26 OpenMPTCProuter user.notice firewall.omr-server: Firewall reload, set server part firewall reloading Sep 20 12:25:26 OpenMPTCProuter user.notice omr-tracker: Launching... Sep 20 12:25:30 OpenMPTCProuter user.notice OMR-VPS: Get config from server vps... Sep 20 12:25:39 OpenMPTCProuter user.notice omr-tracker: Launched Sep 20 12:25:40 OpenMPTCProuter daemon.notice ttyd[26389]: [2024/09/20 12:25:40:3088] N: rops_handle_POLLIN_netlink: DELADDR Sep 20 12:25:40 OpenMPTCProuter daemon.notice ttyd[26389]: [2024/09/20 12:25:40:3089] N: rops_handle_POLLIN_netlink: DELADDR Sep 20 12:25:40 OpenMPTCProuter daemon.notice ttyd[26389]: [2024/09/20 12:25:40:4197] N: rops_handle_POLLIN_netlink: DELADDR Sep 20 12:25:40 OpenMPTCProuter daemon.notice ttyd[26389]: [2024/09/20 12:25:40:5007] N: rops_handle_POLLIN_netlink: DELADDR Sep 20 12:25:41 OpenMPTCProuter daemon.info dnsmasq[1]: read /etc/hosts - 12 names Sep 20 12:25:41 OpenMPTCProuter daemon.info dnsmasq[1]: read /tmp/hosts/dhcp.cfg01411c - 4 names Sep 20 12:25:41 OpenMPTCProuter daemon.info dnsmasq[1]: read /tmp/hosts/odhcpd - 2 names Sep 20 12:25:41 OpenMPTCProuter daemon.info dnsmasq-dhcp[1]: read /etc/ethers - 0 addresses Sep 20 12:25:42 OpenMPTCProuter daemon.err rmmod: unloading the module failed Sep 20 12:25:43 OpenMPTCProuter daemon.info glorytun: starting glorytun vpn instance vpn Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: Network alias '' link is down Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: Network alias '' link is down Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: Network alias '' link is down Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: TMobile (7347): udhcpc: received SIGTERM Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: TMobile (7347): udhcpc: unicasting a release of 192.168.12.226 to 192.168.12.1 Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: TMobile (7347): udhcpc: sending release Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: TMobile (7347): udhcpc: entering released state Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: ATT (6489): udhcpc: received SIGTERM Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: ATT (6489): udhcpc: unicasting a release of 192.168.2.73 to 192.168.2.1 Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: ATT (6489): udhcpc: sending release Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: ATT (6489): udhcpc: entering released state Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: Starlink (6488): udhcpc: received SIGTERM Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: Starlink (6488): udhcpc: unicasting a release of 100.124.24.171 to 100.64.0.1 Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: Starlink (6488): udhcpc: sending release Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: Starlink (6488): udhcpc: entering released state Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: TMobile (7347): Command failed: ubus call network.interface notify_proto { "action": 0, "link-up": false, "keep": false, "interface": "TMobile" } (Permission denied) Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: ATT (6489): Command failed: ubus call network.interface notify_proto { "action": 0, "link-up": false, "keep": false, "interface": "ATT" } (Permission denied) Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: Interface 'ATT' is now down Sep 20 12:25:43 OpenMPTCProuter daemon.notice ttyd[26389]: [2024/09/20 12:25:43:5460] N: rops_handle_POLLIN_netlink: DELADDR Sep 20 12:25:43 OpenMPTCProuter user.notice NET: hotplug (iface): action='remove' interface='eth0.4' Sep 20 12:25:43 OpenMPTCProuter daemon.info ModemManager[21802]: hotplug: remove network interface eth0.4: event processed Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: Interface 'ATT' is disabled Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: Interface 'ATT' has link connectivity loss Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: Interface 'ATT' is enabled Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: Interface 'ATT' has link connectivity Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: Interface 'ATT' is setting up now Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: Interface 'TMobile' is now down Sep 20 12:25:43 OpenMPTCProuter daemon.notice ttyd[26389]: [2024/09/20 12:25:43:6311] N: rops_handle_POLLIN_netlink: DELADDR Sep 20 12:25:43 OpenMPTCProuter user.notice NET: hotplug (iface): action='add' interface='eth0.4' Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: Interface 'TMobile' is disabled Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: Interface 'TMobile' has link connectivity loss Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: Interface 'TMobile' is enabled Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: Interface 'TMobile' has link connectivity Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: Interface 'TMobile' is setting up now Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: 8021q 'eth0.4' link is down Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: Interface 'ATT' has link connectivity loss Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: Starlink (6488): Command failed: ubus call network.interface notify_proto { "action": 0, "link-up": false, "keep": false, "interface": "Starlink" } (Permission denied) Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: 8021q 'eth0.4' link is up Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: Interface 'ATT' has link connectivity Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: 8021q 'eth0.3' link is down Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: Interface 'TMobile' has link connectivity loss Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: 8021q 'eth0.3' link is up Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: Interface 'TMobile' has link connectivity Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: Interface 'Starlink' is now down Sep 20 12:25:43 OpenMPTCProuter daemon.notice ttyd[26389]: [2024/09/20 12:25:43:7100] N: rops_handle_POLLIN_netlink: DELADDR Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: Interface 'Starlink' is disabled Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: Interface 'Starlink' has link connectivity loss Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: Interface 'Starlink' is enabled Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: Interface 'Starlink' has link connectivity Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: Interface 'Starlink' is setting up now Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: ATT (21888): Command failed: ubus call network.interface notify_proto { "action": 1, "command": [ "udhcpc", "-p", "\/var\/run\/udhcpc-eth0.4.pid", "-s", "\/lib\/netifd\/dhcp.script", "-f", "-t", "0", "-i", "eth0.4", "-x", "host Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: 8021q 'eth0.2' link is down Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: Interface 'Starlink' has link connectivity loss Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: 8021q 'eth0.2' link is up Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: Interface 'Starlink' has link connectivity Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: Interface 'ATT' is now down Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: Interface 'ATT' is setting up now Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: Interface 'TMobile' is now down Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: Interface 'TMobile' is setting up now Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: Starlink (21963): Command failed: ubus call network.interface notify_proto { "action": 1, "command": [ "udhcpc", "-p", "\/var\/run\/udhcpc-eth0.2.pid", "-s", "\/lib\/netifd\/dhcp.script", "-f", "-t", "0", "-i", "eth0.2", "-x", Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: ATT (22003): udhcpc: started, v1.36.1 Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: Interface 'Starlink' is now down Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: Interface 'Starlink' is setting up now Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: TMobile (22024): udhcpc: started, v1.36.1 Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: ATT (22003): udhcpc: broadcasting discover Sep 20 12:25:43 OpenMPTCProuter daemon.info ModemManager[21885]: hotplug: add network interface eth0.4: event processed Sep 20 12:25:43 OpenMPTCProuter daemon.notice netifd: Starlink (22052): udhcpc: started, v1.36.1 Sep 20 12:25:44 OpenMPTCProuter user.notice NET: hotplug (iface): action='remove' interface='eth0.3' Sep 20 12:25:44 OpenMPTCProuter daemon.info ModemManager[22070]: hotplug: remove network interface eth0.3: event processed Sep 20 12:25:44 OpenMPTCProuter daemon.notice netifd: TMobile (22024): udhcpc: broadcasting discover Sep 20 12:25:44 OpenMPTCProuter user.notice NET: hotplug (iface): action='add' interface='eth0.3' Sep 20 12:25:44 OpenMPTCProuter daemon.notice netifd: Starlink (22052): udhcpc: broadcasting discover Sep 20 12:25:44 OpenMPTCProuter daemon.notice netifd: Starlink (22052): udhcpc: broadcasting select for 100.124.24.171, server 100.64.0.1 Sep 20 12:25:44 OpenMPTCProuter daemon.info ModemManager[22105]: hotplug: add network interface eth0.3: event processed Sep 20 12:25:44 OpenMPTCProuter user.notice NET: hotplug (iface): action='remove' interface='eth0.2' Sep 20 12:25:44 OpenMPTCProuter user.notice post-tracking-002-error: Restart Starlink Sep 20 12:25:44 OpenMPTCProuter daemon.info ModemManager[22297]: hotplug: remove network interface eth0.2: event processed Sep 20 12:25:44 OpenMPTCProuter daemon.notice netifd: Starlink (22052): udhcpc: lease of 100.124.24.171 obtained from 100.64.0.1, lease time 300 Sep 20 12:25:44 OpenMPTCProuter daemon.notice netifd: Starlink (22052): Command failed: ubus call network.interface notify_proto { "action": 0, "link-up": true, "data": { "leasetime": 300, "dhcpserver": "100.64.0.1" }, "keep": false, "ipaddr": [ { "ipaddr": "100.124.24.171", "mask Sep 20 12:25:44 OpenMPTCProuter daemon.notice netifd: Starlink (22052): udhcpc: received SIGTERM Sep 20 12:25:44 OpenMPTCProuter daemon.notice netifd: Starlink (22052): udhcpc: unicasting a release of 100.124.24.171 to 100.64.0.1 Sep 20 12:25:44 OpenMPTCProuter daemon.notice netifd: Starlink (22052): udhcpc: sending release Sep 20 12:25:44 OpenMPTCProuter daemon.notice netifd: Starlink (22052): udhcpc: bind(UDP): Address not available Sep 20 12:25:44 OpenMPTCProuter daemon.notice netifd: Starlink (22052): udhcpc: entering released state Sep 20 12:25:44 OpenMPTCProuter user.notice NET: hotplug (iface): action='add' interface='eth0.2' Sep 20 12:25:44 OpenMPTCProuter daemon.notice netifd: Starlink (22052): Command failed: ubus call network.interface notify_proto { "action": 0, "link-up": false, "keep": false, "interface": "Starlink" } (Permission denied) Sep 20 12:25:44 OpenMPTCProuter daemon.notice netifd: Interface 'Starlink' is now down Sep 20 12:25:44 OpenMPTCProuter daemon.notice ttyd[26389]: [2024/09/20 12:25:44:3527] N: rops_handle_POLLIN_netlink: DELADDR Sep 20 12:25:44 OpenMPTCProuter user.notice post-tracking-002-error: Restart ATT Sep 20 12:25:44 OpenMPTCProuter daemon.notice netifd: Interface 'Starlink' is disabled Sep 20 12:25:44 OpenMPTCProuter daemon.notice netifd: 8021q 'eth0.2' link is down Sep 20 12:25:44 OpenMPTCProuter daemon.notice netifd: Interface 'Starlink' has link connectivity loss Sep 20 12:25:44 OpenMPTCProuter daemon.notice netifd: ATT (22003): udhcpc: received SIGTERM Sep 20 12:25:44 OpenMPTCProuter daemon.notice netifd: ATT (22003): udhcpc: entering released state Sep 20 12:25:44 OpenMPTCProuter daemon.notice netifd: ATT (22003): Command failed: ubus call network.interface notify_proto { "action": 0, "link-up": false, "keep": false, "interface": "ATT" } (Permission denied) Sep 20 12:25:44 OpenMPTCProuter daemon.notice netifd: Interface 'ATT' is now down Sep 20 12:25:44 OpenMPTCProuter daemon.notice netifd: Interface 'ATT' is disabled Sep 20 12:25:44 OpenMPTCProuter daemon.notice netifd: 8021q 'eth0.4' link is down Sep 20 12:25:44 OpenMPTCProuter daemon.notice netifd: Interface 'ATT' has link connectivity loss Sep 20 12:25:44 OpenMPTCProuter daemon.info ModemManager[22341]: hotplug: add network interface eth0.2: event processed Sep 20 12:25:44 OpenMPTCProuter user.notice NET: hotplug (iface): action='remove' interface='eth0.2' Sep 20 12:25:44 OpenMPTCProuter daemon.info ModemManager[22621]: hotplug: remove network interface eth0.2: event processed Sep 20 12:25:44 OpenMPTCProuter user.notice NET: hotplug (iface): action='remove' interface='eth0.4' Sep 20 12:25:44 OpenMPTCProuter daemon.info ModemManager[22644]: hotplug: remove network interface eth0.4: event processed Sep 20 12:25:45 OpenMPTCProuter daemon.info vnstatd[16259]: Info: Interface "eth0.4" disabled. Sep 20 12:25:45 OpenMPTCProuter daemon.info vnstatd[16259]: Info: Interface "eth0.2" disabled. Sep 20 12:25:46 OpenMPTCProuter daemon.notice netifd: TMobile (22024): udhcpc: broadcasting discover Sep 20 12:25:47 OpenMPTCProuter daemon.notice netifd: TMobile (22024): udhcpc: broadcasting select for 192.168.12.226, server 192.168.12.1 Sep 20 12:25:47 OpenMPTCProuter daemon.notice netifd: TMobile (22024): udhcpc: lease of 192.168.12.226 obtained from 192.168.12.1, lease time 86400 Sep 20 12:25:47 OpenMPTCProuter daemon.notice netifd: Network alias 'eth0.3' link is up Sep 20 12:25:47 OpenMPTCProuter daemon.notice netifd: Interface 'TMobile' is now up Sep 20 12:25:47 OpenMPTCProuter user.notice NET: hotplug (iface): action='remove' interface='ifb4eth0.3' Sep 20 12:25:47 OpenMPTCProuter daemon.info ModemManager[23719]: hotplug: remove network interface ifb4eth0.3: event processed Sep 20 12:25:47 OpenMPTCProuter user.notice NET: hotplug (iface): action='add' interface='SQM_IFB_fa8b5' Sep 20 12:25:47 OpenMPTCProuter daemon.info ModemManager[23790]: hotplug: add network interface SQM_IFB_fa8b5: event processed Sep 20 12:25:47 OpenMPTCProuter user.notice NET: hotplug (iface): action='remove' interface='SQM_IFB_fa8b5' Sep 20 12:25:47 OpenMPTCProuter daemon.info ModemManager[23873]: hotplug: remove network interface SQM_IFB_fa8b5: event processed Sep 20 12:25:47 OpenMPTCProuter user.notice NET: hotplug (iface): action='add' interface='SQM_IFB_6c6cf' Sep 20 12:25:48 OpenMPTCProuter user.notice firewall: Reloading firewall due to ifup of TMobile (eth0.3) Sep 20 12:25:48 OpenMPTCProuter daemon.info ModemManager[23921]: hotplug: add network interface SQM_IFB_6c6cf: event processed Sep 20 12:25:48 OpenMPTCProuter user.notice NET: hotplug (iface): action='remove' interface='SQM_IFB_6c6cf' Sep 20 12:25:48 OpenMPTCProuter daemon.info ModemManager[24053]: hotplug: remove network interface SQM_IFB_6c6cf: event processed Sep 20 12:25:48 OpenMPTCProuter user.notice NET: hotplug (iface): action='add' interface='ifb4eth0.3' Sep 20 12:25:48 OpenMPTCProuter daemon.info ModemManager[24070]: hotplug: add network interface ifb4eth0.3: event processed Sep 20 12:25:49 OpenMPTCProuter user.notice firewall.omr-server: Firewall reload, set server part firewall reloading Sep 20 12:25:49 OpenMPTCProuter daemon.notice netifd: Interface 'Starlink' is enabled Sep 20 12:25:49 OpenMPTCProuter daemon.notice netifd: 8021q 'eth0.2' link is up Sep 20 12:25:49 OpenMPTCProuter daemon.notice netifd: Interface 'Starlink' has link connectivity Sep 20 12:25:49 OpenMPTCProuter daemon.notice netifd: Interface 'Starlink' is setting up now Sep 20 12:25:49 OpenMPTCProuter daemon.notice netifd: Starlink (24208): udhcpc: started, v1.36.1 Sep 20 12:25:49 OpenMPTCProuter user.notice NET: hotplug (iface): action='add' interface='eth0.2' Sep 20 12:25:49 OpenMPTCProuter daemon.notice netifd: Starlink (24208): udhcpc: broadcasting discover Sep 20 12:25:49 OpenMPTCProuter daemon.notice netifd: Interface 'ATT' is enabled Sep 20 12:25:49 OpenMPTCProuter daemon.notice netifd: 8021q 'eth0.4' link is up Sep 20 12:25:49 OpenMPTCProuter daemon.notice netifd: Interface 'ATT' has link connectivity Sep 20 12:25:49 OpenMPTCProuter daemon.notice netifd: Interface 'ATT' is setting up now Sep 20 12:25:49 OpenMPTCProuter daemon.notice netifd: ATT (24321): udhcpc: started, v1.36.1 Sep 20 12:25:49 OpenMPTCProuter daemon.info ModemManager[24173]: hotplug: add network interface eth0.2: event processed Sep 20 12:25:49 OpenMPTCProuter daemon.notice netifd: ATT (24321): udhcpc: broadcasting discover Sep 20 12:25:49 OpenMPTCProuter daemon.notice netifd: Starlink (24208): udhcpc: broadcasting select for 100.124.24.171, server 100.64.0.1 Sep 20 12:25:49 OpenMPTCProuter user.notice NET: hotplug (iface): action='add' interface='eth0.4' Sep 20 12:25:49 OpenMPTCProuter daemon.notice netifd: ATT (24321): udhcpc: broadcasting select for 192.168.2.73, server 192.168.2.1 Sep 20 12:25:49 OpenMPTCProuter daemon.info ModemManager[24408]: hotplug: add network interface eth0.4: event processed Sep 20 12:25:49 OpenMPTCProuter daemon.notice netifd: Starlink (24208): udhcpc: lease of 100.124.24.171 obtained from 100.64.0.1, lease time 300 Sep 20 12:25:49 OpenMPTCProuter daemon.notice netifd: Network alias 'eth0.2' link is up Sep 20 12:25:49 OpenMPTCProuter daemon.notice netifd: Interface 'Starlink' is now up Sep 20 12:25:49 OpenMPTCProuter daemon.notice netifd: ATT (24321): udhcpc: lease of 192.168.2.73 obtained from 192.168.2.1, lease time 43200 Sep 20 12:25:49 OpenMPTCProuter daemon.notice netifd: Network alias 'eth0.4' link is up Sep 20 12:25:49 OpenMPTCProuter daemon.notice netifd: Interface 'ATT' is now up Sep 20 12:25:50 OpenMPTCProuter daemon.info vnstatd[16259]: Info: Interface "eth0.4" enabled. Sep 20 12:25:50 OpenMPTCProuter daemon.info vnstatd[16259]: Info: Interface "eth0.2" enabled. Sep 20 12:25:50 OpenMPTCProuter daemon.info omr-tracker-ss: Shadowsocks rust sss1 is down (can't contact via http 212.27.48.10, 198.27.92.1) Sep 20 12:25:51 OpenMPTCProuter user.notice post-tracking-001-initialize: Routes not correctly set for TMobile (eth0.3 table 4) with IPs 192.168.12.226 Sep 20 12:25:54 OpenMPTCProuter user.notice post-tracking-001-initialize: Routes not correctly set for Starlink (eth0.2 table 3) with IPs 100.124.24.171 Sep 20 12:25:55 OpenMPTCProuter user.notice post-tracking-001-initialize: Routes not correctly set for ATT (eth0.4 table 5) with IPs 192.168.2.73 Sep 20 12:25:59 OpenMPTCProuter daemon.info omr-tracker-ss: Shadowsocks rust sss0 is down (can't contact via http 198.27.92.1, 151.101.129.164) Sep 20 12:26:00 OpenMPTCProuter user.notice post-tracking-002-error: Restart omrvpn Sep 20 12:26:00 OpenMPTCProuter daemon.notice netifd: Interface 'omrvpn' is now down Sep 20 12:26:00 OpenMPTCProuter daemon.notice ttyd[26389]: [2024/09/20 12:26:00:1228] N: rops_handle_POLLIN_netlink: DELADDR Sep 20 12:26:00 OpenMPTCProuter daemon.notice netifd: Interface 'omrvpn' is disabled Sep 20 12:26:00 OpenMPTCProuter daemon.notice netifd: Network device 'tun0' link is down Sep 20 12:26:00 OpenMPTCProuter daemon.notice netifd: Interface 'omrvpn' has link connectivity loss Sep 20 12:26:00 OpenMPTCProuter daemon.info vnstatd[16259]: Info: Traffic rate for "eth0.3" higher than set maximum 1000 Mbit (20s->2673868800, r4279738315 t4292342934, 64bit:0), syncing. Sep 20 12:26:00 OpenMPTCProuter daemon.info omr-tracker-ss: Server sss1 (2605:6400:40:fe6c:99:22:77:65) seems down, no answer to ping Sep 20 12:26:01 OpenMPTCProuter user.notice firewall.omr-server: Firewall reload, set server part firewall reloading Sep 20 12:26:01 OpenMPTCProuter user.notice MPTCP: Set eth0.2 to on from eth0.2 is deactivated Sep 20 12:26:02 OpenMPTCProuter user.notice MPTCP: Set eth0.3 to master from eth0.3 is deactivated Sep 20 12:26:02 OpenMPTCProuter user.notice MPTCP: Multipath master already set, disable master for ATT Sep 20 12:26:02 OpenMPTCProuter user.notice MPTCP: Set eth0.4 to on from eth0.4 is deactivated Sep 20 12:26:03 OpenMPTCProuter user.notice NET: hotplug (iface): action='remove' interface='ifb4eth0.2' Sep 20 12:26:03 OpenMPTCProuter daemon.info ModemManager[26435]: hotplug: remove network interface ifb4eth0.2: event processed Sep 20 12:26:03 OpenMPTCProuter user.notice NET: hotplug (iface): action='add' interface='SQM_IFB_58f4a' Sep 20 12:26:03 OpenMPTCProuter daemon.info ModemManager[26619]: hotplug: add network interface SQM_IFB_58f4a: event processed Sep 20 12:26:03 OpenMPTCProuter user.notice NET: hotplug (iface): action='remove' interface='SQM_IFB_58f4a' Sep 20 12:26:03 OpenMPTCProuter daemon.info ModemManager[26935]: hotplug: remove network interface SQM_IFB_58f4a: event processed Sep 20 12:26:03 OpenMPTCProuter user.notice NET: hotplug (iface): action='add' interface='SQM_IFB_edcaf' Sep 20 12:26:03 OpenMPTCProuter user.notice firewall: Reloading firewall due to ifup of Starlink (eth0.2) Sep 20 12:26:04 OpenMPTCProuter user.notice omr-tracker: Launching... Sep 20 12:26:04 OpenMPTCProuter daemon.info ModemManager[26967]: hotplug: add network interface SQM_IFB_edcaf: event processed Sep 20 12:26:04 OpenMPTCProuter user.notice NET: hotplug (iface): action='remove' interface='SQM_IFB_edcaf' Sep 20 12:26:04 OpenMPTCProuter daemon.info ModemManager[27151]: hotplug: remove network interface SQM_IFB_edcaf: event processed Sep 20 12:26:04 OpenMPTCProuter user.notice NET: hotplug (iface): action='add' interface='ifb4eth0.2' Sep 20 12:26:04 OpenMPTCProuter daemon.info ModemManager[27170]: hotplug: add network interface ifb4eth0.2: event processed Sep 20 12:26:04 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:26:05 OpenMPTCProuter daemon.notice netifd: Interface 'omrvpn' is enabled Sep 20 12:26:05 OpenMPTCProuter daemon.notice netifd: Network device 'tun0' link is up Sep 20 12:26:05 OpenMPTCProuter daemon.notice netifd: Interface 'omrvpn' has link connectivity Sep 20 12:26:05 OpenMPTCProuter daemon.notice netifd: Interface 'omrvpn' is setting up now Sep 20 12:26:05 OpenMPTCProuter daemon.notice netifd: Interface 'omrvpn' is now up Sep 20 12:26:05 OpenMPTCProuter user.notice post-tracking-002-error: omrvpn down because check error, interface have no IPv6, interface have no IPv6 gateway and ping from 10.255.255.2 error (8.8.8.8,1.1.1.1) Sep 20 12:26:05 OpenMPTCProuter user.notice firewall.omr-server: Firewall reload, set server part firewall reloading Sep 20 12:26:05 OpenMPTCProuter user.notice post-tracking-002-error: Glorytun VPN down, restart it Sep 20 12:26:05 OpenMPTCProuter daemon.info glorytun: starting glorytun vpn instance vpn Sep 20 12:26:05 OpenMPTCProuter daemon.err glorytun[11076]: 45.61.186.172.65001: shutdown Sep 20 12:26:06 OpenMPTCProuter daemon.info dnsmasq-dhcp[1]: DHCPREQUEST(eth0) 192.168.42.184 b4:0a:d8:3b:03:d2 Sep 20 12:26:06 OpenMPTCProuter daemon.info dnsmasq-dhcp[1]: DHCPACK(eth0) 192.168.42.184 b4:0a:d8:3b:03:d2 Sep 20 12:26:07 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:26:07 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:26:07 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:26:09 OpenMPTCProuter daemon.info glorytun[11076]: STOPPED tun0 Sep 20 12:26:09 OpenMPTCProuter daemon.notice netifd: Network device 'tun0' link is down Sep 20 12:26:09 OpenMPTCProuter daemon.notice netifd: Interface 'omrvpn' has link connectivity loss Sep 20 12:26:09 OpenMPTCProuter daemon.notice netifd: Interface 'omrvpn' is now down Sep 20 12:26:09 OpenMPTCProuter daemon.notice ttyd[26389]: [2024/09/20 12:26:09:3104] N: rops_handle_POLLIN_netlink: DELADDR Sep 20 12:26:09 OpenMPTCProuter daemon.notice ttyd[26389]: [2024/09/20 12:26:09:3127] N: rops_handle_POLLIN_netlink: DELADDR Sep 20 12:26:09 OpenMPTCProuter user.notice NET: hotplug (iface): action='remove' interface='tun0' Sep 20 12:26:09 OpenMPTCProuter daemon.info ModemManager[28214]: hotplug: remove network interface tun0: event processed Sep 20 12:26:09 OpenMPTCProuter daemon.info glorytun[28239]: INITIALIZED tun0 Sep 20 12:26:09 OpenMPTCProuter user.notice NET: hotplug (iface): action='add' interface='tun0' Sep 20 12:26:09 OpenMPTCProuter daemon.notice netifd: Interface 'omrvpn' is disabled Sep 20 12:26:09 OpenMPTCProuter daemon.notice netifd: Interface 'omrvpn' is enabled Sep 20 12:26:09 OpenMPTCProuter daemon.notice netifd: Network device 'tun0' link is up Sep 20 12:26:09 OpenMPTCProuter daemon.notice netifd: Interface 'omrvpn' has link connectivity Sep 20 12:26:09 OpenMPTCProuter daemon.notice netifd: Interface 'omrvpn' is setting up now Sep 20 12:26:09 OpenMPTCProuter daemon.notice netifd: Interface 'omrvpn' is now up Sep 20 12:26:09 OpenMPTCProuter daemon.info ModemManager[28242]: hotplug: add network interface tun0: event processed Sep 20 12:26:10 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:26:10 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs4_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:26:10 OpenMPTCProuter daemon.err glorytun[28239]: 45.61.186.172.65001: connected Sep 20 12:26:10 OpenMPTCProuter daemon.err glorytun[28239]: couldn't set socket optionTCP_USER_TIMEOUT' Sep 20 12:26:10 OpenMPTCProuter daemon.info glorytun[28239]: STARTED tun0 Sep 20 12:26:11 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:26:11 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:26:11 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:26:11 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:26:12 OpenMPTCProuter user.notice NET: hotplug (iface): action='remove' interface='ifb4eth0.4' Sep 20 12:26:12 OpenMPTCProuter daemon.info ModemManager[28876]: hotplug: remove network interface ifb4eth0.4: event processed Sep 20 12:26:12 OpenMPTCProuter user.notice NET: hotplug (iface): action='add' interface='SQM_IFB_fc991' Sep 20 12:26:12 OpenMPTCProuter daemon.info ModemManager[29005]: hotplug: add network interface SQM_IFB_fc991: event processed Sep 20 12:26:12 OpenMPTCProuter user.notice NET: hotplug (iface): action='remove' interface='SQM_IFB_fc991' Sep 20 12:26:12 OpenMPTCProuter daemon.info ModemManager[29221]: hotplug: remove network interface SQM_IFB_fc991: event processed Sep 20 12:26:12 OpenMPTCProuter user.notice NET: hotplug (iface): action='add' interface='SQM_IFB_80f96' Sep 20 12:26:12 OpenMPTCProuter user.notice firewall: Reloading firewall due to ifup of ATT (eth0.4) Sep 20 12:26:12 OpenMPTCProuter daemon.info ModemManager[29282]: hotplug: add network interface SQM_IFB_80f96: event processed Sep 20 12:26:12 OpenMPTCProuter user.notice NET: hotplug (iface): action='remove' interface='SQM_IFB_80f96' Sep 20 12:26:12 OpenMPTCProuter daemon.info ModemManager[29380]: hotplug: remove network interface SQM_IFB_80f96: event processed Sep 20 12:26:12 OpenMPTCProuter user.notice NET: hotplug (iface): action='add' interface='ifb4eth0.4' Sep 20 12:26:12 OpenMPTCProuter daemon.info ModemManager[29409]: hotplug: add network interface ifb4eth0.4: event processed Sep 20 12:26:13 OpenMPTCProuter user.notice omr-schedule-010-services: Can't find omr-bypass rules, restart omr-bypass... Sep 20 12:26:13 OpenMPTCProuter user.notice omr-bypass: Starting OMR-ByPass... Sep 20 12:26:13 OpenMPTCProuter user.notice firewall.omr-server: Firewall reload, set server part firewall reloading Sep 20 12:26:16 OpenMPTCProuter user.notice omr-tracker: Launched Sep 20 12:26:16 OpenMPTCProuter user.notice omr-tracker: Launching... Sep 20 12:26:16 OpenMPTCProuter daemon.info procd: - shutdown - Sep 20 12:26:16 OpenMPTCProuter daemon.info procd: - shutdown - Sep 20 12:26:16 OpenMPTCProuter daemon.info procd: - shutdown - Sep 20 12:26:16 OpenMPTCProuter daemon.info procd: - shutdown - Sep 20 12:26:16 OpenMPTCProuter daemon.info procd: - shutdown - Sep 20 12:26:16 OpenMPTCProuter daemon.info procd: - shutdown - Sep 20 12:26:16 OpenMPTCProuter daemon.info procd: - shutdown - Sep 20 12:26:17 OpenMPTCProuter user.notice post-tracking-002-error: Restart omrvpn Sep 20 12:26:17 OpenMPTCProuter daemon.notice netifd: Interface 'omrvpn' is now down Sep 20 12:26:17 OpenMPTCProuter daemon.notice netifd: Interface 'omrvpn' is disabled Sep 20 12:26:17 OpenMPTCProuter daemon.notice netifd: Network device 'tun0' link is down Sep 20 12:26:17 OpenMPTCProuter daemon.notice netifd: Interface 'omrvpn' has link connectivity loss Sep 20 12:26:17 OpenMPTCProuter daemon.notice ttyd[26389]: [2024/09/20 12:26:17:3824] N: rops_handle_POLLIN_netlink: DELADDR Sep 20 12:26:17 OpenMPTCProuter daemon.err glorytun[28239]: tun write: I/O error Sep 20 12:26:17 OpenMPTCProuter daemon.info glorytun[28239]: STOPPED tun0 Sep 20 12:26:17 OpenMPTCProuter user.notice post-tracking-003-up: Master up : Replace default route by 192.168.12.1 dev eth0.3 Sep 20 12:26:17 OpenMPTCProuter user.notice NET: hotplug (iface): action='remove' interface='tun0' Sep 20 12:26:17 OpenMPTCProuter daemon.info ModemManager[31653]: hotplug: remove network interface tun0: event processed Sep 20 12:26:20 OpenMPTCProuter user.notice post-tracking-003-up: Local IP changed for eth0.2 (Starlink) force Multipath Sep 20 12:26:20 OpenMPTCProuter daemon.info omr-tracker-ss: Shadowsocks rust sss0 is up (can contact via http 212.27.48.10) Sep 20 12:26:21 OpenMPTCProuter daemon.info omr-tracker-ss: Reload Shadowsocks Rust rules Sep 20 12:26:21 OpenMPTCProuter user.notice post-tracking-020-status: New public ip detected for ATT (eth0.4): 107.72.164.113 (First public IP detected) Sep 20 12:26:21 OpenMPTCProuter daemon.info procd: Instance omr-tracker::ATT pid 30918 not stopped on SIGTERM, sending SIGKILL instead Sep 20 12:26:21 OpenMPTCProuter daemon.info procd: Instance omr-tracker::Starlink pid 30916 not stopped on SIGTERM, sending SIGKILL instead Sep 20 12:26:21 OpenMPTCProuter daemon.info procd: Instance omr-tracker::TMobile pid 30917 not stopped on SIGTERM, sending SIGKILL instead Sep 20 12:26:21 OpenMPTCProuter daemon.info procd: Instance omr-tracker::instance5 pid 30919 not stopped on SIGTERM, sending SIGKILL instead Sep 20 12:26:21 OpenMPTCProuter daemon.info procd: Instance omr-tracker::instance6 pid 30920 not stopped on SIGTERM, sending SIGKILL instead Sep 20 12:26:21 OpenMPTCProuter daemon.info procd: Instance omr-tracker::instance7 pid 30921 not stopped on SIGTERM, sending SIGKILL instead Sep 20 12:26:21 OpenMPTCProuter daemon.info procd: Instance omr-tracker::omrvpn pid 30915 not stopped on SIGTERM, sending SIGKILL instead Sep 20 12:26:22 OpenMPTCProuter user.notice post-tracking-002-error: omrvpn down because omrvpn may have ip issues, interface have no IPv4, interface have no IPv6, interface have no IPv6 gateway Sep 20 12:26:22 OpenMPTCProuter user.notice post-tracking-002-error: Glorytun VPN down, restart it Sep 20 12:26:22 OpenMPTCProuter daemon.info glorytun: starting glorytun vpn instance vpn Sep 20 12:26:22 OpenMPTCProuter daemon.info glorytun[980]: INITIALIZED tun0 Sep 20 12:26:22 OpenMPTCProuter daemon.notice netifd: Interface 'omrvpn' is enabled Sep 20 12:26:22 OpenMPTCProuter daemon.notice netifd: Network device 'tun0' link is up Sep 20 12:26:22 OpenMPTCProuter daemon.notice netifd: Interface 'omrvpn' has link connectivity Sep 20 12:26:22 OpenMPTCProuter daemon.notice netifd: Interface 'omrvpn' is setting up now Sep 20 12:26:22 OpenMPTCProuter daemon.notice netifd: Interface 'omrvpn' is now up Sep 20 12:26:22 OpenMPTCProuter user.notice NET: hotplug (iface): action='add' interface='tun0' Sep 20 12:26:22 OpenMPTCProuter daemon.info ModemManager[1009]: hotplug: add network interface tun0: event processed Sep 20 12:26:23 OpenMPTCProuter user.notice post-tracking-020-status: New public ip detected for Starlink (eth0.2): 129.222.252.138 (First public IP detected) Sep 20 12:26:23 OpenMPTCProuter daemon.err glorytun[980]: 45.61.186.172.65001: connected Sep 20 12:26:23 OpenMPTCProuter daemon.err glorytun[980]: couldn't set socket option TCP_USER_TIMEOUT' Sep 20 12:26:23 OpenMPTCProuter daemon.info glorytun[980]: STARTED tun0 Sep 20 12:26:24 OpenMPTCProuter user.notice firewall.omr-server: Firewall reload, set server part firewall reloading Sep 20 12:26:28 OpenMPTCProuter user.notice firewall: Reloading firewall due to ifup of omrvpn (tun0) Sep 20 12:26:28 OpenMPTCProuter daemon.info dnsmasq[1]: exiting on receipt of SIGTERM Sep 20 12:26:28 OpenMPTCProuter daemon.err procd: Got unexpected signal 1 Sep 20 12:26:28 OpenMPTCProuter daemon.info dnsmasq[1]: started, version 2.90 cachesize 10000 Sep 20 12:26:28 OpenMPTCProuter daemon.info dnsmasq[1]: DNS service limited to local subnets Sep 20 12:26:28 OpenMPTCProuter daemon.info dnsmasq[1]: compile time options: IPv6 GNU-getopt no-DBus UBus no-i18n no-IDN DHCP DHCPv6 no-Lua TFTP conntrack no-ipset nftset auth cryptohash DNSSEC no-ID loop-detect inotify dumpfile Sep 20 12:26:28 OpenMPTCProuter daemon.info dnsmasq[1]: UBus support enabled: connected to system bus Sep 20 12:26:28 OpenMPTCProuter daemon.info dnsmasq-dhcp[1]: DHCP, IP range 192.168.42.100 -- 192.168.42.249, lease time 1h Sep 20 12:26:28 OpenMPTCProuter daemon.info dnsmasq[1]: using nameserver 10.255.255.1#53 Sep 20 12:26:28 OpenMPTCProuter daemon.info dnsmasq[1]: using nameserver 1.1.1.2#53 Sep 20 12:26:28 OpenMPTCProuter daemon.info dnsmasq[1]: using nameserver 1.0.0.2#53 Sep 20 12:26:28 OpenMPTCProuter daemon.info dnsmasq[1]: using nameserver 2606:4700:4700::1002#53 Sep 20 12:26:28 OpenMPTCProuter daemon.info dnsmasq[1]: using nameserver 2606:4700:4700::1112#53 Sep 20 12:26:28 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for test Sep 20 12:26:28 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for onion Sep 20 12:26:28 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for localhost Sep 20 12:26:28 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for local Sep 20 12:26:28 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for invalid Sep 20 12:26:28 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for bind Sep 20 12:26:28 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for use-application-dns.net Sep 20 12:26:28 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for lan Sep 20 12:26:28 OpenMPTCProuter daemon.info dnsmasq[1]: using 1 more local addresses Sep 20 12:26:28 OpenMPTCProuter daemon.info dnsmasq[1]: read /etc/hosts - 12 names Sep 20 12:26:28 OpenMPTCProuter daemon.info dnsmasq[1]: read /tmp/hosts/dhcp.cfg01411c - 4 names Sep 20 12:26:28 OpenMPTCProuter daemon.info dnsmasq[1]: read /tmp/hosts/odhcpd - 2 names Sep 20 12:26:28 OpenMPTCProuter daemon.info dnsmasq-dhcp[1]: read /etc/ethers - 0 addresses Sep 20 12:26:29 OpenMPTCProuter user.notice firewall.omr-server: Firewall reload, set server part firewall reloading Sep 20 12:26:29 OpenMPTCProuter user.notice omr-tracker: Launched Sep 20 12:26:29 OpenMPTCProuter user.notice omr-tracker: Launching... Sep 20 12:26:30 OpenMPTCProuter daemon.notice ttyd[26389]: [2024/09/20 12:26:30:4499] N: rops_handle_POLLIN_netlink: DELADDR Sep 20 12:26:31 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:26:31 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:26:31 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:26:31 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:26:32 OpenMPTCProuter daemon.info dnsmasq-dhcp[1]: DHCPREQUEST(eth0) 192.168.42.172 8e:85:80:06:38:9c Sep 20 12:26:32 OpenMPTCProuter daemon.info dnsmasq-dhcp[1]: DHCPACK(eth0) 192.168.42.172 8e:85:80:06:38:9c Sep 20 12:26:34 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs4_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:26:42 OpenMPTCProuter user.notice omr-tracker: Launched Sep 20 12:26:43 OpenMPTCProuter daemon.info dnsmasq-dhcp[1]: DHCPREQUEST(eth0) 192.168.42.178 e2:aa:56:a6:f4:48 Sep 20 12:26:43 OpenMPTCProuter daemon.info dnsmasq-dhcp[1]: DHCPACK(eth0) 192.168.42.178 e2:aa:56:a6:f4:48 Pixel-6a Sep 20 12:26:45 OpenMPTCProuter user.notice post-tracking-003-up: Tunnel up : Replace default route by 10.255.255.1 dev tun0 (was 192.168.12.1) Sep 20 12:26:45 OpenMPTCProuter user.notice post-tracking-003-up: Set VPN MTU Sep 20 12:26:45 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs4_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:26:52 OpenMPTCProuter daemon.info omr-tracker-ss: Shadowsocks rust sss1 is down (can't contact via http 212.27.48.10, 198.27.92.1) Sep 20 12:26:59 OpenMPTCProuter daemon.info omr-tracker-ss: Server sss1 (2605:6400:40:fe6c:99:22:77:65) seems down, no answer to ping Sep 20 12:27:12 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:27:17 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:27:18 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:27:18 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:27:18 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:27:26 OpenMPTCProuter user.notice firewall.omr-server: Firewall reload, set server part firewall reloading Sep 20 12:27:27 OpenMPTCProuter user.notice omr-bypass: Restart dnsmasq... Sep 20 12:27:27 OpenMPTCProuter daemon.info dnsmasq[1]: exiting on receipt of SIGTERM Sep 20 12:27:27 OpenMPTCProuter user.notice post-tracking-020-status: New public ip detected for TMobile (eth0.3): 172.59.67.148 (First public IP detected) Sep 20 12:27:28 OpenMPTCProuter daemon.info dnsmasq[1]: started, version 2.90 cachesize 10000 Sep 20 12:27:28 OpenMPTCProuter daemon.info dnsmasq[1]: DNS service limited to local subnets Sep 20 12:27:28 OpenMPTCProuter daemon.info dnsmasq[1]: compile time options: IPv6 GNU-getopt no-DBus UBus no-i18n no-IDN DHCP DHCPv6 no-Lua TFTP conntrack no-ipset nftset auth cryptohash DNSSEC no-ID loop-detect inotify dumpfile Sep 20 12:27:28 OpenMPTCProuter daemon.info dnsmasq[1]: UBus support enabled: connected to system bus Sep 20 12:27:28 OpenMPTCProuter daemon.info dnsmasq-dhcp[1]: DHCP, IP range 192.168.42.100 -- 192.168.42.249, lease time 1h Sep 20 12:27:28 OpenMPTCProuter daemon.info dnsmasq[1]: using nameserver 10.255.255.1#53 Sep 20 12:27:28 OpenMPTCProuter daemon.info dnsmasq[1]: using nameserver 1.1.1.2#53 Sep 20 12:27:28 OpenMPTCProuter daemon.info dnsmasq[1]: using nameserver 1.0.0.2#53 Sep 20 12:27:28 OpenMPTCProuter daemon.info dnsmasq[1]: using nameserver 2606:4700:4700::1002#53 Sep 20 12:27:28 OpenMPTCProuter daemon.info dnsmasq[1]: using nameserver 2606:4700:4700::1112#53 Sep 20 12:27:28 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for test Sep 20 12:27:28 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for onion Sep 20 12:27:28 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for localhost Sep 20 12:27:28 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for local Sep 20 12:27:28 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for invalid Sep 20 12:27:28 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for bind Sep 20 12:27:28 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for use-application-dns.net Sep 20 12:27:28 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for lan Sep 20 12:27:28 OpenMPTCProuter daemon.info dnsmasq[1]: using 1 more local addresses Sep 20 12:27:28 OpenMPTCProuter daemon.info dnsmasq[1]: read /etc/hosts - 12 names Sep 20 12:27:28 OpenMPTCProuter daemon.info dnsmasq[1]: read /tmp/hosts/dhcp.cfg01411c - 4 names Sep 20 12:27:28 OpenMPTCProuter daemon.info dnsmasq[1]: read /tmp/hosts/odhcpd - 2 names Sep 20 12:27:28 OpenMPTCProuter daemon.info dnsmasq-dhcp[1]: read /etc/ethers - 0 addresses Sep 20 12:27:28 OpenMPTCProuter user.notice omr-bypass: OMR-ByPass is running Sep 20 12:27:30 OpenMPTCProuter daemon.info dnsmasq-dhcp[1]: DHCPREQUEST(eth0) 192.168.42.249 40:e2:30:0f:94:b0 Sep 20 12:27:30 OpenMPTCProuter daemon.info dnsmasq-dhcp[1]: DHCPACK(eth0) 192.168.42.249 40:e2:30:0f:94:b0 Canon5324f1 Sep 20 12:27:33 OpenMPTCProuter user.notice omr-schedule-010-services: Set firewall on server vps Sep 20 12:27:35 OpenMPTCProuter daemon.info dnsmasq-dhcp[1]: DHCPREQUEST(eth0) 192.168.42.230 50:5a:65:c7:eb:23 Sep 20 12:27:35 OpenMPTCProuter daemon.info dnsmasq-dhcp[1]: DHCPACK(eth0) 192.168.42.230 50:5a:65:c7:eb:23 EcoNet-505A65C7EB23 Sep 20 12:27:35 OpenMPTCProuter daemon.info dnsmasq-dhcp[1]: DHCPREQUEST(eth0) 192.168.42.249 40:e2:30:0f:94:b0 Sep 20 12:27:35 OpenMPTCProuter daemon.info dnsmasq-dhcp[1]: DHCPACK(eth0) 192.168.42.249 40:e2:30:0f:94:b0 Canon5324f1 Sep 20 12:27:35 OpenMPTCProuter daemon.info omr-tracker-ss: Reload Shadowsocks Rust rules Sep 20 12:27:37 OpenMPTCProuter user.notice firewall.omr-server: Firewall reload, set server part firewall reloading Sep 20 12:27:38 OpenMPTCProuter user.notice firewall.omr-server: Firewall reload, set server part firewall reloading Sep 20 12:27:40 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:27:50 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs4_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:27:54 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dst_bypass_all_4 Error: No such file or directory Sep 20 12:27:54 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dst_bypass_all_4 Error: No such file or directory Sep 20 12:27:55 OpenMPTCProuter user.notice OMR-Tracker-Server: Master server vps down (2605:6400:40:fe6c:99:22:77:65) Sep 20 12:27:58 OpenMPTCProuter user.notice firewall.omr-server: Firewall reload, set server part firewall reloading Sep 20 12:27:58 OpenMPTCProuter daemon.info omr-tracker-ss: Reload Shadowsocks Rust rules Sep 20 12:27:59 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs4_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:28:01 OpenMPTCProuter user.notice omr-schedule-010-services: Can't find omr-bypass rules, restart omr-bypass... Sep 20 12:28:01 OpenMPTCProuter user.notice omr-bypass: Starting OMR-ByPass... Sep 20 12:28:03 OpenMPTCProuter user.notice firewall.omr-server: Firewall reload, set server part firewall reloading Sep 20 12:28:04 OpenMPTCProuter daemon.err procd: instance omr not found Sep 20 12:28:05 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:28:05 OpenMPTCProuter daemon.info unbound: [3706:0] info: service stopped (unbound 1.21.0). Sep 20 12:28:05 OpenMPTCProuter daemon.info unbound: [3706:0] info: server stats for thread 0: 0 queries, 0 answers from cache, 0 recursions, 0 prefetch, 0 rejected by ip ratelimiting Sep 20 12:28:05 OpenMPTCProuter daemon.info unbound: [3706:0] info: server stats for thread 0: requestlist max 0 avg 0 exceeded 0 jostled 0 Sep 20 12:28:05 OpenMPTCProuter daemon.info dnsmasq[1]: exiting on receipt of SIGTERM Sep 20 12:28:06 OpenMPTCProuter daemon.notice unbound: [7798:0] notice: init module 0: respip Sep 20 12:28:06 OpenMPTCProuter daemon.notice unbound: [7798:0] notice: init module 1: iterator Sep 20 12:28:06 OpenMPTCProuter daemon.info unbound: [7798:0] info: start of service (unbound 1.21.0). Sep 20 12:28:06 OpenMPTCProuter daemon.info dnsmasq[1]: started, version 2.90 cachesize 10000 Sep 20 12:28:06 OpenMPTCProuter daemon.info dnsmasq[1]: DNS service limited to local subnets Sep 20 12:28:06 OpenMPTCProuter daemon.info dnsmasq[1]: compile time options: IPv6 GNU-getopt no-DBus UBus no-i18n no-IDN DHCP DHCPv6 no-Lua TFTP conntrack no-ipset nftset auth cryptohash DNSSEC no-ID loop-detect inotify dumpfile Sep 20 12:28:06 OpenMPTCProuter daemon.info dnsmasq[1]: UBus support enabled: connected to system bus Sep 20 12:28:06 OpenMPTCProuter daemon.info dnsmasq-dhcp[1]: DHCP, IP range 192.168.42.100 -- 192.168.42.249, lease time 1h Sep 20 12:28:06 OpenMPTCProuter daemon.info dnsmasq[1]: using nameserver 10.255.255.1#53 Sep 20 12:28:06 OpenMPTCProuter daemon.info dnsmasq[1]: using nameserver 1.1.1.2#53 Sep 20 12:28:06 OpenMPTCProuter daemon.info dnsmasq[1]: using nameserver 1.0.0.2#53 Sep 20 12:28:06 OpenMPTCProuter daemon.info dnsmasq[1]: using nameserver 2606:4700:4700::1002#53 Sep 20 12:28:06 OpenMPTCProuter daemon.info dnsmasq[1]: using nameserver 2606:4700:4700::1112#53 Sep 20 12:28:06 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for test Sep 20 12:28:06 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for onion Sep 20 12:28:06 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for localhost Sep 20 12:28:06 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for local Sep 20 12:28:06 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for invalid Sep 20 12:28:06 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for bind Sep 20 12:28:06 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for use-application-dns.net Sep 20 12:28:06 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for lan Sep 20 12:28:06 OpenMPTCProuter daemon.info dnsmasq[1]: using 1 more local addresses Sep 20 12:28:06 OpenMPTCProuter daemon.info dnsmasq[1]: read /etc/hosts - 12 names Sep 20 12:28:06 OpenMPTCProuter daemon.info dnsmasq[1]: read /tmp/hosts/dhcp.cfg01411c - 4 names Sep 20 12:28:06 OpenMPTCProuter daemon.info dnsmasq[1]: read /tmp/hosts/odhcpd - 2 names Sep 20 12:28:06 OpenMPTCProuter daemon.info dnsmasq-dhcp[1]: read /etc/ethers - 0 addresses Sep 20 12:28:11 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:28:12 OpenMPTCProuter daemon.info dnsmasq-dhcp[1]: DHCPREQUEST(eth0) 192.168.42.179 90:09:df:41:bb:4e Sep 20 12:28:12 OpenMPTCProuter daemon.warn dnsmasq-dhcp[1]: Ignoring domain mxns.loc for DHCP host name MXNS-5K2RSV3 Sep 20 12:28:12 OpenMPTCProuter daemon.info dnsmasq-dhcp[1]: DHCPACK(eth0) 192.168.42.179 90:09:df:41:bb:4e MXNS-5K2RSV3 Sep 20 12:28:19 OpenMPTCProuter daemon.notice netifd: Starlink (24208): udhcpc: sending renew to server 100.64.0.1 Sep 20 12:28:19 OpenMPTCProuter daemon.notice netifd: Starlink (24208): udhcpc: lease of 100.124.24.171 obtained from 100.64.0.1, lease time 300 Sep 20 12:28:22 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:28:22 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:28:22 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:28:22 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:28:22 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:28:22 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:28:22 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:28:22 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:28:23 OpenMPTCProuter daemon.info dnsmasq-dhcp[1]: DHCPREQUEST(eth0) 192.168.42.131 80:2a:a8:02:af:32 Sep 20 12:28:23 OpenMPTCProuter daemon.info dnsmasq-dhcp[1]: DHCPACK(eth0) 192.168.42.131 80:2a:a8:02:af:32 AFi-R-HD-02AF32 Sep 20 12:28:23 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs4_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:28:24 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs4_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:28:24 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs4_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:28:27 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:28:27 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:28:27 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:28:27 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:28:37 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs4_4 Error: No such file or directory Sep 20 12:28:39 OpenMPTCProuter daemon.info omr-tracker-ss: Reload Shadowsocks Rust rules Sep 20 12:28:39 OpenMPTCProuter user.notice firewall.omr-server: Firewall reload, set server part firewall reloading Sep 20 12:28:42 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:28:44 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:28:44 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_4 Error: No such file or directory Sep 20 12:28:44 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: No such file or directory Sep 20 12:28:45 OpenMPTCProuter user.notice firewall.omr-server: Firewall reload, set server part firewall reloading Sep 20 12:28:45 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:28:45 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:28:45 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:28:45 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:28:46 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs4_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:28:47 OpenMPTCProuter daemon.err procd: instance omr not found Sep 20 12:28:48 OpenMPTCProuter daemon.info unbound: [7798:0] info: service stopped (unbound 1.21.0). Sep 20 12:28:48 OpenMPTCProuter daemon.info unbound: [7798:0] info: server stats for thread 0: 0 queries, 0 answers from cache, 0 recursions, 0 prefetch, 0 rejected by ip ratelimiting Sep 20 12:28:48 OpenMPTCProuter daemon.info unbound: [7798:0] info: server stats for thread 0: requestlist max 0 avg 0 exceeded 0 jostled 0 Sep 20 12:28:48 OpenMPTCProuter daemon.info dnsmasq[1]: exiting on receipt of SIGTERM Sep 20 12:28:48 OpenMPTCProuter daemon.notice unbound: [21952:0] notice: init module 0: respip Sep 20 12:28:48 OpenMPTCProuter daemon.notice unbound: [21952:0] notice: init module 1: iterator Sep 20 12:28:49 OpenMPTCProuter daemon.info unbound: [21952:0] info: start of service (unbound 1.21.0). Sep 20 12:28:49 OpenMPTCProuter daemon.info dnsmasq[1]: started, version 2.90 cachesize 10000 Sep 20 12:28:49 OpenMPTCProuter daemon.info dnsmasq[1]: DNS service limited to local subnets Sep 20 12:28:49 OpenMPTCProuter daemon.info dnsmasq[1]: compile time options: IPv6 GNU-getopt no-DBus UBus no-i18n no-IDN DHCP DHCPv6 no-Lua TFTP conntrack no-ipset nftset auth cryptohash DNSSEC no-ID loop-detect inotify dumpfile Sep 20 12:28:49 OpenMPTCProuter daemon.info dnsmasq[1]: UBus support enabled: connected to system bus Sep 20 12:28:49 OpenMPTCProuter daemon.info dnsmasq-dhcp[1]: DHCP, IP range 192.168.42.100 -- 192.168.42.249, lease time 1h Sep 20 12:28:49 OpenMPTCProuter daemon.info dnsmasq[1]: using nameserver 10.255.255.1#53 Sep 20 12:28:49 OpenMPTCProuter daemon.info dnsmasq[1]: using nameserver 1.1.1.2#53 Sep 20 12:28:49 OpenMPTCProuter daemon.info dnsmasq[1]: using nameserver 1.0.0.2#53 Sep 20 12:28:49 OpenMPTCProuter daemon.info dnsmasq[1]: using nameserver 2606:4700:4700::1002#53 Sep 20 12:28:49 OpenMPTCProuter daemon.info dnsmasq[1]: using nameserver 2606:4700:4700::1112#53 Sep 20 12:28:49 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for test Sep 20 12:28:49 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for onion Sep 20 12:28:49 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for localhost Sep 20 12:28:49 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for local Sep 20 12:28:49 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for invalid Sep 20 12:28:49 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for bind Sep 20 12:28:49 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for use-application-dns.net Sep 20 12:28:49 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for lan Sep 20 12:28:49 OpenMPTCProuter daemon.info dnsmasq[1]: using 1 more local addresses Sep 20 12:28:49 OpenMPTCProuter daemon.info dnsmasq[1]: read /etc/hosts - 12 names Sep 20 12:28:49 OpenMPTCProuter daemon.info dnsmasq[1]: read /tmp/hosts/dhcp.cfg01411c - 4 names Sep 20 12:28:49 OpenMPTCProuter daemon.info dnsmasq[1]: read /tmp/hosts/odhcpd - 2 names Sep 20 12:28:49 OpenMPTCProuter daemon.info dnsmasq-dhcp[1]: read /etc/ethers - 0 addresses Sep 20 12:28:50 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs4_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:28:51 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs4_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:28:54 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:28:55 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:29:07 OpenMPTCProuter user.notice firewall.omr-server: Firewall reload, set server part firewall reloading Sep 20 12:29:08 OpenMPTCProuter user.notice omr-bypass: Restart dnsmasq... Sep 20 12:29:08 OpenMPTCProuter daemon.info dnsmasq[1]: exiting on receipt of SIGTERM Sep 20 12:29:09 OpenMPTCProuter user.notice omr-bypass: OMR-ByPass is running Sep 20 12:29:09 OpenMPTCProuter daemon.info dnsmasq[1]: started, version 2.90 cachesize 10000 Sep 20 12:29:09 OpenMPTCProuter daemon.info dnsmasq[1]: DNS service limited to local subnets Sep 20 12:29:09 OpenMPTCProuter daemon.info dnsmasq[1]: compile time options: IPv6 GNU-getopt no-DBus UBus no-i18n no-IDN DHCP DHCPv6 no-Lua TFTP conntrack no-ipset nftset auth cryptohash DNSSEC no-ID loop-detect inotify dumpfile Sep 20 12:29:09 OpenMPTCProuter daemon.info dnsmasq[1]: UBus support enabled: connected to system bus Sep 20 12:29:09 OpenMPTCProuter daemon.info dnsmasq-dhcp[1]: DHCP, IP range 192.168.42.100 -- 192.168.42.249, lease time 1h Sep 20 12:29:09 OpenMPTCProuter daemon.info dnsmasq[1]: using nameserver 10.255.255.1#53 Sep 20 12:29:09 OpenMPTCProuter daemon.info dnsmasq[1]: using nameserver 1.1.1.2#53 Sep 20 12:29:09 OpenMPTCProuter daemon.info dnsmasq[1]: using nameserver 1.0.0.2#53 Sep 20 12:29:09 OpenMPTCProuter daemon.info dnsmasq[1]: using nameserver 2606:4700:4700::1002#53 Sep 20 12:29:09 OpenMPTCProuter daemon.info dnsmasq[1]: using nameserver 2606:4700:4700::1112#53 Sep 20 12:29:09 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for test Sep 20 12:29:09 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for onion Sep 20 12:29:09 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for localhost Sep 20 12:29:09 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for local Sep 20 12:29:09 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for invalid Sep 20 12:29:09 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for bind Sep 20 12:29:09 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for use-application-dns.net Sep 20 12:29:09 OpenMPTCProuter daemon.info dnsmasq[1]: using only locally-known addresses for lan Sep 20 12:29:09 OpenMPTCProuter daemon.info dnsmasq[1]: using 1 more local addresses Sep 20 12:29:09 OpenMPTCProuter daemon.info dnsmasq[1]: read /etc/hosts - 12 names Sep 20 12:29:09 OpenMPTCProuter daemon.info dnsmasq[1]: read /tmp/hosts/dhcp.cfg01411c - 4 names Sep 20 12:29:09 OpenMPTCProuter daemon.info dnsmasq[1]: read /tmp/hosts/odhcpd - 2 names Sep 20 12:29:09 OpenMPTCProuter daemon.info dnsmasq-dhcp[1]: read /etc/ethers - 0 addresses Sep 20 12:29:14 OpenMPTCProuter user.notice omr-schedule-010-services: Set firewall on server vps Sep 20 12:29:22 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs4_6 Error: Could not resolve hostname: Name has no usable address Sep 20 12:29:22 OpenMPTCProuter daemon.err dnsmasq[1]: nftset inet fw4 omr_dscp_cs5_6 Error: Could not resolve hostname: Name has no usable address

Ysurac commented 3 weeks ago

@datapharmer please open another issue or keep on your current open issue. I'm not sure at all this issue is related to yours.

datapharmer commented 3 weeks ago

sorry -will do

x4rd0o1Vtx commented 3 weeks ago

I've upgraded the router to the latest version (v0.60-6.1 r0+24843-acf40c022e) but unfortunately the behavior has not changed... I've also tested the new Shadowsocks-Rust 2022 proxy but same as well. I'm sure nothing has changed on the router part so it makes me feel that may related to a VPS server update.

x4rd0o1Vtx commented 3 weeks ago

@datapharmer I'm not sure you're facing the same issue but it's seems to be very close to the error message I got. Did you try to use my method to see if you've some error on your side too ?

That's what I get on my side:

..........fatal: unable to access 'https://github.com/Ysurac/openmptcprouter.git/': Recv failure: Connection reset by peer ......................................................................................................................................fatal: unable to access 'https://github.com/Ysurac/openmptcprouter.git/': Recv failure: Connection reset by peer ..............................................................................................................................................................................................................................................................................fatal: unable to access 'https://github.com/Ysurac/openmptcprouter.git/': GnuTLS recv error (-110): The TLS connection was non-properly terminated.

Ysurac commented 3 weeks ago

Did you check time on both router and VPS ? All is green in status page ?

x4rd0o1Vtx commented 3 weeks ago

Yes exact same time on both side and I've also installed the ntp package on the VPS. All is green with the classic Shadowsocks, but with Shadowsocks Rust I got a warning on the VPS (Can't get public IP address from ShadowSocks Rust) but it still works.

Ysurac commented 3 weeks ago

Did you reboot VPS after script update ? Do you have all keys in System->OpenMPTCProuter, wizard, advanced settings checkbox ?

x4rd0o1Vtx commented 3 weeks ago

I've just thinking that I didn't run my method to reproduce directly on the VPS server and I got the same error :o It's very weird and I would tend to say that it's not related to the link between the router and the server.

Yes I've all the keys in the advanced settings.

Ysurac commented 3 weeks ago

So same problem on the VPS ? What is the VPS host ? For shadowsocks-rust issue, can I have Status->System log ?

x4rd0o1Vtx commented 3 weeks ago

I've tested to switch twice to try extracting the interesting logs for the shadowsocks-rust issue, I think these lines may interest you:

Sep 20 17:51:10 router-mptcp daemon.err glorytun[11960]: couldn't set socket option `TCP_KEEPCNT'
Sep 20 17:51:10 router-mptcp daemon.err glorytun[11960]: couldn't set socket option `TCP_KEEPIDLE'
Sep 20 17:51:10 router-mptcp daemon.err glorytun[11960]: couldn't set socket option `TCP_KEEPINTVL'
Sep 20 17:51:10 router-mptcp daemon.err glorytun[11960]: couldn't set socket option `TCP_USER_TIMEOUT'
...
Sep 20 17:51:28 router-mptcp user.notice OMR-VPS: Setting server config error, try again
...
Sep 20 17:51:34 router-mptcp daemon.err procd: Got unexpected signal 1
...
Sep 20 17:52:10 router-mptcp user.notice omr-schedule-010-services: Set firewall on server vps
Sep 20 17:52:19 router-mptcp daemon.info omr-tracker-ss: Shadowsocks sss0 is down (can't contact via http 212.27.48.10, 198.27.92.1, 151.101.129.164)
Sep 20 17:52:20 router-mptcp user.notice firewall.omr-server: Firewall reload, set server part firewall reloading

But for the initial issue the only conclusion I have now is that it seems more an hosting company problem (hardware or something else) but nothing related to the project. It was very nice to take your time for me and I'll not abuse on it.

x4rd0o1Vtx commented 3 weeks ago

I'm not even sure it's related to TLS I've just tried targeting http site from the VPS server and I also got some Recv failure: Connection reset by peer...

I've disabled the ipv6 on the system but no change too. Maybe the firewall but I've no more idea :/

Ysurac commented 3 weeks ago

There is no reason this can be the VPS firewall, but to test you can disable it temporarily: systemctl stop shorewall. I think it's more a problem on hosting company.

x4rd0o1Vtx commented 3 weeks ago

Yes I think the same thing and disable the firewall did not change the behavior. I should have started with that from the beginning...

Thank you again for your help and devotion, your work is truly incredible !