Dec 17 18:27:06 [ DBG] start_firewall[987]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:06 [ DBG] init_firewall[987]: Start Firewall6
Dec 17 18:27:06 [WARN] kernel: FFFFFFFF:FFFFFFFF:FFFFFFFF:FFFFFFFF:FFFFFFFF:FFFFFFFF
Dec 17 18:27:06 [WARN] kernel: Raeth v3.1 (NAPI
Dec 17 18:27:06 [WARN] kernel: ,SkbRecycle)
Dec 17 18:27:06 [WARN] kernel: set CLK_CFG_0 = 0x40a00020!!!!!!!!!!!!!!!!!!1
Dec 17 18:27:06 [WARN] kernel: phy_tx_ring = 0x00c08000, tx_ring = 0xa0c08000
Dec 17 18:27:06 [WARN] kernel: phy_rx_ring0 = 0x00c0c000, rx_ring[0] = 0xa0c0c000
Dec 17 18:27:06 [WARN] kernel: phy_rx_ring0 = 0x00c0c000, rx_ring[0] = 0xa0c0c000
Dec 17 18:27:06 [WARN] kernel: MT7530 Reset Completed!!
Dec 17 18:27:06 [WARN] kernel: change HW-TRAP to 0x17c8f
Dec 17 18:27:06 [WARN] kernel: set LAN/WAN LLLLW
Dec 17 18:27:06 [WARN] kernel: GMAC1_MAC_ADRH -- : 0x0000bc0f
Dec 17 18:27:06 [WARN] kernel: GMAC1_MAC_ADRL -- : 0x9a5e296d
Dec 17 18:27:06 [WARN] kernel: GDMA2_MAC_ADRH -- : 0x0000bc0f
Dec 17 18:27:06 [WARN] kernel: GDMA2_MAC_ADRL -- : 0x9a5e296c
Dec 17 18:27:06 [WARN] kernel: eth3: ===> VirtualIF_open
Dec 17 18:27:06 [WARN] kernel: MT7621 GE2 link rate to 1G
Dec 17 18:27:07 [WARN] kernel: CDMA_CSG_CFG = 81000000
Dec 17 18:27:07 [WARN] kernel: GDMA1_FWD_CFG = 20710000
Dec 17 18:27:07 [WARN] kernel: GDMA2_FWD_CFG = 20710000
Dec 17 18:27:07 [WARN] kernel: eth3: ===> VirtualIF_open
Dec 17 18:27:07 [INFO] kernel: IPv6: ADDRCONF(NETDEV_UP): eth3: link is not ready
Dec 17 18:27:07 [ DBG] handler_vlan_update[1027]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:07 [ DBG] handler_vlan_update[1027]: determine_action: Start update requested.
Dec 17 18:27:07 [ DBG] handler_vlan_update[1027]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:07 [ DBG] VLAN handler[1027]: Started
Dec 17 18:27:07 [ DBG] VLAN handler[1027]: Action set
Dec 17 18:27:07 [ DBG] VLAN handler[1027]: VID autoselect
Dec 17 18:27:07 [ DBG] VLAN handler[1027]: Action is start. Starting
Dec 17 18:27:07 [ DBG] set_vlan_group[1028]: Start
Dec 17 18:27:07 [ DBG] handler_vlan_update[1032]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:07 [ DBG] handler_vlan_update[1032]: determine_action: Start update requested.
Dec 17 18:27:07 [ DBG] handler_vlan_update[1032]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:07 [ DBG] VLAN handler[1032]: Started
Dec 17 18:27:07 [ DBG] VLAN handler[1032]: Action set
Dec 17 18:27:07 [ DBG] VLAN handler[1032]: VID autoselect
Dec 17 18:27:07 [ DBG] VLAN handler[1032]: Action is start. Starting
Dec 17 18:27:07 [ DBG] set_vlan_group[1033]: Start
Dec 17 18:27:07 [INFO] kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth3: link becomes ready
Dec 17 18:27:07 [ DBG] handler_set_fwrule[1032]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:07 [ DBG] handler_set_fwrule[1032]: determine_action: Stop update requested.
Dec 17 18:27:07 [ DBG] handler_set_fwrule[1032]: determine_action: Status switch Enabled -> Disabling, set Action = STOP.
Dec 17 18:27:07 [ DBG] unload_firewall_rule[1032]: Deleting |-t filter -D z3to2 -p udp -j DROP -m udp --dport 1701|
Dec 17 18:27:07 [ DBG] unload_firewall_rule[1032]: Rule #0 UNLOADED
Dec 17 18:27:07 [ DBG] handler_set_fwrule[1032]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:07 [ DBG] handler_set_fwrule[1032]: determine_action: Stop update requested.
Dec 17 18:27:07 [ DBG] handler_set_fwrule[1032]: determine_action: Status switch Enabled -> Disabling, set Action = STOP.
Dec 17 18:27:07 [ DBG] unload_firewall_rule[1032]: Deleting |-t filter -D z3to2 -p tcp -j DROP -m tcp --dport 1723|
Dec 17 18:27:07 [ DBG] unload_firewall_rule[1032]: Rule #1 UNLOADED
Dec 17 18:27:07 [ DBG] handler_set_fwrule[1032]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:07 [ DBG] handler_set_fwrule[1032]: determine_action: Stop update requested.
Dec 17 18:27:07 [ DBG] handler_set_fwrule[1032]: determine_action: Status switch Enabled -> Disabling, set Action = STOP.
Dec 17 18:27:07 [ DBG] unload_firewall_rule[1032]: Deleting |-t filter -D z3to2 -p udp -j DROP -m udp -m multiport --dports 500,4500|
Dec 17 18:27:07 [ DBG] unload_firewall_rule[1032]: Rule #2 UNLOADED
Dec 17 18:27:07 [ DBG] handler_set_fwrule[1032]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:07 [ DBG] handler_set_fwrule[1032]: determine_action: nothing to do.
Dec 17 18:27:07 [ DBG] handler_set_fwrule[1032]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:07 [ DBG] handler_set_fwrule[1032]: determine_action: nothing to do.
Dec 17 18:27:07 [ DBG] handler_set_fwrule[1032]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:07 [ DBG] handler_set_fwrule[1032]: determine_action: nothing to do.
Dec 17 18:27:07 [ DBG] handler_set_fwrule[1032]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:07 [ DBG] handler_set_fwrule[1032]: determine_action: nothing to do.
Dec 17 18:27:07 [ DBG] handler_set_fwrule[1032]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:07 [ DBG] handler_set_fwrule[1032]: determine_action: nothing to do.
Dec 17 18:27:07 [ DBG] handler_set_fwrule[1032]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:07 [ DBG] handler_set_fwrule[1032]: determine_action: Status switch Disabled -> Disabling, set Action = 0.
Dec 17 18:27:07 [ DBG] handler_set_fwrule[1032]: Unavailable to load Device.Firewall.IPv4.Rules.10.
Dec 17 18:27:07 [ DBG] handler_set_fwrule[1032]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:07 [ DBG] handler_set_fwrule[1032]: determine_action: Status switch Disabled -> Disabling, set Action = 0.
Dec 17 18:27:07 [ DBG] handler_set_fwrule[1032]: Unavailable to load Device.Firewall.IPv4.Rules.11.
Dec 17 18:27:07 [ DBG] handler_set_fwrule[1032]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:07 [ DBG] handler_set_fwrule[1032]: determine_action: Status switch Disabled -> Disabling, set Action = 0.
Dec 17 18:27:07 [ DBG] handler_set_fwrule[1032]: Failed to parse rule Device.Firewall.IPv4.Rules.13.
Dec 17 18:27:07 [ DBG] handler_set_fwrule[1032]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:07 [ DBG] handler_set_fwrule[1032]: determine_action: Status switch Disabled -> Disabling, set Action = 0.
Dec 17 18:27:07 [ DBG] load_firewall_rule[1032]: Creating chain br1_eth3 in table nat
Dec 17 18:27:07 [ DBG] load_firewall_rule[1032]: Creating chain eth3_masq in table nat
Dec 17 18:27:07 [ DBG] set_nat_chain_jump[1032]: Creating: |-t nat -A POSTROUTING -o eth3 -j eth3_masq|
Dec 17 18:27:07 [ DBG] load_firewall_rule[1032]: Creating |-t nat -A eth3_masq -s 192.168.0.1/24 -j br1_eth3|
Dec 17 18:27:07 [ DBG] load_firewall_rule[1032]: Creating |-t nat -A br1_eth3  -j MASQUERADE|
Dec 17 18:27:07 [ DBG] load_firewall_rule[1032]: Rule #10000 LOADED
Dec 17 18:27:08 [ DBG] update_wifi[1083]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:08 [ DBG] update_wifi[1083]: determine_action: Start update requested.
Dec 17 18:27:08 [ DBG] update_wifi[1083]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:08 [ DBG] update_wifi[1083]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:08 [ DBG] update_wifi[1083]: determine_action: Start update requested.
Dec 17 18:27:08 [ DBG] update_wifi[1083]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:08 [ ERR] default_wifi_get_channel[1083]: d_wifi_ioctl(): No such device (19)
Dec 17 18:27:08 [ DBG] d_wifi_auto_bandwidth[1083]: Autoselecting channel bandwidth for 5GHz
Dec 17 18:27:08 [ DBG] d_wifi_auto_bandwidth[1083]: Maximum available bandwidth: 80MHz
Dec 17 18:27:08 [ ERR] default_wifi_get_channel[1083]: d_wifi_ioctl(): No such device (19)
Dec 17 18:27:08 [ DBG] d_wifi_auto_bandwidth[1083]: Autoselecting channel bandwidth for 2.4GHz
Dec 17 18:27:08 [ DBG] d_wifi_auto_bandwidth[1083]: Maximum available bandwidth: 40MHz
Dec 17 18:27:08 [ DBG] handler_update_wifi[1083]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:08 [ DBG] handler_update_wifi[1083]: determine_action: Start update requested.
Dec 17 18:27:08 [ DBG] handler_update_wifi[1083]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:08 [ DBG] handler_update_wifi[1083]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:08 [ DBG] handler_update_wifi[1083]: determine_action: Start update requested.
Dec 17 18:27:08 [ DBG] handler_update_wifi[1083]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:08 [ DBG] prepare[1083]: MTK: preparing
Dec 17 18:27:08 [ DBG] prepare[1083]: supermesh count for Radio.1 = 0
Dec 17 18:27:08 [ DBG] prepare[1083]: MTK: action 4
Dec 17 18:27:08 [ DBG] prepare[1083]: MTK: total 1 interfaces 5GHz
Dec 17 18:27:08 [INFO] write_config_file[1083]: Writing conf: /etc/Wireless/iNIC/iNIC_ap.dat
Dec 17 18:27:08 [ DBG] prepare[1083]: supermesh count for Radio.2 = 0
Dec 17 18:27:08 [ DBG] prepare[1083]: MTK: action 4
Dec 17 18:27:08 [ DBG] prepare[1083]: MTK: total 1 interfaces 2.4GHz
Dec 17 18:27:08 [INFO] write_config_file[1083]: Writing conf: /etc/Wireless/RT2860/RT2860.dat
Dec 17 18:27:08 [ DBG] start_WiFi[1100]: Starting
Dec 17 18:27:08 [ DBG] wifi_up[1100]: MTK: starting
Dec 17 18:27:09 [WARN] kernel: ChipOpsMCUHook
Dec 17 18:27:09 [INFO] kernel: [MTWF][dlink_mesh_check_data_struct]: check data structure: PASS
Dec 17 18:27:09 [INFO] kernel: [MTWF][mesh_module_init]: init hook functions.
Dec 17 18:27:10 [WARN] kernel: efuse_probe: efuse = 10000212
Dec 17 18:27:10 [WARN] kernel: ESW: Link Status Changed - Port4 Link UP
Dec 17 18:27:28 [WARN] kernel: MT7615BBPInit():BBP Initialization.....
Dec 17 18:27:28 [WARN] kernel: 	Band 0: valid=1, isDBDC=0, Band=2, CBW=1, CentCh/PrimCh=1/1, prim_ch_idx=0, txStream=2
Dec 17 18:27:28 [WARN] kernel: 	Band 1: valid=0, isDBDC=0, Band=0, CBW=0, CentCh/PrimCh=0/0, prim_ch_idx=0, txStream=0
Dec 17 18:27:30 [WARN] kernel: d-link channel[36+40+44+48] = 130
Dec 17 18:27:30 [WARN] kernel: d-link channel[52+56+60+64] = 0
Dec 17 18:27:30 [WARN] kernel: d-link channel[149+153+157+161] = 0
Dec 17 18:27:30 [WARN] kernel: d-link select channel = 52 + 64
Dec 17 18:27:30 [WARN] kernel: d-link channel[52] = 0
Dec 17 18:27:30 [WARN] kernel: d-link channel[56] = 0
Dec 17 18:27:30 [WARN] kernel: d-link channel[60] = 0
Dec 17 18:27:30 [WARN] kernel: d-link channel[64] = 0
Dec 17 18:27:30 [WARN] kernel: d-link select main channel = 52
Dec 17 18:27:33 [WARN] kernel: d-link channel[1+2+3+4+5] = 1210
Dec 17 18:27:33 [WARN] kernel: d-link channel[2+3+4+5+6] = 1340
Dec 17 18:27:33 [WARN] kernel: d-link channel[3+4+5+6+7] = 1450
Dec 17 18:27:33 [WARN] kernel: d-link channel[4+5+6+7+8] = 1500
Dec 17 18:27:33 [WARN] kernel: d-link channel[5+6+7+8+9] = 1490
Dec 17 18:27:33 [WARN] kernel: d-link channel[6+7+8+9+10] = 1420
Dec 17 18:27:33 [WARN] kernel: d-link channel[7+8+9+10+11] = 1340
Dec 17 18:27:33 [WARN] kernel: d-link channel[8+9+10+11+12] = 1250
Dec 17 18:27:33 [WARN] kernel: d-link channel[9+10+11+12+13] = 1070
Dec 17 18:27:33 [WARN] kernel: d-link select channel = 13 + 9
Dec 17 18:27:33 [INFO] kernel: ROAM UP
Dec 17 18:27:33 [ DBG] check_supermesh[1100]: There is no SuperMesh in this Radio
Dec 17 18:27:33 [ DBG] start_WiFi[1100]: Started
Dec 17 18:27:33 [ DBG] start_WiFi[1149]: Starting
Dec 17 18:27:33 [ DBG] wifi_up[1149]: MTK: starting
Dec 17 18:27:33 [INFO] kernel: ROAM DOWN
Dec 17 18:27:34 [WARN] kernel: efuse_probe: efuse = 10000212
Dec 17 18:27:34 [WARN] kernel: MT7615BBPInit():BBP Initialization.....
Dec 17 18:27:34 [WARN] kernel: 	Band 0: valid=1, isDBDC=0, Band=2, CBW=1, CentCh/PrimCh=1/1, prim_ch_idx=0, txStream=2
Dec 17 18:27:34 [WARN] kernel: 	Band 1: valid=0, isDBDC=0, Band=0, CBW=0, CentCh/PrimCh=0/0, prim_ch_idx=0, txStream=0
Dec 17 18:27:37 [WARN] kernel: d-link channel[36+40+44+48] = 130
Dec 17 18:27:37 [WARN] kernel: d-link channel[52+56+60+64] = 0
Dec 17 18:27:37 [WARN] kernel: d-link channel[149+153+157+161] = 0
Dec 17 18:27:37 [WARN] kernel: d-link select channel = 52 + 64
Dec 17 18:27:37 [WARN] kernel: d-link channel[52] = 0
Dec 17 18:27:37 [WARN] kernel: d-link channel[56] = 0
Dec 17 18:27:37 [WARN] kernel: d-link channel[60] = 0
Dec 17 18:27:37 [WARN] kernel: d-link channel[64] = 0
Dec 17 18:27:37 [WARN] kernel: d-link select main channel = 52
Dec 17 18:27:39 [WARN] kernel: d-link channel[1+2+3+4+5] = 1560
Dec 17 18:27:39 [WARN] kernel: d-link channel[2+3+4+5+6] = 1790
Dec 17 18:27:39 [WARN] kernel: d-link channel[3+4+5+6+7] = 1980
Dec 17 18:27:39 [WARN] kernel: d-link channel[4+5+6+7+8] = 2080
Dec 17 18:27:39 [WARN] kernel: d-link channel[5+6+7+8+9] = 2070
Dec 17 18:27:39 [WARN] kernel: d-link channel[6+7+8+9+10] = 1950
Dec 17 18:27:39 [WARN] kernel: d-link channel[7+8+9+10+11] = 1760
Dec 17 18:27:39 [WARN] kernel: d-link channel[8+9+10+11+12] = 1550
Dec 17 18:27:39 [WARN] kernel: d-link channel[9+10+11+12+13] = 1250
Dec 17 18:27:39 [WARN] kernel: d-link select channel = 13 + 9
Dec 17 18:27:40 [INFO] kernel: ROAM UP
Dec 17 18:27:40 [ DBG] check_supermesh[1149]: There is no SuperMesh in this Radio
Dec 17 18:27:40 [ DBG] start_WiFi[1149]: Started
Dec 17 18:27:40 [WARN] d_service_start[879]: Module 'NetlinkUevents' not found.
Dec 17 18:27:40 [ DBG] handler_set_fwrule[1172]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:40 [ DBG] handler_set_fwrule[1172]: determine_action: Start update requested.
Dec 17 18:27:40 [ DBG] handler_set_fwrule[1172]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:40 [ DBG] load_firewall_rule[1172]: Creating |-t filter -I z3to2 3 -p udp -j DROP -m udp --dport 1701|
Dec 17 18:27:40 [ DBG] load_firewall_rule[1172]: Rule #0 LOADED
Dec 17 18:27:40 [ DBG] handler_set_fwrule[1172]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:40 [ DBG] handler_set_fwrule[1172]: determine_action: Start update requested.
Dec 17 18:27:40 [ DBG] handler_set_fwrule[1172]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:40 [ DBG] dlinkwtch[1176]: Netlink monitor event handler installed
Dec 17 18:27:40 [ DBG] dlinkwtch[1176]: RTnetlink event handler installed
Dec 17 18:27:40 [ DBG] dlinkwtch[1176]: GPIO button event handler installed
Dec 17 18:27:40 [ DBG] load_firewall_rule[1172]: Creating |-t filter -I z3to2 4 -p tcp -j DROP -m tcp --dport 1723|
Dec 17 18:27:40 [ DBG] load_firewall_rule[1172]: Rule #1 LOADED
Dec 17 18:27:40 [ DBG] handler_set_fwrule[1172]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:40 [ DBG] handler_set_fwrule[1172]: determine_action: Start update requested.
Dec 17 18:27:40 [ DBG] handler_set_fwrule[1172]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:40 [ DBG] load_firewall_rule[1172]: Creating |-t filter -I z3to2 5 -p udp -j DROP -m udp -m multiport --dports 500,4500|
Dec 17 18:27:40 [ DBG] load_firewall_rule[1172]: Rule #2 LOADED
Dec 17 18:27:40 [ DBG] handler_set_fwrule[1172]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:40 [ DBG] handler_set_fwrule[1172]: determine_action: nothing to do.
Dec 17 18:27:40 [ DBG] handler_set_fwrule[1172]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:40 [ DBG] handler_set_fwrule[1172]: determine_action: nothing to do.
Dec 17 18:27:40 [ DBG] handler_set_fwrule[1172]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:40 [ DBG] handler_set_fwrule[1172]: determine_action: nothing to do.
Dec 17 18:27:40 [ DBG] handler_set_fwrule[1172]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:40 [ DBG] handler_set_fwrule[1172]: determine_action: nothing to do.
Dec 17 18:27:40 [ DBG] handler_set_fwrule[1172]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:40 [ DBG] handler_set_fwrule[1172]: determine_action: nothing to do.
Dec 17 18:27:40 [ DBG] handler_set_fwrule[1172]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:40 [ DBG] handler_set_fwrule[1172]: determine_action: Start update requested.
Dec 17 18:27:40 [ DBG] handler_set_fwrule[1172]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:40 [ DBG] handler_set_fwrule[1172]: Unavailable to load Device.Firewall.IPv4.Rules.10.
Dec 17 18:27:40 [ DBG] handler_set_fwrule[1172]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:40 [ DBG] handler_set_fwrule[1172]: determine_action: Start update requested.
Dec 17 18:27:40 [ DBG] handler_set_fwrule[1172]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:40 [ DBG] handler_set_fwrule[1172]: Unavailable to load Device.Firewall.IPv4.Rules.11.
Dec 17 18:27:40 [ DBG] handler_set_fwrule[1172]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:40 [ DBG] handler_set_fwrule[1172]: determine_action: Start update requested.
Dec 17 18:27:40 [ DBG] handler_set_fwrule[1172]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:40 [ DBG] handler_set_fwrule[1172]: Failed to parse rule Device.Firewall.IPv4.Rules.13.
Dec 17 18:27:40 [ DBG] handler_set_fwrule[1172]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:40 [ DBG] handler_set_fwrule[1172]: determine_action: Status switch Enabled -> Enabling, set Action = 0.
Dec 17 18:27:40 [ DBG] set_nat_chain_jump[1172]: Deleting: |-t nat -D POSTROUTING -o eth3 -j eth3_masq|
Dec 17 18:27:40 [ DBG] unload_firewall_rule[1172]: Deleting |-t nat -D eth3_masq -s 192.168.0.1/24 -j br1_eth3|
Dec 17 18:27:40 [ DBG] unload_firewall_rule[1172]: Deleting |-t nat -D br1_eth3  -j MASQUERADE|
Dec 17 18:27:40 [ DBG] unload_firewall_rule[1172]: Rule #10000 UNLOADED
Dec 17 18:27:40 [ DBG] load_firewall_rule[1172]: Creating chain br1_eth3 in table nat
Dec 17 18:27:40 [ DBG] load_firewall_rule[1172]: Creating chain eth3_masq in table nat
Dec 17 18:27:40 [ DBG] set_nat_chain_jump[1172]: Creating: |-t nat -A POSTROUTING -o eth3 -j eth3_masq|
Dec 17 18:27:40 [ DBG] load_firewall_rule[1172]: Creating |-t nat -A eth3_masq -s 192.168.0.1/24 -j br1_eth3|
Dec 17 18:27:40 [ DBG] load_firewall_rule[1172]: Creating |-t nat -A br1_eth3  -j MASQUERADE|
Dec 17 18:27:40 [ DBG] load_firewall_rule[1172]: Rule #10000 LOADED
Dec 17 18:27:40 [ DBG] handler_netfilter_modules[1199]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:40 [ DBG] handler_netfilter_modules[1199]: determine_action: nothing to do.
Dec 17 18:27:40 [ DBG] handler_netfilter_modules[1202]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:40 [ DBG] handler_netfilter_modules[1202]: determine_action: Start update requested.
Dec 17 18:27:40 [ DBG] handler_netfilter_modules[1202]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:40 [WARN] kernel: nf_conntrack_rtsp v0.7 loading
Dec 17 18:27:40 [WARN] kernel: nf_nat_rtsp v0.7 loading
Dec 17 18:27:40 [NOTE] start_Modules[1203]: Modules for RTSP: all loaded. OK
Dec 17 18:27:40 [ DBG] dlinkwtch[1176]: Total 3 receivers installed
Dec 17 18:27:40 [ DBG] handler_wan_connectivity_check[1209]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:40 [ DBG] handler_wan_connectivity_check[1209]: determine_action: nothing to do.
Dec 17 18:27:40 [ DBG] handler_update_rule[1211]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:40 [ DBG] handler_update_rule[1211]: determine_action: Start update requested.
Dec 17 18:27:40 [ DBG] handler_update_rule[1211]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:40 [ DBG] update_rule[1212]: ip rule add  fwmark 101 table 257: OK
Dec 17 18:27:40 [ DBG] handler_update_rule[1213]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:40 [ DBG] handler_update_rule[1213]: determine_action: Start update requested.
Dec 17 18:27:40 [ DBG] handler_update_rule[1213]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:40 [ DBG] update_rule[1214]: ip rule add  fwmark 100 table 256: OK
Dec 17 18:27:41 [ DBG] handler_update_rule[1216]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:41 [ DBG] handler_update_rule[1216]: determine_action: Start update requested.
Dec 17 18:27:41 [ DBG] handler_update_rule[1216]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:41 [ DBG] update_rule[1217]: ip -6 rule add  fwmark 101 table 257: OK
Dec 17 18:27:41 [ DBG] handler_update_rule[1218]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:41 [ DBG] handler_update_rule[1218]: determine_action: Start update requested.
Dec 17 18:27:41 [ DBG] handler_update_rule[1218]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:41 [ DBG] update_rule[1219]: ip -6 rule add  fwmark 100 table 256: OK
Dec 17 18:27:41 [ DBG] handler_printserver[1222]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:41 [ DBG] handler_printserver[1222]: determine_action: nothing to do.
Dec 17 18:27:41 [INFO] init[880]: Boot time (phase 1): 5.46 sec (kernel), 41.11 (user)
Dec 17 18:27:41 [ DBG] dwatcher[wrkr][1225]: Process action: LinkUp
Dec 17 18:27:41 [ DBG] DynPortMap[1226]: could not open lease file: /tmp/miniupnpd/1.lease
Dec 17 18:27:41 [ DBG] dwatcher[wrkr][1225]: check_ip: IP iface link = Device.Network.Interface.Loopback.1.
Dec 17 18:27:41 [ DBG] dwatcher[wrkr][1225]: IP lowerlayer = Device.Network.Interface.Bridge.1., enable = 1
Dec 17 18:27:41 [ DBG] dwatcher[wrkr][1225]: IP lowerlayer = Device.Network.Interface.Ethernet.2., enable = 1
Dec 17 18:27:41 [ DBG] dwatcher[wrkr][1225]: DHCP iface link = Device.Network.Interface.Loopback.1.
Dec 17 18:27:41 [ DBG] d_modules_get_iface_from_conn_low[1225]: Interface 'Device.Network.Interface.Ethernet.2.' is not enabled
Dec 17 18:27:41 [ DBG] dwatcher[wrkr][1225]: Interface = (null), Enable = 1
Dec 17 18:27:41 [ DBG] dwatcher[wrkr][1225]: Static iface link = Device.Network.Interface.Loopback.1.
Dec 17 18:27:41 [ DBG] dwatcher[wrkr][1225]: DHCPv6 iface link = Device.Network.Interface.Loopback.1.
Dec 17 18:27:41 [ DBG] dwatcher[wrkr][1225]: Staticv6 iface link = Device.Network.Interface.Loopback.1.
Dec 17 18:27:41 [ DBG] dwatcher[wrkr][1225]: PPP: Device.Network.Connection.PPPoE., iface_link: Device.Network.Interface.Loopback.1. action: 1
Dec 17 18:27:41 [ DBG] dwatcher[wrkr][1225]: Bridge iface link = Device.Network.Interface.Loopback.1.
Dec 17 18:27:41 [ DBG] dwatcher[wrkr][1225]: ROUTE Args: Interface=Device.Network.Interface.Loopback.1. Origin=(null) Src IP=(null)  Start=1
Dec 17 18:27:41 [ DBG] dwatcher[wrkr][1225]: ROUTE Args: Interface=Device.Network.Interface.Loopback.1. Origin=(null) Src IP=(null)  Start=1
Dec 17 18:27:41 [ DBG] dwatcher[wrkr][1225]: DHCP interface = Device.Network.Interface.Bridge.1., enable = 1
Dec 17 18:27:41 [ DBG] dwatcher[wrkr][1225]: DNS interface = Device.Network.Interface.Bridge.1., enable = 1
Dec 17 18:27:41 [ DBG] SchedRestartService[1225]: set rule DDNS
Dec 17 18:27:41 [ DBG] SchedRestartService[1225]: set rule DynPortMap
Dec 17 18:27:41 [ DBG] dwatcher[wrkr][1229]: Process action: FirewallRelationChanged
Dec 17 18:27:41 [ DBG] dwatcher[wrkr][1231]: Process action: FirewallRelationChanged
Dec 17 18:27:41 [ DBG] dwatcher[wrkr][1233]: Process action: FirewallRelationChanged
Dec 17 18:27:41 [ DBG] dwatcher[wrkr][1234]: Process action: VlanUp
Dec 17 18:27:41 [ DBG] handler_update_ethernet[1236]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:41 [ DBG] handler_update_ethernet[1236]: determine_action: Start update requested.
Dec 17 18:27:41 [ DBG] handler_update_ethernet[1236]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:41 [ DBG] update_ether[1236]: Start
Dec 17 18:27:41 [ DBG] start_Ethernet[1237]: Start
Dec 17 18:27:41 [ DBG] dwatcher[wrkr][1242]: Process action: VlanUp
Dec 17 18:27:41 [ DBG] handler_update_ethernet[1244]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:41 [ DBG] handler_update_ethernet[1244]: determine_action: Start update requested.
Dec 17 18:27:41 [ DBG] handler_update_ethernet[1244]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:41 [ DBG] update_ether[1244]: Start
Dec 17 18:27:41 [ DBG] start_Ethernet[1245]: Start
Dec 17 18:27:41 [WARN] kernel: eth3: ===> VirtualIF_close
Dec 17 18:27:41 [WARN] kernel: GDMA2_MAC_ADRH -- : 0x0000bc0f
Dec 17 18:27:41 [WARN] kernel: GDMA2_MAC_ADRL -- : 0x9a5e296c
Dec 17 18:27:41 [WARN] kernel: eth3: ===> VirtualIF_open
Dec 17 18:27:41 [ DBG] dwatcher[wrkr][1250]: Process action: LinkUp
Dec 17 18:27:41 [ DBG] DynPortMap[1251]: could not open lease file: /tmp/miniupnpd/1.lease
Dec 17 18:27:41 [ DBG] dwatcher[wrkr][1250]: check_ip: IP iface link = Device.Network.Interface.WiFi.1.
Dec 17 18:27:41 [ DBG] dwatcher[wrkr][1250]: IP lowerlayer = Device.Network.Interface.Bridge.1., enable = 1
Dec 17 18:27:41 [ DBG] dwatcher[wrkr][1250]: IP lowerlayer = Device.Network.Interface.Ethernet.2., enable = 1
Dec 17 18:27:41 [ DBG] dwatcher[wrkr][1250]: DHCP iface link = Device.Network.Interface.WiFi.1.
Dec 17 18:27:41 [ DBG] dwatcher[wrkr][1250]: Interface = Device.Network.Interface.Ethernet.2., Enable = 1
Dec 17 18:27:41 [ DBG] dwatcher[wrkr][1250]: Static iface link = Device.Network.Interface.WiFi.1.
Dec 17 18:27:41 [ DBG] dwatcher[wrkr][1250]: DHCPv6 iface link = Device.Network.Interface.WiFi.1.
Dec 17 18:27:41 [ DBG] dwatcher[wrkr][1250]: Staticv6 iface link = Device.Network.Interface.WiFi.1.
Dec 17 18:27:41 [ DBG] dwatcher[wrkr][1250]: PPP: Device.Network.Connection.PPPoE., iface_link: Device.Network.Interface.WiFi.1. action: 1
Dec 17 18:27:41 [ DBG] dwatcher[wrkr][1250]: Bridge iface link = Device.Network.Interface.WiFi.1.
Dec 17 18:27:41 [ DBG] dwatcher[wrkr][1250]: Starting bridge = Device.Network.Interface.Bridge.1.Status
Dec 17 18:27:41 [ DBG] handler_update_bridge[1253]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:41 [ DBG] handler_update_bridge[1253]: determine_action: Start update requested.
Dec 17 18:27:41 [ DBG] handler_update_bridge[1253]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:41 [ DBG] BRIDGE_HANDLER[1253]: Started
Dec 17 18:27:41 [ DBG] BRIDGE_HANDLER[1253]: SET
Dec 17 18:27:41 [ DBG] BRIDGE_HANDLER[1253]: Setted bridge for Device.Network.Interface.Bridge.1.
Dec 17 18:27:41 [ DBG] BRIDGE_HANDLER[1253]: Starting bridge
Dec 17 18:27:41 [ DBG] BRIDGE_MODULE[1254]: Started
Dec 17 18:27:41 [ DBG] BRIDGE_MODULE[1254]: Ifname - br1, MAC - bc:0f:9a:5e:29:6d
Dec 17 18:27:41 [INFO] kernel: device deth1 entered promiscuous mode
Dec 17 18:27:41 [INFO] kernel: device eth2 entered promiscuous mode
Dec 17 18:27:41 [INFO] kernel: device ra0 entered promiscuous mode
Dec 17 18:27:41 [INFO] kernel: device rax0 entered promiscuous mode
Dec 17 18:27:41 [INFO] kernel: br1: port 3(rax0) entered forwarding state
Dec 17 18:27:41 [INFO] kernel: br1: port 3(rax0) entered forwarding state
Dec 17 18:27:41 [INFO] kernel: br1: port 2(ra0) entered forwarding state
Dec 17 18:27:41 [INFO] kernel: br1: port 2(ra0) entered forwarding state
Dec 17 18:27:41 [INFO] kernel: br1: port 1(deth1) entered forwarding state
Dec 17 18:27:41 [INFO] kernel: br1: port 1(deth1) entered forwarding state
Dec 17 18:27:41 [ DBG] hwnat_enable[1253]: Load hw_nat with opts[lans=br1 wans=eth3]
Dec 17 18:27:41 [ DBG] kernel: lan_num = 1, wan_num = 1
Dec 17 18:27:41 [ DBG] kernel: lan[0] = br1
Dec 17 18:27:41 [ DBG] kernel: wan[0] = eth3
Dec 17 18:27:41 [INFO] kernel: enum_acl_netdev: got 2 ifaces (1 LAN, 1 WAN)
Dec 17 18:27:41 [ DBG] kernel: iface[0]: name = br1. mac = BC:0F:9A:5E:29:6D
Dec 17 18:27:41 [ DBG] kernel: iface[1]: name = eth3. mac = BC:0F:9A:5E:29:6C
Dec 17 18:27:41 [ DBG] kernel: halfword[0]: 2 -> 1 items:
Dec 17 18:27:41 [ DBG] kernel:   [0]: bc0f
Dec 17 18:27:41 [ DBG] kernel: halfword[1]: 2 -> 1 items:
Dec 17 18:27:41 [ DBG] kernel:   [0]: 9a5e
Dec 17 18:27:41 [ DBG] kernel: halfword[2]: 2 -> 2 items:
Dec 17 18:27:41 [ DBG] kernel:   [0]: 296c
Dec 17 18:27:41 [ DBG] kernel:   [1]: 296d
Dec 17 18:27:41 [INFO] kernel: enum_acl_netdev: need 4 patterns instead of 6
Dec 17 18:27:41 [ DBG] kernel:   acl dev[0]: patterns: 0, 1, 3
Dec 17 18:27:41 [ DBG] kernel:   acl dev[1]: patterns: 0, 1, 2
Dec 17 18:27:41 [WARN] kernel: init PpeFoeBase = a0e00000
Dec 17 18:27:41 [WARN] kernel: eth2 ifindex =2
Dec 17 18:27:41 [WARN] kernel: eth3 ifindex =8
Dec 17 18:27:41 [WARN] kernel: WanInf name is eth3!
Dec 17 18:27:41 [WARN] kernel: PpeDevRegHandler : ineterface ra0 register (10)
Dec 17 18:27:41 [WARN] kernel: PpeDevRegHandler : ineterface ra1 register (11)
Dec 17 18:27:41 [WARN] kernel: PpeDevRegHandler : ineterface ra2 register (12)
Dec 17 18:27:41 [WARN] kernel: PpeDevRegHandler : ineterface rax0 register (13)
Dec 17 18:27:41 [WARN] kernel: PpeDevRegHandler : ineterface rax1 register (14)
Dec 17 18:27:41 [WARN] kernel: PpeDevRegHandler : ineterface rax2 register (15)
Dec 17 18:27:41 [WARN] kernel: PpeDevRegHandler : ineterface apcli0 register (16)
Dec 17 18:27:41 [WARN] kernel: PpeDevRegHandler : ineterface apclix0 register (17)
Dec 17 18:27:41 [ ERR] d_wifi_iwpriv[1253]: d_wifi_ioctl failed: No such device (19)
Dec 17 18:27:41 [ DBG] BRIDGE_HANDLER[1253]: Success!
Dec 17 18:27:41 [ DBG] dwatcher[wrkr][1250]: ROUTE Args: Interface=Device.Network.Interface.WiFi.1. Origin=(null) Src IP=(null)  Start=1
Dec 17 18:27:41 [ DBG] dwatcher[wrkr][1250]: ROUTE Args: Interface=Device.Network.Interface.WiFi.1. Origin=(null) Src IP=(null)  Start=1
Dec 17 18:27:41 [ DBG] dwatcher[wrkr][1250]: DHCP interface = Device.Network.Interface.Bridge.1., enable = 1
Dec 17 18:27:41 [ DBG] dwatcher[wrkr][1250]: DNS interface = Device.Network.Interface.Bridge.1., enable = 1
Dec 17 18:27:41 [ DBG] SchedRestartService[1250]: set rule DDNS
Dec 17 18:27:41 [ DBG] SchedRestartService[1250]: set rule DynPortMap
Dec 17 18:27:41 [INFO] init[879]: Boot time (phase 2): 5.46 sec (kernel), 41.79 (user)
Dec 17 18:27:41 [ DBG] dwatcher[wrkr][1266]: Process action: SSIDChanged
Dec 17 18:27:41 [ DBG] REDIRECT[1265]: Device.Services.Redirect.1.
Dec 17 18:27:41 [ DBG] REDIRECT[1265]: cable - enable: true, old_state: false, new_state: false
Dec 17 18:27:41 [ DBG] REDIRECT[1265]: factory - enable: true, old_state: false, new_state: false
Dec 17 18:27:41 [ DBG] REDIRECT[1265]: connections - enable: true, old_state: false, new_state: true
Dec 17 18:27:41 [ DBG] REDIRECT[1265]: final_state - enable: false, old_state: false, new_state: true
Dec 17 18:27:41 [ DBG] handler_set_fwrule[1265]: determine_action: Enable switch false -> true, set Action = START.
Dec 17 18:27:41 [ DBG] handler_set_fwrule[1265]: determine_action: Current status Disabled, set Action = START.
Dec 17 18:27:41 [ DBG] load_firewall_rule[1265]: Creating chain ^R_br1_redir in table nat
Dec 17 18:27:41 [ DBG] set_nat_chain_jump[1265]: Creating: |-t nat -A PREROUTING -i br1 -j ^R_br1_redir|
Dec 17 18:27:41 [ DBG] load_firewall_rule[1265]: Creating |-t nat -A ^R_br1_redir -p udp -j REDIRECT -m udp --dport 53|
Dec 17 18:27:41 [ DBG] load_firewall_rule[1265]: Creating |-t nat -A ^R_br1_redir -p tcp -j REDIRECT -m tcp --dport 53|
Dec 17 18:27:41 [ DBG] load_firewall_rule[1265]: Rule #-19997 LOADED
Dec 17 18:27:41 [ DBG] handler_set_fwrule[1265]: determine_action: Enable switch false -> true, set Action = START.
Dec 17 18:27:41 [ DBG] handler_set_fwrule[1265]: determine_action: Current status Disabled, set Action = START.
Dec 17 18:27:41 [ DBG] load_firewall_rule[1265]: Creating chain ^R_br1_redir in table nat
Dec 17 18:27:41 [ DBG] load_firewall_rule[1265]: Creating |-t nat -A ^R_br1_redir -p tcp -j REDIRECT --to-port 4445 ! -d 192.168.0.1/32 -m tcp --dport 443|
Dec 17 18:27:41 [ DBG] load_firewall_rule[1265]: Rule #-19996 LOADED
Dec 17 18:27:42 [ DBG] handler_set_fwrule[1265]: determine_action: Enable switch false -> true, set Action = START.
Dec 17 18:27:42 [ DBG] handler_set_fwrule[1265]: determine_action: Current status Disabled, set Action = START.
Dec 17 18:27:42 [ DBG] load_firewall_rule[1265]: Creating |-t filter -I z3to2 3 -p tcp -j DROP -i br1 -m tcp -m multiport --dports 80,443 -d 192.0.2.1/32|
Dec 17 18:27:42 [ DBG] load_firewall_rule[1265]: Rule #-19995 LOADED
Dec 17 18:27:42 [ DBG] handler_set_fwrule[1265]: determine_action: Enable switch false -> true, set Action = START.
Dec 17 18:27:42 [ DBG] handler_set_fwrule[1265]: determine_action: Current status Disabled, set Action = START.
Dec 17 18:27:42 [ DBG] load_firewall_rule[1265]: Creating chain ^R_br1_redir in table nat
Dec 17 18:27:42 [ DBG] load_firewall_rule[1265]: Creating |-t nat -A ^R_br1_redir -p tcp -j REDIRECT --to-port 81 ! -d 192.168.0.1/32 -m tcp --dport 80|
Dec 17 18:27:42 [ DBG] load_firewall_rule[1265]: Rule #-19994 LOADED
Dec 17 18:27:42 [ DBG] handler_update_dnsmasq[1265]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:42 [ DBG] handler_update_dnsmasq[1265]: determine_action: Current status Disabled, set Action = START.
Dec 17 18:27:42 [WARN] search_ipv4_address[1265]: Needed IP address not found
Dec 17 18:27:42 [WARN] search_ipv4_address[1265]: Needed IP address not found
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1288]: Process action: LinkUp
Dec 17 18:27:42 [ DBG] DynPortMap[1289]: could not open lease file: /tmp/miniupnpd/1.lease
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1288]: check_ip: IP iface link = Device.Network.Interface.WiFi.2.
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1288]: IP lowerlayer = Device.Network.Interface.Bridge.1., enable = 1
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1288]: IP lowerlayer = Device.Network.Interface.Ethernet.2., enable = 1
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1288]: DHCP iface link = Device.Network.Interface.WiFi.2.
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1288]: Interface = Device.Network.Interface.Ethernet.2., Enable = 1
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1288]: Static iface link = Device.Network.Interface.WiFi.2.
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1288]: DHCPv6 iface link = Device.Network.Interface.WiFi.2.
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1288]: Staticv6 iface link = Device.Network.Interface.WiFi.2.
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1288]: PPP: Device.Network.Connection.PPPoE., iface_link: Device.Network.Interface.WiFi.2. action: 1
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1288]: Bridge iface link = Device.Network.Interface.WiFi.2.
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1288]: ROUTE Args: Interface=Device.Network.Interface.WiFi.2. Origin=(null) Src IP=(null)  Start=1
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1288]: ROUTE Args: Interface=Device.Network.Interface.WiFi.2. Origin=(null) Src IP=(null)  Start=1
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1288]: DHCP interface = Device.Network.Interface.Bridge.1., enable = 1
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1288]: DNS interface = Device.Network.Interface.Bridge.1., enable = 1
Dec 17 18:27:42 [ DBG] SchedRestartService[1288]: set rule DDNS
Dec 17 18:27:42 [ DBG] SchedRestartService[1288]: set rule DynPortMap
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1291]: Process action: SSIDChanged
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1293]: Process action: RuleUp
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1294]: Process action: RuleUp
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1295]: Process action: RuleUp
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1296]: Process action: RuleUp
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1297]: Process action: LinkUp
Dec 17 18:27:42 [ DBG] DynPortMap[1298]: could not open lease file: /tmp/miniupnpd/1.lease
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1297]: check_ip: IP iface link = Device.Network.Interface.Ethernet.1.
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1297]: IP lowerlayer = Device.Network.Interface.Bridge.1., enable = 1
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1297]: IP lowerlayer = Device.Network.Interface.Ethernet.2., enable = 1
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1297]: DHCP iface link = Device.Network.Interface.Ethernet.1.
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1297]: Interface = Device.Network.Interface.Ethernet.2., Enable = 1
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1297]: Static iface link = Device.Network.Interface.Ethernet.1.
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1297]: DHCPv6 iface link = Device.Network.Interface.Ethernet.1.
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1297]: Staticv6 iface link = Device.Network.Interface.Ethernet.1.
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1297]: PPP: Device.Network.Connection.PPPoE., iface_link: Device.Network.Interface.Ethernet.1. action: 1
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1297]: Bridge iface link = Device.Network.Interface.Ethernet.1.
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1297]: ROUTE Args: Interface=Device.Network.Interface.Ethernet.1. Origin=(null) Src IP=(null)  Start=1
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1297]: ROUTE Args: Interface=Device.Network.Interface.Ethernet.1. Origin=(null) Src IP=(null)  Start=1
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1297]: DHCP interface = Device.Network.Interface.Bridge.1., enable = 1
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1297]: DNS interface = Device.Network.Interface.Bridge.1., enable = 1
Dec 17 18:27:42 [ DBG] SchedRestartService[1297]: set rule DDNS
Dec 17 18:27:42 [ DBG] SchedRestartService[1297]: set rule DynPortMap
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1300]: Process action: LinkUp
Dec 17 18:27:42 [ DBG] DynPortMap[1301]: could not open lease file: /tmp/miniupnpd/1.lease
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1300]: check_ip: IP iface link = Device.Network.Interface.Ethernet.2.
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1300]: IP lowerlayer = Device.Network.Interface.Bridge.1., enable = 1
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1300]: IP lowerlayer = Device.Network.Interface.Ethernet.2., enable = 1
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1300]: IP str = Device.Network.IP.2
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1300]: DHCP iface link = Device.Network.Interface.Ethernet.2.
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1300]: Interface = Device.Network.Interface.Ethernet.2., Enable = 1
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1300]: DHCP str = Device.Network.Connection.DHCP.2.Status
Dec 17 18:27:42 [ DBG] handler_update_dhcp_daemon[1303]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:42 [ DBG] handler_update_dhcp_daemon[1303]: determine_action: Start update requested.
Dec 17 18:27:42 [ DBG] handler_update_dhcp_daemon[1303]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:42 [ DBG] DHCP handler[1303]: Updating path: Device.Network.Connection.DHCP.2.
Dec 17 18:27:42 [ DBG] dhcp_opt_find_name_by_code[1304]: This option [125] not supported
Dec 17 18:27:42 [INFO] udhcpc[1305]: started, v1.31.1
Dec 17 18:27:42 [ DBG] handler_set_fwrule[1303]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:42 [ DBG] handler_set_fwrule[1303]: determine_action: Stop update requested.
Dec 17 18:27:42 [ DBG] handler_set_fwrule[1303]: determine_action: Status switch Enabled -> Disabling, set Action = STOP.
Dec 17 18:27:42 [ DBG] unload_firewall_rule[1303]: Deleting |-t nat -D ^R_br1_redir -p tcp -j REDIRECT --to-port 4445 ! -d 192.168.0.1/32 -m tcp --dport 443|
Dec 17 18:27:42 [ DBG] unload_firewall_rule[1303]: Rule #-19996 UNLOADED
Dec 17 18:27:42 [ DBG] handler_set_fwrule[1303]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:42 [ DBG] handler_set_fwrule[1303]: determine_action: Stop update requested.
Dec 17 18:27:42 [ DBG] handler_set_fwrule[1303]: determine_action: Status switch Enabled -> Disabling, set Action = STOP.
Dec 17 18:27:42 [ DBG] unload_firewall_rule[1303]: Deleting |-t nat -D ^R_br1_redir -p tcp -j REDIRECT --to-port 81 ! -d 192.168.0.1/32 -m tcp --dport 80|
Dec 17 18:27:42 [ DBG] unload_firewall_rule[1303]: Rule #-19994 UNLOADED
Dec 17 18:27:42 [INFO] udhcpc[1305]: sending discover
Dec 17 18:27:42 [ DBG] handler_set_fwrule[1303]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:42 [ DBG] handler_set_fwrule[1303]: determine_action: nothing to do.
Dec 17 18:27:42 [ DBG] handler_set_fwrule[1303]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:42 [ DBG] handler_set_fwrule[1303]: determine_action: Status switch Disabled -> Disabling, set Action = 0.
Dec 17 18:27:42 [ DBG] handler_set_fwrule[1303]: Failed to parse rule Device.Firewall.IPv4.Rules.13.
Dec 17 18:27:42 [ DBG] handler_set_fwrule[1303]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:42 [ DBG] handler_set_fwrule[1303]: determine_action: Stop update requested.
Dec 17 18:27:42 [ DBG] handler_set_fwrule[1303]: determine_action: Status switch Enabled -> Disabling, set Action = STOP.
Dec 17 18:27:42 [ DBG] set_nat_chain_jump[1303]: Deleting: |-t nat -D POSTROUTING -o eth3 -j eth3_masq|
Dec 17 18:27:42 [ DBG] unload_firewall_rule[1303]: Deleting |-t nat -D eth3_masq -s 192.168.0.1/24 -j br1_eth3|
Dec 17 18:27:42 [ DBG] unload_firewall_rule[1303]: Deleting |-t nat -D br1_eth3  -j MASQUERADE|
Dec 17 18:27:42 [ DBG] unload_firewall_rule[1303]: Rule #10000 UNLOADED
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1300]: Static iface link = Device.Network.Interface.Ethernet.2.
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1300]: DHCPv6 iface link = Device.Network.Interface.Ethernet.2.
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1300]: Staticv6 iface link = Device.Network.Interface.Ethernet.2.
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1300]: PPP: Device.Network.Connection.PPPoE., iface_link: Device.Network.Interface.Ethernet.2. action: 1
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1300]: Bridge iface link = Device.Network.Interface.Ethernet.2.
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1300]: ROUTE Args: Interface=Device.Network.Interface.Ethernet.2. Origin=(null) Src IP=(null)  Start=1
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1300]: ROUTE Args: Interface=Device.Network.Interface.Ethernet.2. Origin=(null) Src IP=(null)  Start=1
Dec 17 18:27:42 [INFO] udhcpc[1305]: sending select for 10.203.111.7
Dec 17 18:27:42 [ DBG] handler_igmpx[1325]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:42 [ DBG] handler_igmpx[1325]: determine_action: Start update requested.
Dec 17 18:27:42 [ DBG] handler_igmpx[1325]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:42 [ DBG] ip_control[1325]: IP is not found by interface [Device.Network.Interface.Ethernet.2.]
Dec 17 18:27:42 [ DBG] interface_control[1325]: No IP addresses on iface [Device.Network.Interface.Ethernet.2.]
Dec 17 18:27:42 [WARN] streams_condition[1325]: Not active interface -> don't started IGMPX
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1300]: DHCP interface = Device.Network.Interface.Bridge.1., enable = 1
Dec 17 18:27:42 [ DBG] dwatcher[wrkr][1300]: DNS interface = Device.Network.Interface.Bridge.1., enable = 1
Dec 17 18:27:42 [ DBG] SchedRestartService[1300]: set rule DDNS
Dec 17 18:27:42 [ DBG] SchedRestartService[1300]: set rule DynPortMap
Dec 17 18:27:42 [ DBG] DynPortMap[1326]: could not open lease file: /tmp/miniupnpd/1.lease
Dec 17 18:27:42 [ DBG] handler_set_fwrule[1328]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:42 [ DBG] handler_set_fwrule[1328]: determine_action: Stop update requested.
Dec 17 18:27:42 [ DBG] handler_set_fwrule[1328]: determine_action: Status switch Enabled -> Disabling, set Action = STOP.
Dec 17 18:27:42 [ DBG] unload_firewall_rule[1328]: Deleting |-t filter -D z3to2 -p udp -j DROP -m udp --dport 1701|
Dec 17 18:27:42 [INFO] udhcpc[1305]: lease of 10.203.111.7 obtained, lease time 604800
Dec 17 18:27:42 [ DBG] unload_firewall_rule[1328]: Rule #0 UNLOADED
Dec 17 18:27:42 [ DBG] handler_set_fwrule[1333]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:42 [ DBG] handler_set_fwrule[1333]: determine_action: Current status Disabled, set Action = START.
Dec 17 18:27:42 [ DBG] handler_set_fwrule[1333]: Failed to parse rule Device.Firewall.IPv4.Rules.13.
Dec 17 18:27:42 [ DBG] handler_set_fwrule[1334]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:42 [ DBG] handler_set_fwrule[1334]: determine_action: Stop update requested.
Dec 17 18:27:42 [ DBG] handler_set_fwrule[1334]: determine_action: Status switch Enabled -> Disabling, set Action = STOP.
Dec 17 18:27:42 [ DBG] unload_firewall_rule[1334]: Deleting |-t filter -D z3to2 -p tcp -j DROP -m tcp --dport 1723|
Dec 17 18:27:43 [ DBG] unload_firewall_rule[1334]: Rule #1 UNLOADED
Dec 17 18:27:43 [ DBG] handler_set_fwrule[1339]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:43 [ DBG] handler_set_fwrule[1339]: determine_action: Stop update requested.
Dec 17 18:27:43 [ DBG] handler_set_fwrule[1339]: determine_action: Status switch Enabled -> Disabling, set Action = STOP.
Dec 17 18:27:43 [ DBG] unload_firewall_rule[1339]: Deleting |-t filter -D z3to2 -p udp -j DROP -m udp -m multiport --dports 500,4500|
Dec 17 18:27:43 [ DBG] unload_firewall_rule[1339]: Rule #2 UNLOADED
Dec 17 18:27:43 [ DBG] handler_set_fwrule[1344]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:43 [ DBG] handler_set_fwrule[1344]: determine_action: Stop update requested.
Dec 17 18:27:43 [ DBG] handler_set_fwrule[1344]: determine_action: Status switch Enabled -> Disabling, set Action = STOP.
Dec 17 18:27:43 [ DBG] set_nat_chain_jump[1344]: Deleting: |-t nat -D PREROUTING -i br1 -j ^R_br1_redir|
Dec 17 18:27:43 [ DBG] unload_firewall_rule[1344]: Deleting |-t nat -D ^R_br1_redir -p udp -j REDIRECT -m udp --dport 53|
Dec 17 18:27:43 [ DBG] unload_firewall_rule[1344]: Deleting |-t nat -D ^R_br1_redir -p tcp -j REDIRECT -m tcp --dport 53|
Dec 17 18:27:43 [ DBG] unload_firewall_rule[1344]: Rule #-19997 UNLOADED
Dec 17 18:27:43 [ DBG] handler_set_fwrule[1352]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:43 [ DBG] handler_set_fwrule[1352]: determine_action: Status switch Disabled -> Disabling, set Action = 0.
Dec 17 18:27:43 [ DBG] load_firewall_rule[1352]: Creating chain ^R_br1_redir in table nat
Dec 17 18:27:43 [ DBG] set_nat_chain_jump[1352]: Creating: |-t nat -A PREROUTING -i br1 -j ^R_br1_redir|
Dec 17 18:27:43 [ DBG] load_firewall_rule[1352]: Creating |-t nat -A ^R_br1_redir -p tcp -j REDIRECT --to-port 4445 ! -d 192.168.0.1/32 -m tcp --dport 443|
Dec 17 18:27:43 [ DBG] load_firewall_rule[1352]: Rule #-19996 LOADED
Dec 17 18:27:43 [ DBG] handler_set_fwrule[1359]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:43 [ DBG] handler_set_fwrule[1359]: determine_action: Stop update requested.
Dec 17 18:27:43 [ DBG] handler_set_fwrule[1359]: determine_action: Status switch Enabled -> Disabling, set Action = STOP.
Dec 17 18:27:43 [ DBG] unload_firewall_rule[1359]: Deleting |-t filter -D z3to2 -p tcp -j DROP -i br1 -m tcp -m multiport --dports 80,443 -d 192.0.2.1/32|
Dec 17 18:27:43 [ DBG] unload_firewall_rule[1359]: Rule #-19995 UNLOADED
Dec 17 18:27:43 [ DBG] handler_set_fwrule[1364]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:43 [ DBG] handler_set_fwrule[1364]: determine_action: Status switch Disabled -> Disabling, set Action = 0.
Dec 17 18:27:43 [ DBG] load_firewall_rule[1364]: Creating chain ^R_br1_redir in table nat
Dec 17 18:27:43 [ DBG] load_firewall_rule[1364]: Creating |-t nat -A ^R_br1_redir -p tcp -j REDIRECT --to-port 81 ! -d 192.168.0.1/32 -m tcp --dport 80|
Dec 17 18:27:43 [ DBG] load_firewall_rule[1364]: Rule #-19994 LOADED
Dec 17 18:27:43 [ DBG] update_udhcpc[1307]: action=deconfig; stop_on_fail=0; interface=Device.Network.Interface.Ethernet.2.;
Dec 17 18:27:43 [ DBG] handler_set_fwrule[1370]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:43 [ DBG] handler_set_fwrule[1370]: determine_action: nothing to do.
Dec 17 18:27:43 [ DBG] handler_set_fwrule[1373]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:43 [ DBG] handler_set_fwrule[1373]: determine_action: Status switch Disabled -> Disabling, set Action = 0.
Dec 17 18:27:43 [ DBG] handler_set_fwrule[1373]: Unavailable to load Device.Firewall.IPv4.Rules.10.
Dec 17 18:27:43 [ DBG] update_udhcpc[1372]: action=send_discover; stop_on_fail=0; interface=Device.Network.Interface.Ethernet.2.;
Dec 17 18:27:43 [ DBG] handler_set_fwrule[1375]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:43 [ DBG] handler_set_fwrule[1375]: determine_action: Status switch Disabled -> Disabling, set Action = 0.
Dec 17 18:27:43 [ DBG] handler_set_fwrule[1375]: Unavailable to load Device.Firewall.IPv4.Rules.11.
Dec 17 18:27:43 [ DBG] handler_set_fwrule[1378]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:43 [ DBG] handler_set_fwrule[1378]: determine_action: Status switch Disabled -> Disabling, set Action = 0.
Dec 17 18:27:43 [ DBG] handler_set_fwrule[1378]: Failed to parse rule Device.Firewall.IPv4.Rules.13.
Dec 17 18:27:43 [ DBG] handler_set_fwrule[1380]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:43 [ DBG] handler_set_fwrule[1380]: determine_action: Status switch Disabled -> Disabling, set Action = 0.
Dec 17 18:27:43 [ DBG] load_firewall_rule[1380]: Creating chain br1_eth3 in table nat
Dec 17 18:27:43 [ DBG] load_firewall_rule[1380]: Creating chain eth3_masq in table nat
Dec 17 18:27:43 [ DBG] set_nat_chain_jump[1380]: Creating: |-t nat -A POSTROUTING -o eth3 -j eth3_masq|
Dec 17 18:27:43 [ DBG] load_firewall_rule[1380]: Creating |-t nat -A eth3_masq -s 192.168.0.1/24 -j br1_eth3|
Dec 17 18:27:43 [ DBG] load_firewall_rule[1380]: Creating |-t nat -A br1_eth3  -j MASQUERADE|
Dec 17 18:27:43 [ DBG] load_firewall_rule[1380]: Rule #10000 LOADED
Dec 17 18:27:43 [ DBG] switch_ip[1402]: ip addr add 10.203.111.7/24 dev eth3: OK
Dec 17 18:27:43 [ DBG] renew[1377]: default_gateway=10.203.111.1
Dec 17 18:27:43 [ DBG] dwatcher[wrkr][1418]: Process action: LinkUp
Dec 17 18:27:43 [ DBG] DynPortMap[1417]: could not open lease file: /tmp/miniupnpd/1.lease
Dec 17 18:27:43 [ DBG] DynPortMap[1420]: could not open lease file: /tmp/miniupnpd/1.lease
Dec 17 18:27:43 [ DBG] dwatcher[wrkr][1418]: check_ip: IP iface link = Device.Network.Interface.Bridge.1.
Dec 17 18:27:43 [ DBG] dwatcher[wrkr][1418]: IP lowerlayer = Device.Network.Interface.Bridge.1., enable = 1
Dec 17 18:27:43 [ DBG] dwatcher[wrkr][1418]: IP str = Device.Network.IP.1
Dec 17 18:27:43 [ DBG] handler_set_fwrule[1422]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:43 [ DBG] handler_set_fwrule[1422]: determine_action: Current status Disabled, set Action = START.
Dec 17 18:27:43 [ DBG] load_firewall_rule[1422]: Creating |-t filter -I z2to1 3 -p udp -j ACCEPT -m udp --sport 67 -m udp --dport 68 -s 127.0.0.1/32 -d 10.203.111.7/32|
Dec 17 18:27:43 [ DBG] load_firewall_rule[1422]: Rule #-9989 LOADED
Dec 17 18:27:43 [ DBG] switch_ip[1426]: ip addr add 192.168.0.1/24 dev br1: OK
Dec 17 18:27:43 [ DBG] dwatcher[wrkr][1418]: IP lowerlayer = Device.Network.Interface.Ethernet.2., enable = 1
Dec 17 18:27:43 [ DBG] dwatcher[wrkr][1418]: DHCP iface link = Device.Network.Interface.Bridge.1.
Dec 17 18:27:43 [ DBG] dwatcher[wrkr][1418]: Interface = Device.Network.Interface.Ethernet.2., Enable = 1
Dec 17 18:27:43 [ DBG] dwatcher[wrkr][1418]: Static iface link = Device.Network.Interface.Bridge.1.
Dec 17 18:27:43 [ DBG] dwatcher[wrkr][1418]: DHCPv6 iface link = Device.Network.Interface.Bridge.1.
Dec 17 18:27:43 [ DBG] dwatcher[wrkr][1418]: Staticv6 iface link = Device.Network.Interface.Bridge.1.
Dec 17 18:27:43 [ DBG] dwatcher[wrkr][1418]: PPP: Device.Network.Connection.PPPoE., iface_link: Device.Network.Interface.Bridge.1. action: 1
Dec 17 18:27:43 [ DBG] dwatcher[wrkr][1418]: Bridge iface link = Device.Network.Interface.Bridge.1.
Dec 17 18:27:44 [INFO] dhcp_opt_print[1377]: Option(1): 255.255.255.0
Dec 17 18:27:44 [INFO] dhcp_opt_print[1377]: Option(3): 10.203.111.1
Dec 17 18:27:44 [INFO] dhcp_opt_print[1377]: Option(6): 10.0.0.2 10.0.0.3
Dec 17 18:27:44 [INFO] dhcp_opt_print[1377]: Option(12): ws_10_203_111_7
Dec 17 18:27:44 [INFO] dhcp_opt_print[1377]: Option(42): 10.0.0.2 10.0.0.3
Dec 17 18:27:44 [ DBG] handler_update_rule[1429]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:44 [ DBG] handler_update_rule[1429]: determine_action: Start update requested.
Dec 17 18:27:44 [ DBG] handler_update_rule[1429]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:44 [ DBG] update_rule[1430]: ip rule add  iif br1 table 257: OK
Dec 17 18:27:44 [ DBG] handler_ntp[1431]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:44 [ DBG] handler_ntp[1431]: determine_action: Current status Disabled, set Action = START.
Dec 17 18:27:44 [INFO] dhcp_opt_print[1377]: Option(51): 604800
Dec 17 18:27:44 [INFO] dhcp_opt_print[1377]: Option(54): 127.0.0.1
Dec 17 18:27:44 [ DBG] handler_update_rule[1435]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:44 [ DBG] handler_update_rule[1435]: determine_action: Start update requested.
Dec 17 18:27:44 [ DBG] handler_update_rule[1435]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:44 [ DBG] update_rule[1436]: ip -6 rule add  iif br1 table 257: OK
Dec 17 18:27:44 [ DBG] dwatcher[wrkr][1418]: ROUTE Args: Interface=Device.Network.Interface.Bridge.1. Origin=(null) Src IP=(null)  Start=1
Dec 17 18:27:44 [ DBG] dwatcher[wrkr][1418]: ROUTE Args: Interface=Device.Network.Interface.Bridge.1. Origin=(null) Src IP=(null)  Start=1
Dec 17 18:27:44 [ DBG] handler_igmpx[1438]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:44 [ DBG] handler_igmpx[1438]: determine_action: Start update requested.
Dec 17 18:27:44 [ DBG] handler_igmpx[1438]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:44 [ DBG] dwatcher[wrkr][1418]: DHCP interface = Device.Network.Interface.Bridge.1., enable = 1
Dec 17 18:27:44 [ DBG] handler_update_dnsmasq[1442]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:44 [ DBG] handler_update_dnsmasq[1442]: determine_action: Start update requested.
Dec 17 18:27:44 [ DBG] handler_update_dnsmasq[1442]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:44 [ DBG] check_diff_args[879]: dnsmasq@36(restart): arguments are equal, nothing to do
Dec 17 18:27:44 [ DBG] dwatcher[wrkr][1418]: DNS interface = Device.Network.Interface.Bridge.1., enable = 1
Dec 17 18:27:44 [ DBG] handler_update_dnsmasq[1451]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:44 [ DBG] handler_update_dnsmasq[1451]: determine_action: Status switch Enabling -> Enabling, set Action = 0.
Dec 17 18:27:44 [ DBG] dnsmasq_action[1451]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:44 [ DBG] check_diff_args[879]: dnsmasq@36(restart): arguments are equal, nothing to do
Dec 17 18:27:44 [ DBG] check_diff_args[879]: dnsmasq@36(restart): arguments are equal, nothing to do
Dec 17 18:27:44 [INFO] igmpx[1440]: daemonizing ...
Dec 17 18:27:44 [INFO] igmpx[1455]: current prio is -20
Dec 17 18:27:44 [NOTE] igmpx[1455]: kernel multicast version is 305 (v3.05 ?)
Dec 17 18:27:44 [INFO] igmpx[1455]: kernel mroute inited
Dec 17 18:27:44 [INFO] igmpx[1455]: proxy prepared
Dec 17 18:27:44 [INFO] igmpx[1455]: config: query_interval        = 125 sec
Dec 17 18:27:44 [INFO] igmpx[1455]: config: query_response_period = 10.0 sec (code = 0x64)
Dec 17 18:27:44 [INFO] igmpx[1455]: config: last_response_period  = 1.0 sec (code = 0x0a)
Dec 17 18:27:44 [INFO] igmpx[1455]: config: doublet_join          = disabled
Dec 17 18:27:44 [INFO] igmpx[1455]: config: hews_interval         = 0.0 sec
Dec 17 18:27:44 [INFO] igmpx[1455]: vifi #0 added for eth3
Dec 17 18:27:44 [INFO] igmpx[1455]: VIF eth3: 0 allowed net(s) configured
Dec 17 18:27:44 [INFO] igmpx[1455]: VIF eth3: 0 denied net(s) configured
Dec 17 18:27:44 [INFO] igmpx[1455]: 1 upstream(s) configured
Dec 17 18:27:44 [INFO] igmpx[1455]: vifi #1 added for br1
Dec 17 18:27:44 [INFO] igmpx[1455]: VIF br1: 0 allowed net(s) configured
Dec 17 18:27:44 [INFO] igmpx[1455]: VIF br1: 0 denied net(s) configured
Dec 17 18:27:44 [INFO] igmpx[1455]: 1 downstream(s) configured
Dec 17 18:27:44 [NOTE] igmpx[1455]: disabling load filter
Dec 17 18:27:44 [WARN] DNSMASQ_SCRIPT[1452]: Too small arguments
Dec 17 18:27:44 [WARN] dnsmasq[1461]: no servers found in /tmp/dnsmasq/resolv36.conf, will retry
Dec 17 18:27:44 [ DBG] handler_update_route[1457]: determine_action: Enable switch false -> true, set Action = START.
Dec 17 18:27:44 [ DBG] handler_update_route[1457]: determine_action: Current status Disabled, set Action = START.
Dec 17 18:27:44 [ DBG] update_route[1465]: ip route add unspec 0.0.0.0/0 dev eth3 via 10.203.111.1 table 256 metric 410: OK
Dec 17 18:27:44 [ DBG] update_route[1465]: ip route add unspec 0.0.0.0/0 dev eth3 via 10.203.111.1 table 257 metric 410: OK
Dec 17 18:27:44 [ DBG] update_route[1465]: ip route add unspec 0.0.0.0/0 dev eth3 via 10.203.111.1 table 254 metric 410: OK
Dec 17 18:27:44 [ DBG] handler_update_samba[1466]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:44 [ DBG] handler_update_samba[1466]: determine_action: nothing to do.
Dec 17 18:27:44 [ DBG] handler_update_samba[1466]: started
Dec 17 18:27:44 [ DBG] handler_update_samba[1466]: set
Dec 17 18:27:45 [ DBG] DynPortMap[1467]: could not open lease file: /tmp/miniupnpd/1.lease
Dec 17 18:27:45 [ DBG] handler_update_samba[1471]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:45 [ DBG] handler_update_samba[1471]: determine_action: nothing to do.
Dec 17 18:27:45 [ DBG] handler_update_samba[1471]: started
Dec 17 18:27:45 [ DBG] handler_update_samba[1471]: set
Dec 17 18:27:45 [ DBG] handler_set_fwrule[1473]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:45 [ DBG] handler_set_fwrule[1473]: determine_action: Start update requested.
Dec 17 18:27:45 [ DBG] handler_set_fwrule[1473]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:45 [ DBG] load_firewall_rule[1473]: Creating |-t filter -I z2to3 3 -j ACCEPT -m iprange  --dst-range 224.0.0.0-239.255.255.255|
Dec 17 18:27:45 [ DBG] load_firewall_rule[1473]: Rule #-9992 LOADED
Dec 17 18:27:45 [ DBG] handler_update_dlna[1477]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:45 [ DBG] handler_update_dlna[1477]: determine_action: nothing to do.
Dec 17 18:27:45 [ DBG] handler_update_dlna[1477]: started
Dec 17 18:27:45 [ DBG] handler_update_dlna[1477]: set
Dec 17 18:27:45 [ DBG] check_wan_group[1478]: Can't find connection for 1 WAN Group or DNS current == NULL
Dec 17 18:27:45 [ DBG] handler_set_fwrule[1479]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:45 [ DBG] handler_set_fwrule[1479]: determine_action: Start update requested.
Dec 17 18:27:45 [ DBG] handler_set_fwrule[1479]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:45 [ DBG] load_firewall_rule[1479]: Creating |-t filter -I z2to1 3 -p igmp -j ACCEPT -m iprange  --dst-range 224.0.0.0-239.255.255.255|
Dec 17 18:27:45 [ DBG] load_firewall_rule[1479]: Rule #-9991 LOADED
Dec 17 18:27:45 [ DBG] handler_update_dlna[1483]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:45 [ DBG] handler_update_dlna[1483]: determine_action: nothing to do.
Dec 17 18:27:45 [ DBG] handler_update_dlna[1483]: started
Dec 17 18:27:45 [ DBG] handler_update_dlna[1483]: set
Dec 17 18:27:45 [ DBG] handler_update_xupnpd[1485]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:45 [ DBG] handler_update_xupnpd[1485]: determine_action: nothing to do.
Dec 17 18:27:45 [ DBG] check_wan_group[1486]: Can't find connection for 1 WAN Group or DNS current == NULL
Dec 17 18:27:45 [ DBG] handler_update_xupnpd[1487]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:45 [ DBG] handler_update_xupnpd[1487]: determine_action: nothing to do.
Dec 17 18:27:45 [ DBG] handler_update_ftp[1490]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:45 [ DBG] handler_update_ftp[1490]: determine_action: nothing to do.
Dec 17 18:27:45 [ DBG] SchedRestartService[1418]: set rule DDNS
Dec 17 18:27:45 [ DBG] SchedRestartService[1418]: set rule DynPortMap
Dec 17 18:27:45 [ DBG] handler_update_transmission[1493]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:45 [ DBG] handler_update_transmission[1493]: determine_action: nothing to do.
Dec 17 18:27:45 [ DBG] handler_set_fwrule[1494]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:45 [ DBG] handler_set_fwrule[1494]: determine_action: Start update requested.
Dec 17 18:27:45 [ DBG] handler_set_fwrule[1494]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:45 [ DBG] load_firewall_rule[1494]: Creating |-t filter -I z3to2 3 -p udp -j DROP -m udp --dport 1701|
Dec 17 18:27:45 [ DBG] load_firewall_rule[1494]: Rule #0 LOADED
Dec 17 18:27:45 [ DBG] handler_set_fwrule[1494]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:45 [ DBG] handler_set_fwrule[1494]: determine_action: Start update requested.
Dec 17 18:27:45 [ DBG] handler_set_fwrule[1494]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:45 [ DBG] load_firewall_rule[1494]: Creating |-t filter -I z3to2 4 -p tcp -j DROP -m tcp --dport 1723|
Dec 17 18:27:45 [ DBG] load_firewall_rule[1494]: Rule #1 LOADED
Dec 17 18:27:45 [ DBG] handler_set_fwrule[1494]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:45 [ DBG] handler_set_fwrule[1494]: determine_action: Start update requested.
Dec 17 18:27:45 [ DBG] handler_set_fwrule[1494]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:45 [ DBG] load_firewall_rule[1494]: Creating |-t filter -I z3to2 5 -p udp -j DROP -m udp -m multiport --dports 500,4500|
Dec 17 18:27:45 [ DBG] load_firewall_rule[1494]: Rule #2 LOADED
Dec 17 18:27:45 [ DBG] handler_set_fwrule[1494]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:45 [ DBG] handler_set_fwrule[1494]: determine_action: Start update requested.
Dec 17 18:27:45 [ DBG] handler_set_fwrule[1494]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:45 [ DBG] load_firewall_rule[1494]: Creating chain ^R_br1_redir in table nat
Dec 17 18:27:45 [ DBG] load_firewall_rule[1494]: Creating |-t nat -A ^R_br1_redir -p udp -j REDIRECT -m udp --dport 53|
Dec 17 18:27:45 [ DBG] load_firewall_rule[1494]: Creating |-t nat -A ^R_br1_redir -p tcp -j REDIRECT -m tcp --dport 53|
Dec 17 18:27:45 [ DBG] load_firewall_rule[1494]: Rule #-19997 LOADED
Dec 17 18:27:45 [ DBG] handler_set_fwrule[1494]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:45 [ DBG] handler_set_fwrule[1494]: determine_action: Status switch Enabled -> Enabling, set Action = 0.
Dec 17 18:27:45 [ DBG] unload_firewall_rule[1494]: Deleting |-t nat -D ^R_br1_redir -p tcp -j REDIRECT --to-port 4445 ! -d 192.168.0.1/32 -m tcp --dport 443|
Dec 17 18:27:45 [ DBG] unload_firewall_rule[1494]: Rule #-19996 UNLOADED
Dec 17 18:27:45 [ DBG] load_firewall_rule[1494]: Creating chain ^R_br1_redir in table nat
Dec 17 18:27:45 [ DBG] load_firewall_rule[1494]: Creating |-t nat -A ^R_br1_redir -p tcp -j REDIRECT --to-port 4445 ! -d 192.168.0.1/32 -m tcp --dport 443|
Dec 17 18:27:45 [ DBG] load_firewall_rule[1494]: Rule #-19996 LOADED
Dec 17 18:27:45 [ DBG] handler_set_fwrule[1494]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:45 [ DBG] handler_set_fwrule[1494]: determine_action: Start update requested.
Dec 17 18:27:45 [ DBG] handler_set_fwrule[1494]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:45 [ DBG] load_firewall_rule[1494]: Creating |-t filter -I z3to2 3 -p tcp -j DROP -i br1 -m tcp -m multiport --dports 80,443 -d 192.0.2.1/32|
Dec 17 18:27:45 [ DBG] load_firewall_rule[1494]: Rule #-19995 LOADED
Dec 17 18:27:45 [ DBG] handler_set_fwrule[1494]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:45 [ DBG] handler_set_fwrule[1494]: determine_action: Status switch Enabled -> Enabling, set Action = 0.
Dec 17 18:27:45 [ DBG] unload_firewall_rule[1494]: Deleting |-t nat -D ^R_br1_redir -p tcp -j REDIRECT --to-port 81 ! -d 192.168.0.1/32 -m tcp --dport 80|
Dec 17 18:27:45 [ DBG] unload_firewall_rule[1494]: Rule #-19994 UNLOADED
Dec 17 18:27:45 [ DBG] load_firewall_rule[1494]: Creating chain ^R_br1_redir in table nat
Dec 17 18:27:45 [ DBG] load_firewall_rule[1494]: Creating |-t nat -A ^R_br1_redir -p tcp -j REDIRECT --to-port 81 ! -d 192.168.0.1/32 -m tcp --dport 80|
Dec 17 18:27:45 [ DBG] load_firewall_rule[1494]: Rule #-19994 LOADED
Dec 17 18:27:45 [ DBG] handler_set_fwrule[1494]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:45 [ DBG] handler_set_fwrule[1494]: determine_action: nothing to do.
Dec 17 18:27:45 [ DBG] handler_set_fwrule[1494]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:45 [ DBG] handler_set_fwrule[1494]: determine_action: Status switch Enabled -> Enabling, set Action = 0.
Dec 17 18:27:45 [ DBG] unload_firewall_rule[1494]: Deleting |-t filter -D z2to3 -j ACCEPT -m iprange  --dst-range 224.0.0.0-239.255.255.255|
Dec 17 18:27:45 [ DBG] unload_firewall_rule[1494]: Rule #-9992 UNLOADED
Dec 17 18:27:45 [ DBG] load_firewall_rule[1494]: Creating |-t filter -I z2to3 3 -j ACCEPT -m iprange  --dst-range 224.0.0.0-239.255.255.255|
Dec 17 18:27:45 [ DBG] load_firewall_rule[1494]: Rule #-9992 LOADED
Dec 17 18:27:45 [ DBG] handler_set_fwrule[1494]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:45 [ DBG] handler_set_fwrule[1494]: determine_action: Status switch Enabled -> Enabling, set Action = 0.
Dec 17 18:27:45 [ DBG] unload_firewall_rule[1494]: Deleting |-t filter -D z2to1 -p igmp -j ACCEPT -m iprange  --dst-range 224.0.0.0-239.255.255.255|
Dec 17 18:27:45 [ DBG] unload_firewall_rule[1494]: Rule #-9991 UNLOADED
Dec 17 18:27:45 [ DBG] load_firewall_rule[1494]: Creating |-t filter -I z2to1 3 -p igmp -j ACCEPT -m iprange  --dst-range 224.0.0.0-239.255.255.255|
Dec 17 18:27:45 [ DBG] load_firewall_rule[1494]: Rule #-9991 LOADED
Dec 17 18:27:45 [ DBG] handler_set_fwrule[1494]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:45 [ DBG] handler_set_fwrule[1494]: determine_action: Status switch Enabled -> Enabling, set Action = 0.
Dec 17 18:27:45 [ DBG] unload_firewall_rule[1494]: Deleting |-t filter -D z2to1 -p udp -j ACCEPT -m udp --sport 67 -m udp --dport 68 -s 127.0.0.1/32 -d 10.203.111.7/32|
Dec 17 18:27:45 [ DBG] unload_firewall_rule[1494]: Rule #-9989 UNLOADED
Dec 17 18:27:45 [ DBG] load_firewall_rule[1494]: Creating |-t filter -I z2to1 4 -p udp -j ACCEPT -m udp --sport 67 -m udp --dport 68 -s 127.0.0.1/32 -d 10.203.111.7/32|
Dec 17 18:27:45 [ DBG] load_firewall_rule[1494]: Rule #-9989 LOADED
Dec 17 18:27:45 [ DBG] handler_set_fwrule[1494]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:45 [ DBG] handler_set_fwrule[1494]: determine_action: Status switch Enabled -> Enabling, set Action = 0.
Dec 17 18:27:46 [ DBG] set_nat_chain_jump[1494]: Deleting: |-t nat -D POSTROUTING -o eth3 -j eth3_masq|
Dec 17 18:27:46 [ DBG] unload_firewall_rule[1494]: Deleting |-t nat -D eth3_masq -s 192.168.0.1/24 -j br1_eth3|
Dec 17 18:27:46 [ DBG] unload_firewall_rule[1494]: Deleting |-t nat -D br1_eth3  -j MASQUERADE|
Dec 17 18:27:46 [ DBG] unload_firewall_rule[1494]: Rule #10000 UNLOADED
Dec 17 18:27:46 [ DBG] load_firewall_rule[1494]: Creating chain br1_eth3 in table nat
Dec 17 18:27:46 [ DBG] load_firewall_rule[1494]: Creating chain eth3_masq in table nat
Dec 17 18:27:46 [ DBG] set_nat_chain_jump[1494]: Creating: |-t nat -A POSTROUTING -o eth3 -j eth3_masq|
Dec 17 18:27:46 [ DBG] load_firewall_rule[1494]: Creating |-t nat -A eth3_masq -s 192.168.0.1/24 -j br1_eth3|
Dec 17 18:27:46 [ DBG] load_firewall_rule[1494]: Creating |-t nat -A br1_eth3  -j MASQUERADE|
Dec 17 18:27:46 [ DBG] load_firewall_rule[1494]: Rule #10000 LOADED
Dec 17 18:27:46 [ DBG] check_wan_group[1562]: Can't find connection for 1 WAN Group or DNS current == NULL
Dec 17 18:27:46 [ DBG] handler_set_fwrule[1564]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:46 [ DBG] handler_set_fwrule[1564]: determine_action: Stop update requested.
Dec 17 18:27:46 [ DBG] handler_set_fwrule[1564]: determine_action: Status switch Enabled -> Disabling, set Action = STOP.
Dec 17 18:27:46 [ DBG] unload_firewall_rule[1564]: Deleting |-t filter -D z3to2 -p udp -j DROP -m udp --dport 1701|
Dec 17 18:27:46 [ DBG] unload_firewall_rule[1564]: Rule #0 UNLOADED
Dec 17 18:27:46 [ DBG] handler_set_fwrule[1569]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:46 [ DBG] handler_set_fwrule[1569]: determine_action: Stop update requested.
Dec 17 18:27:46 [ DBG] handler_set_fwrule[1569]: determine_action: Status switch Enabled -> Disabling, set Action = STOP.
Dec 17 18:27:46 [ DBG] unload_firewall_rule[1569]: Deleting |-t filter -D z3to2 -p tcp -j DROP -m tcp --dport 1723|
Dec 17 18:27:46 [ DBG] unload_firewall_rule[1569]: Rule #1 UNLOADED
Dec 17 18:27:46 [ DBG] update_udhcpc[1377]: action=bound; stop_on_fail=0; interface=Device.Network.Interface.Ethernet.2.;
Dec 17 18:27:46 [ DBG] handler_set_fwrule[1574]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:46 [ DBG] handler_set_fwrule[1574]: determine_action: Stop update requested.
Dec 17 18:27:46 [ DBG] handler_set_fwrule[1574]: determine_action: Status switch Enabled -> Disabling, set Action = STOP.
Dec 17 18:27:46 [ DBG] unload_firewall_rule[1574]: Deleting |-t filter -D z3to2 -p udp -j DROP -m udp -m multiport --dports 500,4500|
Dec 17 18:27:46 [ DBG] unload_firewall_rule[1574]: Rule #2 UNLOADED
Dec 17 18:27:46 [ DBG] handler_set_fwrule[1579]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:46 [ DBG] handler_set_fwrule[1579]: determine_action: Stop update requested.
Dec 17 18:27:46 [ DBG] handler_set_fwrule[1579]: determine_action: Status switch Enabled -> Disabling, set Action = STOP.
Dec 17 18:27:46 [ DBG] unload_firewall_rule[1579]: Deleting |-t nat -D ^R_br1_redir -p udp -j REDIRECT -m udp --dport 53|
Dec 17 18:27:46 [ DBG] unload_firewall_rule[1579]: Deleting |-t nat -D ^R_br1_redir -p tcp -j REDIRECT -m tcp --dport 53|
Dec 17 18:27:46 [ DBG] unload_firewall_rule[1579]: Rule #-19997 UNLOADED
Dec 17 18:27:46 [ DBG] handler_set_fwrule[1586]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:46 [ DBG] handler_set_fwrule[1586]: determine_action: Stop update requested.
Dec 17 18:27:46 [ DBG] handler_set_fwrule[1586]: determine_action: Status switch Enabled -> Disabling, set Action = STOP.
Dec 17 18:27:46 [ DBG] unload_firewall_rule[1586]: Deleting |-t nat -D ^R_br1_redir -p tcp -j REDIRECT --to-port 4445 ! -d 192.168.0.1/32 -m tcp --dport 443|
Dec 17 18:27:46 [ DBG] unload_firewall_rule[1586]: Rule #-19996 UNLOADED
Dec 17 18:27:46 [ DBG] handler_set_fwrule[1591]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:46 [ DBG] handler_set_fwrule[1591]: determine_action: Stop update requested.
Dec 17 18:27:46 [ DBG] handler_set_fwrule[1591]: determine_action: Status switch Enabled -> Disabling, set Action = STOP.
Dec 17 18:27:46 [ DBG] unload_firewall_rule[1591]: Deleting |-t filter -D z3to2 -p tcp -j DROP -i br1 -m tcp -m multiport --dports 80,443 -d 192.0.2.1/32|
Dec 17 18:27:46 [ DBG] unload_firewall_rule[1591]: Rule #-19995 UNLOADED
Dec 17 18:27:46 [ DBG] handler_set_fwrule[1595]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:46 [ DBG] handler_set_fwrule[1595]: determine_action: Stop update requested.
Dec 17 18:27:46 [ DBG] handler_set_fwrule[1595]: determine_action: Status switch Enabled -> Disabling, set Action = STOP.
Dec 17 18:27:46 [ DBG] set_nat_chain_jump[1595]: Deleting: |-t nat -D PREROUTING -i br1 -j ^R_br1_redir|
Dec 17 18:27:46 [ DBG] unload_firewall_rule[1595]: Deleting |-t nat -D ^R_br1_redir -p tcp -j REDIRECT --to-port 81 ! -d 192.168.0.1/32 -m tcp --dport 80|
Dec 17 18:27:46 [ DBG] unload_firewall_rule[1595]: Rule #-19994 UNLOADED
Dec 17 18:27:46 [ DBG] handler_set_fwrule[1601]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:46 [ DBG] handler_set_fwrule[1601]: determine_action: nothing to do.
Dec 17 18:27:46 [ DBG] handler_set_fwrule[1602]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:46 [ DBG] handler_set_fwrule[1602]: determine_action: Stop update requested.
Dec 17 18:27:46 [ DBG] handler_set_fwrule[1602]: determine_action: Status switch Enabled -> Disabling, set Action = STOP.
Dec 17 18:27:46 [ DBG] unload_firewall_rule[1602]: Deleting |-t filter -D z2to3 -j ACCEPT -m iprange  --dst-range 224.0.0.0-239.255.255.255|
Dec 17 18:27:46 [ DBG] unload_firewall_rule[1602]: Rule #-9992 UNLOADED
Dec 17 18:27:46 [ DBG] handler_set_fwrule[1606]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:46 [ DBG] handler_set_fwrule[1606]: determine_action: Stop update requested.
Dec 17 18:27:46 [ DBG] handler_set_fwrule[1606]: determine_action: Status switch Enabled -> Disabling, set Action = STOP.
Dec 17 18:27:46 [ DBG] unload_firewall_rule[1606]: Deleting |-t filter -D z2to1 -p udp -j ACCEPT -m udp --sport 67 -m udp --dport 68 -s 127.0.0.1/32 -d 10.203.111.7/32|
Dec 17 18:27:46 [ DBG] unload_firewall_rule[1606]: Rule #-9989 UNLOADED
Dec 17 18:27:46 [ DBG] handler_set_fwrule[1610]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:46 [ DBG] handler_set_fwrule[1610]: determine_action: Stop update requested.
Dec 17 18:27:46 [ DBG] handler_set_fwrule[1610]: determine_action: Status switch Enabled -> Disabling, set Action = STOP.
Dec 17 18:27:46 [ DBG] set_nat_chain_jump[1610]: Deleting: |-t nat -D POSTROUTING -o eth3 -j eth3_masq|
Dec 17 18:27:46 [ DBG] unload_firewall_rule[1610]: Deleting |-t nat -D eth3_masq -s 192.168.0.1/24 -j br1_eth3|
Dec 17 18:27:46 [ DBG] unload_firewall_rule[1610]: Deleting |-t nat -D br1_eth3  -j MASQUERADE|
Dec 17 18:27:46 [ DBG] unload_firewall_rule[1610]: Rule #10000 UNLOADED
Dec 17 18:27:47 [ DBG] dwatcher[wrkr][1651]: Process action: ConnectionStatusChanged
Dec 17 18:27:47 [ DBG] DynPortMap[1652]: could not open lease file: /tmp/miniupnpd/1.lease
Dec 17 18:27:47 [ DBG] dwatcher[wrkr][1655]: Process action: IpUp
Dec 17 18:27:47 [ DBG] DynPortMap[1656]: could not open lease file: /tmp/miniupnpd/1.lease
Dec 17 18:27:47 [ DBG] handler_telnetd[1660]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:47 [ DBG] handler_telnetd[1660]: determine_action: nothing to do.
Dec 17 18:27:47 [ DBG] handler_update_ssh[1661]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:47 [ DBG] handler_update_ssh[1661]: determine_action: nothing to do.
Dec 17 18:27:47 [ DBG] handler_anweb[1662]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:47 [ DBG] handler_anweb[1662]: determine_action: Start update requested.
Dec 17 18:27:47 [ DBG] handler_anweb[1662]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:47 [ DBG] handler_ntp[1665]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:47 [ DBG] handler_ntp[1665]: determine_action: Status switch Enabled -> Enabling, set Action = 0.
Dec 17 18:27:47 [ DBG] handler_ipsec[1666]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:47 [ DBG] handler_ipsec[1666]: determine_action: nothing to do.
Dec 17 18:27:47 [ DBG] handler_tr069[1667]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:47 [ DBG] handler_tr069[1667]: determine_action: Start update requested.
Dec 17 18:27:47 [ DBG] handler_tr069[1667]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:47 [INFO] anweb[1664]: Starting...
Dec 17 18:27:47 [NOTE] d_socket_poll_process[879]: cannot find socket, fd 23
Dec 17 18:27:47 [ DBG] handler_set_fwrule[1667]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:47 [ DBG] handler_set_fwrule[1667]: determine_action: Start update requested.
Dec 17 18:27:47 [ DBG] handler_set_fwrule[1667]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:47 [ DBG] handler_set_fwrule[1667]: Failed to parse rule Device.Firewall.IPv4.Rules.12.
Dec 17 18:27:47 [ DBG] REDIRECT[1679]: Device.Services.Redirect.1.
Dec 17 18:27:47 [ DBG] REDIRECT[1679]: cable - enable: true, old_state: false, new_state: false
Dec 17 18:27:47 [ DBG] REDIRECT[1679]: factory - enable: true, old_state: false, new_state: false
Dec 17 18:27:47 [ DBG] REDIRECT[1679]: connections - enable: true, old_state: true, new_state: false
Dec 17 18:27:47 [ DBG] REDIRECT[1679]: final_state - enable: false, old_state: true, new_state: false
Dec 17 18:27:47 [ DBG] handler_set_fwrule[1679]: determine_action: Enable switch true -> false, set Action = STOP.
Dec 17 18:27:47 [ DBG] handler_set_fwrule[1679]: determine_action: Current status Disabled, set Action = 0.
Dec 17 18:27:47 [ DBG] handler_set_fwrule[1679]: determine_action: Enable switch true -> false, set Action = STOP.
Dec 17 18:27:47 [ DBG] handler_set_fwrule[1679]: determine_action: Current status Disabled, set Action = 0.
Dec 17 18:27:47 [ DBG] handler_set_fwrule[1679]: determine_action: Enable switch true -> false, set Action = STOP.
Dec 17 18:27:47 [ DBG] handler_set_fwrule[1679]: determine_action: Current status Disabled, set Action = 0.
Dec 17 18:27:47 [INFO] anweb[1677]: HTTP main server started on 80,443s port (ports).
Dec 17 18:27:47 [INFO] anweb[1677]: HTTP intercept server started on 81,4445s port (ports).
Dec 17 18:27:47 [INFO] anweb[1677]: SafeDNS intercept server started on 5353,5454s port (ports).
Dec 17 18:27:47 [ DBG] handler_set_fwrule[1679]: determine_action: Enable switch true -> false, set Action = STOP.
Dec 17 18:27:47 [ DBG] handler_set_fwrule[1679]: determine_action: Current status Disabled, set Action = 0.
Dec 17 18:27:47 [ DBG] handler_update_dnsmasq[1679]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:47 [ DBG] delete_dnsmasq_file[1691]: Delete file: /tmp/dnsmasq/dnsmasq36.conf
Dec 17 18:27:47 [ DBG] delete_dnsmasq_file[1691]: Delete file: /tmp/dnsmasq/hosts36.conf
Dec 17 18:27:47 [ DBG] delete_dnsmasq_file[1691]: Delete file: /tmp/dnsmasq/resolv36.conf
Dec 17 18:27:47 [WARN] DNSMASQ_SCRIPT[1695]: Too small arguments
Dec 17 18:27:47 [ DBG] check_diff_args[879]: dnsmasq@36(restart): arguments are equal, nothing to do
Dec 17 18:27:48 [ DBG] handler_mqtt[1703]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:48 [ DBG] handler_mqtt[1703]: determine_action: Start update requested.
Dec 17 18:27:48 [ DBG] handler_mqtt[1703]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:48 [ DBG] handler_snmp[1709]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:48 [ DBG] handler_snmp[1709]: determine_action: nothing to do.
Dec 17 18:27:48 [ DBG] handler_roamd[1710]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:48 [ DBG] handler_roamd[1710]: determine_action: nothing to do.
Dec 17 18:27:48 [ DBG] dwatcher[wrkr][1655]: ROUTE Args: Interface=Device.Network.Interface.Ethernet.2. Origin=Device.Network.Connection.DHCP.2. Src IP=Device.Network.IP.2.IPv4Address.3.  Start=1
Dec 17 18:27:48 [ DBG] handler_update_route[1711]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:48 [ DBG] handler_update_route[1711]: determine_action: Status switch Enabled -> Enabling, set Action = 0.
Dec 17 18:27:48 [ DBG] update_route[1712]: ip route del unspec 0.0.0.0/0 dev eth3 via 10.203.111.1 table 256 metric 410: OK
Dec 17 18:27:48 [ DBG] update_route[1712]: ip route del unspec 0.0.0.0/0 dev eth3 via 10.203.111.1 table 257 metric 410: OK
Dec 17 18:27:48 [ DBG] update_route[1712]: ip route del unspec 0.0.0.0/0 dev eth3 via 10.203.111.1 table 254 metric 410: OK
Dec 17 18:27:48 [ DBG] update_route[1714]: ip route add unspec 0.0.0.0/0 dev eth3 via 10.203.111.1 table 256 metric 410: OK
Dec 17 18:27:48 [ DBG] update_route[1714]: ip route add unspec 0.0.0.0/0 dev eth3 via 10.203.111.1 table 257 metric 410: OK
Dec 17 18:27:48 [ DBG] update_route[1714]: ip route add unspec 0.0.0.0/0 dev eth3 via 10.203.111.1 table 254 metric 410: OK
Dec 17 18:27:48 [ DBG] dwatcher[wrkr][1655]: ROUTE Args: Interface=Device.Network.Interface.Ethernet.2. Origin=Device.Network.Connection.DHCP.2. Src IP=Device.Network.IP.2.IPv4Address.3.  Start=1
Dec 17 18:27:48 [ DBG] dwatcher[wrkr][1655]: GRE ip link = Device.Network.IP.2.IPv4Address.3.
Dec 17 18:27:48 [ DBG] dwatcher[wrkr][1655]: IGMPX: interface Device.Network.Interface.Ethernet.2.
Dec 17 18:27:48 [ DBG] handler_igmpx[1715]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:48 [ DBG] handler_igmpx[1715]: determine_action: Status switch Enabled -> Enabling, set Action = 0.
Dec 17 18:27:48 [INFO] check_group_wan[1655]: The master connection is started
Dec 17 18:27:48 [ DBG] handler_autoupdate[1716]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:48 [ DBG] handler_autoupdate[1716]: determine_action: Start update requested.
Dec 17 18:27:48 [ DBG] handler_autoupdate[1716]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:48 [ DBG] handler_autoprovision[1718]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:48 [ DBG] handler_autoprovision[1718]: determine_action: nothing to do.
Dec 17 18:27:48 [ DBG] dwatcher[wrkr][1655]: PPP* ip link = Device.Network.IP.2.IPv4Address.3.
Dec 17 18:27:48 [ DBG] dwatcher[wrkr][1655]: PPP* ifname = eth3
Dec 17 18:27:48 [ DBG] dwatcher[wrkr][1655]: Check IPsec: IP = 10.203.111.7/24 IP_Link = Device.Network.IP.2.IPv4Address.3., Start 1
Dec 17 18:27:48 [ DBG] handler_iperf3_set[1719]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:48 [ DBG] handler_iperf3_set[1719]: determine_action: nothing to do.
Dec 17 18:27:48 [ DBG] SchedRestartService[1655]: set rule DDNS
Dec 17 18:27:48 [ DBG] SchedRestartService[1655]: set rule DynPortMap
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1720]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1720]: determine_action: Status switch Disabled -> Disabling, set Action = 0.
Dec 17 18:27:48 [ DBG] load_firewall_rule[1720]: Creating |-t filter -I z3to2 3 -p udp -j DROP -m udp --dport 1701|
Dec 17 18:27:48 [ DBG] load_firewall_rule[1720]: Rule #0 LOADED
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1724]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1724]: determine_action: Status switch Disabled -> Disabling, set Action = 0.
Dec 17 18:27:48 [ DBG] load_firewall_rule[1724]: Creating |-t filter -I z3to2 4 -p tcp -j DROP -m tcp --dport 1723|
Dec 17 18:27:48 [ DBG] load_firewall_rule[1724]: Rule #1 LOADED
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1728]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1728]: determine_action: Status switch Disabled -> Disabling, set Action = 0.
Dec 17 18:27:48 [ DBG] load_firewall_rule[1728]: Creating |-t filter -I z3to2 5 -p udp -j DROP -m udp -m multiport --dports 500,4500|
Dec 17 18:27:48 [ DBG] load_firewall_rule[1728]: Rule #2 LOADED
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1732]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1732]: determine_action: nothing to do.
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1733]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1733]: determine_action: nothing to do.
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1734]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1734]: determine_action: nothing to do.
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1735]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1735]: determine_action: nothing to do.
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1736]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1736]: determine_action: nothing to do.
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1737]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1737]: determine_action: Status switch Disabled -> Disabling, set Action = 0.
Dec 17 18:27:48 [ DBG] load_firewall_rule[1737]: Creating |-t filter -I z2to3 3 -j ACCEPT -m iprange  --dst-range 224.0.0.0-239.255.255.255|
Dec 17 18:27:48 [ DBG] load_firewall_rule[1737]: Rule #-9992 LOADED
Dec 17 18:27:48 [ DBG] REDIRECT[1744]: Device.Services.Redirect.1.
Dec 17 18:27:48 [ DBG] REDIRECT[1744]: cable - enable: true, old_state: false, new_state: false
Dec 17 18:27:48 [ DBG] REDIRECT[1744]: factory - enable: true, old_state: false, new_state: false
Dec 17 18:27:48 [ DBG] REDIRECT[1744]: connections - enable: true, old_state: false, new_state: false
Dec 17 18:27:48 [ DBG] REDIRECT[1744]: final_state - enable: false, old_state: false, new_state: false
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1749]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1749]: determine_action: Stop update requested.
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1749]: determine_action: Status switch Enabled -> Disabling, set Action = STOP.
Dec 17 18:27:48 [ DBG] unload_firewall_rule[1749]: Deleting |-t filter -D z2to1 -p igmp -j ACCEPT -m iprange  --dst-range 224.0.0.0-239.255.255.255|
Dec 17 18:27:48 [ DBG] unload_firewall_rule[1749]: Rule #-9991 UNLOADED
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1753]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1753]: determine_action: Status switch Enabled -> Enabling, set Action = 0.
Dec 17 18:27:48 [ DBG] unload_firewall_rule[1753]: Deleting |-t filter -D z3to2 -p udp -j DROP -m udp --dport 1701|
Dec 17 18:27:48 [ DBG] unload_firewall_rule[1753]: Rule #0 UNLOADED
Dec 17 18:27:48 [ DBG] load_firewall_rule[1753]: Creating |-t filter -I z3to2 3 -p udp -j DROP -m udp --dport 1701|
Dec 17 18:27:48 [ DBG] load_firewall_rule[1753]: Rule #0 LOADED
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1753]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1753]: determine_action: Status switch Enabled -> Enabling, set Action = 0.
Dec 17 18:27:48 [ DBG] unload_firewall_rule[1753]: Deleting |-t filter -D z3to2 -p tcp -j DROP -m tcp --dport 1723|
Dec 17 18:27:48 [ DBG] unload_firewall_rule[1753]: Rule #1 UNLOADED
Dec 17 18:27:48 [ DBG] load_firewall_rule[1753]: Creating |-t filter -I z3to2 4 -p tcp -j DROP -m tcp --dport 1723|
Dec 17 18:27:48 [ DBG] load_firewall_rule[1753]: Rule #1 LOADED
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1753]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1753]: determine_action: Status switch Enabled -> Enabling, set Action = 0.
Dec 17 18:27:48 [ DBG] unload_firewall_rule[1753]: Deleting |-t filter -D z3to2 -p udp -j DROP -m udp -m multiport --dports 500,4500|
Dec 17 18:27:48 [ DBG] unload_firewall_rule[1753]: Rule #2 UNLOADED
Dec 17 18:27:48 [ DBG] load_firewall_rule[1753]: Creating |-t filter -I z3to2 5 -p udp -j DROP -m udp -m multiport --dports 500,4500|
Dec 17 18:27:48 [ DBG] load_firewall_rule[1753]: Rule #2 LOADED
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1753]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1753]: determine_action: nothing to do.
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1753]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1753]: determine_action: nothing to do.
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1753]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1753]: determine_action: nothing to do.
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1753]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1753]: determine_action: nothing to do.
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1753]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1753]: determine_action: nothing to do.
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1753]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1753]: determine_action: Status switch Enabled -> Enabling, set Action = 0.
Dec 17 18:27:48 [ DBG] unload_firewall_rule[1753]: Deleting |-t filter -D z2to3 -j ACCEPT -m iprange  --dst-range 224.0.0.0-239.255.255.255|
Dec 17 18:27:48 [ DBG] unload_firewall_rule[1753]: Rule #-9992 UNLOADED
Dec 17 18:27:48 [ DBG] load_firewall_rule[1753]: Creating |-t filter -I z2to3 3 -j ACCEPT -m iprange  --dst-range 224.0.0.0-239.255.255.255|
Dec 17 18:27:48 [ DBG] load_firewall_rule[1753]: Rule #-9992 LOADED
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1753]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1753]: determine_action: Start update requested.
Dec 17 18:27:48 [ DBG] handler_set_fwrule[1753]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:48 [ DBG] load_firewall_rule[1753]: Creating |-t filter -I z2to1 3 -p udp -j ACCEPT -m udp --sport 67 -m udp --dport 68 -s 127.0.0.1/32 -d 10.203.111.7/32|
Dec 17 18:27:49 [ DBG] load_firewall_rule[1753]: Rule #-9989 LOADED
Dec 17 18:27:49 [ DBG] handler_set_fwrule[1753]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:49 [ DBG] handler_set_fwrule[1753]: determine_action: Start update requested.
Dec 17 18:27:49 [ DBG] handler_set_fwrule[1753]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:49 [ DBG] load_firewall_rule[1753]: Creating chain br1_eth3 in table nat
Dec 17 18:27:49 [ DBG] load_firewall_rule[1753]: Creating chain eth3_masq in table nat
Dec 17 18:27:49 [ DBG] set_nat_chain_jump[1753]: Creating: |-t nat -A POSTROUTING -o eth3 -j eth3_masq|
Dec 17 18:27:49 [ DBG] load_firewall_rule[1753]: Creating |-t nat -A eth3_masq -s 192.168.0.1/24 -j br1_eth3|
Dec 17 18:27:49 [ DBG] load_firewall_rule[1753]: Creating |-t nat -A br1_eth3  -j MASQUERADE|
Dec 17 18:27:49 [ DBG] load_firewall_rule[1753]: Rule #10000 LOADED
Dec 17 18:27:49 [ DBG] handler_set_fwrule[1790]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:49 [ DBG] handler_set_fwrule[1790]: determine_action: Stop update requested.
Dec 17 18:27:49 [ DBG] handler_set_fwrule[1790]: determine_action: Status switch Enabled -> Disabling, set Action = STOP.
Dec 17 18:27:49 [ DBG] unload_firewall_rule[1790]: Deleting |-t filter -D z2to1 -p udp -j ACCEPT -m udp --sport 67 -m udp --dport 68 -s 127.0.0.1/32 -d 10.203.111.7/32|
Dec 17 18:27:49 [ DBG] unload_firewall_rule[1790]: Rule #-9989 UNLOADED
Dec 17 18:27:49 [ DBG] handler_set_fwrule[1795]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:49 [ DBG] handler_set_fwrule[1795]: determine_action: Stop update requested.
Dec 17 18:27:49 [ DBG] handler_set_fwrule[1795]: determine_action: Status switch Enabled -> Disabling, set Action = STOP.
Dec 17 18:27:49 [ DBG] set_nat_chain_jump[1795]: Deleting: |-t nat -D POSTROUTING -o eth3 -j eth3_masq|
Dec 17 18:27:49 [ DBG] unload_firewall_rule[1795]: Deleting |-t nat -D eth3_masq -s 192.168.0.1/24 -j br1_eth3|
Dec 17 18:27:49 [ DBG] unload_firewall_rule[1795]: Deleting |-t nat -D br1_eth3  -j MASQUERADE|
Dec 17 18:27:49 [ DBG] unload_firewall_rule[1795]: Rule #10000 UNLOADED
Dec 17 18:27:49 [ DBG] dwatcher[wrkr][1822]: Process action: FirewallRelationChanged
Dec 17 18:27:49 [ DBG] dwatcher[wrkr][1824]: Process action: IpUp
Dec 17 18:27:49 [ DBG] DynPortMap[1825]: could not open lease file: /tmp/miniupnpd/1.lease
Dec 17 18:27:49 [ DBG] handler_telnetd[1829]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:49 [ DBG] handler_telnetd[1829]: determine_action: nothing to do.
Dec 17 18:27:49 [ DBG] handler_update_ssh[1830]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:49 [ DBG] handler_update_ssh[1830]: determine_action: nothing to do.
Dec 17 18:27:49 [ DBG] handler_anweb[1831]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:49 [ DBG] handler_anweb[1831]: determine_action: Status switch Enabled -> Enabling, set Action = 0.
Dec 17 18:27:49 [ DBG] handler_ntp[1832]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:49 [ DBG] handler_ntp[1832]: determine_action: Status switch Enabled -> Enabling, set Action = 0.
Dec 17 18:27:49 [ DBG] handler_ipsec[1836]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:49 [ DBG] handler_ipsec[1836]: determine_action: nothing to do.
Dec 17 18:27:49 [ DBG] handler_tr069[1839]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:49 [ DBG] handler_tr069[1839]: determine_action: Start update requested.
Dec 17 18:27:49 [ DBG] handler_tr069[1839]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:49 [WARN] d_task_update_pidfile[1841]: Another instance is already running: [1669].
Dec 17 18:27:49 [ DBG] handler_set_fwrule[1839]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:49 [ DBG] handler_set_fwrule[1839]: determine_action: Start update requested.
Dec 17 18:27:49 [ DBG] handler_set_fwrule[1839]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:49 [ DBG] handler_set_fwrule[1839]: Failed to parse rule Device.Firewall.IPv4.Rules.12.
Dec 17 18:27:49 [ DBG] handler_mqtt[1843]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:49 [ DBG] handler_mqtt[1843]: determine_action: Status switch Enabled -> Enabling, set Action = 0.
Dec 17 18:27:49 [ DBG] handler_snmp[1844]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:49 [ DBG] handler_snmp[1844]: determine_action: nothing to do.
Dec 17 18:27:49 [ DBG] handler_roamd[1845]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:49 [ DBG] handler_roamd[1845]: determine_action: nothing to do.
Dec 17 18:27:49 [ DBG] dwatcher[wrkr][1824]: ROUTE Args: Interface=Device.Network.Interface.Bridge.1. Origin= Src IP=Device.Network.IP.1.IPv4Address.1.  Start=1
Dec 17 18:27:49 [ DBG] dwatcher[wrkr][1824]: ROUTE Args: Interface=Device.Network.Interface.Bridge.1. Origin= Src IP=Device.Network.IP.1.IPv4Address.1.  Start=1
Dec 17 18:27:49 [ DBG] dwatcher[wrkr][1824]: GRE ip link = Device.Network.IP.1.IPv4Address.1.
Dec 17 18:27:49 [ DBG] dwatcher[wrkr][1824]: IGMPX: interface Device.Network.Interface.Bridge.1.
Dec 17 18:27:49 [ DBG] dwatcher[wrkr][1824]: PPP* ip link = Device.Network.IP.1.IPv4Address.1.
Dec 17 18:27:49 [ DBG] dwatcher[wrkr][1824]: PPP* ifname = br1
Dec 17 18:27:49 [ DBG] dwatcher[wrkr][1824]: Check IPsec: IP = 192.168.0.1/24 IP_Link = Device.Network.IP.1.IPv4Address.1., Start 1
Dec 17 18:27:49 [ DBG] handler_update_samba[1846]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:49 [ DBG] handler_update_samba[1846]: determine_action: nothing to do.
Dec 17 18:27:49 [ DBG] handler_update_samba[1846]: started
Dec 17 18:27:49 [ DBG] handler_update_samba[1846]: set
Dec 17 18:27:49 [ DBG] handler_update_samba[1847]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:49 [ DBG] handler_update_samba[1847]: determine_action: nothing to do.
Dec 17 18:27:49 [ DBG] handler_update_samba[1847]: started
Dec 17 18:27:49 [ DBG] handler_update_samba[1847]: set
Dec 17 18:27:49 [ DBG] handler_update_dlna[1848]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:49 [ DBG] handler_update_dlna[1848]: determine_action: nothing to do.
Dec 17 18:27:49 [ DBG] handler_update_dlna[1848]: started
Dec 17 18:27:49 [ DBG] handler_update_dlna[1848]: set
Dec 17 18:27:49 [ DBG] handler_update_dlna[1849]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:49 [ DBG] handler_update_dlna[1849]: determine_action: nothing to do.
Dec 17 18:27:49 [ DBG] handler_update_dlna[1849]: started
Dec 17 18:27:49 [ DBG] handler_update_dlna[1849]: set
Dec 17 18:27:49 [ DBG] handler_update_xupnpd[1850]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:49 [ DBG] handler_update_xupnpd[1850]: determine_action: nothing to do.
Dec 17 18:27:49 [ DBG] handler_update_xupnpd[1851]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:49 [ DBG] handler_update_xupnpd[1851]: determine_action: nothing to do.
Dec 17 18:27:50 [ DBG] handler_update_transmission[1852]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:50 [ DBG] handler_update_transmission[1852]: determine_action: nothing to do.
Dec 17 18:27:50 [ DBG] handler_iperf3_set[1853]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:50 [ DBG] handler_iperf3_set[1853]: determine_action: nothing to do.
Dec 17 18:27:50 [ DBG] SchedRestartService[1824]: set rule DDNS
Dec 17 18:27:50 [ DBG] SchedRestartService[1824]: set rule DynPortMap
Dec 17 18:27:50 [ DBG] handler_set_fwrule[1854]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:50 [ DBG] handler_set_fwrule[1854]: determine_action: Stop update requested.
Dec 17 18:27:50 [ DBG] handler_set_fwrule[1854]: determine_action: Status switch Enabled -> Disabling, set Action = STOP.
Dec 17 18:27:50 [ DBG] unload_firewall_rule[1854]: Deleting |-t filter -D z3to2 -p udp -j DROP -m udp --dport 1701|
Dec 17 18:27:50 [ DBG] unload_firewall_rule[1854]: Rule #0 UNLOADED
Dec 17 18:27:50 [ DBG] handler_set_fwrule[1858]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:50 [ DBG] handler_set_fwrule[1858]: determine_action: Stop update requested.
Dec 17 18:27:50 [ DBG] handler_set_fwrule[1858]: determine_action: Status switch Enabled -> Disabling, set Action = STOP.
Dec 17 18:27:50 [ DBG] unload_firewall_rule[1858]: Deleting |-t filter -D z3to2 -p tcp -j DROP -m tcp --dport 1723|
Dec 17 18:27:50 [ DBG] unload_firewall_rule[1858]: Rule #1 UNLOADED
Dec 17 18:27:50 [ DBG] handler_set_fwrule[1862]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:50 [ DBG] handler_set_fwrule[1862]: determine_action: Stop update requested.
Dec 17 18:27:50 [ DBG] handler_set_fwrule[1862]: determine_action: Status switch Enabled -> Disabling, set Action = STOP.
Dec 17 18:27:50 [ DBG] unload_firewall_rule[1862]: Deleting |-t filter -D z3to2 -p udp -j DROP -m udp -m multiport --dports 500,4500|
Dec 17 18:27:50 [ DBG] unload_firewall_rule[1862]: Rule #2 UNLOADED
Dec 17 18:27:50 [ DBG] handler_set_fwrule[1866]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:50 [ DBG] handler_set_fwrule[1866]: determine_action: nothing to do.
Dec 17 18:27:50 [ DBG] handler_set_fwrule[1867]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:50 [ DBG] handler_set_fwrule[1867]: determine_action: nothing to do.
Dec 17 18:27:50 [ DBG] handler_set_fwrule[1868]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:50 [ DBG] handler_set_fwrule[1868]: determine_action: nothing to do.
Dec 17 18:27:50 [ DBG] handler_set_fwrule[1869]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:50 [ DBG] handler_set_fwrule[1869]: determine_action: nothing to do.
Dec 17 18:27:50 [ DBG] handler_set_fwrule[1870]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:50 [ DBG] handler_set_fwrule[1870]: determine_action: nothing to do.
Dec 17 18:27:50 [ DBG] handler_set_fwrule[1871]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:50 [ DBG] handler_set_fwrule[1871]: determine_action: Stop update requested.
Dec 17 18:27:50 [ DBG] handler_set_fwrule[1871]: determine_action: Status switch Enabled -> Disabling, set Action = STOP.
Dec 17 18:27:50 [ DBG] unload_firewall_rule[1871]: Deleting |-t filter -D z2to3 -j ACCEPT -m iprange  --dst-range 224.0.0.0-239.255.255.255|
Dec 17 18:27:50 [ DBG] unload_firewall_rule[1871]: Rule #-9992 UNLOADED
Dec 17 18:27:50 [ DBG] handler_set_fwrule[1875]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:50 [ DBG] handler_set_fwrule[1875]: determine_action: Status switch Disabled -> Disabling, set Action = 0.
Dec 17 18:27:50 [ DBG] load_firewall_rule[1875]: Creating |-t filter -I z2to1 3 -p udp -j ACCEPT -m udp --sport 67 -m udp --dport 68 -s 127.0.0.1/32 -d 10.203.111.7/32|
Dec 17 18:27:50 [ DBG] load_firewall_rule[1875]: Rule #-9989 LOADED
Dec 17 18:27:50 [ DBG] handler_set_fwrule[1879]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:50 [ DBG] handler_set_fwrule[1879]: determine_action: Status switch Disabled -> Disabling, set Action = 0.
Dec 17 18:27:50 [ DBG] load_firewall_rule[1879]: Creating chain br1_eth3 in table nat
Dec 17 18:27:50 [ DBG] load_firewall_rule[1879]: Creating chain eth3_masq in table nat
Dec 17 18:27:50 [ DBG] set_nat_chain_jump[1879]: Creating: |-t nat -A POSTROUTING -o eth3 -j eth3_masq|
Dec 17 18:27:50 [ DBG] load_firewall_rule[1879]: Creating |-t nat -A eth3_masq -s 192.168.0.1/24 -j br1_eth3|
Dec 17 18:27:50 [ DBG] load_firewall_rule[1879]: Creating |-t nat -A br1_eth3  -j MASQUERADE|
Dec 17 18:27:50 [ DBG] load_firewall_rule[1879]: Rule #10000 LOADED
Dec 17 18:27:50 [ DBG] handler_update_locdns[1910]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:50 [ DBG] handler_update_locdns[1910]: determine_action: Start update requested.
Dec 17 18:27:50 [ DBG] handler_update_locdns[1910]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:50 [ DBG] handler_update_route[1910]: determine_action: Enable switch false -> true, set Action = START.
Dec 17 18:27:50 [ DBG] handler_update_route[1910]: determine_action: Current status Disabled, set Action = START.
Dec 17 18:27:50 [ DBG] update_route[1911]: ip route add unspec 224.0.0.252 dev br1 static table 257 metric 0: OK
Dec 17 18:27:50 [ DBG] handler_update_tinysvcmdns[1915]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:50 [ DBG] handler_update_tinysvcmdns[1915]: determine_action: Start update requested.
Dec 17 18:27:50 [ DBG] handler_update_tinysvcmdns[1915]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:50 [ DBG] handler_update_route[1915]: determine_action: Enable switch false -> true, set Action = START.
Dec 17 18:27:50 [ DBG] handler_update_route[1915]: determine_action: Current status Disabled, set Action = START.
Dec 17 18:27:50 [ DBG] update_route[1916]: ip route add unspec 224.0.0.251 dev br1 static table 257 metric 0: OK
Dec 17 18:27:51 [ DBG] handler_set_fwrule[1919]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:51 [ DBG] handler_set_fwrule[1919]: determine_action: Start update requested.
Dec 17 18:27:51 [ DBG] handler_set_fwrule[1919]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:51 [ DBG] load_firewall_rule[1919]: Creating |-t filter -I z3to2 3 -p udp -j DROP -m udp --dport 1701|
Dec 17 18:27:51 [ DBG] load_firewall_rule[1919]: Rule #0 LOADED
Dec 17 18:27:51 [ DBG] handler_set_fwrule[1919]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:51 [ DBG] handler_set_fwrule[1919]: determine_action: Start update requested.
Dec 17 18:27:51 [ DBG] handler_set_fwrule[1919]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:51 [ DBG] load_firewall_rule[1919]: Creating |-t filter -I z3to2 4 -p tcp -j DROP -m tcp --dport 1723|
Dec 17 18:27:51 [ DBG] load_firewall_rule[1919]: Rule #1 LOADED
Dec 17 18:27:51 [ DBG] handler_set_fwrule[1919]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:51 [ DBG] handler_set_fwrule[1919]: determine_action: Start update requested.
Dec 17 18:27:51 [ DBG] handler_set_fwrule[1919]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:51 [ DBG] load_firewall_rule[1919]: Creating |-t filter -I z3to2 5 -p udp -j DROP -m udp -m multiport --dports 500,4500|
Dec 17 18:27:51 [ DBG] load_firewall_rule[1919]: Rule #2 LOADED
Dec 17 18:27:51 [ DBG] handler_set_fwrule[1919]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:51 [ DBG] handler_set_fwrule[1919]: determine_action: nothing to do.
Dec 17 18:27:51 [ DBG] handler_set_fwrule[1919]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:51 [ DBG] handler_set_fwrule[1919]: determine_action: nothing to do.
Dec 17 18:27:51 [ DBG] handler_set_fwrule[1919]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:51 [ DBG] handler_set_fwrule[1919]: determine_action: nothing to do.
Dec 17 18:27:51 [ DBG] handler_set_fwrule[1919]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:51 [ DBG] handler_set_fwrule[1919]: determine_action: nothing to do.
Dec 17 18:27:51 [ DBG] handler_set_fwrule[1919]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:51 [ DBG] handler_set_fwrule[1919]: determine_action: nothing to do.
Dec 17 18:27:51 [ DBG] handler_set_fwrule[1919]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:51 [ DBG] handler_set_fwrule[1919]: determine_action: Start update requested.
Dec 17 18:27:51 [ DBG] handler_set_fwrule[1919]: determine_action: Status switch Disabled -> Enabling, s
et Action = START.
Dec 17 18:27:51 [ DBG] load_firewall_rule[1919]: Creating |-t filter -I z2to3 3 -j ACCEPT -m iprange  --dst-range 224.0.0.0-239.255.255.255|
Dec 17 18:27:51 [ DBG] load_firewall_rule[1919]: Rule #-9992 LOADED
Dec 17 18:27:51 [ DBG] handler_set_fwrule[1919]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:51 [ DBG] handler_set_fwrule[1919]: determine_action: Start update requested.
Dec 17 18:27:51 [ DBG] handler_set_fwrule[1919]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:51 [ DBG] load_firewall_rule[1919]: Creating |-t filter -I z2to1 3 -p igmp -j ACCEPT -m iprange  --dst-range 224.0.0.0-239.255.255.255|
Dec 17 18:27:51 [ DBG] load_firewall_rule[1919]: Rule #-9991 LOADED
Dec 17 18:27:51 [ DBG] handler_set_fwrule[1919]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:51 [ DBG] handler_set_fwrule[1919]: determine_action: Status switch Enabled -> Enabling, set Action = 0.
Dec 17 18:27:51 [ DBG] unload_firewall_rule[1919]: Deleting |-t filter -D z2to1 -p udp -j ACCEPT -m udp --sport 67 -m udp --dport 68 -s 127.0.0.1/32 -d 10.203.111.7/32|
Dec 17 18:27:51 [ DBG] unload_firewall_rule[1919]: Rule #-9989 UNLOADED
Dec 17 18:27:51 [ DBG] load_firewall_rule[1919]: Creating |-t filter -I z2to1 4 -p udp -j ACCEPT -m udp --sport 67 -m udp --dport 68 -s 127.0.0.1/32 -d 10.203.111.7/32|
Dec 17 18:27:51 [ DBG] load_firewall_rule[1919]: Rule #-9989 LOADED
Dec 17 18:27:51 [ DBG] handler_set_fwrule[1919]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:51 [ DBG] handler_set_fwrule[1919]: determine_action: Status switch Enabled -> Enabling, set Action = 0.
Dec 17 18:27:51 [ DBG] set_nat_chain_jump[1919]: Deleting: |-t nat -D POSTROUTING -o eth3 -j eth3_masq|
Dec 17 18:27:51 [ DBG] unload_firewall_rule[1919]: Deleting |-t nat -D eth3_masq -s 192.168.0.1/24 -j br1_eth3|
Dec 17 18:27:51 [ DBG] unload_firewall_rule[1919]: Deleting |-t nat -D br1_eth3  -j MASQUERADE|
Dec 17 18:27:51 [ DBG] unload_firewall_rule[1919]: Rule #10000 UNLOADED
Dec 17 18:27:51 [ DBG] load_firewall_rule[1919]: Creating chain br1_eth3 in table nat
Dec 17 18:27:51 [ DBG] load_firewall_rule[1919]: Creating chain eth3_masq in table nat
Dec 17 18:27:51 [ DBG] set_nat_chain_jump[1919]: Creating: |-t nat -A POSTROUTING -o eth3 -j eth3_masq|
Dec 17 18:27:51 [ DBG] load_firewall_rule[1919]: Creating |-t nat -A eth3_masq -s 192.168.0.1/24 -j br1_eth3|
Dec 17 18:27:51 [ DBG] load_firewall_rule[1919]: Creating |-t nat -A br1_eth3  -j MASQUERADE|
Dec 17 18:27:51 [ DBG] load_firewall_rule[1919]: Rule #10000 LOADED
Dec 17 18:27:51 [ DBG] handler_update_dnsmasq[1958]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:51 [ DBG] handler_update_dnsmasq[1958]: determine_action: Status switch Enabled -> Enabling, set Action = 0.
Dec 17 18:27:51 [ DBG] dnsmasq_action[1958]: Not equal old:Enabled new:Enabling
Dec 17 18:27:51 [ DBG] dnsmasq_action[1958]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:51 [ DBG] dnsmasq_action[1958]: determine_action: Status switch Enabled -> Enabling, set Action = 0.
Dec 17 18:27:51 [ DBG] check_diff_args[879]: dnsmasq@36(restart): arguments are equal, nothing to do
Dec 17 18:27:51 [ DBG] check_diff_args[879]: dnsmasq@36(restart): arguments are equal, nothing to do
Dec 17 18:27:51 [ DBG] dwatcher[wrkr][1963]: Process action: RuleUp
Dec 17 18:27:51 [ DBG] dwatcher[wrkr][1964]: Process action: RuleUp
Dec 17 18:27:51 [ DBG] dwatcher[wrkr][1965]: Process action: DnsmasqUp
Dec 17 18:27:51 [ DBG] dwatcher[wrkr][1966]: Process action: RestartService
Dec 17 18:27:51 [ DBG] DynPortMap[1967]: could not open lease file: /tmp/miniupnpd/1.lease
Dec 17 18:27:51 [ DBG] process_restart_service[1966]: Device.Services.DynamicPortMapping. is multiinstance, getting all instances
Dec 17 18:27:51 [ DBG] process_restart_service[1966]: Restart Service: Device.Services.DynamicPortMapping.1.
Dec 17 18:27:51 [ DBG] handler_update_dynportmap[1968]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:51 [ DBG] handler_update_dynportmap[1968]: determine_action: Start update requested.
Dec 17 18:27:51 [ DBG] handler_update_dynportmap[1968]: determine_action: Status switch Disabled -> Enabling, set Action = START.
Dec 17 18:27:51 [ DBG] DynPortMap[1968]: WANGroup set, auto mode
Dec 17 18:27:51 [ DBG] DynPortMap[1968]: Checking other instances.
Dec 17 18:27:51 [ DBG] load_firewall_rule[1968]: Creating chain MINIUPNPD1 in table filter
Dec 17 18:27:51 [ DBG] load_firewall_rule[1968]: Creating chain MINIUPNPD1 in table nat
Dec 17 18:27:51 [ DBG] load_firewall_rule[1968]: Creating chain POSTROUTING-MINIUPNPD1 in table nat
Dec 17 18:27:51 [ DBG] load_firewall_rule[1968]: Creating |-t filter -I z2to3 3 -i eth3 -o br1 -j MINIUPNPD1|
Dec 17 18:27:51 [ DBG] load_firewall_rule[1968]: Creating |-t nat -I PREROUTING 1 -i eth3 -j MINIUPNPD1|
Dec 17 18:27:51 [ DBG] load_firewall_rule[1968]: Creating |-t nat -I POSTROUTING 1 -o eth3 -j POSTROUTING-MINIUPNPD1|
Dec 17 18:27:51 [ DBG] load_firewall_rule[1968]: Rule #-10001 LOADED
Dec 17 18:27:51 [ DBG] dwatcher[wrkr][1978]: Process action: RestartService
Dec 17 18:27:51 [ DBG] process_restart_service[1978]: Device.Services.DDNS.Instances. is multiinstance, getting all instances
Dec 17 18:27:51 [ DBG] process_restart_service[1978]: Device.Services.DDNS.Instances. is empty, skip
Dec 17 18:27:51 [ DBG] dwatcher[wrkr][1982]: Process action: RouteUp
Dec 17 18:27:51 [ DBG] dwatcher[wrkr][1982]: PPP* ip link = Device.Routing.IPv4.Routes.9.
Dec 17 18:27:51 [ DBG] dwatcher[wrkr][1982]: PPP* ifname = eth3
Dec 17 18:27:51 [ DBG] dwatcher[wrkr][1987]: Process action: FirewallRelationChanged
Dec 17 18:27:51 [NOTE] miniupnpd[1989]: HTTP listening on port 38245
Dec 17 18:27:51 [NOTE] miniupnpd[1989]: Listening for NAT-PMP/PCP traffic on port 5351
Dec 17 18:27:51 [ DBG] dwatcher[wrkr][1990]: Process action: FirewallRelationChanged
Dec 17 18:27:51 [ DBG] dwatcher[wrkr][1992]: Process action: FirewallRelationChanged
Dec 17 18:27:51 [ DBG] dwatcher[wrkr][1994]: Process action: DnsUpdate
Dec 17 18:27:51 [ DBG] d_addr_is_subnet_addr_mask[1994]: 10.203.111.7 and 10.0.0.2 belong to different subnets
Dec 17 18:27:51 [ DBG] d_addr_is_subnet_addr_mask[1994]: 10.203.111.7 and 10.0.0.3 belong to different subnets
Dec 17 18:27:51 [ DBG] handler_update_route[2001]: determine_action: Enable switch false -> true, set Action = START.
Dec 17 18:27:51 [ DBG] handler_update_route[2001]: determine_action: Current status Disabled, set Action = START.
Dec 17 18:27:51 [ DBG] update_route[2002]: ip route add unspec 10.0.0.2 dev eth3 via 10.203.111.1 static table 257 metric 0: OK
Dec 17 18:27:51 [ DBG] update_route[2002]: ip route add unspec 10.0.0.2 dev eth3 via 10.203.111.1 static table 254 metric 0: OK
Dec 17 18:27:51 [ DBG] handler_update_route[2001]: determine_action: Enable switch false -> true, set Action = START.
Dec 17 18:27:51 [ DBG] handler_update_route[2001]: determine_action: Current status Disabled, set Action = START.
Dec 17 18:27:51 [ DBG] update_route[2003]: ip route add unspec 10.0.0.3 dev eth3 via 10.203.111.1 static table 257 metric 0: OK
Dec 17 18:27:51 [ DBG] update_route[2003]: ip route add unspec 10.0.0.3 dev eth3 via 10.203.111.1 static table 254 metric 0: OK
Dec 17 18:27:51 [ DBG] dwatcher[wrkr][2004]: Process action: ConnectionStatusChanged
Dec 17 18:27:52 [ DBG] DynPortMap[2005]: could not open lease file: /tmp/miniupnpd/1.lease
Dec 17 18:27:52 [NOTE] check_ntp[2004]: WAN connection [Device.Network.Connection.DHCP.2.] was up => update ntp-client
Dec 17 18:27:52 [ DBG] dwatcher[wrkr][2008]: Process action: FirewallRelationChanged
Dec 17 18:27:52 [ DBG] dwatcher[wrkr][2010]: Process action: RestartService
Dec 17 18:27:52 [ DBG] DynPortMap[2011]: could not open lease file: /tmp/miniupnpd/1.lease
Dec 17 18:27:52 [ DBG] process_restart_service[2010]: Device.Services.DynamicPortMapping. is multiinstance, getting all instances
Dec 17 18:27:52 [ DBG] process_restart_service[2010]: Restart Service: Device.Services.DynamicPortMapping.1.
Dec 17 18:27:52 [ DBG] handler_update_dynportmap[2012]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:52 [ DBG] handler_update_dynportmap[2012]: determine_action: Status switch Enabled -> Enabling, set Action = 0.
Dec 17 18:27:52 [ DBG] DynPortMap[2012]: WANGroup set, auto mode
Dec 17 18:27:52 [ DBG] DynPortMap[2012]: Checking other instances.
Dec 17 18:27:52 [ DBG] check_diff_args[879]: miniupnpd@48(restart): arguments are equal, nothing to do
Dec 17 18:27:52 [ DBG] dwatcher[wrkr][2013]: Process action: RestartService
Dec 17 18:27:52 [ DBG] process_restart_service[2013]: Device.Services.DDNS.Instances. is multiinstance, getting all instances
Dec 17 18:27:52 [ DBG] process_restart_service[2013]: Device.Services.DDNS.Instances. is empty, skip
Dec 17 18:27:52 [ DBG] dwatcher[wrkr][2015]: Process action: DnsmasqDown
Dec 17 18:27:52 [ DBG] dwatcher[wrkr][2016]: Process action: DnsmasqUp
Dec 17 18:27:52 [ DBG] dwatcher[wrkr][2017]: Process action: RouteDown
Dec 17 18:27:52 [ DBG] dwatcher[wrkr][2017]: PPP* ip link = Device.Routing.IPv4.Routes.9.
Dec 17 18:27:52 [ DBG] dwatcher[wrkr][2017]: PPP* ifname = eth3
Dec 17 18:27:52 [ DBG] dwatcher[wrkr][2019]: Process action: RouteUp
Dec 17 18:27:52 [ DBG] dwatcher[wrkr][2019]: PPP* ip link = Device.Routing.IPv4.Routes.9.
Dec 17 18:27:52 [ DBG] dwatcher[wrkr][2019]: PPP* ifname = eth3
Dec 17 18:27:52 [ DBG] dwatcher[wrkr][2022]: Process action: FirewallRelationChanged
Dec 17 18:27:52 [ DBG] dwatcher[wrkr][2024]: Process action: FirewallRelationChanged
Dec 17 18:27:52 [ DBG] dwatcher[wrkr][2026]: Process action: FirewallRelationChanged
Dec 17 18:27:52 [ DBG] dwatcher[wrkr][2028]: Process action: FirewallRelationChanged
Dec 17 18:27:52 [ DBG] dwatcher[wrkr][2030]: Process action: FirewallRelationChanged
Dec 17 18:27:52 [ DBG] dwatcher[wrkr][2032]: Process action: FirewallRelationChanged
Dec 17 18:27:52 [ DBG] dwatcher[wrkr][2034]: Process action: RestartService
Dec 17 18:27:52 [ DBG] DynPortMap[2035]: could not open lease file: /tmp/miniupnpd/1.lease
Dec 17 18:27:52 [ DBG] process_restart_service[2034]: Device.Services.DynamicPortMapping. is multiinstance, getting all instances
Dec 17 18:27:52 [ DBG] process_restart_service[2034]: Restart Service: Device.Services.DynamicPortMapping.1.
Dec 17 18:27:52 [ DBG] handler_update_dynportmap[2036]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:52 [ DBG] handler_update_dynportmap[2036]: determine_action: Status switch Enabled -> Enabling, set Action = 0.
Dec 17 18:27:52 [ DBG] DynPortMap[2036]: WANGroup set, auto mode
Dec 17 18:27:52 [ DBG] DynPortMap[2036]: Checking other instances.
Dec 17 18:27:52 [ DBG] check_diff_args[879]: miniupnpd@48(restart): arguments are equal, nothing to do
Dec 17 18:27:52 [ DBG] dwatcher[wrkr][2037]: Process action: RestartService
Dec 17 18:27:52 [ DBG] process_restart_service[2037]: Device.Services.DDNS.Instances. is multiinstance, getting all instances
Dec 17 18:27:52 [ DBG] process_restart_service[2037]: Device.Services.DDNS.Instances. is empty, skip
Dec 17 18:27:52 [ DBG] dwatcher[wrkr][2039]: Process action: FirewallRelationChanged
Dec 17 18:27:52 [ DBG] dwatcher[wrkr][2041]: Process action: FirewallRelationChanged
Dec 17 18:27:52 [ DBG] dwatcher[wrkr][2043]: Process action: RouteUp
Dec 17 18:27:52 [ DBG] dwatcher[wrkr][2045]: Process action: RouteUp
Dec 17 18:27:52 [ DBG] dwatcher[wrkr][2047]: Process action: FirewallRelationChanged
Dec 17 18:27:52 [ DBG] dwatcher[wrkr][2049]: Process action: RestartService
Dec 17 18:27:52 [ DBG] DynPortMap[2050]: could not open lease file: /tmp/miniupnpd/1.lease
Dec 17 18:27:52 [ DBG] process_restart_service[2049]: Device.Services.DynamicPortMapping. is multiinstance, getting all instances
Dec 17 18:27:52 [ DBG] process_restart_service[2049]: Restart Service: Device.Services.DynamicPortMapping.1.
Dec 17 18:27:52 [ DBG] handler_update_dynportmap[2051]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:52 [ DBG] handler_update_dynportmap[2051]: determine_action: Status switch Enabled -> Enabling, set Action = 0.
Dec 17 18:27:52 [ DBG] DynPortMap[2051]: WANGroup set, auto mode
Dec 17 18:27:52 [ DBG] DynPortMap[2051]: Checking other instances.
Dec 17 18:27:52 [ DBG] check_diff_args[879]: miniupnpd@48(restart): arguments are equal, nothing to do
Dec 17 18:27:52 [ DBG] dwatcher[wrkr][2052]: Process action: RestartService
Dec 17 18:27:52 [ DBG] process_restart_service[2052]: Device.Services.DDNS.Instances. is multiinstance, getting all instances
Dec 17 18:27:52 [ DBG] process_restart_service[2052]: Device.Services.DDNS.Instances. is empty, skip
Dec 17 18:27:52 [ DBG] dwatcher[wrkr][2054]: Process action: DnsmasqReload
Dec 17 18:27:52 [ DBG] dwatcher[wrkr][2055]: Process action: RouteUp
Dec 17 18:27:52 [ DBG] dwatcher[wrkr][2057]: Process action: RouteUp
Dec 17 18:27:53 [ DBG] REDIRECT[2063]: Device.Services.Redirect.1.
Dec 17 18:27:53 [ DBG] REDIRECT[2063]: cable - enable: true, old_state: false, new_state: false
Dec 17 18:27:53 [ DBG] REDIRECT[2063]: factory - enable: true, old_state: false, new_state: false
Dec 17 18:27:53 [ DBG] REDIRECT[2063]: connections - enable: true, old_state: false, new_state: false
Dec 17 18:27:53 [ DBG] REDIRECT[2063]: final_state - enable: false, old_state: false, new_state: false
Dec 17 18:27:53 [ DBG] AUTOUPDATE[2061]: Autoupdate check starting, server: 'http://fwupdate.dlink.ru' with profile 'DIR_853_MT7621AT'
Dec 17 18:27:53 [ DBG] handler_set_fwrule[2068]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:53 [ DBG] handler_set_fwrule[2068]: determine_action: Status switch Enabled -> Enabling, set Action = 0.
Dec 17 18:27:53 [ DBG] unload_firewall_rule[2068]: Deleting |-t filter -D z3to2 -p udp -j DROP -m udp --dport 1701|
Dec 17 18:27:53 [ DBG] AUTOUPDATE[2061]: No excludes for current version
Dec 17 18:27:53 [ DBG] unload_firewall_rule[2068]: Rule #0 UNLOADED
Dec 17 18:27:53 [ DBG] load_firewall_rule[2068]: Creating |-t filter -I z3to2 3 -p udp -j DROP -m udp --dport 1701|
Dec 17 18:27:53 [INFO] AUTOUPDATE[2061]: Firmware name: '2019.03.22-15.38_DIR_853_MT7621AT_3.5.2_release'
Dec 17 18:27:53 [ DBG] load_firewall_rule[2068]: Rule #0 LOADED
Dec 17 18:27:53 [ DBG] handler_set_fwrule[2068]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:53 [ DBG] handler_set_fwrule[2068]: determine_action: Status switch Enabled -> Enabling, set Action = 0.
Dec 17 18:27:53 [ DBG] unload_firewall_rule[2068]: Deleting |-t filter -D z3to2 -p tcp -j DROP -m tcp --dport 1723|
Dec 17 18:27:53 [NOTE] AUTOUPDATE[2061]: This is a latest version
Dec 17 18:27:53 [ DBG] unload_firewall_rule[2068]: Rule #1 UNLOADED
Dec 17 18:27:53 [ DBG] load_firewall_rule[2068]: Creating |-t filter -I z3to2 4 -p tcp -j DROP -m tcp --dport 1723|
Dec 17 18:27:53 [ DBG] load_firewall_rule[2068]: Rule #1 LOADED
Dec 17 18:27:53 [ DBG] handler_set_fwrule[2068]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:53 [ DBG] handler_set_fwrule[2068]: determine_action: Status switch Enabled -> Enabling, set Action = 0.
Dec 17 18:27:53 [ DBG] unload_firewall_rule[2068]: Deleting |-t filter -D z3to2 -p udp -j DROP -m udp -m multiport --dports 500,4500|
Dec 17 18:27:53 [ DBG] unload_firewall_rule[2068]: Rule #2 UNLOADED
Dec 17 18:27:53 [ DBG] load_firewall_rule[2068]: Creating |-t filter -I z3to2 5 -p udp -j DROP -m udp -m multiport --dports 500,4500|
Dec 17 18:27:53 [ DBG] load_firewall_rule[2068]: Rule #2 LOADED
Dec 17 18:27:53 [ DBG] handler_set_fwrule[2068]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:53 [ DBG] handler_set_fwrule[2068]: determine_action: nothing to do.
Dec 17 18:27:53 [ DBG] handler_set_fwrule[2068]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:53 [ DBG] handler_set_fwrule[2068]: determine_action: nothing to do.
Dec 17 18:27:53 [ DBG] handler_set_fwrule[2068]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:53 [ DBG] handler_set_fwrule[2068]: determine_action: nothing to do.
Dec 17 18:27:53 [ DBG] handler_set_fwrule[2068]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:53 [ DBG] handler_set_fwrule[2068]: determine_action: nothing to do.
Dec 17 18:27:53 [ DBG] handler_set_fwrule[2068]: determine_action: Enable false, set Action = 0.
Dec 17 18:27:53 [ DBG] handler_set_fwrule[2068]: determine_action: nothing to do.
Dec 17 18:27:53 [ DBG] handler_set_fwrule[2068]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:53 [ DBG] handler_set_fwrule[2068]: determine_action: Status switch Enabled -> Enabling, set Action = 0.
Dec 17 18:27:53 [ DBG] unload_firewall_rule[2068]: Deleting |-t filter -D z2to3 -j ACCEPT -m iprange  --dst-range 224.0.0.0-239.255.255.255|
Dec 17 18:27:53 [ DBG] unload_firewall_rule[2068]: Rule #-9992 UNLOADED
Dec 17 18:27:53 [ DBG] dwatcher[wrkr][2089]: Process action: FirewallRelationChanged
Dec 17 18:27:53 [ DBG] load_firewall_rule[2068]: Creating |-t filter -I z2to3 4 -j ACCEPT -m iprange  --dst-range 224.0.0.0-239.255.255.255|
Dec 17 18:27:53 [ DBG] load_firewall_rule[2068]: Rule #-9992 LOADED
Dec 17 18:27:53 [ DBG] handler_set_fwrule[2068]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:53 [ DBG] handler_set_fwrule[2068]: determine_action: Status switch Enabled -> Enabling, set Action = 0.
Dec 17 18:27:53 [ DBG] unload_firewall_rule[2068]: Deleting |-t filter -D z2to1 -p udp -j ACCEPT -m udp --sport 67 -m udp --dport 68 -s 127.0.0.1/32 -d 10.203.111.7/32|
Dec 17 18:27:53 [ DBG] unload_firewall_rule[2068]: Rule #-9989 UNLOADED
Dec 17 18:27:53 [ DBG] load_firewall_rule[2068]: Creating |-t filter -I z2to1 4 -p udp -j ACCEPT -m udp --sport 67 -m udp --dport 68 -s 127.0.0.1/32 -d 10.203.111.7/32|
Dec 17 18:27:53 [ DBG] load_firewall_rule[2068]: Rule #-9989 LOADED
Dec 17 18:27:53 [ DBG] handler_set_fwrule[2068]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:53 [ DBG] handler_set_fwrule[2068]: determine_action: Status switch Enabled -> Enabling, set Action = 0.
Dec 17 18:27:54 [ DBG] set_nat_chain_jump[2068]: Deleting: |-t nat -D POSTROUTING -o eth3 -j eth3_masq|
Dec 17 18:27:54 [ DBG] unload_firewall_rule[2068]: Deleting |-t nat -D eth3_masq -s 192.168.0.1/24 -j br1_eth3|
Dec 17 18:27:54 [ DBG] unload_firewall_rule[2068]: Deleting |-t nat -D br1_eth3  -j MASQUERADE|
Dec 17 18:27:54 [ DBG] unload_firewall_rule[2068]: Rule #10000 UNLOADED
Dec 17 18:27:54 [ DBG] load_firewall_rule[2068]: Creating chain br1_eth3 in table nat
Dec 17 18:27:54 [ DBG] load_firewall_rule[2068]: Creating chain eth3_masq in table nat
Dec 17 18:27:54 [ DBG] set_nat_chain_jump[2068]: Creating: |-t nat -A POSTROUTING -o eth3 -j eth3_masq|
Dec 17 18:27:54 [ DBG] load_firewall_rule[2068]: Creating |-t nat -A eth3_masq -s 192.168.0.1/24 -j br1_eth3|
Dec 17 18:27:54 [ DBG] load_firewall_rule[2068]: Creating |-t nat -A br1_eth3  -j MASQUERADE|
Dec 17 18:27:54 [ DBG] load_firewall_rule[2068]: Rule #10000 LOADED
Dec 17 18:27:54 [ DBG] handler_set_fwrule[2068]: determine_action: Enable true, set Action = STOP | START.
Dec 17 18:27:54 [ DBG] handler_set_fwrule[2068]: determine_action: Status switch Enabled -> Enabling, set Action = 0.
Dec 17 18:27:54 [ DBG] unload_firewall_rule[2068]: Deleting |-t filter -D z2to1 -p igmp -j ACCEPT -m iprange  --dst-range 224.0.0.0-239.255.255.255|
Dec 17 18:27:54 [ DBG] unload_firewall_rule[2068]: Rule #-9991 UNLOADED
Dec 17 18:27:54 [ DBG] load_firewall_rule[2068]: Creating |-t filter -I z2to1 3 -p igmp -j ACCEPT -m iprange  --dst-range 224.0.0.0-239.255.255.255|
Dec 17 18:27:54 [ DBG] load_firewall_rule[2068]: Rule #-9991 LOADED
Dec 17 18:27:54 [ DBG] dwatcher[wrkr][2125]: Process action: FirewallRelationChanged
Mar 31 22:52:29 [NOTE] NTP[2127]: The system time is synchronized: [2022/03/31 22:52:29]
Mar 31 22:52:30 [ DBG] dwatcher[wrkr][2129]: Process action: NTPSynced
Mar 31 22:53:15 [WARN] kernel: Receive ASSOC: (f4:60:e2:e3:ea:ce) --> rax0 (DIR-853-296C)
Mar 31 22:53:15 [ ERR] kernel: [DLINK_VENDOR_CHECK] STA associated.
Mar 31 22:53:15 [ ERR] kernel: [DLINK_VENDOR_CHECK] STA authorized.
Mar 31 22:53:19 [ DBG] module_update_dnsmasq[2135]: ACTION: 4
Mar 31 22:53:19 [ DBG] module_update_dnsmasq[2135]: IP: 192.168.0.141
Mar 31 22:53:19 [ DBG] module_update_dnsmasq[2135]: MAC: f4:60:e2:e3:ea:ce
Mar 31 22:53:19 [ DBG] module_update_dnsmasq[2135]: Iface: br1
Mar 31 22:53:19 [ DBG] module_update_dnsmasq[2135]: Giaddr: 
Mar 31 22:53:19 [ DBG] module_update_dnsmasq[2135]: Time expires: 1648842799
Mar 31 22:53:19 [ DBG] module_update_dnsmasq[2135]: Time remaining: 86400
Mar 31 22:53:19 [ DBG] module_update_dnsmasq[2135]: Hostname: POCOPHONEF1-POCOPHON
Mar 31 22:53:19 [ DBG] module_update_dnsmasq[2135]: Client ID: 01:f4:60:e2:e3:ea:ce
Mar 31 22:53:19 [ DBG] module_update_dnsmasq[2135]: Vendor class ID: android-dhcp-10
Mar 31 22:53:19 [INFO] igmpx[1455]: leave group 224.0.0.251 from 192.168.0.141
Mar 31 22:53:19 [ DBG] dwatcher[wrkr][2142]: Process action: HostnameChanged
Mar 31 22:53:19 [INFO] igmpx[1455]: leave group 224.0.0.251 from 192.168.0.141
Mar 31 22:53:24 [NOTE] AUTH[879]: Attempt to proceed a RPC with invalid token: 8cb7aade-0220-44d0-ae9a-a3f8ab155d6e
Mar 31 22:53:24 [NOTE] AUTH[879]: Attempt to proceed a RPC with invalid token: 8cb7aade-0220-44d0-ae9a-a3f8ab155d6e
Mar 31 22:53:24 [NOTE] [AUTH][879]: Authentication failure: login='admin', access denied
Mar 31 22:53:32 [NOTE] [AUTH][879]: User 'admin' successfully logged in
Mar 31 22:58:34 [NOTE] AUTH[879]: Attempt to proceed a RPC with invalid token: 460e4719-093f-4d8c-bb8c-cb60994b6e2d
Mar 31 22:58:34 [NOTE] AUTH[879]: Attempt to proceed a RPC with invalid token: 460e4719-093f-4d8c-bb8c-cb60994b6e2d
Mar 31 23:03:34 [NOTE] AUTH[879]: Attempt to proceed a RPC with invalid token: 718cc8c8-793d-41a3-8cf9-1e608096a2ef
Mar 31 23:04:15 [WARN] kernel: Receive DeAUTH: (f4:60:e2:e3:ea:ce) reason=3
Mar 31 23:04:15 [ ERR] kernel: [DLINK_VENDOR_CHECK] STA DE-AUTH.
Mar 31 23:04:35 [WARN] kernel: Receive ASSOC: (f4:60:e2:e3:ea:ce) --> rax0 (DIR-853-296C)
Mar 31 23:04:35 [ ERR] kernel: [DLINK_VENDOR_CHECK] STA associated.
Mar 31 23:04:35 [ ERR] kernel: [DLINK_VENDOR_CHECK] STA authorized.
Mar 31 23:04:35 [ DBG] module_update_dnsmasq[3249]: ACTION: 2
Mar 31 23:04:35 [ DBG] module_update_dnsmasq[3249]: IP: 192.168.0.141
Mar 31 23:04:35 [ DBG] module_update_dnsmasq[3249]: MAC: f4:60:e2:e3:ea:ce
Mar 31 23:04:35 [ DBG] module_update_dnsmasq[3249]: Iface: br1
Mar 31 23:04:35 [ DBG] module_update_dnsmasq[3249]: Giaddr: 
Mar 31 23:04:35 [ DBG] module_update_dnsmasq[3249]: Time expires: 1648843475
Mar 31 23:04:35 [ DBG] module_update_dnsmasq[3249]: Time remaining: 86400
Mar 31 23:04:35 [ DBG] module_update_dnsmasq[3249]: Hostname: POCOPHONEF1-POCOPHON
Mar 31 23:04:35 [ DBG] module_update_dnsmasq[3249]: Client ID: 01:f4:60:e2:e3:ea:ce
Mar 31 23:04:35 [ DBG] module_update_dnsmasq[3249]: Vendor class ID: android-dhcp-10
Mar 31 23:04:36 [INFO] igmpx[1455]: leave group 224.0.0.251 from 192.168.0.141
Mar 31 23:04:36 [INFO] igmpx[1455]: leave group 224.0.0.251 from 192.168.0.141
Mar 31 23:08:35 [NOTE] AUTH[879]: Attempt to proceed a RPC with invalid token: 888f9699-6ad2-4209-ae1e-70854c79bb6e
Mar 31 23:17:25 [NOTE] AUTH[879]: Attempt to proceed a RPC with invalid token: 8f8a1985-0ee1-4732-ade7-9607f12eb124
Mar 31 23:17:25 [NOTE] AUTH[879]: Attempt to proceed a RPC with invalid token: 8f8a1985-0ee1-4732-ade7-9607f12eb124
Mar 31 23:17:25 [NOTE] AUTH[879]: Attempt to proceed a RPC with invalid token: 8f8a1985-0ee1-4732-ade7-9607f12eb124