Upgrade from 12/13 to 12/18 -> PPPoE dead…
-
Still not working with latest snap…
Still have to kill mpd5 and then click save on WAN interface again...
-
Actually I tried again, because I needed to reboot. (Still the Internal Server Error after installing avahi package)
I do not need to kill mpd5. I just need to click save on WAN… -
2.0-BETA4 (amd64)
built on Thu Dec 23 12:13:59 EST 2010I updated 8 hours ago and still had to hit the Connect button to get a WAN.
-
Same problem here with newest snap of 12/26…
But if I wait long enough pfSense connects by itself after 3-4 minutes... -
Post your mpd logs.
-
Here is some output of my ppp.log:
Dec 28 00:16:03 ppp: [wan_link0] Link: reconnection attempt 2 Dec 28 00:16:03 ppp: [wan_link0] PPPoE: can't connect "[12]:"->"mpd8264-0" and "[f]:"->"left": No such file or directory Dec 28 00:16:03 ppp: [wan_link0] can't remove hook mpd8264-0 from node "[12]:": No such file or directory Dec 28 00:16:03 ppp: [wan_link0] Link: DOWN event Dec 28 00:16:03 ppp: [wan_link0] LCP: Down event Dec 28 00:16:03 ppp: [wan_link0] Link: reconnection attempt 3 in 4 seconds Dec 28 00:16:07 ppp: [wan_link0] Link: reconnection attempt 3 Dec 28 00:16:07 ppp: [wan_link0] PPPoE: can't connect "[12]:"->"mpd8264-0" and "[f]:"->"left": No such file or directory Dec 28 00:16:07 ppp: [wan_link0] can't remove hook mpd8264-0 from node "[12]:": No such file or directory Dec 28 00:16:07 ppp: [wan_link0] Link: DOWN event Dec 28 00:16:07 ppp: [wan_link0] LCP: Down event Dec 28 00:16:07 ppp: [wan_link0] Link: reconnection attempt 4 in 2 seconds Dec 28 00:16:09 ppp: [wan_link0] Link: reconnection attempt 4 Dec 28 00:16:09 ppp: [wan_link0] PPPoE: can't connect "[12]:"->"mpd8264-0" and "[f]:"->"left": No such file or directory Dec 28 00:16:09 ppp: [wan_link0] can't remove hook mpd8264-0 from node "[12]:": No such file or directory Dec 28 00:16:09 ppp: [wan_link0] Link: DOWN event Dec 28 00:16:09 ppp: [wan_link0] LCP: Down event Dec 28 00:16:09 ppp: [wan_link0] Link: reconnection attempt 5 in 2 seconds Dec 28 00:16:11 ppp: [wan_link0] Link: reconnection attempt 5 Dec 28 00:16:11 ppp: [wan_link0] PPPoE: can't connect "[12]:"->"mpd8264-0" and "[f]:"->"left": No such file or directory Dec 28 00:16:11 ppp: [wan_link0] can't remove hook mpd8264-0 from node "[12]:": No such file or directory Dec 28 00:16:11 ppp: [wan_link0] Link: DOWN event Dec 28 00:16:11 ppp: [wan_link0] LCP: Down event Dec 28 00:16:11 ppp: [wan_link0] Link: reconnection attempt 6 in 2 seconds Dec 28 00:16:13 ppp: [wan_link0] Link: reconnection attempt 6 Dec 28 00:16:13 ppp: [wan_link0] PPPoE: can't connect "[12]:"->"mpd8264-0" and "[f]:"->"left": No such file or directory Dec 28 00:16:13 ppp: [wan_link0] can't remove hook mpd8264-0 from node "[12]:": No such file or directory Dec 28 00:16:13 ppp: [wan_link0] Link: DOWN event Dec 28 00:16:13 ppp: [wan_link0] LCP: Down event Dec 28 00:16:13 ppp: [wan_link0] Link: reconnection attempt 7 in 4 seconds Dec 28 00:16:17 ppp: caught fatal signal term Dec 28 00:16:17 ppp: [wan] IFACE: Close event Dec 28 00:16:17 ppp: [wan] IPCP: Close event Dec 28 00:16:17 ppp: [wan_link0] LCP: Close event Dec 28 00:16:17 ppp: [wan_link0] LCP: state change Starting --> Initial Dec 28 00:16:17 ppp: [wan_link0] LCP: LayerFinish Dec 28 00:16:19 ppp: [wan] Bundle: Shutdown Dec 28 00:16:19 ppp: [wan_link0] Link: Shutdown Dec 28 00:16:19 ppp: process 8264 terminated Dec 28 00:16:25 ppp: Multi-link PPP daemon for FreeBSD Dec 28 00:16:25 ppp: Dec 28 00:16:25 ppp: process 38608 started, version 5.5 (root@FreeBSD_8.0_pfSense_2.0-snaps.pfsense.org 21:35 22-Dec-2010) Dec 28 00:16:25 ppp: web: web is not running Dec 28 00:16:25 ppp: [wan] Bundle: Interface ng0 created Dec 28 00:16:25 ppp: [wan_link0] Link: OPEN event Dec 28 00:16:25 ppp: [wan_link0] LCP: Open event Dec 28 00:16:25 ppp: [wan_link0] LCP: state change Initial --> Starting Dec 28 00:16:25 ppp: [wan_link0] LCP: LayerStart Dec 28 00:16:25 ppp: [wan_link0] PPPoE: Connecting to '*' Dec 28 00:16:25 ppp: PPPoE: rec'd ACNAME "KIER71-se800-B2234310702478"
That goes on for like 2-3 minutes and then suddenly it works…
Dec 28 00:17:44 ppp: [wan_link0] Link: reconnection attempt 7 in 2 seconds Dec 28 00:17:46 ppp: [wan_link0] Link: reconnection attempt 7 Dec 28 00:17:46 ppp: [wan_link0] PPPoE: Connecting to '*' Dec 28 00:17:46 ppp: PPPoE: rec'd ACNAME "KIER71-se800-B2234310702478" Dec 28 00:17:55 ppp: [wan_link0] PPPoE connection timeout after 9 seconds Dec 28 00:17:55 ppp: [wan_link0] Link: DOWN event Dec 28 00:17:55 ppp: [wan_link0] LCP: Down event Dec 28 00:17:55 ppp: [wan_link0] Link: reconnection attempt 8 in 3 seconds Dec 28 00:17:58 ppp: [wan_link0] Link: reconnection attempt 8 Dec 28 00:17:58 ppp: [wan_link0] PPPoE: Connecting to '*' Dec 28 00:17:58 ppp: PPPoE: rec'd ACNAME "KIER71-se800-B2234310702478" Dec 28 00:18:04 ppp: [wan_link0] PPPoE: connection successful Dec 28 00:18:04 ppp: [wan_link0] Link: UP event Dec 28 00:18:04 ppp: [wan_link0] LCP: Up event Dec 28 00:18:04 ppp: [wan_link0] LCP: state change Starting --> Req-Sent Dec 28 00:18:04 ppp: [wan_link0] LCP: SendConfigReq #1 Dec 28 00:18:04 ppp: [wan_link0] PROTOCOMP Dec 28 00:18:04 ppp: [wan_link0] MRU 1492 Dec 28 00:18:04 ppp: [wan_link0] MAGICNUM a8eef870 Dec 28 00:18:04 ppp: [wan_link0] LCP: rec'd Configure Request #52 (Req-Sent) Dec 28 00:18:04 ppp: [wan_link0] MRU 1492 Dec 28 00:18:04 ppp: [wan_link0] AUTHPROTO PAP Dec 28 00:18:04 ppp: [wan_link0] MAGICNUM 49a2d6c8 Dec 28 00:18:04 ppp: [wan_link0] LCP: SendConfigAck #52 Dec 28 00:18:04 ppp: [wan_link0] MRU 1492 Dec 28 00:18:04 ppp: [wan_link0] AUTHPROTO PAP Dec 28 00:18:04 ppp: [wan_link0] MAGICNUM 49a2d6c8 Dec 28 00:18:04 ppp: [wan_link0] LCP: state change Req-Sent --> Ack-Sent Dec 28 00:18:04 ppp: [wan_link0] LCP: rec'd Configure Reject #1 (Ack-Sent) Dec 28 00:18:04 ppp: [wan_link0] PROTOCOMP Dec 28 00:18:04 ppp: [wan_link0] LCP: SendConfigReq #2 Dec 28 00:18:04 ppp: [wan_link0] MRU 1492 Dec 28 00:18:04 ppp: [wan_link0] MAGICNUM a8eef870 Dec 28 00:18:04 ppp: [wan_link0] LCP: rec'd Configure Ack #2 (Ack-Sent) Dec 28 00:18:04 ppp: [wan_link0] MRU 1492 Dec 28 00:18:04 ppp: [wan_link0] MAGICNUM a8eef870 Dec 28 00:18:04 ppp: [wan_link0] LCP: state change Ack-Sent --> Opened Dec 28 00:18:04 ppp: [wan_link0] LCP: auth: peer wants PAP, I want nothing Dec 28 00:18:04 ppp: [wan_link0] PAP: using authname "xxxx@t-online.de" Dec 28 00:18:04 ppp: [wan_link0] PAP: sending REQUEST #1 len: 54 Dec 28 00:18:04 ppp: [wan_link0] LCP: LayerUp Dec 28 00:18:05 ppp: [wan_link0] PAP: rec'd ACK #1 len: 5 Dec 28 00:18:05 ppp: [wan_link0] LCP: authorization successful Dec 28 00:18:05 ppp: [wan_link0] Link: Matched action 'bundle "wan" ""' Dec 28 00:18:05 ppp: [wan_link0] Link: Join bundle "wan" Dec 28 00:18:05 ppp: [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps Dec 28 00:18:05 ppp: [wan] IPCP: Open event Dec 28 00:18:05 ppp: [wan] IPCP: state change Initial --> Starting Dec 28 00:18:05 ppp: [wan] IPCP: LayerStart Dec 28 00:18:05 ppp: [wan] IPCP: Up event Dec 28 00:18:05 ppp: [wan] IPCP: state change Starting --> Req-Sent Dec 28 00:18:05 ppp: [wan] IPCP: SendConfigReq #1 Dec 28 00:18:05 ppp: [wan] IPADDR 0.0.0.0 Dec 28 00:18:05 ppp: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Dec 28 00:18:05 ppp: [wan] IPCP: rec'd Configure Request #229 (Req-Sent) Dec 28 00:18:05 ppp: [wan] IPADDR 87.186.224.38 Dec 28 00:18:05 ppp: [wan] 87.186.224.38 is OK Dec 28 00:18:05 ppp: [wan] IPCP: SendConfigAck #229 Dec 28 00:18:05 ppp: [wan] IPADDR 87.186.224.38 Dec 28 00:18:05 ppp: [wan] IPCP: state change Req-Sent --> Ack-Sent Dec 28 00:18:05 ppp: [wan] IPCP: rec'd Configure Reject #1 (Ack-Sent) Dec 28 00:18:05 ppp: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Dec 28 00:18:05 ppp: [wan] IPCP: SendConfigReq #2 Dec 28 00:18:05 ppp: [wan] IPADDR 0.0.0.0 Dec 28 00:18:05 ppp: [wan] IPCP: rec'd Configure Nak #2 (Ack-Sent) Dec 28 00:18:05 ppp: [wan] IPADDR xxxx Dec 28 00:18:05 ppp: [wan] xxxx is OK Dec 28 00:18:05 ppp: [wan] IPCP: SendConfigReq #3 Dec 28 00:18:05 ppp: [wan] IPADDR xxxx Dec 28 00:18:05 ppp: [wan] IPCP: rec'd Configure Ack #3 (Ack-Sent) Dec 28 00:18:05 ppp: [wan] IPADDR xxxx Dec 28 00:18:05 ppp: [wan] IPCP: state change Ack-Sent --> Opened Dec 28 00:18:05 ppp: [wan] IPCP: LayerUp Dec 28 00:18:05 ppp: [wan] xxxx -> 87.186.224.38 Dec 28 00:18:05 ppp: [wan] IFACE: Up event
This whole thing was working fine for me before…
-
ppp logs if it helps
Dec 27 21:37:47 ppp: [wan] IFACE: Up event
Dec 27 21:37:47 ppp: [wan] 173.191.242.233 -> 151.213.8.5
Dec 27 21:37:47 ppp: [wan] IPCP: LayerUp
Dec 27 21:37:47 ppp: [wan] IPCP: state change Ack-Sent –> Opened
Dec 27 21:37:47 ppp: [wan] IPADDR 173.191.242.233
Dec 27 21:37:47 ppp: [wan] IPCP: rec'd Configure Ack #3 (Ack-Sent)
Dec 27 21:37:47 ppp: [wan] IPADDR 173.191.242.233
Dec 27 21:37:47 ppp: [wan] IPCP: SendConfigReq #3
Dec 27 21:37:47 ppp: [wan] 173.191.242.233 is OK
Dec 27 21:37:47 ppp: [wan] IPADDR 173.191.242.233
Dec 27 21:37:47 ppp: [wan] IPCP: rec'd Configure Nak #2 (Ack-Sent)
Dec 27 21:37:47 ppp: [wan] IPADDR 0.0.0.0
Dec 27 21:37:47 ppp: [wan] IPCP: SendConfigReq #2
Dec 27 21:37:47 ppp: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
Dec 27 21:37:47 ppp: [wan] IPCP: rec'd Configure Reject #1 (Ack-Sent)
Dec 27 21:37:47 ppp: [wan] IPCP: state change Req-Sent –> Ack-Sent
Dec 27 21:37:47 ppp: [wan] IPADDR 151.213.8.5
Dec 27 21:37:47 ppp: [wan] IPCP: SendConfigAck #1
Dec 27 21:37:47 ppp: [wan] 151.213.8.5 is OK
Dec 27 21:37:47 ppp: [wan] IPADDR 151.213.8.5
Dec 27 21:37:47 ppp: [wan] IPCP: rec'd Configure Request #1 (Req-Sent)
Dec 27 21:37:47 ppp: [wan] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
Dec 27 21:37:47 ppp: [wan] IPADDR 0.0.0.0
Dec 27 21:37:47 ppp: [wan] IPCP: SendConfigReq #1
Dec 27 21:37:47 ppp: [wan] IPCP: state change Starting –> Req-Sent
Dec 27 21:37:47 ppp: [wan] IPCP: Up event
Dec 27 21:37:47 ppp: [wan] IPCP: LayerStart
Dec 27 21:37:47 ppp: [wan] IPCP: state change Initial –> Starting
Dec 27 21:37:47 ppp: [wan] IPCP: Open event
Dec 27 21:37:47 ppp: [wan] Bundle: Status update: up 1 link, total bandwidth 64000 bps
Dec 27 21:37:47 ppp: [wan_link0] Link: Join bundle "wan"
Dec 27 21:37:47 ppp: [wan_link0] Link: Matched action 'bundle "wan" ""'
Dec 27 21:37:47 ppp: [wan_link0] LCP: authorization successful
Dec 27 21:37:47 ppp: [wan_link0] PAP: rec'd ACK #1 len: 5
Dec 27 21:37:46 ppp: [wan_link0] LCP: LayerUp
Dec 27 21:37:46 ppp: [wan_link0] PAP: sending REQUEST #1 len: 26
Dec 27 21:37:46 ppp: [wan_link0] PAP: using authname "grandrivers"
Dec 27 21:37:46 ppp: [wan_link0] LCP: auth: peer wants PAP, I want nothing
Dec 27 21:37:46 ppp: [wan_link0] LCP: state change Ack-Sent –> Opened
Dec 27 21:37:46 ppp: [wan_link0] MAGICNUM 6f07b4dc
Dec 27 21:37:46 ppp: [wan_link0] MRU 1492
Dec 27 21:37:46 ppp: [wan_link0] PROTOCOMP
Dec 27 21:37:46 ppp: [wan_link0] LCP: rec'd Configure Ack #1 (Ack-Sent)
Dec 27 21:37:46 ppp: [wan_link0] LCP: state change Req-Sent –> Ack-Sent
Dec 27 21:37:46 ppp: [wan_link0] MAGICNUM c9e5f758
Dec 27 21:37:46 ppp: [wan_link0] AUTHPROTO PAP
Dec 27 21:37:46 ppp: [wan_link0] MRU 1492
Dec 27 21:37:46 ppp: [wan_link0] LCP: SendConfigAck #1
Dec 27 21:37:46 ppp: [wan_link0] MAGICNUM c9e5f758
Dec 27 21:37:46 ppp: [wan_link0] AUTHPROTO PAP
Dec 27 21:37:46 ppp: [wan_link0] MRU 1492
Dec 27 21:37:46 ppp: [wan_link0] LCP: rec'd Configure Request #1 (Req-Sent)
Dec 27 21:37:46 ppp: [wan_link0] MAGICNUM 6f07b4dc
Dec 27 21:37:46 ppp: [wan_link0] MRU 1492
Dec 27 21:37:46 ppp: [wan_link0] PROTOCOMP
Dec 27 21:37:46 ppp: [wan_link0] LCP: SendConfigReq #1
Dec 27 21:37:46 ppp: [wan_link0] LCP: state change Starting –> Req-Sent
Dec 27 21:37:46 ppp: [wan_link0] LCP: Up event
Dec 27 21:37:46 ppp: [wan_link0] Link: UP event
Dec 27 21:37:46 ppp: [wan_link0] PPPoE: connection successful
Dec 27 21:37:46 ppp: PPPoE: rec'd ACNAME "ashtohlcs03-7200"
Dec 27 21:37:46 ppp: [wan_link0] PPPoE: Connecting to ''
Dec 27 21:37:46 ppp: [wan_link0] LCP: LayerStart
Dec 27 21:37:46 ppp: [wan_link0] LCP: state change Initial –> Starting
Dec 27 21:37:46 ppp: [wan_link0] LCP: Open event
Dec 27 21:37:46 ppp: [wan_link0] Link: OPEN event
Dec 27 21:37:46 ppp: [wan] Bundle: Interface ng0 created
Dec 27 21:37:46 ppp: web: web is not running
Dec 27 21:37:46 ppp: process 8957 started, version 5.5 (root@FreeBSD_8.0_pfSense_2.0-snaps.pfsense.org 21:35 22-Dec-2010)
Dec 27 21:37:46 ppp:
Dec 27 21:37:46 ppp: Multi-link PPP daemon for FreeBSD
Dec 27 21:37:43 ppp: process 4206 terminated
Dec 27 21:37:43 ppp: [wan_link0] Link: Shutdown
Dec 27 21:37:43 ppp: [wan] Bundle: Shutdown
Dec 27 21:37:42 ppp: [wan_link0] LCP: state change Closed –> Initial
Dec 27 21:37:42 ppp: [wan_link0] LCP: Down event
Dec 27 21:37:42 ppp: [wan_link0] LCP: state change Stopped –> Closed
Dec 27 21:37:42 ppp: [wan_link0] LCP: Close event
Dec 27 21:37:42 ppp: [wan_link0] Link: giving up after 0 reconnection attempts
Dec 27 21:37:42 ppp: [wan_link0] Link: DOWN event
Dec 27 21:37:42 ppp: [wan_link0] PPPoE: connection closed
Dec 27 21:37:42 ppp: [wan_link0] LCP: LayerFinish
Dec 27 21:37:42 ppp: [wan_link0] LCP: state change Stopping –> Stopped
Dec 27 21:37:42 ppp: [wan_link0] LCP: rec'd Terminate Ack #2 (Stopping)
Dec 27 21:37:41 ppp: [wan_link0] rec'd proto IPCP during terminate phase
Dec 27 21:37:41 ppp: [wan_link0] LCP: LayerDown
Dec 27 21:37:41 ppp: [wan_link0] LCP: SendTerminateReq #2
Dec 27 21:37:41 ppp: [wan_link0] LCP: state change Opened –> Stopping
Dec 27 21:37:41 ppp: [wan_link0] LCP: parameter negotiation failed
Dec 27 21:37:41 ppp: [wan_link0] link did not validate in bundle
Dec 27 21:37:41 ppp: Shutdown sequence in progress, BundJoin() denied
Dec 27 21:37:41 ppp: [wan_link0] LCP: authorization successful
Dec 27 21:37:41 ppp: [wan_link0] PAP: rec'd ACK #1 len: 5
Dec 27 21:37:41 ppp: [wan_link0] LCP: LayerUp
Dec 27 21:37:41 ppp: [wan_link0] PAP: sending REQUEST #1 len: 26
Dec 27 21:37:41 ppp: [wan_link0] PAP: using authname "grandrivers"
Dec 27 21:37:41 ppp: [wan_link0] LCP: auth: peer wants PAP, I want nothing
Dec 27 21:37:41 ppp: [wan_link0] LCP: state change Ack-Sent –> Opened
Dec 27 21:37:41 ppp: [wan_link0] MAGICNUM 29185664
Dec 27 21:37:41 ppp: [wan_link0] MRU 1492
Dec 27 21:37:41 ppp: [wan_link0] PROTOCOMP
Dec 27 21:37:41 ppp: [wan_link0] LCP: rec'd Configure Ack #1 (Ack-Sent)
Dec 27 21:37:41 ppp: [wan_link0] LCP: state change Req-Sent –> Ack-Sent
Dec 27 21:37:41 ppp: [wan_link0] MAGICNUM c9e5e352
Dec 27 21:37:41 ppp: [wan_link0] AUTHPROTO PAP
Dec 27 21:37:41 ppp: [wan_link0] MRU 1492
Dec 27 21:37:41 ppp: [wan_link0] LCP: SendConfigAck #1
Dec 27 21:37:41 ppp: [wan_link0] MAGICNUM c9e5e352
Dec 27 21:37:41 ppp: [wan_link0] AUTHPROTO PAP
Dec 27 21:37:41 ppp: [wan_link0] MRU 1492
Dec 27 21:37:41 ppp: [wan_link0] LCP: rec'd Configure Request #1 (Req-Sent)
Dec 27 21:37:41 ppp: [wan_link0] MAGICNUM 29185664
Dec 27 21:37:41 ppp: [wan_link0] MRU 1492
Dec 27 21:37:41 ppp: [wan_link0] PROTOCOMP
Dec 27 21:37:41 ppp: [wan_link0] LCP: SendConfigReq #1
Dec 27 21:37:41 ppp: [wan_link0] LCP: state change Starting –> Req-Sent
Dec 27 21:37:41 ppp: [wan_link0] LCP: Up event
Dec 27 21:37:41 ppp: [wan_link0] Link: UP event
Dec 27 21:37:41 ppp: [wan_link0] PPPoE: connection successful
Dec 27 21:37:41 ppp: PPPoE: rec'd ACNAME "ashtohlcs03-7200"
Dec 27 21:37:41 ppp: [wan] IPCP: Close event
Dec 27 21:37:41 ppp: [wan] IFACE: Close event
Dec 27 21:37:41 ppp: caught fatal signal term
Dec 27 21:37:41 ppp: [wan_link0] PPPoE: Connecting to ''
Dec 27 21:37:41 ppp: [wan_link0] LCP: LayerStart
Dec 27 21:37:41 ppp: [wan_link0] LCP: state change Initial –> Starting
Dec 27 21:37:41 ppp: [wan_link0] LCP: Open event
Dec 27 21:37:41 ppp: [wan_link0] Link: OPEN event
Dec 27 21:37:41 ppp: [wan] Bundle: Interface ng0 created
Dec 27 21:37:41 ppp: web: web is not running
Dec 27 21:37:41 ppp: process 4206 started, version 5.5 (root@FreeBSD_8.0_pfSense_2.0-snaps.pfsense.org 21:35 22-Dec-2010)
Dec 27 21:37:41 ppp:
Dec 27 21:37:41 ppp: Multi-link PPP daemon for FreeBSD
Dec 27 21:37:38 ppp: process 8816 terminated
Dec 27 21:37:38 ppp: [wan_link0] Link: Shutdown
Dec 27 21:37:38 ppp: [wan] Bundle: Shutdown
Dec 27 21:37:37 ppp: [wan_link0] LCP: LayerFinish
Dec 27 21:37:37 ppp: [wan_link0] LCP: state change Starting –> Initial
Dec 27 21:37:37 ppp: [wan_link0] LCP: Close event
Dec 27 21:37:36 ppp: [wan] IPCP: Close event
Dec 27 21:37:36 ppp: [wan] IFACE: Close event
Dec 27 21:37:36 ppp: caught fatal signal term
Dec 27 21:37:35 ppp: [wan_link0] Link: reconnection attempt 103 in 2 seconds
Dec 27 21:37:35 ppp: [wan_link0] LCP: Down event
Dec 27 21:37:35 ppp: [wan_link0] Link: DOWN event
Dec 27 21:37:35 ppp: [wan_link0] can't remove hook mpd8816-0 from node "[11]:": No such file or directory
Dec 27 21:37:35 ppp: [wan_link0] PPPoE: can't connect "[11]:"->"mpd8816-0" and "[f]:"->"left": No such file or directory
Dec 27 21:37:35 ppp: [wan_link0] Link: reconnection attempt 102
Dec 27 21:37:34 ppp: [wan_link0] Link: reconnection attempt 102 in 1 seconds
Dec 27 21:37:34 ppp: [wan_link0] LCP: Down event
Dec 27 21:37:34 ppp: [wan_link0] Link: DOWN event
Dec 27 21:37:34 ppp: [wan_link0] can't remove hook mpd8816-0 from node "[11]:": No such file or directory
Dec 27 21:37:34 ppp: [wan_link0] PPPoE: can't connect "[11]:"->"mpd8816-0" and "[f]:"->"left": No such file or directory
Dec 27 21:37:34 ppp: [wan_link0] Link: reconnection attempt 101
Dec 27 21:37:33 ppp: [wan_link0] Link: reconnection attempt 101 in 1 seconds
Dec 27 21:37:33 ppp: [wan_link0] LCP: Down event
Dec 27 21:37:33 ppp: [wan_link0] Link: DOWN event
Dec 27 21:37:33 ppp: [wan_link0] can't remove hook mpd8816-0 from node "[11]:": No such file or directory
Dec 27 21:37:33 ppp: [wan_link0] PPPoE: can't connect "[11]:"->"mpd8816-0" and "[f]:"->"left": No such file or directory
Dec 27 21:37:33 ppp: [wan_link0] Link: reconnection attempt 100
Dec 27 21:37:31 ppp: [wan_link0] Link: reconnection attempt 100 in 2 seconds
Dec 27 21:37:31 ppp: [wan_link0] LCP: Down event
Dec 27 21:37:31 ppp: [wan_link0] Link: DOWN event
Dec 27 21:37:31 ppp: [wan_link0] can't remove hook mpd8816-0 from node "[11]:": No such file or directory
Dec 27 21:37:31 ppp: [wan_link0] PPPoE: can't connect "[11]:"->"mpd8816-0" and "[f]:"->"left": No such file or directory
Dec 27 21:37:31 ppp: [wan_link0] Link: reconnection attempt 99
Dec 27 21:37:27 ppp: [wan_link0] Link: reconnection attempt 99 in 4 seconds
Dec 27 21:37:27 ppp: [wan_link0] LCP: Down event
Dec 27 21:37:27 ppp: [wan_link0] Link: DOWN event
Dec 27 21:37:27 ppp: [wan_link0] can't remove hook mpd8816-0 from node "[11]:": No such file or directory
Dec 27 21:37:27 ppp: [wan_link0] PPPoE: can't connect "[11]:"->"mpd8816-0" and "[f]:"->"left": No such file or directory
Dec 27 21:37:27 ppp: [wan_link0] Link: reconnection attempt 98
Dec 27 21:37:24 ppp: [wan_link0] Link: reconnection attempt 98 in 3 seconds
Dec 27 21:37:24 ppp: [wan_link0] LCP: Down event
Dec 27 21:37:24 ppp: [wan_link0] Link: DOWN event
Dec 27 21:37:24 ppp: [wan_link0] can't remove hook mpd8816-0 from node "[11]:": No such file or directory
Dec 27 21:37:24 ppp: [wan_link0] PPPoE: can't connect "[11]:"->"mpd8816-0" and "[f]:"->"left": No such file or directory
Dec 27 21:37:24 ppp: [wan_link0] Link: reconnection attempt 97
Dec 27 21:37:21 ppp: [wan_link0] Link: reconnection attempt 97 in 3 seconds
Dec 27 21:37:21 ppp: [wan_link0] LCP: Down event
Dec 27 21:37:21 ppp: [wan_link0] Link: DOWN event
Dec 27 21:37:21 ppp: [wan_link0] can't remove hook mpd8816-0 from node "[11]:": No such file or directory
Dec 27 21:37:21 ppp: [wan_link0] PPPoE: can't connect "[11]:"->"mpd8816-0" and "[f]:"->"left": No such file or directory
Dec 27 21:37:21 ppp: [wan_link0] Link: reconnection attempt 96
Dec 27 21:37:20 ppp: [wan_link0] Link: reconnection attempt 96 in 1 seconds
Dec 27 21:37:20 ppp: [wan_link0] LCP: Down event
Dec 27 21:37:20 ppp: [wan_link0] Link: DOWN event
Dec 27 21:37:20 ppp: [wan_link0] can't remove hook mpd8816-0 from node "[11]:": No such file or directory
Dec 27 21:37:20 ppp: [wan_link0] PPPoE: can't connect "[11]:"->"mpd8816-0" and "[f]:"->"left": No such file or directory
Dec 27 21:37:20 ppp: [wan_link0] Link: reconnection attempt 95
Dec 27 21:37:19 ppp: [wan_link0] Link: reconnection attempt 95 in 1 seconds
Dec 27 21:37:19 ppp: [wan_link0] LCP: Down event
Dec 27 21:37:19 ppp: [wan_link0] Link: DOWN event
Dec 27 21:37:19 ppp: [wan_link0] can't remove hook mpd8816-0 from node "[11]:": No such file or directory
Dec 27 21:37:19 ppp: [wan_link0] PPPoE: can't connect "[11]:"->"mpd8816-0" and "[f]:"->"left": No such file or directory
Dec 27 21:37:19 ppp: [wan_link0] Link: reconnection attempt 94
Dec 27 21:37:15 ppp: [wan_link0] Link: reconnection attempt 94 in 4 seconds
Dec 27 21:37:15 ppp: [wan_link0] LCP: Down event
Dec 27 21:37:15 ppp: [wan_link0] Link: DOWN event
Dec 27 21:37:15 ppp: [wan_link0] can't remove hook mpd8816-0 from node "[11]:": No such file or directory
Dec 27 21:37:15 ppp: [wan_link0] PPPoE: can't connect "[11]:"->"mpd8816-0" and "[f]:"->"left": No such file or directory
Dec 27 21:37:15 ppp: [wan_link0] Link: reconnection attempt 93
Dec 27 21:37:13 ppp: [wan_link0] Link: reconnection attempt 93 in 2 seconds
Dec 27 21:37:13 ppp: [wan_link0] LCP: Down event
Dec 27 21:37:13 ppp: [wan_link0] Link: DOWN event
Dec 27 21:37:13 ppp: [wan_link0] can't remove hook mpd8816-0 from node "[11]:": No such file or directory
Dec 27 21:37:13 ppp: [wan_link0] PPPoE: can't connect "[11]:"->"mpd8816-0" and "[f]:"->"left": No such file or directory
Dec 27 21:37:13 ppp: [wan_link0] Link: reconnection attempt 92
Dec 27 21:37:12 ppp: [wan_link0] Link: reconnection attempt 92 in 1 seconds
Dec 27 21:37:12 ppp: [wan_link0] LCP: Down event
Dec 27 21:37:12 ppp: [wan_link0] Link: DOWN event
Dec 27 21:37:12 ppp: [wan_link0] can't remove hook mpd8816-0 from node "[11]:": No such file or directory
Dec 27 21:37:12 ppp: [wan_link0] PPPoE: can't connect "[11]:"->"mpd8816-0" and "[f]:"->"left": No such file or directory
Dec 27 21:37:12 ppp: [wan_link0] Link: reconnection attempt 91
Dec 27 21:37:10 ppp: [wan_link0] Link: reconnection attempt 91 in 2 seconds
Dec 27 21:37:10 ppp: [wan_link0] LCP: Down event
Dec 27 21:37:10 ppp: [wan_link0] Link: DOWN event
Dec 27 21:37:10 ppp: [wan_link0] can't remove hook mpd8816-0 from node "[11]:": No such file or directory
Dec 27 21:37:10 ppp: [wan_link0] PPPoE: can't connect "[11]:"->"mpd8816-0" and "[f]:"->"left": No such file or directory
Dec 27 21:37:10 ppp: [wan_link0] Link: reconnection attempt 90
Dec 27 21:37:06 ppp: [wan_link0] Link: reconnection attempt 90 in 4 seconds
Dec 27 21:37:06 ppp: [wan_link0] LCP: Down event
Dec 27 21:37:06 ppp: [wan_link0] Link: DOWN event -
At the exact moment it's having the problem, grab the mpd_wan.conf (or whichever interface it is) from /var/etc/ and post it here - make sure to edit out your username and password though, assuming they are really your username and password.
Also the output of this may help:
ps uxawww | grep mpd5
-
/var/etc/mpd_wan.conf:
startup: # configure the console set console close # configure the web server set web close default: pppoeclient: create bundle static wan set iface name pppoe0 set iface route default set iface disable on-demand set iface idle 0 set iface enable tcpmssfix set iface up-script /usr/local/sbin/ppp-linkup set iface down-script /usr/local/sbin/ppp-linkdown set ipcp ranges 0.0.0.0/0 0.0.0.0/0 #log -bund -ccp -chat -iface -ipcp -lcp -link create link static wan_link0 pppoe set link action bundle wan set link disable multilink set link keep-alive 10 60 set link max-redial 0 set link disable chap pap set link accept chap pap eap set link disable incoming set link mtu 1492 set auth authname "xxxx@t-online.de" set auth password xxxx set pppoe iface vr1 open
ps uxawww | grep mpd5:
root 31262 0.0 1.6 7440 3940 ?? SNs 2:22PM 0:00.02 /usr/local/sbin/mpd5 -b -k -d /var/etc -f mpd_wan.conf -p /var/run/pppoe_wan.pid -s ppp pppoeclient
Also check out the screenshot attached. If I open up mpd_wan.conf with vi there is some sort of control character at the end of the file…
![Bildschirmfoto 2010-12-28 um 14.24.10.png](/public/imported_attachments/1/Bildschirmfoto 2010-12-28 um 14.24.10.png)
-
So those are the files from the same time you are getting the errors in the logs?
Dec 27 21:37:35 ppp: [wan_link0] can't remove hook mpd8816-0 from node "[11]:": No such file or directory Dec 27 21:37:35 ppp: [wan_link0] PPPoE: can't connect "[11]:"->"mpd8816-0" and "[f]:"->"left": No such file or directory
That ^M is just a windows carriage return, usually programs are smart enough to ignore those. I've got one on my home router running a working snap from late November, so it's probably not the cause here.
-
I think so. I took this as soon as I could ssh into the box. But these errors go away and for some time you have the other stuff I posted above going on until it finally connects…
-
I just committed a patch which hopefully will resolve this.
Please test with a new snapshot because you need a new mpd binary. -
FYI- I just rebuilt it on the builder after Ermal's patch, and restarted the build, so the next new snapshot that uploads should include the fix.
-
It got even worse over here…
After a reboot the ppp.log showed this:Dec 29 16:34:25 voldemort ppp: [wan_link0] can't remove hook mpd10506-0 from node "[12]:": No such file or directory Dec 29 16:34:25 voldemort ppp: [wan_link0] Link: DOWN event Dec 29 16:34:25 voldemort ppp: [wan_link0] LCP: Down event Dec 29 16:34:25 voldemort ppp: [wan_link0] Link: reconnection attempt 2 in 1 seconds Dec 29 16:34:26 voldemort ppp: [wan_link0] Link: reconnection attempt 2 Dec 29 16:34:26 voldemort ppp: [wan_link0] PPPoE: can't connect "[12]:"->"mpd10506-0" and "[f]:"->"left": No such file or directory Dec 29 16:34:26 voldemort ppp: [wan_link0] can't remove hook mpd10506-0 from node "[12]:": No such file or directory Dec 29 16:34:26 voldemort ppp: [wan_link0] Link: DOWN event Dec 29 16:34:26 voldemort ppp: [wan_link0] LCP: Down event Dec 29 16:34:26 voldemort ppp: [wan_link0] Link: reconnection attempt 3 in 2 seconds Dec 29 16:34:28 voldemort ppp: [wan_link0] Link: reconnection attempt 3 Dec 29 16:34:28 voldemort ppp: [wan_link0] PPPoE: can't connect "[12]:"->"mpd10506-0" and "[f]:"->"left": No such file or directory Dec 29 16:34:28 voldemort ppp: [wan_link0] can't remove hook mpd10506-0 from node "[12]:": No such file or directory Dec 29 16:34:28 voldemort ppp: [wan_link0] Link: DOWN event Dec 29 16:34:28 voldemort ppp: [wan_link0] LCP: Down event Dec 29 16:34:28 voldemort ppp: [wan_link0] Link: reconnection attempt 4 in 2 seconds Dec 29 16:34:30 voldemort ppp: [wan_link0] Link: reconnection attempt 4 Dec 29 16:34:30 voldemort ppp: [wan_link0] PPPoE: can't connect "[12]:"->"mpd10506-0" and "[f]:"->"left": No such file or directory Dec 29 16:34:30 voldemort ppp: [wan_link0] can't remove hook mpd10506-0 from node "[12]:": No such file or directory Dec 29 16:34:30 voldemort ppp: [wan_link0] Link: DOWN event Dec 29 16:34:30 voldemort ppp: [wan_link0] LCP: Down event Dec 29 16:34:30 voldemort ppp: [wan_link0] Link: reconnection attempt 5 in 4 seconds Dec 29 16:34:34 voldemort ppp: [wan_link0] Link: reconnection attempt 5 Dec 29 16:34:34 voldemort ppp: [wan_link0] PPPoE: can't connect "[12]:"->"mpd10506-0" and "[f]:"->"left": No such file or directory Dec 29 16:34:34 voldemort ppp: [wan_link0] can't remove hook mpd10506-0 from node "[12]:": No such file or directory Dec 29 16:34:34 voldemort ppp: [wan_link0] Link: DOWN event Dec 29 16:34:34 voldemort ppp: [wan_link0] LCP: Down event Dec 29 16:34:34 voldemort ppp: [wan_link0] Link: reconnection attempt 6 in 4 seconds Dec 29 16:34:38 voldemort ppp: [wan_link0] Link: reconnection attempt 6 Dec 29 16:34:38 voldemort ppp: [wan_link0] PPPoE: can't connect "[12]:"->"mpd10506-0" and "[f]:"->"left": No such file or directory Dec 29 16:34:38 voldemort ppp: [wan_link0] can't remove hook mpd10506-0 from node "[12]:": No such file or directory Dec 29 16:34:38 voldemort ppp: [wan_link0] Link: DOWN event Dec 29 16:34:38 voldemort ppp: [wan_link0] LCP: Down event Dec 29 16:34:38 voldemort ppp: [wan_link0] Link: reconnection attempt 7 in 1 seconds Dec 29 16:34:39 voldemort ppp: [wan_link0] Link: reconnection attempt 7 Dec 29 16:34:39 voldemort ppp: [wan_link0] PPPoE: can't connect "[12]:"->"mpd10506-0" and "[f]:"->"left": No such file or directory Dec 29 16:34:39 voldemort ppp: [wan_link0] can't remove hook mpd10506-0 from node "[12]:": No such file or directory Dec 29 16:34:39 voldemort ppp: [wan_link0] Link: DOWN event Dec 29 16:34:39 voldemort ppp: [wan_link0] LCP: Down event Dec 29 16:34:39 voldemort ppp: [wan_link0] Link: reconnection attempt 8 in 3 seconds Dec 29 16:34:41 voldemort ppp: caught fatal signal term Dec 29 16:34:41 voldemort ppp: [wan] IFACE: Close event Dec 29 16:34:41 voldemort ppp: [wan] IPCP: Close event Dec 29 16:34:42 voldemort ppp: [wan_link0] LCP: Close event Dec 29 16:34:42 voldemort ppp: [wan_link0] LCP: state change Starting --> Initial Dec 29 16:34:42 voldemort ppp: [wan_link0] LCP: LayerFinish Dec 29 16:34:43 voldemort ppp: [wan] Bundle: Shutdown Dec 29 16:34:43 voldemort ppp: [wan_link0] Link: Shutdown Dec 29 16:34:43 voldemort ppp: process 10506 terminated Dec 29 16:34:46 voldemort ppp: Multi-link PPP daemon for FreeBSD Dec 29 16:34:46 voldemort ppp: Dec 29 16:34:46 voldemort ppp: process 25103 started, version 5.5 (root@FreeBSD_8.0_pfSense_2.0-snaps.pfsense.org 16:48 28-Dec-2010) Dec 29 16:34:46 voldemort ppp: web: web is not running Dec 29 16:34:46 voldemort ppp: [wan] Bundle: Interface ng0 created Dec 29 16:34:46 voldemort ppp: [wan_link0] Link: OPEN event Dec 29 16:34:46 voldemort ppp: [wan_link0] LCP: Open event Dec 29 16:34:46 voldemort ppp: [wan_link0] LCP: state change Initial --> Starting Dec 29 16:34:46 voldemort ppp: [wan_link0] LCP: LayerStart Dec 29 16:34:46 voldemort ppp: [wan_link0] PPPoE: Connecting to '*' Dec 29 16:34:46 voldemort ppp: PPPoE: rec'd ACNAME "KIER71-se800-B2234310702478" Dec 29 16:34:55 voldemort ppp: [wan_link0] PPPoE connection timeout after 9 seconds Dec 29 16:34:55 voldemort ppp: [wan_link0] Link: DOWN event Dec 29 16:34:55 voldemort ppp: [wan_link0] LCP: Down event Dec 29 16:34:55 voldemort ppp: [wan_link0] Link: reconnection attempt 1 in 1 seconds Dec 29 16:34:56 voldemort ppp: [wan_link0] Link: reconnection attempt 1 Dec 29 16:34:56 voldemort ppp: [wan_link0] PPPoE: Connecting to '*' Dec 29 16:34:57 voldemort ppp: PPPoE: rec'd ACNAME "KIER71-se800-B2234310702478" Dec 29 16:35:06 voldemort ppp: [wan_link0] PPPoE connection timeout after 9 seconds Dec 29 16:35:06 voldemort ppp: [wan_link0] Link: DOWN event Dec 29 16:35:06 voldemort ppp: [wan_link0] LCP: Down event Dec 29 16:35:06 voldemort ppp: [wan_link0] Link: reconnection attempt 2 in 1 seconds Dec 29 16:35:07 voldemort ppp: [wan_link0] Link: reconnection attempt 2 Dec 29 16:35:07 voldemort ppp: [wan_link0] PPPoE: Connecting to '*' Dec 29 16:35:07 voldemort ppp: PPPoE: rec'd ACNAME "KIER71-se800-B2234310702478" Dec 29 16:35:16 voldemort ppp: [wan_link0] PPPoE connection timeout after 9 seconds Dec 29 16:35:16 voldemort ppp: [wan_link0] Link: DOWN event Dec 29 16:35:16 voldemort ppp: [wan_link0] LCP: Down event Dec 29 16:35:16 voldemort ppp: [wan_link0] Link: reconnection attempt 3 in 3 seconds Dec 29 16:35:19 voldemort ppp: [wan_link0] Link: reconnection attempt 3 Dec 29 16:35:19 voldemort ppp: [wan_link0] PPPoE: Connecting to '*' Dec 29 16:35:19 voldemort ppp: PPPoE: rec'd ACNAME "KIER71-se800-B2234310702478"
Then suddenly it stopped and I checked if mpd5 was running which was not. Also the WebGUI wasn't accessable…
system.log showed the following:
Dec 29 16:37:35 voldemort kernel: pid 14143 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 14463 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 14739 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 14314 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 14793 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 15107 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 15387 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 15807 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 16146 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 16160 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 15704 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 16285 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 16331 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 16761 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 16748 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 17055 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 17089 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 17394 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 16638 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 16853 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 17664 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 18136 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 17773 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 18389 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 18687 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 18083 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 18495 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 18919 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 18798 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 19008 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 19298 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 19625 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 19589 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 19925 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 20132 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 20418 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 20714 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 20804 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 20829 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 21317 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 21104 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 21314 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 21511 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 21839 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 22209 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 22150 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 22368 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 22644 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 22831 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 22645 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 23037 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 23171 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 23461 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 24007 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 23702 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 24061 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 24346 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 24312 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 24044 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 24669 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 24820 (php), uid 0: exited on signal 11 Dec 29 16:37:35 voldemort kernel: pid 24933 (php), uid 0: exited on signal 11
So I had to do a 'killall php' and restart the Web Configurator. After that I could click save on the WAN interface so that mpd5 would start again. This time the ppp logs started again and it took some more minutes before the connection came up. Still not everything was right (see screenshot attached) - the IP on WAN was missing and I could not access website although the connection seemed to be up…
After another reboot and waiting some minutes for the connection to come up everything looked fine. But the packages (at the moment only avahi installed) did not get reinstalled automatically, again... After manually reinstalling avahi that was the log:
Dec 29 16:41:22 voldemort avahi-daemon[38866]: Found user 'avahi' (UID 558) and group 'avahi' (GID 558). Dec 29 16:41:22 voldemort avahi-daemon[38866]: Successfully dropped root privileges. Dec 29 16:41:22 voldemort avahi-daemon[38866]: avahi-daemon 0.6.24 starting up. Dec 29 16:41:22 voldemort avahi-daemon[38866]: WARNING: No NSS support for mDNS detected, consider installing nss-mdns! Dec 29 16:41:22 voldemort avahi-daemon[38866]: WARNING: No NSS support for mDNS detected, consider installing nss-mdns! Dec 29 16:41:22 voldemort avahi-daemon[38866]: Loading service file /usr/local/etc/avahi/services/sftp-ssh.service. Dec 29 16:41:22 voldemort avahi-daemon[38866]: Loading service file /usr/local/etc/avahi/services/ssh.service. Dec 29 16:41:22 voldemort avahi-daemon[38866]: Joining mDNS multicast group on interface ng1.IPv4 with address xxxx. Dec 29 16:41:22 voldemort avahi-daemon[38866]: New relevant interface ng1.IPv4 for mDNS. Dec 29 16:41:22 voldemort avahi-daemon[38866]: Joining mDNS multicast group on interface ath0_wlan1.IPv4 with address 192.168.100.254. Dec 29 16:41:22 voldemort avahi-daemon[38866]: New relevant interface ath0_wlan1.IPv4 for mDNS. Dec 29 16:41:22 voldemort avahi-daemon[38866]: Joining mDNS multicast group on interface ath0_wlan0.IPv4 with address 172.16.100.254. Dec 29 16:41:22 voldemort avahi-daemon[38866]: New relevant interface ath0_wlan0.IPv4 for mDNS. Dec 29 16:41:22 voldemort avahi-daemon[38866]: Joining mDNS multicast group on interface vr0.IPv4 with address 10.0.100.254. Dec 29 16:41:22 voldemort avahi-daemon[38866]: New relevant interface vr0.IPv4 for mDNS. Dec 29 16:41:22 voldemort avahi-daemon[38866]: Network interface enumeration completed. Dec 29 16:41:22 voldemort avahi-daemon[38866]: Registering new address record for fe80::20d:b9ff:fe13:54a8 on ng1.*. Dec 29 16:41:22 voldemort avahi-daemon[38866]: Registering new address record for xxxx on ng1.IPv4. Dec 29 16:41:22 voldemort avahi-daemon[38866]: Registering new address record for fe80::480:48ff:fe62:fa57 on ath0_wlan1.*. Dec 29 16:41:22 voldemort avahi-daemon[38866]: Registering new address record for 192.168.100.254 on ath0_wlan1.IPv4. Dec 29 16:41:22 voldemort avahi-daemon[38866]: Registering new address record for fe80::280:48ff:fe62:fa57 on ath0_wlan0.*. Dec 29 16:41:22 voldemort avahi-daemon[38866]: Registering new address record for 172.16.100.254 on ath0_wlan0.IPv4. Dec 29 16:41:22 voldemort avahi-daemon[38866]: Registering new address record for fe80::20d:b9ff:fe13:54a8 on vr0.*. Dec 29 16:41:22 voldemort avahi-daemon[38866]: Registering new address record for 10.0.100.254 on vr0.IPv4. Dec 29 16:41:22 voldemort avahi-daemon[38866]: Registering HINFO record with values 'I386'/'FREEBSD'. Dec 29 16:41:22 voldemort avahi-daemon[38866]: Short read() on signal pipe. Dec 29 16:41:22 voldemort avahi-daemon[38866]: Short read() on signal pipe. Dec 29 16:41:22 voldemort avahi-daemon[38866]: daemon_signal_next() failed Dec 29 16:41:22 voldemort avahi-daemon[38866]: daemon_signal_next() failed Dec 29 16:41:22 voldemort check_reload_status: reloading filter Dec 29 16:41:23 voldemort avahi-daemon[38866]: iface.c: avahi_server_add_service() failed: Not supported Dec 29 16:41:23 voldemort avahi-daemon[38866]: iface.c: avahi_server_add_service() failed: Not supported Dec 29 16:41:23 voldemort avahi-daemon[38866]: iface.c: avahi_server_add_service() failed: Not supported Dec 29 16:41:23 voldemort avahi-daemon[38866]: iface.c: avahi_server_add_service() failed: Not supported Dec 29 16:41:23 voldemort avahi-daemon[38866]: iface.c: avahi_server_add_service() failed: Not supported Dec 29 16:41:23 voldemort avahi-daemon[38866]: iface.c: avahi_server_add_service() failed: Not supported Dec 29 16:41:23 voldemort avahi-daemon[38866]: iface.c: avahi_server_add_service() failed: Not supported Dec 29 16:41:23 voldemort avahi-daemon[38866]: iface.c: avahi_server_add_service() failed: Not supported Dec 29 16:41:23 voldemort avahi-daemon[38866]: iface.c: avahi_server_add_service() failed: Not supported Dec 29 16:41:23 voldemort avahi-daemon[38866]: iface.c: avahi_server_add_service() failed: Not supported Dec 29 16:41:23 voldemort avahi-daemon[38866]: iface.c: avahi_server_add_service() failed: Not supported Dec 29 16:41:23 voldemort avahi-daemon[38866]: iface.c: avahi_server_add_service() failed: Not supported Dec 29 16:41:23 voldemort avahi-daemon[38866]: iface.c: avahi_server_add_service() failed: Not supported Dec 29 16:41:23 voldemort avahi-daemon[38866]: iface.c: avahi_server_add_service() failed: Not supported Dec 29 16:41:23 voldemort avahi-daemon[38866]: iface.c: avahi_server_add_service() failed: Not supported Dec 29 16:41:23 voldemort avahi-daemon[38866]: iface.c: avahi_server_add_service() failed: Not supported Dec 29 16:41:23 voldemort avahi-daemon[38866]: iface.c: avahi_server_add_service() failed: Not supported Dec 29 16:41:23 voldemort avahi-daemon[38866]: iface.c: avahi_server_add_service() failed: Not supported Dec 29 16:41:23 voldemort avahi-daemon[38866]: iface.c: avahi_server_add_service() failed: Not supported Dec 29 16:41:23 voldemort avahi-daemon[38866]: iface.c: avahi_server_add_service() failed: Not supported Dec 29 16:41:23 voldemort avahi-daemon[38866]: iface.c: avahi_server_add_service() failed: Not supported Dec 29 16:41:23 voldemort avahi-daemon[38866]: iface.c: avahi_server_add_service() failed: Not supported Dec 29 16:41:23 voldemort avahi-daemon[38866]: iface.c: avahi_server_add_service() failed: Not supported Dec 29 16:41:23 voldemort avahi-daemon[38866]: iface.c: avahi_server_add_service() failed: Not supported Dec 29 16:41:23 voldemort avahi-daemon[38866]: Server startup complete. Host name is voldemort.hogwarts.lan. Local service cookie is 3244555418. Dec 29 16:41:23 voldemort avahi-daemon[38866]: Failed to add service 'voldemort' of type '_ssh._tcp', ignoring service group (/usr/local/etc/avahi/services/ssh.service): Not supported Dec 29 16:41:23 voldemort avahi-daemon[38866]: Failed to add service 'voldemort' of type '_ssh._tcp', ignoring service group (/usr/local/etc/avahi/services/ssh.service): Not supported Dec 29 16:41:23 voldemort avahi-daemon[38866]: Failed to add service 'SFTP File Transfer on voldemort' of type '_sftp-ssh._tcp', ignoring service group (/usr/local/etc/avahi/services/sftp-ssh.service): Not supported Dec 29 16:41:23 voldemort avahi-daemon[38866]: Failed to add service 'SFTP File Transfer on voldemort' of type '_sftp-ssh._tcp', ignoring service group (/usr/local/etc/avahi/services/sftp-ssh.service): Not supported
So still some error messages. What are these. Are they 'normal'?
![Bildschirmfoto 2010-12-29 um 16.42.48.png](/public/imported_attachments/1/Bildschirmfoto 2010-12-29 um 16.42.48.png)
![Bildschirmfoto 2010-12-29 um 16.42.48.png_thumb](/public/imported_attachments/1/Bildschirmfoto 2010-12-29 um 16.42.48.png_thumb) -
I think your problems come from avahi package because it does some very bad things to base system.
Please uninstall avahi and if you can upgrade to a latest snap. -
Ok. I can test this, but I rely heavily on avahi for the apple bonjour stuff…
-
Bonjour works without the avahi package on your router. I have lots of macs and mac products on my networks and no avahi package on my routers.
I'm not really even sure of the purpose of a router running avahi. What are you trying to do?
GB
-
Well if you have LAN and WLAN on separate interfaces you need avahi in order for Bonjour to work…
(eg iTunes Remote / Connection from AppleTV(WLAN) to iTunes(LAN)) -
Hello…. same problem on Dec 28 pppoe dead after afew minute connected. AMD64
-
Please update to a snapshot after 28 December.