Feb 24 19:24:53 ppp[22128]: Multi-link PPP daemon for FreeBSD Feb 24 19:24:53 ppp[22128]: Feb 24 19:24:53 ppp[22128]: process 22128 started, version 5.9 Feb 24 19:24:53 ppp[22128]: web: web is not running Feb 24 19:24:53 ppp[22128]: [wan] Bundle: Interface ng0 created Feb 24 19:24:53 ppp[22128]: [wan_link0] Link: OPEN event Feb 24 19:24:53 ppp[22128]: [wan_link0] LCP: Open event Feb 24 19:24:53 ppp[22128]: [wan_link0] LCP: state change Initial --> Starting Feb 24 19:24:53 ppp[22128]: [wan_link0] LCP: LayerStart Feb 24 19:24:53 ppp[22128]: [wan_link0] PPPoE: Connecting to '' Feb 24 19:24:53 ppp[22128]: PPPoE: rec'd ACNAME "HYD-HUAWEI-01" Feb 24 19:24:53 ppp[22128]: [wan_link0] PPPoE: connection successful Feb 24 19:24:53 ppp[22128]: [wan_link0] Link: UP event Feb 24 19:24:53 ppp[22128]: [wan_link0] LCP: Up event Feb 24 19:24:53 ppp[22128]: [wan_link0] LCP: state change Starting --> Req-Sent Feb 24 19:24:53 ppp[22128]: [wan_link0] LCP: SendConfigReq #1 Feb 24 19:24:53 ppp[22128]: [wan_link0] PROTOCOMP Feb 24 19:24:53 ppp[22128]: [wan_link0] MRU 1492 Feb 24 19:24:53 ppp[22128]: [wan_link0] MAGICNUM 0xe417c5b0 Feb 24 19:24:53 ppp[22128]: [wan_link0] LCP: rec'd Configure Reject #1 (Req-Sent) Feb 24 19:24:53 ppp[22128]: [wan_link0] PROTOCOMP Feb 24 19:24:53 ppp[22128]: [wan_link0] LCP: SendConfigReq #2 Feb 24 19:24:53 ppp[22128]: [wan_link0] MRU 1492 Feb 24 19:24:53 ppp[22128]: [wan_link0] MAGICNUM 0xe417c5b0 Feb 24 19:24:53 ppp[22128]: [wan_link0] LCP: rec'd Configure Ack #2 (Req-Sent) Feb 24 19:24:53 ppp[22128]: [wan_link0] MRU 1492 Feb 24 19:24:53 ppp[22128]: [wan_link0] MAGICNUM 0xe417c5b0 Feb 24 19:24:53 ppp[22128]: [wan_link0] LCP: state change Req-Sent --> Ack-Rcvd Feb 24 19:24:55 ppp[22128]: [wan_link0] LCP: state change Ack-Rcvd --> Req-Sent Feb 24 19:24:55 ppp[22128]: [wan_link0] LCP: SendConfigReq #3 Feb 24 19:24:55 ppp[22128]: [wan_link0] MRU 1492 Feb 24 19:24:55 ppp[22128]: [wan_link0] MAGICNUM 0xe417c5b0 Feb 24 19:24:55 ppp[22128]: [wan_link0] LCP: rec'd Configure Ack #3 (Req-Sent) Feb 24 19:24:55 ppp[22128]: [wan_link0] MRU 1492 Feb 24 19:24:55 ppp[22128]: [wan_link0] MAGICNUM 0xe417c5b0 Feb 24 19:24:55 ppp[22128]: [wan_link0] LCP: state change Req-Sent --> Ack-Rcvd Feb 24 19:24:56 ppp[22128]: [wan_link0] LCP: rec'd Configure Request #2 (Ack-Rcvd) Feb 24 19:24:56 ppp[22128]: [wan_link0] MRU 1492 Feb 24 19:24:56 ppp[22128]: [wan_link0] AUTHPROTO PAP Feb 24 19:24:56 ppp[22128]: [wan_link0] MAGICNUM 0xbd4090ca Feb 24 19:24:56 ppp[22128]: [wan_link0] LCP: SendConfigAck #2 Feb 24 19:24:56 ppp[22128]: [wan_link0] MRU 1492 Feb 24 19:24:56 ppp[22128]: [wan_link0] AUTHPROTO PAP Feb 24 19:24:56 ppp[22128]: [wan_link0] MAGICNUM 0xbd4090ca Feb 24 19:24:56 ppp[22128]: [wan_link0] LCP: state change Ack-Rcvd --> Opened Feb 24 19:24:56 ppp[22128]: [wan_link0] LCP: auth: peer wants PAP, I want nothing Feb 24 19:24:56 ppp[22128]: [wan_link0] PAP: using authname "test" Feb 24 19:24:56 ppp[22128]: [wan_link0] PAP: sending REQUEST #1 len: 17 Feb 24 19:24:56 ppp[22128]: [wan_link0] LCP: LayerUp Feb 24 19:24:56 ppp[22128]: [wan_link0] PAP: rec'd ACK #1 len: 27 Feb 24 19:24:56 ppp[22128]: [wan_link0] MESG: Authentication Success Feb 24 19:24:56 ppp[22128]: [wan_link0] LCP: authorization successful Feb 24 19:24:56 ppp[22128]: [wan_link0] Link: Matched action 'bundle "wan" ""' Feb 24 19:24:56 ppp[22128]: [wan_link0] Link: Join bundle "wan" Feb 24 19:24:56 ppp[22128]: [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps Feb 24 19:24:56 ppp[22128]: [wan] IPCP: Open event Feb 24 19:24:56 ppp[22128]: [wan] IPCP: state change Initial --> Starting Feb 24 19:24:56 ppp[22128]: [wan] IPCP: LayerStart Feb 24 19:24:56 ppp[22128]: [wan] IPV6CP: Open event Feb 24 19:24:56 ppp[22128]: [wan] IPV6CP: state change Initial --> Starting Feb 24 19:24:56 ppp[22128]: [wan] IPV6CP: LayerStart Feb 24 19:24:56 ppp[22128]: [wan] IPCP: Up event Feb 24 19:24:56 ppp[22128]: [wan] IPCP: state change Starting --> Req-Sent Feb 24 19:24:56 ppp[22128]: [wan] IPCP: SendConfigReq #1 Feb 24 19:24:56 ppp[22128]: [wan] IPADDR 0.0.0.0 Feb 24 19:24:56 ppp[22128]: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Feb 24 19:24:56 ppp[22128]: [wan] IPV6CP: Up event Feb 24 19:24:56 ppp[22128]: [wan] IPV6CP: state change Starting --> Req-Sent Feb 24 19:24:56 ppp[22128]: [wan] IPV6CP: SendConfigReq #1 Feb 24 19:24:56 ppp[22128]: [wan] IPCP: rec'd Configure Request #1 (Req-Sent) Feb 24 19:24:56 ppp[22128]: [wan] IPADDR 10.126.64.1 Feb 24 19:24:56 ppp[22128]: [wan] 10.126.64.1 is OK Feb 24 19:24:56 ppp[22128]: [wan] IPCP: SendConfigAck #1 Feb 24 19:24:56 ppp[22128]: [wan] IPADDR 10.126.64.1 Feb 24 19:24:56 ppp[22128]: [wan] IPCP: state change Req-Sent --> Ack-Sent Feb 24 19:24:56 ppp[22128]: [wan] IPCP: rec'd Configure Reject #1 (Ack-Sent) Feb 24 19:24:56 ppp[22128]: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Feb 24 19:24:56 ppp[22128]: [wan] IPCP: SendConfigReq #2 Feb 24 19:24:56 ppp[22128]: [wan] IPADDR 0.0.0.0 Feb 24 19:24:56 ppp[22128]: [wan_link0] LCP: rec'd Protocol Reject #3 (Opened) Feb 24 19:24:56 ppp[22128]: [wan_link0] LCP: protocol IPV6CP was rejected Feb 24 19:24:56 ppp[22128]: [wan] IPV6CP: protocol was rejected by peer Feb 24 19:24:56 ppp[22128]: [wan] IPV6CP: state change Req-Sent --> Stopped Feb 24 19:24:56 ppp[22128]: [wan] IPV6CP: LayerFinish Feb 24 19:24:56 ppp[22128]: [wan] IPCP: rec'd Configure Nak #2 (Ack-Sent) Feb 24 19:24:56 ppp[22128]: [wan] IPADDR 10.126.113.31 Feb 24 19:24:56 ppp[22128]: [wan] 10.126.113.31 is OK Feb 24 19:24:56 ppp[22128]: [wan] IPCP: SendConfigReq #3 Feb 24 19:24:56 ppp[22128]: [wan] IPADDR 10.126.113.31 Feb 24 19:24:56 ppp[22128]: [wan] IPCP: rec'd Configure Ack #3 (Ack-Sent) Feb 24 19:24:56 ppp[22128]: [wan] IPADDR 10.126.113.31 Feb 24 19:24:56 ppp[22128]: [wan] IPCP: state change Ack-Sent --> Opened Feb 24 19:24:56 ppp[22128]: [wan] IPCP: LayerUp Feb 24 19:24:56 ppp[22128]: [wan] 10.126.113.31 -> 10.126.64.1 Feb 24 19:24:56 ppp[22128]: [wan] IFACE: Up event Feb 24 19:24:56 ppp[22128]: [wan] IFACE: Rename interface ng0 to pppoe0 Feb 26 10:21:19 ppp[58954]: Multi-link PPP daemon for FreeBSD Feb 26 10:21:19 ppp[58954]: Feb 26 10:21:19 ppp[58954]: process 58954 started, version 5.9 Feb 26 10:21:19 ppp[58954]: waiting for process 22128 to die... Feb 26 10:21:19 ppp[22128]: caught fatal signal TERM Feb 26 10:21:19 ppp[22128]: [wan] IFACE: Close event Feb 26 10:21:19 ppp[22128]: [wan] IPCP: Close event Feb 26 10:21:19 ppp[22128]: [wan] IPCP: state change Opened --> Closing Feb 26 10:21:19 ppp[22128]: [wan] IPCP: SendTerminateReq #4 Feb 26 10:21:19 ppp[22128]: [wan] IPCP: LayerDown Feb 26 10:21:20 ppp[22128]: [wan] IFACE: Removing IPv4 address from pppoe0 failed(IGNORING for now. This should be only for PPPoE friendly!): Can't assign requested address Feb 26 10:21:20 ppp[22128]: [wan] IFACE: Down event Feb 26 10:21:20 ppp[22128]: [wan] IFACE: Rename interface pppoe0 to pppoe0 Feb 26 10:21:20 ppp[22128]: [wan] IPV6CP: Close event Feb 26 10:21:20 ppp[22128]: [wan] IPV6CP: state change Stopped --> Closed Feb 26 10:21:20 ppp[22128]: [wan] IPCP: rec'd Terminate Ack #4 (Closing) Feb 26 10:21:20 ppp[22128]: [wan] IPCP: state change Closing --> Closed Feb 26 10:21:20 ppp[22128]: [wan] IPCP: LayerFinish Feb 26 10:21:20 ppp[22128]: [wan] Bundle: No NCPs left. Closing links... Feb 26 10:21:20 ppp[22128]: [wan] Bundle: closing link "wan_link0"... Feb 26 10:21:20 ppp[22128]: [wan_link0] Link: CLOSE event Feb 26 10:21:20 ppp[22128]: [wan_link0] LCP: Close event Feb 26 10:21:20 ppp[22128]: [wan_link0] LCP: state change Opened --> Closing Feb 26 10:21:20 ppp[22128]: [wan_link0] Link: Leave bundle "wan" Feb 26 10:21:20 ppp[22128]: [wan] Bundle: Status update: up 0 links, total bandwidth 9600 bps Feb 26 10:21:20 ppp[22128]: [wan] IPCP: Close event Feb 26 10:21:20 ppp[22128]: [wan] IPV6CP: Close event Feb 26 10:21:20 ppp[22128]: [wan] IPCP: Down event Feb 26 10:21:20 ppp[22128]: [wan] IPCP: state change Closed --> Initial Feb 26 10:21:20 ppp[22128]: [wan] IPV6CP: Down event Feb 26 10:21:20 ppp[22128]: [wan] IPV6CP: state change Closed --> Initial Feb 26 10:21:20 ppp[22128]: [wan_link0] LCP: SendTerminateReq #4 Feb 26 10:21:20 ppp[22128]: [wan_link0] LCP: LayerDown Feb 26 10:21:20 ppp[22128]: [wan_link0] LCP: rec'd Terminate Ack #4 (Closing) Feb 26 10:21:20 ppp[22128]: [wan_link0] LCP: state change Closing --> Closed Feb 26 10:21:20 ppp[22128]: [wan_link0] LCP: LayerFinish Feb 26 10:21:20 ppp[22128]: [wan_link0] Link: DOWN event Feb 26 10:21:20 ppp[22128]: [wan_link0] LCP: Down event Feb 26 10:21:20 ppp[22128]: [wan_link0] LCP: state change Closed --> Initial Feb 26 10:21:21 ppp[58954]: waiting for process 22128 to die... Feb 26 10:21:22 ppp[58954]: waiting for process 22128 to die... Feb 26 10:21:22 ppp[22128]: [wan] Bundle: Shutdown Feb 26 10:21:22 ppp[22128]: [wan_link0] Link: Shutdown Feb 26 10:21:22 ppp[22128]: process 22128 terminated Feb 26 10:21:23 ppp[58954]: web: web is not running Feb 26 10:21:23 ppp[58954]: [wan] Bundle: Interface ng0 created Feb 26 10:21:23 ppp[58954]: [wan_link0] Link: OPEN event Feb 26 10:21:23 ppp[58954]: [wan_link0] LCP: Open event Feb 26 10:21:23 ppp[58954]: [wan_link0] LCP: state change Initial --> Starting Feb 26 10:21:23 ppp[58954]: [wan_link0] LCP: LayerStart Feb 26 10:21:23 ppp[58954]: [wan_link0] PPPoE: Connecting to '' Feb 26 10:21:23 ppp[58954]: PPPoE: rec'd ACNAME "HYD-HUAWEI-01" Feb 26 10:21:25 ppp[58954]: [wan_link0] PPPoE: connection successful Feb 26 10:21:25 ppp[58954]: [wan_link0] Link: UP event Feb 26 10:21:25 ppp[58954]: [wan_link0] LCP: Up event Feb 26 10:21:25 ppp[58954]: [wan_link0] LCP: state change Starting --> Req-Sent Feb 26 10:21:25 ppp[58954]: [wan_link0] LCP: SendConfigReq #1 Feb 26 10:21:25 ppp[58954]: [wan_link0] PROTOCOMP Feb 26 10:21:25 ppp[58954]: [wan_link0] MRU 1492 Feb 26 10:21:25 ppp[58954]: [wan_link0] MAGICNUM 0x795ba194 Feb 26 10:21:25 ppp[58954]: [wan_link0] LCP: rec'd Configure Reject #1 (Req-Sent) Feb 26 10:21:25 ppp[58954]: [wan_link0] PROTOCOMP Feb 26 10:21:25 ppp[58954]: [wan_link0] LCP: SendConfigReq #2 Feb 26 10:21:25 ppp[58954]: [wan_link0] MRU 1492 Feb 26 10:21:25 ppp[58954]: [wan_link0] MAGICNUM 0x795ba194 Feb 26 10:21:25 ppp[58954]: [wan_link0] LCP: rec'd Configure Ack #2 (Req-Sent) Feb 26 10:21:25 ppp[58954]: [wan_link0] MRU 1492 Feb 26 10:21:25 ppp[58954]: [wan_link0] MAGICNUM 0x795ba194 Feb 26 10:21:25 ppp[58954]: [wan_link0] LCP: state change Req-Sent --> Ack-Rcvd Feb 26 10:21:27 ppp[58954]: [wan_link0] LCP: state change Ack-Rcvd --> Req-Sent Feb 26 10:21:27 ppp[58954]: [wan_link0] LCP: SendConfigReq #3 Feb 26 10:21:27 ppp[58954]: [wan_link0] MRU 1492 Feb 26 10:21:27 ppp[58954]: [wan_link0] MAGICNUM 0x795ba194 Feb 26 10:21:27 ppp[58954]: [wan_link0] LCP: rec'd Configure Ack #3 (Req-Sent) Feb 26 10:21:27 ppp[58954]: [wan_link0] MRU 1492 Feb 26 10:21:27 ppp[58954]: [wan_link0] MAGICNUM 0x795ba194 Feb 26 10:21:27 ppp[58954]: [wan_link0] LCP: state change Req-Sent --> Ack-Rcvd Feb 26 10:21:27 ppp[58954]: [wan_link0] LCP: rec'd Configure Request #2 (Ack-Rcvd) Feb 26 10:21:27 ppp[58954]: [wan_link0] MRU 1492 Feb 26 10:21:27 ppp[58954]: [wan_link0] AUTHPROTO PAP Feb 26 10:21:27 ppp[58954]: [wan_link0] MAGICNUM 0x9bc6a51b Feb 26 10:21:27 ppp[58954]: [wan_link0] LCP: SendConfigAck #2 Feb 26 10:21:27 ppp[58954]: [wan_link0] MRU 1492 Feb 26 10:21:27 ppp[58954]: [wan_link0] AUTHPROTO PAP Feb 26 10:21:27 ppp[58954]: [wan_link0] MAGICNUM 0x9bc6a51b Feb 26 10:21:27 ppp[58954]: [wan_link0] LCP: state change Ack-Rcvd --> Opened Feb 26 10:21:27 ppp[58954]: [wan_link0] LCP: auth: peer wants PAP, I want nothing Feb 26 10:21:27 ppp[58954]: [wan_link0] PAP: using authname "test" Feb 26 10:21:27 ppp[58954]: [wan_link0] PAP: sending REQUEST #1 len: 17 Feb 26 10:21:27 ppp[58954]: [wan_link0] LCP: LayerUp Feb 26 10:21:27 ppp[58954]: [wan_link0] PAP: rec'd ACK #1 len: 27 Feb 26 10:21:27 ppp[58954]: [wan_link0] MESG: Authentication Success Feb 26 10:21:27 ppp[58954]: [wan_link0] LCP: authorization successful Feb 26 10:21:27 ppp[58954]: [wan_link0] Link: Matched action 'bundle "wan" ""' Feb 26 10:21:27 ppp[58954]: [wan_link0] Link: Join bundle "wan" Feb 26 10:21:27 ppp[58954]: [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps Feb 26 10:21:27 ppp[58954]: [wan] IPCP: Open event Feb 26 10:21:27 ppp[58954]: [wan] IPCP: state change Initial --> Starting Feb 26 10:21:27 ppp[58954]: [wan] IPCP: LayerStart Feb 26 10:21:27 ppp[58954]: [wan] IPV6CP: Open event Feb 26 10:21:27 ppp[58954]: [wan] IPV6CP: state change Initial --> Starting Feb 26 10:21:27 ppp[58954]: [wan] IPV6CP: LayerStart Feb 26 10:21:27 ppp[58954]: [wan] IPCP: Up event Feb 26 10:21:27 ppp[58954]: [wan] IPCP: state change Starting --> Req-Sent Feb 26 10:21:27 ppp[58954]: [wan] IPCP: SendConfigReq #1 Feb 26 10:21:27 ppp[58954]: [wan] IPADDR 0.0.0.0 Feb 26 10:21:27 ppp[58954]: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Feb 26 10:21:27 ppp[58954]: [wan] IPV6CP: Up event Feb 26 10:21:27 ppp[58954]: [wan] IPV6CP: state change Starting --> Req-Sent Feb 26 10:21:27 ppp[58954]: [wan] IPV6CP: SendConfigReq #1 Feb 26 10:21:28 ppp[58954]: [wan] IPCP: rec'd Configure Reject #1 (Req-Sent) Feb 26 10:21:28 ppp[58954]: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Feb 26 10:21:28 ppp[58954]: [wan] IPCP: SendConfigReq #2 Feb 26 10:21:28 ppp[58954]: [wan] IPADDR 0.0.0.0 Feb 26 10:21:28 ppp[58954]: [wan_link0] LCP: rec'd Protocol Reject #3 (Opened) Feb 26 10:21:28 ppp[58954]: [wan_link0] LCP: protocol IPV6CP was rejected Feb 26 10:21:28 ppp[58954]: [wan] IPV6CP: protocol was rejected by peer Feb 26 10:21:28 ppp[58954]: [wan] IPV6CP: state change Req-Sent --> Stopped Feb 26 10:21:28 ppp[58954]: [wan] IPV6CP: LayerFinish Feb 26 10:21:28 ppp[58954]: [wan] IPCP: rec'd Configure Nak #2 (Req-Sent) Feb 26 10:21:28 ppp[58954]: [wan] IPADDR 10.126.95.29 Feb 26 10:21:28 ppp[58954]: [wan] 10.126.95.29 is OK Feb 26 10:21:28 ppp[58954]: [wan] IPCP: SendConfigReq #3 Feb 26 10:21:28 ppp[58954]: [wan] IPADDR 10.126.95.29 Feb 26 10:21:28 ppp[58954]: [wan] IPCP: rec'd Configure Ack #3 (Req-Sent) Feb 26 10:21:28 ppp[58954]: [wan] IPADDR 10.126.95.29 Feb 26 10:21:28 ppp[58954]: [wan] IPCP: state change Req-Sent --> Ack-Rcvd Feb 26 10:21:30 ppp[58954]: [wan] IPCP: state change Ack-Rcvd --> Req-Sent Feb 26 10:21:30 ppp[58954]: [wan] IPCP: SendConfigReq #4 Feb 26 10:21:30 ppp[58954]: [wan] IPADDR 10.126.95.29 Feb 26 10:21:30 ppp[58954]: [wan] IPCP: rec'd Configure Ack #4 (Req-Sent) Feb 26 10:21:30 ppp[58954]: [wan] IPADDR 10.126.95.29 Feb 26 10:21:30 ppp[58954]: [wan] IPCP: state change Req-Sent --> Ack-Rcvd Feb 26 10:21:30 ppp[58954]: [wan] IPCP: rec'd Configure Request #2 (Ack-Rcvd) Feb 26 10:21:30 ppp[58954]: [wan] IPADDR 10.126.64.1 Feb 26 10:21:30 ppp[58954]: [wan] 10.126.64.1 is OK Feb 26 10:21:30 ppp[58954]: [wan] IPCP: SendConfigAck #2 Feb 26 10:21:30 ppp[58954]: [wan] IPADDR 10.126.64.1 Feb 26 10:21:30 ppp[58954]: [wan] IPCP: state change Ack-Rcvd --> Opened Feb 26 10:21:30 ppp[58954]: [wan] IPCP: LayerUp Feb 26 10:21:30 ppp[58954]: [wan] 10.126.95.29 -> 10.126.64.1 Feb 26 10:21:30 ppp[58954]: [wan] IFACE: Up event Feb 26 10:21:30 ppp[58954]: [wan] IFACE: Rename interface ng0 to pppoe0