Jan 1 00:00:14 syslogd started: BusyBox v1.19.2
Jan 1 00:00:14 resident: init lan
Jan 1 00:00:14 resident: start ipoe
Jan 1 00:00:14 start_ip: begin (br0 -> br0)
Jan 1 00:00:14 resident: start ipoe (v2139794072) on br0
Jan 1 00:00:14 kernel: arp_tables: (C) 2002 David S. Miller
Jan 1 00:00:14 kernel: TCP cubic registered
Jan 1 00:00:14 kernel: NET: Registered protocol family 1
Jan 1 00:00:14 kernel: NET: Registered protocol family 17
Jan 1 00:00:14 kernel: 802.1Q VLAN Support v1.8 Ben Greear
Jan 1 00:00:14 kernel: All bugs added by David S. Miller
Jan 1 00:00:14 kernel: nlmon: nlmon_init entry
Jan 1 00:00:14 kernel: VFS: Mounted root (squashfs filesystem) readonly.
Jan 1 00:00:14 kernel: Freeing unused kernel memory: 188k freed
Jan 1 00:00:14 kernel: Failed to execute /init
Jan 1 00:00:14 kernel: Failed to execute /sbin/preinit. Attempting defaults...
Jan 1 00:00:15 resident: init wan
Jan 1 00:00:15 resident: start ipoe
Jan 1 00:00:15 start_ip: begin (wan1 -> wan1_1)
Jan 1 00:00:15 resident: start ipoe (v2) on wan1
Jan 1 00:00:15 event: send event "ipoe down"
Jan 1 00:00:15 update_ddns: start
Jan 1 00:00:15 telnet-start: begin...
Jan 1 00:00:15 telnet-start: running on 23 port
Jan 1 00:00:15 telnet-start: succes!
Jan 1 00:00:15 printserver-start: begin...
Jan 1 00:00:15 printserver-start: success!
Jan 1 00:00:15 start_sysusers: init ...
Jan 1 00:00:15 start_sysusers: conf not NULL ...
Jan 1 00:00:15 resident: record = action:up;iface:br0;contag:0;ipaddr:192.168.0.1;netmask:255.255.255.0;dns1:;dns2:;
Jan 1 00:00:15 resident: phys_iface br0
Jan 1 00:00:15 test: ip_type = (null)
Jan 1 00:00:15 resident: resident_ipoe_handler - Set default type: ipv4
Jan 1 00:00:15 resident: phys_iface
Jan 1 00:00:15 resident: resident_ipoe_handler - 1
Jan 1 00:00:15 resident: resident_ipoe_handler - 3, name: br0
Jan 1 00:00:15 kernel: ehci_hcd: block sizes: qh 128 qtd 96 itd 192 sitd 96
Jan 1 00:00:15 kernel: PCI: Setting latency timer of device 0000:00:04.1 to 64
Jan 1 00:00:15 kernel: ehci_hcd 0000:00:04.1: EHCI Host Controller
Jan 1 00:00:15 kernel: drivers/usb/core/inode.c: creating file 'devices'
Jan 1 00:00:15 kernel: drivers/usb/core/inode.c: creating file '001'
Jan 1 00:00:15 kernel: ehci_hcd 0000:00:04.1: new USB bus registered, assigned bus number 1
Jan 1 00:00:15 kernel: ehci_hcd 0000:00:04.1: reset hcs_params 0x1212 dbg=0 cc=1 pcc=2 ordered ports=2
Jan 1 00:00:15 kernel: ehci_hcd 0000:00:04.1: reset hcc_params 2a026 thresh 2 uframes 256/512/1024 park
Jan 1 00:00:15 kernel: ehci_hcd 0000:00:04.1: EHCI Fastpath: New EHCI driver starting
Jan 1 00:00:15 kernel: ehci_hcd 0000:00:04.1: park 0
Jan 1 00:00:15 kernel: ehci_hcd 0000:00:04.1: MWI active
Jan 1 00:00:15 kernel: ehci_hcd 0000:00:04.1: ...powerdown ports...
Jan 1 00:00:15 kernel: ehci_hcd 0000:00:04.1: irq 5, io mem 0x18004000
Jan 1 00:00:15 kernel: ehci_hcd 0000:00:04.1: reset command 080b02 park=3 ithresh=8 period=1024 Reset HALT
Jan 1 00:00:15 kernel: ehci_hcd 0000:00:04.1: init command 010009 (park)=0 ithresh=1 period=256 RUN
Jan 1 00:00:15 kernel: ehci_hcd 0000:00:04.1: USB 0.0 started, EHCI 1.00, driver 10 Dec 2004
Jan 1 00:00:15 kernel: usb usb1: default language 0x0409
Jan 1 00:00:15 kernel: usb usb1: new device strings: Mfr=3, Product=2, SerialNumber=1
Jan 1 00:00:15 kernel: usb usb1: Product: EHCI Host Controller
Jan 1 00:00:15 kernel: usb usb1: Manufacturer: Linux 2.6.22 ehci_hcd
Jan 1 00:00:15 kernel: usb usb1: SerialNumber: 0000:00:04.1
Jan 1 00:00:15 kernel: usb usb1: uevent
Jan 1 00:00:15 kernel: usb usb1: usb_probe_device
Jan 1 00:00:15 kernel: usb usb1: configuration #1 chosen from 1 choice
Jan 1 00:00:15 kernel: usb usb1: adding 1-0:1.0 (config #1, interface 0)
Jan 1 00:00:15 kernel: usb 1-0:1.0: uevent
Jan 1 00:00:15 kernel: usb 1-0:1.0: uevent
Jan 1 00:00:15 kernel: hub 1-0:1.0: usb_probe_interface
Jan 1 00:00:15 kernel: hub 1-0:1.0: usb_probe_interface - got id
Jan 1 00:00:15 kernel: hub 1-0:1.0: USB hub found
Jan 1 00:00:15 kernel: hub 1-0:1.0: 2 ports detected
Jan 1 00:00:15 kernel: hub 1-0:1.0: standalone hub
Jan 1 00:00:15 kernel: hub 1-0:1.0: individual port power switching
Jan 1 00:00:15 kernel: hub 1-0:1.0: individual port over-current protection
Jan 1 00:00:15 kernel: hub 1-0:1.0: Single TT
Jan 1 00:00:15 kernel: hub 1-0:1.0: TT requires at most 8 FS bit times (666 ns)
Jan 1 00:00:15 kernel: hub 1-0:1.0: power on to power good time: 20ms
Jan 1 00:00:15 kernel: hub 1-0:1.0: local power source is good
Jan 1 00:00:15 kernel: hub 1-0:1.0: enabling power on all ports
Jan 1 00:00:15 kernel: hub 1-0:1.0: state 7 ports 2 chg 0000 evt 0000
Jan 1 00:00:15 kernel: drivers/usb/core/inode.c: creating file '001'
Jan 1 00:00:15 event: send event "ipoe up"
Jan 1 00:00:15 resident: resident_ipoe_handler - l2:br0, l3:br0, tun:, ip_type:0
Jan 1 00:00:15 resident: resident_ipoe_handler - ipv4
Jan 1 00:00:15 resident: start ip_is_up on iface br0
Jan 1 00:00:15 resident: ip_is_up for link br0
Jan 1 00:00:15 resident: start dhcp+dns on br0
Jan 1 00:00:15 kernel: ohci_hcd: 2006 August 04 USB 1.1 'Open' Host Controller (OHCI) Driver
Jan 1 00:00:15 kernel: ohci_hcd: block sizes: ed 64 td 64
Jan 1 00:00:15 kernel: PCI: Setting latency timer of device 0000:00:04.0 to 64
Jan 1 00:00:15 kernel: ohci_hcd 0000:00:04.0: OHCI Host Controller
Jan 1 00:00:15 kernel: drivers/usb/core/inode.c: creating file '002'
Jan 1 00:00:15 kernel: ohci_hcd 0000:00:04.0: new USB bus registered, assigned bus number 2
Jan 1 00:00:15 kernel: ohci_hcd 0000:00:04.0: created debug files
Jan 1 00:00:15 kernel: ohci_hcd 0000:00:04.0: irq 5, io mem 0x18009000
Jan 1 00:00:15 kernel: ohci_hcd 0000:00:04.0: OHCI controller state
Jan 1 00:00:15 kernel: ohci_hcd 0000:00:04.0: OHCI 1.0, NO legacy support registers
Jan 1 00:00:15 kernel: ohci_hcd 0000:00:04.0: control 0x083 HCFS=operational CBSR=3
Jan 1 00:00:15 kernel: ohci_hcd 0000:00:04.0: cmdstatus 0x00000 SOC=0
Jan 1 00:00:15 kernel: ohci_hcd 0000:00:04.0: intrstatus 0x00000004 SF
Jan 1 00:00:15 kernel: ohci_hcd 0000:00:04.0: intrenable 0x8000001a MIE UE RD WDH
Jan 1 00:00:15 kernel: ohci_hcd 0000:00:04.0: hcca frame #0005
Jan 1 00:00:15 kernel: ohci_hcd 0000:00:04.0: roothub.a 02000202 POTPGT=2 NPS NDP=2(2)
Jan 1 00:00:15 kernel: ohci_hcd 0000:00:04.0: roothub.b 00000000 PPCM=0000 DR=0000
Jan 1 00:00:15 kernel: ohci_hcd 0000:00:04.0: roothub.status 00008000 DRWE
Jan 1 00:00:15 kernel: ohci_hcd 0000:00:04.0: roothub.portstatus [0] 0x00000100 PPS
Jan 1 00:00:15 kernel: usb usb2: usb_probe_device
Jan 1 00:00:15 kernel: usb usb2: configuration #1 chosen from 1 choice
Jan 1 00:00:15 kernel: usb usb2: adding 2-0:1.0 (config #1, interface 0)
Jan 1 00:00:15 kernel: usb 2-0:1.0: uevent
Jan 1 00:00:15 kernel: usb 2-0:1.0: uevent
Jan 1 00:00:15 kernel: hub 2-0:1.0: usb_probe_interface
Jan 1 00:00:15 kernel: hub 2-0:1.0: usb_probe_interface - got id
Jan 1 00:00:15 kernel: hub 2-0:1.0: USB hub found
Jan 1 00:00:15 kernel: hub 2-0:1.0: 2 ports detected
Jan 1 00:00:15 kernel: hub 2-0:1.0: standalone hub
Jan 1 00:00:15 kernel: hub 2-0:1.0: no power switching (usb 1.0)
Jan 1 00:00:15 kernel: hub 2-0:1.0: global over-current protection
Jan 1 00:00:15 kernel: hub 2-0:1.0: power on to power good time: 4ms
Jan 1 00:00:15 kernel: hub 2-0:1.0: local power source is good
Jan 1 00:00:15 kernel: hub 2-0:1.0: no over-current condition exists
Jan 1 00:00:15 kernel: hub 2-0:1.0: trying to enable port power on non-switchable hub
Jan 1 00:00:15 upnp: start - begin
Jan 1 00:00:15 upnp: line 705
Jan 1 00:00:15 upnp: line 714
Jan 1 00:00:15 upnp: line 719
Jan 1 00:00:15 upnp: line 728
Jan 1 00:00:15 upnp: config_ifaces .F.*.^A value
Jan 1 00:00:15 upnp: line 752
Jan 1 00:00:15 upnp: line 767
Jan 1 00:00:15 upnp: line 773
Jan 1 00:00:15 upnp: line 781
Jan 1 00:00:15 kernel: hub 2-0:1.0: state 7 ports 2 chg 0000 evt 0000
Jan 1 00:00:15 kernel: drivers/usb/core/inode.c: creating file '001'
Jan 1 00:00:16 dnsmasq[326]: started, version 2.63 cachesize 512
Jan 1 00:00:16 dnsmasq[326]: compile time options: IPv6 GNU-getopt no-DBus no-i18n no-IDN DHCP DHCPv6 no-Lua no-TFTP no-conntrack
Jan 1 00:00:16 dnsmasq-dhcp[326]: DHCP, IP range 192.168.0.2 -- 192.168.0.254, lease time 1d
Jan 1 00:00:16 dnsmasq[326]: read /tmp/hosts - 2 addresses
Jan 1 00:00:16 dnsmasq-dhcp[326]: read /etc/ethers - 1 addresses
Jan 1 00:00:16 syslog: SNet version started
Jan 1 00:00:16 miniupnpd[328]: HTTP listening on port 44956
Jan 1 00:00:16 miniupnpd[328]: Listening for NAT-PMP traffic on port 5351
Jan 1 00:00:16 kernel: ohci_hcd 0000:00:04.0: auto-stop root hub
Jan 1 00:00:18 resident: record = action:down;iface:wan1;contag:1;
Jan 1 00:00:18 resident: phys_iface wan1
Jan 1 00:00:18 test: ip_type = (null)
Jan 1 00:00:18 resident: resident_ipoe_handler - Set default type: ipv4
Jan 1 00:00:18 resident: phys_iface
Jan 1 00:00:18 resident: resident_ipoe_handler - 2
Jan 1 00:00:18 resident: resident_ipoe_handler - 3, name: wan1_1
Jan 1 00:00:18 resident: resident_ipoe_handler - l2:wan1, l3:wan1_1, tun:wan1_3, ip_type:0
Jan 1 00:00:18 resident: ip_is_down on wan1_1
Jan 1 00:00:18 resident: record = action:up;iface:wan1;contag:1;ipaddr:10.48.104.119 ;netmask:255.255.255.128 ;gateway:10.48.104.1 ;dns1:79.140.28.5;
Jan 1 00:00:18 resident: phys_iface wan1
Jan 1 00:00:18 test: ip_type = (null)
Jan 1 00:00:18 resident: resident_ipoe_handler - Set default type: ipv4
Jan 1 00:00:18 resident: phys_iface
Jan 1 00:00:18 resident: resident_ipoe_handler - 2
Jan 1 00:00:18 resident: resident_ipoe_handler - 3, name: wan1_1
Jan 1 00:00:18 resident: resident_ipoe_handler - l2:wan1, l3:wan1_1, tun:wan1_3, ip_type:0
Jan 1 00:00:18 resident: resident_ipoe_handler - ipv4
Jan 1 00:00:18 resident: start ip_is_up on iface wan1_1
Jan 1 00:00:18 resident: ip_is_up for link wan1_1
Jan 1 00:00:18 set_dhcp_routes: set routes for iface wan1
Jan 1 00:00:18 resident: update dns
Jan 1 00:00:18 dnsmasq[326]: read /tmp/hosts - 2 addresses
Jan 1 00:00:18 dnsmasq-dhcp[326]: read /etc/ethers - 1 addresses
Jan 1 00:00:18 dnsmasq[326]: using nameserver 79.140.28.5#53
Jan 1 00:00:18 dnsmasq[326]: using nameserver 79.140.28.1#53
Jan 1 00:00:18 resident: update rip
Jan 1 00:00:18 resident: update igmpx
Jan 1 00:00:18 resident: stop igmpx
Jan 1 00:00:18 iface: this is wan1
Jan 1 00:00:18 resident: 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: update igmpx compiled
Jan 1 00:00:18 resident: update ntpclient
Jan 1 06:00:18 start_pppd: tunnel: ifaces/wan1/services/wan1_1/tunnels/wan1_3/
Jan 1 06:00:18 resident: start pppd on wan1_3
Jan 1 06:00:18 resident: stop pppd on wan1_3
Jan 1 06:00:18 resident: set lock on wan1_3, with "/var/lock/wan1_3.lock"
Jan 1 06:00:18 resident: stopped link(contype:pptp, iface:wan1_3)
Jan 1 06:00:18 pptp[386]: Plugin /usr/lib/pppd/pptp.so loaded.
Jan 1 06:00:18 pptp[386]: PPTP plugin version 0.8.3 compiled against pppd 2.4.4
Jan 1 06:00:18 pptp[389]: pppd 2.4.4 started by admin, uid 0
Jan 1 06:00:18 pptp[389]: Check server pptp.ufanet.ru
Jan 1 06:00:18 pptp[389]: route_add: have route to host on this dev wan1
Jan 1 06:00:18 pptp[390]: IP: 10.9.0.211
Jan 1 06:00:18 pptp[390]: control connection
Jan 1 06:00:18 pptp[390]: unix_sock
Jan 1 06:00:18 pptp[391]: Sent control packet type is 1 'Start-Control-Connection-Request'
Jan 1 06:00:18 pptp[391]: Received Start Control Connection Reply
Jan 1 06:00:18 pptp[391]: Client connection established.
Jan 1 06:00:19 pptp[391]: Sent control packet type is 7 'Outgoing-Call-Request'
Jan 1 06:00:19 pptp[391]: Received Outgoing Call Reply.
Jan 1 06:00:19 pptp[391]: Outgoing call established (call ID 1, peer's call ID 63321).
Jan 1 06:00:19 pptp[389]: Using interface ppp0
Jan 1 06:00:19 pptp[389]: Connect: ppp0 <--> pptp (pptp.ufanet.ru)
Jan 1 06:00:21 kernel: br0: port 2(eth0.1) entering disabled state
Jan 1 06:00:21 kernel: br0: port 1(eth1) entering disabled state
Jan 1 06:00:21 kernel: br0: port 2(eth0.1) entering learning state
Jan 1 06:00:21 kernel: br0: port 1(eth1) entering learning state
Jan 1 06:00:21 kernel: br0: topology change detected, propagating
Jan 1 06:00:21 kernel: br0: port 2(eth0.1) entering forwarding state
Jan 1 06:00:21 kernel: br0: topology change detected, propagating
Jan 1 06:00:21 kernel: br0: port 1(eth1) entering forwarding state
Jan 1 06:00:21 pptp[389]: CHAP authentication failed: 21
Jan 1 06:00:21 pptp[389]: CHAP authentication failed
Jan 1 06:00:21 pptp[389]: lcp_close: unit:0, reason: "Failed to authenticate ourselves to peer" (status: 19, state: 9, was_ip_down: 0)
Jan 1 06:00:21 pptp[389]: Connection terminated.
Jan 1 06:00:21 pptp[391]: Call disconnect notification received (call id 63321)
Jan 1 06:00:21 pptp[391]: Closing connection (unhandled)
Jan 1 06:00:21 pptp[391]: Sent control packet type is 12 'Call-Clear-Request'
Jan 1 06:00:21 pptp[391]: Closing connection (call state)
Jan 1 06:00:21 pptp[389]: lcp_close: unit:0, reason: "" (status: 19, state: 0, was_ip_down: 0)
Jan 1 06:00:21 pptp[389]: Couldn't get PPP statistics: No such device
Jan 1 06:00:21 pptp[389]: Terminating on signal 15
Jan 1 06:00:21 pptp[389]: Exit.(5)
Jan 1 10:04:26 kernel: et0: et_set_multicast_list, promisc = 1
Jan 1 10:04:26 kernel: wan1: add 01:00:5e:7f:ff:fa mcast address to master interface
Jan 1 10:04:26 syslog: added membership for 239.255.255.250 on upstream #0 10.48.104.119
Jan 1 10:04:26 syslog: added new route 239.255.255.250: 10.48.104.119 -> 192.168.0.1
Jan 1 10:04:26 syslog: route 239.255.255.250 on upstream #0 activated with 192.168.0.75
Jan 1 10:04:28 dnsmasq-dhcp[326]: DHCPREQUEST(br0) 192.168.0.75 cc:af:78:01:10:d4
Jan 1 10:04:28 dnsmasq-dhcp[326]: DHCPACK(br0) 192.168.0.75 cc:af:78:01:10:d4 Aspire5750G
Jan 1 10:04:32 dnsmasq-dhcp[326]: DHCPINFORM(br0) 192.168.0.75 cc:af:78:01:10:d4
Jan 1 10:04:32 dnsmasq-dhcp[326]: DHCPACK(br0) 192.168.0.75 cc:af:78:01:10:d4 Aspire5750G
Jan 1 10:04:41 syslog: active route 239.255.255.250 changed source from 192.168.0.75 to 10.48.105.106
Jan 1 10:04:41 syslog: route 239.255.255.250 on upstream #0 activated with 10.48.105.106
Jan 1 10:04:41 miniupnpd[328]: Can't find in which sub network the client is
Jan 1 10:05:33 dnsmasq-dhcp[326]: DHCPINFORM(br0) 192.168.0.75 cc:af:78:01:10:d4
Jan 1 10:05:33 dnsmasq-dhcp[326]: DHCPACK(br0) 192.168.0.75 cc:af:78:01:10:d4 Aspire5750G
Jan 1 10:05:41 miniupnpd[328]: Can't find in which sub network the client is
Jan 1 10:05:55 miniupnpd[328]: Failed to get ip address for interface
Jan 1 10:06:32 syslog: active route 239.255.255.250 changed source from 10.48.105.106 to 192.168.0.1
Jan 1 10:06:32 syslog: route 239.255.255.250 on upstream #0 activated with 192.168.0.1
Jan 1 10:06:36 dnsmasq-dhcp[326]: DHCPINFORM(br0) 192.168.0.75 cc:af:78:01:10:d4
Jan 1 10:06:36 dnsmasq-dhcp[326]: DHCPACK(br0) 192.168.0.75 cc:af:78:01:10:d4 Aspire5750G
Jan 1 10:06:41 syslog: route 239.255.255.250: all (1 item(s)) down VIF(s) NOT reported. Delete expired route.