Netgate Discussion Forum
    • Categories
    • Recent
    • Tags
    • Popular
    • Users
    • Search
    • Register
    • Login

    pfsense dashboard show "Unable to check for update" via Quad9 DNS

    Scheduled Pinned Locked Moved General pfSense Questions
    28 Posts 4 Posters 1.5k Views
    Loading More Posts
    • Oldest to Newest
    • Newest to Oldest
    • Most Votes
    Reply
    • Reply as topic
    Log in to reply
    This topic has been deleted. Only users with topic management privileges can see it.
    • M
      MaverickHL @stephenw10
      last edited by

      @stephenw10

      So set only 9.9.9.9 and set to use Local DNS and fall back to remote. Log Level on the DNS resolver was set to level 3 and these are the results when accessing the System > Update page:

      Jul 13 12:35:00 sshguard 63076 Now monitoring attacks.
      Jul 13 12:35:00 sshguard 40886 Exiting on signal.
      Jul 13 12:34:48 kernel config_aqm Unable to configure flowset, flowset busy!
      Jul 13 12:34:48 kernel config_aqm Unable to configure flowset, flowset busy!
      Jul 13 12:34:47 check_reload_status 403 Reloading filter
      Jul 13 12:34:47 php-fpm 55880 /system.php: NTPD is starting up.
      Jul 13 12:34:45 dhcpleases 14363 Could not deliver signal HUP to process 45787: No such process.
      Jul 13 12:34:40 root 92857 /etc/rc.d/hostid: WARNING: hostid: unable to figure out a UUID from DMI data, generating a new one
      Jul 13 12:34:40 check_reload_status 403 Syncing firewall

      GertjanG 1 Reply Last reply Reply Quote 0
      • S
        SteveITS Galactic Empire @MaverickHL
        last edited by SteveITS

        @maverickhl FWIW we use Quad9 and have never had an issue. I just checked a couple and they worked. One has 8.8.4.4 as the last DNS server, but the update check finished in about 1-2 seconds so that should be way faster than a DNS timeout through the other entries (2s each as I recall).

        Quad9 has a lot of servers so it could be a regional issue? https://status.quad9.net/smap/ shows "20 in bypass, 1 in maintenance" which I would think means those are intentionally offline...

        Pre-2.7.2/23.09: Only install packages for your version, or risk breaking it. Select your branch in System/Update/Update Settings.
        When upgrading, allow 10-15 minutes to restart, or more depending on packages and device speed.
        Upvote 👍 helpful posts!

        1 Reply Last reply Reply Quote 0
        • stephenw10S
          stephenw10 Netgate Administrator
          last edited by

          Make sure you see queries logged when you check Diag > DNS Lookup.

          M 1 Reply Last reply Reply Quote 0
          • M
            MaverickHL @stephenw10
            last edited by stephenw10

            @stephenw10

            Sorry I think I just sent the generic logs not the DNS resolver logs. This is what came up a few moments ago attempting the System > Update page load:

            Jul 13 15:07:01	unbound	14038	[14038:3] debug: cache memory msg=90265 rrset=95647 infra=8306 val=0
Jul 13 15:07:01	unbound	14038	[14038:3] debug: return error response SERVFAIL
Jul 13 15:07:01	unbound	14038	[14038:3] debug: configured stub or forward servers failed -- returning SERVFAIL
Jul 13 15:07:01	unbound	14038	[14038:3] info: processQueryTargets: 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:3] info: query response was THROWAWAY
Jul 13 15:07:01	unbound	14038	[14038:3] info: reply from <.> 9.9.9.9#853
Jul 13 15:07:01	unbound	14038	[14038:3] info: response for 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:3] info: iterator operate: query 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:3] debug: iterator[module 0] operate: extstate:module_wait_reply event:module_event_reply
Jul 13 15:07:01	unbound	14038	[14038:3] debug: cache memory msg=90265 rrset=95647 infra=8306 val=0
Jul 13 15:07:01	unbound	14038	[14038:3] debug: sending to target: <.> 9.9.9.9#853
Jul 13 15:07:01	unbound	14038	[14038:3] info: sending query: 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:3] info: processQueryTargets: 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:3] info: query response was THROWAWAY
Jul 13 15:07:01	unbound	14038	[14038:3] info: reply from <.> 9.9.9.9#853
Jul 13 15:07:01	unbound	14038	[14038:3] info: response for 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:3] info: iterator operate: query 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:3] debug: iterator[module 0] operate: extstate:module_wait_reply event:module_event_reply
Jul 13 15:07:01	unbound	14038	[14038:3] debug: cache memory msg=90265 rrset=95647 infra=8306 val=0
Jul 13 15:07:01	unbound	14038	[14038:3] debug: sending to target: <.> 9.9.9.9#853
Jul 13 15:07:01	unbound	14038	[14038:3] info: sending query: 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:3] info: processQueryTargets: 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:3] info: query response was THROWAWAY
Jul 13 15:07:01	unbound	14038	[14038:3] info: reply from <.> 9.9.9.9#853
Jul 13 15:07:01	unbound	14038	[14038:3] info: response for 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:3] info: iterator operate: query 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:3] debug: iterator[module 0] operate: extstate:module_wait_reply event:module_event_reply
Jul 13 15:07:01	unbound	14038	[14038:3] debug: cache memory msg=90265 rrset=95647 infra=8306 val=0
Jul 13 15:07:01	unbound	14038	[14038:3] debug: sending to target: <.> 9.9.9.9#853
Jul 13 15:07:01	unbound	14038	[14038:3] info: sending query: 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:3] info: processQueryTargets: 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:3] info: query response was THROWAWAY
Jul 13 15:07:01	unbound	14038	[14038:3] info: reply from <.> 9.9.9.9#853
Jul 13 15:07:01	unbound	14038	[14038:3] info: response for 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:3] info: iterator operate: query 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:3] debug: iterator[module 0] operate: extstate:module_wait_reply event:module_event_reply
Jul 13 15:07:01	unbound	14038	[14038:3] debug: cache memory msg=90265 rrset=95647 infra=8306 val=0
Jul 13 15:07:01	unbound	14038	[14038:3] debug: sending to target: <.> 9.9.9.9#853
Jul 13 15:07:01	unbound	14038	[14038:3] info: sending query: 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:3] info: processQueryTargets: 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:3] info: query response was THROWAWAY
Jul 13 15:07:01	unbound	14038	[14038:3] info: reply from <.> 149.112.112.112#853
Jul 13 15:07:01	unbound	14038	[14038:3] info: response for 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:3] info: iterator operate: query 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:3] debug: iterator[module 0] operate: extstate:module_wait_reply event:module_event_reply
Jul 13 15:07:01	unbound	14038	[14038:3] debug: cache memory msg=90265 rrset=95647 infra=8306 val=0
Jul 13 15:07:01	unbound	14038	[14038:3] debug: sending to target: <.> 149.112.112.112#853
Jul 13 15:07:01	unbound	14038	[14038:3] info: sending query: 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:3] info: processQueryTargets: 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:3] info: query response was THROWAWAY
Jul 13 15:07:01	unbound	14038	[14038:3] info: reply from <.> 149.112.112.112#853
Jul 13 15:07:01	unbound	14038	[14038:3] info: response for 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:3] info: iterator operate: query 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:3] debug: iterator[module 0] operate: extstate:module_wait_reply event:module_event_reply
Jul 13 15:07:01	unbound	14038	[14038:3] debug: cache memory msg=90265 rrset=95647 infra=8306 val=0
Jul 13 15:07:01	unbound	14038	[14038:3] debug: sending to target: <.> 149.112.112.112#853
Jul 13 15:07:01	unbound	14038	[14038:3] info: sending query: 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:3] info: processQueryTargets: 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:3] info: iterator operate: query 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:3] debug: iterator[module 0] operate: extstate:module_wait_reply event:module_event_noreply
Jul 13 15:07:01	unbound	14038	[14038:3] debug: tcp error for address 9.9.9.9 port 853
Jul 13 15:07:01	unbound	14038	[14038:3] debug: outnettcp got tcp error -1
Jul 13 15:07:01	unbound	14038	[14038:2] debug: cache memory msg=90265 rrset=95647 infra=8306 val=0
Jul 13 15:07:01	unbound	14038	[14038:2] debug: return error response SERVFAIL
Jul 13 15:07:01	unbound	14038	[14038:2] debug: configured stub or forward servers failed -- returning SERVFAIL
Jul 13 15:07:01	unbound	14038	[14038:2] info: processQueryTargets: 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:2] info: query response was THROWAWAY
Jul 13 15:07:01	unbound	14038	[14038:2] info: reply from <.> 9.9.9.9#853
Jul 13 15:07:01	unbound	14038	[14038:2] info: response for 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:2] info: iterator operate: query 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:2] debug: iterator[module 0] operate: extstate:module_wait_reply event:module_event_reply
Jul 13 15:07:01	unbound	14038	[14038:2] debug: cache memory msg=90265 rrset=95647 infra=8306 val=0
Jul 13 15:07:01	unbound	14038	[14038:2] debug: sending to target: <.> 9.9.9.9#853
Jul 13 15:07:01	unbound	14038	[14038:2] info: sending query: 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:2] info: processQueryTargets: 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:2] info: query response was THROWAWAY
Jul 13 15:07:01	unbound	14038	[14038:2] info: reply from <.> 9.9.9.9#853
Jul 13 15:07:01	unbound	14038	[14038:2] info: response for 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:2] info: iterator operate: query 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:2] debug: iterator[module 0] operate: extstate:module_wait_reply event:module_event_reply
Jul 13 15:07:01	unbound	14038	[14038:2] debug: cache memory msg=90265 rrset=95647 infra=8306 val=0
Jul 13 15:07:01	unbound	14038	[14038:2] debug: sending to target: <.> 9.9.9.9#853
Jul 13 15:07:01	unbound	14038	[14038:2] info: sending query: 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:2] info: processQueryTargets: 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:2] info: query response was THROWAWAY
Jul 13 15:07:01	unbound	14038	[14038:2] info: reply from <.> 9.9.9.9#853
Jul 13 15:07:01	unbound	14038	[14038:2] info: response for 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:2] info: iterator operate: query 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:2] debug: iterator[module 0] operate: extstate:module_wait_reply event:module_event_reply
Jul 13 15:07:01	unbound	14038	[14038:2] debug: cache memory msg=90265 rrset=95647 infra=8306 val=0
Jul 13 15:07:01	unbound	14038	[14038:2] debug: sending to target: <.> 9.9.9.9#853
Jul 13 15:07:01	unbound	14038	[14038:2] info: sending query: 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:2] info: processQueryTargets: 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:2] info: query response was THROWAWAY
Jul 13 15:07:01	unbound	14038	[14038:2] info: reply from <.> 149.112.112.112#853
Jul 13 15:07:01	unbound	14038	[14038:2] info: response for 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:2] info: iterator operate: query 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:2] debug: iterator[module 0] operate: extstate:module_wait_reply event:module_event_reply
Jul 13 15:07:01	unbound	14038	[14038:2] debug: cache memory msg=90265 rrset=95647 infra=8306 val=0
Jul 13 15:07:01	unbound	14038	[14038:2] debug: sending to target: <.> 149.112.112.112#853
Jul 13 15:07:01	unbound	14038	[14038:2] info: sending query: 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:2] info: processQueryTargets: 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:2] info: iterator operate: query 4.4.8.8.in-addr.arpa. PTR IN
Jul 13 15:07:01	unbound	14038	[14038:2] debug: iterator[module 0] operate: extstate:module_wait_reply event:module_event_noreply
Jul 13 15:07:01	unbound	14038	[14038:2] debug: tcp error for address 9.9.9.9 port 853
            S 1 Reply Last reply Reply Quote 0
            • S
              SteveITS Galactic Empire @MaverickHL
              last edited by

              @maverickhl What if you uncheck "Use SSL/TLS for outgoing DNS Queries to Forwarding Servers"?

              Pre-2.7.2/23.09: Only install packages for your version, or risk breaking it. Select your branch in System/Update/Update Settings.
              When upgrading, allow 10-15 minutes to restart, or more depending on packages and device speed.
              Upvote 👍 helpful posts!

              M 1 Reply Last reply Reply Quote 0
              • M
                MaverickHL @SteveITS
                last edited by

                @steveits

                Wow.. that works... so why? I never had an issue enforcing TLS on DNS queries before? Not with Cloudfare at the very least....

                M 1 Reply Last reply Reply Quote 0
                • M
                  MaverickHL @MaverickHL
                  last edited by

                  Wait nvm lol... forgot to change it from Cloudflare for the test... ignore that previous post.

                  1 Reply Last reply Reply Quote 0
                  • stephenw10S
                    stephenw10 Netgate Administrator
                    last edited by stephenw10

                    Does it work if you're not using DoT? Edit: Missed some replies 🙄

                    Though that works fine for me using DoT to 8.8.8.8:

                    Jul 13 21:49:55 	unbound 	23889 	[23889:1] info: resolving pfsense.org. A IN
Jul 13 21:49:55 	unbound 	23889 	[23889:1] info: processQueryTargets: pfsense.org. A IN
Jul 13 21:49:55 	unbound 	23889 	[23889:1] info: sending query: pfsense.org. A IN
Jul 13 21:49:55 	unbound 	23889 	[23889:1] debug: sending to target: <.> 8.8.8.8#853
Jul 13 21:49:55 	unbound 	23889 	[23889:1] debug: cache memory msg=16528 rrset=16528 infra=3280 val=0
Jul 13 21:49:55 	unbound 	23889 	[23889:1] debug: iterator[module 0] operate: extstate:module_wait_reply event:module_event_reply
Jul 13 21:49:55 	unbound 	23889 	[23889:1] info: iterator operate: query pfsense.org. A IN
Jul 13 21:49:55 	unbound 	23889 	[23889:1] info: response for pfsense.org. A IN
Jul 13 21:49:55 	unbound 	23889 	[23889:1] info: reply from <.> 8.8.8.8#853
Jul 13 21:49:55 	unbound 	23889 	[23889:1] info: query response was ANSWER
Jul 13 21:49:55 	unbound 	23889 	[23889:1] info: finishing processing for pfsense.org. A IN

                    I don't actually see it trying to resolve anything in your logs.

                    Steve

                    M 1 Reply Last reply Reply Quote 0
                    • M
                      MaverickHL @stephenw10
                      last edited by

                      @stephenw10

                      Which is the problem, nothing is coming up to help me determine the issue. I took a while to get back because I wanted to do the log capture at a time when less people are working so I can capture them. These are the log differences between Cloudflare and Quad9 and the fact it does not resolve in Quad9 at all is very weird.

                      CloudFlare response after accessing System > Update page on pfsense:

                      Jul 13 20:41:50 unbound 28884 [28884:0] info: 127.0.0.1 pkg01-atx.netgate.com. AAAA IN
                      Jul 13 20:41:50 unbound 28884 [28884:0] info: 127.0.0.1 pkg01-atx.netgate.com. A IN
                      Jul 13 20:41:50 unbound 28884 [28884:1] info: 127.0.0.1 pkg01-atx.netgate.com. AAAA IN
                      Jul 13 20:41:50 unbound 28884 [28884:0] info: 127.0.0.1 pkg01-atx.netgate.com. A IN
                      Jul 13 20:41:50 unbound 28884 [28884:0] info: 127.0.0.1 pkg01-atx.netgate.com. AAAA IN
                      Jul 13 20:41:50 unbound 28884 [28884:1] info: 127.0.0.1 pkg01-atx.netgate.com. A IN
                      Jul 13 20:41:50 unbound 28884 [28884:1] info: 127.0.0.1 _https._tcp.packages.netgate.com. SRV IN
                      Jul 13 20:41:50 unbound 28884 [28884:0] info: control cmd: stats_noreset
                      Jul 13 20:41:50 unbound 28884 [28884:0] debug: new control connection from 127.0.0.1 port 7536
                      Jul 13 20:41:49 unbound 28884 [28884:0] info: 127.0.0.1 pkg00-atx.netgate.com. AAAA IN
                      Jul 13 20:41:49 unbound 28884 [28884:2] info: 127.0.0.1 pkg00-atx.netgate.com. A IN
                      Jul 13 20:41:49 unbound 28884 [28884:0] info: 127.0.0.1 pkg00-atx.netgate.com. AAAA IN
                      Jul 13 20:41:49 unbound 28884 [28884:1] info: 127.0.0.1 pkg00-atx.netgate.com. A IN
                      Jul 13 20:41:49 unbound 28884 [28884:1] debug: cache memory msg=231360 rrset=334815 infra=8306 val=124083
                      Jul 13 20:41:49 unbound 28884 [28884:1] info: Verified that unsigned response is INSECURE

                      Quad9 response after accessing System > Update page on pfsense:

                      Jul 13 20:48:19 unbound 56545 [56545:1] debug: outnettcp got tcp error -1
                      Jul 13 20:48:18 unbound 56545 [56545:3] debug: cache memory msg=72336 rrset=81059 infra=8057 val=71562
                      Jul 13 20:48:18 unbound 56545 [56545:3] info: validator operate: query 4.4.8.8.in-addr.arpa. PTR IN
                      Jul 13 20:48:18 unbound 56545 [56545:3] debug: validator[module 0] operate: extstate:module_wait_module event:module_event_moddone
                      Jul 13 20:48:18 unbound 56545 [56545:3] debug: return error response SERVFAIL
                      Jul 13 20:48:18 unbound 56545 [56545:3] debug: configured stub or forward servers failed -- returning SERVFAIL
                      Jul 13 20:48:18 unbound 56545 [56545:3] info: processQueryTargets: 4.4.8.8.in-addr.arpa. PTR IN
                      Jul 13 20:48:18 unbound 56545 [56545:3] info: query response was THROWAWAY
                      Jul 13 20:48:18 unbound 56545 [56545:3] info: reply from <.> 9.9.9.9#853
                      Jul 13 20:48:18 unbound 56545 [56545:3] info: response for 4.4.8.8.in-addr.arpa. PTR IN
                      Jul 13 20:48:18 unbound 56545 [56545:3] info: iterator operate: query 4.4.8.8.in-addr.arpa. PTR IN
                      Jul 13 20:48:18 unbound 56545 [56545:3] debug: iterator[module 1] operate: extstate:module_wait_reply event:module_event_reply
                      Jul 13 20:48:18 unbound 56545 [56545:3] debug: cache memory msg=72336 rrset=81059 infra=8057 val=71562
                      Jul 13 20:48:18 unbound 56545 [56545:3] debug: sending to target: <.> 9.9.9.9#853
                      Jul 13 20:48:18 unbound 56545 [56545:3] info: sending query: 4.4.8.8.in-addr.arpa. PTR IN
                      Jul 13 20:48:18 unbound 56545 [56545:3] info: processQueryTargets: 4.4.8.8.in-addr.arpa. PTR IN
                      Jul 13 20:48:18 unbound 56545 [56545:3] info: query response was THROWAWAY
                      Jul 13 20:48:18 unbound 56545 [56545:3] info: reply from <.> 9.9.9.9#853
                      Jul 13 20:48:18 unbound 56545 [56545:3] info: response for 4.4.8.8.in-addr.arpa. PTR IN
                      Jul 13 20:48:18 unbound 56545 [56545:3] info: iterator operate: query 4.4.8.8.in-addr.arpa. PTR IN
                      Jul 13 20:48:18 unbound 56545 [56545:3] debug: iterator[module 1] operate: extstate:module_wait_reply event:module_event_reply
                      Jul 13 20:48:18 unbound 56545 [56545:3] debug: cache memory msg=72336 rrset=81059 infra=8057 val=71562
                      Jul 13 20:48:18 unbound 56545 [56545:3] debug: sending to target: <.> 9.9.9.9#853
                      Jul 13 20:48:18 unbound 56545 [56545:3] info: sending query: 4.4.8.8.in-addr.arpa. PTR IN
                      Jul 13 20:48:18 unbound 56545 [56545:3] info: processQueryTargets: 4.4.8.8.in-addr.arpa. PTR IN
                      Jul 13 20:48:18 unbound 56545 [56545:3] info: query response was THROWAWAY
                      Jul 13 20:48:18 unbound 56545 [56545:3] info: reply from <.> 9.9.9.9#853
                      Jul 13 20:48:18 unbound 56545 [56545:3] info: response for 4.4.8.8.in-addr.arpa. PTR IN
                      Jul 13 20:48:18 unbound 56545 [56545:3] info: iterator operate: query 4.4.8.8.in-addr.arpa. PTR IN
                      Jul 13 20:48:18 unbound 56545 [56545:3] debug: iterator[module 1] operate: extstate:module_wait_reply event:module_event_reply
                      Jul 13 20:48:18 unbound 56545 [56545:3] debug: cache memory msg=72336 rrset=81059 infra=8057 val=71562
                      Jul 13 20:48:18 unbound 56545 [56545:3] debug: sending to target: <.> 9.9.9.9#853
                      Jul 13 20:48:18 unbound 56545 [56545:3] info: sending query: 4.4.8.8.in-addr.arpa. PTR IN
                      Jul 13 20:48:18 unbound 56545 [56545:3] info: processQueryTargets: 4.4.8.8.in-addr.arpa. PTR IN
                      Jul 13 20:48:18 unbound 56545 [56545:3] info: query response was THROWAWAY
                      Jul 13 20:48:18 unbound 56545 [56545:3] info: reply from <.> 9.9.9.9#853
                      Jul 13 20:48:18 unbound 56545 [56545:3] info: response for 4.4.8.8.in-addr.arpa. PTR IN
                      Jul 13 20:48:18 unbound 56545 [56545:3] info: iterator operate: query 4.4.8.8.in-addr.arpa. PTR IN
                      Jul 13 20:48:18 unbound 56545 [56545:3] debug: iterator[module 1] operate: extstate:module_wait_reply event:module_event_reply
                      Jul 13 20:48:18 unbound 56545 [56545:3] debug: cache memory msg=72336 rrset=81059 infra=8057 val=71562
                      Jul 13 20:48:18 unbound 56545 [56545:3] debug: sending to target: <.> 9.9.9.9#853
                      Jul 13 20:48:18 unbound 56545 [56545:3] info: sending query: 4.4.8.8.in-addr.arpa. PTR IN
                      Jul 13 20:48:18 unbound 56545 [56545:3] info: processQueryTargets: 4.4.8.8.in-addr.arpa. PTR IN
                      Jul 13 20:48:18 unbound 56545 [56545:3] info: iterator operate: query 4.4.8.8.in-addr.arpa. PTR IN
                      Jul 13 20:48:18 unbound 56545 [56545:3] debug: iterator[module 1] operate: extstate:module_wait_reply event:module_event_noreply
                      Jul 13 20:48:18 unbound 56545 [56545:3] debug: tcp error for address 9.9.9.9 port 853
                      Jul 13 20:48:18 unbound 56545 [56545:3] debug: outnettcp got tcp error -1
                      Jul 13 20:48:17 unbound 56545 [56545:0] debug: cache memory msg=72336 rrset=81059 infra=8057 val=71562

                      1 Reply Last reply Reply Quote 0
                      • GertjanG
                        Gertjan @MaverickHL
                        last edited by Gertjan

                        If the query answer from " 9.9.9.9#853" is sympathetically "THROWAWAY" you can do 2 things :
                        Stop using TLS or even stop using 9.9.9.9.

                        You're sure nothing is filtered upstream ?
                        I saw

                        debug: tcp error for address 9.9.9.9 port 853

                        As TLS over port 853 needs TCP, and TCP is bad, then 9.9.9.9 doesn't even receive your request correctly ( ? ) ....

                        When the quad9 issues go away (thrown away ;) ) I advise you to look at other threads in this forum. Because this :

                        @maverickhl said in pfsense dashboard show "Unable to check for update" via Quad9 DNS:

                        Jul 13 12:34:45 dhcpleases 14363 Could not deliver signal HUP to process 45787: No such process

                        is also a possible issue, and discussed a lot on the forum.
                        It means unbound was in the process of getting restarted - and while it was restarting, it was informed to restart again.
                        For now : how often does yours restart ?
                        Go to the page and search for "info: start of service (unbound 1.15.0)." and count them.
                        How many a day ? per hour ? even more ?

                        No "help me" PM's please. Use the forum, the community will thank you.
                        Edit : and where are the logs ??

                        1 Reply Last reply Reply Quote 0
                        • stephenw10S
                          stephenw10 Netgate Administrator
                          last edited by

                          Still not seeing any logs for info: resolving. Everything in your logs appears to be reverse lookup for PTR. So I'd suggest it's not using Unbound for those lookups. Something is not configured as you expect it to be.
                          However even if that is that case it's hard to explain why pkg update works but the dashboard check does not.
                          Try to resolve ews.netgate.com in Diag > DNS Lookup. Make sure all the defined servers there can resolve it.

                          Steve

                          M 1 Reply Last reply Reply Quote 0
                          • M
                            MaverickHL @stephenw10
                            last edited by

                            @stephenw10

                            ews.netgate.com does resolve returning an IP of 208.123.73.93

                            I turned off DoT and the results are not any better and can't find any info: resolving lines during the update check:

                            Jul 14 08:59:42 unbound 12183 [12183:0] info: control cmd: stats_noreset
                            Jul 14 08:59:42 unbound 12183 [12183:0] debug: new control connection from 127.0.0.1 port 40927
                            Jul 14 08:59:42 unbound 12183 [12183:0] debug: cache memory msg=158472 rrset=215935 infra=8306 val=95561
                            Jul 14 08:59:42 unbound 12183 [12183:0] info: validator operate: query 4.4.8.8.in-addr.arpa. PTR IN
                            Jul 14 08:59:42 unbound 12183 [12183:0] debug: validator[module 0] operate: extstate:module_wait_module event:module_event_moddone
                            Jul 14 08:59:42 unbound 12183 [12183:0] debug: return error response SERVFAIL
                            Jul 14 08:59:42 unbound 12183 [12183:0] debug: configured stub or forward servers failed -- returning SERVFAIL
                            Jul 14 08:59:42 unbound 12183 [12183:0] info: processQueryTargets: 4.4.8.8.in-addr.arpa. PTR IN
                            Jul 14 08:59:42 unbound 12183 [12183:0] info: query response was THROWAWAY
                            Jul 14 08:59:42 unbound 12183 [12183:0] info: reply from <.> 9.9.9.9#53
                            Jul 14 08:59:42 unbound 12183 [12183:0] info: response for 4.4.8.8.in-addr.arpa. PTR IN
                            Jul 14 08:59:42 unbound 12183 [12183:0] info: iterator operate: query 4.4.8.8.in-addr.arpa. PTR IN

                            1 Reply Last reply Reply Quote 0
                            • stephenw10S
                              stephenw10 Netgate Administrator
                              last edited by

                              Mmm, so exactly what settings do you have in System > General Setup and in Unbound?

                              M 1 Reply Last reply Reply Quote 0
                              • M
                                MaverickHL @stephenw10
                                last edited by

                                @stephenw10

                                Nothing fancy, but here are the main things I have setup:

                                System General Setup:

                                Added DNS 9.9.9.9 and 149.112.112.112

                                Set DNS behavior to Use Local then remote (default)

                                DNS Resolver Settings:

                                Network Interface = All
                                Outgoing Network Interface = WAN
                                Domain Local Zone Type = Transparent
                                DNSSEC = FALSE
                                DNS Query Forward = TRUE
                                Use SSL/TLS = TRUE
                                DHCP Reg = TRUE
                                Static DHCP = TRUE
                                Advanced Config =

                                server:include: /var/unbound/pfb_dnsbl.*conf

                                server:
                                log-queries: yes

                                Advanced Tab:

                                Everything left default except when changing log level to 3.

                                1 Reply Last reply Reply Quote 0
                                • stephenw10S
                                  stephenw10 Netgate Administrator
                                  last edited by stephenw10

                                  Hmm, the only thing different I have is the custom entry you have:

                                  server:
log-queries: yes

                                  But I see all the queries logged so I suspect you may have created a conflict there. Try removing that.

                                  Steve

                                  M 1 Reply Last reply Reply Quote 0
                                  • M
                                    MaverickHL @stephenw10
                                    last edited by

                                    @stephenw10

                                    Sadly, nope same odd response back and no info: resolve lines -_-;

                                    Jul 14 10:45:31 unbound 88800 [88800:0] debug: cache memory msg=68474 rrset=68889 infra=8306 val=0
                                    Jul 14 10:45:31 unbound 88800 [88800:0] debug: return error response SERVFAIL
                                    Jul 14 10:45:31 unbound 88800 [88800:0] debug: configured stub or forward servers failed -- returning SERVFAIL
                                    Jul 14 10:45:31 unbound 88800 [88800:0] info: processQueryTargets: 4.4.8.8.in-addr.arpa. PTR IN
                                    Jul 14 10:45:31 unbound 88800 [88800:0] info: query response was THROWAWAY
                                    Jul 14 10:45:31 unbound 88800 [88800:0] info: reply from <.> 9.9.9.9#853
                                    Jul 14 10:45:31 unbound 88800 [88800:0] info: response for 4.4.8.8.in-addr.arpa. PTR IN
                                    Jul 14 10:45:31 unbound 88800 [88800:0] info: iterator operate: query 4.4.8.8.in-addr.arpa. PTR IN
                                    Jul 14 10:45:31 unbound 88800 [88800:0] debug: iterator[module 0] operate: extstate:module_wait_reply event:module_event_reply
                                    Jul 14 10:45:31 unbound 88800 [88800:0] debug: cache memory msg=68284 rrset=68889 infra=8306 val=0
                                    Jul 14 10:45:31 unbound 88800 [88800:0] debug: sending to target: <.> 9.9.9.9#853
                                    Jul 14 10:45:31 unbound 88800 [88800:0] info: sending query: 4.4.8.8.in-addr.arpa. PTR IN
                                    Jul 14 10:45:31 unbound 88800 [88800:0] info: processQueryTargets: 4.4.8.8.in-addr.arpa. PTR IN
                                    Jul 14 10:45:31 unbound 88800 [88800:0] info: query response was THROWAWAY
                                    Jul 14 10:45:31 unbound 88800 [88800:0] info: reply from <.> 9.9.9.9#853
                                    Jul 14 10:45:31 unbound 88800 [88800:0] info: response for 4.4.8.8.in-addr.arpa. PTR IN
                                    Jul 14 10:45:31 unbound 88800 [88800:0] info: iterator operate: query 4.4.8.8.in-addr.arpa. PTR IN
                                    Jul 14 10:45:31 unbound 88800 [88800:0] debug: iterator[module 0] operate: extstate:module_wait_reply event:module_event_reply
                                    Jul 14 10:45:31 unbound 88800 [88800:0] debug: cache memory msg=68284 rrset=68889 infra=8306 val=0
                                    Jul 14 10:45:31 unbound 88800 [88800:0] debug: sending to target: <.> 9.9.9.9#853
                                    Jul 14 10:45:31 unbound 88800 [88800:0] info: sending query: 4.4.8.8.in-addr.arpa. PTR IN
                                    Jul 14 10:45:31 unbound 88800 [88800:0] info: processQueryTargets: 4.4.8.8.in-addr.arpa. PTR IN

                                    I do think it is Quad9's issue and mostly likely regional. I had to send a few DNS resolution request for their upstream provider to fix since some websites were not resolving but was apparently accessible based on their domain checker.

                                    1 Reply Last reply Reply Quote 0
                                    • stephenw10S
                                      stephenw10 Netgate Administrator
                                      last edited by

                                      Hmm. Weird that it's not showing queries in unbound though. Seems like however it's failing could be because it's not going via Unbound...

                                      1 Reply Last reply Reply Quote 0
                                      • First post
                                        Last post
                                      Copyright 2025 Rubicon Communications LLC (Netgate). All rights reserved.