I've been having issues with PacketFence DHCP performance on the registration network. Maybe someone can suggest a solution or a way to troubleshoot. I have tried everything I could. My setup: VM with AlmaLinux 8 and PacketFence 12.0. The issue started on 11.2 and I upgraded to see if it resolves but no luck. Issue: Clients on the registration network randomly fail to get a lease when many IP addresses are still available in the DHCP scope. DHCP log fills up with the following records: (note IP address 192.168.32.10 is the first in the scope) Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="Temporarily declaring 192.168.32.10 as unusable" pid=3388964 mac=7a:9c:31:98:ae:c8 Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="7a:9c:31:98:ae:c8 in arp table Ip 192.168.32.10 is already own by f4:f5:24:3a:50:9f" pid=3388964 mac=7a:9c:31:98:ae:c8 Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="7a:9c:31:98:ae:c8 192.168.32.10 Added back in the pool none on index 0" pid=3388964 Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="6a:ff:6f:2f:22:2d Ip 192.168.32.10 already in use, trying next" pid=3388964 mac=6a:ff:6f:2f:22:2d Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="Temporarily declaring 192.168.32.10 as unusable" pid=3388964 mac=6a:ff:6f:2f:22:2d Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="62:96:e8:82:03:10 Ip 192.168.32.10 already in use, trying next" pid=3388964 mac=62:96:e8:82:03:10 Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="Temporarily declaring 192.168.32.10 as unusable" pid=3388964 mac=62:96:e8:82:03:10 Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="6a:ff:6f:2f:22:2d in arp table Ip 192.168.32.10 is already own by f4:f5:24:3a:50:9f" pid=3388964 mac=6a:ff:6f:2f:22:2d Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="62:96:e8:82:03:10 in arp table Ip 192.168.32.10 is already own by f4:f5:24:3a:50:9f" pid=3388964 mac=62:96:e8:82:03:10 Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="6a:ff:6f:2f:22:2d 192.168.32.10 Added back in the pool none on index 0" pid=3388964 Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="62:96:e8:82:03:10 192.168.32.10 Added back in the pool none on index 0" pid=3388964 Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="fa:12:5b:e9:00:93 Ip 192.168.32.10 already in use, trying next" pid=3388964 mac=fa:12:5b:e9:00:93 Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="Temporarily declaring 192.168.32.10 as unusable" pid=3388964 mac=fa:12:5b:e9:00:93 Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="fa:12:5b:e9:00:93 in arp table Ip 192.168.32.10 is already own by f4:f5:24:3a:50:9f" pid=3388964 mac=fa:12:5b:e9:00:93 Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="fa:12:5b:e9:00:93 192.168.32.10 Added back in the pool none on index 0" pid=3388964 Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="3e:b9:99:63:ce:2f Ip 192.168.32.10 already in use, trying next" pid=3388964 mac=3e:b9:99:63:ce:2f Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="c6:66:d3:0d:17:87 Ip 192.168.32.10 already in use, trying next" pid=3388964 mac=c6:66:d3:0d:17:87 Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="5e:f2:bb:26:ad:fb Ip 192.168.32.10 already in use, trying next" pid=3388964 mac=5e:f2:bb:26:ad:fb Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="Temporarily declaring 192.168.32.10 as unusable" pid=3388964 mac=c6:66:d3:0d:17:87 Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="Temporarily declaring 192.168.32.10 as unusable" pid=3388964 mac=5e:f2:bb:26:ad:fb Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="c6:66:d3:0d:17:87 in arp table Ip 192.168.32.10 is already own by f4:f5:24:3a:50:9f" pid=3388964 mac=c6:66:d3:0d:17:87 Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="5e:f2:bb:26:ad:fb in arp table Ip 192.168.32.10 is already own by f4:f5:24:3a:50:9f" pid=3388964 mac=5e:f2:bb:26:ad:fb Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="c6:66:d3:0d:17:87 192.168.32.10 Added back in the pool none on index 0" pid=3388964 Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="3e:b9:99:63:ce:2f 192.168.32.10 Added back in the pool none on index 0" pid=3388964 Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="Temporarily declaring 192.168.32.10 as unusable" pid=3388964 mac=3e:b9:99:63:ce:2f Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="5e:f2:bb:26:ad:fb 192.168.32.10 Added back in the pool none on index 0" pid=3388964 Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="3e:b9:99:63:ce:2f in arp table Ip 192.168.32.10 is already own by f4:f5:24:3a:50:9f" pid=3388964 mac=3e:b9:99:63:ce:2f Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="d6:6d:a1:b8:bb:d1 Ip 192.168.32.10 already in use, trying next" pid=3388964 mac=d6:6d:a1:b8:bb:d1 Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="fa:64:93:d9:df:bc Ip 192.168.32.10 already in use, trying next" pid=3388964 mac=fa:64:93:d9:df:bc Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="Temporarily declaring 192.168.32.10 as unusable" pid=3388964 mac=d6:6d:a1:b8:bb:d1 Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="Temporarily declaring 192.168.32.10 as unusable" pid=3388964 mac=fa:64:93:d9:df:bc Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="fa:64:93:d9:df:bc in arp table Ip 192.168.32.10 is already own by f4:f5:24:3a:50:9f" pid=3388964 mac=fa:64:93:d9:df:bc Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="d6:6d:a1:b8:bb:d1 in arp table Ip 192.168.32.10 is already own by f4:f5:24:3a:50:9f" pid=3388964 mac=d6:6d:a1:b8:bb:d1 Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="fa:64:93:d9:df:bc 192.168.32.10 Added back in the pool none on index 0" pid=3388964 Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="d6:6d:a1:b8:bb:d1 192.168.32.10 Added back in the pool none on index 0" pid=3388964 Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="Releasing previously pingable IP 192.168.32.10 back into the pool" pid=3388964 mac=62:96:e8:82:03:10 Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="Releasing previously pingable IP 192.168.32.10 back into the pool" pid=3388964 mac=6a:ff:6f:2f:22:2d Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="Releasing previously pingable IP 192.168.32.10 back into the pool" pid=3388964 mac=1a:e3:b0:35:f5:39 Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="Releasing previously pingable IP 192.168.32.10 back into the pool" pid=3388964 mac=da:10:a0:20:5b:64 Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="Releasing previously pingable IP 192.168.32.10 back into the pool" pid=3388964 mac=5e:f2:bb:26:ad:fb Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="Releasing previously pingable IP 192.168.32.10 back into the pool" pid=3388964 mac=3e:b9:99:63:ce:2f Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="Releasing previously pingable IP 192.168.32.10 back into the pool" pid=3388964 mac=8a:9c:ec:65:de:5a Oct 14 11:15:17 rpsnac pfdhcp[3388964]: t=2022-10-14T11:15:17-0400 lvl=info msg="Releasing previously pingable IP 192.168.32.10 back into the pool" pid=3388964 mac=c6:2b:fa:87:57:e9
Serhiy Morhun Manager of IT Ridgewood Public Schools 201-670-2700 ext. 10507 www.ridgewood.k12.nj.us -- *-----------------------------------------------------------------------------------*** *THE INFORMATION CONTAINED IN THIS MESSAGE (E-MAIL AND ANY ATTACHMENTS) IS INTENDED ONLY FOR THE INDIVIDUAL AND CONFIDENTIAL USE OF THE DESIGNATED RECIPIENT(S).* If any reader of this message is not an intended recipient or any agent responsible for delivering it to an intended recipient, you are hereby notified that you have received this document in error, and that any review, dissemination, distribution, copying or other use of this message is prohibited. If you have received this message in error, please notify us immediately by reply e-mail message or by telephone and delete the original message from your e-mail system and/or computer database. Thank you. *-----------------------------------------------------------------------------------* **NOTICE**: *You are advised that e-mail correspondence and attachments between the public and the Ridgewood Board of Education are obtainable by any person who files a request under the NJ Open Public Records Act (OPRA) unless it is subject to a specific OPRA exception. You should have no expectation that the content of e-mails sent to or from school district e-mail addresses, or between the public and school district officials and employees, will remain private.* *-----------------------------------------------------------------------------------*
_______________________________________________ PacketFence-users mailing list PacketFence-users@lists.sourceforge.net https://lists.sourceforge.net/lists/listinfo/packetfence-users
