Sep 11 05:03:55 ppp 785 [wan_link0] MAGICNUM 0x4fd69f75 Sep 11 05:03:57 ppp 785 [wan_link0] LCP: SendConfigReq #52 Sep 11 05:03:57 ppp 785 [wan_link0] PROTOCOMP Sep 11 05:03:57 ppp 785 [wan_link0] MRU 1492 Sep 11 05:03:57 ppp 785 [wan_link0] MAGICNUM 0x4fd69f75 Sep 11 05:03:59 ppp 785 [wan_link0] LCP: SendConfigReq #53 Sep 11 05:03:59 ppp 785 [wan_link0] PROTOCOMP Sep 11 05:03:59 ppp 785 [wan_link0] MRU 1492 Sep 11 05:03:59 ppp 785 [wan_link0] MAGICNUM 0x4fd69f75 Sep 11 05:04:01 ppp 785 [wan_link0] LCP: SendConfigReq #54 Sep 11 05:04:01 ppp 785 [wan_link0] PROTOCOMP Sep 11 05:04:01 ppp 785 [wan_link0] MRU 1492 Sep 11 05:04:01 ppp 785 [wan_link0] MAGICNUM 0x4fd69f75 Sep 11 05:04:03 ppp 785 [wan_link0] LCP: SendConfigReq #55 Sep 11 05:04:03 ppp 785 [wan_link0] PROTOCOMP Sep 11 05:04:03 ppp 785 [wan_link0] MRU 1492 Sep 11 05:04:03 ppp 785 [wan_link0] MAGICNUM 0x4fd69f75 Sep 11 05:04:03 ppp 785 [wan_link0] LCP: rec'd Configure Request #1 (Ack-Sent) Sep 11 05:04:03 ppp 785 [wan_link0] MRU 1492 Sep 11 05:04:03 ppp 785 [wan_link0] AUTHPROTO PAP Sep 11 05:04:03 ppp 785 [wan_link0] MAGICNUM 0x10bf6245 Sep 11 05:04:03 ppp 785 [wan_link0] LCP: SendConfigAck #1 Sep 11 05:04:03 ppp 785 [wan_link0] MRU 1492 Sep 11 05:04:03 ppp 785 [wan_link0] AUTHPROTO PAP Sep 11 05:04:03 ppp 785 [wan_link0] MAGICNUM 0x10bf6245 Sep 11 05:04:03 ppp 785 [wan_link0] LCP: rec'd Configure Ack #55 (Ack-Sent) Sep 11 05:04:03 ppp 785 [wan_link0] PROTOCOMP Sep 11 05:04:03 ppp 785 [wan_link0] MRU 1492 Sep 11 05:04:03 ppp 785 [wan_link0] MAGICNUM 0x4fd69f75 Sep 11 05:04:03 ppp 785 [wan_link0] LCP: state change Ack-Sent --> Opened Sep 11 05:04:03 ppp 785 [wan_link0] LCP: auth: peer wants PAP, I want nothing Sep 11 05:04:03 ppp 785 [wan_link0] PAP: using authname "davidjcartledge" Sep 11 05:04:03 ppp 785 [wan_link0] PAP: sending REQUEST #1 len: 29 Sep 11 05:04:03 ppp 785 [wan_link0] LCP: LayerUp Sep 11 05:04:05 ppp 785 [wan_link0] PAP: using authname "davidjcartledge" Sep 11 05:04:05 ppp 785 [wan_link0] PAP: sending REQUEST #2 len: 29 Sep 11 05:04:07 ppp 785 [wan_link0] PAP: using authname "davidjcartledge" Sep 11 05:04:07 ppp 785 [wan_link0] PAP: sending REQUEST #3 len: 29 Sep 11 05:04:09 ppp 785 [wan_link0] PAP: using authname "davidjcartledge" Sep 11 05:04:09 ppp 785 [wan_link0] PAP: sending REQUEST #4 len: 29 Sep 11 05:04:11 ppp 785 [wan_link0] PAP: using authname "davidjcartledge" Sep 11 05:04:11 ppp 785 [wan_link0] PAP: sending REQUEST #5 len: 29 Sep 11 05:04:25 ppp 785 [wan_link0] rec'd proto IPCP during authenticate phase Sep 11 05:04:37 ppp 785 [wan_link0] rec'd proto IPCP during authenticate phase Sep 11 05:04:43 ppp 785 [wan_link0] LCP: authorization timer expired Sep 11 05:04:43 ppp 785 [wan_link0] LCP: authorization failed Sep 11 05:04:43 ppp 785 [wan_link0] LCP: parameter negotiation failed Sep 11 05:04:43 ppp 785 [wan_link0] LCP: state change Opened --> Stopping Sep 11 05:04:43 ppp 785 [wan_link0] LCP: SendTerminateReq #56 Sep 11 05:04:43 ppp 785 [wan_link0] LCP: LayerDown Sep 11 05:04:43 ppp 785 [wan_link0] LCP: rec'd Terminate Ack #56 (Stopping) Sep 11 05:04:43 ppp 785 [wan_link0] LCP: state change Stopping --> Stopped Sep 11 05:04:43 ppp 785 [wan_link0] LCP: LayerFinish Sep 11 05:04:43 ppp 785 [wan_link0] PPPoE: connection closed Sep 11 05:04:43 ppp 785 [wan_link0] Link: DOWN event Sep 11 05:04:43 ppp 785 [wan_link0] LCP: Down event Sep 11 05:04:43 ppp 785 [wan_link0] LCP: state change Stopped --> Starting Sep 11 05:04:43 ppp 785 [wan_link0] LCP: LayerStart Sep 11 05:04:43 ppp 785 [wan_link0] Link: reconnection attempt 65 in 1 seconds Sep 11 05:04:44 ppp 785 [wan_link0] Link: reconnection attempt 65 Sep 11 05:04:44 ppp 785 [wan_link0] PPPoE: Connecting to 'iinet' Sep 11 05:04:53 ppp 785 [wan_link0] PPPoE connection timeout after 9 seconds Sep 11 05:04:53 ppp 785 [wan_link0] Link: DOWN event Sep 11 05:04:53 ppp 785 [wan_link0] LCP: Down event Sep 11 05:04:53 ppp 785 [wan_link0] Link: reconnection attempt 66 in 2 seconds Sep 11 05:04:55 ppp 785 [wan_link0] Link: reconnection attempt 66 Sep 11 05:04:55 ppp 785 [wan_link0] PPPoE: Connecting to 'iinet' Sep 11 05:05:04 ppp 785 [wan_link0] PPPoE connection timeout after 9 seconds Sep 11 05:05:04 ppp 785 [wan_link0] Link: DOWN event Sep 11 05:05:04 ppp 785 [wan_link0] LCP: Down event Sep 11 05:05:04 ppp 785 [wan_link0] Link: reconnection attempt 67 in 4 seconds Sep 11 05:05:08 ppp 785 [wan_link0] Link: reconnection attempt 67 Sep 11 05:05:08 ppp 785 [wan_link0] PPPoE: Connecting to 'iinet' Sep 11 05:05:17 ppp 785 [wan_link0] PPPoE connection timeout after 9 seconds Sep 11 05:05:17 ppp 785 [wan_link0] Link: DOWN event Sep 11 05:05:17 ppp 785 [wan_link0] LCP: Down event Sep 11 05:05:17 ppp 785 [wan_link0] Link: reconnection attempt 68 in 2 seconds Sep 11 05:05:19 ppp 785 [wan_link0] Link: reconnection attempt 68 Sep 11 05:05:19 ppp 785 [wan_link0] PPPoE: Connecting to 'iinet' Sep 11 05:05:28 ppp 785 [wan_link0] PPPoE connection timeout after 9 seconds Sep 11 05:05:28 ppp 785 [wan_link0] Link: DOWN event Sep 11 05:05:28 ppp 785 [wan_link0] LCP: Down event Sep 11 05:05:28 ppp 785 [wan_link0] Link: reconnection attempt 69 in 1 seconds Sep 11 05:05:29 ppp 785 [wan_link0] Link: reconnection attempt 69 Sep 11 05:05:29 ppp 785 [wan_link0] PPPoE: Connecting to 'iinet' Sep 11 05:05:38 ppp 785 [wan_link0] PPPoE connection timeout after 9 seconds Sep 11 05:05:38 ppp 785 [wan_link0] Link: DOWN event Sep 11 05:05:38 ppp 785 [wan_link0] LCP: Down event Sep 11 05:05:38 ppp 785 [wan_link0] Link: reconnection attempt 70 in 4 seconds Sep 11 05:05:42 ppp 785 [wan_link0] Link: reconnection attempt 70 Sep 11 05:05:42 ppp 785 [wan_link0] PPPoE: Connecting to 'iinet' Sep 11 05:05:51 ppp 785 [wan_link0] PPPoE connection timeout after 9 seconds Sep 11 05:05:51 ppp 785 [wan_link0] Link: DOWN event Sep 11 05:05:51 ppp 785 [wan_link0] LCP: Down event Sep 11 05:05:51 ppp 785 [wan_link0] Link: reconnection attempt 71 in 4 seconds Sep 11 05:05:55 ppp 785 [wan_link0] Link: reconnection attempt 71 Sep 11 05:05:55 ppp 785 [wan_link0] PPPoE: Connecting to 'iinet' Sep 11 05:06:04 ppp 785 [wan_link0] PPPoE connection timeout after 9 seconds Sep 11 05:06:04 ppp 785 [wan_link0] Link: DOWN event Sep 11 05:06:04 ppp 785 [wan_link0] LCP: Down event Sep 11 05:06:04 ppp 785 [wan_link0] Link: reconnection attempt 72 in 2 seconds Sep 11 05:06:06 ppp 785 [wan_link0] Link: reconnection attempt 72 Sep 11 05:06:06 ppp 785 [wan_link0] PPPoE: Connecting to 'iinet' Sep 11 05:06:12 ppp 785 PPPoE: rec'd ACNAME "bri-apt-wic-bras205" Sep 11 05:06:15 ppp 785 [wan_link0] PPPoE connection timeout after 9 seconds Sep 11 05:06:15 ppp 785 [wan_link0] Link: DOWN event Sep 11 05:06:15 ppp 785 [wan_link0] LCP: Down event Sep 11 05:06:15 ppp 785 [wan_link0] Link: reconnection attempt 73 in 3 seconds Sep 11 05:06:18 ppp 785 [wan_link0] Link: reconnection attempt 73 Sep 11 05:06:18 ppp 785 [wan_link0] PPPoE: Connecting to 'iinet' Sep 11 05:06:18 ppp 785 PPPoE: rec'd ACNAME "bri-apt-wic-bras204" Sep 11 05:06:18 ppp 785 [wan_link0] PPPoE: connection successful Sep 11 05:06:18 ppp 785 [wan_link0] Link: UP event Sep 11 05:06:18 ppp 785 [wan_link0] LCP: Up event Sep 11 05:06:18 ppp 785 [wan_link0] LCP: state change Starting --> Req-Sent Sep 11 05:06:18 ppp 785 [wan_link0] LCP: SendConfigReq #57 Sep 11 05:06:18 ppp 785 [wan_link0] PROTOCOMP Sep 11 05:06:18 ppp 785 [wan_link0] MRU 1492 Sep 11 05:06:18 ppp 785 [wan_link0] MAGICNUM 0x4c4befd6 Sep 11 05:06:18 ppp 785 [wan_link0] LCP: rec'd Configure Request #1 (Req-Sent) Sep 11 05:06:18 ppp 785 [wan_link0] MRU 1492 Sep 11 05:06:18 ppp 785 [wan_link0] AUTHPROTO PAP Sep 11 05:06:18 ppp 785 [wan_link0] MAGICNUM 0x4fa4da0c Sep 11 05:06:18 ppp 785 [wan_link0] LCP: SendConfigAck #1 Sep 11 05:06:18 ppp 785 [wan_link0] MRU 1492 Sep 11 05:06:18 ppp 785 [wan_link0] AUTHPROTO PAP Sep 11 05:06:18 ppp 785 [wan_link0] MAGICNUM 0x4fa4da0c Sep 11 05:06:18 ppp 785 [wan_link0] LCP: state change Req-Sent --> Ack-Sent Sep 11 05:06:18 ppp 785 [wan_link0] LCP: rec'd Configure Ack #57 (Ack-Sent) Sep 11 05:06:18 ppp 785 [wan_link0] PROTOCOMP Sep 11 05:06:18 ppp 785 [wan_link0] MRU 1492 Sep 11 05:06:18 ppp 785 [wan_link0] MAGICNUM 0x4c4befd6 Sep 11 05:06:18 ppp 785 [wan_link0] LCP: state change Ack-Sent --> Opened Sep 11 05:06:18 ppp 785 [wan_link0] LCP: auth: peer wants PAP, I want nothing Sep 11 05:06:18 ppp 785 [wan_link0] PAP: using authname "davidjcartledge" Sep 11 05:06:18 ppp 785 [wan_link0] PAP: sending REQUEST #1 len: 29 Sep 11 05:06:18 ppp 785 [wan_link0] LCP: LayerUp Sep 11 05:06:20 ppp 785 [wan_link0] PAP: using authname "davidjcartledge" Sep 11 05:06:20 ppp 785 [wan_link0] PAP: sending REQUEST #2 len: 29 Sep 11 05:06:22 ppp 785 [wan_link0] PAP: using authname "davidjcartledge" Sep 11 05:06:22 ppp 785 [wan_link0] PAP: sending REQUEST #3 len: 29 Sep 11 05:06:24 ppp 785 [wan_link0] PAP: using authname "davidjcartledge" Sep 11 05:06:24 ppp 785 [wan_link0] PAP: sending REQUEST #4 len: 29 Sep 11 05:06:24 ppp 785 [wan_link0] rec'd proto IPCP during authenticate phase Sep 11 05:06:26 ppp 785 [wan_link0] PAP: using authname "davidjcartledge" Sep 11 05:06:26 ppp 785 [wan_link0] PAP: sending REQUEST #5 len: 29 Sep 11 05:06:54 ppp 785 [wan_link0] rec'd proto IPCP during authenticate phase Sep 11 05:06:58 ppp 785 [wan_link0] LCP: authorization timer expired Sep 11 05:06:58 ppp 785 [wan_link0] LCP: authorization failed Sep 11 05:06:58 ppp 785 [wan_link0] LCP: parameter negotiation failed Sep 11 05:06:58 ppp 785 [wan_link0] LCP: state change Opened --> Stopping Sep 11 05:06:58 ppp 785 [wan_link0] LCP: SendTerminateReq #58 Sep 11 05:06:58 ppp 785 [wan_link0] LCP: LayerDown Sep 11 05:06:58 ppp 785 [wan_link0] LCP: rec'd Terminate Ack #58 (Stopping) Sep 11 05:06:58 ppp 785 [wan_link0] LCP: state change Stopping --> Stopped Sep 11 05:06:58 ppp 785 [wan_link0] LCP: LayerFinish Sep 11 05:06:58 ppp 785 [wan_link0] PPPoE: connection closed Sep 11 05:06:58 ppp 785 [wan_link0] Link: DOWN event Sep 11 05:06:58 ppp 785 [wan_link0] LCP: Down event Sep 11 05:06:58 ppp 785 [wan_link0] LCP: state change Stopped --> Starting Sep 11 05:06:58 ppp 785 [wan_link0] LCP: LayerStart Sep 11 05:06:58 ppp 785 [wan_link0] Link: reconnection attempt 74 in 4 seconds Sep 11 05:07:02 ppp 785 [wan_link0] Link: reconnection attempt 74 Sep 11 05:07:02 ppp 785 [wan_link0] PPPoE: Connecting to 'iinet' Sep 11 05:07:11 ppp 785 [wan_link0] PPPoE connection timeout after 9 seconds Sep 11 05:07:11 ppp 785 [wan_link0] Link: DOWN event Sep 11 05:07:11 ppp 785 [wan_link0] LCP: Down event Sep 11 05:07:11 ppp 785 [wan_link0] Link: reconnection attempt 75 in 1 seconds Sep 11 05:07:12 ppp 785 [wan_link0] Link: reconnection attempt 75 Sep 11 05:07:12 ppp 785 [wan_link0] PPPoE: Connecting to 'iinet' Sep 11 05:07:21 ppp 785 [wan_link0] PPPoE connection timeout after 9 seconds Sep 11 05:07:21 ppp 785 [wan_link0] Link: DOWN event Sep 11 05:07:21 ppp 785 [wan_link0] LCP: Down event Sep 11 05:07:21 ppp 785 [wan_link0] Link: reconnection attempt 76 in 2 seconds Sep 11 05:07:23 ppp 785 [wan_link0] Link: reconnection attempt 76 Sep 11 05:07:23 ppp 785 [wan_link0] PPPoE: Connecting to 'iinet' Sep 11 05:07:32 ppp 785 [wan_link0] PPPoE connection timeout after 9 seconds Sep 11 05:07:32 ppp 785 [wan_link0] Link: DOWN event Sep 11 05:07:32 ppp 785 [wan_link0] LCP: Down event Sep 11 05:07:32 ppp 785 [wan_link0] Link: reconnection attempt 77 in 2 seconds Sep 11 05:07:34 ppp 785 [wan_link0] Link: reconnection attempt 77 Sep 11 05:07:34 ppp 785 [wan_link0] PPPoE: Connecting to 'iinet' Sep 11 05:07:43 ppp 785 [wan_link0] PPPoE connection timeout after 9 seconds Sep 11 05:07:43 ppp 785 [wan_link0] Link: DOWN event Sep 11 05:07:43 ppp 785 [wan_link0] LCP: Down event Sep 11 05:07:43 ppp 785 [wan_link0] Link: reconnection attempt 78 in 2 seconds Sep 11 05:07:45 ppp 785 [wan_link0] Link: reconnection attempt 78 Sep 11 05:07:45 ppp 785 [wan_link0] PPPoE: Connecting to 'iinet' Sep 11 05:07:54 ppp 785 [wan_link0] PPPoE connection timeout after 9 seconds Sep 11 05:07:54 ppp 785 [wan_link0] Link: DOWN event Sep 11 05:07:54 ppp 785 [wan_link0] LCP: Down event Sep 11 05:07:54 ppp 785 [wan_link0] Link: reconnection attempt 79 in 4 seconds Sep 11 05:07:58 ppp 785 [wan_link0] Link: reconnection attempt 79 Sep 11 05:07:58 ppp 785 [wan_link0] PPPoE: Connecting to 'iinet' Sep 11 05:08:07 ppp 785 [wan_link0] PPPoE connection timeout after 9 seconds Sep 11 05:08:07 ppp 785 [wan_link0] Link: DOWN event Sep 11 05:08:07 ppp 785 [wan_link0] LCP: Down event Sep 11 05:08:07 ppp 785 [wan_link0] Link: reconnection attempt 80 in 3 seconds Sep 11 05:08:10 ppp 785 [wan_link0] Link: reconnection attempt 80 Sep 11 05:08:10 ppp 785 [wan_link0] PPPoE: Connecting to 'iinet' Sep 11 05:08:19 ppp 785 [wan_link0] PPPoE connection timeout after 9 seconds Sep 11 05:08:19 ppp 785 [wan_link0] Link: DOWN event Sep 11 05:08:19 ppp 785 [wan_link0] LCP: Down event Sep 11 05:08:19 ppp 785 [wan_link0] Link: reconnection attempt 81 in 3 seconds Sep 11 05:08:22 ppp 785 [wan_link0] Link: reconnection attempt 81 Sep 11 05:08:22 ppp 785 [wan_link0] PPPoE: Connecting to 'iinet' Sep 11 05:08:31 ppp 785 [wan_link0] PPPoE connection timeout after 9 seconds Sep 11 05:08:31 ppp 785 [wan_link0] Link: DOWN event Sep 11 05:08:31 ppp 785 [wan_link0] LCP: Down event Sep 11 05:08:31 ppp 785 [wan_link0] Link: reconnection attempt 82 in 3 seconds Sep 11 05:08:34 ppp 785 [wan_link0] Link: reconnection attempt 82 Sep 11 05:08:34 ppp 785 [wan_link0] PPPoE: Connecting to 'iinet' Sep 11 05:08:43 ppp 785 [wan_link0] PPPoE connection timeout after 9 seconds Sep 11 05:08:43 ppp 785 [wan_link0] Link: DOWN event Sep 11 05:08:43 ppp 785 [wan_link0] LCP: Down event Sep 11 05:08:43 ppp 785 [wan_link0] Link: reconnection attempt 83 in 1 seconds Sep 11 05:08:44 ppp 785 [wan_link0] Link: reconnection attempt 83 Sep 11 05:08:44 ppp 785 [wan_link0] PPPoE: Connecting to 'iinet' Sep 11 05:08:53 ppp 785 [wan_link0] PPPoE connection timeout after 9 seconds Sep 11 05:08:53 ppp 785 [wan_link0] Link: DOWN event Sep 11 05:08:53 ppp 785 [wan_link0] LCP: Down event Sep 11 05:08:53 ppp 785 [wan_link0] Link: reconnection attempt 84 in 3 seconds Sep 11 05:08:56 ppp 785 [wan_link0] Link: reconnection attempt 84 Sep 11 05:08:56 ppp 785 [wan_link0] PPPoE: Connecting to 'iinet' Sep 11 05:09:05 ppp 785 [wan_link0] PPPoE connection timeout after 9 seconds Sep 11 05:09:05 ppp 785 [wan_link0] Link: DOWN event Sep 11 05:09:05 ppp 785 [wan_link0] LCP: Down event Sep 11 05:09:05 ppp 785 [wan_link0] Link: reconnection attempt 85 in 1 seconds Sep 11 05:09:06 ppp 785 [wan_link0] Link: reconnection attempt 85 Sep 11 05:09:06 ppp 785 [wan_link0] PPPoE: Connecting to 'iinet' Sep 11 05:09:15 ppp 785 [wan_link0] PPPoE connection timeout after 9 seconds Sep 11 05:09:15 ppp 785 [wan_link0] Link: DOWN event Sep 11 05:09:15 ppp 785 [wan_link0] LCP: Down event Sep 11 05:09:15 ppp 785 [wan_link0] Link: reconnection attempt 86 in 2 seconds Sep 11 05:09:17 ppp 785 [wan_link0] Link: reconnection attempt 86 Sep 11 05:09:17 ppp 785 [wan_link0] PPPoE: Connecting to 'iinet' Sep 11 05:09:19 ppp 785 PPPoE: rec'd ACNAME "bri-apt-wic-bras208" Sep 11 05:09:19 ppp 785 [wan_link0] PPPoE: connection successful Sep 11 05:09:19 ppp 785 [wan_link0] Link: UP event Sep 11 05:09:19 ppp 785 [wan_link0] LCP: Up event Sep 11 05:09:19 ppp 785 [wan_link0] LCP: state change Starting --> Req-Sent Sep 11 05:09:19 ppp 785 [wan_link0] LCP: SendConfigReq #59 Sep 11 05:09:19 ppp 785 [wan_link0] PROTOCOMP Sep 11 05:09:19 ppp 785 [wan_link0] MRU 1492 Sep 11 05:09:19 ppp 785 [wan_link0] MAGICNUM 0x5c5c1e91 Sep 11 05:09:19 ppp 785 [wan_link0] LCP: rec'd Configure Request #1 (Req-Sent) Sep 11 05:09:19 ppp 785 [wan_link0] MRU 1492 Sep 11 05:09:19 ppp 785 [wan_link0] AUTHPROTO PAP Sep 11 05:09:19 ppp 785 [wan_link0] MAGICNUM 0xf4949eb8 Sep 11 05:09:19 ppp 785 [wan_link0] LCP: SendConfigAck #1 Sep 11 05:09:19 ppp 785 [wan_link0] MRU 1492 Sep 11 05:09:19 ppp 785 [wan_link0] AUTHPROTO PAP Sep 11 05:09:19 ppp 785 [wan_link0] MAGICNUM 0xf4949eb8 Sep 11 05:09:19 ppp 785 [wan_link0] LCP: state change Req-Sent --> Ack-Sent Sep 11 05:09:19 ppp 785 [wan_link0] LCP: rec'd Configure Ack #59 (Ack-Sent) Sep 11 05:09:19 ppp 785 [wan_link0] PROTOCOMP Sep 11 05:09:19 ppp 785 [wan_link0] MRU 1492 Sep 11 05:09:19 ppp 785 [wan_link0] MAGICNUM 0x5c5c1e91 Sep 11 05:09:19 ppp 785 [wan_link0] LCP: state change Ack-Sent --> Opened Sep 11 05:09:19 ppp 785 [wan_link0] LCP: auth: peer wants PAP, I want nothing Sep 11 05:09:19 ppp 785 [wan_link0] PAP: using authname "davidjcartledge" Sep 11 05:09:19 ppp 785 [wan_link0] PAP: sending REQUEST #1 len: 29 Sep 11 05:09:19 ppp 785 [wan_link0] LCP: LayerUp Sep 11 05:09:21 ppp 785 [wan_link0] PAP: using authname "davidjcartledge" Sep 11 05:09:21 ppp 785 [wan_link0] PAP: sending REQUEST #2 len: 29 Sep 11 05:09:23 ppp 785 [wan_link0] PAP: using authname "davidjcartledge" Sep 11 05:09:23 ppp 785 [wan_link0] PAP: sending REQUEST #3 len: 29 Sep 11 05:09:25 ppp 785 [wan_link0] PAP: using authname "davidjcartledge" Sep 11 05:09:25 ppp 785 [wan_link0] PAP: sending REQUEST #4 len: 29 Sep 11 05:09:27 ppp 785 [wan_link0] PAP: using authname "davidjcartledge" Sep 11 05:09:27 ppp 785 [wan_link0] PAP: sending REQUEST #5 len: 29 Sep 11 05:09:35 ppp 785 [wan_link0] rec'd proto IPCP during authenticate phase Sep 11 05:09:59 ppp 785 [wan_link0] LCP: authorization timer expired Sep 11 05:09:59 ppp 785 [wan_link0] LCP: authorization failed Sep 11 05:09:59 ppp 785 [wan_link0] LCP: parameter negotiation failed Sep 11 05:09:59 ppp 785 [wan_link0] LCP: state change Opened --> Stopping Sep 11 05:09:59 ppp 785 [wan_link0] LCP: SendTerminateReq #60 Sep 11 05:09:59 ppp 785 [wan_link0] LCP: LayerDown Sep 11 05:09:59 ppp 785 [wan_link0] rec'd proto IPCP during terminate phase Sep 11 05:10:01 ppp 785 [wan_link0] LCP: SendTerminateReq #61 Sep 11 05:10:03 ppp 785 [wan_link0] LCP: state change Stopping --> Stopped Sep 11 05:10:03 ppp 785 [wan_link0] LCP: LayerFinish Sep 11 05:10:03 ppp 785 [wan_link0] PPPoE: connection closed Sep 11 05:10:03 ppp 785 [wan_link0] Link: DOWN event Sep 11 05:10:03 ppp 785 [wan_link0] LCP: Down event Sep 11 05:10:03 ppp 785 [wan_link0] LCP: state change Stopped --> Starting Sep 11 05:10:03 ppp 785 [wan_link0] LCP: LayerStart Sep 11 05:10:03 ppp 785 [wan_link0] Link: reconnection attempt 87 in 1 seconds Sep 11 05:10:04 ppp 785 [wan_link0] Link: reconnection attempt 87 Sep 11 05:10:04 ppp 785 [wan_link0] PPPoE: Connecting to 'iinet' Sep 11 05:10:13 ppp 785 [wan_link0] PPPoE connection timeout after 9 seconds Sep 11 05:10:13 ppp 785 [wan_link0] Link: DOWN event Sep 11 05:10:13 ppp 785 [wan_link0] LCP: Down event Sep 11 05:10:13 ppp 785 [wan_link0] Link: reconnection attempt 88 in 2 seconds Sep 11 05:10:15 ppp 785 [wan_link0] Link: reconnection attempt 88 Sep 11 05:10:15 ppp 785 [wan_link0] PPPoE: Connecting to 'iinet' Sep 11 05:10:24 ppp 785 [wan_link0] PPPoE connection timeout after 9 seconds Sep 11 05:10:24 ppp 785 [wan_link0] Link: DOWN event Sep 11 05:10:24 ppp 785 [wan_link0] LCP: Down event Sep 11 05:10:24 ppp 785 [wan_link0] Link: reconnection attempt 89 in 1 seconds Sep 11 05:10:25 ppp 785 [wan_link0] Link: reconnection attempt 89 Sep 11 05:10:25 ppp 785 [wan_link0] PPPoE: Connecting to 'iinet' Sep 11 05:10:34 ppp 785 [wan_link0] PPPoE connection timeout after 9 seconds Sep 11 05:10:34 ppp 785 [wan_link0] Link: DOWN event Sep 11 05:10:34 ppp 785 [wan_link0] LCP: Down event Sep 11 05:10:34 ppp 785 [wan_link0] Link: reconnection attempt 90 in 4 seconds Sep 11 05:10:38 ppp 785 [wan_link0] Link: reconnection attempt 90 Sep 11 05:10:38 ppp 785 [wan_link0] PPPoE: Connecting to 'iinet' Sep 11 05:10:47 ppp 785 [wan_link0] PPPoE connection timeout after 9 seconds Sep 11 05:10:47 ppp 785 [wan_link0] Link: DOWN event Sep 11 05:10:47 ppp 785 [wan_link0] LCP: Down event Sep 11 05:10:47 ppp 785 [wan_link0] Link: reconnection attempt 91 in 1 seconds Sep 11 05:10:48 ppp 785 [wan_link0] Link: reconnection attempt 91 Sep 11 05:10:48 ppp 785 [wan_link0] PPPoE: Connecting to 'iinet' Sep 11 05:10:57 ppp 785 [wan_link0] PPPoE connection timeout after 9 seconds Sep 11 05:10:57 ppp 785 [wan_link0] Link: DOWN event Sep 11 05:10:57 ppp 785 [wan_link0] LCP: Down event Sep 11 05:10:57 ppp 785 [wan_link0] Link: reconnection attempt 92 in 4 seconds Sep 11 05:11:01 ppp 785 [wan_link0] Link: reconnection attempt 92 Sep 11 05:11:01 ppp 785 [wan_link0] PPPoE: Connecting to 'iinet' Sep 11 05:11:10 ppp 785 [wan_link0] PPPoE connection timeout after 9 seconds Sep 11 05:11:10 ppp 785 [wan_link0] Link: DOWN event Sep 11 05:11:10 ppp 785 [wan_link0] LCP: Down event Sep 11 05:11:10 ppp 785 [wan_link0] Link: reconnection attempt 93 in 3 seconds Sep 11 05:11:13 ppp 785 [wan_link0] Link: reconnection attempt 93 Sep 11 05:11:13 ppp 785 [wan_link0] PPPoE: Connecting to 'iinet' Sep 11 05:11:22 ppp 785 [wan_link0] PPPoE connection timeout after 9 seconds Sep 11 05:11:22 ppp 785 [wan_link0] Link: DOWN event Sep 11 05:11:22 ppp 785 [wan_link0] LCP: Down event Sep 11 05:11:22 ppp 785 [wan_link0] Link: reconnection attempt 94 in 1 seconds Sep 11 05:11:23 ppp 785 [wan_link0] Link: reconnection attempt 94 Sep 11 05:11:23 ppp 785 [wan_link0] PPPoE: Connecting to 'iinet' Sep 11 05:11:32 ppp 785 [wan_link0] PPPoE connection timeout after 9 seconds Sep 11 05:11:32 ppp 785 [wan_link0] Link: DOWN event Sep 11 05:11:32 ppp 785 [wan_link0] LCP: Down event Sep 11 05:11:32 ppp 785 [wan_link0] Link: reconnection attempt 95 in 2 seconds Sep 11 05:11:34 ppp 785 [wan_link0] Link: reconnection attempt 95 Sep 11 05:11:34 ppp 785 [wan_link0] PPPoE: Connecting to 'iinet' Sep 11 05:11:43 ppp 785 [wan_link0] PPPoE connection timeout after 9 seconds Sep 11 05:11:43 ppp 785 [wan_link0] Link: DOWN event Sep 11 05:11:43 ppp 785 [wan_link0] LCP: Down event Sep 11 05:11:43 ppp 785 [wan_link0] Link: reconnection attempt 96 in 2 seconds Sep 11 05:11:45 ppp 785 [wan_link0] Link: reconnection attempt 96 Sep 11 05:11:45 ppp 785 [wan_link0] PPPoE: Connecting to 'iinet' Sep 11 05:11:54 ppp 785 [wan_link0] PPPoE connection timeout after 9 seconds Sep 11 05:11:54 ppp 785 [wan_link0] Link: DOWN event Sep 11 05:11:54 ppp 785 [wan_link0] LCP: Down event Sep 11 05:11:54 ppp 785 [wan_link0] Link: reconnection attempt 97 in 1 seconds Sep 11 05:11:55 ppp 785 [wan_link0] Link: reconnection attempt 97 Sep 11 05:11:55 ppp 785 [wan_link0] PPPoE: Connecting to 'iinet' Sep 11 05:12:04 ppp 785 [wan_link0] PPPoE connection timeout after 9 seconds Sep 11 05:12:04 ppp 785 [wan_link0] Link: DOWN event Sep 11 05:12:04 ppp 785 [wan_link0] LCP: Down event Sep 11 05:12:04 ppp 785 [wan_link0] Link: reconnection attempt 98 in 4 seconds Sep 11 05:12:08 ppp 785 [wan_link0] Link: reconnection attempt 98 Sep 11 05:12:08 ppp 785 [wan_link0] PPPoE: Connecting to 'iinet' Sep 11 05:12:17 ppp 785 [wan_link0] PPPoE connection timeout after 9 seconds Sep 11 05:12:17 ppp 785 [wan_link0] Link: DOWN event Sep 11 05:12:17 ppp 785 [wan_link0] LCP: Down event Sep 11 05:12:17 ppp 785 [wan_link0] Link: reconnection attempt 99 in 1 seconds Sep 11 05:12:18 ppp 785 [wan_link0] Link: reconnection attempt 99 Sep 11 05:12:18 ppp 785 [wan_link0] PPPoE: Connecting to 'iinet' Sep 11 05:12:24 ppp 785 PPPoE: rec'd ACNAME "bri-apt-wic-bras203" Sep 11 05:12:24 ppp 785 [wan_link0] PPPoE: connection successful Sep 11 05:12:24 ppp 785 [wan_link0] Link: UP event Sep 11 05:12:24 ppp 785 [wan_link0] LCP: Up event Sep 11 05:12:24 ppp 785 [wan_link0] LCP: state change Starting --> Req-Sent Sep 11 05:12:24 ppp 785 [wan_link0] LCP: SendConfigReq #62 Sep 11 05:12:24 ppp 785 [wan_link0] PROTOCOMP Sep 11 05:12:24 ppp 785 [wan_link0] MRU 1492 Sep 11 05:12:24 ppp 785 [wan_link0] MAGICNUM 0x57d10774 Sep 11 05:12:24 ppp 785 [wan_link0] LCP: rec'd Configure Request #1 (Req-Sent) Sep 11 05:12:24 ppp 785 [wan_link0] MRU 1492 Sep 11 05:12:24 ppp 785 [wan_link0] AUTHPROTO PAP Sep 11 05:12:24 ppp 785 [wan_link0] MAGICNUM 0x0234164b Sep 11 05:12:24 ppp 785 [wan_link0] LCP: SendConfigAck #1 Sep 11 05:12:24 ppp 785 [wan_link0] MRU 1492 Sep 11 05:12:24 ppp 785 [wan_link0] AUTHPROTO PAP Sep 11 05:12:24 ppp 785 [wan_link0] MAGICNUM 0x0234164b Sep 11 05:12:24 ppp 785 [wan_link0] LCP: state change Req-Sent --> Ack-Sent Sep 11 05:12:24 ppp 785 [wan_link0] LCP: rec'd Configure Ack #62 (Ack-Sent) Sep 11 05:12:24 ppp 785 [wan_link0] PROTOCOMP Sep 11 05:12:24 ppp 785 [wan_link0] MRU 1492 Sep 11 05:12:24 ppp 785 [wan_link0] MAGICNUM 0x57d10774 Sep 11 05:12:24 ppp 785 [wan_link0] LCP: state change Ack-Sent --> Opened Sep 11 05:12:24 ppp 785 [wan_link0] LCP: auth: peer wants PAP, I want nothing Sep 11 05:12:24 ppp 785 [wan_link0] PAP: using authname "davidjcartledge" Sep 11 05:12:24 ppp 785 [wan_link0] PAP: sending REQUEST #1 len: 29 Sep 11 05:12:24 ppp 785 [wan_link0] LCP: LayerUp Sep 11 05:12:24 ppp 785 [wan_link0] PAP: rec'd ACK #1 len: 5 Sep 11 05:12:24 ppp 785 [wan_link0] LCP: authorization successful Sep 11 05:12:24 ppp 785 [wan_link0] Link: Matched action 'bundle "wan" ""' Sep 11 05:12:24 ppp 785 [wan_link0] Link: Join bundle "wan" Sep 11 05:12:24 ppp 785 [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps Sep 11 05:12:24 ppp 785 [wan] IPCP: Open event Sep 11 05:12:24 ppp 785 [wan] IPCP: state change Initial --> Starting Sep 11 05:12:24 ppp 785 [wan] IPCP: LayerStart Sep 11 05:12:24 ppp 785 [wan] IPV6CP: Open event Sep 11 05:12:24 ppp 785 [wan] IPV6CP: state change Initial --> Starting Sep 11 05:12:24 ppp 785 [wan] IPV6CP: LayerStart Sep 11 05:12:24 ppp 785 [wan] IPCP: Up event Sep 11 05:12:24 ppp 785 [wan] IPCP: state change Starting --> Req-Sent Sep 11 05:12:24 ppp 785 [wan] IPCP: SendConfigReq #29 Sep 11 05:12:24 ppp 785 [wan] IPADDR 0.0.0.0 Sep 11 05:12:24 ppp 785 [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Sep 11 05:12:24 ppp 785 [wan] PRIDNS 0.0.0.0 Sep 11 05:12:24 ppp 785 [wan] SECDNS 0.0.0.0 Sep 11 05:12:24 ppp 785 [wan] IPV6CP: Up event Sep 11 05:12:24 ppp 785 [wan] IPV6CP: state change Starting --> Req-Sent Sep 11 05:12:24 ppp 785 [wan] IPV6CP: SendConfigReq #5 Sep 11 05:12:24 ppp 785 [wan] IPCP: rec'd Configure Request #1 (Req-Sent) Sep 11 05:12:24 ppp 785 [wan] IPADDR 10.20.23.172 Sep 11 05:12:24 ppp 785 [wan] 10.20.23.172 is OK Sep 11 05:12:24 ppp 785 [wan] IPCP: SendConfigAck #1 Sep 11 05:12:24 ppp 785 [wan] IPADDR 10.20.23.172 Sep 11 05:12:24 ppp 785 [wan] IPCP: state change Req-Sent --> Ack-Sent Sep 11 05:12:26 ppp 785 [wan] IPV6CP: SendConfigReq #6 Sep 11 05:12:26 ppp 785 [wan] IPCP: SendConfigReq #30 Sep 11 05:12:26 ppp 785 [wan] IPADDR 0.0.0.0 Sep 11 05:12:26 ppp 785 [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Sep 11 05:12:26 ppp 785 [wan] PRIDNS 0.0.0.0 Sep 11 05:12:26 ppp 785 [wan] SECDNS 0.0.0.0 Sep 11 05:12:28 ppp 785 [wan] IPCP: SendConfigReq #31 Sep 11 05:12:28 ppp 785 [wan] IPADDR 0.0.0.0 Sep 11 05:12:28 ppp 785 [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Sep 11 05:12:28 ppp 785 [wan] PRIDNS 0.0.0.0 Sep 11 05:12:28 ppp 785 [wan] SECDNS 0.0.0.0 Sep 11 05:12:28 ppp 785 [wan] IPV6CP: SendConfigReq #7 Sep 11 05:12:30 ppp 785 [wan] IPV6CP: SendConfigReq #8 Sep 11 05:12:30 ppp 785 [wan] IPCP: SendConfigReq #32 Sep 11 05:12:30 ppp 785 [wan] IPADDR 0.0.0.0 Sep 11 05:12:30 ppp 785 [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Sep 11 05:12:30 ppp 785 [wan] PRIDNS 0.0.0.0 Sep 11 05:12:30 ppp 785 [wan] SECDNS 0.0.0.0 Sep 11 05:12:32 ppp 785 [wan] IPCP: SendConfigReq #33 Sep 11 05:12:32 ppp 785 [wan] IPADDR 0.0.0.0 Sep 11 05:12:32 ppp 785 [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Sep 11 05:12:32 ppp 785 [wan] PRIDNS 0.0.0.0 Sep 11 05:12:32 ppp 785 [wan] SECDNS 0.0.0.0 Sep 11 05:12:32 ppp 785 [wan] IPV6CP: SendConfigReq #9 Sep 11 05:12:34 ppp 785 [wan] IPV6CP: SendConfigReq #10 Sep 11 05:12:34 ppp 785 [wan] IPCP: SendConfigReq #34 Sep 11 05:12:34 ppp 785 [wan] IPADDR 0.0.0.0 Sep 11 05:12:34 ppp 785 [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Sep 11 05:12:34 ppp 785 [wan] PRIDNS 0.0.0.0 Sep 11 05:12:34 ppp 785 [wan] SECDNS 0.0.0.0 Sep 11 05:12:36 ppp 785 [wan] IPCP: SendConfigReq #35 Sep 11 05:12:36 ppp 785 [wan] IPADDR 0.0.0.0 Sep 11 05:12:36 ppp 785 [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Sep 11 05:12:36 ppp 785 [wan] PRIDNS 0.0.0.0 Sep 11 05:12:36 ppp 785 [wan] SECDNS 0.0.0.0 Sep 11 05:12:36 ppp 785 [wan] IPV6CP: SendConfigReq #11 Sep 11 05:12:38 ppp 785 [wan] IPV6CP: SendConfigReq #12 Sep 11 05:12:38 ppp 785 [wan] IPCP: SendConfigReq #36 Sep 11 05:12:38 ppp 785 [wan] IPADDR 0.0.0.0 Sep 11 05:12:38 ppp 785 [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Sep 11 05:12:38 ppp 785 [wan] PRIDNS 0.0.0.0 Sep 11 05:12:38 ppp 785 [wan] SECDNS 0.0.0.0 Sep 11 05:12:40 ppp 785 [wan] IPCP: SendConfigReq #37 Sep 11 05:12:40 ppp 785 [wan] IPADDR 0.0.0.0 Sep 11 05:12:40 ppp 785 [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Sep 11 05:12:40 ppp 785 [wan] PRIDNS 0.0.0.0 Sep 11 05:12:40 ppp 785 [wan] SECDNS 0.0.0.0 Sep 11 05:12:40 ppp 785 [wan] IPV6CP: SendConfigReq #13 Sep 11 05:12:42 ppp 785 [wan] IPV6CP: SendConfigReq #14 Sep 11 05:12:42 ppp 785 [wan] IPCP: SendConfigReq #38 Sep 11 05:12:42 ppp 785 [wan] IPADDR 0.0.0.0 Sep 11 05:12:42 ppp 785 [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Sep 11 05:12:42 ppp 785 [wan] PRIDNS 0.0.0.0 Sep 11 05:12:42 ppp 785 [wan] SECDNS 0.0.0.0 Sep 11 05:12:44 ppp 785 [wan_link0] LCP: no reply to 1 echo request(s) Sep 11 05:12:44 ppp 785 [wan] IPCP: parameter negotiation failed Sep 11 05:12:44 ppp 785 [wan] IPCP: state change Ack-Sent --> Stopped Sep 11 05:12:44 ppp 785 [wan] IPCP: LayerFinish Sep 11 05:12:44 ppp 785 [wan] IPV6CP: parameter negotiation failed Sep 11 05:12:44 ppp 785 [wan] IPV6CP: state change Req-Sent --> Stopped Sep 11 05:12:44 ppp 785 [wan] IPV6CP: LayerFinish Sep 11 05:12:44 ppp 785 [wan] Bundle: No NCPs left. Closing links... Sep 11 05:12:44 ppp 785 [wan] Bundle: closing link "wan_link0"... Sep 11 05:12:44 ppp 785 [wan_link0] Link: CLOSE event Sep 11 05:12:44 ppp 785 [wan_link0] LCP: Close event Sep 11 05:12:44 ppp 785 [wan_link0] LCP: state change Opened --> Closing Sep 11 05:12:44 ppp 785 [wan_link0] Link: Leave bundle "wan" Sep 11 05:12:44 ppp 785 [wan] Bundle: Status update: up 0 links, total bandwidth 9600 bps Sep 11 05:12:44 ppp 785 [wan] IPCP: Close event Sep 11 05:12:44 ppp 785 [wan] IPCP: state change Stopped --> Closed Sep 11 05:12:44 ppp 785 [wan] IPV6CP: Close event Sep 11 05:12:44 ppp 785 [wan] IPV6CP: state change Stopped --> Closed Sep 11 05:12:44 ppp 785 [wan] IPCP: Down event Sep 11 05:12:44 ppp 785 [wan] IPCP: state change Closed --> Initial Sep 11 05:12:44 ppp 785 [wan] IPV6CP: Down event Sep 11 05:12:44 ppp 785 [wan] IPV6CP: state change Closed --> Initial Sep 11 05:12:44 ppp 785 [wan_link0] LCP: SendTerminateReq #63 Sep 11 05:12:44 ppp 785 [wan_link0] LCP: LayerDown Sep 11 05:12:46 ppp 785 [wan_link0] LCP: SendTerminateReq #64 Sep 11 05:12:48 ppp 785 [wan_link0] LCP: state change Closing --> Closed Sep 11 05:12:48 ppp 785 [wan_link0] LCP: LayerFinish Sep 11 05:12:48 ppp 785 [wan_link0] Link: DOWN event Sep 11 05:12:48 ppp 785 [wan_link0] LCP: Down event Sep 11 05:12:48 ppp 785 [wan_link0] LCP: state change Closed --> Initial