Netgate Discussion Forum
    • Categories
    • Recent
    • Tags
    • Popular
    • Users
    • Search
    • Register
    • Login

    Losing WAN IP on APU [SOLVED]

    Scheduled Pinned Locked Moved Problems Installing or Upgrading pfSense Software
    5 Posts 3 Posters 2.8k Views
    Loading More Posts
    • Oldest to Newest
    • Newest to Oldest
    • Most Votes
    Reply
    • Reply as topic
    Log in to reply
    This topic has been deleted. Only users with topic management privileges can see it.
    • X
      xtropx
      last edited by

      I'm running pfSense-2.1.2-RELEASE-4g-amd64-nanobsd.img on an apu1c with a generic 8GB compact flash card.
      I keep periodically losing my WAN IP.
      This didn't seem to happen on a microSD 4GB card with pfSense-2.1.2-RELEASE-2g-amd64-nanobsd.img.
      It seems to grab a modem DHCP address, and I have to log in and physically do a ifconfig re0 down, ifconfig re0 up for it to regain the public IP address from my ISP.

      Syslogs:

      
      04-27-2014	17:12:52	User.Error	172.16.1.1	Apr 27 17:12:50 php: rc.start_packages: Restarting/Starting all packages.
      04-27-2014	17:12:51	System2.Warning	172.16.1.1	Apr 27 17:12:50 ntpd[10286]: restrict ::: KOD does nothing without LIMITED.
      04-27-2014	17:12:51	System2.Warning	172.16.1.1	Apr 27 17:12:50 ntpd[10286]: restrict default: KOD does nothing without LIMITED.
      04-27-2014	17:12:51	System2.Info	172.16.1.1	Apr 27 17:12:50 ntpd[10286]: Listening on routing socket on fd #30 for interface updates
      04-27-2014	17:12:51	System2.Error	172.16.1.1	Apr 27 17:12:50 ntpd[10286]: setsockopt IPV6_MULTICAST_IF 0 for fe80::1%4 fails: Can't assign requested address
      04-27-2014	17:12:51	System2.Info	172.16.1.1	Apr 27 17:12:50 ntpd[10286]: Listen normally on 9 lo0 [fe80::1%4]:123
      04-27-2014	17:12:51	System2.Info	172.16.1.1	Apr 27 17:12:50 ntpd[10286]: Listen normally on 8 lo0 [::1]:123
      04-27-2014	17:12:51	System2.Info	172.16.1.1	Apr 27 17:12:50 ntpd[10286]: Listen normally on 7 lo0 127.0.0.1:123
      04-27-2014	17:12:51	System2.Error	172.16.1.1	Apr 27 17:12:50 ntpd[10286]: setsockopt IPV6_MULTICAST_IF 0 for fe80::20d:b9ff:fe33:8336%3 fails: Can't assign requested address
      04-27-2014	17:12:51	System2.Info	172.16.1.1	Apr 27 17:12:50 ntpd[10286]: Listen normally on 6 re2 [fe80::20d:b9ff:fe33:8336%3]:123
      04-27-2014	17:12:51	System2.Error	172.16.1.1	Apr 27 17:12:50 ntpd[10286]: setsockopt IPV6_MULTICAST_IF 0 for fe80::20d:b9ff:fe33:8335%2 fails: Can't assign requested address
      04-27-2014	17:12:51	System2.Info	172.16.1.1	Apr 27 17:12:50 ntpd[10286]: Listen normally on 5 re1 [fe80::20d:b9ff:fe33:8335%2]:123
      04-27-2014	17:12:51	System2.Info	172.16.1.1	Apr 27 17:12:50 ntpd[10286]: Listen normally on 4 re1 172.16.1.1:123
      04-27-2014	17:12:51	System2.Error	172.16.1.1	Apr 27 17:12:50 ntpd[10286]: setsockopt IPV6_MULTICAST_IF 0 for fe80::20d:b9ff:fe33:8334%1 fails: Can't assign requested address
      04-27-2014	17:12:51	System2.Info	172.16.1.1	Apr 27 17:12:50 ntpd[10286]: Listen normally on 3 re0 [fe80::20d:b9ff:fe33:8334%1]:123
      04-27-2014	17:12:51	System2.Info	172.16.1.1	Apr 27 17:12:50 ntpd[10286]: Listen normally on 2 re0 68.112.154.60:123
      04-27-2014	17:12:51	System2.Info	172.16.1.1	Apr 27 17:12:50 ntpd[10286]: Listen and drop on 1 v4wildcard 0.0.0.0:123
      04-27-2014	17:12:51	System2.Info	172.16.1.1	Apr 27 17:12:50 ntpd[10286]: Listen and drop on 0 v6wildcard [::]:123
      04-27-2014	17:12:51	System2.Info	172.16.1.1	Apr 27 17:12:50 ntpd[10286]: proto: precision = 1.956 usec (-19)
      04-27-2014	17:12:51	System2.Info	172.16.1.1	Apr 27 17:12:50 ntpd[10005]: Command line: /usr/local/sbin/ntpd -g -c /var/etc/ntpd.conf -p /var/run/ntpd.pid
      04-27-2014	17:12:51	System2.Notice	172.16.1.1	Apr 27 17:12:50 ntpd[10005]: ntpd 4.2.7p411@1.2483-o Fri Mar 28 00:11:42 UTC 2014 (1): Starting
      04-27-2014	17:12:51	User.Notice	172.16.1.1	Apr 27 17:12:50 ntp: Starting NTP Daemon.
      04-27-2014	17:12:51	User.Notice	172.16.1.1	Apr 27 17:12:50 ntp: Successfully synced time after 1 attempts.
      04-27-2014	17:12:51	System2.Notice	172.16.1.1	Apr 27 17:12:50 ntpdate[9127]: adjust time server 216.66.0.142 offset -0.008839 sec
      04-27-2014	17:12:49	System2.Notice	172.16.1.1	Apr 27 17:12:48 ntpd[68857]: ntpd exiting on signal 15 (Terminated: 15)
      04-27-2014	17:12:49	User.Notice	172.16.1.1	Apr 27 17:12:48 check_reload_status: Reloading filter
      04-27-2014	17:12:49	User.Notice	172.16.1.1	Apr 27 17:12:48 check_reload_status: Starting packages
      04-27-2014	17:12:49	User.Error	172.16.1.1	Apr 27 17:12:48 php: rc.newwanip: pfSense package system has detected an ip change 192.168.100.10 ->  68.112.154.60 ... Restarting packages.
      04-27-2014	17:12:47	User.Error	172.16.1.1	Apr 27 17:12:45 php: rc.newwanip: Creating rrd update script
      04-27-2014	17:12:47	User.Error	172.16.1.1	Apr 27 17:12:45 php: rc.newwanip: Resyncing OpenVPN instances for interface WAN.
      04-27-2014	17:12:44	Daemon.Warning	172.16.1.1	Apr 27 17:12:42 dnsmasq[35963]: ignoring nameserver 127.0.0.1 - local interface
      04-27-2014	17:12:44	Daemon.Info	172.16.1.1	Apr 27 17:12:42 dnsmasq[35963]: using nameserver 208.67.220.220#53
      04-27-2014	17:12:44	Daemon.Info	172.16.1.1	Apr 27 17:12:42 dnsmasq[35963]: using nameserver 208.67.222.222#53
      04-27-2014	17:12:44	Daemon.Info	172.16.1.1	Apr 27 17:12:42 dnsmasq[35963]: reading /etc/resolv.conf
      04-27-2014	17:12:41	User.Error	172.16.1.1	Apr 27 17:12:39 apinger: Starting Alarm Pinger, apinger(13788)
      04-27-2014	17:12:40	User.Error	172.16.1.1	Apr 27 17:12:38 php: rc.newwanip: Removing static route for monitor 208.67.220.220 and adding a new route through 68.112.152.1
      04-27-2014	17:12:40	User.Error	172.16.1.1	Apr 27 17:12:38 php: rc.newwanip: ROUTING: setting default route to 68.112.152.1
      04-27-2014	17:12:40	User.Error	172.16.1.1	Apr 27 17:12:38 php: rc.newwanip: rc.newwanip: on (IP address: 68.112.154.60) (interface: wan) (real interface: re0).
      04-27-2014	17:12:40	User.Error	172.16.1.1	Apr 27 17:12:38 php: rc.newwanip: rc.newwanip: Informational is starting re0.
      04-27-2014	17:12:39	System2.Debug	172.16.1.1	Apr 27 17:12:37 ntpd[68857]: new interface(s) found: waking up resolver
      04-27-2014	17:12:39	System2.Info	172.16.1.1	Apr 27 17:12:37 ntpd[68857]: Listen normally on 10 re0 68.112.154.60:123
      04-27-2014	17:12:38	Daemon.Info	172.16.1.1	Apr 27 17:12:36 dhclient[33143]: bound to 68.112.154.60 -- renewal in 14400 seconds.
      04-27-2014	17:12:38	User.Notice	172.16.1.1	Apr 27 17:12:36 check_reload_status: rc.newwanip starting re0
      04-27-2014	17:12:38	User.Notice	172.16.1.1	Apr 27 17:12:36 dhclient: Creating resolv.conf
      04-27-2014	17:12:38	User.Notice	172.16.1.1	Apr 27 17:12:36 dhclient: /sbin/route add default 68.112.152.1
      04-27-2014	17:12:38	User.Notice	172.16.1.1	Apr 27 17:12:36 dhclient: Adding new routes to interface: re0
      04-27-2014	17:12:38	User.Notice	172.16.1.1	Apr 27 17:12:36 dhclient: New Routers (re0): 68.112.152.1
      04-27-2014	17:12:38	User.Notice	172.16.1.1	Apr 27 17:12:36 dhclient: New Broadcast Address (re0): 255.255.255.255
      04-27-2014	17:12:38	User.Notice	172.16.1.1	Apr 27 17:12:36 dhclient: New Subnet Mask (re0): 255.255.252.0
      04-27-2014	17:12:38	User.Notice	172.16.1.1	Apr 27 17:12:36 dhclient: New IP Address (re0): 68.112.154.60
      04-27-2014	17:12:38	User.Notice	172.16.1.1	Apr 27 17:12:36 dhclient: ifconfig re0 inet 68.112.154.60 netmask 255.255.252.0 broadcast 255.255.255.255 
      04-27-2014	17:12:38	User.Notice	172.16.1.1	Apr 27 17:12:36 dhclient: Starting add_new_address()
      04-27-2014	17:12:38	User.Notice	172.16.1.1	Apr 27 17:12:36 dhclient: Deleting old routes
      04-27-2014	17:12:38	User.Notice	172.16.1.1	Apr 27 17:12:36 dhclient: Starting delete_old_states()
      04-27-2014	17:12:38	User.Notice	172.16.1.1	Apr 27 17:12:36 dhclient: BOUND
      04-27-2014	17:12:38	Daemon.Info	172.16.1.1	Apr 27 17:12:36 dhclient[33143]: DHCPACK from 10.148.48.1
      04-27-2014	17:12:37	Daemon.Info	172.16.1.1	Apr 27 17:12:36 dhclient[33143]: DHCPREQUEST on re0 to 255.255.255.255 port 67
      04-27-2014	17:12:37	User.Notice	172.16.1.1	Apr 27 17:12:36 dhclient: ARPCHECK
      04-27-2014	17:12:37	System2.Info	172.16.1.1	Apr 27 17:12:35 ntpd[68857]: Deleting interface #2 re0, 192.168.100.10#123, interface stats: received=0, sent=0, dropped=0, active_time=32 secs
      04-27-2014	17:12:35	User.Notice	172.16.1.1	Apr 27 17:12:34 dhclient: ARPSEND
      04-27-2014	17:12:35	Daemon.Info	172.16.1.1	Apr 27 17:12:34 dhclient[33143]: DHCPOFFER from 10.148.48.1
      04-27-2014	17:12:35	Daemon.Info	172.16.1.1	Apr 27 17:12:34 dhclient[33143]: DHCPDISCOVER on re0 to 255.255.255.255 port 67 interval 1
      04-27-2014	17:12:35	User.Notice	172.16.1.1	Apr 27 17:12:34 dhclient: Starting delete_old_states()
      04-27-2014	17:12:35	User.Notice	172.16.1.1	Apr 27 17:12:34 dhclient: PREINIT
      04-27-2014	17:12:35	User.Notice	172.16.1.1	Apr 27 17:12:34 dhclient: Deleting old routes
      04-27-2014	17:12:35	User.Notice	172.16.1.1	Apr 27 17:12:34 dhclient: Comparing IPs: Old:  New: 
      04-27-2014	17:12:35	User.Notice	172.16.1.1	Apr 27 17:12:34 dhclient: Starting delete_old_states()
      04-27-2014	17:12:35	User.Notice	172.16.1.1	Apr 27 17:12:34 dhclient: EXPIRE
      04-27-2014	17:12:24	Daemon.Info	172.16.1.1	Apr 27 17:12:22 dhclient[33143]: DHCPREQUEST on re0 to 192.168.100.1 port 67
      04-27-2014	17:12:18	Daemon.Info	172.16.1.1	Apr 27 17:12:16 dhclient[33143]: DHCPREQUEST on re0 to 192.168.100.1 port 67
      04-27-2014	17:12:15	Daemon.Info	172.16.1.1	Apr 27 17:12:13 dhclient[33143]: DHCPREQUEST on re0 to 192.168.100.1 port 67
      04-27-2014	17:12:12	Daemon.Info	172.16.1.1	Apr 27 17:12:10 dhclient[33143]: DHCPREQUEST on re0 to 192.168.100.1 port 67
      04-27-2014	17:12:10	Daemon.Info	172.16.1.1	Apr 27 17:12:08 dhclient[33143]: DHCPREQUEST on re0 to 192.168.100.1 port 67
      04-27-2014	17:12:08	Daemon.Info	172.16.1.1	Apr 27 17:12:06 dhclient[33143]: DHCPREQUEST on re0 to 192.168.100.1 port 67
      04-27-2014	17:12:06	Daemon.Info	172.16.1.1	Apr 27 17:12:04 dhclient[33143]: DHCPREQUEST on re0 to 192.168.100.1 port 67
      04-27-2014	17:12:05	System2.Warning	172.16.1.1	Apr 27 17:12:03 ntpd[68857]: restrict ::: KOD does nothing without LIMITED.
      04-27-2014	17:12:05	System2.Warning	172.16.1.1	Apr 27 17:12:03 ntpd[68857]: restrict default: KOD does nothing without LIMITED.
      04-27-2014	17:12:05	System2.Info	172.16.1.1	Apr 27 17:12:03 ntpd[68857]: Listening on routing socket on fd #30 for interface updates
      04-27-2014	17:12:05	System2.Error	172.16.1.1	Apr 27 17:12:03 ntpd[68857]: setsockopt IPV6_MULTICAST_IF 0 for fe80::1%4 fails: Can't assign requested address
      04-27-2014	17:12:05	System2.Info	172.16.1.1	Apr 27 17:12:03 ntpd[68857]: Listen normally on 9 lo0 [fe80::1%4]:123
      04-27-2014	17:12:05	System2.Info	172.16.1.1	Apr 27 17:12:03 ntpd[68857]: Listen normally on 8 lo0 [::1]:123
      04-27-2014	17:12:05	System2.Info	172.16.1.1	Apr 27 17:12:03 ntpd[68857]: Listen normally on 7 lo0 127.0.0.1:123
      04-27-2014	17:12:05	System2.Error	172.16.1.1	Apr 27 17:12:03 ntpd[68857]: setsockopt IPV6_MULTICAST_IF 0 for fe80::20d:b9ff:fe33:8336%3 fails: Can't assign requested address
      04-27-2014	17:12:05	System2.Info	172.16.1.1	Apr 27 17:12:03 ntpd[68857]: Listen normally on 6 re2 [fe80::20d:b9ff:fe33:8336%3]:123
      04-27-2014	17:12:05	System2.Error	172.16.1.1	Apr 27 17:12:03 ntpd[68857]: setsockopt IPV6_MULTICAST_IF 0 for fe80::20d:b9ff:fe33:8335%2 fails: Can't assign requested address
      04-27-2014	17:12:05	System2.Info	172.16.1.1	Apr 27 17:12:03 ntpd[68857]: Listen normally on 5 re1 [fe80::20d:b9ff:fe33:8335%2]:123
      04-27-2014	17:12:05	System2.Info	172.16.1.1	Apr 27 17:12:03 ntpd[68857]: Listen normally on 4 re1 172.16.1.1:123
      04-27-2014	17:12:05	System2.Error	172.16.1.1	Apr 27 17:12:03 ntpd[68857]: setsockopt IPV6_MULTICAST_IF 0 for fe80::20d:b9ff:fe33:8334%1 fails: Can't assign requested address
      04-27-2014	17:12:05	System2.Info	172.16.1.1	Apr 27 17:12:03 ntpd[68857]: Listen normally on 3 re0 [fe80::20d:b9ff:fe33:8334%1]:123
      04-27-2014	17:12:05	System2.Info	172.16.1.1	Apr 27 17:12:03 ntpd[68857]: Listen normally on 2 re0 192.168.100.10:123
      04-27-2014	17:12:05	System2.Info	172.16.1.1	Apr 27 17:12:03 ntpd[68857]: Listen and drop on 1 v4wildcard 0.0.0.0:123
      04-27-2014	17:12:05	System2.Info	172.16.1.1	Apr 27 17:12:03 ntpd[68857]: Listen and drop on 0 v6wildcard [::]:123
      04-27-2014	17:12:05	System2.Info	172.16.1.1	Apr 27 17:12:03 ntpd[68857]: proto: precision = 1.955 usec (-19)
      04-27-2014	17:12:05	System2.Info	172.16.1.1	Apr 27 17:12:03 ntpd[68654]: Command line: /usr/local/sbin/ntpd -g -c /var/etc/ntpd.conf -p /var/run/ntpd.pid
      04-27-2014	17:12:05	System2.Notice	172.16.1.1	Apr 27 17:12:03 ntpd[68654]: ntpd 4.2.7p411@1.2483-o Fri Mar 28 00:11:42 UTC 2014 (1): Starting
      04-27-2014	17:12:05	User.Notice	172.16.1.1	Apr 27 17:12:03 ntp: Starting NTP Daemon.
      04-27-2014	17:12:05	User.Notice	172.16.1.1	Apr 27 17:12:03 ntp: Giving up on time sync after 3 attempts.
      04-27-2014	17:12:05	Daemon.Info	172.16.1.1	Apr 27 17:12:03 dhclient[33143]: DHCPREQUEST on re0 to 192.168.100.1 port 67
      04-27-2014	17:12:00	System2.Error	172.16.1.1	Apr 27 17:11:58 ntpdate[67664]: no servers can be used, exiting
      04-27-2014	17:12:00	System2.Error	172.16.1.1	Apr 27 17:11:58 ntpdate[67664]: can't find host 0.pfsense.pool.ntp.org
      04-27-2014	17:11:54	System2.Error	172.16.1.1	Apr 27 17:11:52 ntpdate[67035]: no servers can be used, exiting
      04-27-2014	17:11:54	System2.Error	172.16.1.1	Apr 27 17:11:52 ntpdate[67035]: can't find host 0.pfsense.pool.ntp.org
      04-27-2014	17:11:49	User.Error	172.16.1.1	Apr 27 17:11:47 php: rc.start_packages: Restarting/Starting all packages.
      04-27-2014	17:11:48	System2.Error	172.16.1.1	Apr 27 17:11:46 ntpdate[61693]: no servers can be used, exiting
      04-27-2014	17:11:48	System2.Error	172.16.1.1	Apr 27 17:11:46 ntpdate[61693]: can't find host 0.pfsense.pool.ntp.org
      04-27-2014	17:11:46	System2.Notice	172.16.1.1	Apr 27 17:11:45 ntpd[75612]: ntpd exiting on signal 15 (Terminated: 15)
      04-27-2014	17:11:46	User.Notice	172.16.1.1	Apr 27 17:11:45 check_reload_status: Reloading filter
      04-27-2014	17:11:46	User.Notice	172.16.1.1	Apr 27 17:11:45 check_reload_status: Starting packages
      04-27-2014	17:11:46	User.Error	172.16.1.1	Apr 27 17:11:45 php: rc.newwanip: pfSense package system has detected an ip change 68.112.154.60 ->  192.168.100.10 ... Restarting packages.
      04-27-2014	17:11:44	User.Error	172.16.1.1	Apr 27 17:11:43 php: rc.newwanip: Creating rrd update script
      04-27-2014	17:11:44	User.Error	172.16.1.1	Apr 27 17:11:43 php: rc.newwanip: Resyncing OpenVPN instances for interface WAN.
      04-27-2014	17:11:40	User.Notice	172.16.1.1	Apr 27 17:11:38 check_reload_status: updating dyndns wan
      04-27-2014	17:11:40	Daemon.Info	172.16.1.1	Apr 27 17:11:38 radvd[63690]: resuming normal operation
      04-27-2014	17:11:40	Daemon.Warning	172.16.1.1	Apr 27 17:11:38 radvd[63690]: no auto-selected prefix on interface re1, disabling advertisements
      04-27-2014	17:11:40	Daemon.Info	172.16.1.1	Apr 27 17:11:38 radvd[63690]: attempting to reread config file
      04-27-2014	17:11:39	Local7.Info	172.16.1.1	Apr 27 17:11:37 dhcpd: Sending on   Socket/fallback/fallback-net
      04-27-2014	17:11:38	User.Error	172.16.1.1	Apr 27 17:11:37 apinger: No usable targets found, exiting
      04-27-2014	17:11:38	User.Error	172.16.1.1	Apr 27 17:11:37 apinger: Starting Alarm Pinger, apinger(40741)
      04-27-2014	17:11:38	Local7.Info	172.16.1.1	Apr 27 17:11:36 dhcpd: Disabling input on BPF/re1/00:0d:b9:33:83:35/172.16.1.0/27
      04-27-2014	17:11:38	Local7.Info	172.16.1.1	Apr 27 17:11:36 dhcpd: Disabling output on BPF/re1/00:0d:b9:33:83:35/172.16.1.0/27
      04-27-2014	17:11:38	Local7.Info	172.16.1.1	Apr 27 17:11:36 dhcpd: Received signal 15, initiating shutdown.
      04-27-2014	17:11:38	Daemon.Info	172.16.1.1	Apr 27 17:11:36 dnsmasq[35963]: read /etc/hosts - 2 addresses
      04-27-2014	17:11:38	Daemon.Warning	172.16.1.1	Apr 27 17:11:36 dnsmasq[35963]: ignoring nameserver 127.0.0.1 - local interface
      04-27-2014	17:11:38	Daemon.Info	172.16.1.1	Apr 27 17:11:36 dnsmasq[35963]: using nameserver 208.67.220.220#53
      04-27-2014	17:11:38	Daemon.Info	172.16.1.1	Apr 27 17:11:36 dnsmasq[35963]: using nameserver 208.67.222.222#53
      04-27-2014	17:11:38	Daemon.Info	172.16.1.1	Apr 27 17:11:36 dnsmasq[35963]: reading /etc/resolv.conf
      04-27-2014	17:11:38	Daemon.Info	172.16.1.1	Apr 27 17:11:36 dnsmasq[35963]: compile time options: IPv6 GNU-getopt no-DBus i18n IDN DHCP DHCPv6 no-Lua TFTP no-conntrack no-ipset auth
      04-27-2014	17:11:38	Daemon.Info	172.16.1.1	Apr 27 17:11:36 dnsmasq[35963]: started, version 2.68 cachesize 10000
      04-27-2014	17:11:37	User.Error	172.16.1.1	Apr 27 17:11:35 php: rc.newwanip: rc.newwanip: on (IP address: 192.168.100.10) (interface: wan) (real interface: re0).
      04-27-2014	17:11:37	User.Error	172.16.1.1	Apr 27 17:11:35 php: rc.newwanip: rc.newwanip: Informational is starting re0.
      04-27-2014	17:11:37	Daemon.Info	172.16.1.1	Apr 27 17:11:35 dnsmasq[22971]: exiting on receipt of SIGTERM
      04-27-2014	17:11:36	System2.Debug	172.16.1.1	Apr 27 17:11:34 ntpd[75612]: new interface(s) found: waking up resolver
      04-27-2014	17:11:36	System2.Info	172.16.1.1	Apr 27 17:11:34 ntpd[75612]: Listen normally on 10 re0 192.168.100.10:123
      04-27-2014	17:11:35	User.Error	172.16.1.1	Apr 27 17:11:33 php: rc.linkup: Accept router advertisements on interface re0 
      04-27-2014	17:11:35	Daemon.Info	172.16.1.1	Apr 27 17:11:33 dhclient[20215]: bound to 192.168.100.10 -- renewal in 30 seconds.
      04-27-2014	17:11:35	User.Notice	172.16.1.1	Apr 27 17:11:33 check_reload_status: rc.newwanip starting re0
      04-27-2014	17:11:35	User.Notice	172.16.1.1	Apr 27 17:11:33 dhclient: Creating resolv.conf
      04-27-2014	17:11:35	User.Notice	172.16.1.1	Apr 27 17:11:33 dhclient: Adding new routes to interface: re0
      04-27-2014	17:11:35	User.Notice	172.16.1.1	Apr 27 17:11:33 dhclient: New Routers (re0): 
      04-27-2014	17:11:35	User.Notice	172.16.1.1	Apr 27 17:11:33 dhclient: New Broadcast Address (re0): 192.168.100.255
      04-27-2014	17:11:35	User.Notice	172.16.1.1	Apr 27 17:11:33 dhclient: New Subnet Mask (re0): 255.255.255.0
      04-27-2014	17:11:35	User.Notice	172.16.1.1	Apr 27 17:11:33 dhclient: New IP Address (re0): 192.168.100.10
      04-27-2014	17:11:35	User.Notice	172.16.1.1	Apr 27 17:11:33 dhclient: ifconfig re0 inet 192.168.100.10 netmask 255.255.255.0 broadcast 192.168.100.255 
      04-27-2014	17:11:35	User.Notice	172.16.1.1	Apr 27 17:11:33 dhclient: Starting add_new_address()
      04-27-2014	17:11:35	User.Notice	172.16.1.1	Apr 27 17:11:33 dhclient: Comparing IPs: Old:  New: 192.168.100.10
      04-27-2014	17:11:35	User.Notice	172.16.1.1	Apr 27 17:11:33 dhclient: Starting delete_old_states()
      04-27-2014	17:11:35	User.Notice	172.16.1.1	Apr 27 17:11:33 dhclient: BOUND
      04-27-2014	17:11:35	Daemon.Info	172.16.1.1	Apr 27 17:11:33 dhclient[20215]: DHCPACK from 192.168.100.1
      04-27-2014	17:11:35	Daemon.Info	172.16.1.1	Apr 27 17:11:33 dhclient[20215]: DHCPREQUEST on re0 to 255.255.255.255 port 67
      04-27-2014	17:11:35	User.Notice	172.16.1.1	Apr 27 17:11:33 dhclient: ARPCHECK
      04-27-2014	17:11:33	Daemon.Debug	172.16.1.1	Apr 27 17:11:31 dhclient[20215]: DHCPOFFER already seen.
      04-27-2014	17:11:33	Daemon.Info	172.16.1.1	Apr 27 17:11:31 dhclient[20215]: DHCPOFFER from 192.168.100.1
      04-27-2014	17:11:33	User.Notice	172.16.1.1	Apr 27 17:11:31 dhclient: ARPSEND
      04-27-2014	17:11:33	Daemon.Info	172.16.1.1	Apr 27 17:11:31 dhclient[20215]: DHCPOFFER from 192.168.100.1
      04-27-2014	17:11:32	Daemon.Info	172.16.1.1	Apr 27 17:11:31 dhclient[20215]: DHCPDISCOVER on re0 to 255.255.255.255 port 67 interval 4
      04-27-2014	17:11:31	Daemon.Info	172.16.1.1	Apr 27 17:11:29 dhclient[20215]: DHCPDISCOVER on re0 to 255.255.255.255 port 67 interval 2
      04-27-2014	17:11:31	Daemon.Info	172.16.1.1	Apr 27 17:11:29 dhclient[20215]: DHCPNAK from 192.168.100.1
      04-27-2014	17:11:31	Daemon.Info	172.16.1.1	Apr 27 17:11:29 dhclient[20215]: DHCPREQUEST on re0 to 255.255.255.255 port 67
      04-27-2014	17:11:30	User.Notice	172.16.1.1	Apr 27 17:11:28 check_reload_status: updating dyndns wan
      04-27-2014	17:11:30	Daemon.Info	172.16.1.1	Apr 27 17:11:28 radvd[63690]: resuming normal operation
      04-27-2014	17:11:30	Daemon.Warning	172.16.1.1	Apr 27 17:11:28 radvd[63690]: no auto-selected prefix on interface re1, disabling advertisements
      04-27-2014	17:11:30	Daemon.Info	172.16.1.1	Apr 27 17:11:28 radvd[63690]: attempting to reread config file
      04-27-2014	17:11:28	Daemon.Info	172.16.1.1	Apr 27 17:11:27 dhclient[20215]: DHCPREQUEST on re0 to 255.255.255.255 port 67
      04-27-2014	17:11:28	Local7.Info	172.16.1.1	Apr 27 17:11:26 dhcpd: Disabling input on BPF/re1/00:0d:b9:33:83:35/172.16.1.0/27
      04-27-2014	17:11:28	Local7.Info	172.16.1.1	Apr 27 17:11:26 dhcpd: Disabling output on BPF/re1/00:0d:b9:33:83:35/172.16.1.0/27
      04-27-2014	17:11:28	Local7.Info	172.16.1.1	Apr 27 17:11:26 dhcpd: Received signal 15, initiating shutdown.
      04-27-2014	17:11:28	Daemon.Info	172.16.1.1	Apr 27 17:11:26 dnsmasq[22971]: read /etc/hosts - 2 addresses
      04-27-2014	17:11:28	Daemon.Warning	172.16.1.1	Apr 27 17:11:26 dnsmasq[22971]: ignoring nameserver 127.0.0.1 - local interface
      04-27-2014	17:11:28	Daemon.Info	172.16.1.1	Apr 27 17:11:26 dnsmasq[22971]: using nameserver 208.67.220.220#53
      04-27-2014	17:11:28	Daemon.Info	172.16.1.1	Apr 27 17:11:26 dnsmasq[22971]: using nameserver 208.67.222.222#53
      04-27-2014	17:11:28	Daemon.Info	172.16.1.1	Apr 27 17:11:26 dnsmasq[22971]: reading /etc/resolv.conf
      04-27-2014	17:11:28	Daemon.Info	172.16.1.1	Apr 27 17:11:26 dnsmasq[22971]: compile time options: IPv6 GNU-getopt no-DBus i18n IDN DHCP DHCPv6 no-Lua TFTP no-conntrack no-ipset auth
      04-27-2014	17:11:28	Daemon.Info	172.16.1.1	Apr 27 17:11:26 dnsmasq[22971]: started, version 2.68 cachesize 10000
      04-27-2014	17:11:27	Daemon.Info	172.16.1.1	Apr 27 17:11:26 dhclient[20215]: DHCPREQUEST on re0 to 255.255.255.255 port 67
      04-27-2014	17:11:27	Daemon.Warning	172.16.1.1	Apr 27 17:11:25 dnsmasq[46779]: overflow: 7 log entries lost
      04-27-2014	17:11:27	Daemon.Info	172.16.1.1	Apr 27 16:34:09 dnsmasq[46779]: started, version 2.68 cachesize 10000
      04-27-2014	17:11:27	Daemon.Info	172.16.1.1	Apr 27 17:11:25 dhclient[20215]: DHCPREQUEST on re0 to 255.255.255.255 port 67
      04-27-2014	17:11:27	User.Notice	172.16.1.1	Apr 27 17:11:25 dhclient: Comparing IPs: Old:  New: 
      04-27-2014	17:11:27	User.Notice	172.16.1.1	Apr 27 17:11:25 dhclient: Starting delete_old_states()
      04-27-2014	17:11:27	User.Notice	172.16.1.1	Apr 27 17:11:25 dhclient: PREINIT
      04-27-2014	17:11:26	User.Error	172.16.1.1	Apr 27 17:11:25 php: rc.linkup: HOTPLUG: Configuring interface wan
      04-27-2014	17:11:26	User.Error	172.16.1.1	Apr 27 17:11:25 php: rc.linkup: DEVD Ethernet attached event for wan
      04-27-2014	17:11:25	User.Error	172.16.1.1	Apr 27 17:11:23 php: rc.linkup: Accept router advertisements on interface re0 
      04-27-2014	17:11:25	User.Error	172.16.1.1	Apr 27 17:11:23 php: rc.linkup: The command '/sbin/dhclient -c /var/etc/dhclient_wan.conf re0 > /tmp/re0_output 2> /tmp/re0_error_output' returned exit code '15', the output was '' 
      04-27-2014	17:11:25	Daemon.Critical	172.16.1.1	Apr 27 17:11:23 dhclient[16060]: exiting.
      04-27-2014	17:11:25	Daemon.Error	172.16.1.1	Apr 27 17:11:23 dhclient[16060]: connection closed
      04-27-2014	17:11:25	User.Error	172.16.1.1	Apr 27 17:11:23 php: rc.linkup: DEVD Ethernet detached event for wan
      04-27-2014	17:11:24	Kernel.Notice	172.16.1.1	Apr 27 17:11:22 kernel: re0: link state changed to UP
      04-27-2014	17:11:24	User.Notice	172.16.1.1	Apr 27 17:11:22 check_reload_status: Linkup starting re0
      04-27-2014	17:11:22	Kernel.Notice	172.16.1.1	Apr 27 17:11:20 kernel: re0: link state changed to DOWN
      04-27-2014	17:11:22	User.Notice	172.16.1.1	Apr 27 17:11:20 check_reload_status: Linkup starting re0
      04-27-2014	17:11:21	Daemon.Info	172.16.1.1	Apr 27 17:11:20 dhclient[15739]: DHCPREQUEST on re0 to 255.255.255.255 port 67
      04-27-2014	17:11:20	Daemon.Info	172.16.1.1	Apr 27 17:11:18 dhclient[15739]: DHCPREQUEST on re0 to 255.255.255.255 port 67
      04-27-2014	17:11:20	User.Notice	172.16.1.1	Apr 27 17:11:18 dhclient: Comparing IPs: Old:  New: 
      04-27-2014	17:11:20	User.Notice	172.16.1.1	Apr 27 17:11:18 dhclient: Starting delete_old_states()
      04-27-2014	17:11:20	User.Notice	172.16.1.1	Apr 27 17:11:18 dhclient: PREINIT
      04-27-2014	17:11:19	User.Error	172.16.1.1	Apr 27 17:11:18 php: rc.linkup: HOTPLUG: Configuring interface wan
      04-27-2014	17:11:19	User.Error	172.16.1.1	Apr 27 17:11:18 php: rc.linkup: DEVD Ethernet attached event for wan
      04-27-2014	17:11:19	Local7.Info	172.16.1.1	Apr 27 17:11:17 dhcpd: DHCPACK to 172.16.1.13 (00:24:d7:b9:42:64) via re1
      04-27-2014	17:11:19	Local7.Info	172.16.1.1	Apr 27 17:11:17 dhcpd: DHCPINFORM from 172.16.1.13 via re1
      04-27-2014	17:11:17	Kernel.Notice	172.16.1.1	Apr 27 17:11:15 kernel: re0: link state changed to UP
      04-27-2014	17:11:17	User.Notice	172.16.1.1	Apr 27 17:11:15 check_reload_status: Linkup starting re0
      04-27-2014	17:11:07	System2.Info	172.16.1.1	Apr 27 17:11:05 ntpd[75612]: 66.40.130.103 local addr 68.112.154.60 -> <null>04-27-2014	17:11:07	System2.Info	172.16.1.1	Apr 27 17:11:05 ntpd[75612]: Deleting interface #2 re0, 68.112.154.60#123, interface stats: received=38, sent=38, dropped=0, active_time=2206 secs
      04-27-2014	17:11:04	Daemon.Critical	172.16.1.1	Apr 27 17:11:03 dhclient[35604]: exiting.
      04-27-2014	17:11:04	Daemon.Error	172.16.1.1	Apr 27 17:11:03 dhclient[35604]: connection closed
      04-27-2014	17:11:04	User.Error	172.16.1.1	Apr 27 17:11:03 php: rc.linkup: DEVD Ethernet detached event for wan
      04-27-2014	17:11:02	Kernel.Notice	172.16.1.1	Apr 27 17:11:00 kernel: re0: link state changed to DOWN
      04-27-2014	17:11:02	User.Notice	172.16.1.1	Apr 27 17:11:00 check_reload_status: Linkup starting re0
      04-27-2014	17:05:45	Local7.Info	172.16.1.1	Apr 27 17:05:44 dhcpd: DHCPACK to 172.16.1.13 (00:24:d7:b9:42:64) via re1
      04-27-2014	17:05:45	Local7.Info	172.16.1.1	Apr 27 17:05:44 dhcpd: DHCPINFORM from 172.16.1.13 via re1
      04-27-2014	17:04:29	Local7.Info	172.16.1.1	Apr 27 17:04:27 dhcpd: DHCPACK on 172.16.1.12 to 00:24:8d:3c:ee:87 via re1
      04-27-2014	17:04:29	Local7.Info	172.16.1.1	Apr 27 17:04:27 dhcpd: DHCPREQUEST for 172.16.1.12 from 00:24:8d:3c:ee:87 via re1
      04-27-2014	17:02:40	Local7.Info	172.16.1.1	Apr 27 17:02:39 dhcpd: DHCPACK to 172.16.1.13 (00:24:d7:b9:42:64) via re1
      04-27-2014	17:02:40	Local7.Info	172.16.1.1	Apr 27 17:02:39 dhcpd: DHCPINFORM from 172.16.1.13 via re1
      04-27-2014	17:00:01	Cron.Info	172.16.1.1	Apr 27 17:00:00 /usr/sbin/cron[62864]: (root) CMD (/usr/bin/nice -n20 /usr/local/sbin/expiretable -v -t 3600 sshlockout)
      04-27-2014	17:00:01	Cron.Info	172.16.1.1	Apr 27 17:00:00 /usr/sbin/cron[62663]: (root) CMD (/usr/bin/nice -n20 /usr/local/sbin/expiretable -v -t 3600 virusprot)
      04-27-2014	16:58:56	Local7.Info	172.16.1.1	Apr 27 16:58:55 dhcpd: DHCPACK to 172.16.1.13 (00:24:d7:b9:42:64) via re1
      04-27-2014	16:58:56	Local7.Info	172.16.1.1	Apr 27 16:58:55 dhcpd: DHCPINFORM from 172.16.1.13 via re1
      04-27-2014	16:57:54	System4.Notice	172.16.1.1	Apr 27 16:57:52 sshlockout[31198]: sshlockout/webConfigurator v3.0 starting up
      04-27-2014	16:57:54	Auth.Info	172.16.1.1	Apr 27 16:57:52 sshd[16902]: Accepted keyboard-interactive/pam for admin from 172.16.1.10 port 28481 ssh2
      04-27-2014	16:56:30	Local7.Info	172.16.1.1	Apr 27 16:56:28 dhcpd: DHCPACK to 172.16.1.13 (00:24:d7:b9:42:64) via re1
      04-27-2014	16:56:30	Local7.Info	172.16.1.1	Apr 27 16:56:28 dhcpd: DHCPINFORM from 172.16.1.13 via re1
      04-27-2014	16:55:06	Local7.Info	172.16.1.1	Apr 27 16:55:04 dhcpd: DHCPACK to 172.16.1.13 (00:24:d7:b9:42:64) via re1
      04-27-2014	16:55:06	Local7.Info	172.16.1.1	Apr 27 16:55:04 dhcpd: DHCPINFORM from 172.16.1.13 via re1
      04-27-2014	16:53:53	Local7.Info	172.16.1.1	Apr 27 16:53:51 dhcpd: DHCPACK to 172.16.1.13 (00:24:d7:b9:42:64) via re1
      04-27-2014	16:53:53	Local7.Info	172.16.1.1	Apr 27 16:53:51 dhcpd: DHCPINFORM from 172.16.1.13 via re1
      04-27-2014	16:50:57	Local7.Info	172.16.1.1	Apr 27 16:50:55 dhcpd: DHCPACK on 172.16.1.13 to 00:24:d7:b9:42:64 (6KFXKQ1) via re1
      04-27-2014	16:50:57	Local7.Info	172.16.1.1	Apr 27 16:50:55 dhcpd: DHCPREQUEST for 172.16.1.13 from 00:24:d7:b9:42:64 (6KFXKQ1) via re1
      04-27-2014	16:46:28	Local7.Info	172.16.1.1	Apr 27 16:46:26 dhcpd: DHCPACK to 172.16.1.13 (00:24:d7:b9:42:64) via re1
      04-27-2014	16:46:28	Local7.Info	172.16.1.1	Apr 27 16:46:26 dhcpd: DHCPINFORM from 172.16.1.13 via re1
      04-27-2014	16:43:51	Local7.Info	172.16.1.1	Apr 27 16:43:49 dhcpd: DHCPACK to 172.16.1.13 (00:24:d7:b9:42:64) via re1
      04-27-2014	16:43:51	Local7.Info	172.16.1.1	Apr 27 16:43:49 dhcpd: DHCPINFORM from 172.16.1.13 via re1
      04-27-2014	16:38:15	Local7.Info	172.16.1.1	Apr 27 16:38:14 dhcpd: DHCPACK on 172.16.1.11 to f8:f1:b6:57:61:2f (android-cc5e5e29a352956c) via re1
      04-27-2014	16:38:15	Local7.Info	172.16.1.1	Apr 27 16:38:14 dhcpd: DHCPREQUEST for 172.16.1.11 from f8:f1:b6:57:61:2f (android-cc5e5e29a352956c) via re1
      04-27-2014	16:36:11	Kernel.Info	172.16.1.1	Apr 27 16:36:10 kernel: pflog0: promiscuous mode enabled
      04-27-2014	16:36:11	Local0.Info	172.16.1.1	Apr 27 16:36:09 pf: 0 packets dropped by kernel
      04-27-2014	16:36:11	Local0.Info	172.16.1.1	Apr 27 16:36:09 pf: 0 packets received by filter
      04-27-2014	16:36:11	Local0.Info	172.16.1.1	Apr 27 16:36:09 pf: 0 packets captured
      04-27-2014	16:36:11	System4.Info	172.16.1.1	Apr 27 16:36:09 kernel: Enter an option: 
      04-27-2014	16:36:11	System4.Info	172.16.1.1	Apr 27 16:36:09 kernel: 
      04-27-2014	16:36:11	System4.Info	172.16.1.1	Apr 27 16:36:09 kernel: 
      04-27-2014	16:36:11	System4.Info	172.16.1.1	Apr 27 16:36:09 kernel: 7) Ping host                         15) Restore recent configuration
      04-27-2014	16:36:11	System4.Info	172.16.1.1	Apr 27 16:36:09 kernel: 6) Halt system                       14) Enable Secure Shell (sshd)
      04-27-2014	16:36:11	System4.Info	172.16.1.1	Apr 27 16:36:09 kernel: 5) Reboot system                     13) Upgrade from console
      04-27-2014	16:36:11	System4.Info	172.16.1.1	Apr 27 16:36:09 kernel: 4) Reset to factory defaults         12) pfSense Developer Shell
      04-27-2014	16:36:11	System4.Info	172.16.1.1	Apr 27 16:36:09 kernel: 3) Reset webConfigurator password    11) Restart webConfigurator
      04-27-2014	16:36:11	System4.Info	172.16.1.1	Apr 27 16:36:09 kernel: 2) Set interface(s) IP address       10) Filter Logs
      04-27-2014	16:36:11	System4.Info	172.16.1.1	Apr 27 16:36:09 kernel: 1) Assign Interfaces                  9) pfTop
      04-27-2014	16:36:11	System4.Info	172.16.1.1	Apr 27 16:36:09 kernel: 0) Logout (SSH only)                  8) Shell
      04-27-2014	16:36:11	System4.Info	172.16.1.1	Apr 27 16:36:09 kernel: 
      04-27-2014	16:36:11	System4.Info	172.16.1.1	Apr 27 16:36:09 kernel: 
      04-27-2014	16:36:11	System4.Info	172.16.1.1	Apr 27 16:36:09 kernel: OPT1 (opt1)     -> re2        -> 
      04-27-2014	16:36:11	System4.Info	172.16.1.1	Apr 27 16:36:09 kernel: 
      04-27-2014	16:36:11	System4.Info	172.16.1.1	Apr 27 16:36:09 kernel: v4: 172.16.1.1/27
      04-27-2014	16:36:11	System4.Info	172.16.1.1	Apr 27 16:36:09 kernel: LAN (lan)       -> re1        -> 
      04-27-2014	16:36:11	System4.Info	172.16.1.1	Apr 27 16:36:09 kernel: 
      04-27-2014	16:36:11	System4.Info	172.16.1.1	Apr 27 16:36:09 kernel: v4/DHCP4: 68.112.154.60/22
      04-27-2014	16:36:11	System4.Info	172.16.1.1	Apr 27 16:36:09 kernel: WAN (wan)       -> re0        -> 
      04-27-2014	16:36:11	System4.Info	172.16.1.1	Apr 27 16:36:09 kernel: 
      04-27-2014	16:36:11	System4.Info	172.16.1.1	Apr 27 16:36:09 kernel: *** Welcome to pfSense 2.1.2-RELEASE-nanobsd (amd64) on h-pf ***
      04-27-2014	16:36:11	System4.Info	172.16.1.1	Apr 27 16:36:09 kernel: 
      04-27-2014	16:36:11	System4.Info	172.16.1.1	Apr 27 16:36:09 kernel: FreeBSD/amd64 (h-pf.emrlab.info) (console)
      04-27-2014	16:36:11	System4.Info	172.16.1.1	Apr 27 16:36:09 kernel: 
      04-27-2014	16:36:11	System4.Info	172.16.1.1	Apr 27 16:36:09 kernel: Bootup complete
      04-27-2014	16:36:11	System4.Info	172.16.1.1	Apr 27 16:36:09 kernel: done.
      04-27-2014	16:36:11	System4.Info	172.16.1.1	Apr 27 16:36:09 kernel: Starting CRON... 
      04-27-2014	16:36:11	System4.Info	172.16.1.1	Apr 27 16:36:09 kernel: done.
      04-27-2014	16:36:11	System4.Info	172.16.1.1	Apr 27 16:36:09 kernel: Starting syslog...
      04-27-2014	16:36:11	System4.Info	172.16.1.1	Apr 27 16:36:09 kernel: done.
      04-27-2014	16:36:11	Kernel.Info	172.16.1.1	Apr 27 16:36:09 syslogd: kernel boot file is /boot/kernel/kernel
      04-27-2014	16:36:11	Syslog.Info	172.16.1.1	Apr 27 16:36:09 syslogd: restart</null> 
      

      Regards,

      xtropx

      1 Reply Last reply Reply Quote 0
      • C
        cmb
        last edited by

        I presume you mean APU and not ALIX given the re NICs. There's no such thing as an "ALIX APU", I edited your post to remove ALIX.

        Your modem is handing out an IP to the firewall, typically what happens when your modem isn't connected to your ISP. Fill in the "Reject leases from" field with 192.168.0.0/16 so it'll reject your modem's leases, and that'll make things a bit better. The root problem though seems to be that you're losing Internet connectivity.

        1 Reply Last reply Reply Quote 0
        • X
          xtropx
          last edited by

          I stand corrected.

          I moved back to my E1000 with DD-WRT last night and I have not had any problems since then.

          I will try your suggestion, hopefully it will result in some success.

          Regards,

          xtropx

          1 Reply Last reply Reply Quote 0
          • X
            xtropx
            last edited by

            Your suggestion has helped to some degree, ( I don't have to reset the interface manually to get my public lease anymore ) however, the problem is still happening.

            Logs:

            05-01-2014	18:05:09	User.Notice	172.16.1.1	May  1 18:05:04 check_reload_status: updating dyndns wan
            05-01-2014	18:05:09	Daemon.Info	172.16.1.1	May  1 18:05:04 radvd[66567]: resuming normal operation
            05-01-2014	18:05:09	Daemon.Warning	172.16.1.1	May  1 18:05:04 radvd[66567]: no auto-selected prefix on interface re1, disabling advertisements
            05-01-2014	18:05:09	Daemon.Info	172.16.1.1	May  1 18:05:04 radvd[66567]: attempting to reread config file
            05-01-2014	18:05:08	Local7.Info	172.16.1.1	May  1 18:05:03 dhcpd: Sending on   Socket/fallback/fallback-net
            05-01-2014	18:05:07	User.Error	172.16.1.1	May  1 18:05:02 apinger: SIGHUP received, reloading configuration.
            05-01-2014	18:05:07	Local7.Info	172.16.1.1	May  1 18:05:02 dhcpd: Disabling input on BPF/re1/00:0d:b9:33:83:35/172.16.1.0/27
            05-01-2014	18:05:07	Local7.Info	172.16.1.1	May  1 18:05:02 dhcpd: Disabling output on BPF/re1/00:0d:b9:33:83:35/172.16.1.0/27
            05-01-2014	18:05:07	Local7.Info	172.16.1.1	May  1 18:05:02 dhcpd: Received signal 15, initiating shutdown.
            05-01-2014	18:05:07	User.Error	172.16.1.1	May  1 18:05:02 php: rc.newwanip: Removing static route for monitor 208.67.220.220 and adding a new route through 68.112.156.1
            05-01-2014	18:05:07	User.Error	172.16.1.1	May  1 18:05:02 php: rc.newwanip: ROUTING: setting default route to 68.112.156.1
            05-01-2014	18:05:07	User.Error	172.16.1.1	May  1 18:05:02 php: rc.newwanip: rc.newwanip: on (IP address: 68.112.157.243) (interface: wan) (real interface: re0).
            05-01-2014	18:05:07	User.Error	172.16.1.1	May  1 18:05:02 php: rc.newwanip: rc.newwanip: Informational is starting re0.
            05-01-2014	18:05:05	System2.Debug	172.16.1.1	May  1 18:05:01 ntpd[17170]: new interface(s) found: waking up resolver
            05-01-2014	18:05:05	System2.Info	172.16.1.1	May  1 18:05:01 ntpd[17170]: Listen normally on 10 re0 68.112.157.243:123
            05-01-2014	18:05:05	User.Error	172.16.1.1	May  1 18:05:01 apinger: alarm canceled: WAN_DHCP(208.67.220.220)  *** down ***
            05-01-2014	18:05:04	User.Error	172.16.1.1	May  1 18:05:00 php: rc.linkup: ROUTING: setting default route to 68.112.156.1
            05-01-2014	18:05:04	User.Error	172.16.1.1	May  1 18:05:00 php: rc.linkup: Accept router advertisements on interface re0 
            05-01-2014	18:05:04	Daemon.Info	172.16.1.1	May  1 18:05:00 dhclient[8496]: bound to 68.112.157.243 -- renewal in 14400 seconds.
            05-01-2014	18:05:04	User.Notice	172.16.1.1	May  1 18:05:00 check_reload_status: rc.newwanip starting re0
            05-01-2014	18:05:04	User.Notice	172.16.1.1	May  1 18:05:00 dhclient: Creating resolv.conf
            05-01-2014	18:05:04	User.Notice	172.16.1.1	May  1 18:05:00 dhclient: /sbin/route add default 68.112.156.1
            05-01-2014	18:05:04	User.Notice	172.16.1.1	May  1 18:05:00 dhclient: Adding new routes to interface: re0
            05-01-2014	18:05:04	User.Notice	172.16.1.1	May  1 18:05:00 dhclient: New Routers (re0): 68.112.156.1
            05-01-2014	18:05:04	User.Notice	172.16.1.1	May  1 18:05:00 dhclient: New Broadcast Address (re0): 255.255.255.255
            05-01-2014	18:05:04	User.Notice	172.16.1.1	May  1 18:05:00 dhclient: New Subnet Mask (re0): 255.255.252.0
            05-01-2014	18:05:04	User.Notice	172.16.1.1	May  1 18:05:00 dhclient: New IP Address (re0): 68.112.157.243
            05-01-2014	18:05:04	User.Notice	172.16.1.1	May  1 18:05:00 dhclient: ifconfig re0 inet 68.112.157.243 netmask 255.255.252.0 broadcast 255.255.255.255 
            05-01-2014	18:05:04	User.Notice	172.16.1.1	May  1 18:05:00 dhclient: Starting add_new_address()
            05-01-2014	18:05:04	User.Notice	172.16.1.1	May  1 18:05:00 dhclient: BOUND
            05-01-2014	18:05:04	Daemon.Info	172.16.1.1	May  1 18:05:00 dhclient[8496]: DHCPACK from 10.148.48.1
            05-01-2014	18:05:04	Daemon.Info	172.16.1.1	May  1 18:05:00 dhclient[8496]: DHCPREQUEST on re0 to 255.255.255.255 port 67
            05-01-2014	18:05:04	User.Notice	172.16.1.1	May  1 18:05:00 dhclient: ARPCHECK
            05-01-2014	18:05:02	User.Notice	172.16.1.1	May  1 18:04:58 dhclient: ARPSEND
            05-01-2014	18:05:02	Daemon.Info	172.16.1.1	May  1 18:04:58 dhclient[8496]: DHCPOFFER from 10.148.48.1
            05-01-2014	18:05:02	Daemon.Info	172.16.1.1	May  1 18:04:58 dhclient[8496]: DHCPDISCOVER on re0 to 255.255.255.255 port 67 interval 1
            05-01-2014	18:05:02	Daemon.Info	172.16.1.1	May  1 18:04:57 dhclient[8496]: DHCPOFFER from 192.168.100.1 rejected.
            05-01-2014	18:05:02	Daemon.Info	172.16.1.1	May  1 18:04:57 dhclient[8496]: DHCPOFFER from 192.168.100.1 rejected.
            05-01-2014	18:05:01	Daemon.Info	172.16.1.1	May  1 18:04:57 dhclient[8496]: DHCPDISCOVER on re0 to 255.255.255.255 port 67 interval 1
            05-01-2014	18:05:00	Daemon.Info	172.16.1.1	May  1 18:04:56 dhclient[8496]: DHCPDISCOVER on re0 to 255.255.255.255 port 67 interval 1
            05-01-2014	18:04:53	Daemon.Info	172.16.1.1	May  1 18:04:49 dhclient[8496]: DHCPNACK from 192.168.100.1 rejected.
            05-01-2014	18:04:53	Daemon.Info	172.16.1.1	May  1 18:04:49 dhclient[8496]: DHCPREQUEST on re0 to 255.255.255.255 port 67
            05-01-2014	18:04:49	Daemon.Info	172.16.1.1	May  1 18:04:45 dhclient[8496]: DHCPNACK from 192.168.100.1 rejected.
            05-01-2014	18:04:49	Daemon.Info	172.16.1.1	May  1 18:04:45 dhclient[8496]: DHCPREQUEST on re0 to 255.255.255.255 port 67
            05-01-2014	18:04:46	User.Notice	172.16.1.1	May  1 18:04:42 check_reload_status: updating dyndns wan
            05-01-2014	18:04:46	Daemon.Info	172.16.1.1	May  1 18:04:42 radvd[66567]: resuming normal operation
            05-01-2014	18:04:46	Daemon.Warning	172.16.1.1	May  1 18:04:42 radvd[66567]: no auto-selected prefix on interface re1, disabling advertisements
            05-01-2014	18:04:46	Daemon.Info	172.16.1.1	May  1 18:04:42 radvd[66567]: attempting to reread config file
            05-01-2014	18:04:45	Local7.Info	172.16.1.1	May  1 18:04:41 dhcpd: Sending on   Socket/fallback/fallback-net
            05-01-2014	18:04:45	Daemon.Info	172.16.1.1	May  1 18:04:41 dhclient[8496]: DHCPREQUEST on re0 to 255.255.255.255 port 67
            05-01-2014	18:04:44	Local7.Info	172.16.1.1	May  1 18:04:39 dhcpd: Disabling input on BPF/re1/00:0d:b9:33:83:35/172.16.1.0/27
            05-01-2014	18:04:44	Local7.Info	172.16.1.1	May  1 18:04:39 dhcpd: Disabling output on BPF/re1/00:0d:b9:33:83:35/172.16.1.0/27
            05-01-2014	18:04:44	Local7.Info	172.16.1.1	May  1 18:04:39 dhcpd: Received signal 15, initiating shutdown.
            05-01-2014	18:04:44	Daemon.Info	172.16.1.1	May  1 18:04:39 dhclient[8496]: DHCPREQUEST on re0 to 255.255.255.255 port 67
            05-01-2014	18:04:44	User.Notice	172.16.1.1	May  1 18:04:39 dhclient: Comparing IPs: Old:  New: 
            05-01-2014	18:04:44	User.Notice	172.16.1.1	May  1 18:04:39 dhclient: Starting delete_old_states()
            05-01-2014	18:04:44	User.Notice	172.16.1.1	May  1 18:04:39 dhclient: PREINIT
            05-01-2014	18:04:43	User.Error	172.16.1.1	May  1 18:04:39 php: rc.linkup: HOTPLUG: Configuring interface wan
            05-01-2014	18:04:43	User.Error	172.16.1.1	May  1 18:04:39 php: rc.linkup: DEVD Ethernet attached event for wan
            05-01-2014	18:04:42	User.Error	172.16.1.1	May  1 18:04:37 php: rc.linkup: Accept router advertisements on interface re0 
            05-01-2014	18:04:42	User.Error	172.16.1.1	May  1 18:04:37 php: rc.linkup: The command '/sbin/dhclient -c /var/etc/dhclient_wan.conf re0 > /tmp/re0_output 2> /tmp/re0_error_output' returned exit code '15', the output was '' 
            05-01-2014	18:04:42	Daemon.Critical	172.16.1.1	May  1 18:04:37 dhclient[92175]: exiting.
            05-01-2014	18:04:42	Daemon.Error	172.16.1.1	May  1 18:04:37 dhclient[92175]: connection closed
            05-01-2014	18:04:42	User.Error	172.16.1.1	May  1 18:04:37 php: rc.linkup: DEVD Ethernet detached event for wan
            05-01-2014	18:04:41	Kernel.Notice	172.16.1.1	May  1 18:04:37 kernel: re0: link state changed to UP
            05-01-2014	18:04:41	User.Notice	172.16.1.1	May  1 18:04:37 check_reload_status: Linkup starting re0
            05-01-2014	18:04:41	Daemon.Info	172.16.1.1	May  1 18:04:37 dhclient[92018]: DHCPREQUEST on re0 to 255.255.255.255 port 67
            05-01-2014	18:04:39	User.Notice	172.16.1.1	May  1 18:04:35 check_reload_status: Linkup starting re0
            05-01-2014	18:04:39	Kernel.Notice	172.16.1.1	May  1 18:04:35 kernel: re0: link state changed to DOWN
            05-01-2014	18:04:39	Daemon.Info	172.16.1.1	May  1 18:04:35 dhclient[92018]: DHCPREQUEST on re0 to 255.255.255.255 port 67
            05-01-2014	18:04:38	Daemon.Info	172.16.1.1	May  1 18:04:33 dhclient[92018]: DHCPREQUEST on re0 to 255.255.255.255 port 67
            05-01-2014	18:04:38	User.Notice	172.16.1.1	May  1 18:04:33 dhclient: Comparing IPs: Old:  New: 
            05-01-2014	18:04:38	User.Notice	172.16.1.1	May  1 18:04:33 dhclient: Starting delete_old_states()
            05-01-2014	18:04:38	User.Notice	172.16.1.1	May  1 18:04:33 dhclient: PREINIT
            05-01-2014	18:04:37	User.Error	172.16.1.1	May  1 18:04:33 php: rc.linkup: HOTPLUG: Configuring interface wan
            05-01-2014	18:04:37	User.Error	172.16.1.1	May  1 18:04:33 php: rc.linkup: DEVD Ethernet attached event for wan
            05-01-2014	18:04:35	Kernel.Notice	172.16.1.1	May  1 18:04:31 kernel: re0: link state changed to UP
            05-01-2014	18:04:35	User.Notice	172.16.1.1	May  1 18:04:31 check_reload_status: Linkup starting re0
            05-01-2014	18:04:26	Kernel.Debug	172.16.1.1	May  1 18:04:21 kernel: arpresolve: can't allocate llinfo for 68.112.156.1
            05-01-2014	18:04:26	Kernel.Debug	172.16.1.1	May  1 18:04:21 kernel: arpresolve: can't allocate llinfo for 68.112.156.1
            05-01-2014	18:04:26	User.Error	172.16.1.1	May  1 18:04:21 php: rc.linkup: Clearing states to old gateway 68.112.156.1.
            05-01-2014	18:04:25	Kernel.Debug	172.16.1.1	May  1 18:04:21 kernel: arpresolve: can't allocate llinfo for 68.112.156.1
            05-01-2014	18:04:25	Kernel.Debug	172.16.1.1	May  1 18:04:21 kernel: arpresolve: can't allocate llinfo for 68.112.156.1
            05-01-2014	18:04:25	Kernel.Debug	172.16.1.1	May  1 18:04:21 kernel: arpresolve: can't allocate llinfo for 68.112.156.1
            05-01-2014	18:04:25	Kernel.Debug	172.16.1.1	May  1 18:04:21 kernel: arpresolve: can't allocate llinfo for 68.112.156.1
            05-01-2014	18:04:24	System2.Info	172.16.1.1	May  1 18:04:20 ntpd[17170]: 74.120.8.2 local addr 68.112.157.243 -> <null>
            05-01-2014	18:04:24	System2.Info	172.16.1.1	May  1 18:04:20 ntpd[17170]: Deleting interface #2 re0, 68.112.157.243#123, interface stats: received=27, sent=27, dropped=0, active_time=1450 secs
            05-01-2014	18:04:24	Kernel.Debug	172.16.1.1	May  1 18:04:20 kernel: arpresolve: can't allocate llinfo for 68.112.156.1
            05-01-2014	18:04:24	Kernel.Debug	172.16.1.1	May  1 18:04:20 kernel: arpresolve: can't allocate llinfo for 68.112.156.1
            05-01-2014	18:04:24	Kernel.Debug	172.16.1.1	May  1 18:04:20 kernel: arpresolve: can't allocate llinfo for 68.112.156.1
            05-01-2014	18:04:23	Kernel.Debug	172.16.1.1	May  1 18:04:19 kernel: arpresolve: can't allocate llinfo for 68.112.156.1
            05-01-2014	18:04:23	Kernel.Debug	172.16.1.1	May  1 18:04:19 kernel: arpresolve: can't allocate llinfo for 68.112.156.1
            05-01-2014	18:04:23	Kernel.Debug	172.16.1.1	May  1 18:04:18 kernel: arpresolve: can't allocate llinfo for 68.112.156.1
            05-01-2014	18:04:22	Kernel.Debug	172.16.1.1	May  1 18:04:18 kernel: arpresolve: can't allocate llinfo for 68.112.156.1
            05-01-2014	18:04:21	Daemon.Critical	172.16.1.1	May  1 18:04:17 dhclient[77765]: exiting.
            05-01-2014	18:04:21	Daemon.Error	172.16.1.1	May  1 18:04:17 dhclient[77765]: connection closed
            05-01-2014	18:04:21	User.Error	172.16.1.1	May  1 18:04:17 php: rc.linkup: DEVD Ethernet detached event for wan
            05-01-2014	18:04:19	User.Notice	172.16.1.1	May  1 18:04:15 check_reload_status: Linkup starting re0
            05-01-2014	18:04:19	Kernel.Notice	172.16.1.1	May  1 18:04:15 kernel: re0: link state changed to DOWN
            05-01-2014	18:04:15	User.Notice	172.16.1.1	May  1 18:04:11 check_reload_status: Reloading filter
            05-01-2014	18:04:15	User.Notice	172.16.1.1	May  1 18:04:11 check_reload_status: Restarting OpenVPN tunnels/interfaces
            05-01-2014	18:04:15	User.Notice	172.16.1.1	May  1 18:04:11 check_reload_status: Restarting ipsec tunnels
            05-01-2014	18:04:15	User.Notice	172.16.1.1	May  1 18:04:11 check_reload_status: updating dyndns WAN_DHCP
            05-01-2014	18:04:05	User.Error	172.16.1.1	May  1 18:04:01 apinger: ALARM: WAN_DHCP(208.67.220.220)  *** down ***
            05-01-2014	18:00:04	Cron.Info	172.16.1.1	May  1 18:00:00 /usr/sbin/cron[31652]: (root) CMD (/usr/bin/nice -n20 /usr/local/sbin/expiretable -v -t 3600 sshlockout)
            05-01-2014	18:00:04	Cron.Info	172.16.1.1	May  1 18:00:00 /usr/sbin/cron[31414]: (root) CMD (/usr/bin/nice -n20 /usr/local/sbin/expiretable -v -t 3600 virusprot)
            05-01-2014	18:00:04	Cron.Info	172.16.1.1	May  1 18:00:00 /usr/sbin/cron[31192]: (root) CMD (/usr/local/bin/php -q /usr/local/www/pfblocker.php cron)
            05-01-2014	17:47:22	Local7.Info	172.16.1.1	May  1 17:47:18 dhcpd: DHCPACK on 172.16.1.14 to f8:f1:b6:ad:4a:a0 (android-b51578e06c580150) via re1
            05-01-2014	17:47:22	Local7.Info	172.16.1.1	May  1 17:47:18 dhcpd: DHCPREQUEST for 172.16.1.14 from f8:f1:b6:ad:4a:a0 (android-b51578e06c580150) via re1</null>
            

            Regards,

            xtropx

            1 Reply Last reply Reply Quote 0
            • stephenw10S
              stephenw10 Netgate Administrator
              last edited by

              I would suggest that DD-WRT is simply not catching the interruption in service. The connection comes back up in ~1min so there's a good chance you simply don't notice.

              You could try disabling apinger for the WAN which will probably put you on par with DD-WRT but, as Chris said, it looks like your cable service is going down.

              Go to System: Routing: Gateways:
              Edit the wan gateway, check 'disable gateway monitoring'.

              Steve

              1 Reply Last reply Reply Quote 0
              • First post
                Last post
              Copyright 2025 Rubicon Communications LLC (Netgate). All rights reserved.