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.8k stars 258 forks source link

Losing connection on Hyper-V #903

Closed ccmks closed 4 years ago

ccmks commented 4 years ago

Expected Behavior

Stable connection running on Hyper-V and expect to work normally

Actual Behavior

After setup OpenMPTCPRouter and get everything setup, the MPTCP is working fine across 3 different WAN. However, after 5 minutes or so, random WAN (either WAN1, WAN2 or WAN3) losing connection. The status page will show "Gateway Down" on one or 2 WAN connection and it happen randomly on which WAN.

Trying to restart the interface but the router WAN which gateway is down can't ping to its respective gateway. The only way to fix it is to reboot the router again, but still having same problem within 5 minutes after rebooting.

Steps to Reproduce the Problem

  1. Download the Hyper-V Image EXT4 or Squash, both regular or EFI
  2. Setup all WAN to be on DHCP
  3. Test connectivity and test ping

Specifications

Ysurac commented 4 years ago

I never used Hyper-V. But you can check in State->System log why wan are losing connections.

ccmks commented 4 years ago

Here is the log

Wed Mar 18 14:36:37 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:37 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI3, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI3 Wed Mar 18 14:36:38 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI3, subsystem=tty Wed Mar 18 14:36:38 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:38 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI4, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI4 Wed Mar 18 14:36:38 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI4, subsystem=tty Wed Mar 18 14:36:38 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:38 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI5, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI5 Wed Mar 18 14:36:38 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI5, subsystem=tty Wed Mar 18 14:36:38 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:38 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI6, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI6 Wed Mar 18 14:36:38 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI6, subsystem=tty Wed Mar 18 14:36:38 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:38 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI7, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI7 Wed Mar 18 14:36:38 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI7, subsystem=tty Wed Mar 18 14:36:38 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:38 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI8, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI8 Wed Mar 18 14:36:38 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI8, subsystem=tty Wed Mar 18 14:36:39 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:39 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI9, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI9 Wed Mar 18 14:36:39 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI9, subsystem=tty Wed Mar 18 14:36:39 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:39 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI10, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI10 Wed Mar 18 14:36:39 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI10, subsystem=tty Wed Mar 18 14:36:39 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:39 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI11, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI11 Wed Mar 18 14:36:39 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI11, subsystem=tty Wed Mar 18 14:36:39 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:39 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI12, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI12 Wed Mar 18 14:36:39 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI12, subsystem=tty Wed Mar 18 14:36:39 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:39 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI13, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI13 Wed Mar 18 14:36:39 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI13, subsystem=tty Wed Mar 18 14:36:39 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:39 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI14, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI14 Wed Mar 18 14:36:39 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI14, subsystem=tty Wed Mar 18 14:36:39 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:39 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI15, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI15 Wed Mar 18 14:36:39 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI15, subsystem=tty Wed Mar 18 14:36:39 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:39 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI16, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI16 Wed Mar 18 14:36:39 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI16, subsystem=tty Wed Mar 18 14:36:39 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:39 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI17, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI17 Wed Mar 18 14:36:39 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI17, subsystem=tty Wed Mar 18 14:36:39 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:39 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI18, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI18 Wed Mar 18 14:36:39 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI18, subsystem=tty Wed Mar 18 14:36:39 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:39 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI19, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI19 Wed Mar 18 14:36:39 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI19, subsystem=tty Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI20, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI20 Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI20, subsystem=tty Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI21, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI21 Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI21, subsystem=tty Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI22, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI22 Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI22, subsystem=tty Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI23, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI23 Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI23, subsystem=tty Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI24, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI24 Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI24, subsystem=tty Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI25, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI25 Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI25, subsystem=tty Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI26, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI26 Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI26, subsystem=tty Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI27, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI27 Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI27, subsystem=tty Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI28, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI28 Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI28, subsystem=tty Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI29, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI29 Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI29, subsystem=tty Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI30, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI30 Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI30, subsystem=tty Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI31, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI31 Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI31, subsystem=tty Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI32, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI32 Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI32, subsystem=tty Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI33, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI33 Wed Mar 18 14:36:40 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI33, subsystem=tty Wed Mar 18 14:36:41 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:41 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI34, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI34 Wed Mar 18 14:36:41 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI34, subsystem=tty Wed Mar 18 14:36:41 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:41 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI35, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI35 Wed Mar 18 14:36:41 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI35, subsystem=tty Wed Mar 18 14:36:41 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:41 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI36, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI36 Wed Mar 18 14:36:41 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI36, subsystem=tty Wed Mar 18 14:36:41 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:41 2020 daemon.info glorytun: starting glorytun vpn instance vpn Wed Mar 18 14:36:41 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI37, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI37 Wed Mar 18 14:36:41 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI37, subsystem=tty Wed Mar 18 14:36:41 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:41 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI38, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI38 Wed Mar 18 14:36:41 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI38, subsystem=tty Wed Mar 18 14:36:41 2020 daemon.notice netifd: Interface 'omrvpn' is enabled Wed Mar 18 14:36:41 2020 daemon.notice netifd: Network device 'tun0' link is up Wed Mar 18 14:36:41 2020 daemon.notice netifd: Interface 'omrvpn' has link connectivity Wed Mar 18 14:36:41 2020 daemon.notice netifd: Interface 'omrvpn' is setting up now Wed Mar 18 14:36:41 2020 daemon.info glorytun[11344]: INITIALIZED tun0 Wed Mar 18 14:36:41 2020 daemon.notice netifd: Interface 'omrvpn' is now up Wed Mar 18 14:36:41 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:42 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI39, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI39 Wed Mar 18 14:36:42 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI39, subsystem=tty Wed Mar 18 14:36:42 2020 user.notice ModemManager: hotplug: add network interface tun0: event processed Wed Mar 18 14:36:42 2020 user.notice ModemManager: hotplug: event reported: action=add, name=tun0, subsystem=net Wed Mar 18 14:36:42 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:42 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:42 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI40, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI40 Wed Mar 18 14:36:42 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI40, subsystem=tty Wed Mar 18 14:36:42 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:42 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI41, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI41 Wed Mar 18 14:36:42 2020 user.notice firewall: Reloading firewall due to ifup of wan1 (eth1) Wed Mar 18 14:36:42 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI41, subsystem=tty Wed Mar 18 14:36:42 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:42 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI42, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI42 Wed Mar 18 14:36:42 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI42, subsystem=tty Wed Mar 18 14:36:42 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:42 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI43, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI43 Wed Mar 18 14:36:42 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI43, subsystem=tty Wed Mar 18 14:36:42 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:42 2020 daemon.err glorytun[11344]: 45.32.101.41.65001: connected Wed Mar 18 14:36:42 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI44, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI44 Wed Mar 18 14:36:42 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI44, subsystem=tty Wed Mar 18 14:36:43 2020 daemon.info glorytun[11344]: STARTED tun0 Wed Mar 18 14:36:43 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:43 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI45, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI45 Wed Mar 18 14:36:43 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI45, subsystem=tty Wed Mar 18 14:36:43 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:43 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI46, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI46 Wed Mar 18 14:36:43 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI46, subsystem=tty Wed Mar 18 14:36:43 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:43 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI47, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI47 Wed Mar 18 14:36:43 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI47, subsystem=tty Wed Mar 18 14:36:43 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:43 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI48, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI48 Wed Mar 18 14:36:43 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI48, subsystem=tty Wed Mar 18 14:36:43 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:43 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI49, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI49 Wed Mar 18 14:36:43 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI49, subsystem=tty Wed Mar 18 14:36:43 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:43 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI50, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI50 Wed Mar 18 14:36:43 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI50, subsystem=tty Wed Mar 18 14:36:43 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:43 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI51, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI51 Wed Mar 18 14:36:43 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI51, subsystem=tty Wed Mar 18 14:36:43 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:43 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI52, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI52 Wed Mar 18 14:36:43 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI52, subsystem=tty Wed Mar 18 14:36:44 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:44 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI53, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI53 Wed Mar 18 14:36:44 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI53, subsystem=tty Wed Mar 18 14:36:44 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:44 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI54, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI54 Wed Mar 18 14:36:44 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI54, subsystem=tty Wed Mar 18 14:36:44 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:44 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI55, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI55 Wed Mar 18 14:36:44 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI55, subsystem=tty Wed Mar 18 14:36:44 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:44 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI56, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI56 Wed Mar 18 14:36:44 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI56, subsystem=tty Wed Mar 18 14:36:44 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:44 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI57, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI57 Wed Mar 18 14:36:44 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI57, subsystem=tty Wed Mar 18 14:36:44 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:44 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI58, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI58 Wed Mar 18 14:36:44 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI58, subsystem=tty Wed Mar 18 14:36:44 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:44 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI59, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI59 Wed Mar 18 14:36:44 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI59, subsystem=tty Wed Mar 18 14:36:44 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:44 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI60, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI60 Wed Mar 18 14:36:44 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI60, subsystem=tty Wed Mar 18 14:36:44 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:44 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI61, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI61 Wed Mar 18 14:36:44 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI61, subsystem=tty Wed Mar 18 14:36:44 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:44 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI62, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI62 Wed Mar 18 14:36:44 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI62, subsystem=tty Wed Mar 18 14:36:45 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:45 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=ttyI63, subsystem=tty, sysfspath=/sys/devices/virtual/tty/ttyI63 Wed Mar 18 14:36:45 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ttyI63, subsystem=tty Wed Mar 18 14:36:45 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:45 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=teql0, subsystem=net, sysfspath=/sys/devices/virtual/net/teql0 Wed Mar 18 14:36:45 2020 user.notice ModemManager: hotplug: event reported: action=add, name=teql0, subsystem=net Wed Mar 18 14:36:45 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:45 2020 user.notice ModemManager: hotplug: cached event found: action=add, name=tun0, subsystem=net, sysfspath=/sys/devices/virtual/net/tun0 Wed Mar 18 14:36:45 2020 user.notice ModemManager: hotplug: event reported: action=add, name=tun0, subsystem=net Wed Mar 18 14:36:45 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:56 2020 user.notice mptcp: Reloading mptcp config due to ifup of wan1 (eth1) Wed Mar 18 14:36:59 2020 user.notice SQM: Starting SQM script: simple.qos on tun0, in: 0 Kbps, out: 0 Kbps Wed Mar 18 14:36:59 2020 user.notice SQM: Using generic sqm_start_default function. Wed Mar 18 14:36:59 2020 user.notice ModemManager: hotplug: add network interface TMP_IFB_4_SQM: event processed Wed Mar 18 14:36:59 2020 user.notice ModemManager: hotplug: event reported: action=add, name=TMP_IFB_4_SQM, subsystem=net Wed Mar 18 14:36:59 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:36:59 2020 daemon.warn [6917]: Invalid sysfs path read for net/TMP_IFB_4_SQM Wed Mar 18 14:36:59 2020 user.notice ModemManager: hotplug: remove network interface TMP_IFB_4_SQM: event processed Wed Mar 18 14:36:59 2020 user.notice ModemManager: hotplug: event reported: action=remove, name=TMP_IFB_4_SQM, subsystem=net Wed Mar 18 14:37:00 2020 user.notice ModemManager: hotplug: add network interface TMP_IFB_4_SQM: event processed Wed Mar 18 14:37:00 2020 user.notice ModemManager: hotplug: event reported: action=add, name=TMP_IFB_4_SQM, subsystem=net Wed Mar 18 14:37:00 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:37:00 2020 daemon.warn [6917]: Invalid sysfs path read for net/TMP_IFB_4_SQM Wed Mar 18 14:37:00 2020 user.notice ModemManager: hotplug: remove network interface TMP_IFB_4_SQM: event processed Wed Mar 18 14:37:00 2020 user.notice ModemManager: hotplug: event reported: action=remove, name=TMP_IFB_4_SQM, subsystem=net Wed Mar 18 14:37:00 2020 user.notice ModemManager: hotplug: add network interface ifb4tun0: event processed Wed Mar 18 14:37:00 2020 user.notice ModemManager: hotplug: event reported: action=add, name=ifb4tun0, subsystem=net Wed Mar 18 14:37:00 2020 user.notice SQM: simple.qos was started on tun0 successfully Wed Mar 18 14:37:00 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:37:01 2020 user.notice firewall: Reloading firewall due to ifup of omrvpn (tun0) Wed Mar 18 14:37:02 2020 user.notice mptcp: Reloading mptcp config due to ifup of omrvpn (tun0) Wed Mar 18 14:37:02 2020 user.notice omr-tracker: Launching... Wed Mar 18 14:37:03 2020 user.notice omr-tracker: Launched Wed Mar 18 14:37:05 2020 user.notice post-tracking-post-tracking: eth4 switched off Wed Mar 18 14:37:05 2020 user.notice post-tracking-post-tracking: Delete default route via dev eth4 Wed Mar 18 14:37:05 2020 daemon.notice openvpn(wan2)[14748]: OpenVPN 2.4.8 x86_64-openwrt-linux-gnu [SSL (OpenSSL)] [LZO] [LZ4] [EPOLL] [MH/PKTINFO] [AEAD] Wed Mar 18 14:37:05 2020 daemon.notice openvpn(wan2)[14748]: library versions: OpenSSL 1.1.1d 10 Sep 2019, LZO 2.10 Wed Mar 18 14:37:05 2020 daemon.warn openvpn(wan2)[14748]: WARNING: No server certificate verification method has been enabled. See http://openvpn.net/howto.html#mitm for more info. Wed Mar 18 14:37:05 2020 daemon.notice openvpn(wan2)[14748]: TCP/UDP: Preserving recently used remote address: [AF_INET]45.32.101.41:65301 Wed Mar 18 14:37:05 2020 daemon.notice openvpn(wan2)[14748]: UDP link local (bound): [AF_INET]192.168.40.102:65301 Wed Mar 18 14:37:05 2020 daemon.notice openvpn(wan2)[14748]: UDP link remote: [AF_INET]45.32.101.41:65301 Wed Mar 18 14:37:05 2020 user.notice post-tracking-post-tracking: ovpnwan2 down. Replace default route by 192.168.8.1 dev eth3 Wed Mar 18 14:37:06 2020 user.notice post-tracking-post-tracking: wan4 down. Replace default route by 192.168.8.1 dev eth3 Wed Mar 18 14:37:06 2020 user.notice post-tracking-post-tracking: Tunnel up : Replace default route by 10.255.255.1 dev tun0 Wed Mar 18 14:37:07 2020 user.notice post-tracking-post-tracking: Set server vps (45.32.101.41) default route via 192.168.80.1 Wed Mar 18 14:37:07 2020 user.notice post-tracking-post-tracking: Set server vps (45.32.101.41) route via 192.168.8.1 metric 5 Wed Mar 18 14:37:07 2020 user.notice post-tracking-post-tracking: Get status and settings for wan3... Wed Mar 18 14:37:07 2020 user.notice post-tracking-post-tracking: Get status and settings for wan1... Wed Mar 18 14:37:08 2020 daemon.err usbmuxd[15200]: [14:37:08.635][3] usbmuxd v1.1.1 starting up Wed Mar 18 14:37:08 2020 daemon.err usbmuxd[15200]: [14:37:08.642][0] libusb_init failed: -99 Wed Mar 18 14:37:08 2020 daemon.notice procd: /etc/rc.d/S95done: Failed to initialize libusb: LIBUSB_ERROR_OTHER Wed Mar 18 14:37:10 2020 daemon.notice procd: /etc/rc.d/S95done: Failed to initialize libusb: LIBUSB_ERROR_OTHER Wed Mar 18 14:37:11 2020 user.err vnstat_backup: cannot restore, backup file does not exist (yet) Wed Mar 18 14:37:11 2020 user.notice adb-enablemodem: INFO: waiting for device Wed Mar 18 14:37:11 2020 daemon.notice procd: /etc/rc.d/S99omr-6in4: net.ipv6.conf.all.disable_ipv6 = 1 Wed Mar 18 14:37:11 2020 user.notice omr-6in4: Disable IPv6 Wed Mar 18 14:37:12 2020 user.notice omr-bypass: Starting OMR-ByPass... Wed Mar 18 14:37:13 2020 daemon.notice openvpn(wan2)[14748]: [server] Peer Connection Initiated with [AF_INET]45.32.101.41:65301 Wed Mar 18 14:20:48 2020 daemon.notice netifd: Interface 'ovpnwan2' is enabled Wed Mar 18 14:20:48 2020 daemon.notice netifd: Network device 'tun4' link is up Wed Mar 18 14:20:48 2020 daemon.notice netifd: Interface 'ovpnwan2' has link connectivity Wed Mar 18 14:20:48 2020 daemon.notice netifd: Interface 'ovpnwan2' is setting up now Wed Mar 18 14:20:48 2020 daemon.notice netifd: Interface 'ovpnwan2' is now up Wed Mar 18 14:20:48 2020 daemon.notice openvpn(wan2)[14748]: TUN/TAP device tun4 opened Wed Mar 18 14:20:48 2020 daemon.notice openvpn(wan2)[14748]: /sbin/ifconfig tun4 10.255.250.6 pointopoint 10.255.250.5 mtu 1500 Wed Mar 18 14:20:48 2020 daemon.notice openvpn(wan2)[14748]: Initialization Sequence Completed Wed Mar 18 14:20:48 2020 user.notice ModemManager: hotplug: add network interface tun4: event processed Wed Mar 18 14:20:49 2020 user.notice ModemManager: hotplug: event reported: action=add, name=tun4, subsystem=net Wed Mar 18 14:20:49 2020 user.notice ModemManager: hotplug: error: parent device sysfspath not found Wed Mar 18 14:20:49 2020 user.notice mptcp: Reloading mptcp config due to ifup of ovpnwan2 (tun4) Wed Mar 18 14:20:51 2020 user.notice post-tracking-post-tracking: Get status and settings for wan3... Done Wed Mar 18 14:20:53 2020 user.notice Shadowsocks: Rules UP Wed Mar 18 14:20:55 2020 user.notice Shadowsocks: Reload omr-bypass rules Wed Mar 18 14:20:55 2020 user.notice omr-bypass: Starting OMR-ByPass... Wed Mar 18 14:20:55 2020 daemon.err omr-tracker-ss[14537]: Another app is currently holding the xtables lock. Perhaps you want to use the -w option? Wed Mar 18 14:20:59 2020 user.notice post-tracking-post-tracking: Get status and settings for wan1... Done Wed Mar 18 14:21:00 2020 user.notice omr-bypass: Restart dnsmasq... Wed Mar 18 14:21:00 2020 daemon.info dnsmasq[6418]: exiting on receipt of SIGTERM Wed Mar 18 14:21:01 2020 daemon.info omr-tracker-ss: Shadowsocks is down (can't contact via http 1.1.1.1, 1.0.0.1, 212.27.48.10, 104.16.1.1) Wed Mar 18 14:21:01 2020 user.notice dnsmasq: DNS rebinding protection is active, will discard upstream RFC1918 responses! Wed Mar 18 14:21:01 2020 user.notice dnsmasq: Allowing 127.0.0.0/8 responses Wed Mar 18 14:21:01 2020 user.notice dnsmasq: Allowing RFC1918 responses for domain plex.direct Wed Mar 18 14:21:01 2020 user.notice omr-bypass: OMR-ByPass is running Wed Mar 18 14:21:01 2020 daemon.info dnsmasq[18427]: started, version 2.81rc3 cachesize 150 Wed Mar 18 14:21:01 2020 daemon.info dnsmasq[18427]: DNS service limited to local subnets Wed Mar 18 14:21:01 2020 daemon.info dnsmasq[18427]: compile time options: IPv6 GNU-getopt no-DBus UBus no-i18n no-IDN DHCP DHCPv6 no-Lua TFTP conntrack ipset auth DNSSEC no-ID loop-detect inotify dumpfile Wed Mar 18 14:21:01 2020 daemon.info dnsmasq-dhcp[18427]: DHCP, IP range 192.168.100.100 -- 192.168.100.249, lease time 12h Wed Mar 18 14:21:01 2020 daemon.info dnsmasq[18427]: using only locally-known addresses for domain test Wed Mar 18 14:21:01 2020 daemon.info dnsmasq[18427]: using only locally-known addresses for domain onion Wed Mar 18 14:21:01 2020 daemon.info dnsmasq[18427]: using only locally-known addresses for domain localhost Wed Mar 18 14:21:01 2020 daemon.info dnsmasq[18427]: using only locally-known addresses for domain local Wed Mar 18 14:21:01 2020 daemon.info dnsmasq[18427]: using only locally-known addresses for domain invalid Wed Mar 18 14:21:01 2020 daemon.info dnsmasq[18427]: using only locally-known addresses for domain bind Wed Mar 18 14:21:01 2020 daemon.info dnsmasq[18427]: using only locally-known addresses for domain use-application-dns.net Wed Mar 18 14:21:01 2020 daemon.info dnsmasq[18427]: using nameserver 127.0.0.1#5353 Wed Mar 18 14:21:01 2020 daemon.info dnsmasq[18427]: using only locally-known addresses for domain lan Wed Mar 18 14:21:01 2020 daemon.info dnsmasq[18427]: read /etc/hosts - 4 addresses Wed Mar 18 14:21:01 2020 daemon.info dnsmasq[18427]: read /tmp/hosts/dhcp.cfg01411c - 2 addresses Wed Mar 18 14:21:01 2020 daemon.info dnsmasq-dhcp[18427]: read /etc/ethers - 0 addresses Wed Mar 18 14:21:02 2020 user.notice Shadowsocks: Rules DOWN Wed Mar 18 14:21:04 2020 user.notice omr-bypass: Reload dnsmasq... Wed Mar 18 14:21:04 2020 daemon.info dnsmasq[18427]: exiting on receipt of SIGTERM Wed Mar 18 14:21:04 2020 daemon.info dnsmasq[18881]: started, version 2.81rc3 cachesize 150 Wed Mar 18 14:21:04 2020 daemon.info dnsmasq[18881]: DNS service limited to local subnets Wed Mar 18 14:21:04 2020 daemon.info dnsmasq[18881]: compile time options: IPv6 GNU-getopt no-DBus UBus no-i18n no-IDN DHCP DHCPv6 no-Lua TFTP conntrack ipset auth DNSSEC no-ID loop-detect inotify dumpfile Wed Mar 18 14:21:04 2020 daemon.info dnsmasq-dhcp[18881]: DHCP, IP range 192.168.100.100 -- 192.168.100.249, lease time 12h Wed Mar 18 14:21:04 2020 daemon.info dnsmasq[18881]: using only locally-known addresses for domain test Wed Mar 18 14:21:04 2020 daemon.info dnsmasq[18881]: using only locally-known addresses for domain onion Wed Mar 18 14:21:04 2020 daemon.info dnsmasq[18881]: using only locally-known addresses for domain localhost Wed Mar 18 14:21:04 2020 daemon.info dnsmasq[18881]: using only locally-known addresses for domain local Wed Mar 18 14:21:04 2020 daemon.info dnsmasq[18881]: using only locally-known addresses for domain invalid Wed Mar 18 14:21:04 2020 daemon.info dnsmasq[18881]: using only locally-known addresses for domain bind Wed Mar 18 14:21:04 2020 daemon.info dnsmasq[18881]: using only locally-known addresses for domain use-application-dns.net Wed Mar 18 14:21:04 2020 daemon.info dnsmasq[18881]: using nameserver 127.0.0.1#5353 Wed Mar 18 14:21:04 2020 daemon.info dnsmasq[18881]: using only locally-known addresses for domain lan Wed Mar 18 14:21:04 2020 daemon.info dnsmasq[18881]: read /etc/hosts - 4 addresses Wed Mar 18 14:21:04 2020 daemon.info dnsmasq[18881]: read /tmp/hosts/dhcp.cfg01411c - 2 addresses Wed Mar 18 14:21:04 2020 daemon.info dnsmasq-dhcp[18881]: read /etc/ethers - 0 addresses Wed Mar 18 14:21:04 2020 daemon.info dnsmasq[18881]: read /etc/hosts - 4 addresses Wed Mar 18 14:21:04 2020 daemon.info dnsmasq[18881]: read /tmp/hosts/dhcp.cfg01411c - 2 addresses Wed Mar 18 14:21:04 2020 daemon.info dnsmasq-dhcp[18881]: read /etc/ethers - 0 addresses Wed Mar 18 14:21:04 2020 user.notice omr-bypass: OMR-ByPass is running Wed Mar 18 14:21:11 2020 user.notice post-tracking-post-tracking: Set server vps (45.32.101.41) route via 10.255.250.5 metric 9 Wed Mar 18 14:21:11 2020 user.notice post-tracking-post-tracking: Get status and settings for ovpnwan2... Wed Mar 18 14:21:14 2020 user.notice post-tracking-post-tracking: Get status and settings for ovpnwan2... Done Wed Mar 18 14:21:15 2020 daemon.info omr-tracker-ss: Server (45.32.101.41) seems down, no answer to ping Wed Mar 18 14:21:21 2020 daemon.info unbound: [6995:0] info: service stopped (unbound 1.10.0). Wed Mar 18 14:21:21 2020 daemon.info unbound: [6995:0] info: server stats for thread 0: 22 queries, 1 answers from cache, 21 recursions, 0 prefetch, 0 rejected by ip ratelimiting Wed Mar 18 14:21:21 2020 daemon.info unbound: [6995:0] info: server stats for thread 0: requestlist max 13 avg 3.42857 exceeded 0 jostled 0 Wed Mar 18 14:21:21 2020 daemon.info unbound: [6995:0] info: average recursion processing time 0.456483 sec Wed Mar 18 14:21:21 2020 daemon.info unbound: [6995:0] info: histogram of recursion processing times Wed Mar 18 14:21:21 2020 daemon.info unbound: [6995:0] info: [25%]=0.223915 median[50%]=0.393216 [75%]=0.663037 Wed Mar 18 14:21:21 2020 daemon.info unbound: [6995:0] info: lower(secs) upper(secs) recursions Wed Mar 18 14:21:21 2020 daemon.info unbound: [6995:0] info: 0.065536 0.131072 1 Wed Mar 18 14:21:21 2020 daemon.info unbound: [6995:0] info: 0.131072 0.262144 6 Wed Mar 18 14:21:21 2020 daemon.info unbound: [6995:0] info: 0.262144 0.524288 7 Wed Mar 18 14:21:21 2020 daemon.info unbound: [6995:0] info: 0.524288 1.000000 6 Wed Mar 18 14:21:21 2020 daemon.info unbound: [6995:0] info: 1.000000 2.000000 1 Wed Mar 18 14:21:21 2020 daemon.notice unbound: [19762:0] notice: init module 0: iterator Wed Mar 18 14:21:21 2020 daemon.info unbound: [19762:0] info: start of service (unbound 1.10.0). Wed Mar 18 14:21:23 2020 user.notice OMR-VPS: Can't get token, try later (can't ping server, no server API answer) Wed Mar 18 14:21:23 2020 user.notice post-tracking-post-tracking: Can't find Shadowsocks, restart it... Wed Mar 18 14:21:23 2020 daemon.err omr-tracker[14533]: Command failed: Not found Wed Mar 18 14:21:24 2020 user.notice Shadowsocks: Rules UP Wed Mar 18 14:21:24 2020 user.notice Shadowsocks: Reload omr-bypass rules Wed Mar 18 14:21:24 2020 user.notice omr-bypass: Starting OMR-ByPass... Wed Mar 18 14:21:25 2020 daemon.info omr-tracker-ss: Shadowsocks is down (can't contact via http 1.1.1.1, 1.0.0.1, 212.27.48.10, 104.16.1.1, 103.224.182.242, 198.27.92.1) Wed Mar 18 14:21:30 2020 user.notice omr-bypass: Reload dnsmasq... Wed Mar 18 14:21:30 2020 daemon.info dnsmasq[18881]: read /etc/hosts - 4 addresses Wed Mar 18 14:21:30 2020 daemon.info dnsmasq[18881]: read /tmp/hosts/dhcp.cfg01411c - 2 addresses Wed Mar 18 14:21:30 2020 daemon.info dnsmasq-dhcp[18881]: read /etc/ethers - 0 addresses Wed Mar 18 14:21:30 2020 user.notice omr-bypass: OMR-ByPass is running Wed Mar 18 14:21:31 2020 user.notice Shadowsocks: Rules DOWN Wed Mar 18 14:21:32 2020 user.info : using tcp fast open Wed Mar 18 14:21:32 2020 user.info : using tcp fast open Wed Mar 18 14:21:32 2020 daemon.info /usr/bin/ss-redir[21458]: enable TCP no-delay Wed Mar 18 14:21:32 2020 user.info : using tcp fast open Wed Mar 18 14:21:32 2020 daemon.info /usr/bin/ss-redir[21458]: resolving hostname to IPv6 address first Wed Mar 18 14:21:32 2020 daemon.info /usr/bin/ss-redir[21458]: initializing ciphers... aes-256-gcm Wed Mar 18 14:21:32 2020 daemon.info /usr/bin/ss-redir[21458]: listening at 0.0.0.0:1100 Wed Mar 18 14:21:32 2020 daemon.info /usr/bin/ss-redir[21459]: enable TCP no-delay Wed Mar 18 14:21:32 2020 daemon.info /usr/bin/ss-redir[21457]: enable TCP no-delay Wed Mar 18 14:21:32 2020 daemon.info /usr/bin/ss-redir[21459]: resolving hostname to IPv6 address first Wed Mar 18 14:21:32 2020 daemon.info /usr/bin/ss-redir[21457]: resolving hostname to IPv6 address first Wed Mar 18 14:21:32 2020 daemon.info /usr/bin/ss-local[21456]: using tcp fast open Wed Mar 18 14:21:32 2020 daemon.info /usr/bin/ss-redir[21459]: initializing ciphers... aes-256-gcm Wed Mar 18 14:21:32 2020 daemon.info /usr/bin/ss-redir[21457]: initializing ciphers... aes-256-gcm Wed Mar 18 14:21:32 2020 daemon.info /usr/bin/ss-redir[21459]: listening at 0.0.0.0:1101 Wed Mar 18 14:21:32 2020 daemon.info /usr/bin/ss-redir[21457]: listening at 0.0.0.0:1100 Wed Mar 18 14:21:32 2020 daemon.info /usr/bin/ss-redir[21458]: tcp port reuse enabled Wed Mar 18 14:21:32 2020 daemon.info /usr/bin/ss-redir[21458]: UDP relay enabled Wed Mar 18 14:21:32 2020 daemon.info /usr/bin/ss-redir[21458]: udp port reuse enabled Wed Mar 18 14:21:32 2020 daemon.info /usr/bin/ss-local[21456]: enable TCP no-delay Wed Mar 18 14:21:32 2020 daemon.info /usr/bin/ss-redir[21459]: tcp port reuse enabled Wed Mar 18 14:21:32 2020 daemon.info /usr/bin/ss-redir[21457]: tcp port reuse enabled Wed Mar 18 14:21:32 2020 daemon.info /usr/bin/ss-local[21456]: initializing ciphers... aes-256-gcm Wed Mar 18 14:21:32 2020 daemon.info /usr/bin/ss-redir[21457]: UDP relay enabled Wed Mar 18 14:21:32 2020 daemon.info /usr/bin/ss-redir[21459]: UDP relay enabled Wed Mar 18 14:21:32 2020 daemon.info /usr/bin/ss-local[21456]: listening at 127.0.0.1:1111 Wed Mar 18 14:21:32 2020 daemon.info /usr/bin/ss-redir[21457]: udp port reuse enabled Wed Mar 18 14:21:32 2020 daemon.info /usr/bin/ss-redir[21459]: udp port reuse enabled Wed Mar 18 14:21:32 2020 daemon.info /usr/bin/ss-redir[21458]: running from root user Wed Mar 18 14:21:32 2020 daemon.info /usr/bin/ss-redir[21459]: running from root user Wed Mar 18 14:21:32 2020 daemon.info /usr/bin/ss-redir[21457]: running from root user Wed Mar 18 14:21:32 2020 daemon.info /usr/bin/ss-local[21456]: tcp port reuse enabled Wed Mar 18 14:21:32 2020 daemon.info /usr/bin/ss-local[21456]: udprelay enabled Wed Mar 18 14:21:32 2020 daemon.info /usr/bin/ss-local[21456]: udp port reuse enabled Wed Mar 18 14:21:32 2020 daemon.info /usr/bin/ss-local[21456]: running from root user Wed Mar 18 14:21:33 2020 user.notice OMR-VPS: Can't get token, try later (can't ping server, no server API answer) Wed Mar 18 14:21:38 2020 daemon.err /usr/bin/ss-local[21456]: getpeername: Socket not connected Wed Mar 18 14:21:38 2020 daemon.info omr-tracker-ss: Server (45.32.101.41) seems down, no answer to ping Wed Mar 18 14:21:41 2020 daemon.notice procd: /etc/rc.d/S99openmptcprouter-vps: % Total % Received % Xferd Average Speed Time Time Time Current Wed Mar 18 14:21:41 2020 daemon.notice procd: /etc/rc.d/S99openmptcprouter-vps: Dload Upload Total Spent Left Speed Wed Mar 18 14:21:42 2020 daemon.notice procd: /etc/rc.d/S99openmptcprouter-vps: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 Wed Mar 18 14:21:42 2020 daemon.notice procd: /etc/rc.d/S99openmptcprouter-vps: curl: (7) Failed to connect to 45.32.101.41 port 65500: Host is unreachable Wed Mar 18 14:21:42 2020 user.notice OMR-VPS: Can't get token, try later (can't ping server, no server API answer) Wed Mar 18 14:21:42 2020 user.notice Shadowsocks: Rules UP Wed Mar 18 14:21:43 2020 user.notice Shadowsocks: Reload omr-bypass rules Wed Mar 18 14:21:43 2020 user.notice omr-bypass: Starting OMR-ByPass... Wed Mar 18 14:21:45 2020 daemon.err /usr/bin/ss-local[21456]: getpeername: Socket not connected Wed Mar 18 14:21:45 2020 daemon.info omr-tracker-ss: Shadowsocks is down (can't contact via http 1.1.1.1, 1.0.0.1, 212.27.48.10, 104.16.1.1, 103.224.182.242, 198.27.92.1, 88.191.250.176) Wed Mar 18 14:21:48 2020 user.notice omr-bypass: Reload dnsmasq... Wed Mar 18 14:21:48 2020 daemon.err /usr/bin/ss-redir[21457]: remote recv: Host is unreachable Wed Mar 18 14:21:48 2020 daemon.err /usr/bin/ss-redir[21458]: remote recv: Host is unreachable Wed Mar 18 14:21:48 2020 daemon.err /usr/bin/ss-redir[21458]: remote recv: Host is unreachable Wed Mar 18 14:21:48 2020 daemon.err /usr/bin/ss-redir[21458]: remote recv: Host is unreachable Wed Mar 18 14:21:48 2020 user.notice OMR-VPS: Can't get token, try later (can't ping server, no server API answer) Wed Mar 18 14:21:49 2020 daemon.info dnsmasq[18881]: read /etc/hosts - 4 addresses Wed Mar 18 14:21:49 2020 daemon.info dnsmasq[18881]: read /tmp/hosts/dhcp.cfg01411c - 2 addresses Wed Mar 18 14:21:49 2020 daemon.info dnsmasq-dhcp[18881]: read /etc/ethers - 0 addresses Wed Mar 18 14:21:49 2020 user.notice omr-bypass: OMR-ByPass is running Wed Mar 18 14:21:49 2020 user.notice Shadowsocks: Rules DOWN Wed Mar 18 14:21:50 2020 daemon.info procd: - init complete - Wed Mar 18 14:21:50 2020 daemon.info vnstatd[23772]: No interfaces found in database, adding available interfaces... Wed Mar 18 14:21:50 2020 daemon.info vnstatd[23772]: Interface "ifb4tun0" added with 1000 Mbit bandwidth limit. Wed Mar 18 14:21:50 2020 daemon.info vnstatd[23772]: Interface "eth1" added with 1000 Mbit bandwidth limit. Wed Mar 18 14:21:50 2020 daemon.info vnstatd[23772]: Interface "eth4" added with 10000 Mbit bandwidth limit. Wed Mar 18 14:21:50 2020 daemon.info vnstatd[23772]: Interface "tun4" added with 10 Mbit bandwidth limit. Wed Mar 18 14:21:50 2020 daemon.info vnstatd[23772]: Interface "eth3" added with 1000 Mbit bandwidth limit. Wed Mar 18 14:21:50 2020 daemon.info vnstatd[23772]: Interface "eth0" added with 10000 Mbit bandwidth limit. Wed Mar 18 14:21:50 2020 daemon.info vnstatd[23772]: Interface "ifb1" added with 1000 Mbit bandwidth limit. Wed Mar 18 14:21:50 2020 daemon.info vnstatd[23772]: Interface "teql0" added with 1000 Mbit bandwidth limit. Wed Mar 18 14:21:50 2020 daemon.info vnstatd[23772]: Interface "tun0" added with 10 Mbit bandwidth limit. Wed Mar 18 14:21:50 2020 daemon.info vnstatd[23772]: Interface "eth2" added with 1000 Mbit bandwidth limit. Wed Mar 18 14:21:50 2020 daemon.info vnstatd[23772]: Interface "ifb0" added with 1000 Mbit bandwidth limit. Wed Mar 18 14:21:50 2020 daemon.info vnstatd[23772]: -> 11 new interfaces found. Wed Mar 18 14:21:50 2020 daemon.info vnstatd[23772]: Limits can be modified using the configuration file. See "man vnstat.conf". Wed Mar 18 14:21:50 2020 daemon.info vnstatd[23772]: Unwanted interfaces can be removed from monitoring with "vnstat --remove". Wed Mar 18 14:21:50 2020 daemon.info vnstatd[23772]: Info: vnStat daemon 2.4 started. (pid:23772 uid:0 gid:0 64-bit) Wed Mar 18 14:21:50 2020 daemon.info vnstatd[23772]: Info: Monitoring (11): tun4 (10 Mbit) tun0 (10 Mbit) teql0 (1000 Mbit) ifb4tun0 (1000 Mbit) ifb1 (1000 Mbit) ifb0 (1000 Mbit) eth4 (10000 Mbit) eth3 (1000 Mbit) eth2 (1000 Mbit) eth1 (1000 Mbit) eth0 (10000 Mbit) Wed Mar 18 14:21:51 2020 daemon.err /usr/bin/ss-redir[21458]: remote recv: Operation timed out Wed Mar 18 14:21:51 2020 daemon.err /usr/bin/ss-local[21456]: getpeername: Socket not connected Wed Mar 18 14:21:51 2020 daemon.err /usr/bin/ss-redir[21458]: remote recv: Host is unreachable Wed Mar 18 14:21:51 2020 daemon.err /usr/bin/ss-redir[21458]: remote recv: Host is unreachable Wed Mar 18 14:21:54 2020 daemon.info omr-tracker-ss: Server (45.32.101.41) seems down, no answer to ping Wed Mar 18 14:21:54 2020 user.notice OMR-VPS: Can't get token, try later (can't ping server, no server API answer) Wed Mar 18 14:22:01 2020 daemon.err /usr/bin/ss-local[21456]: getpeername: Socket not connected Wed Mar 18 14:22:01 2020 user.notice OMR-VPS: Can't get token, try later (can't ping server, no server API answer) Wed Mar 18 14:22:07 2020 daemon.err /usr/bin/ss-local[21456]: getpeername: Socket not connected Wed Mar 18 14:22:07 2020 user.notice OMR-VPS: Can't get token, try later (can't ping server, no server API answer) Wed Mar 18 14:22:14 2020 daemon.err /usr/bin/ss-local[21456]: getpeername: Socket not connected Wed Mar 18 14:22:16 2020 user.notice post-tracking-post-tracking: eth1 switched off because gateway down and ping from 192.168.80.24 error (8.8.8.8,8.8.4.4) Wed Mar 18 14:22:17 2020 user.notice OMR-VPS: Can't get token, try later (can't ping server, no server API answer) Wed Mar 18 14:22:18 2020 user.notice post-tracking-post-tracking: Change master interface from wan1 (1000 ms) to ovpnwan2 (75 ms) Wed Mar 18 14:22:18 2020 user.notice post-tracking-post-tracking: Delete default route via 192.168.80.1 dev eth1 Wed Mar 18 14:22:19 2020 daemon.info omr-tracker-ss: Shadowsocks is up (can contact via http 1.1.1.1) Wed Mar 18 14:22:21 2020 daemon.info omr-tracker-ss: Reload Shadowsocks rules Wed Mar 18 14:22:21 2020 user.notice Shadowsocks: Rules UP Wed Mar 18 14:22:22 2020 user.notice Shadowsocks: Reload omr-bypass rules Wed Mar 18 14:22:22 2020 user.notice omr-bypass: Starting OMR-ByPass... Wed Mar 18 14:22:27 2020 user.notice omr-bypass: Reload dnsmasq... Wed Mar 18 14:22:27 2020 daemon.info dnsmasq[18881]: read /etc/hosts - 4 addresses Wed Mar 18 14:22:27 2020 daemon.info dnsmasq[18881]: read /tmp/hosts/dhcp.cfg01411c - 2 addresses Wed Mar 18 14:22:27 2020 daemon.info dnsmasq-dhcp[18881]: read /etc/ethers - 0 addresses Wed Mar 18 14:22:27 2020 user.notice omr-bypass: OMR-ByPass is running Wed Mar 18 14:22:45 2020 user.notice post-tracking-post-tracking: Set server vps (45.32.101.41) default route via 10.255.250.5 Wed Mar 18 14:23:15 2020 user.notice post-tracking-post-tracking: tun4 switched off because gateway down and ping from 10.255.250.6 error (114.114.115.115,4.2.2.1) Wed Mar 18 14:23:15 2020 user.notice post-tracking-post-tracking: Delete default route via 10.255.250.5 dev tun4 Wed Mar 18 14:23:29 2020 user.notice post-tracking-post-tracking: Set server vps (45.32.101.41) default route via 10.255.250.5 Wed Mar 18 14:23:30 2020 user.notice post-tracking-post-tracking: Set server vps (45.32.101.41) route via 10.255.250.5 metric 9 Wed Mar 18 14:23:30 2020 user.notice post-tracking-post-tracking: Get status and settings for ovpnwan2... Wed Mar 18 14:23:31 2020 user.notice post-tracking-post-tracking: Get status and settings for ovpnwan2... Done Wed Mar 18 14:24:01 2020 user.notice OMR-VPS: Can't get token, try later (can't ping server, server API answer) Wed Mar 18 14:24:10 2020 daemon.err /usr/bin/ss-redir[21457]: remote recv: Operation timed out Wed Mar 18 14:24:20 2020 daemon.err /usr/bin/ss-redir[21457]: remote recv: Operation timed out Wed Mar 18 14:24:28 2020 daemon.err /usr/bin/ss-redir[21458]: remote recv: Operation timed out Wed Mar 18 14:24:42 2020 daemon.err /usr/bin/ss-redir[21457]: remote recv: Operation timed out Wed Mar 18 14:25:05 2020 daemon.err /usr/bin/ss-redir[21457]: remote recv: Operation timed out Wed Mar 18 14:25:14 2020 user.notice post-tracking-post-tracking: tun4 switched off because ping from 10.255.250.6 error (1.0.0.1,80.67.169.12) Wed Mar 18 14:25:14 2020 user.notice post-tracking-post-tracking: Delete default route via 10.255.250.5 dev tun4 Wed Mar 18 14:25:39 2020 daemon.err /usr/bin/ss-redir[21457]: send: Connection reset by peer Wed Mar 18 14:25:40 2020 user.notice post-tracking-post-tracking: Set server vps (45.32.101.41) default route via 10.255.250.5 Wed Mar 18 14:25:40 2020 user.notice post-tracking-post-tracking: Set server vps (45.32.101.41) route via 10.255.250.5 metric 9 Wed Mar 18 14:25:41 2020 user.notice post-tracking-post-tracking: Get status and settings for ovpnwan2... Wed Mar 18 14:25:42 2020 user.notice post-tracking-post-tracking: Get status and settings for ovpnwan2... Done Wed Mar 18 14:26:12 2020 daemon.err /usr/bin/ss-redir[21457]: remote recv: Operation timed out Wed Mar 18 14:26:55 2020 daemon.err /usr/bin/ss-local[21456]: getpeername: Socket not connected Wed Mar 18 14:27:22 2020 daemon.err /usr/bin/ss-redir[21457]: getpeername: Socket not connected Wed Mar 18 14:27:33 2020 user.notice post-tracking-post-tracking: tun4 switched off because ping from 10.255.250.6 error (9.9.9.9,1.1.1.1) Wed Mar 18 14:27:33 2020 user.notice post-tracking-post-tracking: Delete default route via 10.255.250.5 dev tun4 Wed Mar 18 14:27:48 2020 user.notice post-tracking-post-tracking: Set server vps (45.32.101.41) default route via 10.255.250.5 Wed Mar 18 14:27:49 2020 user.notice post-tracking-post-tracking: Set server vps (45.32.101.41) route via 10.255.250.5 metric 9 Wed Mar 18 14:27:49 2020 user.notice post-tracking-post-tracking: Get status and settings for ovpnwan2... Wed Mar 18 14:27:50 2020 user.notice post-tracking-post-tracking: Get status and settings for ovpnwan2... Done Wed Mar 18 14:27:54 2020 daemon.err /usr/bin/ss-redir[21458]: remote recv: Operation timed out Wed Mar 18 14:27:54 2020 daemon.err /usr/bin/ss-redir[21458]: remote recv: Operation timed out Wed Mar 18 14:28:51 2020 user.notice post-tracking-post-tracking: tun4 switched off because gateway down and ping from 10.255.250.6 error (8.8.8.8,8.8.4.4) Wed Mar 18 14:28:51 2020 user.notice post-tracking-post-tracking: Delete default route via 10.255.250.5 dev tun4 Wed Mar 18 14:29:00 2020 user.notice post-tracking-post-tracking: Set server vps (45.32.101.41) default route via 10.255.250.5 Wed Mar 18 14:29:00 2020 user.notice post-tracking-post-tracking: Set server vps (45.32.101.41) route via 10.255.250.5 metric 9 Wed Mar 18 14:29:00 2020 user.notice post-tracking-post-tracking: Get status and settings for ovpnwan2... Wed Mar 18 14:29:01 2020 user.notice post-tracking-post-tracking: Get status and settings for ovpnwan2... Done Wed Mar 18 14:29:10 2020 daemon.err /usr/bin/ss-redir[21457]: remote recv: Operation timed out Wed Mar 18 14:29:17 2020 daemon.err /usr/bin/ss-redir[21458]: remote recv: Operation timed out Wed Mar 18 14:30:49 2020 user.notice post-tracking-post-tracking: tun4 switched off because gateway down and ping from 10.255.250.6 error (80.67.169.12,80.67.169.40) Wed Mar 18 14:30:50 2020 user.notice post-tracking-post-tracking: Delete default route via 10.255.250.5 dev tun4 Wed Mar 18 14:31:05 2020 user.notice post-tracking-post-tracking: Set server vps (45.32.101.41) default route via 10.255.250.5 Wed Mar 18 14:31:05 2020 user.notice post-tracking-post-tracking: Set server vps (45.32.101.41) route via 10.255.250.5 metric 9 Wed Mar 18 14:31:05 2020 user.notice post-tracking-post-tracking: Get status and settings for ovpnwan2... Wed Mar 18 14:31:06 2020 user.notice post-tracking-post-tracking: Get status and settings for ovpnwan2... Done Wed Mar 18 14:32:16 2020 user.notice post-tracking-post-tracking: tun4 switched off because gateway down and ping from 10.255.250.6 error (1.0.0.1,80.67.169.12) Wed Mar 18 14:32:16 2020 user.notice post-tracking-post-tracking: Delete default route via 10.255.250.5 dev tun4 Wed Mar 18 14:32:37 2020 daemon.err /usr/bin/ss-redir[21458]: remote recv: Connection reset by peer Wed Mar 18 14:32:37 2020 user.notice post-tracking-post-tracking: Set server vps (45.32.101.41) default route via 10.255.250.5 Wed Mar 18 14:32:38 2020 user.notice post-tracking-post-tracking: Set server vps (45.32.101.41) route via 10.255.250.5 metric 9 Wed Mar 18 14:32:38 2020 user.notice post-tracking-post-tracking: Get status and settings for ovpnwan2... Wed Mar 18 14:32:39 2020 user.notice post-tracking-post-tracking: Get status and settings for ovpnwan2... Done Wed Mar 18 14:33:56 2020 user.notice post-tracking-post-tracking: tun4 switched off because gateway down and ping from 10.255.250.6 error (80.67.169.12,80.67.169.40) Wed Mar 18 14:33:57 2020 user.notice post-tracking-post-tracking: Delete default route via 10.255.250.5 dev tun4 Wed Mar 18 14:34:19 2020 user.notice post-tracking-post-tracking: Set server vps (45.32.101.41) default route via 10.255.250.5 Wed Mar 18 14:34:19 2020 user.notice post-tracking-post-tracking: Set server vps (45.32.101.41) route via 10.255.250.5 metric 9 Wed Mar 18 14:34:19 2020 user.notice post-tracking-post-tracking: Get status and settings for ovpnwan2... Wed Mar 18 14:34:20 2020 user.notice post-tracking-post-tracking: Get status and settings for ovpnwan2... Done Wed Mar 18 14:35:00 2020 daemon.err /usr/bin/ss-redir[21457]: remote recv: Operation timed out Wed Mar 18 14:35:02 2020 daemon.err /usr/bin/ss-redir[21457]: remote recv: Operation timed out Wed Mar 18 14:35:04 2020 daemon.err /usr/bin/ss-redir[21458]: remote recv: Operation timed out Wed Mar 18 14:35:05 2020 daemon.err /usr/bin/ss-local[21456]: getpeername: Socket not connected Wed Mar 18 14:35:06 2020 daemon.err /usr/bin/ss-redir[21458]: remote recv: Operation timed out Wed Mar 18 14:35:06 2020 daemon.err /usr/bin/ss-redir[21457]: remote recv: Operation timed out Wed Mar 18 14:35:07 2020 daemon.err /usr/bin/ss-redir[21457]: remote recv: Operation timed out Wed Mar 18 14:35:08 2020 daemon.err /usr/bin/ss-redir[21457]: remote recv: Operation timed out Wed Mar 18 14:35:09 2020 daemon.err /usr/bin/ss-redir[21458]: remote recv: Operation timed out Wed Mar 18 14:35:09 2020 daemon.err /usr/bin/ss-redir[21458]: remote recv: Operation timed out Wed Mar 18 14:35:12 2020 user.notice post-tracking-post-tracking: tun4 switched off because gateway down and ping from 10.255.250.6 error (9.9.9.9,1.1.1.1) Wed Mar 18 14:35:12 2020 user.notice post-tracking-post-tracking: Delete default route via 10.255.250.5 dev tun4 Wed Mar 18 14:35:12 2020 daemon.err /usr/bin/ss-redir[21457]: remote recv: Operation timed out Wed Mar 18 14:35:13 2020 daemon.err /usr/bin/ss-redir[21457]: remote recv: Operation timed out Wed Mar 18 14:35:13 2020 daemon.err /usr/bin/ss-local[21456]: getpeername: Socket not connected Wed Mar 18 14:35:13 2020 daemon.err /usr/bin/ss-redir[21458]: remote recv: Operation timed out Wed Mar 18 14:35:14 2020 user.notice post-tracking-post-tracking: omrvpn down. Replace default route by 192.168.8.1 dev eth3 Wed Mar 18 14:35:14 2020 daemon.err /usr/bin/ss-redir[21457]: remote recv: Operation timed out Wed Mar 18 14:35:14 2020 user.notice post-tracking-post-tracking: omrvpn down because gateway down Wed Mar 18 14:35:14 2020 user.notice post-tracking-post-tracking: Tunnel down use ShadowSocks for UDP Wed Mar 18 14:35:14 2020 user.notice Shadowsocks: Rules DOWN Wed Mar 18 14:35:14 2020 daemon.err /usr/bin/ss-redir[21458]: remote recv: Operation timed out Wed Mar 18 14:35:15 2020 user.notice Shadowsocks: Rules UP Wed Mar 18 14:35:16 2020 daemon.err omr-tracker[14535]: RTNETLINK answers: Permission denied Wed Mar 18 14:35:16 2020 user.notice Shadowsocks: Reload omr-bypass rules Wed Mar 18 14:35:16 2020 user.notice omr-bypass: Starting OMR-ByPass... Wed Mar 18 14:35:19 2020 user.notice omr-bypass: Reload dnsmasq... Wed Mar 18 14:35:20 2020 daemon.info dnsmasq[18881]: read /etc/hosts - 4 addresses Wed Mar 18 14:35:20 2020 daemon.info dnsmasq[18881]: read /tmp/hosts/dhcp.cfg01411c - 2 addresses Wed Mar 18 14:35:20 2020 daemon.info dnsmasq-dhcp[18881]: read /etc/ethers - 0 addresses Wed Mar 18 14:35:20 2020 user.notice omr-bypass: OMR-ByPass is running Wed Mar 18 14:35:40 2020 user.notice post-tracking-post-tracking: Master up : Replace default route by 10.255.250.5 dev tun4 Wed Mar 18 14:35:40 2020 user.notice post-tracking-post-tracking: Set server vps (45.32.101.41) route via 10.255.250.5 metric 9 Wed Mar 18 14:35:40 2020 user.notice post-tracking-post-tracking: Get status and settings for ovpnwan2... Wed Mar 18 14:35:41 2020 user.notice post-tracking-post-tracking: Get status and settings for ovpnwan2... Done Wed Mar 18 14:36:08 2020 user.notice post-tracking-post-tracking: Tunnel up : Replace default route by 10.255.255.1 dev tun0 Wed Mar 18 14:36:13 2020 user.notice post-tracking-post-tracking: Set server vps (45.32.101.41) default route via 10.255.250.5 Wed Mar 18 14:36:30 2020 user.notice post-tracking-post-tracking: Tunnel up disable use of ShadowSocks for UDP Wed Mar 18 14:36:30 2020 user.notice Shadowsocks: Rules DOWN Wed Mar 18 14:36:30 2020 daemon.info omr-tracker-ss: Reload Shadowsocks rules Wed Mar 18 14:36:31 2020 user.notice Shadowsocks: Rules UP Wed Mar 18 14:36:31 2020 user.notice Shadowsocks: Reload omr-bypass rules Wed Mar 18 14:36:31 2020 user.notice omr-bypass: Starting OMR-ByPass... Wed Mar 18 14:36:34 2020 user.notice post-tracking-post-tracking: tun4 switched off because gateway down and ping from 10.255.250.6 error (9.9.9.9,1.1.1.1) Wed Mar 18 14:36:34 2020 user.notice post-tracking-post-tracking: Delete default route via 10.255.250.5 dev tun4 Wed Mar 18 14:36:36 2020 user.notice omr-bypass: Reload dnsmasq... Wed Mar 18 14:36:36 2020 daemon.info dnsmasq[18881]: read /etc/hosts - 4 addresses Wed Mar 18 14:36:36 2020 daemon.info dnsmasq[18881]: read /tmp/hosts/dhcp.cfg01411c - 2 addresses Wed Mar 18 14:36:36 2020 daemon.info dnsmasq-dhcp[18881]: read /etc/ethers - 0 addresses Wed Mar 18 14:36:36 2020 user.notice omr-bypass: OMR-ByPass is running Wed Mar 18 14:36:48 2020 user.notice post-tracking-post-tracking: Set server vps (45.32.101.41) default route via 10.255.250.5 Wed Mar 18 14:36:49 2020 user.notice post-tracking-post-tracking: Set server vps (45.32.101.41) route via 10.255.250.5 metric 9 Wed Mar 18 14:36:49 2020 user.notice post-tracking-post-tracking: Get status and settings for ovpnwan2... Wed Mar 18 14:36:50 2020 user.notice post-tracking-post-tracking: Get status and settings for ovpnwan2... Done Wed Mar 18 14:38:52 2020 daemon.err /usr/bin/ss-local[21456]: getpeername: Socket not connected Wed Mar 18 14:38:55 2020 user.notice post-tracking-post-tracking: tun4 switched off because ping from 10.255.250.6 error (8.8.8.8,8.8.4.4) Wed Mar 18 14:38:55 2020 user.notice post-tracking-post-tracking: Delete default route via 10.255.250.5 dev tun4 Wed Mar 18 14:39:10 2020 user.notice post-tracking-post-tracking: Set server vps (45.32.101.41) default route via 10.255.250.5 Wed Mar 18 14:39:10 2020 user.notice post-tracking-post-tracking: Set server vps (45.32.101.41) route via 10.255.250.5 metric 9 Wed Mar 18 14:39:10 2020 user.notice post-tracking-post-tracking: Get status and settings for ovpnwan2... Wed Mar 18 14:39:11 2020 user.notice post-tracking-post-tracking: Get status and settings for ovpnwan2... Done Wed Mar 18 14:39:42 2020 daemon.err /usr/bin/ss-local[21456]: getpeername: Socket not connected Wed Mar 18 14:39:52 2020 user.notice post-tracking-post-tracking: tun4 switched off because ping from 10.255.250.6 error (80.67.169.12,80.67.169.40) Wed Mar 18 14:39:52 2020 user.notice post-tracking-post-tracking: Delete default route via 10.255.250.5 dev tun4 Wed Mar 18 14:40:01 2020 user.notice post-tracking-post-tracking: Set server vps (45.32.101.41) default route via 10.255.250.5 Wed Mar 18 14:40:01 2020 user.notice post-tracking-post-tracking: Set server vps (45.32.101.41) route via 10.255.250.5 metric 9 Wed Mar 18 14:40:01 2020 user.notice post-tracking-post-tracking: Get status and settings for ovpnwan2... Wed Mar 18 14:40:02 2020 user.notice post-tracking-post-tracking: Get status and settings for ovpnwan2... Done Wed Mar 18 14:41:11 2020 user.notice post-tracking-post-tracking: tun4 switched off because gateway down and ping from 10.255.250.6 error (1.0.0.1,80.67.169.12) Wed Mar 18 14:41:11 2020 user.notice post-tracking-post-tracking: Delete default route via 10.255.250.5 dev tun4 Wed Mar 18 14:41:27 2020 user.notice post-tracking-post-tracking: Set server vps (45.32.101.41) default route via 10.255.250.5 Wed Mar 18 14:41:27 2020 user.notice post-tracking-post-tracking: Set server vps (45.32.101.41) route via 10.255.250.5 metric 9 Wed Mar 18 14:41:27 2020 user.notice post-tracking-post-tracking: Get status and settings for ovpnwan2... Wed Mar 18 14:41:28 2020 user.notice post-tracking-post-tracking: Get status and settings for ovpnwan2... Done Wed Mar 18 14:41:40 2020 user.notice OMR-VPS: Can't get token, try later Wed Mar 18 14:41:44 2020 daemon.err /usr/bin/ss-local[21456]: getpeername: Socket not connected Wed Mar 18 14:42:37 2020 user.notice OMR-VPS: Can't get token, try later Wed Mar 18 14:42:37 2020 daemon.err /usr/bin/ss-local[21456]: getpeername: Socket not connected Wed Mar 18 14:43:49 2020 user.notice post-tracking-post-tracking: tun4 switched off because gateway down and ping from 10.255.250.6 error (8.8.8.8,8.8.4.4) Wed Mar 18 14:43:49 2020 user.notice post-tracking-post-tracking: Delete default route via 10.255.250.5 dev tun4 Wed Mar 18 14:43:55 2020 user.notice post-tracking-post-tracking: Set server vps (45.32.101.41) default route via 10.255.250.5 Wed Mar 18 14:43:55 2020 user.notice post-tracking-post-tracking: Set server vps (45.32.101.41) route via 10.255.250.5 metric 9 Wed Mar 18 14:43:55 2020 user.notice post-tracking-post-tracking: Get status and settings for ovpnwan2... Wed Mar 18 14:43:56 2020 user.notice post-tracking-post-tracking: Get status and settings for ovpnwan2... Done Wed Mar 18 14:44:57 2020 user.notice post-tracking-post-tracking: tun4 switched off because ping from 10.255.250.6 error (114.114.114.114,114.114.115.115) Wed Mar 18 14:44:57 2020 user.notice post-tracking-post-tracking: Delete default route via 10.255.250.5 dev tun4 Wed Mar 18 14:45:07 2020 user.notice post-tracking-post-tracking: Set server vps (45.32.101.41) default route via 10.255.250.5 Wed Mar 18 14:45:08 2020 user.notice post-tracking-post-tracking: Set server vps (45.32.101.41) route via 10.255.250.5 metric 9 Wed Mar 18 14:45:08 2020 user.notice post-tracking-post-tracking: Get status and settings for ovpnwan2... Wed Mar 18 14:45:09 2020 user.notice post-tracking-post-tracking: Get status and settings for ovpnwan2... Done Wed Mar 18 14:46:13 2020 user.notice post-tracking-post-tracking: tun4 switched off because gateway down and ping from 10.255.250.6 error (80.67.169.12,80.67.169.40) Wed Mar 18 14:46:13 2020 user.notice post-tracking-post-tracking: Delete default route via 10.255.250.5 dev tun4 Wed Mar 18 14:46:30 2020 user.notice post-tracking-post-tracking: Set server vps (45.32.101.41) default route via 10.255.250.5 Wed Mar 18 14:46:30 2020 user.notice post-tracking-post-tracking: Set server vps (45.32.101.41) route via 10.255.250.5 metric 9 Wed Mar 18 14:46:30 2020 user.notice post-tracking-post-tracking: Get status and settings for ovpnwan2... Wed Mar 18 14:46:31 2020 user.notice post-tracking-post-tracking: Get status and settings for ovpnwan2... Done Wed Mar 18 14:47:37 2020 daemon.err /usr/bin/ss-local[21456]: getpeername: Socket not connected Wed Mar 18 14:47:50 2020 user.notice post-tracking-post-tracking: tun4 switched off because ping from 10.255.250.6 error (80.67.169.12,80.67.169.40) Wed Mar 18 14:47:50 2020 user.notice post-tracking-post-tracking: Delete default route via 10.255.250.5 dev tun4 Wed Mar 18 14:48:08 2020 user.notice post-tracking-post-tracking: Set server vps (45.32.101.41) default route via 10.255.250.5 Wed Mar 18 14:48:08 2020 user.notice post-tracking-post-tracking: Set server vps (45.32.101.41) route via 10.255.250.5 metric 9 Wed Mar 18 14:48:08 2020 user.notice post-tracking-post-tracking: Get status and settings for ovpnwan2... Wed Mar 18 14:48:09 2020 user.notice post-tracking-post-tracking: Get status and settings for ovpnwan2... Done Wed Mar 18 14:54:46 2020 daemon.err uhttpd[6519]: luci: accepted login on /admin/system/openmptcprouter/status for root from 192.168.100.205

Ysurac commented 4 years ago

You are using MPTCP over VPN ? why ?

ccmks commented 4 years ago

My WAN 2 connection doesn't support MPTCP so have to enable over VPN

Ysurac commented 4 years ago

Without this interface, it's working ?

ccmks commented 4 years ago

Same issue too. The random WAN will show gateway down.

I believe this was not a new issue. It happened when I was back then v0.52 version on Sept 2019. However, didn't have a chance to bring it up here until today when I was experimenting with it again.

Ysurac commented 4 years ago

On the log I only tun4 interface, that is the MPTCP over VPN interface as down. Maybe some problems with the DHCP ? Each wan have own real interface and each real interface have a router directly connected ?

ccmks commented 4 years ago

I have been running it for 35 minutes when I generated the log for you. Again, the random WAN disconnection happens.

I don't think it is DHCP issue, because I have setup static IP for the WAN whose GW is down and still can't ping to its gateway.

Answer to last question: It is Hyper-V so all interface is from Hyper-V virtual interface. But each interface is connected to different vSwitch, and each vSwitch is connected to each physical NIC in the Intel PRO 1000 PT Quad NIC. Each NIC in Physical port is connected to each different modem

Ysurac commented 4 years ago

Can you give me, when there is a disconnection, the result of ip a and ip r via SSH on the router ?

ccmks commented 4 years ago

I could no longer be able to duplicate the issue.

Apparently, when I read the system log, I realized that I gave too low memory which was only 384 MB, after increase the memory to 512 MB, the issue is no longer there. I will go ahead and close this issue.

Thank you for your help!

ccmks commented 4 years ago

Well it happened again!

Here is the output for ip a 1: lo: <LOOPBACK,UP,LOWER_UP,80000> mtu 65536 qdisc noqueue state UNKNOWN group default qlen 1000 link/loopback 00:00:00:00:00:00 brd 00:00:00:00:00:00 inet 127.0.0.1/8 scope host lo valid_lft forever preferred_lft forever 2: eth0: <BROADCAST,MULTICAST,UP,LOWER_UP,80000> mtu 1500 qdisc mq state UP grou p default qlen 1000 link/ether 00:15:5d:05:f7:4a brd ff:ff:ff:ff:ff:ff inet 192.168.100.1/24 brd 192.168.100.255 scope global eth0 valid_lft forever preferred_lft forever 3: eth1: <BROADCAST,MULTICAST,UP,LOWER_UP> mtu 1244 qdisc mq state UP group defa ult qlen 100 link/ether 00:15:5d:05:f7:4b brd ff:ff:ff:ff:ff:ff inet 192.168.80.24/24 brd 192.168.80.255 scope global eth1 valid_lft forever preferred_lft forever 4: eth2: <BROADCAST,MULTICAST,UP,LOWER_UP,80000> mtu 1500 qdisc mq state UP grou p default qlen 50 link/ether 00:15:5d:05:f7:4c brd ff:ff:ff:ff:ff:ff inet 192.168.40.102/24 brd 192.168.40.255 scope global eth2 valid_lft forever preferred_lft forever 5: eth3: <BROADCAST,MULTICAST,UP,LOWER_UP> mtu 1500 qdisc mq state UP group defa ult qlen 100 link/ether 00:15:5d:05:f7:4d brd ff:ff:ff:ff:ff:ff inet 192.168.8.102/24 brd 192.168.8.255 scope global eth3 valid_lft forever preferred_lft forever 6: eth4: <BROADCAST,MULTICAST,UP,LOWER_UP> mtu 1500 qdisc mq state UP group defa ult qlen 1000 link/ether 00:15:5d:05:f7:4e brd ff:ff:ff:ff:ff:ff 7: sit0@NONE: <NOARP,80000> mtu 1480 qdisc noop state DOWN group default qlen 10 00 link/sit 0.0.0.0 brd 0.0.0.0 8: ifb0: <BROADCAST,NOARP,80000> mtu 1500 qdisc noop state DOWN group default ql en 32 link/ether 5e:7b:bf:be:e9:12 brd ff:ff:ff:ff:ff:ff 9: ifb1: <BROADCAST,NOARP,80000> mtu 1500 qdisc noop state DOWN group default ql en 32 link/ether 0e:d0:d2:1a:d1:86 brd ff:ff:ff:ff:ff:ff 10: teql0: <NOARP,80000> mtu 1500 qdisc noop state DOWN group default qlen 100 link/void 16: tun0: <POINTOPOINT,MULTICAST,NOARP,UP,LOWER_UP,80000> mtu 1500 qdisc fq_code l state UNKNOWN group default qlen 1000 link/none inet 10.255.255.2 peer 10.255.255.1/32 scope global tun0 valid_lft forever preferred_lft forever 19: ifb4tun0: <BROADCAST,NOARP,80000> mtu 1500 qdisc noop state DOWN group defau lt qlen 32 link/ether ce:8e:6e:64:61:68 brd ff:ff:ff:ff:ff:ff

Here is the output for ip r default via 10.255.255.1 dev tun0 default via 192.168.40.1 dev eth2 metric 4 default via 192.168.8.1 dev eth3 metric 5 10.255.255.1 dev tun0 proto kernel scope link src 10.255.255.2 45.32.101.41 via 192.168.8.1 dev eth3 metric 5 127.0.0.0/8 dev lo proto static scope link metric 1 192.168.8.0/24 dev eth3 scope link metric 5 192.168.40.0/24 dev eth2 scope link metric 4 192.168.80.0/24 dev eth1 scope link metric 3

Ysurac commented 4 years ago

512 is still low... eth4 have no IP, normal ? Else there is no error and gateway should be pingable.

ccmks commented 4 years ago

We don't have anything on eth4. Only 3 WAN plugged in

The WAN 1 IP GW is not pingable although I already set to DHCP.

If 512 RAM is still low, what would be the minimum?

Ysurac commented 4 years ago

1024 is better

ccmks commented 4 years ago

Already tried 1024 MB, still experiencing random WAN disconnection. I tried plug in 4 WAN, and sometimes, there are 2 WAN experience random disconnection. It happened on random WAN

Ysurac commented 4 years ago

What is the latency of each interfaces ? (in OpenMPTCProuter status page)

ccmks commented 4 years ago

image

Ysurac commented 4 years ago

While it's not working, remove MPTCP over VPN, this doesn't help to find the issue.

ccmks commented 4 years ago

I am still currently testing on various parameter. My configuration works on Banana Pi R2, however, I decided to use Hyper-V since my router is also hosted there, no need additional hardware plug in. On the top of that, the Banana Pi R2 only works with v0.53, doesn't work higher version.

I have been putting this Hyper-V on different condition, such as adjusting the core and the memory. Right now, the most stable is using 32 bit version of image and using Hyper-V with virtual memory range between 512 - 768 MB, more than that, it could trigger the Gateway Down and not stable too.

However, I still want to see if this could last for several days without having random disconnection on WAN.

Before I was only using single core on virtual processor, however, the throughput was limited, so I ended up using all core of my processor to reach the maximum speed.

ccmks commented 4 years ago

I gave up on doing this, ended up migrating my router to different hardware, however, this new hardware, I only have Hyper-V core 2019. The OpenMPTCPRouter is working fine on the new hardware under Hyper-V hosting. I guess, I have to find what's wrong with the old hardware.