(DHCP)WAN IP gets dropped and has to be manually renewed



  • Problem:
    Somehow, every couple of days my home pfSense box won't automatically renew it's WAN IP. For example this morning I woke up and found that there was no IP assigned to the WAN. I had to login to pfSense and click "renew" which then re-established the DHCP reserved address and continued working. I'm not sure why or how the address is dropped and why pfSense doesn't automatically renew?

    My Environment
    2.1.5-RELEASE (amd64) built on Mon Aug 25 07:44:45 EDT 2014
    FreeBSD 8.3-RELEASE-p16

    Sadly i'm stuck with my cable providers "all-in-one" box that performs it's own NATing. The pfSense box is directly connected via Ethernet as a reserved DHCP client with address of "192.168.200.2", while my internal network (LAN side) has 192.168.2.1

    [Internet]  <-> 64.233.xxx.xxx [Cable Box] 192.168.200.1 <-> 192.168.200.2 [pfSense] 192.168.2.1  <-> 192.168.2.46 [Workstation]

    pfSense box
    WAN: (DHCP client) 192.168.200.2 [reserved address in the cable box]
    LAN: (static) 192.168.2.1

    System Logs:
    Sep 18 03:57:15 check_reload_status: Linkup starting em1
    Sep 18 03:57:15 kernel: em1: link state changed to DOWN
    Sep 18 03:57:17 php: rc.linkup: DEVD Ethernet detached event for wan
    Sep 18 03:57:18 check_reload_status: Linkup starting em1
    Sep 18 03:57:18 kernel: em1: link state changed to UP
    Sep 18 03:57:18 php: rc.linkup: Clearing states to old gateway 192.168.200.1.
    Sep 18 03:57:20 php: rc.linkup: DEVD Ethernet attached event for wan
    Sep 18 03:57:20 php: rc.linkup: HOTPLUG: Configuring interface wan
    Sep 18 03:57:34 check_reload_status: updating dyndns WANGW
    Sep 18 03:57:34 check_reload_status: Restarting ipsec tunnels
    Sep 18 03:57:34 check_reload_status: Restarting OpenVPN tunnels/interfaces
    Sep 18 03:57:34 check_reload_status: Reloading filter
    Sep 18 03:57:38 php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan).
    Sep 18 03:57:38 php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan).
    Sep 18 03:57:38 php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan).
    Sep 18 03:57:38 php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan).
    Sep 18 03:58:30 check_reload_status: Linkup starting em1
    Sep 18 03:58:30 kernel: em1: link state changed to DOWN
    Sep 18 03:58:32 php: rc.linkup: DEVD Ethernet detached event for wan
    Sep 18 03:58:32 php: rc.linkup: The command '/sbin/dhclient -c /var/etc/dhclient_wan.conf em1 > /tmp/em1_output 2> /tmp/em1_error_output' returned exit code '15', the output was ''
    Sep 18 03:58:32 php: rc.linkup: ROUTING: setting default route to 192.168.200.1
    Sep 18 03:58:33 check_reload_status: Linkup starting em1
    Sep 18 03:58:33 kernel: em1: link state changed to UP
    Sep 18 03:58:33 php: rc.linkup: Clearing states to old gateway 192.168.200.1.
    Sep 18 03:58:35 php: rc.linkup: DEVD Ethernet attached event for wan
    Sep 18 03:58:35 php: rc.linkup: HOTPLUG: Configuring interface wan
    Sep 18 03:58:36 php: rc.linkup: The command '/sbin/dhclient -c /var/etc/dhclient_wan.conf em1 > /tmp/em1_output 2> /tmp/em1_error_output' returned exit code '1', the output was ''
    Sep 18 03:58:36 php: rc.linkup: ROUTING: setting default route to 192.168.200.1
    Sep 18 03:58:36 php: rc.linkup: The command '/sbin/route change -inet default '192.168.200.1'' returned exit code '1', the output was 'route: writing to routing socket: No such process route: writing to routing socket: Network is unreachable change net default: gateway 192.168.200.1: Network is unreachable'
    Sep 18 03:58:37 check_reload_status: updating dyndns wan
    Sep 18 03:58:40 check_reload_status: updating dyndns wan
    Sep 18 08:05:54 php: /index.php: Successful login for user 'admin' from: 192.168.2.46
    Sep 18 08:05:54 php: /index.php: Successful login for user 'admin' from: 192.168.2.46
    Sep 18 08:07:46 check_reload_status: rc.newwanip starting em1
    Sep 18 08:07:49 php: rc.newwanip: rc.newwanip: Informational is starting em1.
    Sep 18 08:07:49 php: rc.newwanip: rc.newwanip: on (IP address: 192.168.200.2) (interface: WAN[wan]) (real interface: em1).
    Sep 18 08:07:49 php: rc.newwanip: ROUTING: setting default route to 192.168.200.1
    Sep 18 08:07:54 php: rc.newwanip: Resyncing OpenVPN instances for interface WAN.
    Sep 18 08:07:54 php: rc.newwanip: Creating rrd update script
    Sep 18 08:07:56 php: rc.newwanip: pfSense package system has detected an ip change 192.168.200.2 -> 192.168.200.2 … Restarting packages.
    Sep 18 08:07:56 check_reload_status: Starting packages
    Sep 18 08:07:56 check_reload_status: Reloading filter
    Sep 18 08:07:57 check_reload_status: updating dyndns WANGW
    Sep 18 08:07:57 check_reload_status: Restarting ipsec tunnels
    Sep 18 08:07:57 check_reload_status: Restarting OpenVPN tunnels/interfaces
    Sep 18 08:07:57 check_reload_status: Reloading filter
    Sep 18 08:07:59 php: rc.start_packages: Restarting/Starting all packages.

    DHCP Logs
    Sep 18 02:55:05 firewall dhcpd: DHCPINFORM from 192.168.2.46 via em0
    Sep 18 02:55:05 firewall dhcpd: DHCPACK to 192.168.2.46 (e0:3f:49:8f:b2:66) via em0
    Sep 18 03:00:53 firewall dhcpd: Wrote 0 deleted host decls to leases file.
    Sep 18 03:00:53 firewall dhcpd: Wrote 0 new dynamic host decls to leases file.
    Sep 18 03:00:53 firewall dhcpd: Wrote 13 leases to leases file.
    Sep 18 03:00:53 firewall dhcpd: DHCPREQUEST for 192.168.2.50 from cc:3a:61:71:28:91 (android) via em0
    Sep 18 03:00:53 firewall dhcpd: DHCPACK on 192.168.2.50 to cc:3a:61:71:28:91 (android) via em0
    Sep 18 03:07:47 firewall dhcpd: DHCPREQUEST for 192.168.2.119 from 2c:59:e5:b3:5f:a0 via em0
    Sep 18 03:07:47 firewall dhcpd: DHCPACK on 192.168.2.119 to 2c:59:e5:b3:5f:a0 via em0
    Sep 18 03:11:51 firewall dhcpd: DHCPREQUEST for 192.168.2.115 from 00:0c:29:bc:62:7d via em0
    Sep 18 03:11:51 firewall dhcpd: DHCPACK on 192.168.2.115 to 00:0c:29:bc:62:7d via em0
    Sep 18 03:15:36 firewall dhcpd: DHCPREQUEST for 192.168.2.58 (192.168.2.1) from 00:0d:4b:4f:0a:85 (tablet) via em0
    Sep 18 03:15:36 firewall dhcpd: DHCPACK on 192.168.2.58 to 00:0d:4b:4f:0a:85 (tablet) via em0
    Sep 18 03:18:26 firewall dhcpd: DHCPREQUEST for 192.168.2.46 from e0:3f:49:8f:b2:66 (Workstation) via em0
    Sep 18 03:18:26 firewall dhcpd: DHCPACK on 192.168.2.46 to e0:3f:49:8f:b2:66 (Workstation) via em0
    Sep 18 03:35:44 firewall dhcpd: DHCPINFORM from 192.168.2.46 via em0
    Sep 18 03:35:44 firewall dhcpd: DHCPACK to 192.168.2.46 (e0:3f:49:8f:b2:66) via em0
    Sep 18 03:36:45 firewall dhcpd: DHCPINFORM from 192.168.2.46 via em0
    Sep 18 03:36:45 firewall dhcpd: DHCPACK to 192.168.2.46 (e0:3f:49:8f:b2:66) via em0
    Sep 18 03:57:17 firewall dhclient[7038]: connection closed
    Sep 18 03:57:17 firewall dhclient[7038]: exiting.
    Sep 18 03:57:20 firewall dhclient: PREINIT
    Sep 18 03:57:20 firewall dhclient: Starting delete_old_states()
    Sep 18 03:57:20 firewall dhclient: Comparing IPs: Old: 192.168.200.2 New:
    Sep 18 03:57:20 firewall dhclient: Removing states from old IP '192.168.200.2' (new IP '')
    Sep 18 03:57:20 firewall dhclient[76046]: DHCPREQUEST on em1 to 255.255.255.255 port 67
    Sep 18 03:57:22 firewall dhclient[76046]: DHCPREQUEST on em1 to 255.255.255.255 port 67
    Sep 18 03:57:26 firewall dhclient[76046]: DHCPREQUEST on em1 to 255.255.255.255 port 67
    Sep 18 03:57:31 firewall dhclient[76046]: DHCPDISCOVER on em1 to 255.255.255.255 port 67 interval 1
    Sep 18 03:57:32 firewall dhclient[76046]: DHCPDISCOVER on em1 to 255.255.255.255 port 67 interval 1
    Sep 18 03:57:33 firewall dhclient[76046]: DHCPDISCOVER on em1 to 255.255.255.255 port 67 interval 2
    Sep 18 03:57:35 firewall dhclient[76046]: DHCPDISCOVER on em1 to 255.255.255.255 port 67 interval 3
    Sep 18 03:57:38 firewall dhclient[76046]: DHCPDISCOVER on em1 to 255.255.255.255 port 67 interval 8
    Sep 18 03:57:46 firewall dhclient[76046]: DHCPDISCOVER on em1 to 255.255.255.255 port 67 interval 15
    Sep 18 03:58:01 firewall dhclient[76046]: DHCPDISCOVER on em1 to 255.255.255.255 port 67 interval 20
    Sep 18 03:58:21 firewall dhclient[76046]: DHCPDISCOVER on em1 to 255.255.255.255 port 67 interval 11
    Sep 18 03:58:32 firewall dhclient[76046]: No DHCPOFFERS received.
    Sep 18 03:58:32 firewall dhclient[76046]: Trying recorded lease 192.168.200.2
    Sep 18 03:58:32 firewall dhclient: TIMEOUT
    Sep 18 03:58:32 firewall dhclient: Starting add_new_address()
    Sep 18 03:58:32 firewall dhclient: ifconfig em1 inet 192.168.200.2 netmask 255.255.255.0 broadcast 192.168.200.255
    Sep 18 03:58:32 firewall dhclient: New IP Address (em1): 192.168.200.2
    Sep 18 03:58:32 firewall dhclient: New Subnet Mask (em1): 255.255.255.0
    Sep 18 03:58:32 firewall dhclient: New Broadcast Address (em1): 192.168.200.255
    Sep 18 03:58:32 firewall dhclient: New Routers (em1): 192.168.200.1
    Sep 18 03:58:33 firewall dhclient: New Routers (em1): 192.168.200.1
    Sep 18 03:58:36 firewall dhclient[3834]: dhclient already running, pid: 76046.
    Sep 18 03:58:36 firewall dhclient[3834]: exiting.
    Sep 18 03:58:36 firewall dhcpd: Received signal 15, initiating shutdown.
    Sep 18 03:58:36 firewall dhcpd: Disabling output on BPF/em0/00:22:4d:b1:4a:22/192.168.2.0/24
    Sep 18 03:58:36 firewall dhcpd: Disabling input on BPF/em0/00:22:4d:b1:4a:22/192.168.2.0/24
    Sep 18 03:58:37 firewall dhcpd: Internet Systems Consortium DHCP Server 4.2.6
    Sep 18 03:58:37 firewall dhcpd: Copyright 2004-2014 Internet Systems Consortium.
    Sep 18 03:58:37 firewall dhcpd: All rights reserved.
    Sep 18 03:58:37 firewall dhcpd: For info, please visit https://www.isc.org/software/dhcp/
    Sep 18 03:58:37 firewall dhcpd: Internet Systems Consortium DHCP Server 4.2.6
    Sep 18 03:58:37 firewall dhcpd: Copyright 2004-2014 Internet Systems Consortium.
    Sep 18 03:58:37 firewall dhcpd: All rights reserved.
    Sep 18 03:58:37 firewall dhcpd: For info, please visit https://www.isc.org/software/dhcp/
    Sep 18 03:58:37 firewall dhcpd: Wrote 0 deleted host decls to leases file.
    Sep 18 03:58:37 firewall dhcpd: Wrote 0 new dynamic host decls to leases file.
    Sep 18 03:58:37 firewall dhcpd: Wrote 13 leases to leases file.
    Sep 18 03:58:37 firewall dhcpd: Listening on BPF/em0/00:22:4d:b1:4a:22/192.168.2.0/24
    Sep 18 03:58:37 firewall dhcpd: Sending on  BPF/em0/00:22:4d:b1:4a:22/192.168.2.0/24
    Sep 18 03:58:37 firewall dhcpd: Sending on  Socket/fallback/fallback-net
    Sep 18 03:58:39 firewall dhcpd: DHCPREQUEST for 192.168.2.50 from cc:3a:61:71:28:91 (android) via em0
    Sep 18 03:58:39 firewall dhcpd: DHCPACK on 192.168.2.50 to cc:3a:61:71:28:91 (android) via em0
    Sep 18 03:58:39 firewall dhcpd: Received signal 15, initiating shutdown.
    Sep 18 03:58:39 firewall dhcpd: Disabling output on BPF/em0/00:22:4d:b1:4a:22/192.168.2.0/24
    Sep 18 03:58:39 firewall dhcpd: Disabling input on BPF/em0/00:22:4d:b1:4a:22/192.168.2.0/24
    Sep 18 03:58:40 firewall dhcpd: Internet Systems Consortium DHCP Server 4.2.6
    Sep 18 03:58:40 firewall dhcpd: Copyright 2004-2014 Internet Systems Consortium.
    Sep 18 03:58:40 firewall dhcpd: All rights reserved.
    Sep 18 03:58:40 firewall dhcpd: For info, please visit https://www.isc.org/software/dhcp/
    Sep 18 03:58:40 firewall dhcpd: Internet Systems Consortium DHCP Server 4.2.6
    Sep 18 03:58:40 firewall dhcpd: Copyright 2004-2014 Internet Systems Consortium.
    Sep 18 03:58:40 firewall dhcpd: All rights reserved.
    Sep 18 03:58:40 firewall dhcpd: For info, please visit https://www.isc.org/software/dhcp/
    Sep 18 03:58:40 firewall dhcpd: Wrote 0 deleted host decls to leases file.
    Sep 18 03:58:40 firewall dhcpd: Wrote 0 new dynamic host decls to leases file.
    Sep 18 03:58:40 firewall dhcpd: Wrote 13 leases to leases file.
    Sep 18 03:58:40 firewall dhcpd: Listening on BPF/em0/00:22:4d:b1:4a:22/192.168.2.0/24
    Sep 18 03:58:40 firewall dhcpd: Sending on  BPF/em0/00:22:4d:b1:4a:22/192.168.2.0/24
    Sep 18 03:58:40 firewall dhcpd: Sending on  Socket/fallback/fallback-net
    Sep 18 03:58:45 firewall dhclient: Starting delete_old_states()
    Sep 18 03:58:45 firewall dhclient: Comparing IPs: Old: 192.168.200.2 New: 192.168.200.2
    Sep 18 03:58:45 firewall dhclient: Deleting old routes
    Sep 18 03:58:45 firewall dhclient[76121]: short write: wanted 20 got 0 bytes
    Sep 18 03:58:45 firewall dhclient[76121]: exiting.
    Sep 18 04:04:35 firewall dhcpd: DHCPREQUEST for 192.168.2.115 from 00:0c:29:bc:62:7d via em0
    Sep 18 04:04:35 firewall dhcpd: DHCPACK on 192.168.2.115 to 00:0c:29:bc:62:7d via em0
    Sep 18 04:07:47 firewall dhcpd: DHCPREQUEST for 192.168.2.119 from 2c:59:e5:b3:5f:a0 via em0
    Sep 18 04:07:47 firewall dhcpd: DHCPACK on 192.168.2.119 to 2c:59:e5:b3:5f:a0 via em0
    Sep 18 04:10:08 firewall dhcpd: DHCPINFORM from 192.168.2.46 via em0
    Sep 18 04:10:08 firewall dhcpd: DHCPACK to 192.168.2.46 (e0:3f:49:8f:b2:66) via em0
    Sep 18 04:15:36 firewall dhcpd: DHCPREQUEST for 192.168.2.58 (192.168.2.1) from 00:0d:4b:4f:0a:85 (tablet) via em0
    Sep 18 04:15:36 firewall dhcpd: DHCPACK on 192.168.2.58 to 00:0d:4b:4f:0a:85 (tablet) via em0
    Sep 18 04:18:26 firewall dhcpd: DHCPREQUEST for 192.168.2.46 from e0:3f:49:8f:b2:66 (Workstation) via em0
    Sep 18 04:18:26 firewall dhcpd: DHCPACK on 192.168.2.46 to e0:3f:49:8f:b2:66 (Workstation) via em0
    Sep 18 04:25:13 firewall dhcpd: DHCPINFORM from 192.168.2.46 via em0
    Sep 18 04:25:13 firewall dhcpd: DHCPACK to 192.168.2.46 (e0:3f:49:8f:b2:66) via em0
    Sep 18 04:40:22 firewall dhcpd: DHCPINFORM from 192.168.2.46 via em0
    Sep 18 04:40:22 firewall dhcpd: DHCPACK to 192.168.2.46 (e0:3f:49:8f:b2:66) via em0
    Sep 18 04:55:37 firewall dhcpd: DHCPINFORM from 192.168.2.46 via em0
    Sep 18 04:55:37 firewall dhcpd: DHCPACK to 192.168.2.46 (e0:3f:49:8f:b2:66) via em0
    Sep 18 04:56:16 firewall dhcpd: DHCPREQUEST for 192.168.2.50 from cc:3a:61:71:28:91 (android) via em0
    Sep 18 04:56:16 firewall dhcpd: DHCPACK on 192.168.2.50 to cc:3a:61:71:28:91 (android) via em0
    Sep 18 05:00:17 firewall dhcpd: DHCPREQUEST for 192.168.2.115 from 00:0c:29:bc:62:7d via em0
    Sep 18 05:00:17 firewall dhcpd: DHCPACK on 192.168.2.115 to 00:0c:29:bc:62:7d via em0
    Sep 18 05:07:47 firewall dhcpd: DHCPREQUEST for 192.168.2.119 from 2c:59:e5:b3:5f:a0 via em0
    Sep 18 05:07:47 firewall dhcpd: DHCPACK on 192.168.2.119 to 2c:59:e5:b3:5f:a0 via em0
    Sep 18 05:10:56 firewall dhcpd: DHCPINFORM from 192.168.2.46 via em0
    Sep 18 05:10:56 firewall dhcpd: DHCPACK to 192.168.2.46 (e0:3f:49:8f:b2:66) via em0
    Sep 18 05:15:35 firewall dhcpd: Wrote 0 deleted host decls to leases file.
    Sep 18 05:15:35 firewall dhcpd: Wrote 0 new dynamic host decls to leases file.
    Sep 18 05:15:35 firewall dhcpd: Wrote 13 leases to leases file.
    Sep 18 05:15:35 firewall dhcpd: DHCPREQUEST for 192.168.2.58 (192.168.2.1) from 00:0d:4b:4f:0a:85 (tablet) via em0
    Sep 18 05:15:35 firewall dhcpd: DHCPACK on 192.168.2.58 to 00:0d:4b:4f:0a:85 (tablet) via em0
    Sep 18 05:18:26 firewall dhcpd: DHCPREQUEST for 192.168.2.46 from e0:3f:49:8f:b2:66 (Workstation) via em0
    Sep 18 05:18:26 firewall dhcpd: DHCPACK on 192.168.2.46 to e0:3f:49:8f:b2:66 (Workstation) via em0
    Sep 18 05:26:20 firewall dhcpd: DHCPINFORM from 192.168.2.46 via em0
    Sep 18 05:26:20 firewall dhcpd: DHCPACK to 192.168.2.46 (e0:3f:49:8f:b2:66) via em0
    Sep 18 05:41:49 firewall dhcpd: DHCPINFORM from 192.168.2.46 via em0
    Sep 18 05:41:49 firewall dhcpd: DHCPACK to 192.168.2.46 (e0:3f:49:8f:b2:66) via em0
    Sep 18 05:48:57 firewall dhcpd: DHCPINFORM from 192.168.2.46 via em0
    Sep 18 05:48:57 firewall dhcpd: DHCPACK to 192.168.2.46 (e0:3f:49:8f:b2:66) via em0
    Sep 18 05:50:00 firewall dhcpd: DHCPINFORM from 192.168.2.46 via em0
    Sep 18 05:50:00 firewall dhcpd: DHCPACK to 192.168.2.46 (e0:3f:49:8f:b2:66) via em0
    Sep 18 05:51:01 firewall dhcpd: DHCPINFORM from 192.168.2.46 via em0
    Sep 18 05:51:01 firewall dhcpd: DHCPACK to 192.168.2.46 (e0:3f:49:8f:b2:66) via em0
    Sep 18 05:52:53 firewall dhcpd: DHCPREQUEST for 192.168.2.115 from 00:0c:29:bc:62:7d via em0
    Sep 18 05:52:53 firewall dhcpd: DHCPACK on 192.168.2.115 to 00:0c:29:bc:62:7d via em0
    Sep 18 05:53:53 firewall dhcpd: DHCPREQUEST for 192.168.2.50 from cc:3a:61:71:28:91 (android) via em0
    Sep 18 05:53:53 firewall dhcpd: DHCPACK on 192.168.2.50 to cc:3a:61:71:28:91 (android) via em0
    Sep 18 05:55:38 firewall dhcpd: DHCPINFORM from 192.168.2.46 via em0
    Sep 18 05:55:38 firewall dhcpd: DHCPACK to 192.168.2.46 (e0:3f:49:8f:b2:66) via em0
    Sep 18 05:57:23 firewall dhcpd: DHCPINFORM from 192.168.2.46 via em0
    Sep 18 05:57:23 firewall dhcpd: DHCPACK to 192.168.2.46 (e0:3f:49:8f:b2:66) via em0
    Sep 18 06:07:48 firewall dhcpd: DHCPREQUEST for 192.168.2.119 from 2c:59:e5:b3:5f:a0 via em0
    Sep 18 06:07:48 firewall dhcpd: DHCPACK on 192.168.2.119 to 2c:59:e5:b3:5f:a0 via em0
    Sep 18 06:13:01 firewall dhcpd: DHCPINFORM from 192.168.2.46 via em0
    Sep 18 06:13:01 firewall dhcpd: DHCPACK to 192.168.2.46 (e0:3f:49:8f:b2:66) via em0
    Sep 18 06:15:35 firewall dhcpd: DHCPREQUEST for 192.168.2.58 (192.168.2.1) from 00:0d:4b:4f:0a:85 (tablet) via em0
    Sep 18 06:15:35 firewall dhcpd: DHCPACK on 192.168.2.58 to 00:0d:4b:4f:0a:85 (tablet) via em0
    Sep 18 06:18:26 firewall dhcpd: Wrote 0 deleted host decls to leases file.
    Sep 18 06:18:26 firewall dhcpd: Wrote 0 new dynamic host decls to leases file.
    Sep 18 06:18:26 firewall dhcpd: Wrote 13 leases to leases file.
    Sep 18 06:18:26 firewall dhcpd: DHCPREQUEST for 192.168.2.46 from e0:3f:49:8f:b2:66 (Workstation) via em0
    Sep 18 06:18:26 firewall dhcpd: DHCPACK on 192.168.2.46 to e0:3f:49:8f:b2:66 (Workstation) via em0
    Sep 18 06:28:44 firewall dhcpd: DHCPINFORM from 192.168.2.46 via em0
    Sep 18 06:28:44 firewall dhcpd: DHCPACK to 192.168.2.46 (e0:3f:49:8f:b2:66) via em0
    Sep 18 06:44:33 firewall dhcpd: DHCPINFORM from 192.168.2.46 via em0
    Sep 18 06:44:33 firewall dhcpd: DHCPACK to 192.168.2.46 (e0:3f:49:8f:b2:66) via em0
    Sep 18 06:45:36 firewall dhcpd: DHCPREQUEST for 192.168.2.115 from 00:0c:29:bc:62:7d via em0
    Sep 18 06:45:36 firewall dhcpd: DHCPACK on 192.168.2.115 to 00:0c:29:bc:62:7d via em0
    Sep 18 06:51:30 firewall dhcpd: DHCPREQUEST for 192.168.2.50 from cc:3a:61:71:28:91 (android) via em0
    Sep 18 06:51:30 firewall dhcpd: DHCPACK on 192.168.2.50 to cc:3a:61:71:28:91 (android) via em0
    Sep 18 07:00:26 firewall dhcpd: DHCPINFORM from 192.168.2.46 via em0
    Sep 18 07:00:26 firewall dhcpd: DHCPACK to 192.168.2.46 (e0:3f:49:8f:b2:66) via em0
    Sep 18 07:07:48 firewall dhcpd: DHCPREQUEST for 192.168.2.119 from 2c:59:e5:b3:5f:a0 via em0
    Sep 18 07:07:48 firewall dhcpd: DHCPACK on 192.168.2.119 to 2c:59:e5:b3:5f:a0 via em0
    Sep 18 07:15:35 firewall dhcpd: DHCPREQUEST for 192.168.2.58 (192.168.2.1) from 00:0d:4b:4f:0a:85 (tablet) via em0
    Sep 18 07:15:35 firewall dhcpd: DHCPACK on 192.168.2.58 to 00:0d:4b:4f:0a:85 (tablet) via em0
    Sep 18 07:16:23 firewall dhcpd: DHCPINFORM from 192.168.2.46 via em0
    Sep 18 07:16:23 firewall dhcpd: DHCPACK to 192.168.2.46 (e0:3f:49:8f:b2:66) via em0
    Sep 18 07:18:26 firewall dhcpd: DHCPREQUEST for 192.168.2.46 from e0:3f:49:8f:b2:66 (Workstation) via em0
    Sep 18 07:18:26 firewall dhcpd: DHCPACK on 192.168.2.46 to e0:3f:49:8f:b2:66 (Workstation) via em0
    Sep 18 07:31:00 firewall dhcpd: DHCPREQUEST for 192.168.2.115 from 00:0c:29:bc:62:7d via em0
    Sep 18 07:31:00 firewall dhcpd: DHCPACK on 192.168.2.115 to 00:0c:29:bc:62:7d via em0
    Sep 18 07:32:26 firewall dhcpd: DHCPINFORM from 192.168.2.46 via em0
    Sep 18 07:32:26 firewall dhcpd: DHCPACK to 192.168.2.46 (e0:3f:49:8f:b2:66) via em0
    Sep 18 07:33:28 firewall dhcpd: DHCPINFORM from 192.168.2.46 via em0
    Sep 18 07:33:28 firewall dhcpd: DHCPACK to 192.168.2.46 (e0:3f:49:8f:b2:66) via em0
    Sep 18 07:48:33 firewall dhcpd: DHCPINFORM from 192.168.2.46 via em0
    Sep 18 07:48:33 firewall dhcpd: DHCPACK to 192.168.2.46 (e0:3f:49:8f:b2:66) via em0
    Sep 18 07:49:06 firewall dhcpd: Wrote 0 deleted host decls to leases file.
    Sep 18 07:49:06 firewall dhcpd: Wrote 0 new dynamic host decls to leases file.
    Sep 18 07:49:06 firewall dhcpd: Wrote 13 leases to leases file.
    Sep 18 07:49:06 firewall dhcpd: DHCPREQUEST for 192.168.2.50 from cc:3a:61:71:28:91 (android) via em0
    Sep 18 07:49:06 firewall dhcpd: DHCPACK on 192.168.2.50 to cc:3a:61:71:28:91 (android) via em0
    Sep 18 07:49:36 firewall dhcpd: DHCPINFORM from 192.168.2.46 via em0
    Sep 18 07:49:36 firewall dhcpd: DHCPACK to 192.168.2.46 (e0:3f:49:8f:b2:66) via em0
    Sep 18 07:53:17 firewall dhcpd: DHCPREQUEST for 192.168.2.41 from f8:1e:df:ea:1e:c0 (macbook) via em0
    Sep 18 07:53:17 firewall dhcpd: DHCPACK on 192.168.2.41 to f8:1e:df:ea:1e:c0 (macbook) via em0
    Sep 18 08:02:26 firewall dhcpd: DHCPREQUEST for 192.168.2.41 from f8:1e:df:ea:1e:c0 (macbook) via em0
    Sep 18 08:02:26 firewall dhcpd: DHCPACK on 192.168.2.41 to f8:1e:df:ea:1e:c0 (macbook) via em0
    Sep 18 08:04:45 firewall dhcpd: DHCPINFORM from 192.168.2.46 via em0
    Sep 18 08:04:45 firewall dhcpd: DHCPACK to 192.168.2.46 (e0:3f:49:8f:b2:66) via em0
    Sep 18 08:05:48 firewall dhcpd: DHCPINFORM from 192.168.2.46 via em0
    Sep 18 08:05:48 firewall dhcpd: DHCPACK to 192.168.2.46 (e0:3f:49:8f:b2:66) via em0
    Sep 18 08:07:14 firewall dhcpd: DHCPINFORM from 192.168.2.46 via em0
    Sep 18 08:07:14 firewall dhcpd: DHCPACK to 192.168.2.46 (e0:3f:49:8f:b2:66) via em0
    Sep 18 08:07:45 firewall dhclient: PREINIT
    Sep 18 08:07:45 firewall dhclient: Starting delete_old_states()
    Sep 18 08:07:45 firewall dhclient: Comparing IPs: Old: 192.168.200.2 New:
    Sep 18 08:07:45 firewall dhclient: Removing states from old IP '192.168.200.2' (new IP '')
    Sep 18 08:07:45 firewall dhclient[6164]: DHCPREQUEST on em1 to 255.255.255.255 port 67
    Sep 18 08:07:46 firewall dhclient[6164]: DHCPACK from 192.168.200.1
    Sep 18 08:07:46 firewall dhclient: REBOOT
    Sep 18 08:07:46 firewall dhclient: Starting delete_old_states()
    Sep 18 08:07:46 firewall dhclient: Comparing IPs: Old: 192.168.200.2 New: 192.168.200.2
    Sep 18 08:07:46 firewall dhclient: Starting add_new_address()
    Sep 18 08:07:46 firewall dhclient: ifconfig em1 inet 192.168.200.2 netmask 255.255.255.0 broadcast 192.168.200.255
    Sep 18 08:07:46 firewall dhclient: New IP Address (em1): 192.168.200.2
    Sep 18 08:07:46 firewall dhclient: New Subnet Mask (em1): 255.255.255.0
    Sep 18 08:07:46 firewall dhclient: New Broadcast Address (em1): 192.168.200.255
    Sep 18 08:07:46 firewall dhclient: New Routers (em1): 192.168.200.1
    Sep 18 08:07:46 firewall dhclient: Adding new routes to interface: em1
    Sep 18 08:07:46 firewall dhclient: /sbin/route add default 192.168.200.1
    Sep 18 08:07:46 firewall dhclient: Creating resolv.conf
    Sep 18 08:07:46 firewall dhclient[6164]: bound to 192.168.200.2 – renewal in 604800 seconds.
    Sep 18 08:07:48 firewall dhcpd: DHCPREQUEST for 192.168.2.119 from 2c:59:e5:b3:5f:a0 via em0
    Sep 18 08:07:48 firewall dhcpd: DHCPACK on 192.168.2.119 to 2c:59:e5:b3:5f:a0 via em0
    Sep 18 08:12:20 firewall dhcpd: DHCPINFORM from 192.168.2.46 via em0
    Sep 18 08:12:20 firewall dhcpd: DHCPACK to 192.168.2.46 (e0:3f:49:8f:b2:66) via em0
    Sep 18 08:12:32 firewall dhcpd: DHCPREQUEST for 192.168.2.45 from 0c:3e:9f:3e:1a:82 (iPhone) via em0
    Sep 18 08:12:32 firewall dhcpd: DHCPACK on 192.168.2.45 to 0c:3e:9f:3e:1a:82 (iPhone) via em0
    Sep 18 08:15:35 firewall dhcpd: DHCPREQUEST for 192.168.2.58 (192.168.2.1) from 00:0d:4b:4f:0a:85 (tablet) via em0
    Sep 18 08:15:35 firewall dhcpd: DHCPACK on 192.168.2.58 to 00:0d:4b:4f:0a:85 (tablet) via em0
    Sep 18 08:18:26 firewall dhcpd: DHCPREQUEST for 192.168.2.46 from e0:3f:49:8f:b2:66 (Workstation) via em0
    Sep 18 08:18:26 firewall dhcpd: DHCPACK on 192.168.2.46 to e0:3f:49:8f:b2:66 (Workstation) via em0
    Sep 18 08:21:02 firewall dhcpd: DHCPINFORM from 192.168.2.46 via em0
    Sep 18 08:21:02 firewall dhcpd: DHCPACK to 192.168.2.46 (e0:3f:49:8f:b2:66) via em0
    Sep 18 08:22:30 firewall dhcpd: DHCPREQUEST for 192.168.2.45 from 0c:3e:9f:3e:1a:82 (iPhone) via em0
    Sep 18 08:22:30 firewall dhcpd: DHCPACK on 192.168.2.45 to 0c:3e:9f:3e:1a:82 (iPhone) via em0
    Sep 18 08:22:30 firewall dhcpd: DHCPREQUEST for 192.168.2.45 from 0c:3e:9f:3e:1a:82 (iPhone) via em0
    Sep 18 08:22:30 firewall dhcpd: DHCPACK on 192.168.2.45 to 0c:3e:9f:3e:1a:82 (iPhone) via em0
    Sep 18 08:25:57 firewall dhcpd: DHCPREQUEST for 192.168.2.115 from 00:0c:29:bc:62:7d via em0
    Sep 18 08:25:57 firewall dhcpd: DHCPACK on 192.168.2.115 to 00:0c:29:bc:62:7d via em0
    Sep 18 08:31:52 firewall dhcpd: DHCPINFORM from 192.168.2.46 via em0
    Sep 18 08:31:52 firewall dhcpd: DHCPACK to 192.168.2.46 (e0:3f:49:8f:b2:66) via em0
    Sep 18 08:33:17 firewall dhcpd: DHCPINFORM from 192.168.2.46 via em0
    Sep 18 08:33:17 firewall dhcpd: DHCPACK to 192.168.2.46 (e0:3f:49:8f:b2:66) via em0
    Sep 18 08:43:19 firewall dhcpd: DHCPINFORM from 192.168.2.46 via em0
    Sep 18 08:43:19 firewall dhcpd: DHCPACK to 192.168.2.46 (e0:3f:49:8f:b2:66) via em0
    Sep 18 08:53:21 firewall dhcpd: DHCPINFORM from 192.168.2.46 via em0
    Sep 18 08:53:21 firewall dhcpd: DHCPACK to 192.168.2.46 (e0:3f:49:8f:b2:66) via em0
    Sep 18 09:03:24 firewall dhcpd: DHCPINFORM from 192.168.2.46 via em0
    Sep 18 09:03:24 firewall dhcpd: DHCPACK to 192.168.2.46 (e0:3f:49:8f:b2:66) via em0
    Sep 18 09:07:48 firewall dhcpd: DHCPREQUEST for 192.168.2.119 from 2c:59:e5:b3:5f:a0 via em0
    Sep 18 09:07:48 firewall dhcpd: DHCPACK on 192.168.2.119 to 2c:59:e5:b3:5f:a0 via em0
    Sep 18 09:13:26 firewall dhcpd: DHCPINFORM from 192.168.2.46 via em0
    Sep 18 09:13:26 firewall dhcpd: DHCPACK to 192.168.2.46 (e0:3f:49:8f:b2:66) via em0
    Sep 18 09:15:35 firewall dhcpd: Wrote 0 deleted host decls to leases file.
    Sep 18 09:15:35 firewall dhcpd: Wrote 0 new dynamic host decls to leases file.
    Sep 18 09:15:35 firewall dhcpd: Wrote 13 leases to leases file.



  • Happened again today  :'(. Woke up around 8:00am today and found that the WAN IP address was dropped (LAN access works fine).
    I had to login to pfSense and click "Renew".. Once I did that the WAN IP was re-established.
    The odd part was on my windows workstation, I had to do a "ipconfig /release" & "ipconfig /renew" in order to get out to the internet (despite the IP/GW/Route not changing)

    Looking at the logs on pfSense, it seemed to occur around 3:00am again, exactly 7 days from the last time. Makes me think there is an issue with the DHCP on WAN?

    DHCP Log (with some Request/ACK removed)
    Sep 25 03:16:12 firewall dhclient[9859]: connection closed
    Sep 25 03:16:12 firewall dhclient[9859]: exiting.
    Sep 25 03:16:14 firewall dhclient: PREINIT
    Sep 25 03:16:14 firewall dhclient: Starting delete_old_states()
    Sep 25 03:16:14 firewall dhclient: Comparing IPs: Old: 192.168.200.2 New:
    Sep 25 03:16:14 firewall dhclient: Removing states from old IP '192.168.200.2' (new IP '')
    Sep 25 03:16:14 firewall dhclient[38569]: DHCPREQUEST on em1 to 255.255.255.255 port 67
    Sep 25 03:16:15 firewall dhclient[38569]: DHCPREQUEST on em1 to 255.255.255.255 port 67
    Sep 25 03:16:17 firewall dhclient[38569]: DHCPREQUEST on em1 to 255.255.255.255 port 67
    Sep 25 03:16:19 firewall dhclient[38569]: DHCPREQUEST on em1 to 255.255.255.255 port 67
    Sep 25 03:16:21 firewall dhclient[38569]: DHCPREQUEST on em1 to 255.255.255.255 port 67
    Sep 25 03:16:26 firewall dhclient[38569]: DHCPDISCOVER on em1 to 255.255.255.255 port 67 interval 2
    Sep 25 03:16:28 firewall dhclient[38569]: DHCPDISCOVER on em1 to 255.255.255.255 port 67 interval 4
    Sep 25 03:16:32 firewall dhclient[38569]: DHCPDISCOVER on em1 to 255.255.255.255 port 67 interval 11
    Sep 25 03:16:43 firewall dhclient[38569]: DHCPDISCOVER on em1 to 255.255.255.255 port 67 interval 21
    Sep 25 03:17:04 firewall dhclient[38569]: DHCPDISCOVER on em1 to 255.255.255.255 port 67 interval 18
    Sep 25 03:17:22 firewall dhclient[38569]: DHCPDISCOVER on em1 to 255.255.255.255 port 67 interval 5
    Sep 25 03:17:27 firewall dhclient[38569]: No DHCPOFFERS received.
    Sep 25 03:17:27 firewall dhclient[38569]: Trying recorded lease 192.168.200.2
    Sep 25 03:17:27 firewall dhclient: TIMEOUT
    Sep 25 03:17:27 firewall dhclient: Starting add_new_address()
    Sep 25 03:17:27 firewall dhclient: ifconfig em1 inet 192.168.200.2 netmask 255.255.255.0 broadcast 192.168.200.255
    Sep 25 03:17:27 firewall dhclient: New IP Address (em1): 192.168.200.2
    Sep 25 03:17:27 firewall dhclient: New Subnet Mask (em1): 255.255.255.0
    Sep 25 03:17:27 firewall dhclient: New Broadcast Address (em1): 192.168.200.255
    Sep 25 03:17:27 firewall dhclient: New Routers (em1): 192.168.200.1
    Sep 25 03:17:28 firewall dhclient: New Routers (em1): 192.168.200.1
    Sep 25 03:17:30 firewall dhclient[65655]: dhclient already running, pid: 38569.
    Sep 25 03:17:30 firewall dhclient[65655]: exiting.
    Sep 25 03:17:30 firewall dhcpd: Received signal 15, initiating shutdown.
    Sep 25 03:17:30 firewall dhcpd: Disabling output on BPF/em0/00:22:4d:b1:4a:22/192.168.2.0/24
    Sep 25 03:17:30 firewall dhcpd: Disabling input on BPF/em0/00:22:4d:b1:4a:22/192.168.2.0/24
    Sep 25 03:17:31 firewall dhcpd: Internet Systems Consortium DHCP Server 4.2.6
    Sep 25 03:17:31 firewall dhcpd: Copyright 2004-2014 Internet Systems Consortium.
    Sep 25 03:17:31 firewall dhcpd: All rights reserved.
    Sep 25 03:17:31 firewall dhcpd: For info, please visit https://www.isc.org/software/dhcp/
    Sep 25 03:17:31 firewall dhcpd: Internet Systems Consortium DHCP Server 4.2.6
    Sep 25 03:17:31 firewall dhcpd: Copyright 2004-2014 Internet Systems Consortium.
    Sep 25 03:17:31 firewall dhcpd: All rights reserved.
    Sep 25 03:17:31 firewall dhcpd: For info, please visit https://www.isc.org/software/dhcp/
    Sep 25 03:17:31 firewall dhcpd: Wrote 0 deleted host decls to leases file.
    Sep 25 03:17:31 firewall dhcpd: Wrote 0 new dynamic host decls to leases file.
    Sep 25 03:17:31 firewall dhcpd: Wrote 20 leases to leases file.
    Sep 25 03:17:31 firewall dhcpd: Listening on BPF/em0/00:22:4d:b1:4a:22/192.168.2.0/24
    Sep 25 03:17:31 firewall dhcpd: Sending on  BPF/em0/00:22:4d:b1:4a:22/192.168.2.0/24
    Sep 25 03:17:31 firewall dhcpd: Sending on  Socket/fallback/fallback-net
    Sep 25 03:17:34 firewall dhcpd: Received signal 15, initiating shutdown.
    Sep 25 03:17:34 firewall dhcpd: Disabling output on BPF/em0/00:22:4d:b1:4a:22/192.168.2.0/24
    Sep 25 03:17:34 firewall dhcpd: Disabling input on BPF/em0/00:22:4d:b1:4a:22/192.168.2.0/24
    Sep 25 03:17:35 firewall dhcpd: Internet Systems Consortium DHCP Server 4.2.6
    Sep 25 03:17:35 firewall dhcpd: Copyright 2004-2014 Internet Systems Consortium.
    Sep 25 03:17:35 firewall dhcpd: All rights reserved.
    Sep 25 03:17:35 firewall dhcpd: For info, please visit https://www.isc.org/software/dhcp/
    Sep 25 03:17:35 firewall dhcpd: Internet Systems Consortium DHCP Server 4.2.6
    Sep 25 03:17:35 firewall dhcpd: Copyright 2004-2014 Internet Systems Consortium.
    Sep 25 03:17:35 firewall dhcpd: All rights reserved.
    Sep 25 03:17:35 firewall dhcpd: For info, please visit https://www.isc.org/software/dhcp/
    Sep 25 03:17:35 firewall dhcpd: Wrote 0 deleted host decls to leases file.
    Sep 25 03:17:35 firewall dhcpd: Wrote 0 new dynamic host decls to leases file.
    Sep 25 03:17:35 firewall dhcpd: Wrote 20 leases to leases file.
    Sep 25 03:17:35 firewall dhcpd: Listening on BPF/em0/00:22:4d:b1:4a:22/192.168.2.0/24
    Sep 25 03:17:35 firewall dhcpd: Sending on  BPF/em0/00:22:4d:b1:4a:22/192.168.2.0/24
    Sep 25 03:17:35 firewall dhcpd: Sending on  Socket/fallback/fallback-net
    Sep 25 03:17:39 firewall dhclient: Starting delete_old_states()
    Sep 25 03:17:39 firewall dhclient: Comparing IPs: Old: 192.168.200.2 New: 192.168.200.2
    Sep 25 03:17:39 firewall dhclient: Deleting old routes
    Sep 25 03:17:39 firewall dhclient[38654]: short write: wanted 20 got 0 bytes
    Sep 25 03:17:39 firewall dhclient[38654]: exiting.
    Sep 25 04:22:37 firewall dhcpd: Wrote 0 deleted host decls to leases file.
    Sep 25 04:22:37 firewall dhcpd: Wrote 0 new dynamic host decls to leases file.
    Sep 25 04:22:37 firewall dhcpd: Wrote 20 leases to leases file.
    Sep 25 05:31:08 firewall dhcpd: Wrote 0 deleted host decls to leases file.
    Sep 25 05:31:08 firewall dhcpd: Wrote 0 new dynamic host decls to leases file.
    Sep 25 05:31:08 firewall dhcpd: Wrote 20 leases to leases file.
    Sep 25 06:55:24 firewall dhcpd: Wrote 0 deleted host decls to leases file.
    Sep 25 06:55:24 firewall dhcpd: Wrote 0 new dynamic host decls to leases file.
    Sep 25 06:55:24 firewall dhcpd: Wrote 20 leases to leases file.
    Sep 25 08:22:37 firewall dhcpd: Wrote 0 deleted host decls to leases file.
    Sep 25 08:22:37 firewall dhcpd: Wrote 0 new dynamic host decls to leases file.
    Sep 25 08:22:37 firewall dhcpd: Wrote 20 leases to leases file.
    Sep 25 08:23:35 firewall dhclient: PREINIT
    Sep 25 08:23:35 firewall dhclient: Starting delete_old_states()
    Sep 25 08:23:35 firewall dhclient: Comparing IPs: Old: 192.168.200.2 New:
    Sep 25 08:23:35 firewall dhclient: Removing states from old IP '192.168.200.2' (new IP '')
    Sep 25 08:23:35 firewall dhclient[25443]: DHCPREQUEST on em1 to 255.255.255.255 port 67
    Sep 25 08:23:36 firewall dhclient[25443]: DHCPREQUEST on em1 to 255.255.255.255 port 67
    Sep 25 08:23:37 firewall dhclient[25443]: DHCPREQUEST on em1 to 255.255.255.255 port 67
    Sep 25 08:23:38 firewall dhclient[25443]: DHCPACK from 192.168.200.1
    Sep 25 08:23:38 firewall dhclient: REBOOT
    Sep 25 08:23:38 firewall dhclient: Starting delete_old_states()
    Sep 25 08:23:38 firewall dhclient: Comparing IPs: Old: 192.168.200.2 New: 192.168.200.2
    Sep 25 08:23:38 firewall dhclient: Starting add_new_address()
    Sep 25 08:23:38 firewall dhclient: ifconfig em1 inet 192.168.200.2 netmask 255.255.255.0 broadcast 192.168.200.255
    Sep 25 08:23:38 firewall dhclient: New IP Address (em1): 192.168.200.2
    Sep 25 08:23:38 firewall dhclient: New Subnet Mask (em1): 255.255.255.0
    Sep 25 08:23:38 firewall dhclient: New Broadcast Address (em1): 192.168.200.255
    Sep 25 08:23:38 firewall dhclient: New Routers (em1): 192.168.200.1
    Sep 25 08:23:38 firewall dhclient: Adding new routes to interface: em1
    Sep 25 08:23:38 firewall dhclient: /sbin/route add default 192.168.200.1
    Sep 25 08:23:38 firewall dhclient: Creating resolv.conf
    Sep 25 08:23:38 firewall dhclient[25443]: bound to 192.168.200.2 – renewal in 604800 seconds.
    Sep 25 08:25:28 firewall dhcpd: Received signal 15, initiating shutdown.
    Sep 25 08:25:28 firewall dhcpd: Disabling output on BPF/em0/00:22:4d:b1:4a:22/192.168.2.0/24
    Sep 25 08:25:28 firewall dhcpd: Disabling input on BPF/em0/00:22:4d:b1:4a:22/192.168.2.0/24
    Sep 25 08:25:30 firewall dhcpd: Internet Systems Consortium DHCP Server 4.2.6
    Sep 25 08:25:30 firewall dhcpd: Copyright 2004-2014 Internet Systems Consortium.
    Sep 25 08:25:30 firewall dhcpd: All rights reserved.
    Sep 25 08:25:30 firewall dhcpd: For info, please visit https://www.isc.org/software/dhcp/
    Sep 25 08:25:30 firewall dhcpd: Internet Systems Consortium DHCP Server 4.2.6
    Sep 25 08:25:30 firewall dhcpd: Copyright 2004-2014 Internet Systems Consortium.
    Sep 25 08:25:30 firewall dhcpd: All rights reserved.
    Sep 25 08:25:30 firewall dhcpd: For info, please visit https://www.isc.org/software/dhcp/
    Sep 25 08:25:30 firewall dhcpd: Wrote 0 deleted host decls to leases file.
    Sep 25 08:25:30 firewall dhcpd: Wrote 0 new dynamic host decls to leases file.
    Sep 25 08:25:30 firewall dhcpd: Wrote 20 leases to leases file.
    Sep 25 08:25:30 firewall dhcpd: Listening on BPF/em0/00:22:4d:b1:4a:22/192.168.2.0/24
    Sep 25 08:25:30 firewall dhcpd: Sending on  BPF/em0/00:22:4d:b1:4a:22/192.168.2.0/24
    Sep 25 08:25:30 firewall dhcpd: Sending on  Socket/fallback/fallback-net
    Sep 25 08:26:07 firewall dhcpd: DHCPRELEASE of 192.168.2.40 from ec:f4:bb:02:2a:02 (Workstation) via em0 (found)
    Sep 25 08:26:10 firewall dhcpd: DHCPDISCOVER from ec:f4:bb:02:2a:02 via em0
    Sep 25 08:26:10 firewall dhcpd: unexpected ICMP Echo Reply from 192.168.200.1
    Sep 25 08:26:11 firewall dhcpd: DHCPOFFER on 192.168.2.40 to ec:f4:bb:02:2a:02 (Workstation) via em0
    Sep 25 09:31:09 firewall dhcpd: Wrote 0 deleted host decls to leases file.
    Sep 25 09:31:09 firewall dhcpd: Wrote 0 new dynamic host decls to leases file.
    Sep 25 09:31:09 firewall dhcpd: Wrote 20 leases to leases file.
    Sep 25 11:31:09 firewall dhcpd: Wrote 0 deleted host decls to leases file.
    Sep 25 11:31:09 firewall dhcpd: Wrote 0 new dynamic host decls to leases file.
    Sep 25 11:31:09 firewall dhcpd: Wrote 20 leases to leases file.

    System Log
    Sep 23 16:37:01 firewall php: /index.php: Successful login for user 'admin' from: 192.168.2.115
    Sep 25 03:16:10 firewall check_reload_status: Linkup starting em1
    Sep 25 03:16:10 firewall kernel: em1: link state changed to DOWN
    Sep 25 03:16:12 firewall check_reload_status: Linkup starting em1
    Sep 25 03:16:12 firewall kernel: em1: link state changed to UP
    Sep 25 03:16:12 firewall php: rc.linkup: DEVD Ethernet detached event for wan
    Sep 25 03:16:13 firewall php: rc.linkup: Clearing states to old gateway 192.168.200.1.
    Sep 25 03:16:14 firewall php: rc.linkup: DEVD Ethernet attached event for wan
    Sep 25 03:16:14 firewall php: rc.linkup: HOTPLUG: Configuring interface wan
    Sep 25 03:16:29 firewall check_reload_status: updating dyndns WANGW
    Sep 25 03:16:29 firewall check_reload_status: Restarting ipsec tunnels
    Sep 25 03:16:29 firewall check_reload_status: Restarting OpenVPN tunnels/interfaces
    Sep 25 03:16:29 firewall check_reload_status: Reloading filter
    Sep 25 03:16:32 firewall php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan).
    Sep 25 03:16:32 firewall php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan).
    Sep 25 03:16:32 firewall php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan).
    Sep 25 03:16:32 firewall php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan).
    Sep 25 03:16:32 firewall php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan).
    Sep 25 03:17:25 firewall check_reload_status: Linkup starting em1
    Sep 25 03:17:25 firewall kernel: em1: link state changed to DOWN
    Sep 25 03:17:27 firewall php: rc.linkup: DEVD Ethernet detached event for wan
    Sep 25 03:17:27 firewall php: rc.linkup: The command '/sbin/dhclient -c /var/etc/dhclient_wan.conf em1 > /tmp/em1_output 2> /tmp/em1_error_output' returned exit code '15', the output was ''
    Sep 25 03:17:27 firewall php: rc.linkup: ROUTING: setting default route to 192.168.200.1
    Sep 25 03:17:28 firewall check_reload_status: Linkup starting em1
    Sep 25 03:17:28 firewall kernel: em1: link state changed to UP
    Sep 25 03:17:28 firewall php: rc.linkup: Clearing states to old gateway 192.168.200.1.
    Sep 25 03:17:30 firewall php: rc.linkup: DEVD Ethernet attached event for wan
    Sep 25 03:17:30 firewall php: rc.linkup: HOTPLUG: Configuring interface wan
    Sep 25 03:17:30 firewall dhcpleases: Could not deliver signal HUP to process because its pidfile does not exist, No such process.
    Sep 25 03:17:30 firewall php: rc.linkup: The command '/sbin/dhclient -c /var/etc/dhclient_wan.conf em1 > /tmp/em1_output 2> /tmp/em1_error_output' returned exit code '1', the output was ''
    Sep 25 03:17:30 firewall php: rc.linkup: ROUTING: setting default route to 192.168.200.1
    Sep 25 03:17:30 firewall php: rc.linkup: The command '/sbin/route change -inet default '192.168.200.1'' returned exit code '1', the output was 'route: writing to routing socket: No such process route: writing to routing socket: Network is unreachable change net default: gateway 192.168.200.1: Network is unreachable'
    Sep 25 03:17:31 firewall check_reload_status: updating dyndns wan
    Sep 25 03:17:35 firewall check_reload_status: updating dyndns wan
    Sep 25 08:22:35 firewall php: /index.php: Successful login for user 'admin' from: 192.168.2.40

    "/tmp/em1_output" file
    dhclient: PREINIT
    dhclient: Starting delete_old_states()
    dhclient: Comparing IPs: Old: 192.168.200.2 New:
    dhclient: Removing states from old IP '192.168.200.2' (new IP '')
    1 states cleared
    killed 0 src nodes from 1 sources and 0 destinations
    DHCPREQUEST on em1 to 255.255.255.255 port 67
    DHCPREQUEST on em1 to 255.255.255.255 port 67
    DHCPREQUEST on em1 to 255.255.255.255 port 67
    DHCPACK from 192.168.200.1
    bound to 192.168.200.2 – renewal in 604800 seconds.

    Why doesn't pfSense automatically re-establish the connection?



  • Hi terminalhit,

    I had exactly the same problem a while ago (2.1.4) , and I'm also with a cable provider with virtually the same setup as yours. 
    After a bit of searching around, and monitoring my ISP's cable modem/router, I found they did often do some modem tests at night.
    And in the morning I discovered my WAN didn't have an IP address assigned. Also, when I manually reset my cable modem for whatever reason,
    I also have to reset my pfSense box or renew the WAN.

    I'm not sure either why pfSense doesn't pick this up and automatically re-assigns the IP to the WAN.
    Anyway it seemed the only logical thing to do was to give the WAN interface of my pfSense box a static (not a reserved DHCP) IP address.
    It's been running fine since.

    The only thing I had to lookout for was that my cable modem/NAT router reserves a part of the range for DHCP and a part for static
    IP addresses (also one of those 'all-in-one' boxes where you can't really do much configuration yourself :( ) 
    so you may have to find that out or ask your cable provider.

    cheers


  • LAYER 8 Netgate

    Sadly i'm stuck with my cable providers "all-in-one" box that performs it's own NATing. The pfSense box is directly connected via Ethernet as a reserved DHCP client with address of "192.168.200.2", while my internal network (LAN side) has 192.168.2.1

    [Internet]  <-> 64.233.xxx.xxx [Cable Box] 192.168.200.1 <-> 192.168.200.2 [pfSense] 192.168.2.1  <-> 192.168.2.46 [Workstation]

    Yup.  That's a pretty sad config.


Log in to reply