Keep loosing WAN IP Address - dhclient does not seem to do update
-
ISP 1 (fails most often) uniserve www.uniserve.com
ISP 2 telus www.telus.net
both are adsl links -
Having the exact same problem.
Have been using pfSense 1.0.1 but changed yesterday to 1.0.1-SNAPSHOT-12-06-2006. I have had this problem along time and it's not related to my upgrade of firmware. The problem occurs when my ISP is braking my connection in some way. Happens.. maybe.. every 2-3 month.
–- local computer (192.168.x) --- (My LAN)
1 Gbit/sec
|
–- pfSense firewall/router --- (My LAN)
100 Mbit/sec
|
–- Switch --- (LAN)
Fiber, xxx Mbit/sec
|
–- Gateway/DHCP/DNS --- (MAN)
Fiber, xxx Mbit/sec
|
–- Internet --- (WAN, Swedish ISP: port80)
100 Mbit/sec
|
–- forum.pfSense.org --- (WAN) -
-
I am copying up a new image for you all to try to http://www.pfsense.com/~sullrich/1.0.1-SNAPSHOT-12-12-2006/
It will be done in a few hours, please double check the file size is not changing before downloading!
However! You need to reinstall before using this or you need to update /etc/crontab to: http://pfsense.com/cgi-bin/cvsweb.cgi/pfSense/etc/crontab?rev=1.21.2.9;content-type=text%2Fplain;only_with_tag=RELENG_1 (notice the tabs, not spaces!)
If you decide to simply update /etc/crontab then you need to issue a killall cron && cron from diagnostics/command to restart cron after updating.
-
Thanks alot for the snapshot. I was looking forward to a solution! I've got the same problem as mentioned in this thread with my swiss isp cablecom. Happened every other day, so we'll see soon if it'll work or not.
Cheers
fireseller -
Any updates?
-
Excellent, while reading your post the wan failed:
Dec 13 16:21:28 dhclient[270]: exiting.
Dec 13 16:21:28 dhclient[270]: short write: wanted 21 got 0 bytesManually had to press "renew" to get it working again.
Annoying problem.
Cheers
fireseller -
Can you show me all the records leading up to that point that has dhclient in it?
-
Hello Scott !
Here you have my log for the dhcp issue:
Dec 14 10:54:06 check_reload_status: reloading filter
Dec 14 10:54:06 php: : Resyncing configuration for all packages.
Dec 14 10:54:06 php: : Creating rrd update script
Dec 14 10:54:05 php: : Informational: DHClient spawned /etc/rc.newwanip and the new ip is wan - 0.0.0.0.
Dec 14 10:54:00 login: login on ttyv0 as root
Dec 14 10:54:00 dhclient[13796]: bound to 90.224.168.54 – renewal in 600 seconds.
Dec 14 10:54:00 dhclient: /sbin/route add default 90.224.168.1
Dec 14 10:54:00 dhclient: New Routers (rl0): 90.224.168.1
Dec 14 10:54:00 dhclient: New Broadcast Address (rl0): 90.224.168.255
Dec 14 10:54:00 dhclient: New Subnet Mask (rl0): 255.255.255.0
Dec 14 10:54:00 dhclient: New IP Address (rl0): 90.224.168.54
Dec 14 10:54:00 dhclient[13796]: DHCPACK from 90.224.168.1
Dec 14 10:54:00 dhclient[13796]: DHCPREQUEST on rl0 to 255.255.255.255 port 67
Dec 14 10:53:59 dhclient: /sbin/route add default 90.224.168.1
Dec 14 10:53:59 dhclient: New Routers (rl0): 90.224.168.1
Dec 14 10:53:59 dhclient: New Broadcast Address (rl0): 90.224.168.255
Dec 14 10:53:59 dhclient: New Subnet Mask (rl0): 255.255.255.0
Dec 14 10:53:59 dhclient: New IP Address (rl0): 90.224.168.54
Dec 14 10:53:58 dhclient[13796]: DHCPOFFER from 90.224.168.1
Dec 14 10:53:58 dhclient[13796]: DHCPDISCOVER on rl0 to 255.255.255.255 port 67 interval 6
Dec 14 10:53:58 php: : Informational: rc.newwanip is starting. -
Here's the log: (I forgot to mention that I'm using 2 WAN interfaces, connected on a switch onto a cablemodem which is giving 2 different ip's via dhcp).
Let me know if there's something more I can help.
Dec 13 13:32:28 check_reload_status: reloading filter
Dec 13 13:32:31 php: : FTP proxy disabled for interface LAN - ignoring.
Dec 13 13:32:31 php: : FTP proxy disabled for interface opt1 - ignoring.
Dec 13 13:32:31 php: : FTP proxy disabled for interface opt2 - ignoring.
Dec 13 13:48:03 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 13:48:52 last message repeated 5 times
Dec 13 13:49:44 last message repeated 2 times
Dec 13 13:50:09 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 13:50:14 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 13:50:23 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 13:50:24 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 13:50:41 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 13:50:48 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 13:51:04 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 13:51:20 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 13:51:29 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 13:51:39 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 13:51:43 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 13:51:47 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 13:51:58 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 13:52:00 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 13:52:10 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 13:52:23 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 13:52:26 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 13:52:35 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 13:52:47 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 13:53:03 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 13:53:10 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 13:53:23 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 13:53:27 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 13:53:47 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 13:53:57 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 13:54:16 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 13:54:24 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 13:54:25 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 13:54:34 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 13:54:36 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 13:54:46 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 13:54:55 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 13:54:56 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 13:55:07 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 13:55:25 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 13:55:29 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 13:55:39 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 13:55:50 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 13:55:56 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 13:56:15 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 13:56:23 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 13:56:55 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 13:57:01 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 13:57:39 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 13:57:52 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 13:57:53 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 13:58:17 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 13:58:52 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 14:00:22 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 14:00:27 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 14:00:59 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 14:03:25 last message repeated 3 times
Dec 13 14:03:35 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 14:03:39 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 14:04:25 last message repeated 2 times
Dec 13 14:06:03 last message repeated 4 times
Dec 13 14:10:33 last message repeated 5 times
Dec 13 14:10:57 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 14:11:49 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 14:12:15 last message repeated 2 times
Dec 13 14:13:32 last message repeated 4 times
Dec 13 14:14:03 dhclient[270]: DHCPREQUEST on xl1 to 255.255.255.255 port 67
Dec 13 14:14:03 dhclient[270]: DHCPACK from 10.215.0.1
Dec 13 14:14:03 dhclient[270]: bound to 84.75.14.219 – renewal in 2246 seconds.
Dec 13 14:14:05 check_reload_status: rc.newwanip starting
Dec 13 14:14:07 php: : Informational: rc.newwanip is starting.
Dec 13 14:14:07 kernel: pflog0: promiscuous mode disabled
Dec 13 14:14:09 php: : Informational: DHClient spawned /etc/rc.newwanip and the new ip is wan - 84.75.14.219.
Dec 13 14:14:10 php: : Creating rrd update script
Dec 13 14:14:11 dnsmasq[4219]: reading /etc/resolv.conf
Dec 13 14:14:11 dnsmasq[4219]: using nameserver 62.2.24.162#53
Dec 13 14:14:11 dnsmasq[4219]: using nameserver 62.2.17.60#53
Dec 13 14:14:11 dnsmasq[4219]: using nameserver 62.2.24.158#53
Dec 13 14:14:11 dnsmasq[4219]: using nameserver 62.2.17.61#53
Dec 13 14:14:12 php: : Resyncing configuration for all packages.
Dec 13 14:14:12 check_reload_status: reloading filter
Dec 13 14:14:14 php: : FTP proxy disabled for interface LAN - ignoring.
Dec 13 14:14:14 php: : FTP proxy disabled for interface opt1 - ignoring.
Dec 13 14:14:14 php: : FTP proxy disabled for interface opt2 - ignoring.
Dec 13 14:14:20 check_reload_status: updating dyndns
Dec 13 14:14:23 php: : DynDns: Running updatedns()
Dec 13 14:14:23 php: : DynDns: updatedns() starting
Dec 13 14:14:23 php: : DynDns: _detectChange() starting.
Dec 13 14:14:23 php: : DynDns: Current WAN IP: 84.75.14.219
Dec 13 14:14:23 php: : DynDns: Cached IP: 84.75.14.219
Dec 13 14:14:23 php: : phpDynDNS: No Change In My IP Address and/or 25 Days Has Not Past. Not Updating Dynamic DNS Entry.
Dec 13 14:20:10 dhclient[338]: DHCPREQUEST on xl0 to 255.255.255.255 port 67
Dec 13 14:20:10 dhclient[338]: DHCPACK from 10.215.0.1
Dec 13 14:20:10 dhclient[338]: bound to 84.75.15.90 – renewal in 2018 seconds.
Dec 13 14:20:13 check_reload_status: rc.newwanip starting
Dec 13 14:20:14 php: : Informational: rc.newwanip is starting.
Dec 13 14:20:16 php: : Informational: DHClient spawned /etc/rc.newwanip and the new ip is opt1 - 84.75.15.90.
Dec 13 14:20:16 php: : Creating rrd update script
Dec 13 14:20:17 dnsmasq[4219]: reading /etc/resolv.conf
Dec 13 14:20:17 dnsmasq[4219]: using nameserver 62.2.24.162#53
Dec 13 14:20:17 dnsmasq[4219]: using nameserver 62.2.17.60#53
Dec 13 14:20:17 dnsmasq[4219]: using nameserver 62.2.24.158#53
Dec 13 14:20:17 dnsmasq[4219]: using nameserver 62.2.17.61#53
Dec 13 14:20:19 php: : Resyncing configuration for all packages.
Dec 13 14:20:19 check_reload_status: reloading filter
Dec 13 14:20:21 php: : FTP proxy disabled for interface LAN - ignoring.
Dec 13 14:20:21 php: : FTP proxy disabled for interface opt1 - ignoring.
Dec 13 14:20:21 php: : FTP proxy disabled for interface opt2 - ignoring.
Dec 13 14:20:26 check_reload_status: updating dyndns
Dec 13 14:20:29 php: : DynDns: Running updatedns()
Dec 13 14:20:29 php: : DynDns: updatedns() starting
Dec 13 14:20:29 php: : DynDns: _detectChange() starting.
Dec 13 14:20:29 php: : DynDns: Current WAN IP: 84.75.14.219
Dec 13 14:20:29 php: : DynDns: Cached IP: 84.75.14.219
Dec 13 14:20:29 php: : phpDynDNS: No Change In My IP Address and/or 25 Days Has Not Past. Not Updating Dynamic DNS Entry.
Dec 13 14:51:29 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 14:52:04 last message repeated 3 times
Dec 13 14:53:43 last message repeated 6 times
Dec 13 14:53:48 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 14:53:54 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 14:53:57 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 14:54:05 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 14:54:08 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 14:54:29 last message repeated 2 times
Dec 13 14:54:30 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 14:54:52 last message repeated 2 times
Dec 13 14:55:00 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 14:55:11 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 14:55:21 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 14:55:22 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 14:55:53 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 14:56:03 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 14:56:05 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 14:56:21 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 14:56:28 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 14:56:48 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 14:57:04 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 14:57:04 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 14:57:14 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 14:57:15 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 14:57:33 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 14:57:39 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 14:58:22 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 14:58:48 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 14:59:41 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 15:00:15 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 15:00:59 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 15:03:50 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 15:04:00 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 15:04:27 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 15:06:40 last message repeated 2 times
Dec 13 15:07:44 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 15:08:03 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 15:10:20 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 15:10:43 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 15:11:40 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 15:12:46 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 15:14:43 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 15:15:03 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 15:15:31 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 15:16:07 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 15:17:13 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 15:18:27 dhclient[338]: DHCPREQUEST on xl0 to 10.215.0.1 port 67
Dec 13 15:20:37 dhclient[338]: DHCPREQUEST on xl0 to 255.255.255.255 port 67
Dec 13 15:20:37 dhclient[338]: DHCPACK from 10.215.0.1
Dec 13 15:20:37 dhclient[338]: short write: wanted 21 got 0 bytes
Dec 13 15:20:37 dhclient[338]: short write: wanted 21 got 0 bytes
Dec 13 15:20:37 dhclient[338]: exiting.
Dec 13 15:20:37 dhclient[338]: exiting.
Dec 13 15:25:32 dhclient[270]: DHCPREQUEST on xl1 to 255.255.255.255 port 67
Dec 13 15:25:32 dhclient[270]: DHCPACK from 10.215.0.1
Dec 13 15:25:32 dhclient[270]: bound to 84.75.14.219 – renewal in 1905 seconds.
Dec 13 15:25:34 check_reload_status: rc.newwanip starting
Dec 13 15:25:35 php: : Informational: rc.newwanip is starting.
Dec 13 15:25:38 php: : Informational: DHClient spawned /etc/rc.newwanip and the new ip is wan - 84.75.14.219.
Dec 13 15:25:38 php: : Creating rrd update script
Dec 13 15:25:40 php: : Resyncing configuration for all packages.
Dec 13 15:25:41 check_reload_status: reloading filter
Dec 13 15:25:42 php: : FTP proxy disabled for interface LAN - ignoring.
Dec 13 15:25:42 php: : FTP proxy disabled for interface opt1 - ignoring.
Dec 13 15:25:42 php: : FTP proxy disabled for interface opt2 - ignoring.
Dec 13 15:25:48 check_reload_status: updating dyndns
Dec 13 15:25:48 dnsmasq[4219]: reading /etc/resolv.conf
Dec 13 15:25:48 dnsmasq[4219]: using nameserver 62.2.24.162#53
Dec 13 15:25:48 dnsmasq[4219]: using nameserver 62.2.17.60#53
Dec 13 15:25:48 dnsmasq[4219]: using nameserver 62.2.24.158#53
Dec 13 15:25:48 dnsmasq[4219]: using nameserver 62.2.17.61#53
Dec 13 15:25:51 php: : DynDns: Running updatedns()
Dec 13 15:25:51 php: : DynDns: updatedns() starting
Dec 13 15:25:51 php: : DynDns: _detectChange() starting.
Dec 13 15:25:51 php: : DynDns: Current WAN IP: 84.75.14.219
Dec 13 15:25:51 php: : DynDns: Cached IP: 84.75.14.219
Dec 13 15:25:51 php: : phpDynDNS: No Change In My IP Address and/or 25 Days Has Not Past. Not Updating Dynamic DNS Entry.
Dec 13 15:57:17 dhclient[270]: DHCPREQUEST on xl1 to 10.215.0.1 port 67
Dec 13 15:57:55 last message repeated 4 times
Dec 13 15:59:15 last message repeated 2 times
Dec 13 16:07:46 last message repeated 4 times
Dec 13 16:19:17 last message repeated 21 times
Dec 13 16:20:53 last message repeated 3 times
Dec 13 16:21:28 dhclient[270]: DHCPREQUEST on xl1 to 255.255.255.255 port 67
Dec 13 16:21:28 dhclient[270]: DHCPACK from 10.215.0.1
Dec 13 16:21:28 dhclient[270]: short write: wanted 21 got 0 bytes
Dec 13 16:21:28 dhclient[270]: short write: wanted 21 got 0 bytes
Dec 13 16:21:28 dhclient[270]: exiting.
Dec 13 16:21:28 dhclient[270]: exiting.**************** renew pressed ****************
Dec 13 19:17:14 dhclient[41510]: DHCPDISCOVER on xl1 to 255.255.255.255 port 67 interval 3
Dec 13 19:17:14 dhclient[41510]: DHCPOFFER from 10.215.0.1
Dec 13 19:17:16 dhclient[41510]: DHCPREQUEST on xl1 to 255.255.255.255 port 67
Dec 13 19:17:17 dhclient[41510]: DHCPACK from 10.215.0.1
Dec 13 19:17:17 dhclient: New IP Address (xl1): 84.75.14.219
Dec 13 19:17:17 dhclient: New Subnet Mask (xl1): 255.255.248.0
Dec 13 19:17:17 dhclient: New Broadcast Address (xl1): 255.255.255.255
Dec 13 19:17:17 dhclient: New Routers (xl1): 84.75.8.1
Dec 13 19:17:17 dhclient: /sbin/route add default 84.75.8.1
Dec 13 19:17:18 dhclient[41510]: bound to 84.75.14.219 – renewal in 1800 seconds.
Dec 13 19:17:18 dhclient[41595]: DHCPDISCOVER on xl0 to 255.255.255.255 port 67 interval 8
Dec 13 19:17:18 dhclient[41595]: DHCPOFFER from 10.215.0.1
Dec 13 19:17:18 check_reload_status: rc.newwanip starting
Dec 13 19:17:20 dhclient[41595]: DHCPREQUEST on xl0 to 255.255.255.255 port 67
Dec 13 19:17:20 dhclient[41595]: DHCPACK from 10.215.0.1
Dec 13 19:17:20 dhclient: New IP Address (xl0): 84.75.15.90
Dec 13 19:17:20 dhclient: New Subnet Mask (xl0): 255.255.248.0
Dec 13 19:17:20 dhclient: New Broadcast Address (xl0): 255.255.255.255
Dec 13 19:17:20 dhclient: New Routers (xl0): 84.75.8.1
Dec 13 19:17:20 dhclient: /sbin/route add default 84.75.8.1
Dec 13 19:17:20 dhclient[41595]: bound to 84.75.15.90 – renewal in 1800 seconds.
Dec 13 19:17:21 php: : Informational: rc.newwanip is starting.
Dec 13 19:17:26 php: : Informational: DHClient spawned /etc/rc.newwanip and the new ip is opt1 - 84.75.15.90.
Dec 13 19:17:26 php: : Creating rrd update script
Dec 13 19:17:28 php: : Resyncing configuration for all packages.
Dec 13 19:17:29 check_reload_status: reloading filter
Dec 13 19:17:30 php: : FTP proxy disabled for interface LAN - ignoring.
Dec 13 19:17:30 php: : FTP proxy disabled for interface opt1 - ignoring.
Dec 13 19:17:30 php: : FTP proxy disabled for interface opt2 - ignoring.
Dec 13 19:17:36 check_reload_status: updating dyndns
Dec 13 19:17:38 php: : DynDns: Running updatedns()
Dec 13 19:17:38 php: : DynDns: updatedns() starting
Dec 13 19:17:38 php: : DynDns: _detectChange() starting.
Dec 13 19:17:38 php: : DynDns: Current WAN IP: 84.75.14.219
Dec 13 19:17:38 php: : DynDns: Cached IP: 84.75.14.219
Dec 13 19:17:38 php: : phpDynDNS: No Change In My IP Address and/or 25 Days Has Not Past. Not Updating Dynamic DNS Entry.
Dec 13 19:17:52 dnsmasq[4219]: reading /etc/resolv.conf
Dec 13 19:17:52 dnsmasq[4219]: using nameserver 62.2.24.162#53
Dec 13 19:17:52 dnsmasq[4219]: using nameserver 62.2.17.60#53
Dec 13 19:17:52 dnsmasq[4219]: using nameserver 62.2.24.158#53
Dec 13 19:17:52 dnsmasq[4219]: using nameserver 62.2.17.61#53 -
Okay, I can confirm that the new snapshot is not working in this issue.
I have a problem with my ISP that my IP is dropped 5-10 times a day. I don't believe at the moment it is because of pfsense.Anyway, this makes me a great candidate for testing if pfsense is renewing my ip address when it detects it's down. I can say it dosen't. If I press the "renew" button manually, I get the interface up.
My WAN interface is dc0
My LAN interface is xl0Dec 15 08:36:23 check_reload_status: updating dyndns Dec 15 08:36:22 dnsmasq[7736]: using nameserver 217.75.96.11#53 Dec 15 08:36:22 dnsmasq[7736]: using nameserver 217.75.96.12#53 Dec 15 08:36:22 dnsmasq[7736]: reading /etc/resolv.conf Dec 15 08:36:22 check_reload_status: reloading filter Dec 15 08:36:22 miniupnpd[16371]: received signal 15, exiting Dec 15 08:36:19 php: : Resyncing configuration for all packages. Dec 15 08:36:18 php: : Creating rrd update script Dec 15 08:36:18 php: : Informational: DHClient spawned /etc/rc.newwanip and the new ip is wan - 0.0.0.0. Dec 15 08:36:14 dhclient[57046]: bound to 89.233.199.181 -- renewal in 1800 seconds. Dec 15 08:36:14 dhclient: /sbin/route add default 89.233.199.1 Dec 15 08:36:14 dhclient: New Routers (dc0): 89.233.199.1 Dec 15 08:36:14 dhclient: New Broadcast Address (dc0): 89.233.199.255 Dec 15 08:36:14 dhclient: New Subnet Mask (dc0): 255.255.255.0 Dec 15 08:36:14 dhclient: New IP Address (dc0): 89.233.199.181 Dec 15 08:36:13 dhclient[57046]: DHCPACK from 89.233.199.1 Dec 15 08:36:13 dhclient[57046]: DHCPREQUEST on dc0 to 255.255.255.255 port 67 Dec 15 08:36:13 sshlockout[57101]: sshlockout starting up Dec 15 08:36:13 sshlockout[57101]: sshlockout starting up Dec 15 08:36:13 login: login on ttyv0 as root Dec 15 08:36:13 php: : Informational: rc.newwanip is starting. Dec 15 08:36:12 check_reload_status: rc.newwanip starting Dec 15 08:36:11 dhclient[57046]: DHCPOFFER from 89.233.199.1 Dec 15 08:36:10 dhclient[57046]: DHCPDISCOVER on dc0 to 255.255.255.255 port 67 interval 7 Dec 15 01:50:56 php: : Hotplug event detected for xl0 but ignoring since interface is not set for DHCP Dec 15 01:50:55 check_reload_status: rc.linkup starting Dec 15 01:50:51 kernel: xl0: link state changed to UP Dec 15 01:50:50 php: : Hotplug event detected for xl0 but ignoring since interface is not set for DHCP Dec 15 01:50:49 check_reload_status: rc.linkup starting Dec 15 01:50:49 kernel: xl0: link state changed to DOWN Dec 15 01:50:49 kernel: xl0: watchdog timeout Dec 15 01:15:21 php: : Hotplug event detected for xl0 but ignoring since interface is not set for DHCP Dec 15 01:15:21 php: : Hotplug event detected for xl0 but ignoring since interface is not set for DHCP Dec 15 01:15:21 check_reload_status: rc.linkup starting Dec 15 01:15:18 kernel: xl0: link state changed to UP Dec 15 01:15:16 kernel: xl0: link state changed to DOWN Dec 15 01:15:16 kernel: xl0: watchdog timeout Dec 15 00:36:07 dnsmasq[7736]: using nameserver 217.75.96.11#53 Dec 15 00:36:07 dnsmasq[7736]: using nameserver 217.75.96.12#53 Dec 15 00:36:07 dnsmasq[7736]: reading /etc/resolv.conf Dec 15 00:35:42 check_reload_status: updating dyndns Dec 15 00:35:40 miniupnpd[13408]: received signal 15, exiting Dec 15 00:35:40 check_reload_status: reloading filter Dec 15 00:35:38 php: : Resyncing configuration for all packages. Dec 15 00:35:36 php: : Creating rrd update script Dec 15 00:35:36 php: : Informational: DHClient spawned /etc/rc.newwanip and the new ip is wan - 89.233.202.100. Dec 15 00:35:32 php: : Informational: rc.newwanip is starting. Dec 15 00:35:31 check_reload_status: rc.newwanip starting Dec 15 00:10:34 dnsmasq[7736]: using nameserver 217.75.96.11#53 Dec 15 00:10:34 dnsmasq[7736]: using nameserver 217.75.96.12#53 Dec 15 00:10:34 dnsmasq[7736]: reading /etc/resolv.conf Dec 15 00:05:43 check_reload_status: updating dyndns Dec 15 00:05:41 check_reload_status: reloading filter Dec 15 00:05:41 miniupnpd[10415]: received signal 15, exiting Dec 15 00:05:39 php: : Resyncing configuration for all packages. Dec 15 00:05:38 php: : Creating rrd update script Dec 15 00:05:38 php: : Informational: DHClient spawned /etc/rc.newwanip and the new ip is wan - 89.233.202.100. Dec 15 00:05:36 kernel: pflog0: promiscuous mode disabled Dec 15 00:05:33 php: : Informational: rc.newwanip is starting. Dec 15 00:05:33 check_reload_status: rc.newwanip starting Dec 14 23:47:15 dnsmasq[7736]: using nameserver 217.75.96.11#53 Dec 14 23:47:15 dnsmasq[7736]: using nameserver 217.75.96.12#53 Dec 14 23:47:15 dnsmasq[7736]: reading /etc/resolv.conf Dec 14 23:35:44 check_reload_status: updating dyndns Dec 14 23:35:43 check_reload_status: reloading filter Dec 14 23:35:42 miniupnpd[10275]: received signal 15, exiting Dec 14 23:35:40 php: : Resyncing configuration for all packages. Dec 14 23:35:39 php: : Creating rrd update script Dec 14 23:35:39 php: : Informational: DHClient spawned /etc/rc.newwanip and the new ip is wan - 89.233.202.100. Dec 14 23:35:38 miniupnpd[6728]: received signal 15, exiting Dec 14 23:35:36 php: : Resyncing configuration for all packages. Dec 14 23:35:36 php: : Creating rrd update script Dec 14 23:35:35 php: : Informational: DHClient spawned /etc/rc.newwanip and the new ip is wan - 89.233.202.100. Dec 14 23:35:35 php: : Informational: rc.newwanip is starting. Dec 14 23:35:34 check_reload_status: rc.newwanip starting Dec 14 23:35:34 check_reload_status: check_reload_status is starting Dec 14 23:35:31 php: : Informational: rc.newwanip is starting. Dec 14 22:35:30 check_reload_status: rc.newwanip starting Dec 14 23:16:00 syslogd: kernel boot file is /boot/kernel/kernel Dec 14 23:16:00 syslogd: exiting on signal 15 Dec 14 23:12:59 dhcpd: For info, please visit http://www.isc.org/sw/dhcp/ Dec 14 23:12:59 dhcpd: All rights reserved. Dec 14 23:12:59 dhcpd: Copyright 2004-2006 Internet Systems Consortium. Dec 14 23:12:59 dhcpd: Internet Systems Consortium DHCP Server V3.0.4 Dec 14 23:12:58 dnsmasq[7736]: using nameserver 217.75.96.11#53 Dec 14 23:12:58 dnsmasq[7736]: using nameserver 217.75.96.12#53 Dec 14 23:12:58 dnsmasq[7736]: reading /etc/resolv.conf Dec 14 23:12:58 dnsmasq[7736]: read /etc/hosts - 4 addresses Dec 14 23:12:58 dnsmasq[7736]: started, version 2.22 cachesize 150 Dec 14 23:12:57 dnsmasq[4470]: exiting on receipt of SIGTERM Dec 14 23:12:57 dnsmasq[4470]: using nameserver 217.75.96.11#53 Dec 14 23:12:57 dnsmasq[4470]: using nameserver 217.75.96.12#53 Dec 14 23:12:57 dnsmasq[4470]: reading /etc/resolv.conf Dec 14 23:12:57 dhcpd: For info, please visit http://www.isc.org/sw/dhcp/ Dec 14 23:12:57 dhcpd: All rights reserved. Dec 14 23:12:57 dhcpd: Copyright 2004-2006 Internet Systems Consortium. Dec 14 23:12:57 dhcpd: Internet Systems Consortium DHCP Server V3.0.4 Dec 14 23:09:40 dnsmasq[4470]: using nameserver 217.75.96.11#53 Dec 14 23:09:40 dnsmasq[4470]: using nameserver 217.75.96.12#53 Dec 14 23:09:40 dnsmasq[4470]: reading /etc/resolv.conf Dec 14 22:09:08 php: /pkg_mgr_install.php: Beginning package installation for stunnel. Dec 14 22:05:41 check_reload_status: updating dyndns Dec 14 22:05:40 check_reload_status: reloading filter Dec 14 23:05:40 miniupnpd[1731]: received signal 15, exiting Dec 14 23:05:38 php: : Resyncing configuration for all packages. Dec 14 23:05:37 php: : Creating rrd update script Dec 14 23:05:37 php: : Informational: DHClient spawned /etc/rc.newwanip and the new ip is wan - 89.233.202.100. Dec 14 23:05:33 php: : Informational: rc.newwanip is starting. Dec 14 22:05:32 check_reload_status: rc.newwanip starting Dec 14 22:03:04 check_reload_status: reloading filter Dec 14 23:01:10 sshd[5595]: subsystem request for sftp Dec 14 22:59:00 sshd[5595]: Accepted password for admin from 192.168.1.199 port 1683 ssh2 Dec 14 22:58:55 sshd[5595]: Failed password for admin from 192.168.1.199 port 1683 ssh2 Dec 14 21:57:53 check_reload_status: reloading filter Dec 14 21:53:41 check_reload_status: reloading filter Dec 14 22:53:36 sshd[4601]: Server listening on 0.0.0.0 port 222. Dec 14 22:53:36 sshlockout[4602]: sshlockout starting up Dec 14 22:53:36 sshlockout[4602]: sshlockout starting up Dec 14 22:53:36 sshd[4601]: Server listening on :: port 222. Dec 14 22:53:35 php: : New alert found: pfSense has completed creating your SSH keys. SSH is now started. Dec 14 22:53:23 php: : New alert found: pfSense has started creating your SSH keys. SSH Startup will be delayed. Please note that reloading the filter rules and changes will be delayed until this operation is completed. Dec 14 21:53:23 check_reload_status: starting sshd Dec 14 22:53:21 dhcpd: For info, please visit http://www.isc.org/sw/dhcp/ Dec 14 22:53:21 dhcpd: All rights reserved. Dec 14 22:53:21 dhcpd: Copyright 2004-2006 Internet Systems Consortium. Dec 14 22:53:21 dhcpd: Internet Systems Consortium DHCP Server V3.0.4 Dec 14 22:53:20 dnsmasq[4470]: using nameserver 217.75.96.11#53 Dec 14 22:53:20 dnsmasq[4470]: using nameserver 217.75.96.12#53 Dec 14 22:53:20 dnsmasq[4470]: reading /etc/resolv.conf Dec 14 22:53:20 dnsmasq[4470]: read /etc/hosts - 4 addresses Dec 14 22:53:20 dnsmasq[4470]: started, version 2.22 cachesize 150 Dec 14 21:53:19 dnsmasq[1378]: exiting on receipt of SIGTERM Dec 14 22:53:19 dhcpd: For info, please visit http://www.isc.org/sw/dhcp/ Dec 14 22:53:19 dhcpd: All rights reserved. Dec 14 22:53:19 dhcpd: Copyright 2004-2006 Internet Systems Consortium. Dec 14 22:53:19 dhcpd: Internet Systems Consortium DHCP Server V3.0.4 Dec 14 21:53:16 check_reload_status: reloading filter Dec 14 22:44:27 syslogd: kernel boot file is /boot/kernel/kernel Dec 14 21:44:27 syslogd: exiting on signal 15 Dec 14 21:42:06 kernel: dc0: TX underrun -- increasing TX threshold Dec 14 21:41:54 kernel: dc0: TX underrun -- increasing TX threshold Dec 14 21:39:41 php: miniupnpd: Starting service Dec 14 21:39:40 php: miniupnpd: Active on lan interface Dec 14 21:39:40 php: miniupnpd: Syncing package Dec 14 21:37:52 dhcpd: For info, please visit http://www.isc.org/sw/dhcp/ Dec 14 21:37:52 dhcpd: All rights reserved. Dec 14 21:37:52 dhcpd: Copyright 2004-2006 Internet Systems Consortium. Dec 14 21:37:52 dhcpd: Internet Systems Consortium DHCP Server V3.0.4 Dec 14 21:37:51 dnsmasq[1378]: using nameserver 217.75.96.11#53 Dec 14 21:37:51 dnsmasq[1378]: using nameserver 217.75.96.12#53 Dec 14 21:37:51 dnsmasq[1378]: reading /etc/resolv.conf Dec 14 21:37:51 dnsmasq[1378]: read /etc/hosts - 4 addresses Dec 14 21:37:50 dnsmasq[1378]: started, version 2.22 cachesize 150 Dec 14 21:37:49 dnsmasq[1108]: exiting on receipt of SIGTERM Dec 14 21:37:49 dnsmasq[1108]: using nameserver 217.75.96.11#53 Dec 14 21:37:49 dnsmasq[1108]: using nameserver 217.75.96.12#53 Dec 14 21:37:49 dnsmasq[1108]: reading /etc/resolv.conf Dec 14 21:37:49 dhcpd: For info, please visit http://www.isc.org/sw/dhcp/ Dec 14 21:37:49 dhcpd: All rights reserved. Dec 14 21:37:49 dhcpd: Copyright 2004-2006 Internet Systems Consortium. Dec 14 21:37:49 dhcpd: Internet Systems Consortium DHCP Server V3.0.4 Dec 14 21:37:04 dhcpd: For info, please visit http://www.isc.org/sw/dhcp/ Dec 14 21:37:04 dhcpd: All rights reserved. Dec 14 21:37:04 dhcpd: Copyright 2004-2006 Internet Systems Consortium. Dec 14 21:37:04 dhcpd: Internet Systems Consortium DHCP Server V3.0.4 Dec 14 21:37:03 dnsmasq[1108]: using nameserver 217.75.96.11#53 Dec 14 21:37:03 dnsmasq[1108]: using nameserver 217.75.96.12#53 Dec 14 21:37:03 dnsmasq[1108]: reading /etc/resolv.conf Dec 14 21:37:03 dnsmasq[1108]: read /etc/hosts - 4 addresses Dec 14 21:37:03 dnsmasq[1108]: started, version 2.22 cachesize 150 Dec 14 21:37:02 dnsmasq[386]: exiting on receipt of SIGTERM Dec 14 21:37:02 dnsmasq[386]: using nameserver 217.75.96.11#53 Dec 14 21:37:02 dnsmasq[386]: using nameserver 217.75.96.12#53 Dec 14 21:37:02 dnsmasq[386]: reading /etc/resolv.conf Dec 14 21:37:02 dhcpd: For info, please visit http://www.isc.org/sw/dhcp/ Dec 14 21:37:02 dhcpd: All rights reserved. Dec 14 21:37:02 dhcpd: Copyright 2004-2006 Internet Systems Consortium. Dec 14 21:37:02 dhcpd: Internet Systems Consortium DHCP Server V3.0.4 Dec 14 21:35:49 dnsmasq[386]: using nameserver 217.75.96.11#53 Dec 14 21:35:49 dnsmasq[386]: using nameserver 217.75.96.12#53 Dec 14 21:35:49 dnsmasq[386]: reading /etc/resolv.conf Dec 14 21:35:43 check_reload_status: updating dyndns Dec 14 21:35:41 check_reload_status: reloading filter Dec 14 21:35:41 php: : Resyncing configuration for all packages. Dec 14 21:35:40 php: : Creating rrd update script Dec 14 21:35:40 php: : Informational: DHClient spawned /etc/rc.newwanip and the new ip is wan - 89.233.202.100. Dec 14 21:35:39 sshlockout[664]: sshlockout starting up Dec 14 21:35:39 sshlockout[664]: sshlockout starting up Dec 14 21:35:39 login: login on ttyv0 as root Dec 14 21:35:38 php: : Informational: rc.newwanip is starting. Dec 14 21:35:37 check_reload_status: rc.newwanip starting Dec 14 21:35:37 check_reload_status: check_reload_status is starting Dec 14 21:35:37 php: : Resyncing configuration for all packages. Dec 14 21:35:33 dhcpd: For info, please visit http://www.isc.org/sw/dhcp/ Dec 14 21:35:33 dhcpd: All rights reserved. Dec 14 21:35:33 dhcpd: Copyright 2004-2006 Internet Systems Consortium. Dec 14 21:35:33 dhcpd: Internet Systems Consortium DHCP Server V3.0.4 Dec 14 21:35:33 php: : Creating rrd update script Dec 14 21:35:32 pftpx[457]: listening on 127.0.0.1 port 8021 Dec 14 21:35:32 pftpx[457]: listening on 127.0.0.1 port 8021 -
i have the same problem, and i have done this (no warranty!):
edit /etc/rc.newwanip
and in the beginning of the file i added:if($curwanip == "0.0.0.0") {
log_error("Failed to update WAN IP, restarting dhclient.");
exec("dhclient rl0");
}
–----------------------------------------------------------------------------------
Replace "rl0" with you WAN interface!
It would look like this:/* WAN IP address has changed */
$argument = str_replace("\n", "", $argv[1]);
if($argument <> "") {
$curwanip = find_interface_ip($argument);
$interface = convert_real_interface_to_friendly_interface_name($argument);
if($curwanip == "")
$curwanip = get_current_wan_address();
} else {
$curwanip = get_current_wan_address();
$interface = "wan";
}
if($curwanip == "0.0.0.0") {
log_error("Failed to update WAN IP, restarting dhclient.");
exec("dhclient rl0");
} -
have done some research, and it seems that the problem is dhclient and not pfsense, this guy is not using pfsense:
http://lists.freebsd.org/pipermail/freebsd-current/2005-October/056279.html
-
That was from 2005. Since then dhclient was replaced with a version from OpenBSD.
-
well,, the error is the same:
"short write: wanted 21 got 0 bytes" -
well,, the error is the same:
"short write: wanted 21 got 0 bytes"Yeah, that's very strange. Just to make sure, you are on the latest testing snapshot?
-
i have the same problem, and i have done this (no warranty!):
edit /etc/rc.newwanip
and in the beginning of the file i added:if($curwanip == "0.0.0.0") {
log_error("Failed to update WAN IP, restarting dhclient.");
exec("dhclient rl0");
}
–----------------------------------------------------------------------------------
Replace "rl0" with you WAN interface!
It would look like this:/* WAN IP address has changed */
$argument = str_replace("\n", "", $argv[1]);
if($argument <> "") {
$curwanip = find_interface_ip($argument);
$interface = convert_real_interface_to_friendly_interface_name($argument);
if($curwanip == "")
$curwanip = get_current_wan_address();
} else {
$curwanip = get_current_wan_address();
$interface = "wan";
}
if($curwanip == "0.0.0.0") {
log_error("Failed to update WAN IP, restarting dhclient.");
exec("dhclient rl0");
}THANKS SO MUCH!
This works like a charm. My ISP drops my IP from time to time, it was annoying because pfsense doesn't auto-renew it for whatever reason. I'm running in vmware. It works fine now! I can see it in the system logs as it happens.
-
Nice to hear it worked !! :D
-
well,, the error is the same:
"short write: wanted 21 got 0 bytes"Yeah, that's very strange. Just to make sure, you are on the latest testing snapshot?
Yes, im using 2006-12-14 right now, maybe its time to upgrade dhclient to 3.0.5 if its possibly ?? or even replace dhclient.
-
yeah, definately looks like the same error. What drives me crazy is that the versions before 1.0 of Pfsense worked flawlessly concerning the dhclient Wan IP issue. Was there a version change?
Cheers
fireseller