Keep loosing WAN IP Address - dhclient does not seem to do update
-
Atm there is a workaround in pllace that will restart the dhclient when it exits. Does it get restarted?
-
Atm there is a workaround in pllace that will restart the dhclient when it exits. Does it get restarted?
Nope at 20:01:24 it exited, at 21:01 i lost my ip, then i had to do a renew.
-
It can take up to 5 minutes to restart dhclient depending on if check_reload_status is running.
So if you still have trouble please check that check_reload_status is running from a shell by doing:
ps awux | grep check_reload_status
Also, cat /etc/crontab | grep check
-
I found yet another problem. This WAN DHCP issue has been nothing but fun!
Try out a recent snapshot atleast an hour from now.
-
damn! snapshot 02-21 is not working :'( :'( :'(
–----------------Feb 22 20:02:39 dhclient[283]: exiting.
Feb 22 20:02:39 dhclient[283]: exiting.
Feb 22 20:02:39 dhclient[283]: short write: wanted 21 got 0 bytes
Feb 22 20:02:39 dhclient[283]: short write: wanted 21 got 0 bytes
Feb 22 20:02:39 dhclient[283]: DHCPACK from 90.224.168.1
Feb 22 20:02:39 dhclient[283]: DHCPREQUEST on rl0 to 255.255.255.255 port 67
Feb 22 19:59:46 last message repeated 5 times
Feb 22 19:56:08 last message repeated 6 times
Feb 22 19:54:11 last message repeated 4 times
Feb 22 19:53:39 dhclient[283]: DHCPREQUEST on rl0 to 213.67.15.234 port 67
Feb 22 19:44:03 php: : FTP proxy disabled for interface opt2 - ignoring.
Feb 22 19:44:03 php: : FTP proxy disabled for interface opt1 - ignoring.
Feb 22 19:44:03 php: : FTP proxy disabled for interface LAN - ignoring.
Feb 22 19:44:02 check_reload_status: reloading filter -
damn! snapshot 02-21 is not working :'( :'( :'(
Yes the problem still exists and we have been racking our brains out – literally.
-
Please try http://snapshots.pfsense.com/FreeBSD6/RELENG_1/updates/pfSense-Full-Update-1.0.1-SNAPSHOT-02-21-2007.tgz
-
Sorry, not working either (snap 02-21)
–----------------------
Feb 24 05:03:45 dhclient[282]: exiting.
Feb 24 05:03:45 dhclient[282]: exiting.
Feb 24 05:03:45 dhclient[282]: short write: wanted 21 got 0 bytes
Feb 24 05:03:45 dhclient[282]: short write: wanted 21 got 0 bytes
Feb 24 05:03:45 dhclient[282]: DHCPACK from 90.224.168.1
Feb 24 05:03:45 dhclient[282]: DHCPREQUEST on rl0 to 255.255.255.255 port 67
Feb 24 05:02:41 last message repeated 4 times
Feb 24 04:58:09 last message repeated 3 times
Feb 24 04:56:02 last message repeated 3 times
Feb 24 04:55:34 dhclient[282]: DHCPREQUEST on rl0 to 213.67.15.234 port 67
Feb 24 04:45:58 php: : FTP proxy disabled for interface opt2 - ignoring.
Feb 24 04:45:58 php: : FTP proxy disabled for interface opt1 - ignoring.
Feb 24 04:45:58 php: : FTP proxy disabled for interface LAN - ignoring.
Feb 24 04:45:56 check_reload_status: reloading filter -
At this point reinstall. My dhclient has been rock solid for over 24 hours!
-
mine to, but only after i pushed the renew button the first time it died, strange
-
Make that 48 hours. And Vescovo has been running it for 48 hours on 2 wans with 180 second renewal time.
This issue is fixed for sure and verified now by 3 different people.
-
Thats nice to hear =)
But just one thing, could you reboot your pfsense and monitor it again ?
My issue always come after a while when pfsense is rebooted, and the issue disappears after i push the renew button.
-
Yes, it has been rebooted once.
-
Mine has been steady for the last 2 days as well.
-
I also get the dhcp problem only one time after each boot.
I have also been losing functionality of the DNS forwarder since upgrading to 1.0.2-0221 from 1.0.1 but that seems to have vanished since I started out with a fresh config. -
as i said, happens one time after reboot, then press renew and the issue disappears,
there is something magic about the renew button that doesn´t happen in the reboot process =) -
I have rebooted countless times and cannot reproduce this. Sorry.
-
I don't think I am affected by that bug, It's much worse for me :(
After about 12h uptime (this time) the interface went down, when i renewed the ip adress nothing worked correctly, I could not do nslookup. Didnt try anything else. I restarted the DNS forwarder, it made no difference. I'm not sure about this but my hardware could be very incompatible with pfsense 1.0.2/fbsd 5.2.Feb 27 08:43:36 kernel: arplookup 66.249.93.99 failed: could not allocate llinfo
Feb 27 08:43:36 kernel: arpresolve: can't allocate route for 66.249.93.99Just wanted to say this, I don't have time to look further into this at the moment.
EDIT: SNAPSHOT-02-27-2007 solved my problems
-
I don't think I am affected by that bug, It's much worse for me :(
After about 12h uptime (this time) the ip adress went down, when i renewed it nothing worked correctly, I could not do nslookup. Didnt try anything else. I restarted the DNS forwarder, it made no difference. I'm not sure about this but my hardware could be very incompatible with pfsense 1.0.2/fbsd 5.2.Feb 27 08:43:36 kernel: arplookup 66.249.93.99 failed: could not allocate llinfo
Feb 27 08:43:36 kernel: arpresolve: can't allocate route for 66.249.93.99This is not the same problem. Please start a new thread. And for the record, we do not use FreeBSD 5.2.
-
Feb 27 08:43:36 kernel: arplookup 66.249.93.99 failed: could not allocate llinfo
Feb 27 08:43:36 kernel: arpresolve: can't allocate route for 66.249.93.99Any possibility that you try to run PPPoE along with Multiwan like in the following thread?
http://forum.pfsense.org/index.php/topic,3554.0.htmlIf this is true please add your comments to this thread. If not please start a new one like Scott asked you to do.
-
i don´t know what you guys are using when you are testing the dhclient, but issue still exists:
Mar 1 17:38:47 dhclient[322]: exiting.
Mar 1 17:38:47 dhclient[322]: exiting.
Mar 1 17:38:47 dhclient[322]: short write: wanted 21 got 0 bytes
Mar 1 17:38:47 dhclient[322]: short write: wanted 21 got 0 bytes
Mar 1 17:38:47 dhclient[322]: DHCPACK from 90.224.168.1
Mar 1 17:38:47 dhclient[322]: DHCPREQUEST on rl0 to 255.255.255.255 port 67
Mar 1 17:36:26 last message repeated 3 times
Mar 1 17:32:37 last message repeated 6 times
Mar 1 17:30:36 last message repeated 3 times -
We lowered the lease time to 150 and used a dedicated testing box.
At this point we cannot reproduce the error. Reinstall.
-
i have done so 2 times already =)
-
Well sorry, 4 developers where able to reproduce it prior but under no conditions does it break now.
I don't know what to tell you at this point.
-
oh well, i just lay low for a while, and see if others having problems too,
thanks for all your hard work !
-
1.0.1-SNAPSHOT-02-21-2007
Uptime 3 days, 16:21
Still running :)
-
1.0.1-SNAPSHOT-02-21-2007
Uptime 3 days, 16:21
Still running :)
Great! Please continue to let us know the progress. We really think its nailed.
-
-
It seems to be working just fine now, thanks!
-
I've done a clean install with the latest official update from 08/03/2007 but my logs registeres the following rc.linkup message:
Last 50 system log entries
Mar 9 18:13:30 php: : Incorrect number of arguments passed rc.linkup…exiting.
Mar 9 18:13:30 php: : Arguments passed rc.linkup. ''
Mar 9 18:13:28 check_reload_status: rc.linkup starting
Mar 9 18:13:23 php: : phpDynDNS: No Change In My IP Address and/or 25 Days Has Not Past. Not Updating Dynamic DNS Entry.It's normal ?
[]'s
-
Yes, those are debugging statements and looks fine.
-
1.0.1-SNAPSHOT-02-27-2007
Uptime 7 days, 16:51Still running, updating to pfSense-Full-Update-1.0.1-SNAPSHOT-03-08-2007
-
1.0.1-SNAPSHOT-02-27-2007
Uptime 7 days, 16:51Still running, updating to pfSense-Full-Update-1.0.1-SNAPSHOT-03-08-2007
Great! Thanks for the update.
-
Don't know if this is the same issue, but i noticed this yesterday.
Running 1.0.1-SNAPSHOT-03-18-2007 built on Thu Mar 8 22:14:44 EST 2007.For some unknown reason, my pfSense box lost it's WAN dhcp ipaddress, but my
WatchGuard box connected to the same ISP outlet(i use a switch to get several ports)
did not have any problems recorded, and it to runs on a WAN dhcp. The WatchGuard box
uses something called udhcpc. I don't know if it's better, worse or the same as dhclient.Pressing the Renew button in Status–>Interfaces had no problem of getting a ipaddress.
I pressed the button around 20:15.Got this from the syslog(if was not at home when this happened):
| Mar 12 17:35:24 dhclient[261]: DHCPREQUEST on xl1 to 81.228.3.186 port 67 |
| Mar 12 17:41:13 last message repeated 3 times |
| Mar 12 17:44:02 dhclient[261]: DHCPDISCOVER on xl1 to 255.255.255.255 port 67 interval 6 |
| Mar 12 17:44:02 dhclient[261]: DHCPOFFER from 81.236.128.1 |
| Mar 12 17:44:04 dhclient[261]: DHCPREQUEST on xl1 to 255.255.255.255 port 67 |
| Mar 12 17:44:04 dhclient[261]: DHCPACK from 81.236.128.1 |
| Mar 12 17:44:04 dhclient[261]: bound to 81.236.134.30 – renewal in 600 seconds. |
| Mar 12 17:44:34 SnortStartup[55432]: Ram free BEFORE starting Snort: 108M – Ram free AFTER starting Snort: 107M -- Mode ac-sparsebands -- Snort memory usage: |
| Mar 12 17:44:51 SnortStartup[55465]: Ram free BEFORE starting Snort: 107M – Ram free AFTER starting Snort: 108M -- Mode ac-sparsebands -- Snort memory usage: |
| Mar 12 17:54:04 dhclient[261]: DHCPREQUEST on xl1 to 81.228.3.186 port 67 |
| Mar 12 17:54:43 last message repeated 3 times |
| Mar 12 17:56:45 last message repeated 7 times |
| Mar 12 18:00:44 last message repeated 9 times |
| Mar 12 18:01:39 dnsmasq[572]: reading /etc/resolv.conf |
| Mar 12 18:01:39 dnsmasq[572]: using nameserver 195.67.199.41#53 |
| Mar 12 18:01:39 dnsmasq[572]: using nameserver 195.67.199.40#53 |
| Mar 12 18:01:39 dnsmasq[572]: using nameserver 195.67.199.39#53 |
| Mar 12 18:02:17 dhclient[261]: DHCPREQUEST on xl1 to 255.255.255.255 port 67 |
| Mar 12 18:02:17 dhclient[261]: DHCPACK from 81.236.128.1 |
| Mar 12 18:02:17 dhclient[261]: short write: wanted 21 got 0 bytes |
| Mar 12 18:02:17 dhclient[261]: exiting. |
| Mar 12 20:13:17 login: login on ttyv0 as root |
| Mar 12 20:15:57 dhclient[81132]: DHCPDISCOVER on xl1 to 255.255.255.255 port 67 interval 5 |
| Mar 12 20:16:02 dhclient[81132]: DHCPDISCOVER on xl1 to 255.255.255.255 port 67 interval 6 |
| Mar 12 20:16:08 dhclient[81132]: DHCPDISCOVER on xl1 to 255.255.255.255 port 67 interval 7 |
| Mar 12 20:16:08 dhclient[81132]: DHCPOFFER from 81.236.128.1 |
| Mar 12 20:16:10 dhclient[81132]: DHCPREQUEST on xl1 to 255.255.255.255 port 67 |
| Mar 12 20:16:10 dhclient[81132]: DHCPACK from 81.236.128.1 |
| Mar 12 20:16:10 dhclient[81132]: bound to 81.236.134.30 – renewal in 600 seconds. | -
Remove snort and see if the problem persists.
-
removing snort won´t change a thing, he got the same error i do,and i don´t use snort. And as i said it only happens one time after reboot, pressing the renew button clears the problem.
the dhclient error is not fixed !
-
I removed Snort a couple of hours ago, and will give it a go
try to reproduce the issue by rebooting the pfSense computer
and not reinstalling Snort for a while. -
removing snort won´t change a thing, he got the same error i do,and i don´t use snort. And as i said it only happens one time after reboot, pressing the renew button clears the problem.
the dhclient error is not fixed !
Calm down there pal. Snort gets RELOADED at the same time that dhclient invokes… So you don't know what your talking about quite frankly.
-
Alright, it happened again a couple of minutes ago.
Pressing the Renew button gave me back my ipaddress within 5 seconds.
Checked traffic on my WatchGuard box and it did not record any problem with the internet.I pressed the Renew button around 08:27.
This is what i have from syslog:
Mar 15 07:00:57 last message repeated 4 times
Mar 15 07:01:30 dhclient[269]: DHCPREQUEST on xl1 to 255.255.255.255 port 67
Mar 15 07:01:30 dhclient[269]: DHCPACK from 81.236.128.1
Mar 15 07:01:31 dhclient[269]: bound to 81.236.134.30 – renewal in 600 seconds.
Mar 15 07:11:30 dhclient[269]: DHCPREQUEST on xl1 to 81.228.3.186 port 67
Mar 15 07:12:01 last message repeated 3 times
Mar 15 07:14:07 last message repeated 4 times
Mar 15 07:18:51 last message repeated 12 times
Mar 15 07:19:58 dhclient[269]: DHCPREQUEST on xl1 to 255.255.255.255 port 67
Mar 15 07:19:58 dhclient[269]: DHCPACK from 81.236.128.1
Mar 15 07:19:59 dhclient[269]: bound to 81.236.134.30 – renewal in 600 seconds.
Mar 15 07:29:58 dhclient[269]: DHCPREQUEST on xl1 to 81.228.3.186 port 67
Mar 15 07:30:26 last message repeated 2 times
Mar 15 07:32:35 last message repeated 4 times
Mar 15 07:36:11 last message repeated 3 times
Mar 15 07:39:59 dhclient[269]: DHCPDISCOVER on xl1 to 255.255.255.255 port 67 interval 7
Mar 15 07:40:06 dhclient[269]: DHCPDISCOVER on xl1 to 255.255.255.255 port 67 interval 15
Mar 15 07:40:06 dhclient[269]: DHCPOFFER from 81.236.128.1
Mar 15 07:40:08 dhclient[269]: DHCPREQUEST on xl1 to 255.255.255.255 port 67
Mar 15 07:40:08 dhclient[269]: DHCPACK from 81.236.128.1
Mar 15 07:40:08 dhclient[269]: bound to 81.236.134.30 – renewal in 600 seconds.
Mar 15 07:42:02 dnsmasq[529]: reading /etc/resolv.conf
Mar 15 07:42:02 dnsmasq[529]: using nameserver 195.67.199.41#53
Mar 15 07:42:02 dnsmasq[529]: using nameserver 195.67.199.40#53
Mar 15 07:42:02 dnsmasq[529]: using nameserver 195.67.199.39#53
Mar 15 07:50:08 dhclient[269]: DHCPREQUEST on xl1 to 81.228.3.186 port 67
Mar 15 07:50:38 last message repeated 3 times
Mar 15 07:52:41 last message repeated 5 times
Mar 15 07:55:06 dhclient[269]: DHCPREQUEST on xl1 to 81.228.3.186 port 67
Mar 15 08:00:10 dhclient[269]: DHCPDISCOVER on xl1 to 255.255.255.255 port 67 interval 3
Mar 15 08:00:10 dhclient[269]: DHCPOFFER from 81.236.128.1
Mar 15 08:00:12 dhclient[269]: DHCPREQUEST on xl1 to 255.255.255.255 port 67
Mar 15 08:00:12 dhclient[269]: DHCPACK from 81.236.128.1
Mar 15 08:00:12 dhclient[269]: bound to 81.236.134.30 – renewal in 600 seconds.
Mar 15 08:01:33 dnsmasq[529]: reading /etc/resolv.conf
Mar 15 08:01:33 dnsmasq[529]: using nameserver 195.67.199.41#53
Mar 15 08:01:33 dnsmasq[529]: using nameserver 195.67.199.40#53
Mar 15 08:01:33 dnsmasq[529]: using nameserver 195.67.199.39#53
Mar 15 08:10:12 dhclient[269]: DHCPREQUEST on xl1 to 81.228.3.186 port 67
Mar 15 08:10:33 last message repeated 2 times
Mar 15 08:11:41 last message repeated 4 times
Mar 15 08:15:34 last message repeated 2 times
Mar 15 08:20:13 dhclient[269]: short write: wanted 22 got 0 bytes
Mar 15 08:20:13 dhclient[269]: exiting.
Mar 15 08:27:37 dhclient[68835]: DHCPDISCOVER on xl1 to 255.255.255.255 port 67 interval 8
Mar 15 08:27:37 dhclient[68835]: DHCPOFFER from 81.236.128.1
Mar 15 08:27:39 dhclient[68835]: DHCPREQUEST on xl1 to 255.255.255.255 port 67
Mar 15 08:27:39 dhclient[68835]: DHCPACK from 81.236.128.1
Mar 15 08:27:40 dhclient[68835]: bound to 81.236.134.30 – renewal in 600 seconds.
Mar 15 08:27:42 login: login on ttyv0 as root
Mar 15 08:28:03 dnsmasq[529]: reading /etc/resolv.conf
Mar 15 08:28:03 dnsmasq[529]: using nameserver 195.67.199.41#53
Mar 15 08:28:03 dnsmasq[529]: using nameserver 195.67.199.40#53
Mar 15 08:28:03 dnsmasq[529]: using nameserver 195.67.199.39#53 -
We REALLY wish that we could reproduce this… Everything we have tried does not reproduce it :(