What's new

DNSMASQ DHCPOFFER problems

  • SNBForums Code of Conduct

    SNBForums is a community for everyone, no matter what their level of experience.

    Please be tolerant and patient of others, especially newcomers. We are all here to share and learn!

    The rules are simple: Be patient, be nice, be helpful or be gone!

Tso-jie

Occasional Visitor
Hello

I`m running 384.7_2 on a AC68U and having a problem with DNSMASQ-DHCP..was having it since 3.8xxx

Oct 22 09:56:58 dnsmasq-dhcp[245]: DHCPREQUEST(br0) 192.168.1.233 ac:xxxxxx
Oct 22 09:56:58 dnsmasq-dhcp[245]: DHCPACK(br0) 192.168.1.233 ac:xxxxxxxx HF-LPB100

Every like 10 minutes one of the 20 wifi devices do a request.

What is here the problem?
 
Every like 10 minutes one of the 20 wifi devices do a request.
Are you saying that the same device is doing this every 10 minutes, or are you saying that out of 20 devices a different one does it every 10 minutes?
 
Yes... all the devices do a reguest after a fe minutes again and again

Here is a small log.



Oct 22 09:34:22 dnsmasq-dhcp[245]: DHCPREQUEST(br0) 192.168.1.233 ac:cf
Oct 22 09:34:22 dnsmasq-dhcp[245]: DHCPACK(br0) 192.168.1.233 ac:cfHF-LPB100
Oct 22 09:36:05 dnsmasq-dhcp[245]: DHCPREQUEST(br0) 192.168.1.129 cc:78:
Oct 22 09:36:05 dnsmasq-dhcp[245]: DHCPACK(br0) 192.168.1.129 cc:78:
Oct 22 09:49:55 dnsmasq-dhcp[245]: DHCPREQUEST(br0) 192.168.1.220 60:01
Oct 22 09:49:55 dnsmasq-dhcp[245]: DHCPACK(br0) 192.168.1.220 60:01:94 WIfibulb
Oct 22 09:50:19 dnsmasq-dhcp[245]: DHCPREQUEST(br0) 192.168.1.222 78:e1:
Oct 22 09:50:19 dnsmasq-dhcp[245]: DHCPACK(br0) 192.168.1.222 78:e1:03: amazon-5203d8791
Oct 22 09:50:41 dnsmasq-dhcp[245]: DHCPREQUEST(br0) 192.168.1.29 f0:85
Oct 22 09:50:41 dnsmasq-dhcp[245]: DHCPACK(br0) 192.168.1.29 f0:85
Oct 22 09:52:27 dnsmasq-dhcp[245]: DHCPREQUEST(br0) 192.168.1.212 30:ae:
Oct 22 09:52:27 dnsmasq-dhcp[245]: DHCPACK(br0) 192.168.1.212 30:ae ESP-Easy-0
Oct 22 09:52:29 dnsmasq-dhcp[245]: DHCPREQUEST(br0) 192.168.1.26 78:0f
Oct 22 09:52:29 dnsmasq-dhcp[245]: DHCPACK(br0) 192.168.1.26 78:0f: RMMINI
Oct 22 09:52:36 dnsmasq-dhcp[245]: DHCPREQUEST(br0) 192.168.1.99 50:c7
Oct 22 09:52:36 dnsmasq-dhcp[245]: DHCPACK(br0) 192.168.1.99 50:c7:bf GARAGE_TPLINK
Oct 22 09:52:36 dnsmasq-dhcp[245]: DHCPREQUEST(br0) 192.168.1.153 50:c7
Oct 22 09:52:36 dnsmasq-dhcp[245]: DHCPACK(br0) 192.168.1.153 50:c7:bfTPLINK_PLUG2
Oct 22 09:52:46 dnsmasq-dhcp[245]: DHCPREQUEST(br0) 192.168.1.239 80:7
Oct 22 09:52:46 dnsmasq-dhcp[245]: DHCPACK(br0) 192.168.1.239 80:7d Room_Switch
Oct 22 09:52:48 dnsmasq-dhcp[245]: DHCPREQUEST(br0) 192.168.1.239 80
Oct 22 09:52:48 dnsmasq-dhcp[245]: DHCPACK(br0) 192.168.1.239 80:7d Room_Switch
Oct 22 09:53:11 kernel: [tdts_shell_ioctl_stat:256] Recv ioctl req with op 2
Oct 22 09:53:15 dnsmasq-dhcp[245]: DHCPREQUEST(br0) 192.168.1.60 84:
Oct 22 09:53:15 dnsmasq-dhcp[245]: DHCPACK(br0) 192.168.1.60 84:Garage_ESP
Oct 22 09:53:17 rc_service: httpd 258:notify_rc restart_wlcscan
Oct 22 09:53:34 dnsmasq-dhcp[245]: DHCPREQUEST(br0) 192.168.1.152 80:7d:
Oct 22 09:53:34 dnsmasq-dhcp[245]: DHCPACK(br0) 192.168.1.152 80:7d: Tempsensor
Oct 22 09:55:57 dnsmasq-dhcp[245]: DHCPREQUEST(br0) 192.168.1.168 b8:
Oct 22 09:55:57 dnsmasq-dhcp[245]: DHCPACK(br0) 192.168.1.168 b8:27: homeng
Oct 22 09:56:01 dnsmasq-dhcp[245]: DHCPREQUEST(br0) 192.168.1.67 06:
Oct 22 09:56:01 dnsmasq-dhcp[245]: DHCPACK(br0) 192.168.1.67 06:61:android-78875fc3769f1b6a
Oct 22 09:56:58 dnsmasq-dhcp[245]: DHCPREQUEST(br0) 192.168.1.233 ac:cf:
Oct 22 09:56:58 dnsmasq-dhcp[245]: DHCPACK(br0) 192.168.1.233 ac:cf: HF-LPB100
Oct 22 10:06:44 dnsmasq-dhcp[245]: DHCPDISCOVER(br0) 78:0f:
Oct 22 10:06:44 dnsmasq-dhcp[245]: DHCPOFFER(br0) 192.168.1.26 78:0f:
Oct 22 10:06:44 dnsmasq-dhcp[245]: DHCPREQUEST(br0) 192.168.1.26 RMMINI
Oct 22 10:10:13 dnsmasq-dhcp[245]: DHCPREQUEST(br0) 192.168.1.129 cc:78:
Oct 22 10:10:13 dnsmasq-dhcp[245]: DHCPACK(br0) 192.168.1.129 cc:78Lisas-iPad
Oct 22 10:14:42 dnsmasq-dhcp[245]: DHCPREQUEST(br0) 192.168.1.29 f0:85:
Oct 22 10:14:42 dnsmasq-dhcp[245]: DHCPACK(br0) 192.168.1.29 f0:85
Oct 22 10:15:44 dnsmasq-dhcp[245]: DHCPREQUEST(br0) 192.168.1.220 60:01
Oct 22 10:15:44 dnsmasq-dhcp[245]: DHCPACK(br0) 192.168.1.220 60:01WIfibulb
Oct 22 10:15:56 dnsmasq-dhcp[245]: DHCPREQUEST(br0) 192.168.1.222 78:e1
Oct 22 10:15:56 dnsmasq-dhcp[245]: DHCPACK(br0) 192.168.1.222 78: amazon-5203d8791
 
Check what you have set for the DHCP Lease Time on the router at LAN > DHCP Server. It should be something like 86400.
 
I just upgraded today and seen that my DNS are gone also.. and the lease time is set to 3200.. very strange.

Enable the DHCP Server
Yes
Hide DHCP/RA queries No
RT-AC68U's Domain Name
IP Pool Starting Address
IP Pool Ending Address
Lease time: 3200
Default Gateway

But it was at 86400
 
Maybe your NVRAM got corrupted when you upgraded. What firmware version were you on before the upgrade?
 
Right now I`m using 384.7_2

But I was having this problem a long time and now its working on my nerves :)
I got home assistant and but the time a devices keeps asking for an IP, HA logs that it was not able to communicate with the device.. resulting that for an automation could not be completed..

I`ve done a factory reset after installing a Firmware many times.. but this keeps on going. I waited patiently for a fix but seems there is not.. but perhaps there is a workaround for this?
 
See..I`ve have changed to the default 86400 Lease time and still the Request..check the times.

Oct 22 10:45:21 dnsmasq-dhcp[8338]: DHCPREQUEST(br0) 192.168.1.168 b8:
Oct 22 10:45:21 dnsmasq-dhcp[8338]: DHCPACK(br0) 192.168.1.168 b8:27:
Oct 22 10:45:43 dnsmasq-dhcp[8338]: DHCPREQUEST(br0) 192.168.1.212 30:ae
Oct 22 10:45:43 dnsmasq-dhcp[8338]: DHCPACK(br0) 192.168.1.212 30:a ESP-Easy-0
Oct 22 10:45:56 dnsmasq-dhcp[8338]: DHCPREQUEST(br0) 192.168.1.153 50:
Oct 22 10:45:56 dnsmasq-dhcp[8338]: DHCPACK(br0) 192.168.1.153 50:c TPLINK_PLUG2
Oct 22 10:45:58 dnsmasq-dhcp[8338]: DHCPREQUEST(br0) 192.168.1.99 50:
Oct 22 10:45:58 dnsmasq-dhcp[8338]: DHCPACK(br0) 192.168.1.99 50:c7:bTPLINK
Oct 22 10:47:15 dnsmasq-dhcp[8338]: DHCPREQUEST(br0) 192.168.1.239 8
Oct 22 10:47:15 dnsmasq-dhcp[8338]: DHCPACK(br0) 192.168.1.239 80:7Room_Switch
Oct 22 10:47:17 dnsmasq-dhcp[8338]: DHCPREQUEST(br0) 192.168.1.239 80:7
Oct 22 10:47:17 dnsmasq-dhcp[8338]: DHCPACK(br0) 192.168.1.239 80:7dRoom_Switch
Oct 22 10:47:21 dnsmasq-dhcp[8338]: DHCPREQUEST(br0) 192.168.1.239 80:7
Oct 22 10:47:21 dnsmasq-dhcp[8338]: DHCPACK(br0) 192.168.1.239 80: Room_Switch
Oct 22 10:47:47 dnsmasq-dhcp[8338]: DHCPREQUEST(br0) 192.168.1.60 84:
Oct 22 10:47:47 dnsmasq-dhcp[8338]: DHCPACK(br0) 192.168.1.60 84:f3:ebGarage_ESP
Oct 22 10:48:10 dnsmasq-dhcp[8338]: DHCPREQUEST(br0) 192.168.1.152 80:7d
Oct 22 10:48:10 dnsmasq-dhcp[8338]: DHCPACK(br0) 192.168.1.152 80: Tempsensor
Oct 22 10:53:11 kernel: [tdts_shell_ioctl_stat:256] Recv ioctl req with op 2
Oct 22 11:03:43 dnsmasq-dhcp[8338]: DHCPREQUEST(br0) 192.168.1.29 f0:8
Oct 22 11:03:43 dnsmasq-dhcp[8338]: DHCPACK(br0) 192.168.1.29 f0:8
Oct 22 11:04:26 dnsmasq-dhcp[8338]: DHCPREQUEST(br0) 192.168.1.129
Oct 22 11:04:26 dnsmasq-dhcp[8338]: DHCPACK(br0) 192.168.1.129 cc:78:5iPad
Oct 22 11:04:48 dnsmasq-dhcp[8338]: DHCPREQUEST(br0) 192.168.1.233 a
Oct 22 11:04:48 dnsmasq-dhcp[8338]: DHCPACK(br0) 192.168.1.233 ac:c HF-LPB100
 
I`ve done a factory reset after installing a Firmware many times.. but this keeps on going. I waited patiently for a fix but seems there is not.. but perhaps there is a workaround for this?
I was going to suggest a factory reset. That should have set the DHCP lease time back to 86400, unless of course you are reloading your old settings from a backup which would negate the effect of the factory reset.

See..I`ve have changed to the default 86400 Lease time and still the Request..check the times.
You have to wait for each of the devices to expire their current lease and request the new one. I don't see any repeated requests (from the same client) like before so I suspect it's now working. You'll have to wait a bit longer to know for sure.
 
they are repeating....asking every now and then..

I`ve also installed and Fatory reset and begin from Scratch with the whole settings. same results :-(

What else you think could be the culprit?

Me personlly think its the DNSMASQ they are using.. Sure its not a finished thing as they mentioned a long time since they went to it, that its in a test stage.

- CHANGED: Updated dnsmasq to v2.80test8 (themiron).

Whats your opinion about that?
 
dnsmasq is one of the oldest most stable products there is and is used in millions of routers from all manufactures. The test/bug fix versions tend to add or address some of the newer more esoteric features of DNS or DHCP. A fundamental function like acquiring a DHCP lease is not something that should ever be an issue. If there were problems with that function forums around the world would be flooded with bug reports.

Given that no one else is reporting this issue and that you say that you've had this problem with multiple versions I think it's extremely unlikely to be a bug in dnsmasq itself.

If your router is not resetting values like the DHCP lease time even after a factory reset that would suggest there is a more general problem with your router.
 
I think that I am not the only one with this problem..there is a lot of people that use Merlin with this problem.. I put the links for you,....anyway I could not find all cause I`ve been searching and had found lots people with this issue.

https://www.snbforums.com/threads/dnsmasq-dhcp-failure-ac3100-any-idea.45008/

https://www.snbforums.com/threads/rt-ac68u-dhcprequest-br0-dhcpack-br0.30573/

https://www.snbforums.com/threads/merlin-firmware-380-57-log-message-every-10-minutes.29431/

https://rachio.discoursehosting.net/t/constant-dhcp-requests/2217
 
As for right now... Checkout the reuest repeating.. .

Oct 22 11:38:59 dnsmasq-dhcp[8338]: DHCPACK(br0) 192.168.1.212 30:ae:a4:23:4b:68 ESP-Easy-0
Oct 22 11:41:44 dnsmasq-dhcp[8338]: DHCPREQUEST(br0) 192.168.1.239 80:7d:3a:46:fb:66
Oct 22 11:41:44 dnsmasq-dhcp[8338]: DHCPACK(br0) 192.168.1.239 80:7d:3a:46:fb:66 Room_Switch
Oct 22 11:41:45 dnsmasq-dhcp[8338]: DHCPREQUEST(br0) 192.168.1.239 80:7d:3a:46:fb:66
Oct 22 11:41:45 dnsmasq-dhcp[8338]: DHCPACK(br0) 192.168.1.239 80:7d:3a:46:fb:66 Room_Switch
Oct 22 11:41:50 dnsmasq-dhcp[8338]: DHCPREQUEST(br0) 192.168.1.239 80:7d:3a:46:fb:66
Oct 22 11:41:50 dnsmasq-dhcp[8338]: DHCPACK(br0) 192.168.1.239 80:7d:3a:46:fb:66 Room_Switch
Oct 22 11:42:19 dnsmasq-dhcp[8338]: DHCPREQUEST(br0) 192.168.1.60 84:f3:eb:b2:f1:da
Oct 22 11:42:19 dnsmasq-dhcp[8338]: DHCPACK(br0) 192.168.1.60 84:f3:eb:b2:f1:da Garage_ESP
Oct 22 11:42:46 dnsmasq-dhcp[8338]: DHCPREQUEST(br0) 192.168.1.152 80:7d:3a:59:24:04
Oct 22 11:42:46 dnsmasq-dhcp[8338]: DHCPACK(br0) 192.168.1.152 80:7d:3a:59:24:04 Tempsensor
Oct 22 11:42:47 dnsmasq-dhcp[8338]: DHCPREQUEST(br0) 192.168.1.152 80:7d:3a:59:24:04
Oct 22 11:42:47 dnsmasq-dhcp[8338]: DHCPACK(br0) 192.168.1.152 80:7d:3a:59:24:04 Tempsensor
Oct 22 11:42:51 dnsmasq-dhcp[8338]: DHCPREQUEST(br0) 192.168.1.152 80:7d:3a:59:24:04
Oct 22 11:42:51 dnsmasq-dhcp[8338]: DHCPACK(br0) 192.168.1.152 80:7d:3a:59:24:04 Tempsensor
Oct 22 11:48:03 kernel: nvram: consolidating space!
Oct 22 11:50:02 dnsmasq-dhcp[8338]: DHCPREQUEST(br0) 192.168.1.233 ac:cf:23:81:7e:70
Oct 22 11:50:02 dnsmasq-dhcp[8338]: DHCPACK(br0) 192.168.1.233 ac:cf:23:81:7e:70 HF-LPB100
 
Yes I've seen those other posts (and even responded to some). In all cases it wasn't an issue with dnsmaq (or DHCP) per se. It was either a client issue or sometimes WiFi related.

Are these wireless devices? Have a look at the wireless log on the router. Find some of the devices that have the problem and see how long they have been connected. Are they continuously connected to the router, or do they keep disconnecting/reconnecting in line with the DHCP requests?

Do you have a PC that is also showing this problem? If so could you post the output of "ipconfig /all".
 
they are repeating....asking every now and then..

I`ve also installed and Fatory reset and begin from Scratch with the whole settings. same results :-(

What else you think could be the culprit?

Me personlly think its the DNSMASQ they are using.. Sure its not a finished thing as they mentioned a long time since they went to it, that its in a test stage.

- CHANGED: Updated dnsmasq to v2.80test8 (themiron).

Whats your opinion about that?

2.80 went final just after test8, and barely contained 2 or maybe 3 code changes at most, so for all intent and purposes, test8 was nearly final.
 
You can check the lease time shown on System Log -> DHCP Leases. If you see a short duration, then the issue is your DHCP configuration.
 
I`ve checked..

One device seems to be going up down.. its time for now is 19 minutes.. the rest of the 12 wifi devices seems to have 3hours and 27 min...
 
I`ve checked..

One device seems to be going up down.. its time for now is 19 minutes.. the rest of the 12 wifi devices seems to have 3hours and 27 min...

Once you've corrected the lease time on your router, reboot those devices to force them to obtain a new lease, with the new duration. My devices correctly get 24 hours leases here:

upload_2018-10-22_12-32-9.png
 
this is another log after the last post of 11:50am

Oct 22 11:53:12 kernel: [tdts_shell_ioctl_stat:256] Recv ioctl req with op 2
Oct 22 11:56:52 ovpn-server1[596]: client/200.26.199.110 [client] Inactivity timeout (--ping-restart), restarting
Oct 22 11:56:52 ovpn-server1[596]: client/200.26.199.110 SIGUSR1[soft,ping-restart] received, client-instance restarting
Oct 22 11:58:57 dnsmasq-dhcp[8338]: DHCPREQUEST(br0) 192.168.1.220 60:01:94:15:bf:b1
Oct 22 11:58:57 dnsmasq-dhcp[8338]: DHCPACK(br0) 192.168.1.220 60:01:94:15:bf:b1 WIfibulb
Oct 22 12:05:37 dnsmasq-dhcp[8338]: DHCPREQUEST(br0) 192.168.1.212 30:ae:a4:23:4b:68
Oct 22 12:05:37 dnsmasq-dhcp[8338]: DHCPACK(br0) 192.168.1.212 30:ae:a4:23:4b:68 ESP-Easy-0
Oct 22 12:06:41 dnsmasq-dhcp[8338]: DHCPDISCOVER(br0) 78:0f:77:5a:d4:9b
Oct 22 12:06:41 dnsmasq-dhcp[8338]: DHCPOFFER(br0) 192.168.1.26 78:0f:77:5a:d4:9b
Oct 22 12:06:41 dnsmasq-dhcp[8338]: DHCPREQUEST(br0) 192.168.1.26 78:0f:77:5a:d4:9b
Oct 22 12:06:41 dnsmasq-dhcp[8338]: DHCPACK(br0) 192.168.1.26 78:0f:77:5a:d4:9b RMMINI
Oct 22 12:08:58 dnsmasq-dhcp[8338]: DHCPREQUEST(br0) 192.168.1.239 80:7d:3a:46:fb:66
Oct 22 12:08:58 dnsmasq-dhcp[8338]: DHCPACK(br0) 192.168.1.239 80:7d:3a:46:fb:66 Room_Switch
Oct 22 12:09:35 dnsmasq-dhcp[8338]: DHCPREQUEST(br0) 192.168.1.60 84:f3:eb:b2:f1:da
Oct 22 12:09:35 dnsmasq-dhcp[8338]: DHCPACK(br0) 192.168.1.60 84:f3:eb:b2:f1:da Garage_ESP
Oct 22 12:10:03 dnsmasq-dhcp[8338]: DHCPREQUEST(br0) 192.168.1.152 80:7d:3a:59:24:04
Oct 22 12:10:03 dnsmasq-dhcp[8338]: DHCPACK(br0) 192.168.1.152 80:7d:3a:59:24:04 Tempsensor
Oct 22 12:12:38 dnsmasq-dhcp[8338]: DHCPREQUEST(br0) 192.168.1.233 ac:cf:23:81:7e:70
Oct 22 12:12:38 dnsmasq-dhcp[8338]: DHCPACK(br0) 192.168.1.233 ac:cf:23:81:7e:70 HF-LPB100
 

Latest threads

Sign Up For SNBForums Daily Digest

Get an update of what's new every day delivered to your mailbox. Sign up here!
Top