Much problems with PPOE on pfsense 0.94.10 .12 .14

MainFrame · Nov 27, 2005, 4:24 PM

Hi @ all

The last working version (for me) of pfsense with no problems is 0.90. I use this version with PPOE with the german provider arcor.

The last testet version is 0.94.14 and I have the following problems:
If I set up my WAN provider (username & pass) and I make a reboot of pfsense, than I´ve got this message:

*** Welcome to pfSense version 0.94.14 - pfSense ***

LAN* -> sis0 -> 192.168.123.254
WAN* -> sis3 -> NONE(PPPoE)

pfSense console setup

0) Logout (SSH only)
1) Assign Interfaces
2) Set LAN IP address
3) Reset webGUI password
4) Reset to factory defaults
5) Reboot system
6) Halt system
7) Ping host
8) Shell
9) PFtop
10) Traffic Logs

Enter an option:

In the system log/system I can read this:

Nov 27 16:45:19 mpd: [pppoe] device is now in state DOWN
Nov 27 16:45:19 mpd: [pppoe] pausing 4 seconds before open
Nov 27 16:45:19 mpd: [pppoe] device: OPEN event in state DOWN
Nov 27 16:45:19 mpd: [pppoe] LCP: Down event
Nov 27 16:45:19 mpd: [pppoe] link: DOWN event
Nov 27 16:45:19 mpd: [pppoe] device is now in state DOWN
Nov 27 16:45:19 mpd: [pppoe] device: DOWN event in state OPENING
Nov 27 16:45:19 mpd: [pppoe] PPPoE connection timeout after 9 seconds
Nov 27 16:45:10 mpd: [pppoe] device is now in state OPENING
Nov 27 16:45:10 mpd: [pppoe] device: OPEN event in state DOWN
Nov 27 16:45:04 mpd: [pppoe] device is now in state DOWN
Nov 27 16:45:04 mpd: [pppoe] pausing 6 seconds before open
Nov 27 16:45:04 mpd: [pppoe] device: OPEN event in state DOWN
Nov 27 16:45:04 mpd: [pppoe] LCP: Down event
Nov 27 16:45:04 mpd: [pppoe] link: DOWN event
Nov 27 16:45:04 mpd: [pppoe] device is now in state DOWN
Nov 27 16:45:04 mpd: [pppoe] device: DOWN event in state OPENING
Nov 27 16:45:04 mpd: [pppoe] PPPoE connection timeout after 9 seconds
Nov 27 16:44:55 mpd: [pppoe] device is now in state OPENING
Nov 27 16:44:55 mpd: [pppoe] device: OPEN event in state DOWN
Nov 27 16:44:54 mpd: [pppoe] device is now in state DOWN
Nov 27 16:44:54 mpd: [pppoe] pausing 1 seconds before open
Nov 27 16:44:54 mpd: [pppoe] device: OPEN event in state DOWN
Nov 27 16:44:50 mpd: [pppoe] device is now in state DOWN
Nov 27 16:44:50 mpd: [pppoe] pausing 4 seconds before open
Nov 27 16:44:50 mpd: [pppoe] device: OPEN event in state DOWN
Nov 27 16:44:50 mpd: [pppoe] LCP: Down event
Nov 27 16:44:50 mpd: [pppoe] link: DOWN event
Nov 27 16:44:50 mpd: [pppoe] device is now in state DOWN
Nov 27 16:44:50 mpd: [pppoe] device: DOWN event in state OPENING
Nov 27 16:44:50 mpd: [pppoe] PPPoE connection timeout after 9 seconds
Nov 27 16:44:41 mpd: [pppoe] device is now in state OPENING
Nov 27 16:44:41 mpd: [pppoe] device: OPEN event in state DOWN
Nov 27 16:44:35 mpd: [pppoe] device is now in state DOWN
Nov 27 16:44:35 mpd: [pppoe] pausing 6 seconds before open
Nov 27 16:44:35 mpd: [pppoe] device: OPEN event in state DOWN
Nov 27 16:44:35 mpd: [pppoe] LCP: Down event
Nov 27 16:44:35 mpd: [pppoe] link: DOWN event
Nov 27 16:44:35 mpd: [pppoe] device is now in state DOWN
Nov 27 16:44:35 mpd: [pppoe] device: DOWN event in state OPENING
Nov 27 16:44:35 mpd: [pppoe] PPPoE connection timeout after 9 seconds
Nov 27 16:44:26 mpd: [pppoe] device is now in state OPENING
Nov 27 16:44:26 mpd: [pppoe] device: OPEN event in state DOWN
Nov 27 16:44:25 mpd: [pppoe] device is now in state DOWN
Nov 27 16:44:25 mpd: [pppoe] pausing 1 seconds before open
Nov 27 16:44:25 mpd: [pppoe] device: OPEN event in state DOWN
Nov 27 16:44:21 mpd: [pppoe] device is now in state DOWN
Nov 27 16:44:21 mpd: [pppoe] pausing 4 seconds before open
Nov 27 16:44:21 mpd: [pppoe] device: OPEN event in state DOWN
Nov 27 16:44:21 mpd: [pppoe] LCP: Down event
Nov 27 16:44:21 mpd: [pppoe] link: DOWN event
Nov 27 16:44:21 mpd: [pppoe] device is now in state DOWN
Nov 27 16:44:21 mpd: [pppoe] device: DOWN event in state OPENING
Nov 27 16:44:21 mpd: [pppoe] PPPoE connection timeout after 9 seconds
Nov 27 16:44:12 mpd: [pppoe] device is now in state OPENING
Nov 27 16:44:12 mpd: [pppoe] device: OPEN event in state DOWN
Nov 27 16:44:06 mpd: [pppoe] device is now in state DOWN
Nov 27 16:44:06 mpd: [pppoe] pausing 6 seconds before open
Nov 27 16:44:06 mpd: [pppoe] device: OPEN event in state DOWN
Nov 27 16:44:06 mpd: [pppoe] LCP: Down event
Nov 27 16:44:06 mpd: [pppoe] link: DOWN event
Nov 27 16:44:06 mpd: [pppoe] device is now in state DOWN
Nov 27 16:44:06 mpd: [pppoe] device: DOWN event in state OPENING
Nov 27 16:44:06 mpd: [pppoe] PPPoE connection timeout after 9 seconds
Nov 27 16:43:57 mpd: [pppoe] device is now in state OPENING
Nov 27 16:43:57 mpd: [pppoe] device: OPEN event in state DOWN
Nov 27 16:43:55 mpd: [pppoe] device is now in state DOWN
Nov 27 16:43:55 mpd: [pppoe] pausing 2 seconds before open
Nov 27 16:43:55 mpd: [pppoe] device: OPEN event in state DOWN
Nov 27 16:43:51 mpd: [pppoe] device is now in state DOWN
Nov 27 16:43:51 mpd: [pppoe] pausing 4 seconds before open
Nov 27 16:43:51 mpd: [pppoe] device: OPEN event in state DOWN
Nov 27 16:43:51 mpd: [pppoe] LCP: Down event
Nov 27 16:43:51 mpd: [pppoe] link: DOWN event
Nov 27 16:43:51 mpd: [pppoe] device is now in state DOWN
Nov 27 16:43:51 mpd: [pppoe] device: DOWN event in state OPENING
Nov 27 16:43:51 mpd: [pppoe] PPPoE connection timeout after 9 seconds
Nov 27 16:43:51 login: ROOT LOGIN (admin) ON console
Nov 27 16:43:51 login: ROOT LOGIN (admin) ON console
Nov 27 16:43:51 login: login on console as admin
Nov 27 16:43:42 mpd: [pppoe] device is now in state OPENING
Nov 27 16:43:42 mpd: [pppoe] device: OPEN event in state DOWN
Nov 27 16:43:40 mpd: [pppoe] device is now in state DOWN
Nov 27 16:43:40 mpd: [pppoe] pausing 2 seconds before open
Nov 27 16:43:40 mpd: [pppoe] device: OPEN event in state DOWN
Nov 27 16:43:36 mpd: [pppoe] device is now in state DOWN
Nov 27 16:43:36 mpd: [pppoe] pausing 4 seconds before open
Nov 27 16:43:36 mpd: [pppoe] device: OPEN event in state DOWN
Nov 27 16:43:36 mpd: [pppoe] LCP: Down event
Nov 27 16:43:36 mpd: [pppoe] link: DOWN event
Nov 27 16:43:36 mpd: [pppoe] device is now in state DOWN
Nov 27 16:43:36 mpd: [pppoe] device: DOWN event in state OPENING
Nov 27 16:43:36 mpd: [pppoe] PPPoE connection timeout after 9 seconds
Nov 27 16:43:32 php: : Resyncing configuration for all packages.
Nov 27 16:43:28 kernel: pflog0: promiscuous mode enabled
Nov 27 16:43:27 mpd: [pppoe] device is now in state OPENING
Nov 27 16:43:27 mpd: [pppoe] device: OPEN event in state DOWN
Nov 27 16:43:25 mpd: [pppoe] device is now in state DOWN
Nov 27 16:43:25 mpd: [pppoe] pausing 2 seconds before open
Nov 27 16:43:25 mpd: [pppoe] device: OPEN event in state DOWN
Nov 27 16:43:21 mpd: [pppoe] device is now in state DOWN
Nov 27 16:43:21 mpd: [pppoe] pausing 4 seconds before open
Nov 27 16:43:21 mpd: [pppoe] device: OPEN event in state DOWN
Nov 27 16:43:21 mpd: [pppoe] LCP: Down event
Nov 27 16:43:21 mpd: [pppoe] link: DOWN event
Nov 27 16:43:21 mpd: [pppoe] device is now in state DOWN
Nov 27 16:43:21 mpd: [pppoe] device: DOWN event in state OPENING
Nov 27 16:43:21 mpd: [pppoe] PPPoE connection timeout after 9 seconds
Nov 27 16:43:12 mpd: [pppoe] device is now in state OPENING
Nov 27 16:43:12 mpd: [pppoe] device: OPEN event in state DOWN
Nov 27 16:43:06 mpd: [pppoe] device is now in state DOWN
Nov 27 16:43:06 mpd: [pppoe] pausing 6 seconds before open
Nov 27 16:43:06 mpd: [pppoe] device: OPEN event in state DOWN
Nov 27 16:43:06 mpd: [pppoe] LCP: Down event
Nov 27 16:43:06 mpd: [pppoe] link: DOWN event
Nov 27 16:43:06 mpd: [pppoe] device is now in state DOWN
Nov 27 16:43:06 mpd: [pppoe] device: DOWN event in state OPENING
Nov 27 16:43:06 mpd: [pppoe] PPPoE connection timeout after 9 seconds
Nov 27 16:42:59 mpd: mpd: already running as process 214
Nov 27 16:42:59 mpd: mpd: pid 226, version 3.18 (root@builder.livebsd.com 15:38 27-Aug-2005)
Nov 27 16:42:57 mpd: [pppoe] device is now in state OPENING
Nov 27 16:42:57 mpd: [pppoe] device: OPEN event in state DOWN
Nov 27 16:42:57 mpd: [pppoe] LCP: LayerStart
Nov 27 16:42:57 mpd: [pppoe] LCP: state change Initial –> Starting
Nov 27 16:42:57 mpd: [pppoe] LCP: Open event
Nov 27 16:42:57 mpd: [pppoe] link: OPEN event
Nov 27 16:42:57 mpd: [pppoe] opening link "pppoe"…
Nov 27 16:42:57 mpd: [pppoe] bundle: OPEN event in state CLOSED
Nov 27 16:42:57 mpd: [pppoe] IPCP: LayerStart
Nov 27 16:42:57 mpd: [pppoe] IPCP: state change Initial –> Starting
Nov 27 16:42:57 mpd: [pppoe] IPCP: Open event
Nov 27 16:42:57 mpd: [pppoe] IFACE: Open event
Nov 27 16:42:57 mpd: [pppoe] IPCP: peer address cannot be zero
Nov 27 16:42:57 mpd: [pppoe] using interface ng0
Nov 27 16:42:57 mpd: [pppoe] exec: /sbin/ifconfig sis3 up
Nov 27 16:42:57 mpd: [pppoe] ppp node is "mpd214-pppoe"
Nov 27 16:42:57 mpd: mpd: pid 214, version 3.18 (root@builder.livebsd.com 15:38 27-Aug-2005)
Nov 27 16:42:57 php: : HOTPLUG: Configuring wan interface wan
Nov 27 16:42:57 php: : DEVD Ethernet attached event for sis3
Nov 27 16:42:56 php: : Hotplug event detected for sis2 but ignoring since interface is not set for DHCP
Nov 27 16:42:55 php: : Hotplug event detected for sis1 but ignoring since interface is not set for DHCP
Nov 27 16:42:55 php: : Hotplug event detected for sis0 but ignoring since interface is not set for DHCP
Nov 27 16:42:55 kernel: sis3: link state changed to UP
Nov 27 16:42:55 kernel: sis2: link state changed to DOWN
Nov 27 16:42:55 kernel: sis1: link state changed to DOWN
Nov 27 16:42:55 kernel: sis0: link state changed to UP
Nov 27 16:42:54 kernel: Trying to mount root from ufs:/dev/ad0s1a

And now if I go to the webguided menue WAN and I only "save" without any changes than I got a real IP from my provider, like this:

*** Welcome to pfSense version 0.94.14 - pfSense ***

LAN* -> sis0 -> 192.168.123.254
WAN* -> sis3 -> 82.83.57.167(PPPoE)

pfSense console setup

0) Logout (SSH only)
1) Assign Interfaces
2) Set LAN IP address
3) Reset webGUI password
4) Reset to factory defaults
5) Reboot system
6) Halt system
7) Ping host
8) Shell
9) PFtop
10) Traffic Logs

Enter an option:

The next Problen with configuring the WAN is, if I sign the field "Enable Dial-On-Demand mode" and I reboot the system, then I got this IP:

*** Welcome to pfSense version 0.94.14 - pfSense ***

LAN* -> sis0 -> 192.168.123.254
WAN* -> sis3 -> 192.0.2.112(PPPoE)

pfSense console setup

0) Logout (SSH only)
1) Assign Interfaces
2) Set LAN IP address
3) Reset webGUI password
4) Reset to factory defaults
5) Reboot system
6) Halt system
7) Ping host
8) Shell
9) PFtop
10) Traffic Logs

Enter an option:

This IP comming not from my provider, its an othe range - I think its my DSL-Modem.

The first version I´ve got this probs is 0.92

Sorry for my bad english

Best regards
Udo

wolfman · Nov 27, 2005, 6:05 PM

Hi all!

I run into the same probs after upgrading to 0.92 with a Telekom-SDSL via PPPOE.

After only a reboot, WAN is disconnected. I've to save WAN-Settings in GUI without only doing any changes, then WAN is immediately online.

I tried to restore config from previously saved without success.

Maybe, due to the last changes in the built, settings have to be drawn back to default and then rebuilt by hand?

Nevertheless, its an outstanding project, done by the devs. I hope, they'll not "loose their nerves", confronted to a raising # of users - and their probs… ;-)

Ciao Wolf

hoba · Nov 27, 2005, 8:12 PM

I'll do some testing tomorrow (if I find some time) in the office at our backup adsl line (t-online) to find out what's going on.

sullrich · Nov 27, 2005, 8:55 PM

@hoba:

I'll do some testing tomorrow (if I find some time) in the office at our backup adsl line (t-online) to find out what's going on.

I rewired my home network to test this and found quite a number of issues.

A new version is coming up soon.

sullrich · Nov 28, 2005, 2:04 AM

@sullrich:

@hoba:

I'll do some testing tomorrow (if I find some time) in the office at our backup adsl line (t-online) to find out what's going on.

I rewired my home network to test this and found quite a number of issues.

A new version is coming up soon.

Please test 0.94.16 from my home dir: http://www.pfsense.com/~sullrich/

wolfman · Nov 28, 2005, 5:43 AM

I updated to 0.94.16, also 0.94.18 with your last commits, but PPPOE is only coming up after a reboot. If you ever hit 'disconnect' in GUI- interfaces, PPPOE is never connecting, when you try 'connect'.

From my point of view, there's no hint in system-log, regarding to mpd.

sullrich · Nov 28, 2005, 5:47 AM

@wolfman:

I updated to 0.94.16, also 0.94.18 with your last commits, but PPPOE is only coming up after a reboot. If you ever hit 'disconnect' in GUI- interfaces, PPPOE is never connecting, when you try 'connect'.

From my point of view, there's no hint in system-log, regarding to mpd.

Mind posting the system logs or sending them to me? Seems like we have the oppisite problem now…

MainFrame · Nov 28, 2005, 4:44 PM

Hello,

testet ver 0.94.18 the same prob like wolfman. After a disconnect i got these system log:

Nov 28 17:22:18 mpd: [pppoe] device is now in state DOWN
Nov 28 17:22:18 mpd: [pppoe] device: CLOSE event in state DOWN
Nov 28 17:22:18 mpd: [pppoe] LCP: Close event
Nov 28 17:22:18 mpd: [pppoe] link: CLOSE event
Nov 28 17:22:18 mpd: [pppoe] device is now in state DOWN
Nov 28 17:22:18 mpd: [pppoe] pausing 6 seconds before open
Nov 28 17:22:18 mpd: [pppoe] device: OPEN event in state DOWN
Nov 28 17:22:18 mpd: [pppoe] LCP: LayerFinish
Nov 28 17:22:18 mpd: [pppoe] LCP: state change Starting –> Initial
Nov 28 17:22:18 mpd: [pppoe] LCP: Close event
Nov 28 17:22:18 mpd: [pppoe] link: CLOSE event
Nov 28 17:22:18 mpd: [pppoe] rec'd proto LCP while dead
Nov 28 17:22:18 mpd: [pppoe] LCP: LayerDown
Nov 28 17:22:18 mpd: [pppoe] closing link "pppoe"…
Nov 28 17:22:18 mpd: [pppoe] IPCP: state change Closed –> Initial
Nov 28 17:22:18 mpd: [pppoe] IPCP: Down event
Nov 28 17:22:18 mpd: [pppoe] up: 0 links, total bandwidth 9600 bps
Nov 28 17:22:18 mpd: [pppoe] setting interface ng0 MTU to 1500 bytes
Nov 28 17:22:18 mpd: [pppoe] LCP: phase shift NETWORK –> DEAD
Nov 28 17:22:18 mpd: [pppoe] LCP: state change Opened –> Starting
Nov 28 17:22:18 mpd: [pppoe] LCP: Down event
Nov 28 17:22:18 mpd: [pppoe] link: DOWN event
Nov 28 17:22:18 mpd: [pppoe] closing link "pppoe"…
Nov 28 17:22:18 mpd: [pppoe] bundle: CLOSE event in state OPENED
Nov 28 17:22:18 mpd: [pppoe] IPCP: LayerFinish
Nov 28 17:22:18 mpd: [pppoe] IPCP: state change Closing –> Closed
Nov 28 17:22:18 mpd: [pppoe] IPCP: rec'd Terminate Ack #4 link 0 (Closing)
Nov 28 17:22:18 mpd: [pppoe] device is now in state DOWN
Nov 28 17:22:18 mpd: [pppoe] device: DOWN event in state UP
Nov 28 17:22:18 mpd: [pppoe] rec'd unexpected protocol IP on link 0
Nov 28 17:22:18 mpd: [pppoe] PPPoE connection closed
Nov 28 17:22:18 mpd: [pppoe] exec: /sbin/ifconfig ng0 down delete -link0
Nov 28 17:22:18 mpd: [pppoe] exec: /sbin/route delete 82.82.186.254 -iface lo0
Nov 28 17:22:18 mpd: [pppoe] exec: /sbin/route delete 0.0.0.0 82.82.160.1
Nov 28 17:22:18 mpd: [pppoe] IFACE: Down event
Nov 28 17:22:18 mpd: [pppoe] IPCP: LayerDown
Nov 28 17:22:18 mpd: [pppoe] IPCP: SendTerminateReq #4
Nov 28 17:22:18 mpd: [pppoe] IPCP: state change Opened –> Closing
Nov 28 17:22:18 mpd: [pppoe] IPCP: Close event
Nov 28 17:22:18 mpd: [pppoe] rec'd signal usr2, closing
Nov 28 17:22:01 syslogd: kernel boot file is /boot/kernel/kernel

If I want to reconnect I got no message in the system log.

When I boot the system with aktivated "Dynamic DNS" then I receive an IP from the provider, but it´s not possible to connect to the I-net.

Bye Udo

sullrich · Nov 28, 2005, 5:12 PM

@MainFrame:

Hello,

testet ver 0.94.18 the same prob like wolfman. After a disconnect i got these system log:

Nov 28 17:22:18 mpd: [pppoe] device is now in state DOWN
Nov 28 17:22:18 mpd: [pppoe] device: CLOSE event in state DOWN
Nov 28 17:22:18 mpd: [pppoe] LCP: Close event
Nov 28 17:22:18 mpd: [pppoe] link: CLOSE event
Nov 28 17:22:18 mpd: [pppoe] device is now in state DOWN
Nov 28 17:22:18 mpd: [pppoe] pausing 6 seconds before open
Nov 28 17:22:18 mpd: [pppoe] device: OPEN event in state DOWN
Nov 28 17:22:18 mpd: [pppoe] LCP: LayerFinish
Nov 28 17:22:18 mpd: [pppoe] LCP: state change Starting –> Initial
Nov 28 17:22:18 mpd: [pppoe] LCP: Close event
Nov 28 17:22:18 mpd: [pppoe] link: CLOSE event
Nov 28 17:22:18 mpd: [pppoe] rec'd proto LCP while dead
Nov 28 17:22:18 mpd: [pppoe] LCP: LayerDown
Nov 28 17:22:18 mpd: [pppoe] closing link "pppoe"…
Nov 28 17:22:18 mpd: [pppoe] IPCP: state change Closed –> Initial
Nov 28 17:22:18 mpd: [pppoe] IPCP: Down event
Nov 28 17:22:18 mpd: [pppoe] up: 0 links, total bandwidth 9600 bps
Nov 28 17:22:18 mpd: [pppoe] setting interface ng0 MTU to 1500 bytes
Nov 28 17:22:18 mpd: [pppoe] LCP: phase shift NETWORK –> DEAD
Nov 28 17:22:18 mpd: [pppoe] LCP: state change Opened –> Starting
Nov 28 17:22:18 mpd: [pppoe] LCP: Down event
Nov 28 17:22:18 mpd: [pppoe] link: DOWN event
Nov 28 17:22:18 mpd: [pppoe] closing link "pppoe"…
Nov 28 17:22:18 mpd: [pppoe] bundle: CLOSE event in state OPENED
Nov 28 17:22:18 mpd: [pppoe] IPCP: LayerFinish
Nov 28 17:22:18 mpd: [pppoe] IPCP: state change Closing –> Closed
Nov 28 17:22:18 mpd: [pppoe] IPCP: rec'd Terminate Ack #4 link 0 (Closing)
Nov 28 17:22:18 mpd: [pppoe] device is now in state DOWN
Nov 28 17:22:18 mpd: [pppoe] device: DOWN event in state UP
Nov 28 17:22:18 mpd: [pppoe] rec'd unexpected protocol IP on link 0
Nov 28 17:22:18 mpd: [pppoe] PPPoE connection closed
Nov 28 17:22:18 mpd: [pppoe] exec: /sbin/ifconfig ng0 down delete -link0
Nov 28 17:22:18 mpd: [pppoe] exec: /sbin/route delete 82.82.186.254 -iface lo0
Nov 28 17:22:18 mpd: [pppoe] exec: /sbin/route delete 0.0.0.0 82.82.160.1
Nov 28 17:22:18 mpd: [pppoe] IFACE: Down event
Nov 28 17:22:18 mpd: [pppoe] IPCP: LayerDown
Nov 28 17:22:18 mpd: [pppoe] IPCP: SendTerminateReq #4
Nov 28 17:22:18 mpd: [pppoe] IPCP: state change Opened –> Closing
Nov 28 17:22:18 mpd: [pppoe] IPCP: Close event
Nov 28 17:22:18 mpd: [pppoe] rec'd signal usr2, closing
Nov 28 17:22:01 syslogd: kernel boot file is /boot/kernel/kernel

If I want to reconnect I got no message in the system log.

When I boot the system with aktivated "Dynamic DNS" then I receive an IP from the provider, but it´s not possible to connect to the I-net.

Bye Udo

Really need to see the entire log. There are many aspects besides mpd… rc.linkup, etc.

MainFrame · Nov 28, 2005, 5:35 PM

o.k moment, I will send it to you per PM - its very long -

Udo

sullrich · Nov 28, 2005, 5:42 PM

@MainFrame:

o.k moment, I will send it to you per PM - its very long -

Udo

Logs show your fully up. No traffic passes!?

MainFrame · Nov 28, 2005, 6:32 PM

YES, it´s right. The log I sent to you after a normally reboot (without activated "Dynamic DNS")! At this time they are no problems. If I disconnect the WAN connection, you can see the log in Reply#7 - there is nothing more.

If I try to connect, in the Interface menue - nothing happend - no connection and NO entries in the system log.

Or do you mean a full log with activated "Dynamic DNS" ?

sullrich · Nov 28, 2005, 6:35 PM

@MainFrame:

YES, it´s right. The log I sent to you after a normally reboot (without activated "Dynamic DNS")! At this time they are no problems. If I disconnect the WAN connection, you can see the log in Reply#7 - there is nothing more.

If I try to connect, in the Interface menue - nothing happend - no connection and NO entries in the system log.

Or do you mean a full log with activated "Dynamic DNS" ?

We fixed this dynamic dns many moons ago but it appears to be coming back. Joy.

Please send the logs from dynamic dns enabled too.

sullrich · Nov 28, 2005, 8:02 PM

@sullrich:

@MainFrame:

YES, it´s right. The log I sent to you after a normally reboot (without activated "Dynamic DNS")! At this time they are no problems. If I disconnect the WAN connection, you can see the log in Reply#7 - there is nothing more.

If I try to connect, in the Interface menue - nothing happend - no connection and NO entries in the system log.

Or do you mean a full log with activated "Dynamic DNS" ?

We fixed this dynamic dns many moons ago but it appears to be coming back. Joy.

Please send the logs from dynamic dns enabled too.

Please try http://www.pfsense.com/~sullrich/pfSense-Full-Update-0.94.18.tgz

Found a nice pppoe blocking situation.

Also, please make sure that the dyndns updates okay.

MainFrame · Nov 29, 2005, 7:46 AM

Ok, I will try the newest update, I think it´s now 0.95 !

I do it in the afternoon , at this time I´m at work.

I will give you my feedback after testing ! ;)

Udo

hoba · Nov 29, 2005, 7:53 AM

Expect the issue to be solved, we already have lot's of reports from IRC user that are leading a happy life again ;D

MainFrame · Nov 29, 2005, 11:45 PM

Thx - now PPOE and DNS working fine. A reboot and a change of "Enable Dial-On-Demand mode" is now working.

Only sometimes try DNS to refresh every minute - look this, it comes from alone, I don´t make any changes:

Nov 30 00:28:02 php: : phpDynDNS: No Change In My IP Address and/or 28 Days Has Not Past. Not Updating Dynamic DNS Entry.
Nov 30 00:28:02 php: : DynDns: Cached IP: 82.82.176.84
Nov 30 00:28:02 php: : DynDns: Current WAN IP: 82.82.176.84
Nov 30 00:28:02 php: : DynDns: _detectChange() starting.
Nov 30 00:28:02 php: : DynDns: updatedns() starting
Nov 30 00:28:02 php: : DynDns: Running updatedns()
Nov 30 00:27:02 php: : phpDynDNS: No Change In My IP Address and/or 28 Days Has Not Past. Not Updating Dynamic DNS Entry.
Nov 30 00:27:02 php: : DynDns: Cached IP: 82.82.176.84
Nov 30 00:27:02 php: : DynDns: Current WAN IP: 82.82.176.84
Nov 30 00:27:02 php: : DynDns: _detectChange() starting.
Nov 30 00:27:02 php: : DynDns: updatedns() starting
Nov 30 00:27:02 php: : DynDns: Running updatedns()
Nov 30 00:26:01 php: : phpDynDNS: No Change In My IP Address and/or 28 Days Has Not Past. Not Updating Dynamic DNS Entry.
Nov 30 00:26:01 php: : DynDns: Cached IP: 82.82.176.84
Nov 30 00:26:01 php: : DynDns: Current WAN IP: 82.82.176.84
Nov 30 00:26:01 php: : DynDns: _detectChange() starting.
Nov 30 00:26:01 php: : DynDns: updatedns() starting
Nov 30 00:26:01 php: : DynDns: Running updatedns()
Nov 30 00:25:01 php: : phpDynDNS: No Change In My IP Address and/or 28 Days Has Not Past. Not Updating Dynamic DNS Entry.
Nov 30 00:25:01 php: : DynDns: Cached IP: 82.82.176.84
Nov 30 00:25:01 php: : DynDns: Current WAN IP: 82.82.176.84
Nov 30 00:25:01 php: : DynDns: _detectChange() starting.
Nov 30 00:25:01 php: : DynDns: updatedns() starting
Nov 30 00:25:01 php: : DynDns: Running updatedns()
Nov 30 00:24:02 php: : phpDynDNS: No Change In My IP Address and/or 28 Days Has Not Past. Not Updating Dynamic DNS Entry.
Nov 30 00:24:02 php: : DynDns: Cached IP: 82.82.176.84
Nov 30 00:24:02 php: : DynDns: Current WAN IP: 82.82.176.84
Nov 30 00:24:02 php: : DynDns: _detectChange() starting.
Nov 30 00:24:02 php: : DynDns: updatedns() starting
Nov 30 00:24:02 php: : DynDns: Running updatedns()
Nov 30 00:23:02 php: : phpDynDNS: No Change In My IP Address and/or 28 Days Has Not Past. Not Updating Dynamic DNS Entry.
Nov 30 00:23:02 php: : DynDns: Cached IP: 82.82.176.84
Nov 30 00:23:02 php: : DynDns: Current WAN IP: 82.82.176.84
Nov 30 00:23:02 php: : DynDns: _detectChange() starting.
Nov 30 00:23:02 php: : DynDns: updatedns() starting
Nov 30 00:23:02 php: : DynDns: Running updatedns()
Nov 30 00:22:02 php: : phpDynDNS: No Change In My IP Address and/or 28 Days Has Not Past. Not Updating Dynamic DNS Entry.
Nov 30 00:22:02 php: : DynDns: Cached IP: 82.82.176.84
Nov 30 00:22:02 php: : DynDns: Current WAN IP: 82.82.176.84
Nov 30 00:22:02 php: : DynDns: _detectChange() starting.
Nov 30 00:22:02 php: : DynDns: updatedns() starting
Nov 30 00:22:02 php: : DynDns: Running updatedns()
Nov 30 00:21:01 php: : phpDynDNS: No Change In My IP Address and/or 28 Days Has Not Past. Not Updating Dynamic DNS Entry.
Nov 30 00:21:01 php: : DynDns: Cached IP: 82.82.176.84
Nov 30 00:21:01 php: : DynDns: Current WAN IP: 82.82.176.84
Nov 30 00:21:01 php: : DynDns: _detectChange() starting.
Nov 30 00:21:01 php: : DynDns: updatedns() starting
Nov 30 00:21:01 php: : DynDns: Running updatedns()
Nov 30 00:20:02 php: : phpDynDNS: No Change In My IP Address and/or 28 Days Has Not Past. Not Updating Dynamic DNS Entry.
Nov 30 00:20:02 php: : DynDns: Cached IP: 82.82.176.84
Nov 30 00:20:02 php: : DynDns: Current WAN IP: 82.82.176.84
Nov 30 00:20:02 php: : DynDns: _detectChange() starting.
Nov 30 00:20:02 php: : DynDns: updatedns() starting
Nov 30 00:20:02 php: : DynDns: Running updatedns()
Nov 30 00:19:02 php: : phpDynDNS: No Change In My IP Address and/or 28 Days Has Not Past. Not Updating Dynamic DNS Entry.
Nov 30 00:19:02 php: : DynDns: Cached IP: 82.82.176.84
Nov 30 00:19:02 php: : DynDns: Current WAN IP: 82.82.176.84
Nov 30 00:19:02 php: : DynDns: _detectChange() starting.
Nov 30 00:19:02 php: : DynDns: updatedns() starting
Nov 30 00:19:02 php: : DynDns: Running updatedns()
Nov 30 00:18:01 php: : phpDynDNS: No Change In My IP Address and/or 28 Days Has Not Past. Not Updating Dynamic DNS Entry.
Nov 30 00:18:01 php: : DynDns: Cached IP: 82.82.176.84
Nov 30 00:18:01 php: : DynDns: Current WAN IP: 82.82.176.84
Nov 30 00:18:01 php: : DynDns: _detectChange() starting.
Nov 30 00:18:01 php: : DynDns: updatedns() starting
Nov 30 00:18:01 php: : DynDns: Running updatedns()
Nov 30 00:17:02 php: : phpDynDNS: No Change In My IP Address and/or 28 Days Has Not Past. Not Updating Dynamic DNS Entry.
Nov 30 00:17:02 php: : DynDns: Cached IP: 82.82.176.84
Nov 30 00:17:02 php: : DynDns: Current WAN IP: 82.82.176.84
Nov 30 00:17:02 php: : DynDns: _detectChange() starting.
Nov 30 00:17:02 php: : DynDns: updatedns() starting
Nov 30 00:17:02 php: : DynDns: Running updatedns()
Nov 30 00:16:02 php: : phpDynDNS: No Change In My IP Address and/or 28 Days Has Not Past. Not Updating Dynamic DNS Entry.
Nov 30 00:16:02 php: : DynDns: Cached IP: 82.82.176.84
Nov 30 00:16:02 php: : DynDns: Current WAN IP: 82.82.176.84
Nov 30 00:16:02 php: : DynDns: _detectChange() starting.
Nov 30 00:16:02 php: : DynDns: updatedns() starting
Nov 30 00:16:02 php: : DynDns: Running updatedns()
Nov 30 00:15:01 php: : phpDynDNS: No Change In My IP Address and/or 28 Days Has Not Past. Not Updating Dynamic DNS Entry.
Nov 30 00:15:01 php: : DynDns: Cached IP: 82.82.176.84
Nov 30 00:15:01 php: : DynDns: Current WAN IP: 82.82.176.84
Nov 30 00:15:01 php: : DynDns: _detectChange() starting.
Nov 30 00:15:01 php: : DynDns: updatedns() starting
Nov 30 00:15:01 php: : DynDns: Running updatedns()
Nov 30 00:14:01 php: : phpDynDNS: No Change In My IP Address and/or 28 Days Has Not Past. Not Updating Dynamic DNS Entry.
Nov 30 00:14:01 php: : DynDns: Cached IP: 82.82.176.84
Nov 30 00:14:01 php: : DynDns: Current WAN IP: 82.82.176.84
Nov 30 00:14:01 php: : DynDns: _detectChange() starting.
Nov 30 00:14:01 php: : DynDns: updatedns() starting
Nov 30 00:14:01 php: : DynDns: Running updatedns()
Nov 30 00:13:02 php: : phpDynDNS: No Change In My IP Address and/or 28 Days Has Not Past. Not Updating Dynamic DNS Entry.
Nov 30 00:13:02 php: : DynDns: Cached IP: 82.82.176.84
Nov 30 00:13:02 php: : DynDns: Current WAN IP: 82.82.176.84
Nov 30 00:13:02 php: : DynDns: _detectChange() starting.
Nov 30 00:13:02 php: : DynDns: updatedns() starting
Nov 30 00:13:02 php: : DynDns: Running updatedns()
Nov 30 00:12:02 php: : phpDynDNS: No Change In My IP Address and/or 28 Days Has Not Past. Not Updating Dynamic DNS Entry.
Nov 30 00:12:02 php: : DynDns: Cached IP: 82.82.176.84
Nov 30 00:12:02 php: : DynDns: Current WAN IP: 82.82.176.84

more I can show to you, its not more possible if I change the entries in "Diagnostics: System logs: Settings" at any value I got no more than 60 entries - but I think it´s cosmetic ;)

Please remember - I´m not a software freak - I´m a technican - sorry !

Udo

sullrich · Nov 29, 2005, 11:46 PM

@MainFrame:

Thx - now PPOE and DNS working fine. A reboot and a change of "Enable Dial-On-Demand mode" is now working.

Only sometimes try DNS to refresh every minute - look this, it comes from alone, I don´t make any changes:

Nov 30 00:28:02 php: : phpDynDNS: No Change In My IP Address and/or 28 Days Has Not Past. Not Updating Dynamic DNS Entry.
Nov 30 00:28:02 php: : DynDns: Cached IP: 82.82.176.84
Nov 30 00:28:02 php: : DynDns: Current WAN IP: 82.82.176.84
Nov 30 00:28:02 php: : DynDns: _detectChange() starting.
Nov 30 00:28:02 php: : DynDns: updatedns() starting
Nov 30 00:28:02 php: : DynDns: Running updatedns()
Nov 30 00:27:02 php: : phpDynDNS: No Change In My IP Address and/or 28 Days Has Not Past. Not Updating Dynamic DNS Entry.
Nov 30 00:27:02 php: : DynDns: Cached IP: 82.82.176.84
Nov 30 00:27:02 php: : DynDns: Current WAN IP: 82.82.176.84
Nov 30 00:27:02 php: : DynDns: _detectChange() starting.
Nov 30 00:27:02 php: : DynDns: updatedns() starting
Nov 30 00:27:02 php: : DynDns: Running updatedns()
Nov 30 00:26:01 php: : phpDynDNS: No Change In My IP Address and/or 28 Days Has Not Past. Not Updating Dynamic DNS Entry.
Nov 30 00:26:01 php: : DynDns: Cached IP: 82.82.176.84
Nov 30 00:26:01 php: : DynDns: Current WAN IP: 82.82.176.84
Nov 30 00:26:01 php: : DynDns: _detectChange() starting.
Nov 30 00:26:01 php: : DynDns: updatedns() starting
Nov 30 00:26:01 php: : DynDns: Running updatedns()
Nov 30 00:25:01 php: : phpDynDNS: No Change In My IP Address and/or 28 Days Has Not Past. Not Updating Dynamic DNS Entry.
Nov 30 00:25:01 php: : DynDns: Cached IP: 82.82.176.84
Nov 30 00:25:01 php: : DynDns: Current WAN IP: 82.82.176.84
Nov 30 00:25:01 php: : DynDns: _detectChange() starting.
Nov 30 00:25:01 php: : DynDns: updatedns() starting
Nov 30 00:25:01 php: : DynDns: Running updatedns()
Nov 30 00:24:02 php: : phpDynDNS: No Change In My IP Address and/or 28 Days Has Not Past. Not Updating Dynamic DNS Entry.
Nov 30 00:24:02 php: : DynDns: Cached IP: 82.82.176.84
Nov 30 00:24:02 php: : DynDns: Current WAN IP: 82.82.176.84
Nov 30 00:24:02 php: : DynDns: _detectChange() starting.
Nov 30 00:24:02 php: : DynDns: updatedns() starting
Nov 30 00:24:02 php: : DynDns: Running updatedns()
Nov 30 00:23:02 php: : phpDynDNS: No Change In My IP Address and/or 28 Days Has Not Past. Not Updating Dynamic DNS Entry.
Nov 30 00:23:02 php: : DynDns: Cached IP: 82.82.176.84
Nov 30 00:23:02 php: : DynDns: Current WAN IP: 82.82.176.84
Nov 30 00:23:02 php: : DynDns: _detectChange() starting.
Nov 30 00:23:02 php: : DynDns: updatedns() starting
Nov 30 00:23:02 php: : DynDns: Running updatedns()
Nov 30 00:22:02 php: : phpDynDNS: No Change In My IP Address and/or 28 Days Has Not Past. Not Updating Dynamic DNS Entry.
Nov 30 00:22:02 php: : DynDns: Cached IP: 82.82.176.84
Nov 30 00:22:02 php: : DynDns: Current WAN IP: 82.82.176.84
Nov 30 00:22:02 php: : DynDns: _detectChange() starting.
Nov 30 00:22:02 php: : DynDns: updatedns() starting
Nov 30 00:22:02 php: : DynDns: Running updatedns()
Nov 30 00:21:01 php: : phpDynDNS: No Change In My IP Address and/or 28 Days Has Not Past. Not Updating Dynamic DNS Entry.
Nov 30 00:21:01 php: : DynDns: Cached IP: 82.82.176.84
Nov 30 00:21:01 php: : DynDns: Current WAN IP: 82.82.176.84
Nov 30 00:21:01 php: : DynDns: _detectChange() starting.
Nov 30 00:21:01 php: : DynDns: updatedns() starting
Nov 30 00:21:01 php: : DynDns: Running updatedns()
Nov 30 00:20:02 php: : phpDynDNS: No Change In My IP Address and/or 28 Days Has Not Past. Not Updating Dynamic DNS Entry.
Nov 30 00:20:02 php: : DynDns: Cached IP: 82.82.176.84
Nov 30 00:20:02 php: : DynDns: Current WAN IP: 82.82.176.84
Nov 30 00:20:02 php: : DynDns: _detectChange() starting.
Nov 30 00:20:02 php: : DynDns: updatedns() starting
Nov 30 00:20:02 php: : DynDns: Running updatedns()
Nov 30 00:19:02 php: : phpDynDNS: No Change In My IP Address and/or 28 Days Has Not Past. Not Updating Dynamic DNS Entry.
Nov 30 00:19:02 php: : DynDns: Cached IP: 82.82.176.84
Nov 30 00:19:02 php: : DynDns: Current WAN IP: 82.82.176.84
Nov 30 00:19:02 php: : DynDns: _detectChange() starting.
Nov 30 00:19:02 php: : DynDns: updatedns() starting
Nov 30 00:19:02 php: : DynDns: Running updatedns()
Nov 30 00:18:01 php: : phpDynDNS: No Change In My IP Address and/or 28 Days Has Not Past. Not Updating Dynamic DNS Entry.
Nov 30 00:18:01 php: : DynDns: Cached IP: 82.82.176.84
Nov 30 00:18:01 php: : DynDns: Current WAN IP: 82.82.176.84
Nov 30 00:18:01 php: : DynDns: _detectChange() starting.
Nov 30 00:18:01 php: : DynDns: updatedns() starting
Nov 30 00:18:01 php: : DynDns: Running updatedns()
Nov 30 00:17:02 php: : phpDynDNS: No Change In My IP Address and/or 28 Days Has Not Past. Not Updating Dynamic DNS Entry.
Nov 30 00:17:02 php: : DynDns: Cached IP: 82.82.176.84
Nov 30 00:17:02 php: : DynDns: Current WAN IP: 82.82.176.84
Nov 30 00:17:02 php: : DynDns: _detectChange() starting.
Nov 30 00:17:02 php: : DynDns: updatedns() starting
Nov 30 00:17:02 php: : DynDns: Running updatedns()
Nov 30 00:16:02 php: : phpDynDNS: No Change In My IP Address and/or 28 Days Has Not Past. Not Updating Dynamic DNS Entry.
Nov 30 00:16:02 php: : DynDns: Cached IP: 82.82.176.84
Nov 30 00:16:02 php: : DynDns: Current WAN IP: 82.82.176.84
Nov 30 00:16:02 php: : DynDns: _detectChange() starting.
Nov 30 00:16:02 php: : DynDns: updatedns() starting
Nov 30 00:16:02 php: : DynDns: Running updatedns()
Nov 30 00:15:01 php: : phpDynDNS: No Change In My IP Address and/or 28 Days Has Not Past. Not Updating Dynamic DNS Entry.
Nov 30 00:15:01 php: : DynDns: Cached IP: 82.82.176.84
Nov 30 00:15:01 php: : DynDns: Current WAN IP: 82.82.176.84
Nov 30 00:15:01 php: : DynDns: _detectChange() starting.
Nov 30 00:15:01 php: : DynDns: updatedns() starting
Nov 30 00:15:01 php: : DynDns: Running updatedns()
Nov 30 00:14:01 php: : phpDynDNS: No Change In My IP Address and/or 28 Days Has Not Past. Not Updating Dynamic DNS Entry.
Nov 30 00:14:01 php: : DynDns: Cached IP: 82.82.176.84
Nov 30 00:14:01 php: : DynDns: Current WAN IP: 82.82.176.84
Nov 30 00:14:01 php: : DynDns: _detectChange() starting.
Nov 30 00:14:01 php: : DynDns: updatedns() starting
Nov 30 00:14:01 php: : DynDns: Running updatedns()
Nov 30 00:13:02 php: : phpDynDNS: No Change In My IP Address and/or 28 Days Has Not Past. Not Updating Dynamic DNS Entry.
Nov 30 00:13:02 php: : DynDns: Cached IP: 82.82.176.84
Nov 30 00:13:02 php: : DynDns: Current WAN IP: 82.82.176.84
Nov 30 00:13:02 php: : DynDns: _detectChange() starting.
Nov 30 00:13:02 php: : DynDns: updatedns() starting
Nov 30 00:13:02 php: : DynDns: Running updatedns()
Nov 30 00:12:02 php: : phpDynDNS: No Change In My IP Address and/or 28 Days Has Not Past. Not Updating Dynamic DNS Entry.
Nov 30 00:12:02 php: : DynDns: Cached IP: 82.82.176.84
Nov 30 00:12:02 php: : DynDns: Current WAN IP: 82.82.176.84

more I can show to you, its not more possible if I change the entries in "Diagnostics: System logs: Settings" at any value I got no more than 60 entries - but I think it´s cosmetic ;)

Please remember - I´m not a software freak - I´m a technican - sorry !

Udo

Fixed today. Please update to 0.95a.

sullrich · Nov 29, 2005, 11:48 PM

Also make sure your check_reload_status file is up to date:

update_file.sh /usr/local/sbin/check_reload_status from a shell script

sullrich · Nov 30, 2005, 5:42 AM

Issues this command from the shell:

update_file.sh /etc/crontab && killall -HUP cron