Unbound Crash with Interface Timeout.

[eminent]

Good evening,

I have been struggling with an issue, where my internet goes out randomly through out the day.  I would fix it by restarting my OpnSense itself. Then narrowed it down to Unbound.  I have found these logs every time the Unbound Service has crashed.

I do not have Unbound Block Lists Enabled, however I do have DOT and some custom Overrides enabled.  Outside of that I followed the guide for performance Tuning for NIDs from this forum and os-ddclient. It is only affecting Unbound, as soon as I restart Unbound it will work for a random time.

I have even set up a Cron Job to restart Unbound every 3 hours to try and prevent it from Locking up Unbound but it is still happening regardless.

Thank you in advance.

Code Select Expand


2023-01-08T15:57:01-05:00 Error configd.py Timeout (120) executing : interface newip 'vlan05'
2023-01-08T15:54:53-05:00 Error configd.py Timeout (120) executing : interface newip 'vlan02'
2023-01-08T15:52:53-05:00 Error configd.py Timeout (120) executing : interface newip 'lagg0'
2023-01-08T15:43:46-05:00 Error configd.py Timeout (120) executing : interface newip 'vlan01'
2023-01-08T15:30:08-05:00 Error configd.py Timeout (120) executing : interface newip 'vlan05'
2023-01-08T15:28:07-05:00 Error configd.py Timeout (120) executing : interface newip 'vlan03'
2023-01-08T15:16:35-05:00 Error configd.py Timeout (120) executing : interface newip 'vlan04'
2023-01-08T15:14:24-05:00 Error configd.py Timeout (120) executing : interface newip 'lagg0'
2023-01-08T14:28:30-05:00 Error configd.py Timeout (120) executing : interface newip 'vlan04'
2023-01-08T14:26:29-05:00 Error configd.py Timeout (120) executing : interface newip 'vlan02'
2023-01-08T03:14:49-05:00 Error configd.py Timeout (120) executing : interface newip 'vlan02'
2023-01-08T03:12:49-05:00 Error configd.py Timeout (120) executing : interface newip 'lagg0'6


[eminent]

I found a few more logs.  Listed at the bottom.  The only thing I can think is the ddclient breaking it or registering static dhcp leases.  I disabled registering static dhcp leases to see if that resolves the issue.

I have found this two postings somewhat related to it, but it appears to be fixed a couple of versions back.
https://forum.opnsense.org/index.php?topic=30126.0
https://github.com/opnsense/core/issues/5752

Code Select Expand


2023-01-09T18:12:58 Error configd.py [40fc8cfb-0bbb-45fd-a556-3fe14992b6d6] Script action stderr returned "b'pgrep: Cannot get process list (kvm_getprocs: No such process)'"
2023-01-09T18:12:58 Error configd.py [92c7b090-f886-4a35-953d-b154977b0932] Script action stderr returned "b'pgrep: Cannot get process list (kvm_getprocs: No such process)'"
2023-01-09T18:12:57 Error configd.py [7a6067c5-b543-4ae1-b2b7-f4e23ec007b0] Script action stderr returned "b'pgrep: Cannot get process list (kvm_getprocs: No such process)'"
2023-01-09T18:12:56 Error configd.py [66968367-8745-4fe7-b14a-3c69cb6d79b8] Script action stderr returned "b'pgrep: Cannot get process list (kvm_getprocs: No such process)'"
2023-01-09T18:12:47 Error configd.py [cf36ff3e-2fc1-440f-904e-70eab8fcbffb] Script action stderr returned "b'pgrep: Cannot get process list (kvm_getprocs: No such process)'"
2023-01-09T18:12:47 Error configd.py [d42e416f-e234-454c-9529-a641b23224e2] Script action stderr returned "b'pgrep: Cannot get process list (kvm_getprocs: No such process)'"
2023-01-09T18:11:36 Error configd.py [23eaa643-69ed-45b5-8d86-e829c8fe5634] Script action stderr returned "b'pgrep: Cannot get process list (kvm_getprocs: No such process)'"
2023-01-09T18:11:35 Error configd.py [c8328e8c-e1ef-41ca-98da-d2494c01642e] Script action stderr returned "b'pgrep: Cannot get process list (kvm_getprocs: No such process)'"
2023-01-09T18:07:49 Error configd.py [2015a2e3-6249-4ce8-a4e6-e5817f6c8170] Script action stderr returned "b'pgrep: Cannot get process list (kvm_getprocs: No such process)'"
2023-01-09T15:19:34 Error configd.py [2651ca00-d554-4a89-b907-96c737fff1a2] Script action stderr returned "b"pgrep: Cannot open pidfile `/var/run/ddclient.pid': No such file or directory""
2023-01-09T15:19:00 Error configd.py [19ece738-671d-4e76-b797-5064e5cae75e] Script action stderr returned "b"pgrep: Cannot open pidfile `/var/run/ddclient.pid': No such file or directory""
2023-01-09T15:18:49 Error configd.py [5a19540f-a906-4184-b9e5-fc6aba8f643d] Script action stderr returned "b"pgrep: Cannot open pidfile `/var/run/ddclient.pid': No such file or directory""
2023-01-09T15:12:46 Error configd.py [552c01d6-886c-4241-a95e-393d3f6698d6] Script action stderr returned "b'pgrep: Cannot get process list (kvm_getprocs: No such process)'"


Code Select Expand


2023-01-09T18:18:55 Debug configd.py OPNsense/Unbound/* generated //var/unbound/advanced.conf
2023-01-09T18:18:55 Notice configd.py generate template container OPNsense/Unbound/core
2023-01-09T18:18:55 Notice configd.py [9da7a348-15ae-4a93-b76f-ec120cc09743] generate template OPNsense/Unbound/*
2023-01-09T18:18:54 Notice configd.py [332b29fc-e1a7-47bc-8d91-4af0ee0166da] list gateway status
2023-01-09T18:18:54 Notice configd.py [f9edc566-1586-4e6d-ac4a-030a6252e950] Unbound cache dump
2023-01-09T18:18:54 Notice configd.py [09deb65d-0be9-438b-a50c-693be826500f] get ddclient statistics
2023-01-09T18:18:50 Notice configd.py [1bcd8ff5-67cf-4837-bb43-779df4c27239] system status
2023-01-09T18:18:49 Notice configd.py [75f5410a-6cfb-46f1-be33-39ed943e0347] Retrieve firmware product info
2023-01-09T18:18:49 Notice configd.py [52b55c0f-2703-49c0-80c3-e6388543976e] list gateway status
2023-01-09T18:18:49 Notice configd.py [63c79221-4f0d-4c4a-a01e-25726cff0ad2] get ddclient statistics
2023-01-09T18:13:19 Notice configd.py [22dcd6fe-0e51-42ff-87d4-7658192ab1aa] system status
2023-01-09T18:13:18 Notice configd.py [5941fdc0-d3d6-47b5-9dd8-a211e0c1e227] list gateways
2023-01-09T18:13:18 Notice configd.py [935b8104-2647-42ce-9961-8f89e7f4a0c0] request pf current overall table record count and table-entries limit
2023-01-09T18:13:02 Notice configd.py [3bdbf39d-9613-435d-b832-6249c69d0e70] system status
2023-01-09T18:13:01 Notice configd.py [77c68634-0081-416d-b64c-7fa7450bda32] request Unbound status
2023-01-09T18:12:58 Error configd.py [40fc8cfb-0bbb-45fd-a556-3fe14992b6d6] Script action stderr returned "b'pgrep: Cannot get process list (kvm_getprocs: No such process)'"
2023-01-09T18:12:58 Notice configd.py [40fc8cfb-0bbb-45fd-a556-3fe14992b6d6] request Unbound status
2023-01-09T18:12:58 Error configd.py [92c7b090-f886-4a35-953d-b154977b0932] Script action stderr returned "b'pgrep: Cannot get process list (kvm_getprocs: No such process)'"
2023-01-09T18:12:58 Notice configd.py [92c7b090-f886-4a35-953d-b154977b0932] request Unbound status
2023-01-09T18:12:58 Debug configd.py OPNsense/Unbound/* generated //var/unbound/dnsbl_module.py


[eminent]

Have been running Unbound with Register Static Leases as disabled, I have zero unbound crashes.

Thank you for everyone that took the time to read this, and hopefully this helps if someone else comes across the same issue.