Pfsense 2.0 not getting IP with thomson DCM475 cable modem



  • Ok I am not sure where to fit this topic, but here's the problem…

    I recently (yesterday) changed ISP and the modem they sent me is a Thomson DCM475 cable modem (docsis 3.0).

    I connected the new modem instead of the old modem I had (SMC SCD3GNRES) which used to work perfectly, but somehow pfsense no longer seems to "handshake" with this modem.

    I tried connecting my laptop directly to the modem, it works perfectly, I get an IP right away (xxx.xxx.xxx.xxx) from my ISP (aaa.aaa.aaa.aaa):

    Output of the slackware network client:

    bash-4.1# /etc/rc.d/rc.inet1 restart
    Polling for DHCP server on interface eth0:
    dhcpcd[11815]: version 5.2.11 starting
    dhcpcd[11815]: eth0: waiting for carrier
    dhcpcd[11815]: eth0: carrier acquired
    dhcpcd[11815]: eth0: broadcasting for a lease
    dhcpcd[11815]: eth0: offered xxx.xxx.xxx.xxx from aaa.aaa.aaa.aaa
    dhcpcd[11815]: eth0: acknowledged xxx.xxx.xxx.xxx from aaa.aaa.aaa.aaa
    dhcpcd[11815]: eth0: checking for xxx.xxx.xxx.xxx
    dhcpcd[11815]: eth0: leased xxx.xxx.xxx.xxx for 3600 seconds
    dhcpcd: eth0: MTU set to 576
    dhcpcd[11815]: forked to background, child pid 11858
    
    

    Trying with pfsense clicking on "renew" (under the status>interfaces) and I see:

    Status 	up
    DHCP 	up  
    MAC address 	90:fb:a6:3c:ae:19
    ISP DNS servers 	bbb.bbb.bbb.ccc
                                    bbb.bbb.bbb.ddd
    Media 	1000baseT <full-duplex>In/out packets 	129/78 (33 KB/10 KB)
    In/out packets (pass) 	78/128 (15 KB/10 KB)
    In/out packets (block) 	51/0 (18 KB/0 bytes)
    In/out errors 	0/0
    Collisions 	0</full-duplex> 
    

    But when I refresh the page, WITHOUT CHANGING ANYTHING, I either get this:

    Status 	up
    DHCP 	up  
    MAC address 	90:fb:a6:3c:ae:19
    IP address 	0.0.0.0  
    Subnet mask 	255.0.0.0
    ISP DNS servers 	bbb.bbb.bbb.ccc
    			        bbb.bbb.bbb.ddd
    Media 	1000baseT <full-duplex>In/out packets 	124/73 (32 KB/10 KB)
    In/out packets (pass) 	73/120 (14 KB/10 KB)
    In/out packets (block) 	51/0 (18 KB/0 bytes)
    In/out errors 	0/0
    Collisions 	0</full-duplex> 
    

    or this:

    Status 	no carrier
    DHCP 	up  
    MAC address 	90:fb:a6:3c:ae:19
    ISP DNS servers 	bbb.bbb.bbb.ccc
    			        bbb.bbb.bbb.ddd
    Media 	none
    In/out packets 	124/73 (32 KB/10 KB)
    In/out packets (pass) 	73/120 (14 KB/10 KB)
    In/out packets (block) 	51/0 (18 KB/0 bytes)
    In/out errors 	0/0
    Collisions 	0 
    

    The IP and subnet mask are gone, or the information constantly changes…

    The modem was tested by a tech, it works (brand new), my cable signal is apparently adequate (around 38dbmV).

    The configuration of WAN:

    Enable: checked
    Type: DHCP
    MAC Address: empty
    MTU: empty
    MSS: empty
    Hostname: empty
    Alias IP address: empty
    Block private networks: checked
    BLock bogon networks: checked

    The laptop I am successfully connecting to the internet runs slackware and I use rc.inet1 to connect (standard Slackware network script).

    The pfsense system logs have tons of info about the dhcp server:

    Nov 17 21:50:30 	php: : The command '/sbin/dhclient -c /var/etc/dhclient_wan.conf re0 > /tmp/re0_output > /tmp/re0_error_output' returned exit code '15', the output was ''
    Nov 17 21:50:30 	dhclient[4829]: exiting.
    Nov 17 21:50:30 	dhclient[4829]: exiting.
    Nov 17 21:50:30 	dhclient[4829]: connection closed
    Nov 17 21:50:30 	dhclient[4829]: connection closed
    Nov 17 21:50:30 	php: : DEVD Ethernet detached event for wan
    Nov 17 21:50:29 	dhclient[51347]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 21:50:28 	dhclient[51347]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 21:50:28 	dhclient: PREINIT
    Nov 17 21:50:28 	kernel: re0: link state changed to UP
    Nov 17 21:50:28 	check_reload_status: Linkup starting re0
    Nov 17 21:50:25 	kernel: re0: link state changed to DOWN
    Nov 17 21:50:25 	check_reload_status: Linkup starting re0
    Nov 17 21:50:24 	php: : HOTPLUG: Configuring interface wan
    Nov 17 21:50:24 	php: : DEVD Ethernet attached event for wan
    Nov 17 21:50:21 	php: : The command '/sbin/dhclient -c /var/etc/dhclient_wan.conf re0 > /tmp/re0_output > /tmp/re0_error_output' returned exit code '15', the output was ''
    Nov 17 21:50:21 	dhclient[33693]: exiting.
    Nov 17 21:50:21 	dhclient[33693]: exiting.
    Nov 17 21:50:21 	dhclient[33693]: connection closed
    Nov 17 21:50:21 	dhclient[33693]: connection closed
    Nov 17 21:50:21 	php: : DEVD Ethernet detached event for wan
    Nov 17 21:50:20 	dhclient[24754]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 21:50:19 	dhclient[24754]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 21:50:19 	dhclient: PREINIT
    Nov 17 21:50:19 	kernel: re0: link state changed to UP
    Nov 17 21:50:19 	check_reload_status: Linkup starting re0
    Nov 17 21:50:16 	kernel: re0: link state changed to DOWN
    Nov 17 21:50:16 	check_reload_status: Linkup starting re0
    Nov 17 21:50:16 	php: : HOTPLUG: Configuring interface wan
    Nov 17 21:50:16 	php: : DEVD Ethernet attached event for wan
    Nov 17 21:50:15 	php: : The command '/sbin/dhclient -c /var/etc/dhclient_wan.conf re0 > /tmp/re0_output > /tmp/re0_error_output' returned exit code '15', the output was ''
    Nov 17 21:50:15 	dhclient[24177]: exiting.
    Nov 17 21:50:15 	dhclient[24177]: exiting.
    Nov 17 21:50:15 	dhclient[24177]: connection closed
    Nov 17 21:50:15 	dhclient[24177]: connection closed
    Nov 17 21:50:13 	php: : The command '/sbin/dhclient -c /var/etc/dhclient_wan.conf re0 > /tmp/re0_output > /tmp/re0_error_output' returned exit code '15', the output was ''
    Nov 17 21:50:13 	dhclient[3681]: exiting.
    Nov 17 21:50:13 	dhclient[3681]: exiting.
    Nov 17 21:50:13 	dhclient[3681]: connection closed
    Nov 17 21:50:13 	dhclient[3681]: connection closed
    Nov 17 21:50:13 	php: : DEVD Ethernet detached event for wan
    Nov 17 21:50:13 	dhclient[61466]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 21:50:11 	dhclient[61466]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 21:50:11 	dhclient[61466]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 21:50:11 	dhclient: PREINIT
    Nov 17 21:50:10 	kernel: re0: link state changed to UP
    Nov 17 21:50:10 	check_reload_status: Linkup starting re0
    Nov 17 21:50:07 	kernel: re0: link state changed to DOWN
    Nov 17 21:50:07 	check_reload_status: Linkup starting re0
    Nov 17 21:50:07 	php: : HOTPLUG: Configuring interface wan
    Nov 17 21:50:07 	php: : DEVD Ethernet attached event for wan
    Nov 17 21:50:07 	php: : The command '/sbin/dhclient -c /var/etc/dhclient_wan.conf re0 > /tmp/re0_output > /tmp/re0_error_output' returned exit code '15', the output was ''
    Nov 17 21:50:07 	dhclient[61255]: exiting.
    Nov 17 21:50:07 	dhclient[61255]: exiting.
    Nov 17 21:50:07 	dhclient[61255]: connection closed
    Nov 17 21:50:07 	dhclient[61255]: connection closed
    Nov 17 21:50:04 	php: : The command '/sbin/dhclient -c /var/etc/dhclient_wan.conf re0 > /tmp/re0_output > /tmp/re0_error_output' returned exit code '15', the output was ''
    Nov 17 21:50:04 	dhclient[49014]: exiting.
    Nov 17 21:50:04 	dhclient[49014]: exiting.
    Nov 17 21:50:04 	dhclient[49014]: connection closed
    Nov 17 21:50:04 	dhclient[49014]: connection closed
    Nov 17 21:50:04 	php: : DEVD Ethernet detached event for wan
    Nov 17 21:50:03 	dhclient[45121]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 21:50:02 	dhclient[45121]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 21:50:02 	dhclient: PREINIT
    Nov 17 21:50:02 	kernel: re0: link state changed to UP
    Nov 17 21:50:02 	check_reload_status: Linkup starting re0
    Nov 17 21:50:02 	dhclient[23875]: DHCPDISCOVER on re0 to 255.255.255.255 port 67 interval 15
    Nov 17 21:49:59 	check_reload_status: Linkup starting re0
    Nov 17 21:49:59 	kernel: re0: link state changed to DOWN
    Nov 17 21:49:59 	php: : HOTPLUG: Configuring interface wan
    Nov 17 21:49:59 	php: : DEVD Ethernet attached event for wan
    Nov 17 21:49:56 	php: : The command '/sbin/dhclient -c /var/etc/dhclient_wan.conf re0 > /tmp/re0_output > /tmp/re0_error_output' returned exit code '15', the output was ''
    Nov 17 21:49:56 	dhclient[40837]: exiting.
    Nov 17 21:49:56 	dhclient[40837]: exiting.
    Nov 17 21:49:56 	dhclient[40837]: connection closed
    Nov 17 21:49:56 	dhclient[40837]: connection closed
    Nov 17 21:49:56 	php: : DEVD Ethernet detached event for wan
    Nov 17 21:49:56 	dhclient[40333]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 21:49:55 	dhclient[40333]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 21:49:54 	dhclient[40333]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 21:49:54 	dhclient: PREINIT
    Nov 17 21:49:54 	dhclient[23875]: DHCPDISCOVER on re0 to 255.255.255.255 port 67 interval 8
    Nov 17 21:49:53 	kernel: re0: link state changed to UP
    Nov 17 21:49:53 	check_reload_status: Linkup starting re0
    Nov 17 21:49:51 	kernel: re0: link state changed to DOWN
    Nov 17 21:49:51 	check_reload_status: Linkup starting re0
    Nov 17 21:49:50 	php: : HOTPLUG: Configuring interface wan
    Nov 17 21:49:50 	php: : DEVD Ethernet attached event for wan
    Nov 17 21:49:49 	dhclient[41425]: DHCPDISCOVER on re0 to 255.255.255.255 port 67 interval 21
    Nov 17 21:49:47 	php: : The command '/sbin/dhclient -c /var/etc/dhclient_wan.conf re0 > /tmp/re0_output > /tmp/re0_error_output' returned exit code '15', the output was ''
    Nov 17 21:49:47 	dhclient[34224]: exiting.
    Nov 17 21:49:47 	dhclient[34224]: exiting.
    Nov 17 21:49:47 	dhclient[34224]: connection closed
    Nov 17 21:49:47 	dhclient[34224]: connection closed
    Nov 17 21:49:47 	php: : DEVD Ethernet detached event for wan
    Nov 17 21:49:46 	dhclient[31279]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 21:49:45 	dhclient[31279]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 21:49:45 	dhclient: PREINIT
    Nov 17 21:49:45 	kernel: re0: link state changed to UP
    

    Anybody can help????  Thats extremely disappointing.  Maybe a wrong setting somewhere?
    Thanks



  • OK I just did a "quick" test:

    Connected the pfsense to the modem, went to the system logs, and I hit "refresh" on the browser, and the output in the log is endless, with the same things coming up over and over again.  Looks like pfsense is stuck trying to do the same thing over and over again, but fails.  I literally tried to refresh and see what happens for 5 minutes or so, was still not done.  Shouldn't be that long to get a valid IP and "handshake" with the modem/ISP…

    Nov 17 22:14:46 	kernel: re0: link state changed to DOWN
    Nov 17 22:14:46 	check_reload_status: Linkup starting re0
    Nov 17 22:14:46 	php: : HOTPLUG: Configuring interface wan
    Nov 17 22:14:46 	php: : DEVD Ethernet attached event for wan
    Nov 17 22:14:45 	dhclient[40772]: bound to xxx.xxx.xxx.xxx -- renewal in 302355 seconds.
    Nov 17 22:14:45 	dhclient[45675]: bound to xxx.xxx.xxx.xxx -- renewal in 302355 seconds.
    Nov 17 22:14:45 	check_reload_status: rc.newwanip starting re0
    Nov 17 22:14:45 	dhclient[37190]: bound to xxx.xxx.xxx.xxx -- renewal in 302355 seconds.
    Nov 17 22:14:45 	check_reload_status: rc.newwanip starting re0
    Nov 17 22:14:45 	dhclient: Creating resolv.conf
    Nov 17 22:14:45 	dhclient: Creating resolv.conf
    Nov 17 22:14:45 	dhclient: Creating resolv.conf
    Nov 17 22:14:45 	dhclient: /sbin/route add default aaa.aaa.aaa.aaa
    Nov 17 22:14:45 	dhclient: /sbin/route add default aaa.aaa.aaa.aaa
    Nov 17 22:14:45 	dhclient: /sbin/route add default aaa.aaa.aaa.aaa
    Nov 17 22:14:45 	dhclient: Adding new routes to interface: re0
    Nov 17 22:14:45 	dhclient: Adding new routes to interface: re0
    Nov 17 22:14:45 	dhclient: Adding new routes to interface: re0
    Nov 17 22:14:45 	dhclient: New Routers (re0): aaa.aaa.aaa.aaa
    Nov 17 22:14:45 	dhclient: New Routers (re0): aaa.aaa.aaa.aaa
    Nov 17 22:14:45 	dhclient: New Routers (re0): aaa.aaa.aaa.aaa
    Nov 17 22:14:45 	dhclient: New Broadcast Address (re0): 255.255.255.255
    Nov 17 22:14:45 	dhclient: New Broadcast Address (re0): 255.255.255.255
    Nov 17 22:14:45 	dhclient: New Subnet Mask (re0): 255.255.255.224
    Nov 17 22:14:45 	dhclient: New Subnet Mask (re0): 255.255.255.224
    Nov 17 22:14:45 	dhclient: New Broadcast Address (re0): 255.255.255.255
    Nov 17 22:14:45 	dhclient: New Subnet Mask (re0): 255.255.255.224
    Nov 17 22:14:45 	dhclient: New IP Address (re0): xxx.xxx.xxx.xxx
    Nov 17 22:14:45 	dhclient: New IP Address (re0): xxx.xxx.xxx.xxx
    Nov 17 22:14:45 	dhclient: New IP Address (re0): xxx.xxx.xxx.xxx
    Nov 17 22:14:45 	dhclient: ifconfig re0 inet xxx.xxx.xxx.xxx netmask 255.255.255.224 broadcast 255.255.255.255
    Nov 17 22:14:45 	dhclient: ifconfig re0 inet xxx.xxx.xxx.xxx netmask 255.255.255.224 broadcast 255.255.255.255
    Nov 17 22:14:45 	dhclient: Starting add_new_address()
    Nov 17 22:14:45 	dhclient: ifconfig re0 inet xxx.xxx.xxx.xxx netmask 255.255.255.224 broadcast 255.255.255.255
    Nov 17 22:14:45 	dhclient: Starting add_new_address()
    Nov 17 22:14:45 	dhclient: Starting add_new_address()
    Nov 17 22:14:45 	dhclient: REBOOT
    Nov 17 22:14:45 	dhclient: REBOOT
    Nov 17 22:14:45 	dhclient: REBOOT
    Nov 17 22:14:45 	dhclient[45675]: DHCPACK from bbb.bbb.bbb.bbb
    Nov 17 22:14:45 	dhclient[40772]: DHCPACK from bbb.bbb.bbb.bbb
    Nov 17 22:14:45 	dhclient[45675]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 22:14:45 	dhclient[37190]: DHCPACK from bbb.bbb.bbb.bbb
    Nov 17 22:14:45 	dhclient[45675]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 22:14:45 	dhclient: PREINIT
    Nov 17 22:14:44 	kernel: re0: link state changed to UP
    Nov 17 22:14:44 	check_reload_status: Linkup starting re0
    Nov 17 22:14:44 	dhclient[40772]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 22:14:44 	apinger: ALARM: GW_WAN(aaa.aaa.aaa.aaa) *** down ***
    Nov 17 22:14:43 	dhclient[37190]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 22:14:42 	dhclient[40772]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 22:14:41 	check_reload_status: Linkup starting re0
    Nov 17 22:14:41 	kernel: re0: link state changed to DOWN
    Nov 17 22:14:41 	dhclient[37190]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 22:14:41 	dhclient[37190]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 22:14:41 	dhclient: PREINIT
    Nov 17 22:14:41 	dhclient[40772]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 22:14:41 	dhclient[40772]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 22:14:41 	dhclient: PREINIT
    Nov 17 22:14:40 	check_reload_status: Linkup starting re0
    Nov 17 22:14:40 	kernel: re0: link state changed to UP
    Nov 17 22:14:39 	php: : DEVD Ethernet detached event for wan
    Nov 17 22:14:37 	check_reload_status: Configuring interface wan
    Nov 17 22:14:37 	php: : rc.newwanip: Failed to update wan IP, restarting...
    Nov 17 22:14:37 	php: : rc.newwanip: on (IP address: ) (interface: wan) (real interface: re0).
    Nov 17 22:14:37 	php: : rc.newwanip: Informational is starting re0.
    Nov 17 22:14:36 	php: : HOTPLUG: Configuring interface wan
    Nov 17 22:14:36 	php: : DEVD Ethernet attached event for wan
    Nov 17 22:14:34 	kernel: re0: link state changed to DOWN
    Nov 17 22:14:34 	check_reload_status: Linkup starting re0
    Nov 17 22:14:33 	dhclient[29496]: exiting.
    Nov 17 22:14:33 	dhclient[29496]: exiting.
    Nov 17 22:14:33 	dhclient[29496]: connection closed
    Nov 17 22:14:33 	dhclient[29496]: connection closed
    Nov 17 22:14:33 	php: : DEVD Ethernet detached event for wan
    Nov 17 22:14:31 	dhclient[27403]: bound to xxx.xxx.xxx.xxx -- renewal in 302362 seconds.
    Nov 17 22:14:31 	check_reload_status: rc.newwanip starting re0
    Nov 17 22:14:31 	dhclient: Creating resolv.conf
    Nov 17 22:14:31 	dhclient: /sbin/route add default aaa.aaa.aaa.aaa
    Nov 17 22:14:31 	dhclient: Adding new routes to interface: re0
    Nov 17 22:14:31 	dhclient: New Routers (re0): aaa.aaa.aaa.aaa
    Nov 17 22:14:31 	dhclient: New Broadcast Address (re0): 255.255.255.255
    Nov 17 22:14:31 	dhclient: New Subnet Mask (re0): 255.255.255.224
    Nov 17 22:14:31 	dhclient: New IP Address (re0): xxx.xxx.xxx.xxx
    Nov 17 22:14:31 	dhclient: ifconfig re0 inet xxx.xxx.xxx.xxx netmask 255.255.255.224 broadcast 255.255.255.255
    Nov 17 22:14:31 	dhclient: Starting add_new_address()
    Nov 17 22:14:31 	dhclient: REBOOT
    Nov 17 22:14:31 	dhclient[27403]: DHCPACK from bbb.bbb.bbb.bbb
    Nov 17 22:14:31 	dhclient[27403]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 22:14:31 	dhclient: PREINIT
    Nov 17 22:14:31 	kernel: re0: link state changed to UP
    Nov 17 22:14:31 	check_reload_status: Linkup starting re0
    Nov 17 22:14:28 	check_reload_status: Configuring interface wan
    Nov 17 22:14:28 	php: : rc.newwanip: Failed to update wan IP, restarting...
    Nov 17 22:14:28 	php: : rc.newwanip: on (IP address: ) (interface: wan) (real interface: re0).
    Nov 17 22:14:28 	php: : rc.newwanip: Informational is starting re0.
    Nov 17 22:14:28 	kernel: re0: link state changed to DOWN
    Nov 17 22:14:28 	check_reload_status: Linkup starting re0
    Nov 17 22:14:28 	php: : HOTPLUG: Configuring interface wan
    Nov 17 22:14:28 	php: : DEVD Ethernet attached event for wan
    Nov 17 22:14:28 	check_reload_status: Configuring interface wan
    Nov 17 22:14:28 	php: : rc.newwanip: Failed to update wan IP, restarting...
    Nov 17 22:14:28 	php: : rc.newwanip: on (IP address: ) (interface: wan) (real interface: re0).
    Nov 17 22:14:28 	php: : rc.newwanip: Informational is starting re0.
    Nov 17 22:14:28 	kernel: re0: link state changed to DOWN
    Nov 17 22:14:28 	check_reload_status: Linkup starting re0
    Nov 17 22:14:28 	php: : HOTPLUG: Configuring interface wan
    Nov 17 22:14:28 	php: : DEVD Ethernet attached event for wan
    Nov 17 22:14:25 	dhclient[6847]: exiting.
    Nov 17 22:14:25 	dhclient[6847]: exiting.
    Nov 17 22:14:25 	dhclient[6847]: connection closed
    Nov 17 22:14:25 	dhclient[6847]: connection closed
    Nov 17 22:14:25 	php: : DEVD Ethernet detached event for wan
    Nov 17 22:14:24 	php: : Adding TFTP nat rules
    Nov 17 22:14:23 	dhclient[6522]: bound to xxx.xxx.xxx.xxx -- renewal in 302366 seconds.
    Nov 17 22:14:23 	check_reload_status: rc.newwanip starting re0
    Nov 17 22:14:23 	dhclient: Creating resolv.conf
    Nov 17 22:14:23 	dhclient: /sbin/route add default aaa.aaa.aaa.aaa
    Nov 17 22:14:23 	dhclient: Adding new routes to interface: re0
    Nov 17 22:14:23 	dhclient: New Routers (re0): aaa.aaa.aaa.aaa
    Nov 17 22:14:23 	dhclient: New Broadcast Address (re0): 255.255.255.255
    Nov 17 22:14:23 	dhclient: New Subnet Mask (re0): 255.255.255.224
    Nov 17 22:14:23 	dhclient: New IP Address (re0): xxx.xxx.xxx.xxx
    Nov 17 22:14:23 	dhclient: ifconfig re0 inet xxx.xxx.xxx.xxx netmask 255.255.255.224 broadcast 255.255.255.255
    Nov 17 22:14:23 	dhclient: Starting add_new_address()
    Nov 17 22:14:23 	dhclient: REBOOT
    Nov 17 22:14:23 	dhclient[6522]: DHCPACK from bbb.bbb.bbb.bbb
    Nov 17 22:14:23 	dhclient[6522]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 22:14:23 	dhclient: PREINIT
    Nov 17 22:14:22 	kernel: re0: link state changed to UP
    Nov 17 22:14:22 	check_reload_status: Linkup starting re0
    Nov 17 22:14:19 	kernel: re0: link state changed to DOWN
    Nov 17 22:14:19 	check_reload_status: Linkup starting re0
    Nov 17 22:14:19 	php: : HOTPLUG: Configuring interface wan
    Nov 17 22:14:19 	php: : DEVD Ethernet attached event for wan
    Nov 17 22:14:18 	php: : Adding TFTP nat rules
    Nov 17 22:14:18 	apinger: bind socket: Can't assign requested address
    Nov 17 22:14:18 	apinger: Starting Alarm Pinger, apinger(57777)
    Nov 17 22:14:18 	check_reload_status: Reloading filter
    Nov 17 22:14:17 	dhclient[5605]: exiting.
    Nov 17 22:14:17 	dhclient[5605]: exiting.
    Nov 17 22:14:17 	dhclient[10846]: exiting.
    Nov 17 22:14:17 	dhclient[10846]: exiting.
    Nov 17 22:14:17 	dhclient[10846]: connection closed
    Nov 17 22:14:17 	dhclient[10846]: connection closed
    Nov 17 22:14:17 	dhclient[5605]: connection closed
    Nov 17 22:14:17 	dhclient[5605]: connection closed
    Nov 17 22:14:17 	dhclient: FAIL
    Nov 17 22:14:17 	dhclient: FAIL
    Nov 17 22:14:17 	dhclient[16419]: My address (xxx.xxx.xxx.xxx) was deleted, dhclient exiting
    Nov 17 22:14:17 	dhclient[16419]: My address (xxx.xxx.xxx.xxx) was deleted, dhclient exiting
    Nov 17 22:14:17 	dhclient[10372]: My address (xxx.xxx.xxx.xxx) was deleted, dhclient exiting
    Nov 17 22:14:17 	dhclient[10372]: My address (xxx.xxx.xxx.xxx) was deleted, dhclient exiting
    Nov 17 22:14:17 	apinger: Exiting on signal 15.
    Nov 17 22:14:17 	php: : ROUTING: setting default route to aaa.aaa.aaa.aaa
    Nov 17 22:14:17 	php: : rc.newwanip: on (IP address: xxx.xxx.xxx.xxx) (interface: wan) (real interface: re0).
    Nov 17 22:14:17 	php: : rc.newwanip: Informational is starting re0.
    Nov 17 22:14:16 	dhclient[29526]: exiting.
    Nov 17 22:14:16 	dhclient[29526]: exiting.
    Nov 17 22:14:16 	dhclient[29526]: connection closed
    Nov 17 22:14:16 	dhclient[29526]: connection closed
    Nov 17 22:14:16 	php: : DEVD Ethernet detached event for wan
    Nov 17 22:14:14 	dhclient[26849]: bound to xxx.xxx.xxx.xxx -- renewal in 302371 seconds.
    Nov 17 22:14:14 	dhclient: Creating resolv.conf
    Nov 17 22:14:14 	dhclient: /sbin/route add default aaa.aaa.aaa.aaa
    Nov 17 22:14:14 	dhclient: Adding new routes to interface: re0
    Nov 17 22:14:14 	dhclient: New Routers (re0): aaa.aaa.aaa.aaa
    Nov 17 22:14:14 	dhclient: New Broadcast Address (re0): 255.255.255.255
    Nov 17 22:14:14 	dhclient: New Subnet Mask (re0): 255.255.255.224
    Nov 17 22:14:14 	dhclient: New IP Address (re0): xxx.xxx.xxx.xxx
    Nov 17 22:14:14 	dhclient: ifconfig re0 inet xxx.xxx.xxx.xxx netmask 255.255.255.224 broadcast 255.255.255.255
    Nov 17 22:14:14 	dhclient: Starting add_new_address()
    Nov 17 22:14:14 	dhclient: REBOOT
    Nov 17 22:14:14 	dhclient[26849]: DHCPACK from bbb.bbb.bbb.bbb
    Nov 17 22:14:14 	dhclient[26849]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 22:14:14 	dhclient: PREINIT
    Nov 17 22:14:14 	kernel: re0: link state changed to UP
    Nov 17 22:14:14 	check_reload_status: Linkup starting re0
    Nov 17 22:14:12 	apinger: Starting Alarm Pinger, apinger(29108)
    Nov 17 22:14:12 	check_reload_status: Reloading filter
    Nov 17 22:14:11 	apinger: Exiting on signal 15.
    Nov 17 22:14:11 	php: : ROUTING: setting default route to aaa.aaa.aaa.aaa
    Nov 17 22:14:11 	dnsmasq[40956]: using nameserver ggg.ggg.ggg.ggg#53
    Nov 17 22:14:11 	dnsmasq[40956]: using nameserver hhh.hhh.hhh.hhh#53
    Nov 17 22:14:11 	dnsmasq[40956]: reading /etc/resolv.conf
    Nov 17 22:14:11 	php: : rc.newwanip: on (IP address: xxx.xxx.xxx.xxx) (interface: wan) (real interface: re0).
    Nov 17 22:14:11 	php: : rc.newwanip: Informational is starting re0.
    Nov 17 22:14:11 	kernel: re0: link state changed to DOWN
    Nov 17 22:14:11 	check_reload_status: Linkup starting re0
    Nov 17 22:14:11 	php: : HOTPLUG: Configuring interface wan
    Nov 17 22:14:11 	php: : DEVD Ethernet attached event for wan
    Nov 17 22:14:09 	php: : Adding TFTP nat rules
    Nov 17 22:14:06 	dhclient[63781]: bound to xxx.xxx.xxx.xxx -- renewal in 302374 seconds.
    Nov 17 22:14:06 	check_reload_status: rc.newwanip starting re0
    Nov 17 22:14:06 	dnsmasq[40956]: using nameserver ggg.ggg.ggg.ggg#53
    Nov 17 22:14:06 	dnsmasq[40956]: using nameserver hhh.hhh.hhh.hhh#53
    Nov 17 22:14:06 	dnsmasq[40956]: reading /etc/resolv.conf
    Nov 17 22:14:06 	dhclient: Creating resolv.conf
    Nov 17 22:14:06 	dhclient: /sbin/route add default aaa.aaa.aaa.aaa
    Nov 17 22:14:06 	dhclient: Adding new routes to interface: re0
    Nov 17 22:14:06 	dhclient: New Routers (re0): aaa.aaa.aaa.aaa
    Nov 17 22:14:06 	dhclient: New Broadcast Address (re0): 255.255.255.255
    Nov 17 22:14:06 	dhclient: New Subnet Mask (re0): 255.255.255.224
    Nov 17 22:14:06 	dhclient: New IP Address (re0): xxx.xxx.xxx.xxx
    Nov 17 22:14:06 	dhclient: ifconfig re0 inet xxx.xxx.xxx.xxx netmask 255.255.255.224 broadcast 255.255.255.255
    Nov 17 22:14:06 	dhclient: Starting add_new_address()
    Nov 17 22:14:06 	dhclient: REBOOT
    Nov 17 22:14:06 	dhclient[63781]: DHCPACK from bbb.bbb.bbb.bbb
    Nov 17 22:14:06 	dhclient[63781]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 22:14:06 	dhclient: PREINIT
    Nov 17 22:14:06 	dhclient[60480]: bound to xxx.xxx.xxx.xxx -- renewal in 302375 seconds.
    Nov 17 22:14:06 	check_reload_status: rc.newwanip starting re0
    Nov 17 22:14:06 	dhclient: Creating resolv.conf
    Nov 17 22:14:06 	dhclient: /sbin/route add default aaa.aaa.aaa.aaa
    Nov 17 22:14:06 	dhclient: Adding new routes to interface: re0
    Nov 17 22:14:06 	dhclient: New Routers (re0): aaa.aaa.aaa.aaa
    Nov 17 22:14:06 	dhclient: New Broadcast Address (re0): 255.255.255.255
    Nov 17 22:14:06 	dhclient: New Subnet Mask (re0): 255.255.255.224
    Nov 17 22:14:06 	dhclient: New IP Address (re0): xxx.xxx.xxx.xxx
    Nov 17 22:14:06 	dhclient: ifconfig re0 inet xxx.xxx.xxx.xxx netmask 255.255.255.224 broadcast 255.255.255.255
    Nov 17 22:14:06 	dhclient: Starting add_new_address()
    Nov 17 22:14:06 	dhclient: REBOOT
    Nov 17 22:14:06 	dhclient[60480]: DHCPACK from bbb.bbb.bbb.bbb
    Nov 17 22:14:06 	dhclient[60480]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 22:14:06 	dhclient: PREINIT
    Nov 17 22:14:05 	check_reload_status: Linkup starting re0
    Nov 17 22:14:05 	kernel: re0: link state changed to UP
    Nov 17 22:14:05 	dhclient[28483]: exiting.
    Nov 17 22:14:05 	dhclient[28483]: exiting.
    Nov 17 22:14:05 	dhclient[27841]: exiting.
    Nov 17 22:14:05 	dhclient[27841]: exiting.
    Nov 17 22:14:05 	dhclient[27841]: connection closed
    Nov 17 22:14:05 	dhclient[27841]: connection closed
    Nov 17 22:14:05 	dhclient[28483]: connection closed
    Nov 17 22:14:05 	dhclient[28483]: connection closed
    Nov 17 22:14:05 	dhclient: FAIL
    Nov 17 22:14:05 	dhclient: FAIL
    Nov 17 22:14:05 	dhclient[44483]: My address (xxx.xxx.xxx.xxx) was deleted, dhclient exiting
    Nov 17 22:14:05 	dhclient[44483]: My address (xxx.xxx.xxx.xxx) was deleted, dhclient exiting
    Nov 17 22:14:05 	dhclient[43861]: My address (xxx.xxx.xxx.xxx) was deleted, dhclient exiting
    Nov 17 22:14:05 	dhclient[43861]: My address (xxx.xxx.xxx.xxx) was deleted, dhclient exiting
    Nov 17 22:14:04 	dhclient[50320]: exiting.
    Nov 17 22:14:04 	dhclient[50320]: exiting.
    Nov 17 22:14:04 	dhclient[50320]: connection closed
    Nov 17 22:14:04 	dhclient[50320]: connection closed
    Nov 17 22:14:04 	php: : DEVD Ethernet detached event for wan
    Nov 17 22:14:04 	apinger: Starting Alarm Pinger, apinger(442)
    Nov 17 22:14:04 	check_reload_status: Reloading filter
    Nov 17 22:14:02 	php: : ROUTING: setting default route to aaa.aaa.aaa.aaa
    Nov 17 22:14:02 	php: : rc.newwanip: on (IP address: xxx.xxx.xxx.xxx) (interface: wan) (real interface: re0).
    Nov 17 22:14:02 	php: : rc.newwanip: Informational is starting re0.
    Nov 17 22:14:02 	kernel: re0: link state changed to DOWN
    Nov 17 22:14:02 	php: : HOTPLUG: Configuring interface wan
    Nov 17 22:14:02 	php: : DEVD Ethernet attached event for wan
    Nov 17 22:13:58 	dhclient[48075]: bound to xxx.xxx.xxx.xxx -- renewal in 302379 seconds.
    Nov 17 22:13:58 	dhclient: Creating resolv.conf
    Nov 17 22:13:58 	dhclient: /sbin/route add default aaa.aaa.aaa.aaa
    Nov 17 22:13:58 	dhclient: Adding new routes to interface: re0
    Nov 17 22:13:58 	dhclient: New Routers (re0): aaa.aaa.aaa.aaa
    Nov 17 22:13:58 	dhclient: New Broadcast Address (re0): 255.255.255.255
    Nov 17 22:13:58 	dhclient: New Subnet Mask (re0): 255.255.255.224
    Nov 17 22:13:58 	dhclient: New IP Address (re0): xxx.xxx.xxx.xxx
    Nov 17 22:13:58 	dhclient: ifconfig re0 inet xxx.xxx.xxx.xxx netmask 255.255.255.224 broadcast 255.255.255.255
    Nov 17 22:13:58 	dhclient: Starting add_new_address()
    Nov 17 22:13:58 	dhclient: REBOOT
    Nov 17 22:13:58 	dhclient[48075]: DHCPACK from bbb.bbb.bbb.bbb
    Nov 17 22:13:58 	dhclient[48075]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 22:13:58 	dhclient: PREINIT
    Nov 17 22:13:57 	check_reload_status: Configuring interface wan
    Nov 17 22:13:57 	php: : rc.newwanip: Failed to update wan IP, restarting...
    Nov 17 22:13:57 	php: : rc.newwanip: on (IP address: ) (interface: wan) (real interface: re0).
    Nov 17 22:13:57 	php: : rc.newwanip: Informational is starting re0.
    Nov 17 22:13:57 	kernel: re0: link state changed to UP
    Nov 17 22:13:54 	dhclient[28156]: exiting.
    Nov 17 22:13:54 	dhclient[28156]: exiting.
    Nov 17 22:13:54 	dhclient[28156]: connection closed
    Nov 17 22:13:54 	dhclient[28156]: connection closed
    Nov 17 22:13:54 	php: : DEVD Ethernet detached event for wan
    Nov 17 22:13:54 	check_reload_status: Linkup starting re0
    Nov 17 22:13:54 	kernel: re0: link state changed to DOWN
    Nov 17 22:13:54 	php: : HOTPLUG: Configuring interface wan
    Nov 17 22:13:54 	php: : DEVD Ethernet attached event for wan
    Nov 17 22:13:52 	dhclient[25058]: bound to xxx.xxx.xxx.xxx -- renewal in 302382 seconds.
    Nov 17 22:13:52 	dhclient[26269]: bound to xxx.xxx.xxx.xxx -- renewal in 302382 seconds.
    Nov 17 22:13:52 	check_reload_status: rc.newwanip starting re0
    Nov 17 22:13:52 	dhclient[23068]: bound to xxx.xxx.xxx.xxx -- renewal in 302382 seconds.
    Nov 17 22:13:52 	check_reload_status: rc.newwanip starting re0
    Nov 17 22:13:52 	dhclient: Creating resolv.conf
    Nov 17 22:13:52 	dhclient: Creating resolv.conf
    Nov 17 22:13:52 	dhclient: /sbin/route add default aaa.aaa.aaa.aaa
    Nov 17 22:13:52 	dhclient: /sbin/route add default aaa.aaa.aaa.aaa
    Nov 17 22:13:52 	dhclient: Creating resolv.conf
    Nov 17 22:13:52 	dhclient: /sbin/route add default aaa.aaa.aaa.aaa
    Nov 17 22:13:52 	dhclient: Adding new routes to interface: re0
    Nov 17 22:13:52 	dhclient: Adding new routes to interface: re0
    Nov 17 22:13:52 	dhclient: New Routers (re0): aaa.aaa.aaa.aaa
    Nov 17 22:13:52 	dhclient: Adding new routes to interface: re0
    Nov 17 22:13:52 	dhclient: New Routers (re0): aaa.aaa.aaa.aaa
    Nov 17 22:13:52 	dhclient: New Broadcast Address (re0): 255.255.255.255
    Nov 17 22:13:52 	dhclient: New Broadcast Address (re0): 255.255.255.255
    Nov 17 22:13:52 	dhclient: New Routers (re0): aaa.aaa.aaa.aaa
    Nov 17 22:13:52 	dhclient[58273]: exiting.
    Nov 17 22:13:52 	dhclient[58273]: exiting.
    Nov 17 22:13:52 	dhclient[58273]: connection closed
    Nov 17 22:13:52 	dhclient[58273]: connection closed
    Nov 17 22:13:52 	dhclient: FAIL
    Nov 17 22:13:52 	dhclient: New Subnet Mask (re0): 255.255.255.224
    Nov 17 22:13:52 	dhclient: New Subnet Mask (re0): 255.255.255.224
    Nov 17 22:13:52 	dhclient: New Broadcast Address (re0): 255.255.255.255
    Nov 17 22:13:52 	dhclient: New IP Address (re0): xxx.xxx.xxx.xxx
    Nov 17 22:13:52 	dhclient: New IP Address (re0): xxx.xxx.xxx.xxx
    Nov 17 22:13:52 	dhclient: New Subnet Mask (re0): 255.255.255.224
    Nov 17 22:13:52 	dhclient[395]: My address (xxx.xxx.xxx.xxx) was deleted, dhclient exiting
    Nov 17 22:13:52 	dhclient[395]: My address (xxx.xxx.xxx.xxx) was deleted, dhclient exiting
    Nov 17 22:13:52 	dhclient: New IP Address (re0): xxx.xxx.xxx.xxx
    Nov 17 22:13:52 	dhclient: ifconfig re0 inet xxx.xxx.xxx.xxx netmask 255.255.255.224 broadcast 255.255.255.255
    Nov 17 22:13:52 	dhclient: ifconfig re0 inet xxx.xxx.xxx.xxx netmask 255.255.255.224 broadcast 255.255.255.255
    Nov 17 22:13:52 	dhclient[395]: My address (xxx.xxx.xxx.xxx) was re-added
    Nov 17 22:13:52 	dhclient[395]: My address (xxx.xxx.xxx.xxx) was re-added
    Nov 17 22:13:52 	dhclient: Starting add_new_address()
    Nov 17 22:13:52 	dhclient: Starting add_new_address()
    Nov 17 22:13:52 	dhclient: ifconfig re0 inet xxx.xxx.xxx.xxx netmask 255.255.255.224 broadcast 255.255.255.255
    Nov 17 22:13:52 	dhclient: REBOOT
    Nov 17 22:13:52 	dhclient: REBOOT
    Nov 17 22:13:52 	dhclient: Starting add_new_address()
    Nov 17 22:13:52 	dhclient: REBOOT
    Nov 17 22:13:52 	dhclient[26269]: DHCPACK from bbb.bbb.bbb.bbb
    Nov 17 22:13:52 	dhclient[25058]: DHCPACK from bbb.bbb.bbb.bbb
    Nov 17 22:13:52 	dhclient[23068]: DHCPACK from bbb.bbb.bbb.bbb
    Nov 17 22:13:52 	dhclient[26269]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 22:13:52 	dhclient[26269]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 22:13:52 	dhclient[25058]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 22:13:52 	dhclient[25058]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 22:13:52 	dhclient[23068]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 22:13:52 	dhclient[23068]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 22:13:52 	dhclient: PREINIT
    Nov 17 22:13:52 	dhclient: PREINIT
    Nov 17 22:13:52 	dhclient: PREINIT
    Nov 17 22:13:52 	kernel: re0: link state changed to UP
    Nov 17 22:13:52 	check_reload_status: Linkup starting re0
    Nov 17 22:13:49 	dhclient[6729]: exiting.
    Nov 17 22:13:49 	dhclient[6729]: exiting.
    Nov 17 22:13:49 	dhclient[6729]: connection closed
    Nov 17 22:13:49 	dhclient[6729]: connection closed
    Nov 17 22:13:49 	php: : DEVD Ethernet detached event for wan
    Nov 17 22:13:49 	kernel: re0: link state changed to DOWN
    Nov 17 22:13:49 	check_reload_status: Linkup starting re0
    Nov 17 22:13:48 	kernel: re0: link state changed to UP
    Nov 17 22:13:48 	check_reload_status: Linkup starting re0
    Nov 17 22:13:46 	php: : HOTPLUG: Configuring interface wan
    Nov 17 22:13:46 	php: : DEVD Ethernet attached event for wan
    Nov 17 22:13:44 	kernel: re0: link state changed to DOWN
    Nov 17 22:13:44 	check_reload_status: Linkup starting re0
    Nov 17 22:13:43 	check_reload_status: Configuring interface wan
    Nov 17 22:13:43 	php: : rc.newwanip: Failed to update wan IP, restarting...
    Nov 17 22:13:43 	php: : rc.newwanip: on (IP address: ) (interface: wan) (real interface: re0).
    Nov 17 22:13:43 	php: : rc.newwanip: Informational is starting re0.
    Nov 17 22:13:41 	dhclient[7264]: exiting.
    Nov 17 22:13:41 	dhclient[7264]: exiting.
    Nov 17 22:13:41 	dhclient[7264]: short write: wanted 20 got 0 bytes
    Nov 17 22:13:41 	dhclient[7264]: short write: wanted 20 got 0 bytes
    Nov 17 22:13:41 	dhclient[2712]: bound to xxx.xxx.xxx.xxx -- renewal in 302387 seconds.
    Nov 17 22:13:41 	dhclient: Creating resolv.conf
    Nov 17 22:13:41 	dhclient: Creating resolv.conf
    Nov 17 22:13:41 	dhclient: /sbin/route add default aaa.aaa.aaa.aaa
    Nov 17 22:13:41 	dhclient: /sbin/route add default aaa.aaa.aaa.aaa
    Nov 17 22:13:41 	php: : The command '/sbin/dhclient -c /var/etc/dhclient_wan.conf re0 > /tmp/re0_output > /tmp/re0_error_output' returned exit code '15', the output was ''
    Nov 17 22:13:41 	dhclient: Adding new routes to interface: re0
    Nov 17 22:13:41 	dhclient: Adding new routes to interface: re0
    Nov 17 22:13:41 	dhclient: New Routers (re0): aaa.aaa.aaa.aaa
    Nov 17 22:13:41 	dhclient: New Broadcast Address (re0): 255.255.255.255
    Nov 17 22:13:41 	dhclient: New Routers (re0): aaa.aaa.aaa.aaa
    Nov 17 22:13:41 	dhclient: New Subnet Mask (re0): 255.255.255.224
    Nov 17 22:13:41 	dhclient: New Broadcast Address (re0): 255.255.255.255
    Nov 17 22:13:41 	dhclient: New IP Address (re0): xxx.xxx.xxx.xxx
    Nov 17 22:13:41 	dhclient: New Subnet Mask (re0): 255.255.255.224
    Nov 17 22:13:41 	php: : DEVD Ethernet detached event for wan
    Nov 17 22:13:41 	dhclient: New IP Address (re0): xxx.xxx.xxx.xxx
    Nov 17 22:13:41 	dhclient: ifconfig re0 inet xxx.xxx.xxx.xxx netmask 255.255.255.224 broadcast 255.255.255.255
    Nov 17 22:13:41 	dhclient: Starting add_new_address()
    Nov 17 22:13:41 	dhclient: ifconfig re0 inet xxx.xxx.xxx.xxx netmask 255.255.255.224 broadcast 255.255.255.255
    Nov 17 22:13:41 	dhclient: Starting add_new_address()
    Nov 17 22:13:41 	dhclient: REBOOT
    Nov 17 22:13:41 	dhclient: REBOOT
    Nov 17 22:13:41 	dhclient[4967]: DHCPACK from bbb.bbb.bbb.bbb
    Nov 17 22:13:41 	dhclient[2712]: DHCPACK from bbb.bbb.bbb.bbb
    Nov 17 22:13:41 	dhclient[4967]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 22:13:41 	dhclient[4967]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 22:13:41 	dhclient[2712]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 22:13:41 	dhclient: PREINIT
    Nov 17 22:13:41 	dhclient: PREINIT
    Nov 17 22:13:40 	kernel: re0: link state changed to UP
    Nov 17 22:13:40 	check_reload_status: Linkup starting re0
    Nov 17 22:13:38 	check_reload_status: Configuring interface wan
    Nov 17 22:13:38 	php: : rc.newwanip: Failed to update wan IP, restarting...
    Nov 17 22:13:38 	php: : rc.newwanip: on (IP address: ) (interface: wan) (real interface: re0).
    Nov 17 22:13:38 	php: : rc.newwanip: Informational is starting re0.
    Nov 17 22:13:37 	php: : HOTPLUG: Configuring interface wan
    Nov 17 22:13:37 	php: : DEVD Ethernet attached event for wan
    Nov 17 22:13:35 	kernel: re0: link state changed to DOWN
    Nov 17 22:13:35 	check_reload_status: Linkup starting re0
    Nov 17 22:13:33 	dhclient[48393]: bound to xxx.xxx.xxx.xxx -- renewal in 302391 seconds.
    Nov 17 22:13:33 	check_reload_status: rc.newwanip starting re0
    Nov 17 22:13:33 	dhclient: Creating resolv.conf
    Nov 17 22:13:33 	dhclient: /sbin/route add default aaa.aaa.aaa.aaa
    Nov 17 22:13:33 	dhclient: Adding new routes to interface: re0
    Nov 17 22:13:33 	dhclient: New Routers (re0): aaa.aaa.aaa.aaa
    Nov 17 22:13:33 	dhclient: New Broadcast Address (re0): 255.255.255.255
    Nov 17 22:13:33 	dhclient: New Subnet Mask (re0): 255.255.255.224
    Nov 17 22:13:33 	dhclient: New IP Address (re0): xxx.xxx.xxx.xxx
    Nov 17 22:13:33 	dhclient: ifconfig re0 inet xxx.xxx.xxx.xxx netmask 255.255.255.224 broadcast 255.255.255.255
    Nov 17 22:13:33 	dhclient: Starting add_new_address()
    Nov 17 22:13:33 	dhclient: REBOOT
    Nov 17 22:13:33 	dhclient[48393]: DHCPACK from bbb.bbb.bbb.bbb
    Nov 17 22:13:33 	dhclient[48393]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 22:13:33 	dhclient: PREINIT
    Nov 17 22:13:33 	dhclient[51852]: exiting.
    Nov 17 22:13:33 	dhclient[51852]: exiting.
    Nov 17 22:13:33 	dhclient[51852]: short write: wanted 20 got 0 bytes
    Nov 17 22:13:33 	dhclient[51852]: short write: wanted 20 got 0 bytes
    Nov 17 22:13:33 	check_reload_status: rc.newwanip starting re0
    Nov 17 22:13:33 	php: : The command '/sbin/dhclient -c /var/etc/dhclient_wan.conf re0 > /tmp/re0_output > /tmp/re0_error_output' returned exit code '15', the output was ''
    Nov 17 22:13:33 	dhclient: Creating resolv.conf
    Nov 17 22:13:33 	dhclient: /sbin/route add default aaa.aaa.aaa.aaa
    Nov 17 22:13:33 	php: : DEVD Ethernet detached event for wan
    Nov 17 22:13:33 	dhclient: Adding new routes to interface: re0
    Nov 17 22:13:33 	dhclient: New Routers (re0): aaa.aaa.aaa.aaa
    Nov 17 22:13:33 	dhclient: New Broadcast Address (re0): 255.255.255.255
    Nov 17 22:13:33 	dhclient: New Subnet Mask (re0): 255.255.255.224
    Nov 17 22:13:33 	dhclient: New IP Address (re0): xxx.xxx.xxx.xxx
    Nov 17 22:13:32 	dhclient: ifconfig re0 inet xxx.xxx.xxx.xxx netmask 255.255.255.224 broadcast 255.255.255.255
    Nov 17 22:13:32 	dhclient: Starting add_new_address()
    Nov 17 22:13:32 	dhclient: REBOOT
    Nov 17 22:13:32 	dhclient[45596]: DHCPACK from bbb.bbb.bbb.bbb
    Nov 17 22:13:32 	dhclient[45596]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 22:13:32 	dhclient: PREINIT
    Nov 17 22:13:32 	check_reload_status: Linkup starting re0
    Nov 17 22:13:32 	kernel: re0: link state changed to UP
    Nov 17 22:13:30 	check_reload_status: Configuring interface wan
    Nov 17 22:13:30 	php: : rc.newwanip: Failed to update wan IP, restarting...
    Nov 17 22:13:30 	php: : rc.newwanip: on (IP address: ) (interface: wan) (real interface: re0).
    Nov 17 22:13:30 	php: : rc.newwanip: Informational is starting re0.
    Nov 17 22:13:29 	php: : HOTPLUG: Configuring interface wan
    Nov 17 22:13:29 	php: : DEVD Ethernet attached event for wan
    Nov 17 22:13:27 	kernel: re0: link state changed to DOWN
    Nov 17 22:13:27 	check_reload_status: Linkup starting re0
    Nov 17 22:13:27 	dhclient[37447]: exiting.
    Nov 17 22:13:27 	dhclient[37447]: exiting.
    Nov 17 22:13:27 	dhclient[37447]: connection closed
    Nov 17 22:13:27 	dhclient[37447]: connection closed
    Nov 17 22:13:27 	php: : DEVD Ethernet detached event for wan
    Nov 17 22:13:25 	dhclient[35019]: bound to xxx.xxx.xxx.xxx -- renewal in 302395 seconds.
    Nov 17 22:13:25 	check_reload_status: rc.newwanip starting re0
    Nov 17 22:13:25 	dhclient: Creating resolv.conf
    Nov 17 22:13:25 	dhclient: /sbin/route add default aaa.aaa.aaa.aaa
    Nov 17 22:13:25 	dhclient: Adding new routes to interface: re0
    Nov 17 22:13:25 	dhclient: New Routers (re0): aaa.aaa.aaa.aaa
    Nov 17 22:13:25 	dhclient: New Broadcast Address (re0): 255.255.255.255
    Nov 17 22:13:25 	dhclient: New Subnet Mask (re0): 255.255.255.224
    Nov 17 22:13:25 	dhclient: New IP Address (re0): xxx.xxx.xxx.xxx
    Nov 17 22:13:25 	dhclient: ifconfig re0 inet xxx.xxx.xxx.xxx netmask 255.255.255.224 broadcast 255.255.255.255
    Nov 17 22:13:25 	dhclient: Starting add_new_address()
    Nov 17 22:13:25 	dhclient: REBOOT
    Nov 17 22:13:25 	dhclient[35019]: DHCPACK from bbb.bbb.bbb.bbb
    Nov 17 22:13:24 	dhclient[35019]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 22:13:24 	dhclient: PREINIT
    Nov 17 22:13:24 	kernel: re0: link state changed to UP
    Nov 17 22:13:24 	check_reload_status: Linkup starting re0
    Nov 17 22:13:22 	check_reload_status: Configuring interface wan
    Nov 17 22:13:22 	php: : rc.newwanip: Failed to update wan IP, restarting...
    Nov 17 22:13:22 	php: : rc.newwanip: on (IP address: ) (interface: wan) (real interface: re0).
    Nov 17 22:13:22 	php: : rc.newwanip: Informational is starting re0.
    Nov 17 22:13:21 	kernel: re0: link state changed to DOWN
    Nov 17 22:13:21 	check_reload_status: Linkup starting re0
    Nov 17 22:13:21 	php: : HOTPLUG: Configuring interface wan
    Nov 17 22:13:21 	php: : DEVD Ethernet attached event for wan
    Nov 17 22:13:18 	dhclient[7760]: exiting.
    Nov 17 22:13:18 	dhclient[7760]: exiting.
    Nov 17 22:13:18 	dhclient[7760]: connection closed
    Nov 17 22:13:18 	dhclient[7760]: connection closed
    Nov 17 22:13:18 	php: : DEVD Ethernet detached event for wan
    Nov 17 22:13:16 	dhclient[7456]: bound to xxx.xxx.xxx.xxx -- renewal in 86400 seconds.
    Nov 17 22:13:16 	check_reload_status: rc.newwanip starting re0
    Nov 17 22:13:16 	dhclient: Creating resolv.conf
    Nov 17 22:13:16 	dhclient: /sbin/route add default aaa.aaa.aaa.aaa
    Nov 17 22:13:16 	dhclient: Adding new routes to interface: re0
    Nov 17 22:13:16 	dhclient: New Routers (re0): aaa.aaa.aaa.aaa
    Nov 17 22:13:16 	dhclient: New Broadcast Address (re0): 255.255.255.255
    Nov 17 22:13:16 	dhclient: New Subnet Mask (re0): 255.255.255.224
    Nov 17 22:13:16 	dhclient: New IP Address (re0): xxx.xxx.xxx.xxx
    Nov 17 22:13:16 	dhclient: ifconfig re0 inet xxx.xxx.xxx.xxx netmask 255.255.255.224 broadcast 255.255.255.255
    Nov 17 22:13:16 	dhclient: Starting add_new_address()
    Nov 17 22:13:16 	dhclient: REBOOT
    Nov 17 22:13:16 	dhclient[7456]: DHCPACK from bbb.bbb.bbb.bbb
    Nov 17 22:13:16 	dhclient[7456]: DHCPREQUEST on re0 to 255.255.255.255 port 67
    Nov 17 22:13:16 	dhclient: PREINIT
    Nov 17 22:13:16 	kernel: re0: link state changed to UP
    Nov 17 22:13:16 	check_reload_status: Linkup starting re0
    Nov 17 22:13:13 	kernel: re0: link state changed to DOWN
    Nov 17 22:13:13 	check_reload_status: Linkup starting re0
    Nov 17 22:13:13 	php: : HOTPLUG: Configuring interface wan
    Nov 17 22:13:13 	php: : DEVD Ethernet attached event for wan
    Nov 17 22:13:07 	check_reload_status: Linkup starting re0
    Nov 17 22:13:07 	kernel: re0: link state changed to UP
    

    Now I fear my ISP bans my pfsense box for screwing up with their network…  I'd be pissed... :(



  • I may have to scratch my head for some time….. It now works...  Not sure why but the only thing I did was to reverse the WAN/LAN interfaces back & forth, and reboot...

    Anybody can clarify this for me?  I just want to make sure this wont happen again.

    Thanks!



  • Did you reboot your cable modem and pfsense box together?

    Next time-

    Start the modem and let it sync…

    Start the pfSense box.

    Cable modems tend to lock to the first mac address that connects to them.  Sometimes you get two trys...


  • Netgate Administrator

    There seems to be known bug in which an interface can get stuck in loop cycling up and down. It happens if you have forced one of the interface settings rather than using auto. E.g. the link speed or the MAC address.
    Could this have been your problem?

    Steve

    Edit: See http://redmine.pfsense.org/issues/1572


Log in to reply