Jan 1 00:00:12 syslogd started: BusyBox v1.19.2
Jan 1 00:00:12 init_lan[95]: start
Jan 1 00:00:12 init_lan[95]: no grouping style
Jan 1 00:00:12 init_lan[95]: iface br0
Jan 1 00:00:12 config_bridge[95]: iface br0 ip 192.168.0.1 255.255.255.0
Jan 1 00:00:12 kernel: et_module_init: passivemode set to 0x0
Jan 1 00:00:12 kernel: et_module_init: et_txq_thresh set to 0x0
Jan 1 00:00:12 kernel: PCI: Setting latency timer of device 0000:00:02.0 to 64
Jan 1 00:00:12 kernel: set et_ctfpool_fastrecycle
Jan 1 00:00:12 kernel: ET_ALL_PASSIVE is defined
Jan 1 00:00:12 kernel: ET_ALL_PASSIVE_ENAB: 0
Jan 1 00:00:12 kernel: eth0: Broadcom BCM47XX 10/100/1000 Mbps Ethernet Controller 5.100.138.2205
Jan 1 00:00:13 resident[95]: init wan
Jan 1 00:00:13 kernel: wan1: del 01:00:5e:00:00:01 mcast address from vlan interface
Jan 1 00:00:13 kernel: wan1: del 01:00:5e:00:00:01 mcast address from master interface
Jan 1 00:00:13 kernel: wan1: Setting MAC address to cc b2 55 fe 60 7d.
Jan 1 00:00:13 kernel: wan1: add 01:00:5e:00:00:01 mcast address to master interface
Jan 1 00:00:13 resident[95]: start ipoe
Jan 1 00:00:13 start_ip[95]: begin (wan1 -> wan1_4)
Jan 1 00:00:13 resident[95]: start ipoe (v0) on wan1
Jan 1 00:00:13 DEBUG[95]: Enter global PASSSRU
Jan 1 00:00:13 udhcpc[225]: UDHCP start..
Jan 1 00:00:13 udhcpc[225]: udhcp client (v0.9.

started (iface: wan1, connect: 4)
Jan 1 00:00:13 udhcpc[225]: interface wan1 index 7
Jan 1 00:00:13 udhcpc[225]: interface wan1 hwaddr cc:b2:55:fe:60:7d
Jan 1 00:00:13 udhcpc[225]: interface wan1 mtu is 1500
Jan 1 00:00:13 udhcpc[228]: execle'ing /tmp/udhcpc with name deconfig
Jan 1 00:00:13 event[228]: send event "ipoe down"
Jan 1 00:00:13 udhcpc[225]: Opening raw socket on ifindex 7
Jan 1 00:00:13 update_ddns[95]: start
Jan 1 00:00:13 dms_srv_httpd_start[95]: start
Jan 1 00:00:13 udhcpc[225]: Sending discover...
Jan 1 00:00:13 telnet-start[95]: begin...
Jan 1 00:00:13 telnet-start[95]: running on 23 port
Jan 1 00:00:13 telnet-start[95]: succes!
Jan 1 00:00:13 tr069-start[95]: begin...
Jan 1 00:00:14 tr069-start[95]: success!
Jan 1 00:00:14 FIND_GW[95]: gwif false
Jan 1 00:00:14 FIND_GW[95]: iface wan1
Jan 1 00:00:14 UPNP[95]: wan1
Jan 1 00:00:14 miniupnpd[240]: could not open lease file: /tmp/upnp.leases
Jan 1 00:00:14 miniupnpd[240]: HTTP listening on port 56351
Jan 1 00:00:14 miniupnpd[240]: Listening for NAT-PMP traffic on port 5351
Jan 1 00:00:14 resident[95]: Out init_device
Jan 1 00:00:14 resident[245]: record = action:down;iface:wan1;contag:4;
Jan 1 00:00:14 resident[245]: phys_iface wan1
Jan 1 00:00:14 resident_ipoe_handler[245]: ip_type = (null)
Jan 1 00:00:14 resident[245]: resident_ipoe_handler - Set default type: ipv4
Jan 1 00:00:14 resident[245]: phys_iface
Jan 1 00:00:14 resident[245]: resident_ipoe_handler - 2
Jan 1 00:00:14 resident_ipoe_handler[245]: name: wan1_4
Jan 1 00:00:14 resident_mng[94]: RESIDENT WORKER is running.
Jan 1 00:00:15 resident[245]: resident_ipoe_handler - l2:wan1, l3:wan1_4, tun:, ip_type:0
Jan 1 00:00:15 resident[245]: ip_is_down on wan1_4
Jan 1 00:00:16 udhcpc[225]: Sending discover...
Jan 1 00:00:16 kernel: Link status change phy 4
Jan 1 00:00:16 resident_phy_link_handler[268]: record = phy:4;status:1
Jan 1 00:00:16 resident_phy_link_handler[268]: phy - 4, status - 1
Jan 1 00:00:16 resident_phy_link_handler[268]: etherwan key_l2=wan1
Jan 1 00:00:16 resident[268]: start ipoe
Jan 1 00:00:16 start_ip[268]: begin (wan1 -> wan1_4)
Jan 1 00:00:16 resident[268]: start ipoe (v0) on wan1
Jan 1 00:00:16 udhcpc[225]: Watchdog was signaled
Jan 1 00:00:16 resident_phy_link_handler[268]: Exit
Jan 1 00:00:16 save config[272]: saving... at line 133
Jan 1 00:00:16 write[272]: line 978
Jan 1 00:00:16 save_to_flash[272]: file size is 2727
Jan 1 00:00:17 udhcpc[225]: Sending select for 10.129.81.54...
Jan 1 00:00:18 udhcpc[225]: Lease of 10.129.81.54 obtained, lease time 43269
Jan 1 00:00:18 udhcpc[281]: execle'ing /tmp/udhcpc with name bound
Jan 1 00:00:18 event[281]: send event "ipoe up"
Jan 1 00:00:18 resident[245]: record = action:up;iface:wan1;contag:4;ipaddr:10.129.81.54 ;netmask:255.255.255.248 ;gateway:10.129.81.49 ;serverid:213.138.70.3 ;dns1:213.138.70.8;dns2:86.110.181.14;
Jan 1 00:00:18 resident[245]: phys_iface wan1
Jan 1 00:00:18 resident_ipoe_handler[245]: ip_type = (null)
Jan 1 00:00:18 resident[245]: resident_ipoe_handler - Set default type: ipv4
Jan 1 00:00:18 resident[245]: phys_iface
Jan 1 00:00:18 resident[245]: resident_ipoe_handler - 2
Jan 1 00:00:18 resident_ipoe_handler[245]: name: wan1_4
Jan 1 00:00:18 save config[272]: saving... at line 149
Jan 1 00:00:18 resident[245]: resident_ipoe_handler - l2:wan1, l3:wan1_4, tun:, ip_type:0
Jan 1 00:00:18 resident[245]: resident_ipoe_handler - ipv4
Jan 1 00:00:18 resident[245]: start ip_is_up on iface wan1_4
Jan 1 00:00:18 resident[245]: ip_is_up for link wan1_4
Jan 1 00:00:18 DMS_NL_API[245]: Rtnetlink answer: No such process
Jan 1 00:00:18 DMS_NL_API[245]: Error deleting route default via (null) dev wan1 m0
Jan 1 00:00:18 dnsmasq[184]: script process exited with status 1
Jan 1 00:00:18 set_dhcp_routes[245]: set routes for iface wan1
Jan 1 00:00:18 triggerPingRespond[245]: OK
Jan 1 00:00:18 resident[245]: update rip
Jan 1 00:00:18 resident[245]: update igmpx
Jan 1 00:00:18 resident[245]: stop igmpx
Jan 1 00:00:18 iface[245]: this is wan1
Jan 1 00:00:18 resident[245]: igmpx wan1
Jan 1 00:00:18 syslog: Loading liblogger v2.0.2
Jan 1 00:00:18 syslog: upstream ifaces: wan1
Jan 1 00:00:18 syslog: downstream ifaces: br0
Jan 1 00:00:18 syslog: hews interval = 120.0 sec
Jan 1 00:00:18 syslog: doublet join enabled
Jan 1 00:00:18 syslog: Using old argv style
Jan 1 00:00:18 syslog: daemonizing ...
Jan 1 00:00:18 syslog: kernel multicast version is 305 (v3.05 ?)
Jan 1 00:00:18 syslog: kernel mroute inited
Jan 1 00:00:18 syslog: proxy prepared
Jan 1 00:00:18 kernel: wan1: dev_set_allmulti(master, 1)
Jan 1 00:00:18 kernel: et0: et_set_multicast_list, promisc = 1
Jan 1 00:00:18 syslog: vifi #0 added for wan1
Jan 1 00:00:18 syslog: vifi #1 added for br0
Jan 1 00:00:18 syslog: valid VIF's configured: upstreams=1, downstreams=1. Ok.
Jan 1 00:00:18 resident[245]: update igmpx compiled
Jan 1 00:00:18 resident[245]: update ntpclient
Jan 1 00:00:18 update_ntpclient[245]: server string: ntpd -p ntp1.dlink.com -p ntp.dlink.com.tw&
Jan 1 04:00:18 autoupdate[245]: Downloading file: fwupdate.dlink.ru/dislocation
Jan 1 04:00:19 autoupdate[245]: Downloading file: fwupdate.dlink.ru/Router/DIR-615_K1/Firmware/exclude
Jan 1 04:00:19 autoupdate[245]: Not found exception
Jan 1 04:00:19 autoupdate[245]: Downloading file: fwupdate.dlink.ru/Router/DIR-615_K1/Firmware/latest
Jan 1 04:00:19 autoupdate[245]: Downloading file: fwupdate.dlink.ru/Router/DIR-615_K1/Firmware/20140711_1343_DIR_615K1_2.5.4_sdk-master.des
Jan 1 04:00:19 autoupdate[245]: Update not needed
Jan 1 04:00:21 syslog: leave group 224.0.0.251 from 192.168.0.142
Jan 1 04:00:21 syslog: leave group 224.0.0.251 from 192.168.0.142
Jan 1 04:00:22 kernel: et0: et_set_multicast_list, promisc = 1
Jan 1 04:00:22 kernel: wan1: add 01:00:5e:7f:ff:fa mcast address to master interface
Jan 1 04:00:22 syslog: added membership for 239.255.255.250 on upstream #0 10.129.81.54
Jan 1 04:00:22 syslog: added new route 239.255.255.250: 10.129.81.54 -> 192.168.0.1
Jan 1 04:00:22 syslog: leave group 224.0.0.252 from 192.168.0.142
Jan 1 04:00:23 syslog: route 239.255.255.250 on upstream #0 activated with 192.168.0.142
Oct 4 00:21:54 autoupdate[361]: Downloading file: fwupdate.dlink.ru/dislocation
Oct 4 00:21:54 autoupdate[361]: Downloading file: fwupdate.dlink.ru/Router/DIR-615_K1/Firmware/exclude
Oct 4 00:21:54 autoupdate[361]: Not found exception
Oct 4 00:21:54 autoupdate[361]: Downloading file: fwupdate.dlink.ru/Router/DIR-615_K1/Firmware/latest
Oct 4 00:21:54 autoupdate[361]: Downloading file: fwupdate.dlink.ru/Router/DIR-615_K1/Firmware/20140711_1343_DIR_615K1_2.5.4_sdk-master.des
Oct 4 00:21:54 autoupdate[361]: Update not needed
Oct 4 00:22:07 udhcpc[287]: WATCHDOG_TIMEOUT exceeded
Oct 4 00:22:07 udhcpc[287]: Dumping diags to /jffs
Oct 4 00:23:06 conf_wan[973]: CONFIG_ACTION_EDIT - start
Oct 4 00:23:06 conf_wan[973]: key_l2_incoming = wan1
Oct 4 00:23:06 conf_wan[973]: test
Oct 4 00:23:06 conf_wan[973]: IPOE IPV4
Oct 4 00:23:06 conf_wan[973]: max_count = 5
Oct 4 00:23:06 conf_wan[973]: key_l3_incoming = wan1_4
Oct 4 00:23:06 conf_wan[973]: Get incoming L2 wan1 from config
Oct 4 00:23:06 conf_wan[973]: Is it lan?
Oct 4 00:23:06 conf_wan[973]: It's wan iface
Oct 4 00:23:06 conf_wan[973]: Make edit old
Oct 4 00:23:06 conf_wan[973]: line 868
Oct 4 00:23:06 conf_wan[973]: 876: l2_key=wan1, l3_key=wan1_4
Oct 4 00:23:06 conf_wan[973]: 883
Oct 4 00:23:06 conf_wan[973]: stop L3 wan1_4
Oct 4 00:23:06 conf_wan[973]: type_link ip
Oct 4 00:23:06 resident[973]: stop ipoe on wan1_4
Oct 4 00:23:06 resident[973]: set lock /var/lock/wan1_4.lock
Oct 4 00:23:06 udhcpc[287]: Sending release...
Oct 4 00:23:06 udhcpc[287]: kernel_packet: Socket Result = 532
Oct 4 00:23:06 udhcpc[976]: execle'ing /tmp/udhcpc with name deconfig
Oct 4 00:23:06 event[976]: file "/var/lock/wan1_4.lock" is set
Oct 4 00:23:06 event[976]: udhcp_down fake
Oct 4 00:23:06 udhcpc[287]: Received SIGTERM
Oct 4 00:23:06 miniupnpd[240]: ioctl(s, SIOCGIFADDR, ...): Cannot assign requested address
Oct 4 00:23:06 miniupnpd[240]: Failed to get IP for interface wan1
Oct 4 00:23:06 miniupnpd[240]: SendNATPMPPublicAddressChangeNotification: cannot get public IP address, stopping
Oct 4 00:23:06 wan_down[973]: name = wan1
Oct 4 00:23:06 triggerPingRespond[973]: OK
Oct 4 00:23:07 conf_wan[973]: 925
Oct 4 00:23:07 conf_wan[973]: Renew search L3 wan1_4
Oct 4 00:23:07 conf_wan[973]: Delete link wan1_4
Oct 4 00:23:07 conf_wan[973]: Set link name wan1_4
Oct 4 00:23:07 conf_wan[973]: Not have default route on any link, set it!
Oct 4 00:23:07 conf_wan[973]: L3 ethernet
Oct 4 00:23:07 conf_wan[973]: Change mac or mtu on L2 iface wan1 !!!
Oct 4 00:23:07 resident[973]: stop ipoe on wan1_4
Oct 4 00:23:07 DMS_NL_API[973]: Rtnetlink answer: No such process
Oct 4 00:23:07 DMS_NL_API[973]: Error deleting route 213.138.70.3 via 10.129.81.49 dev wan1 m0
Oct 4 00:23:07 resident[973]: set lock /var/lock/wan1_4.lock
Oct 4 00:23:08 wan_down[973]: name = wan1
Oct 4 00:23:09 triggerPingRespond[973]: OK
Oct 4 00:23:09 kernel: wan1: del 01:00:5e:7f:ff:fa mcast address from vlan interface
Oct 4 00:23:09 kernel: et0: et_set_multicast_list, promisc = 1
Oct 4 00:23:09 kernel: wan1: del 01:00:5e:7f:ff:fa mcast address from master interface
Oct 4 00:23:09 kernel: wan1: del 01:00:5e:00:00:01 mcast address from vlan interface
Oct 4 00:23:09 kernel: wan1: del 01:00:5e:00:00:01 mcast address from master interface
Oct 4 00:23:09 kernel: wan1: Setting MAC address to 50 46 5d a3 30 3e.
Oct 4 00:23:09 kernel: wan1: add 01:00:5e:00:00:01 mcast address to master interface
Oct 4 00:23:09 kernel: et0: et_set_multicast_list, promisc = 1
Oct 4 00:23:09 kernel: wan1: add 01:00:5e:7f:ff:fa mcast address to master interface
Oct 4 00:23:09 syslog: active route 239.255.255.250 changed source from 192.168.0.142 to 192.168.0.1
Oct 4 00:23:09 syslog: route 239.255.255.250 on upstream #0 activated with 192.168.0.1
Oct 4 00:23:09 resident[973]: start ipoe
Oct 4 00:23:09 start_ip[973]: begin (wan1 -> wan1_4)
Oct 4 00:23:09 resident[973]: start ipoe (v0) on wan1
Oct 4 00:23:09 udhcpc[1005]: UDHCP start..
Oct 4 00:23:09 udhcpc[1005]: udhcp client (v0.9.

started (iface: wan1, connect: 4)
Oct 4 00:23:09 DMS_NL_API[973]: Rtnetlink answer: No such process
Oct 4 00:23:09 DMS_NL_API[973]: Error deleting route default via NULL dev wan1 m0
Oct 4 00:23:09 set_defroute[973]: gateway_iface: wan1
Oct 4 00:23:09 DMS_NL_API[973]: Rtnetlink answer: No such process
Oct 4 00:23:09 DMS_NL_API[973]: Error adding route default via 10.129.81.49 dev wan1 m101
Oct 4 00:23:09 udhcpc[1005]: interface wan1 index 7
Oct 4 00:23:09 udhcpc[1005]: interface wan1 hwaddr 50:46:5d:a3:30:3e
Oct 4 00:23:09 udhcpc[1005]: interface wan1 mtu is 1500
Oct 4 00:23:09 udhcpc[1015]: execle'ing /tmp/udhcpc with name deconfig
Oct 4 00:23:09 event[1015]: file "/var/lock/wan1_4.lock" is set
Oct 4 00:23:09 event[1015]: udhcp_down fake
Oct 4 00:23:09 udhcpc[1005]: Opening raw socket on ifindex 7
Oct 4 00:23:09 udhcpc[1005]: Sending discover...
Oct 4 00:23:10 FIND_GW[973]: gwif false
Oct 4 00:23:10 FIND_GW[973]: iface wan1
Oct 4 00:23:10 UPNP[973]: wan1
Oct 4 00:23:10 miniupnpd[1018]: could not open lease file: /tmp/upnp.leases
Oct 4 00:23:10 miniupnpd[1018]: HTTP listening on port 56423
Oct 4 00:23:10 miniupnpd[1018]: Listening for NAT-PMP traffic on port 5351
Oct 4 00:23:10 conf_wan[973]: CONFIG_ACTION_EDIT - exit
Oct 4 00:23:10 udhcpc[1005]: Sending select for 10.129.81.53...
Oct 4 00:23:10 udhcpc[1005]: Lease of 10.129.81.53 obtained, lease time 85922
Oct 4 00:23:10 udhcpc[1023]: execle'ing /tmp/udhcpc with name bound
Oct 4 00:23:10 event[1023]: send event "ipoe up"
Oct 4 00:23:10 resident[245]: record = action:up;iface:wan1;contag:4;ipaddr:10.129.81.53 ;netmask:255.255.255.248 ;gateway:10.129.81.49 ;serverid:213.138.70.3 ;dns1:213.138.70.8;dns2:86.110.181.14;
Oct 4 00:23:10 resident[245]: phys_iface wan1
Oct 4 00:23:10 resident_ipoe_handler[245]: ip_type = (null)
Oct 4 00:23:10 resident[245]: resident_ipoe_handler - Set default type: ipv4
Oct 4 00:23:10 resident[245]: phys_iface
Oct 4 00:23:10 resident[245]: resident_ipoe_handler - 2
Oct 4 00:23:10 resident_ipoe_handler[245]: name: wan1_4
Oct 4 00:23:10 resident[245]: resident_ipoe_handler - l2:wan1, l3:wan1_4, tun:, ip_type:0
Oct 4 00:23:10 resident[245]: resident_ipoe_handler - ipv4
Oct 4 00:23:10 resident[245]: start ip_is_up on iface wan1_4
Oct 4 00:23:10 resident[245]: ip_is_up for link wan1_4
Oct 4 00:23:10 DMS_NL_API[245]: Rtnetlink answer: No such process
Oct 4 00:23:10 DMS_NL_API[245]: Error deleting route default via (null) dev wan1 m0
Oct 4 00:23:10 set_dhcp_routes[245]: set routes for iface wan1
Oct 4 00:23:10 triggerPingRespond[245]: OK
Oct 4 00:23:10 resident[245]: update rip
Oct 4 00:23:10 resident[245]: update igmpx
Oct 4 00:23:10 resident[245]: stop igmpx
Oct 4 00:23:10 kernel: et0: et_set_multicast_list, promisc = 1
Oct 4 00:23:10 kernel: wan1: del 01:00:5e:7f:ff:fa mcast address from master interface
Oct 4 00:23:10 kernel: wan1: dev_set_allmulti(master, -1)
Oct 4 00:23:10 kernel: et0: et_set_multicast_list, promisc = 1
Oct 4 00:23:10 iface[245]: this is wan1
Oct 4 00:23:10 resident[245]: igmpx wan1
Oct 4 00:23:10 syslog: Loading liblogger v2.0.2
Oct 4 00:23:10 syslog: upstream ifaces: wan1
Oct 4 00:23:10 syslog: downstream ifaces: br0
Oct 4 00:23:10 syslog: hews interval = 120.0 sec
Oct 4 00:23:10 syslog: doublet join enabled
Oct 4 00:23:10 syslog: Using old argv style
Oct 4 00:23:10 syslog: daemonizing ...
Oct 4 00:23:10 syslog: kernel multicast version is 305 (v3.05 ?)
Oct 4 00:23:10 syslog: kernel mroute inited
Oct 4 00:23:10 syslog: proxy prepared
Oct 4 00:23:10 kernel: wan1: dev_set_allmulti(master, 1)
Oct 4 00:23:10 kernel: et0: et_set_multicast_list, promisc = 1
Oct 4 00:23:10 syslog: vifi #0 added for wan1
Oct 4 00:23:10 syslog: vifi #1 added for br0
Oct 4 00:23:10 syslog: valid VIF's configured: upstreams=1, downstreams=1. Ok.
Oct 4 00:23:10 resident[245]: update igmpx compiled
Oct 4 00:23:10 resident[245]: update ntpclient
Oct 4 00:23:10 update_ntpclient[245]: server string: ntpd -p ntp1.dlink.com -p ntp.dlink.com.tw&
Oct 4 00:23:10 autoupdate[245]: Downloading file: fwupdate.dlink.ru/dislocation
Oct 4 00:23:11 autoupdate[245]: Downloading file: fwupdate.dlink.ru/Router/DIR-615_K1/Firmware/exclude
Oct 4 00:23:11 autoupdate[245]: Not found exception
Oct 4 00:23:11 autoupdate[245]: Downloading file: fwupdate.dlink.ru/Router/DIR-615_K1/Firmware/latest
Oct 4 00:23:11 autoupdate[245]: Downloading file: fwupdate.dlink.ru/Router/DIR-615_K1/Firmware/20140711_1343_DIR_615K1_2.5.4_sdk-master.des
Oct 4 00:23:11 autoupdate[245]: Update not needed
Oct 4 00:23:11 resident[245]: record = action:dhcp_options;iface:NULL;type:del;ipaddr:192.168.0.142;
Oct 4 00:23:11 resident[245]: phys_iface NULL
Oct 4 00:23:11 resident[245]: ip:192.168.0.142 type:del
Oct 4 00:23:11 dhcp_opt_rule[245]: start
Oct 4 00:23:11 dhcp_opt_rule[245]: config was loaded
Oct 4 00:23:11 dhcp_opt_rule[245]: get dhcp rule
Oct 4 00:23:11 dhcp_opt_rule[245]: type is del
Oct 4 00:23:11 kernel: et0: et_set_multicast_list, promisc = 1
Oct 4 00:23:11 kernel: wan1: add 01:00:5e:7f:ff:fa mcast address to master interface
Oct 4 00:23:11 syslog: added membership for 239.255.255.250 on upstream #0 10.129.81.53
Oct 4 00:23:11 syslog: added new route 239.255.255.250: 10.129.81.53 -> 192.168.0.1
Oct 4 00:23:11 syslog: route 239.255.255.250 on upstream #0 activated with 192.168.0.142
Oct 4 00:23:14 save config[1112]: saving... at line 133
Oct 4 00:23:14 write[1112]: line 978
Oct 4 00:23:14 save_to_flash[1112]: file size is 2864
Oct 4 00:23:15 save config[1112]: saving... at line 149
Oct 4 00:25:22 syslog: active route 239.255.255.250 changed source from 192.168.0.142 to 192.168.0.1
Oct 4 00:25:22 syslog: route 239.255.255.250 on upstream #0 activated with 192.168.0.1
Oct 4 00:25:26 syslog: route 239.255.255.250: all (1 item(s)) down VIF(s) NOT reported. Delete expired route.
Oct 4 00:25:26 kernel: et0: et_set_multicast_list, promisc = 1
Oct 4 00:25:26 kernel: wan1: del 01:00:5e:7f:ff:fa mcast address from master interface
Oct 4 00:25:26 syslog: removed route 239.255.255.250 on upstream #0 from origin 192.168.0.1
Oct 4 00:47:00 conf_wan[2579]: 1536
Oct 4 00:47:00 conf_wan[2579]: 1553
Oct 4 00:47:00 conf_wan[2579]: 1568
Oct 4 00:47:00 conf_wan[2579]: 1579
Oct 4 00:47:00 conf_wan[2579]: 1597
Oct 4 00:47:00 conf_wan[2579]: 1579
Oct 4 00:47:00 conf_wan[2579]: 1579
Oct 4 00:47:00 conf_wan[2579]: 1616
Oct 4 00:47:00 conf_wan[2579]: 1620
Oct 4 00:47:00 conf_wan[2579]: 1637
Oct 4 00:47:02 conf_wan[2579]: 1660
Oct 4 00:47:02 resident[2579]: stop ipoe on wan1_4
Oct 4 00:47:02 resident[2579]: set lock /var/lock/wan1_4.lock
Oct 4 00:47:02 udhcpc[1049]: Sending release...
Oct 4 00:47:02 udhcpc[1049]: kernel_packet: Socket Result = 532
Oct 4 00:47:02 udhcpc[2582]: execle'ing /tmp/udhcpc with name deconfig
Oct 4 00:47:02 event[2582]: file "/var/lock/wan1_4.lock" is set
Oct 4 00:47:02 event[2582]: udhcp_down fake
Oct 4 00:47:02 udhcpc[1049]: Received SIGTERM
Oct 4 00:47:02 wan_down[2579]: name = wan1
Oct 4 00:47:02 miniupnpd[1018]: ioctl(s, SIOCGIFADDR, ...): Cannot assign requested address
Oct 4 00:47:02 miniupnpd[1018]: Failed to get IP for interface wan1
Oct 4 00:47:02 miniupnpd[1018]: SendNATPMPPublicAddressChangeNotification: cannot get public IP address, stopping
Oct 4 00:47:02 triggerPingRespond[2579]: OK
Oct 4 00:47:04 set_free_unit[2579]: 1853
Oct 4 00:47:04 set_free_unit[2579]: 1869: iface = wan1
Oct 4 00:47:04 conf_wan[2579]: 1723
Oct 4 00:47:04 conf_wan[2579]: 1788
Oct 4 00:47:04 conf_wan[2579]: 1793
Oct 4 00:47:04 conf_wan[2592]: CONFIG_ACTION_EDIT - start
Oct 4 00:47:04 conf_wan[2592]: key_l2_incoming = wan1
Oct 4 00:47:04 conf_wan[2592]: test
Oct 4 00:47:04 conf_wan[2592]: IPOE IPV4
Oct 4 00:47:04 conf_wan[2592]: max_count = 5
Oct 4 00:47:04 conf_wan[2592]: key_l3_incoming = create
Oct 4 00:47:04 conf_wan[2592]: Get incoming L2 wan1 from config
Oct 4 00:47:04 conf_wan[2592]: Is it lan?
Oct 4 00:47:04 conf_wan[2592]: It's wan iface
Oct 4 00:47:04 conf_wan[2592]: Make new
Oct 4 00:47:04 conf_wan[2592]: Create L3 on L2 wan1
Oct 4 00:47:04 conf_wan[2592]: Set iface wan1!
Oct 4 00:47:04 conf_wan[2592]: Key for connection is wan1_5
Oct 4 00:47:04 conf_wan[2592]: Not have default route on any link, set it!
Oct 4 00:47:04 conf_wan[2592]: L3 ethernet
Oct 4 00:47:04 conf_wan[2592]: Start start_ip on iface wan1_5
Oct 4 00:47:04 conf_wan[2592]: Start start_ip for ipv4
Oct 4 00:47:04 resident[2592]: start ipoe
Oct 4 00:47:04 start_ip[2592]: begin (wan1 -> wan1_5)
Oct 4 00:47:04 resident[2592]: start ipoe (v0) on wan1
Oct 4 00:47:04 udhcpc[2593]: UDHCP start..
Oct 4 00:47:04 udhcpc[2593]: udhcp client (v0.9.

started (iface: wan1, connect: 5)
Oct 4 00:47:04 udhcpc[2593]: interface wan1 index 7
Oct 4 00:47:04 udhcpc[2593]: interface wan1 hwaddr 50:46:5d:a3:30:3e
Oct 4 00:47:04 udhcpc[2593]: interface wan1 mtu is 1500
Oct 4 00:47:04 udhcpc[2594]: execle'ing /tmp/udhcpc with name deconfig
Oct 4 00:47:04 event[2594]: send event "ipoe down"
Oct 4 00:47:04 DMS_NL_API[2592]: Rtnetlink answer: No such process
Oct 4 00:47:04 DMS_NL_API[2592]: Error deleting route default via NULL dev wan1 m0
Oct 4 00:47:04 set_defroute[2592]: gateway_iface: wan1
Oct 4 00:47:04 resident[245]: record = action:down;iface:wan1;contag:5;
Oct 4 00:47:04 resident[245]: phys_iface wan1
Oct 4 00:47:04 resident_ipoe_handler[245]: ip_type = (null)
Oct 4 00:47:04 resident[245]: resident_ipoe_handler - Set default type: ipv4
Oct 4 00:47:04 resident[245]: phys_iface
Oct 4 00:47:04 resident[245]: resident_ipoe_handler - 2
Oct 4 00:47:04 resident_ipoe_handler[245]: name: wan1_5
Oct 4 00:47:04 udhcpc[2593]: Opening raw socket on ifindex 7
Oct 4 00:47:04 udhcpc[2593]: Sending discover...
Oct 4 00:47:05 FIND_GW[2592]: gwif false
Oct 4 00:47:06 FIND_GW[2592]: iface wan1
Oct 4 00:47:06 UPNP[2592]: wan1
Oct 4 00:47:06 miniupnpd[2606]: could not open lease file: /tmp/upnp.leases
Oct 4 00:47:06 miniupnpd[2606]: HTTP listening on port 44203
Oct 4 00:47:06 miniupnpd[2606]: Listening for NAT-PMP traffic on port 5351
Oct 4 00:47:06 resident[245]: resident_ipoe_handler - l2:wan1, l3:wan1_5, tun:, ip_type:0
Oct 4 00:47:06 resident[245]: ip_is_down on wan1_5
Oct 4 00:47:06 conf_wan[2592]: CONFIG_ACTION_EDIT - exit
Oct 4 00:47:06 udhcpc[2593]: Sending discover...
Oct 4 00:47:11 udhcpc[2593]: Sending discover...
Oct 4 00:47:24 udhcpc[2593]: Sending discover...
Oct 4 00:47:26 udhcpc[2593]: Sending discover...
Oct 4 00:47:30 udhcpc[2593]: Sending discover...
Oct 4 00:47:43 udhcpc[2647]: Sending discover...
Oct 4 00:47:45 udhcpc[2647]: Sending discover...
Oct 4 00:47:49 udhcpc[2647]: Sending discover...
Oct 4 00:48:02 udhcpc[2647]: Sending discover...
Oct 4 00:48:04 udhcpc[2647]: Sending discover...
Oct 4 00:48:05 kernel: Link status change phy 4
Oct 4 00:48:08 resident_phy_link_handler[2906]: record = phy:4;status:0
Oct 4 00:48:08 resident_phy_link_handler[2906]: phy - 4, status - 0
Oct 4 00:48:08 resident_phy_link_handler[2906]: etherwan key_l2=wan1
Oct 4 00:48:08 resident[2906]: stop ipoe on wan1_5
Oct 4 00:48:08 resident[2906]: set lock /var/lock/wan1_5.lock
Oct 4 00:48:08 resident_phy_link_handler[2906]: Exit
Oct 4 00:48:08 udhcpc[2647]: Sending release...
Oct 4 00:48:08 dnsmasq-dhcp[184]: no address range available for DHCP request via lo
Oct 4 00:48:08 udhcpc[2647]: kernel_packet: Socket Result = 532
Oct 4 00:48:08 udhcpc[2909]: execle'ing /tmp/udhcpc with name deconfig
Oct 4 00:48:08 event[2909]: file "/var/lock/wan1_5.lock" is set
Oct 4 00:48:08 event[2909]: udhcp_down fake
Oct 4 00:48:08 udhcpc[2647]: Received SIGTERM
Oct 4 00:48:12 kernel: Link status change phy 3
Oct 4 00:48:23 dnsmasq[184]: script process exited with status 1
Oct 4 00:48:23 syslog: setsockopt: add membership for 239.255.255.250 on upstream #0 10.129.81.53: 19(No such device)
Oct 4 00:48:24 syslog: leave group 224.0.0.252 from 192.168.0.142
Oct 4 00:48:24 syslog: setsockopt: add membership for 239.255.255.250 on upstream #0 10.129.81.53: 19(No such device)
Oct 4 00:48:24 kernel: Link status change phy 3
Oct 4 00:48:24 syslog: leave group 224.0.0.252 from 192.168.0.142
Oct 4 00:48:26 syslog: leave group 224.0.0.251 from 192.168.0.142
Oct 4 00:48:26 syslog: leave group 224.0.0.252 from 192.168.0.142
Oct 4 00:48:27 resident_phy_link_handler[2959]: record = phy:3;status:1
Oct 4 00:48:27 resident_phy_link_handler[2959]: phy - 3, status - 1
Oct 4 00:48:27 resident_phy_link_handler[2959]: Exit
Oct 4 00:48:27 syslog: leave group 224.0.0.251 from 192.168.0.142
Oct 4 00:48:27 syslog: leave group 224.0.0.252 from 192.168.0.142
Oct 4 00:48:29 syslog: leave group 224.0.0.251 from 192.168.0.142
Oct 4 00:48:29 syslog: leave group 224.0.0.252 from 192.168.0.142
Jan 1 04:06:22 resident[245]: resident_ipoe_handler - l2:wan1, l3:wan1_4, tun:, ip_type:0
Jan 1 04:06:22 resident[245]: ip_is_down on wan1_4
Jan 1 04:06:22 udhcpc[1351]: Opening raw socket on ifindex 7
Jan 1 04:06:22 udhcpc[1351]: Sending discover...
Jan 1 04:06:24 udhcpc[1351]: Sending discover...
Jan 1 04:06:28 udhcpc[1351]: Sending discover...
Jan 1 04:06:32 kernel: Link status change phy 4
Jan 1 04:06:34 resident_phy_link_handler[1356]: record = phy:4;status:0
Jan 1 04:06:34 resident_phy_link_handler[1356]: phy - 4, status - 0
Jan 1 04:06:34 resident_phy_link_handler[1356]: etherwan key_l2=wan1
Jan 1 04:06:34 resident[1356]: stop ipoe on wan1_4
Jan 1 04:06:34 resident[1356]: set lock /var/lock/wan1_4.lock
Jan 1 04:06:34 udhcpc[1351]: Sending release...
Jan 1 04:06:34 udhcpc[1351]: kernel_packet: Socket Result = 532
Jan 1 04:06:34 udhcpc[1359]: execle'ing /tmp/udhcpc with name deconfig
Jan 1 04:06:34 resident_phy_link_handler[1356]: Exit
Jan 1 04:06:34 dnsmasq-dhcp[184]: no address range available for DHCP request via lo
Jan 1 04:06:34 event[1359]: file "/var/lock/wan1_4.lock" is set
Jan 1 04:06:34 event[1359]: udhcp_down fake
Jan 1 04:06:34 udhcpc[1351]: Received SIGTERM
Jan 1 04:06:35 kernel: Link status change phy 4
Jan 1 04:06:36 kernel: Link status change phy 4
Jan 1 04:06:38 kernel: Link status change phy 4
Jan 1 04:06:40 resident_phy_link_handler[1360]: record = phy:4;status:1
Jan 1 04:06:40 resident_phy_link_handler[1360]: phy - 4, status - 1
Jan 1 04:06:40 resident_phy_link_handler[1360]: etherwan key_l2=wan1
Jan 1 04:06:40 resident[1360]: start ipoe
Jan 1 04:06:40 start_ip[1360]: begin (wan1 -> wan1_4)
Jan 1 04:06:40 resident[1360]: start ipoe (v0) on wan1
Jan 1 04:06:40 udhcpc[1363]: UDHCP start..
Jan 1 04:06:40 udhcpc[1363]: udhcp client (v0.9.

started (iface: wan1, connect: 4)
Jan 1 04:06:40 udhcpc[1363]: interface wan1 index 7
Jan 1 04:06:40 udhcpc[1363]: interface wan1 hwaddr cc:b2:55:fe:60:7d
Jan 1 04:06:40 udhcpc[1363]: interface wan1 mtu is 1500
Jan 1 04:06:40 udhcpc[1364]: execle'ing /tmp/udhcpc with name deconfig
Jan 1 04:06:40 event[1364]: send event "ipoe down"
Jan 1 04:06:40 resident_phy_link_handler[1360]: Exit
Jan 1 04:06:40 resident[245]: record = action:down;iface:wan1;contag:4;
Jan 1 04:06:40 resident[245]: phys_iface wan1
Jan 1 04:06:40 resident_ipoe_handler[245]: ip_type = (null)
Jan 1 04:06:40 resident[245]: resident_ipoe_handler - Set default type: ipv4
Jan 1 04:06:40 resident[245]: phys_iface
Jan 1 04:06:40 resident[245]: resident_ipoe_handler - 2
Jan 1 04:06:40 resident_ipoe_handler[245]: name: wan1_4
Jan 1 04:06:40 resident[245]: resident_ipoe_handler - l2:wan1, l3:wan1_4, tun:, ip_type:0
Jan 1 04:06:40 resident[245]: ip_is_down on wan1_4
Jan 1 04:06:40 udhcpc[1363]: Opening raw socket on ifindex 7
Jan 1 04:06:40 udhcpc[1363]: Sending discover...
Jan 1 04:06:42 udhcpc[1363]: Sending discover...
Jan 1 04:06:45 syslog: setsockopt: mc if 10.129.81.54: 126(Cannot assign requested address)
Jan 1 04:06:45 syslog: sendto: 0a815136 -> effffff6: 128(Network is unreachable)
Jan 1 04:06:46 udhcpc[1363]: Sending discover...
Jan 1 04:06:59 udhcpc[1363]: Sending discover...
Jan 1 04:07:02 udhcpc[1363]: Sending discover...
Jan 1 04:07:03 syslog: setsockopt: add membership for 239.255.255.250 on upstream #0 10.129.81.54: 19(No such device)
Jan 1 04:07:05 udhcpc[1363]: Sending discover...
Jan 1 04:07:10 kernel: Link status change phy 4
Jan 1 04:07:12 resident_phy_link_handler[1376]: record = phy:4;status:0
Jan 1 04:07:12 resident_phy_link_handler[1376]: phy - 4, status - 0
Jan 1 04:07:12 resident_phy_link_handler[1376]: etherwan key_l2=wan1
Jan 1 04:07:12 resident[1376]: stop ipoe on wan1_4
Jan 1 04:07:12 resident[1376]: set lock /var/lock/wan1_4.lock
Jan 1 04:07:12 udhcpc[1375]: Sending release...
Jan 1 04:07:12 udhcpc[1375]: kernel_packet: Socket Result = 532
Jan 1 04:07:12 udhcpc[1379]: execle'ing /tmp/udhcpc with name deconfig
Jan 1 04:07:12 dnsmasq-dhcp[184]: no address range available for DHCP request via lo
Jan 1 04:07:12 event[1379]: file "/var/lock/wan1_4.lock" is set
Jan 1 04:07:12 event[1379]: udhcp_down fake
Jan 1 04:07:12 udhcpc[1375]: Received SIGTERM
Jan 1 04:07:12 resident_phy_link_handler[1376]: Exit
Jan 1 04:07:13 kernel: Link status change phy 4
Jan 1 04:07:14 resident_phy_link_handler[1380]: record = phy:4;status:1
Jan 1 04:07:14 resident_phy_link_handler[1380]: phy - 4, status - 1
Jan 1 04:07:14 resident_phy_link_handler[1380]: etherwan key_l2=wan1
Jan 1 04:07:14 resident[1380]: start ipoe
Jan 1 04:07:14 start_ip[1380]: begin (wan1 -> wan1_4)
Jan 1 04:07:14 resident[1380]: start ipoe (v0) on wan1
Jan 1 04:07:14 udhcpc[1383]: UDHCP start..
Jan 1 04:07:14 udhcpc[1383]: udhcp client (v0.9.

started (iface: wan1, connect: 4)
Jan 1 04:07:14 udhcpc[1383]: interface wan1 index 7
Jan 1 04:07:14 udhcpc[1383]: interface wan1 hwaddr cc:b2:55:fe:60:7d
Jan 1 04:07:14 udhcpc[1383]: interface wan1 mtu is 1500
Jan 1 04:07:14 udhcpc[1384]: execle'ing /tmp/udhcpc with name deconfig
Jan 1 04:07:14 resident_phy_link_handler[1380]: Exit
Jan 1 04:07:14 event[1384]: send event "ipoe down"
Jan 1 04:07:14 resident[245]: record = action:down;iface:wan1;contag:4;
Jan 1 04:07:14 resident[245]: phys_iface wan1
Jan 1 04:07:14 resident_ipoe_handler[245]: ip_type = (null)
Jan 1 04:07:14 resident[245]: resident_ipoe_handler - Set default type: ipv4
Jan 1 04:07:14 resident[245]: phys_iface
Jan 1 04:07:14 resident[245]: resident_ipoe_handler - 2
Jan 1 04:07:14 resident_ipoe_handler[245]: name: wan1_4
Jan 1 04:07:14 resident[245]: resident_ipoe_handler - l2:wan1, l3:wan1_4, tun:, ip_type:0
Jan 1 04:07:14 resident[245]: ip_is_down on wan1_4
Jan 1 04:07:14 udhcpc[1383]: Opening raw socket on ifindex 7
Jan 1 04:07:14 udhcpc[1383]: Sending discover...
Jan 1 04:07:16 udhcpc[1383]: Sending discover...
Jan 1 04:07:18 kernel: Link status change phy 4
Jan 1 04:07:19 resident_phy_link_handler[1387]: record = phy:4;status:0
Jan 1 04:07:19 resident_phy_link_handler[1387]: phy - 4, status - 0
Jan 1 04:07:19 resident_phy_link_handler[1387]: etherwan key_l2=wan1
Jan 1 04:07:19 resident[1387]: stop ipoe on wan1_4
Jan 1 04:07:19 resident[1387]: set lock /var/lock/wan1_4.lock
Jan 1 04:07:19 udhcpc[1383]: Sending release...
Jan 1 04:07:19 udhcpc[1383]: kernel_packet: Socket Result = 532
Jan 1 04:07:19 udhcpc[1390]: execle'ing /tmp/udhcpc with name deconfig
Jan 1 04:07:19 dnsmasq-dhcp[184]: no address range available for DHCP request via lo
Jan 1 04:07:19 event[1390]: file "/var/lock/wan1_4.lock" is set
Jan 1 04:07:19 event[1390]: udhcp_down fake
Jan 1 04:07:19 udhcpc[1383]: Received SIGTERM
Jan 1 04:07:19 resident_phy_link_handler[1387]: Exit
Jan 1 04:07:20 kernel: Link status change phy 4
Jan 1 04:07:21 resident_phy_link_handler[1395]: record = phy:4;status:1
Jan 1 04:07:21 resident_phy_link_handler[1395]: phy - 4, status - 1
Jan 1 04:07:21 resident_phy_link_handler[1395]: etherwan key_l2=wan1
Jan 1 04:07:21 resident[1395]: start ipoe
Jan 1 04:07:21 start_ip[1395]: begin (wan1 -> wan1_4)
Jan 1 04:07:21 resident[1395]: start ipoe (v0) on wan1
Jan 1 04:07:21 udhcpc[1398]: UDHCP start..
Jan 1 04:07:21 udhcpc[1398]: udhcp client (v0.9.

started (iface: wan1, connect: 4)
Jan 1 04:07:21 udhcpc[1398]: interface wan1 index 7
Jan 1 04:07:21 udhcpc[1398]: interface wan1 hwaddr cc:b2:55:fe:60:7d
Jan 1 04:07:21 udhcpc[1398]: interface wan1 mtu is 1500
Jan 1 04:07:21 resident_phy_link_handler[1395]: Exit
Jan 1 04:07:21 udhcpc[1399]: execle'ing /tmp/udhcpc with name deconfig
Jan 1 04:07:21 event[1399]: send event "ipoe down"
Jan 1 04:07:21 resident[245]: record = action:down;iface:wan1;contag:4;
Jan 1 04:07:21 resident[245]: phys_iface wan1
Jan 1 04:07:21 resident_ipoe_handler[245]: ip_type = (null)
Jan 1 04:07:21 resident[245]: resident_ipoe_handler - Set default type: ipv4
Jan 1 04:07:21 resident[245]: phys_iface
Jan 1 04:07:21 resident[245]: resident_ipoe_handler - 2
Jan 1 04:07:21 resident_ipoe_handler[245]: name: wan1_4
Jan 1 04:07:21 resident[245]: resident_ipoe_handler - l2:wan1, l3:wan1_4, tun:, ip_type:0
Jan 1 04:07:21 resident[245]: ip_is_down on wan1_4
Jan 1 04:07:21 udhcpc[1398]: Opening raw socket on ifindex 7
Jan 1 04:07:21 udhcpc[1398]: Sending discover...
Jan 1 04:07:23 udhcpc[1398]: Sending discover...
Jan 1 04:07:27 udhcpc[1398]: Sending discover...
Jan 1 04:07:41 udhcpc[1398]: Sending discover...
Jan 1 04:07:43 udhcpc[1398]: Sending discover...
Jan 1 04:07:47 udhcpc[1398]: Sending discover...
Jan 1 04:07:50 kernel: Link status change phy 4
Jan 1 04:07:51 resident_phy_link_handler[1410]: record = phy:4;status:0
Jan 1 04:07:51 resident_phy_link_handler[1410]: phy - 4, status - 0
Jan 1 04:07:51 resident_phy_link_handler[1410]: etherwan key_l2=wan1
Jan 1 04:07:51 resident[1410]: stop ipoe on wan1_4
Jan 1 04:07:51 resident[1410]: set lock /var/lock/wan1_4.lock
Jan 1 04:07:51 udhcpc[1405]: Sending release...
Jan 1 04:07:51 udhcpc[1405]: kernel_packet: Socket Result = 532
Jan 1 04:07:51 udhcpc[1413]: execle'ing /tmp/udhcpc with name deconfig
Jan 1 04:07:51 dnsmasq-dhcp[184]: no address range available for DHCP request via lo
Jan 1 04:07:51 resident_phy_link_handler[1410]: Exit
Jan 1 04:07:51 event[1413]: file "/var/lock/wan1_4.lock" is set
Jan 1 04:07:51 event[1413]: udhcp_down fake
Jan 1 04:07:51 udhcpc[1405]: Received SIGTERM
Jan 1 04:07:52 kernel: Link status change phy 4
Jan 1 04:07:53 resident_phy_link_handler[1415]: record = phy:4;status:1
Jan 1 04:07:53 resident_phy_link_handler[1415]: phy - 4, status - 1
Jan 1 04:07:53 resident_phy_link_handler[1415]: etherwan key_l2=wan1
Jan 1 04:07:53 resident[1415]: start ipoe
Jan 1 04:07:53 start_ip[1415]: begin (wan1 -> wan1_4)
Jan 1 04:07:53 resident[1415]: start ipoe (v0) on wan1
Jan 1 04:07:53 udhcpc[1418]: UDHCP start..
Jan 1 04:07:53 udhcpc[1418]: udhcp client (v0.9.

started (iface: wan1, connect: 4)
Jan 1 04:07:53 udhcpc[1418]: interface wan1 index 7
Jan 1 04:07:53 udhcpc[1418]: interface wan1 hwaddr cc:b2:55:fe:60:7d
Jan 1 04:07:53 udhcpc[1418]: interface wan1 mtu is 1500
Jan 1 04:07:53 udhcpc[1419]: execle'ing /tmp/udhcpc with name deconfig
Jan 1 04:07:53 resident_phy_link_handler[1415]: Exit
Jan 1 04:07:53 event[1419]: send event "ipoe down"
Jan 1 04:07:53 resident[245]: record = action:down;iface:wan1;contag:4;
Jan 1 04:07:53 resident[245]: phys_iface wan1
Jan 1 04:07:53 resident_ipoe_handler[245]: ip_type = (null)
Jan 1 04:07:53 resident[245]: resident_ipoe_handler - Set default type: ipv4
Jan 1 04:07:53 resident[245]: phys_iface
Jan 1 04:07:53 resident[245]: resident_ipoe_handler - 2
Jan 1 04:07:53 resident_ipoe_handler[245]: name: wan1_4
Jan 1 04:07:53 resident[245]: resident_ipoe_handler - l2:wan1, l3:wan1_4, tun:, ip_type:0
Jan 1 04:07:53 resident[245]: ip_is_down on wan1_4
Jan 1 04:07:53 udhcpc[1418]: Opening raw socket on ifindex 7
Jan 1 04:07:53 udhcpc[1418]: Sending discover...
Jan 1 04:07:55 kernel: Link status change phy 4
Jan 1 04:07:55 udhcpc[1418]: Sending discover...
Jan 1 04:07:56 resident_phy_link_handler[1422]: record = phy:4;status:0
Jan 1 04:07:56 resident_phy_link_handler[1422]: phy - 4, status - 0
Jan 1 04:07:56 resident_phy_link_handler[1422]: etherwan key_l2=wan1
Jan 1 04:07:56 resident[1422]: stop ipoe on wan1_4
Jan 1 04:07:56 resident[1422]: set lock /var/lock/wan1_4.lock
Jan 1 04:07:56 udhcpc[1418]: Sending release...
Jan 1 04:07:56 dnsmasq-dhcp[184]: no address range available for DHCP request via lo
Jan 1 04:07:56 udhcpc[1418]: kernel_packet: Socket Result = 532
Jan 1 04:07:56 udhcpc[1425]: execle'ing /tmp/udhcpc with name deconfig
Jan 1 04:07:56 resident_phy_link_handler[1422]: Exit
Jan 1 04:07:56 event[1425]: file "/var/lock/wan1_4.lock" is set
Jan 1 04:07:56 event[1425]: udhcp_down fake
Jan 1 04:07:56 udhcpc[1418]: Received SIGTERM
Jan 1 04:07:57 kernel: Link status change phy 4
Jan 1 04:07:59 resident_phy_link_handler[1426]: record = phy:4;status:1
Jan 1 04:07:59 resident_phy_link_handler[1426]: phy - 4, status - 1
Jan 1 04:07:59 resident_phy_link_handler[1426]: etherwan key_l2=wan1
Jan 1 04:07:59 resident[1426]: start ipoe
Jan 1 04:07:59 start_ip[1426]: begin (wan1 -> wan1_4)
Jan 1 04:07:59 resident[1426]: start ipoe (v0) on wan1
Jan 1 04:07:59 udhcpc[1429]: UDHCP start..
Jan 1 04:07:59 udhcpc[1429]: udhcp client (v0.9.

started (iface: wan1, connect: 4)
Jan 1 04:07:59 udhcpc[1429]: interface wan1 index 7
Jan 1 04:07:59 udhcpc[1429]: interface wan1 hwaddr cc:b2:55:fe:60:7d
Jan 1 04:07:59 udhcpc[1429]: interface wan1 mtu is 1500
Jan 1 04:07:59 udhcpc[1430]: execle'ing /tmp/udhcpc with name deconfig
Jan 1 04:07:59 event[1430]: send event "ipoe down"
Jan 1 04:07:59 resident_phy_link_handler[1426]: Exit
Jan 1 04:07:59 resident[245]: record = action:down;iface:wan1;contag:4;
Jan 1 04:07:59 resident[245]: phys_iface wan1
Jan 1 04:07:59 resident_ipoe_handler[245]: ip_type = (null)
Jan 1 04:07:59 resident[245]: resident_ipoe_handler - Set default type: ipv4
Jan 1 04:07:59 resident[245]: phys_iface
Jan 1 04:07:59 resident[245]: resident_ipoe_handler - 2
Jan 1 04:07:59 resident_ipoe_handler[245]: name: wan1_4
Jan 1 04:07:59 resident[245]: resident_ipoe_handler - l2:wan1, l3:wan1_4, tun:, ip_type:0
Jan 1 04:07:59 resident[245]: ip_is_down on wan1_4
Jan 1 04:07:59 udhcpc[1429]: Opening raw socket on ifindex 7
Jan 1 04:07:59 udhcpc[1429]: Sending discover...
Jan 1 04:08:01 udhcpc[1429]: Sending discover...
Jan 1 04:08:04 kernel: Link status change phy 4
Jan 1 04:08:05 udhcpc[1429]: Sending discover...
Jan 1 04:08:06 resident_phy_link_handler[1434]: record = phy:4;status:0
Jan 1 04:08:06 resident_phy_link_handler[1434]: phy - 4, status - 0
Jan 1 04:08:06 resident_phy_link_handler[1434]: etherwan key_l2=wan1
Jan 1 04:08:06 resident[1434]: stop ipoe on wan1_4
Jan 1 04:08:06 resident[1434]: set lock /var/lock/wan1_4.lock
Jan 1 04:08:06 resident_phy_link_handler[1434]: Exit
Jan 1 04:08:06 udhcpc[1429]: Sending release...
Jan 1 04:08:06 udhcpc[1429]: kernel_packet: Socket Result = 532
Jan 1 04:08:06 udhcpc[1437]: execle'ing /tmp/udhcpc with name deconfig
Jan 1 04:08:06 event[1437]: file "/var/lock/wan1_4.lock" is set
Jan 1 04:08:06 event[1437]: udhcp_down fake
Jan 1 04:08:06 udhcpc[1429]: Received SIGTERM
Jan 1 04:08:06 dnsmasq-dhcp[184]: no address range available for DHCP request via lo
Jan 1 04:08:09 kernel: Link status change phy 4
Jan 1 04:08:11 resident_phy_link_handler[1438]: record = phy:4;status:1
Jan 1 04:08:11 resident_phy_link_handler[1438]: phy - 4, status - 1
Jan 1 04:08:11 resident_phy_link_handler[1438]: etherwan key_l2=wan1
Jan 1 04:08:11 resident[1438]: start ipoe
Jan 1 04:08:11 start_ip[1438]: begin (wan1 -> wan1_4)
Jan 1 04:08:11 resident[1438]: start ipoe (v0) on wan1
Jan 1 04:08:11 udhcpc[1441]: UDHCP start..
Jan 1 04:08:11 udhcpc[1441]: udhcp client (v0.9.

started (iface: wan1, connect: 4)
Jan 1 04:08:11 udhcpc[1441]: interface wan1 index 7
Jan 1 04:08:11 udhcpc[1441]: interface wan1 hwaddr cc:b2:55:fe:60:7d
Jan 1 04:08:11 udhcpc[1441]: interface wan1 mtu is 1500
Jan 1 04:08:11 udhcpc[1442]: execle'ing /tmp/udhcpc with name deconfig
Jan 1 04:08:11 event[1442]: send event "ipoe down"
Jan 1 04:08:11 resident_phy_link_handler[1438]: Exit
Jan 1 04:08:11 resident[245]: record = action:down;iface:wan1;contag:4;
Jan 1 04:08:11 resident[245]: phys_iface wan1
Jan 1 04:08:11 resident_ipoe_handler[245]: ip_type = (null)
Jan 1 04:08:11 resident[245]: resident_ipoe_handler - Set default type: ipv4
Jan 1 04:08:11 resident[245]: phys_iface
Jan 1 04:08:11 resident[245]: resident_ipoe_handler - 2
Jan 1 04:08:11 resident_ipoe_handler[245]: name: wan1_4
Jan 1 04:08:11 resident[245]: resident_ipoe_handler - l2:wan1, l3:wan1_4, tun:, ip_type:0
Jan 1 04:08:11 resident[245]: ip_is_down on wan1_4
Jan 1 04:08:11 udhcpc[1441]: Opening raw socket on ifindex 7
Jan 1 04:08:11 udhcpc[1441]: Sending discover...
Jan 1 04:08:12 udhcpc[1441]: Sending select for 10.129.81.54...
Jan 1 04:08:12 udhcpc[1441]: Lease of 10.129.81.54 obtained, lease time 46906
Jan 1 04:08:12 udhcpc[1445]: execle'ing /tmp/udhcpc with name bound
Jan 1 04:08:12 event[1445]: send event "ipoe up"
Jan 1 04:08:13 resident[245]: record = action:up;iface:wan1;contag:4;ipaddr:10.129.81.54 ;netmask:255.255.255.248 ;gateway:10.129.81.49 ;serverid:213.138.70.3 ;dns1:213.138.70.8;dns2:86.110.181.14;
Jan 1 04:08:13 resident[245]: phys_iface wan1
Jan 1 04:08:13 resident_ipoe_handler[245]: ip_type = (null)
Jan 1 04:08:13 resident[245]: resident_ipoe_handler - Set default type: ipv4
Jan 1 04:08:13 resident[245]: phys_iface
Jan 1 04:08:13 resident[245]: resident_ipoe_handler - 2
Jan 1 04:08:13 resident_ipoe_handler[245]: name: wan1_4
Jan 1 04:08:13 resident[245]: resident_ipoe_handler - l2:wan1, l3:wan1_4, tun:, ip_type:0
Jan 1 04:08:13 resident[245]: resident_ipoe_handler - ipv4
Jan 1 04:08:13 resident[245]: start ip_is_up on iface wan1_4
Jan 1 04:08:13 resident[245]: ip_is_up for link wan1_4
Jan 1 04:08:13 DMS_NL_API[245]: Rtnetlink answer: No such process
Jan 1 04:08:13 DMS_NL_API[245]: Error deleting route default via (null) dev wan1 m0
Jan 1 04:08:13 set_dhcp_routes[245]: set routes for iface wan1
Jan 1 04:08:13 triggerPingRespond[245]: OK
Jan 1 04:08:13 resident[245]: update rip
Jan 1 04:08:13 resident[245]: update igmpx
Jan 1 04:08:13 resident[245]: stop igmpx
Jan 1 04:08:13 kernel: et0: et_set_multicast_list, promisc = 1
Jan 1 04:08:13 kernel: wan1: del 01:00:5e:7f:ff:f6 mcast address from master interface
Jan 1 04:08:13 kernel: wan1: dev_set_allmulti(master, -1)
Jan 1 04:08:13 kernel: et0: et_set_multicast_list, promisc = 1
Jan 1 04:08:13 iface[245]: this is wan1
Jan 1 04:08:13 resident[245]: igmpx wan1
Jan 1 04:08:13 syslog: Loading liblogger v2.0.2
Jan 1 04:08:13 syslog: upstream ifaces: wan1
Jan 1 04:08:13 syslog: downstream ifaces: br0
Jan 1 04:08:13 syslog: hews interval = 120.0 sec
Jan 1 04:08:13 syslog: doublet join enabled
Jan 1 04:08:13 syslog: Using old argv style
Jan 1 04:08:13 syslog: daemonizing ...
Jan 1 04:08:13 syslog: kernel multicast version is 305 (v3.05 ?)
Jan 1 04:08:13 syslog: kernel mroute inited
Jan 1 04:08:13 syslog: proxy prepared
Jan 1 04:08:13 kernel: wan1: dev_set_allmulti(master, 1)
Jan 1 04:08:13 kernel: et0: et_set_multicast_list, promisc = 1
Jan 1 04:08:13 syslog: vifi #0 added for wan1
Jan 1 04:08:13 syslog: vifi #1 added for br0
Jan 1 04:08:13 resident[245]: update igmpx compiled
Jan 1 04:08:13 resident[245]: update ntpclient
Jan 1 04:08:13 syslog: valid VIF's configured: upstreams=1, downstreams=1. Ok.
Jan 1 04:08:13 update_ntpclient[245]: server string: ntpd &
Jan 1 04:08:13 autoupdate[245]: Downloading file: fwupdate.dlink.ru/dislocation
Jan 1 04:08:13 autoupdate[245]: Downloading file: fwupdate.dlink.ru/Router/DIR-615_K1/Firmware/exclude
Jan 1 04:08:13 autoupdate[245]: Not found exception
Jan 1 04:08:13 autoupdate[245]: Downloading file: fwupdate.dlink.ru/Router/DIR-615_K1/Firmware/latest
Jan 1 04:08:13 autoupdate[245]: Downloading file: fwupdate.dlink.ru/Router/DIR-615_K1/Firmware/20140711_1343_DIR_615K1_2.5.4_sdk-master.des
Jan 1 04:08:13 autoupdate[245]: Update not needed
Jan 1 04:08:14 syslog: added membership for 239.255.255.246 on upstream #0 10.129.81.54
Jan 1 04:08:14 syslog: added new route 239.255.255.246: 10.129.81.54 -> 192.168.0.1
Jan 1 04:08:14 kernel: et0: et_set_multicast_list, promisc = 1
Jan 1 04:08:14 kernel: wan1: add 01:00:5e:7f:ff:f6 mcast address to master interface
Jan 1 04:10:19 syslog: added membership for 239.255.255.250 on upstream #0 10.129.81.54
Jan 1 04:10:19 syslog: added new route 239.255.255.250: 10.129.81.54 -> 192.168.0.1
Jan 1 04:10:19 syslog: route 239.255.255.250 on upstream #0 activated with 192.168.0.65
Jan 1 04:10:19 kernel: et0: et_set_multicast_list, promisc = 1
Jan 1 04:10:19 kernel: wan1: add 01:00:5e:7f:ff:fa mcast address to master interface
Jan 1 04:10:20 syslog: leave group 224.0.0.251 from 192.168.0.253
Jan 1 04:10:26 syslog: leave group 224.0.0.251 from 192.168.0.253
Jan 1 04:11:45 kernel: Link status change phy 3
Jan 1 04:11:46 kernel: Link status change phy 3
Jan 1 04:11:48 resident_phy_link_handler[1568]: record = phy:3;status:0
Jan 1 04:11:48 resident_phy_link_handler[1568]: phy - 3, status - 0
Jan 1 04:11:48 resident_phy_link_handler[1568]: Exit
Jan 1 04:11:49 kernel: Link status change phy 3
Jan 1 04:11:51 resident_phy_link_handler[1573]: record = phy:3;status:1
Jan 1 04:11:51 resident_phy_link_handler[1573]: phy - 3, status - 1
Jan 1 04:11:51 resident_phy_link_handler[1573]: Exit
Jan 1 04:12:02 kernel: Link status change phy 3
Jan 1 04:12:03 resident_phy_link_handler[1575]: record = phy:3;status:0
Jan 1 04:12:03 resident_phy_link_handler[1575]: phy - 3, status - 0
Jan 1 04:12:03 resident_phy_link_handler[1575]: Exit
Jan 1 04:12:04 kernel: Link status change phy 3
Jan 1 04:12:05 dnsmasq[184]: script process exited with status 1
Jan 1 04:12:05 syslog: leave group 224.0.0.252 from 192.168.0.142
Jan 1 04:12:05 resident_phy_link_handler[1577]: record = phy:3;status:1
Jan 1 04:12:05 resident_phy_link_handler[1577]: phy - 3, status - 1
Jan 1 04:12:05 resident_phy_link_handler[1577]: Exit
Jan 1 04:12:05 syslog: active route 239.255.255.250 changed source from 192.168.0.65 to 192.168.0.142
Jan 1 04:12:05 syslog: route 239.255.255.250 on upstream #0 activated with 192.168.0.142
Jan 1 04:12:09 syslog: leave group 224.0.0.251 from 192.168.0.142
Jan 1 04:12:09 syslog: leave group 224.0.0.252 from 192.168.0.142
Jan 1 04:12:10 syslog: leave group 224.0.0.252 from 192.168.0.142
Jan 1 04:12:29 syslog: active route 239.255.255.250 changed source from 192.168.0.142 to 192.168.0.1
Jan 1 04:12:29 syslog: route 239.255.255.250 on upstream #0 activated with 192.168.0.1
Jan 1 04:12:35 syslog: route 239.255.255.250: all (1 item(s)) down VIF(s) NOT reported. Delete expired route.
Jan 1 04:12:35 kernel: et0: et_set_multicast_list, promisc = 1
Jan 1 04:12:35 kernel: wan1: del 01:00:5e:7f:ff:fa mcast address from master interface
Jan 1 04:12:35 syslog: removed route 239.255.255.250 on upstream #0 from origin 192.168.0.1
Jan 1 04:16:13 save config[1884]: saving... at line 133
Jan 1 04:16:13 write[1884]: line 978
Jan 1 04:16:13 save_to_flash[1884]: file size is 2979
Jan 1 04:16:14 save config[1884]: saving... at line 149
Jan 1 04:16:35 syslog: added membership for 239.255.255.250 on upstream #0 10.129.81.54
Jan 1 04:16:35 kernel: et0: et_set_multicast_list, promisc = 1
Jan 1 04:16:35 kernel: wan1: add 01:00:5e:7f:ff:fa mcast address to master interface
Jan 1 04:16:35 syslog: added new route 239.255.255.250: 10.129.81.54 -> 192.168.0.1
Jan 1 04:17:01 resident[1970]: update ntpclient
Jan 1 04:17:01 update_ntpclient[1970]: server string: ntpd -p ntp1.dlink.com -p ntp.dlink.com.tw&
Jan 1 04:17:04 save config[2008]: saving... at line 133
Jan 1 04:17:04 write[2008]: line 978
Jan 1 04:17:04 save_to_flash[2008]: file size is 2979
Jan 1 04:17:05 save config[2008]: saving... at line 149