Pihole with Unbound mysteriously stops working, then works again

Kevin_Klasmeier · November 12, 2023, 3:05pm

Expected Behaviour:

I am expecting to be able to do dns resolution through pihole with unbound. I expect to configure my router to resolve dns through this pihole server. I expect to be able to resolve dns directly from my pihole server.

Actual Behaviour:

DNS resolution does not consistently work on my pihole server. It was working fine and without change, it stopped working. Now it is mysteriously working again after some time.

Alsothe pihole interface says that it cannot reach to FTL api. It stated this for a couple hours then started finding the FTL api.

My environment: ROC-RK3328-CC running Debian Bullseye. Packages installed: PiHole + Unbound


roc@RocPiHole:/etc/unbound/unbound.conf.d $ unbound-checkconf
unbound-checkconf: no errors in /etc/unbound/unbound.conf
roc@RocPiHole:/etc/unbound/unbound.conf.d $ sudo grep -v '#\|^$' -R /etc/unbound/unbound.conf*
/etc/unbound/unbound.conf:include-toplevel: "/etc/unbound/unbound.conf.d/*.conf"
/etc/unbound/unbound.conf.d/root-auto-trust-anchor-file.conf:server:
/etc/unbound/unbound.conf.d/root-auto-trust-anchor-file.conf:    auto-trust-anchor-file: "/var/lib/unbound/root.key"
/etc/unbound/unbound.conf.d/pi-hole.conf:server:
/etc/unbound/unbound.conf.d/pi-hole.conf:    verbosity: 1
/etc/unbound/unbound.conf.d/pi-hole.conf:    interface: 127.0.0.1
/etc/unbound/unbound.conf.d/pi-hole.conf:    port: 5335
/etc/unbound/unbound.conf.d/pi-hole.conf:    do-ip4: yes
/etc/unbound/unbound.conf.d/pi-hole.conf:    do-udp: yes
/etc/unbound/unbound.conf.d/pi-hole.conf:    do-tcp: yes
/etc/unbound/unbound.conf.d/pi-hole.conf:    do-ip6: no
/etc/unbound/unbound.conf.d/pi-hole.conf:    prefer-ip6: no
/etc/unbound/unbound.conf.d/pi-hole.conf:    harden-glue: yes
/etc/unbound/unbound.conf.d/pi-hole.conf:    harden-dnssec-stripped: yes
/etc/unbound/unbound.conf.d/pi-hole.conf:    use-caps-for-id: no
/etc/unbound/unbound.conf.d/pi-hole.conf:    edns-buffer-size: 1232
/etc/unbound/unbound.conf.d/pi-hole.conf:    prefetch: yes
/etc/unbound/unbound.conf.d/pi-hole.conf:    num-threads: 4
/etc/unbound/unbound.conf.d/pi-hole.conf:    so-rcvbuf: 1m
/etc/unbound/unbound.conf.d/pi-hole.conf:    private-address: 192.168.0.0/16
/etc/unbound/unbound.conf.d/pi-hole.conf:    private-address: 169.254.0.0/16
/etc/unbound/unbound.conf.d/pi-hole.conf:    private-address: 172.16.0.0/12
/etc/unbound/unbound.conf.d/pi-hole.conf:    private-address: 10.0.0.0/8
/etc/unbound/unbound.conf.d/pi-hole.conf:    private-address: fd00::/8
/etc/unbound/unbound.conf.d/pi-hole.conf:    private-address: fe80::/10
/etc/unbound/unbound.conf.d/bak/pi-hole.conf:server:
/etc/unbound/unbound.conf.d/bak/pi-hole.conf:    verbosity: 1
/etc/unbound/unbound.conf.d/bak/pi-hole.conf:    interface: 0.0.0.0
/etc/unbound/unbound.conf.d/bak/pi-hole.conf:    port: 5353
/etc/unbound/unbound.conf.d/bak/pi-hole.conf:    do-ip4: yes
/etc/unbound/unbound.conf.d/bak/pi-hole.conf:    hide-identity: yes
/etc/unbound/unbound.conf.d/bak/pi-hole.conf:    hide-version: yes
/etc/unbound/unbound.conf.d/bak/pi-hole.conf:    qname-minimisation: yes
/etc/unbound/unbound.conf.d/bak/resolvconf_resolvers.conf.bak:forward-zone:
/etc/unbound/unbound.conf.d/bak/resolvconf_resolvers.conf.bak:  name: "."
/etc/unbound/unbound.conf.d/bak/resolvconf_resolvers.conf.bak:  forward-addr: 192.168.1.1

journalctl -u unbound
-- Boot e9a3a19d56454d8ba2d52a8c9f9bcf3d --
Nov 12 04:18:45 RocPiHole systemd[1]: Starting Unbound DNS server...
Nov 12 04:18:45 RocPiHole unbound[817]: [817:0] notice: init module 0: subnet
Nov 12 04:18:45 RocPiHole unbound[817]: [817:0] notice: init module 1: validator
Nov 12 04:18:45 RocPiHole unbound[817]: [817:0] notice: init module 2: iterator
Nov 12 04:18:45 RocPiHole systemd[1]: Started Unbound DNS server.
Nov 12 04:18:45 RocPiHole unbound[817]: [817:0] info: start of service (unbound 1.13.1).
Nov 12 05:00:02 RocPiHole unbound[817]: [817:2] info: generate keytag query _ta-4f66. NULL IN
l

Debug Token:

https://tricorder.pi-hole.net/Ni1fjVzo/

jfb · November 12, 2023, 7:02pm

Your debug log shows that Pi-hole has recently been receiving queries from network clients and blocking or forwarding them correctly.

What is the nature of the failure? Pi-hole does not receive the queries from the clients? Pi-hole receives the queries but the upstream DNS server is not providing a response?

Please post a screen capture of your dashboard showing the query graphs at the top - in this forum you can paste clipboard contents directly into a reply, or upload a file with the image.

What troubleshooting have you done? Have you changed upstream DNS servers used by Pi-hole?

You have blocking disabled on Pi-hole. Was this intentional (part of your troubleshooting)?

    BLOCKING_ENABLED=false

Unrelated to your problem, but noted in your degub log - none of these regex local domain entries will have any effect - https:// is not part of the domain name, it is a protocol that is unseen by Pi-hole:

*** [ DIAGNOSING ]: Domainlist (0/1 = exact white-/blacklist, 2/3 = regex white-/blacklist)
   id     type  enabled  group_ids     domain                                                                                                date_added           date_modified        comment                                           
   -----  ----  -------  ------------  ----------------------------------------------------------------------------------------------------  -------------------  -------------------  --------------------------------------------------
...
   3         3        1  0             ^https?://([A-Za-z0-9.-]*\.)?clicks\.beap\.bc\.yahoo\.com/                                            2023-10-30 21:46:55  2023-10-30 21:46:55                                                    
   4         3        1  0             ^https?://([A-Za-z0-9.-]*\.)?secure\.footprint\.net/                                                  2023-10-30 21:46:55  2023-10-30 21:46:55                                                    
   5         3        1  0             ^https?://([A-Za-z0-9.-]*\.)?match\.com/                                                              2023-10-30 21:46:55  2023-10-30 21:46:55                                                    
   6         3        1  0             ^https?://([A-Za-z0-9.-]*\.)?clicks\.beap\.bc\.yahoo(\.\w{2}\.\w{2}|\.\w{2,4})/                       2023-10-30 21:46:55  2023-10-30 21:46:55                                                    
   7         3        1  0             ^https?://([A-Za-z0-9.-]*\.)?sitescout(\.\w{2}\.\w{2}|\.\w{2,4})/                                     2023-10-30 21:46:55  2023-10-30 21:46:55                                                    
   8         3        1  0             ^https?://([A-Za-z0-9.-]*\.)?appnexus(\.\w{2}\.\w{2}|\.\w{2,4})/                                      2023-10-30 21:46:55  2023-10-30 21:46:55                                                    
   9         3        1  0             ^https?://([A-Za-z0-9.-]*\.)?evidon(\.\w{2}\.\w{2}|\.\w{2,4})/                                        2023-10-30 21:46:55  2023-10-30 21:46:55                                                    
   10        3        1  0             ^https?://([A-Za-z0-9.-]*\.)?mediamath(\.\w{2}\.\w{2}|\.\w{2,4})/                                     2023-10-30 21:46:55  2023-10-30 21:46:55                                                    
   11        3        1  0             ^https?://([A-Za-z0-9.-]*\.)?scorecardresearch(\.\w{2}\.\w{2}|\.\w{2,4})/                             2023-10-30 21:46:55  2023-10-30 21:46:55                                                    
   12        3        1  0             ^https?://([A-Za-z0-9.-]*\.)?doubleclick(\.\w{2}\.\w{2}|\.\w{2,4})/                                   2023-10-30 21:46:55  2023-10-30 21:46:55                                                    
   13        3        1  0             ^https?://([A-Za-z0-9.-]*\.)?.doubleclick(\.\w{2}\.\w{2}|\.\w{2,4})/                                  2023-10-30 21:46:55  2023-10-30 21:46:55                                                    
   14        3        1  0             ^https?://([A-Za-z0-9.-]*\.)?googlesyndication(\.\w{2}\.\w{2}|\.\w{2,4})/                             2023-10-30 21:46:55  2023-10-30 21:46:55                                                    
   15        3        1  0             ^https?://([A-Za-z0-9.-]*\.)?s\.yimg\.com/cv/ae/us/audience/                                          2023-10-30 21:46:55  2023-10-30 21:46:55                                                    
   16        3        1  0             ^https?://([A-Za-z0-9.-]*\.)?yieldmanager(\.\w{2}\.\w{2}|\.\w{2,4})/                                  2023-10-30 21:46:55  2023-10-30 21:46:55                                                    
   17        3        1  0             ^https?://([A-Za-z0-9.-]*\.)?w55c(\.\w{2}\.\w{2}|\.\w{2,4})/                                          2023-10-30 21:46:55  2023-10-30 21:46:55                                                    
   18        3        1  0             ^https?://([A-Za-z0-9.-]*\.)?adnxs(\.\w{2}\.\w{2}|\.\w{2,4})/                                         2023-10-30 21:46:55  2023-10-30 21:46:55                                                    
   19        3        1  0             ^https?://([A-Za-z0-9.-]*\.)?advertising\.com/                                                        2023-10-30 21:46:55  2023-10-30 21:46:55                                                    
   20        3        1  0             ^https?://([A-Za-z0-9.-]*\.)?evidon\.com/                                                             2023-10-30 21:46:55  2023-10-30 21:46:55                                                    
   21        3        1  0             ^https?://([A-Za-z0-9.-]*\.)?scorecardresearch\.com/                                                  2023-10-30 21:46:55  2023-10-30 21:46:55                                                    
   22        3        1  0             ^https?://([A-Za-z0-9.-]*\.)?flashtalking\.com/                                                       2023-10-30 21:46:55  2023-10-30 21:46:55                                                    
   23        3        1  0             ^https?://([A-Za-z0-9.-]*\.)?ads\.yahoo\.com/                                                         2023-10-30 21:46:55  2023-10-30 21:46:55                                                    
   24        3        1  0             ^https?://([A-Za-z0-9.-]*\.)?global\.ard\.yahoo\.com/                                                 2023-10-30 21:46:55  2023-10-30 21:46:55                                                    
   25        3        1  0             ^https?://([A-Za-z0-9.-]*\.)?info\.yahoo\.com/                                                        2023-10-30 21:46:55  2023-10-30 21:46:55                                                    
   26        3        1  0             ^https?://([A-Za-z0-9.-]*\.)?mathtag\.com/                                                            2023-10-30 21:46:55  2023-10-30 21:46:55        
...

Kevin_Klasmeier · November 13, 2023, 12:35am

I have 2 pihole servers and have my network configured to use both. I have two servers in the event that one goes down.

I rebooted several times to unstick it with the same result.

In this past outage two observations:

I could get into the UI, but the UI would not render any data. A message appeared in the Total Queries, Queries Blocked, Percentage Blocked, and Domains on Adlists boxes in the UI stating that the website could not connect to the FTL.

PI-HOLE V5.17.2
FTL V5.23
WEB INTERFACE V5.20.2

Doing a pihole status reported that everything including FTL was up and listening.

I could not dig to google.com, i could not do a ping to google.com, i could not do an nslookup to google.com. I could ping to outside IP addresses.
I compared the settings files between both of my pihole servers to confirm they are the same.

Right after I ran the diagnostics to completed this discord post, this pihole started working. FTL was accessible and also DNS resolution started working. I wonder if the diagnostics run unstuck it.

The is the second time I had this issue with this pihole.

jfb · November 13, 2023, 2:33am

Your debug log shows some errors related to time on this Pi-hole.

   [2023-11-12 05:00:02.154 943M] WARN: Found database entries in the future (2023-11-12 05:05:00 (1699765500), last timestamp for importing: 2023-11-12 04:15:00 (1699762500)). Your over-time statistics may be incorrect (found in src/dnsmasq_interface.c:691)

Check that the date/time are correct in the OS. Incorrect time will cause problems with the unbound DNSSEC process.

If this happens again, check the following logs for any entries around the time of the freeze that may indicate a related issue or problem.

/var/log/pihole/pihole.log

/var/log/pihole/FTL.log

/var/log/syslog

and at the output of the following command:

dmesg

And, just to clean up old files in the unbound directory, I would remove the following files and restart unbound:

/etc/unbound/unbound.conf.d/bak/resolvconf_resolvers.conf.bak

/etc/unbound/unbound.conf.d/bak/pi-hole.conf

Kevin_Klasmeier · November 13, 2023, 3:13am

Ok, i just noticed that FTL cannot be accessed by the UI again.

Date and time is correct
roc@RocPiHole:~ $ date
Mon 13 Nov 2023 02:41:38 AM UTC

Dig fails:
roc@RocPiHole:~ $ dig google.com

; <<>> DiG 9.16.44-Debian <<>> google.com
;; global options: +cmd
;; connection timed out; no servers could be reached

/var/log/pihole/pihole.log - shows an exit then no more traffic
Nov 13 02:30:01 dnsmasq[943]: cached www.netgear.com is
Nov 13 02:30:01 dnsmasq[943]: cached d3jdtixm7cvu7y.cloudfront.net is 3.160.22.100
Nov 13 02:30:01 dnsmasq[943]: cached d3jdtixm7cvu7y.cloudfront.net is 3.160.22.102
Nov 13 02:30:01 dnsmasq[943]: cached d3jdtixm7cvu7y.cloudfront.net is 3.160.22.72
Nov 13 02:30:01 dnsmasq[943]: cached d3jdtixm7cvu7y.cloudfront.net is 3.160.22.94
Nov 13 02:30:01 dnsmasq[943]: exiting on receipt of SIGTERM

Removed the files you suggested
roc@RocPiHole:/etc/unbound/unbound.conf.d/bak $ ls -la
total 8
drwxr-xr-x 1 root root 82 Oct 30 20:51 .
drwxr-xr-x 1 root root 94 Oct 30 20:55 ..
-rw-r--r-- 1 root root 294 Oct 30 20:51 pi-hole.conf
-rw-r--r-- 1 root root 79 Oct 30 20:08 resolvconf_resolvers.conf.bak
roc@RocPiHole:/etc/unbound/unbound.conf.d/bak $ sudo rm resolvconf_resolvers.conf.bak
roc@RocPiHole:/etc/unbound/unbound.conf.d/bak $ sudo rm pi-hole.conf

Other steps
I rebooted several times and the same issue occurs

I ran another debug log. Highlights
*** [ DIAGNOSING ]: Operating system
[i] Distro: Debian
[i] Version: 11
[✗] dig return code: 10
[✗] dig response: dig: couldn't get address for 'ns1.pi-hole.net': failure
[✗] Error: dig command failed - Unable to check OS

*** [ DIAGNOSING ]: Name resolution (IPv4) using a random blocked domain and a known ad-serving domain
[✗] Failed to resolve polandoperation.ink on lo (127.0.0.1)
[✗] Failed to resolve polandoperation.ink on eth0 (192.168.1.11)
[✗] Failed to resolve doubleclick.com via a remote, public DNS server (8.8.8.8)

*** [ DIAGNOSING ]: Name resolution (IPv6) using a random blocked domain and a known ad-serving domain
[✗] Failed to resolve sexy-iveta.blogspot.ie on lo (::1)
[✗] Failed to resolve sexy-iveta.blogspot.ie on eth0 (fd79:c568:357d:44f3:425c:efd0:b8b4:5669)
[✗] Failed to resolve sexy-iveta.blogspot.ie on eth0 (fe80::966a:ab14:e3c7:81dd)
[✗] Failed to resolve doubleclick.com via a remote, public DNS server (2001:4860:4860::8888)

*** [ DIAGNOSING ]: contents of /etc/lighttpd/conf.d
/etc/lighttpd/conf.d does not exist.

Kevin_Klasmeier · November 13, 2023, 3:13am

dmesg

**roc@RocPiHole:~ $ dmesg**
[    0.000000] Booting Linux on physical CPU 0x0000000000 [0x410fd034]
[    0.000000] Linux version 6.1.54-10001-gd517e36a604d (autobuild@deb.libre.computer) (aarch64-linux-gnu-gcc (Debian 12.2.0-14) 12.2.0, GNU ld (GNU Binutils for Debian) 2.40) #1 SMP PREEMPT_DYNAMIC Fri Sep 22 22:11:56 EDT 2023
[    0.000000] Machine model: Libre Computer ROC-RK3328-CC
[    0.000000] efi: EFI v2.100 by Das U-Boot
[    0.000000] efi: RTPROP=0x76692040 SMBIOS=0x76691000 RNG=0x54c56040 MEMRESERVE=0x54c55040
[    0.000000] random: crng init done
[    0.000000] Zone ranges:
[    0.000000]   DMA      [mem 0x0000000000200000-0x000000007fffffff]
[    0.000000]   DMA32    empty
[    0.000000]   Normal   empty
[    0.000000] Movable zone start for each node
[    0.000000] Early memory node ranges
[    0.000000]   node   0: [mem 0x0000000000200000-0x0000000076690fff]
[    0.000000]   node   0: [mem 0x0000000076691000-0x0000000076692fff]
[    0.000000]   node   0: [mem 0x0000000076693000-0x0000000076693fff]
[    0.000000]   node   0: [mem 0x0000000076694000-0x0000000076699fff]
[    0.000000]   node   0: [mem 0x000000007669a000-0x000000007f6affff]
[    0.000000]   node   0: [mem 0x000000007f6b0000-0x000000007f6bffff]
[    0.000000]   node   0: [mem 0x000000007f6c0000-0x000000007f7fffff]
[    0.000000]   node   0: [mem 0x000000007f800000-0x000000007ffe8fff]
[    0.000000]   node   0: [mem 0x000000007ffe9000-0x000000007fffffff]
[    0.000000] Initmem setup node 0 [mem 0x0000000000200000-0x000000007fffffff]
[    0.000000] On node 0, zone DMA: 512 pages in unavailable ranges
[    0.000000] cma: Reserved 384 MiB at 0x000000005e600000
[    0.000000] psci: probing for conduit method from DT.
[    0.000000] psci: PSCIv1.1 detected in firmware.
[    0.000000] psci: Using standard PSCI v0.2 function IDs
[    0.000000] psci: MIGRATE_INFO_TYPE not supported.
[    0.000000] psci: SMC Calling Convention v1.4
[    0.000000] percpu: Embedded 29 pages/cpu s80744 r8192 d29848 u118784
[    0.000000] pcpu-alloc: s80744 r8192 d29848 u118784 alloc=29*4096
[    0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3
[    0.000000] Detected VIPT I-cache on CPU0
[    0.000000] CPU features: kernel page table isolation forced ON by KASLR
[    0.000000] CPU features: detected: Kernel page table isolation (KPTI)
[    0.000000] CPU features: detected: ARM erratum 845719
[    0.000000] alternatives: applying boot alternatives
[    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 515592
[    0.000000] Kernel command line: BOOT_IMAGE=/boot/vmlinuz-6.1.54-10001-gd517e36a604d root=UUID=f88619ca-3aa4-4a55-9d7c-129d9519f03a ro noquiet
[    0.000000] Unknown kernel command line parameters "noquiet BOOT_IMAGE=/boot/vmlinuz-6.1.54-10001-gd517e36a604d", will be passed to user space.
[    0.000000] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
[    0.000000] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)
[    0.000000] mem auto-init: stack:all(zero), heap alloc:off, heap free:off
[    0.000000] Memory: 1588568K/2095104K available (19456K kernel code, 3598K rwdata, 14768K rodata, 7680K init, 805K bss, 113320K reserved, 393216K cma-reserved)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[    0.000000] ftrace: allocating 61715 entries in 242 pages
[    0.000000] ftrace: allocated 242 pages with 5 groups
[    0.000000] trace event string verifier disabled
[    0.000000] Dynamic Preempt: full
[    0.000000] rcu: Preemptible hierarchical RCU implementation.
[    0.000000] rcu:     RCU event tracing is enabled.
[    0.000000] rcu:     RCU restricting CPUs from NR_CPUS=8 to nr_cpu_ids=4.
[    0.000000]  Trampoline variant of Tasks RCU enabled.
[    0.000000]  Rude variant of Tasks RCU enabled.
[    0.000000]  Tracing variant of Tasks RCU enabled.
[    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
[    0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4
[    0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
[    0.000000] Root IRQ handler: gic_handle_irq
[    0.000000] GIC: Using split EOI/Deactivate mode
[    0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.
[    0.000000] arch_timer: cp15 timer(s) running at 24.00MHz (phys).
[    0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x588fe9dc0, max_idle_ns: 440795202592 ns
[    0.000000] sched_clock: 56 bits at 24MHz, resolution 41ns, wraps every 4398046511097ns
[    0.001692] Console: colour dummy device 80x25
[    0.002650] printk: console [tty0] enabled
[    0.002710] Calibrating delay loop (skipped), value calculated using timer frequency.. 48.00 BogoMIPS (lpj=96000)
[    0.002754] pid_max: default: 32768 minimum: 301
[    0.002907] LSM: Security Framework initializing
[    0.002946] Yama: becoming mindful.
[    0.003097] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)
[    0.003144] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)
[    0.005340] cblist_init_generic: Setting adjustable number of callback queues.
[    0.005389] cblist_init_generic: Setting shift to 2 and lim to 1.
[    0.005524] cblist_init_generic: Setting adjustable number of callback queues.
[    0.005555] cblist_init_generic: Setting shift to 2 and lim to 1.
[    0.005680] cblist_init_generic: Setting adjustable number of callback queues.
[    0.005710] cblist_init_generic: Setting shift to 2 and lim to 1.
[    0.006030] rcu: Hierarchical SRCU implementation.
[    0.006055] rcu:     Max phase no-delay instances is 1000.
[    0.008771] Remapping and enabling EFI services.
[    0.009238] smp: Bringing up secondary CPUs ...
[    0.010041] Detected VIPT I-cache on CPU1
[    0.010228] CPU1: Booted secondary processor 0x0000000001 [0x410fd034]
[    0.011092] Detected VIPT I-cache on CPU2
[    0.011266] CPU2: Booted secondary processor 0x0000000002 [0x410fd034]
[    0.012149] Detected VIPT I-cache on CPU3
[    0.012332] CPU3: Booted secondary processor 0x0000000003 [0x410fd034]
[    0.012471] smp: Brought up 1 node, 4 CPUs
[    0.012663] SMP: Total of 4 processors activated.
[    0.012688] CPU features: detected: 32-bit EL0 Support
[    0.012709] CPU features: detected: 32-bit EL1 Support
[    0.012735] CPU features: detected: CRC32 instructions
[    0.012863] CPU: All CPU(s) started at EL2
[    0.012894] alternatives: applying system-wide alternatives
[    0.015667] devtmpfs: initialized
[    0.030555] Registered cp15_barrier emulation handler
[    0.030608] Registered setend emulation handler
[    0.030933] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[    0.030986] futex hash table entries: 1024 (order: 4, 65536 bytes, linear)
[    0.045886] pinctrl core: initialized pinctrl subsystem
[    0.046331] regulator-dummy: no parameters, enabled
[    0.046842] SMBIOS 3.0 present.
[    0.046895] DMI: libre-computer roc-rk3328-cc/roc-rk3328-cc, BIOS 2023.07+ 07/01/2023
[    0.047545] NET: Registered PF_NETLINK/PF_ROUTE protocol family
[    0.049365] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations
[    0.049852] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
[    0.050168] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
[    2.406215] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
[    2.432884] loop: module loaded
[    2.433694] Loading iSCSI transport class v2.0-870.
[    2.434419] iscsi: registered transport (tcp)
[    2.436211] Rounding down aligned max_sectors from 4294967295 to 4294967288
[    2.436459] db_root: cannot open: /etc/target
[    2.439939] spi-nor spi0.0: unrecognized JEDEC id bytes: ff ff ff ff ff ff
[    2.443108] tun: Universal TUN/TAP device driver, 1.6
[    2.445483] rk_gmac-dwmac ff540000.ethernet: IRQ eth_wake_irq not found
[    2.445532] rk_gmac-dwmac ff540000.ethernet: IRQ eth_lpi not found
[    2.445693] rk_gmac-dwmac ff540000.ethernet: PTP uses main clock
[    2.445740] rk_gmac-dwmac ff540000.ethernet: Looking up phy-supply from device tree
[    2.445942] rk_gmac-dwmac ff540000.ethernet: clock input or output? (input).
[    2.445977] rk_gmac-dwmac ff540000.ethernet: TX delay(0x24).
[    2.446007] rk_gmac-dwmac ff540000.ethernet: RX delay(0x18).
[    2.446041] rk_gmac-dwmac ff540000.ethernet: integrated PHY? (no).
[    2.446113] rk_gmac-dwmac ff540000.ethernet: clock input from PHY
[    2.451150] rk_gmac-dwmac ff540000.ethernet: init for RGMII
[    2.451446] rk_gmac-dwmac ff540000.ethernet: User ID: 0x10, Synopsys ID: 0x35
[    2.451490] rk_gmac-dwmac ff540000.ethernet:         DWMAC1000
[    2.451521] rk_gmac-dwmac ff540000.ethernet: DMA HW capability register supported
[    2.451550] rk_gmac-dwmac ff540000.ethernet: RX Checksum Offload Engine supported
[    2.451578] rk_gmac-dwmac ff540000.ethernet: COE Type 2
[    2.451602] rk_gmac-dwmac ff540000.ethernet: TX Checksum insertion supported
[    2.451628] rk_gmac-dwmac ff540000.ethernet: Wake-Up On Lan supported
[    2.451740] rk_gmac-dwmac ff540000.ethernet: Normal descriptors
[    2.451769] rk_gmac-dwmac ff540000.ethernet: Ring mode enabled
[    2.451794] rk_gmac-dwmac ff540000.ethernet: Enable RX Mitigation via HW Watchdog Timer
[    2.564612] RTL8211E Gigabit Ethernet stmmac-0:00: attached PHY driver (mii_bus:phy_addr=stmmac-0:00, irq=POLL)
[    2.564674] RTL8211E Gigabit Ethernet stmmac-0:01: attached PHY driver (mii_bus:phy_addr=stmmac-0:01, irq=POLL)
[    2.567471] VFIO - User Level meta-driver version: 0.3
[    2.629008] dwc2 ff580000.usb: Looking up vusb_d-supply from device tree
[    2.629036] dwc2 ff580000.usb: Looking up vusb_d-supply property in node /usb@ff580000 failed
[    2.629066] dwc2 ff580000.usb: supply vusb_d not found, using dummy regulator
[    2.629278] dwc2 ff580000.usb: Looking up vusb_a-supply from device tree
[    2.629295] dwc2 ff580000.usb: Looking up vusb_a-supply property in node /usb@ff580000 failed
[    2.629318] dwc2 ff580000.usb: supply vusb_a not found, using dummy regulator
[    2.629561] dwc2 ff580000.usb: Looking up vbus-supply from device tree
[    2.629578] dwc2 ff580000.usb: Looking up vbus-supply property in node /usb@ff580000 failed
[    2.642151] dwc2 ff580000.usb: DWC OTG Controller
[    2.642211] dwc2 ff580000.usb: new USB bus registered, assigned bus number 1
[    2.642274] dwc2 ff580000.usb: irq 34, io mem 0xff580000
[    2.642560] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.01
[    2.642602] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    2.642634] usb usb1: Product: DWC OTG Controller
[    2.642658] usb usb1: Manufacturer: Linux 6.1.54-10001-gd517e36a604d dwc2_hsotg
[    2.642687] usb usb1: SerialNumber: ff580000.usb
[    2.643462] hub 1-0:1.0: USB hub found
[    2.643533] hub 1-0:1.0: 1 port detected
[    2.645953] xhci-hcd xhci-hcd.0.auto: xHCI Host Controller
[    2.646019] xhci-hcd xhci-hcd.0.auto: new USB bus registered, assigned bus number 2
[    2.646240] xhci-hcd xhci-hcd.0.auto: hcc params 0x0220fe64 hci version 0x110 quirks 0x0000000002010010
[    2.646339] xhci-hcd xhci-hcd.0.auto: irq 33, io mem 0xff600000
[    2.646596] xhci-hcd xhci-hcd.0.auto: xHCI Host Controller
[    2.646634] xhci-hcd xhci-hcd.0.auto: new USB bus registered, assigned bus number 3
[    2.646675] xhci-hcd xhci-hcd.0.auto: Host supports USB 3.0 SuperSpeed
[    2.646993] usb usb2: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.01
[    2.647035] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    2.647068] usb usb2: Product: xHCI Host Controller
[    2.647092] usb usb2: Manufacturer: Linux 6.1.54-10001-gd517e36a604d xhci-hcd
[    2.647120] usb usb2: SerialNumber: xhci-hcd.0.auto
[    2.647310] ehci-platform ff5c0000.usb: EHCI Host Controller
[    2.647334] ohci-platform ff5d0000.usb: Generic Platform OHCI controller
[    2.647863] hub 2-0:1.0: USB hub found
[    2.647930] hub 2-0:1.0: 1 port detected
[    2.648509] usb usb3: We don't know the algorithms for LPM for this host, disabling LPM.
[    2.648717] usb usb3: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.01
[    2.648757] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    2.648788] usb usb3: Product: xHCI Host Controller
[    2.648813] usb usb3: Manufacturer: Linux 6.1.54-10001-gd517e36a604d xhci-hcd
[    2.648843] usb usb3: SerialNumber: xhci-hcd.0.auto
[    2.649507] hub 3-0:1.0: USB hub found
[    2.649574] hub 3-0:1.0: 1 port detected
[    2.650087] ehci-platform ff5c0000.usb: new USB bus registered, assigned bus number 4
[    2.650108] ohci-platform ff5d0000.usb: new USB bus registered, assigned bus number 5
[    2.650277] ehci-platform ff5c0000.usb: irq 35, io mem 0xff5c0000
[    2.650304] ohci-platform ff5d0000.usb: irq 36, io mem 0xff5d0000
[    2.650901] usbcore: registered new interface driver uas
[    2.651061] usbcore: registered new interface driver usb-storage
[    2.652721] i2c_dev: i2c /dev entries driver
[    2.654747] i2c 1-0018: Fixed dependency cycle(s) with /i2c@ff160000/pmic@18/regulators/DCDC_REG4
[    2.656540] rk808 1-0018: chip id: 0x8050
[    2.661854] rk808-regulator rk808-regulator: there is no dvs0 gpio
[    2.661929] rk808-regulator rk808-regulator: there is no dvs1 gpio
[    2.662039] rk808 1-0018: Looking up vcc1-supply from device tree
[    2.662062] vdd_logic: supplied by vcc_sys
[    2.662075] vcc_sys: could not add device link regulator.3: -ENOENT
[    2.662880] ehci-platform ff5c0000.usb: USB 2.0 started, EHCI 1.00
[    2.663332] usb usb4: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.01
[    2.663376] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    2.663411] usb usb4: Product: EHCI Host Controller
[    2.663435] usb usb4: Manufacturer: Linux 6.1.54-10001-gd517e36a604d ehci_hcd
[    2.663462] usb usb4: SerialNumber: ff5c0000.usb
[    2.664200] hub 4-0:1.0: USB hub found
[    2.664301] hub 4-0:1.0: 1 port detected
[    2.664429] vdd_logic: 712 <--> 1450 mV at 1200 mV, enabled
[    2.664755] rk808 1-0018: Looking up vcc2-supply from device tree
[    2.664782] vdd_arm: supplied by vcc_sys
[    2.664795] vcc_sys: could not add device link regulator.4: -ENOENT
[    2.666185] vdd_arm: 712 <--> 1450 mV at 950 mV, enabled
[    2.666459] rk808 1-0018: Looking up vcc3-supply from device tree
[    2.666481] vcc_ddr: supplied by vcc_sys
[    2.666493] vcc_sys: could not add device link regulator.5: -ENOENT
[    2.666556] vcc_ddr: at 5000 mV, enabled
[    2.666871] rk808 1-0018: Looking up vcc4-supply from device tree
[    2.666893] vcc_io: supplied by vcc_sys
[    2.666904] vcc_sys: could not add device link regulator.6: -ENOENT
[    2.667911] vcc_io: 3300 mV, enabled
[    2.668192] rk808 1-0018: Looking up vcc5-supply from device tree
[    2.668216] vcc_18: supplied by vcc_io
[    2.668227] vcc_io: could not add device link regulator.7: -ENOENT
[    2.671465] vcc_18: 1800 mV, enabled
[    2.671785] rk808 1-0018: Looking up vcc5-supply from device tree
[    2.671813] vcc18_emmc: supplied by vcc_io
[    2.671825] vcc_io: could not add device link regulator.8: -ENOENT
[    2.675116] vcc18_emmc: 1800 mV, enabled
[    2.675418] rk808 1-0018: Looking up vcc6-supply from device tree
[    2.675442] vdd_10: supplied by vcc_io
[    2.675454] vcc_io: could not add device link regulator.9: -ENOENT
[    2.678710] vdd_10: 1000 mV, enabled
[    2.686081] dw_wdt ff1a0000.watchdog: No valid TOPs array specified
[    2.688097] cpu cpu0: Looking up cpu-supply from device tree
[    2.689675] cpu cpu0: EM: created perf domain
[    2.692550] sdhci: Secure Digital Host Controller Interface driver
[    2.692586] sdhci: Copyright(c) Pierre Ossman
[    2.693179] Synopsys Designware Multimedia Card Interface Driver
[    2.693979] sdhci-pltfm: SDHCI platform and OF driver helper
[    2.694271] dwmmc_rockchip ff520000.mmc: IDMAC supports 32-bit address mode.
[    2.694328] dwmmc_rockchip ff520000.mmc: Using internal DMA controller.
[    2.694353] dwmmc_rockchip ff520000.mmc: Version ID is 270a
[    2.694417] dwmmc_rockchip ff520000.mmc: DW MMC controller at irq 49,32 bit host data width,256 deep fifo
[    2.694552] dwmmc_rockchip ff520000.mmc: Looking up vmmc-supply from device tree
[    2.694722] dwmmc_rockchip ff520000.mmc: Looking up vqmmc-supply from device tree
[    2.696819] ledtrig-cpu: registered to indicate activity on CPUs
[    2.698455] SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping ....
[    2.698550] hid: raw HID events driver (C) Jiri Kosina
[    2.698702] usbcore: registered new interface driver usbhid
[    2.698721] usbhid: USB HID core driver
[    2.706909] mmc_host mmc0: Bus speed (slot 0) = 400000Hz (slot req 400000Hz, actual 400000HZ div = 0)
[    2.711048] usb usb5: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.01
[    2.711091] usb usb5: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    2.711110] usb usb5: Product: Generic Platform OHCI controller
[    2.711126] usb usb5: Manufacturer: Linux 6.1.54-10001-gd517e36a604d ohci_hcd
[    2.711142] usb usb5: SerialNumber: ff5d0000.usb
[    2.711849] hub 5-0:1.0: USB hub found
[    2.711905] hub 5-0:1.0: 1 port detected
[    2.782291] NET: Registered PF_PACKET protocol family
[    2.782749] 9pnet: Installing 9P2000 support
[    2.782856] Key type dns_resolver registered
[    2.783297] registered taskstats version 1
[    2.783345] Loading compiled-in X.509 certificates
[    2.785745] zswap: loaded using pool zstd/z3fold
[    2.786467] Key type .fscrypt registered
[    2.786494] Key type fscrypt-provisioning registered
[    2.787500] Btrfs loaded, crc32c=crc32c-generic, zoned=yes, fsverity=yes
[    2.805014] reg-fixed-voltage sdmmc-regulator: Looking up vin-supply from device tree
[    2.805042] vcc_sd: supplied by vcc_io
[    2.805049] vcc_io: could not add device link regulator.10: -ENOENT
[    2.805102] vcc_sd: 3300 mV, enabled
[    2.805219] reg-fixed-voltage sdmmc-regulator: vcc_sd supplying 3300000uV
[    2.805503] reg-fixed-voltage vcc-host1-5v-regulator: Looking up vin-supply from device tree
[    2.805516] vcc_host1_5v: supplied by vcc_sys
[    2.805522] vcc_sys: could not add device link regulator.11: -ENOENT
[    2.805562] vcc_host1_5v: at 5000 mV, enabled
[    2.805674] reg-fixed-voltage vcc-host1-5v-regulator: vcc_host1_5v supplying 0uV
[    2.805878] gpio-regulator sdmmcio-regulator: Looking up vin-supply from device tree
[    2.805887] vcc_sdio: supplied by vcc_sys
[    2.805893] vcc_sys: could not add device link regulator.12: -ENOENT
[    2.805926] vcc_sdio: 1800 <--> 3300 mV at 1800 mV, enabled
[    2.806400] rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree
[    2.806522] rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree
[    2.807143] rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree
[    2.807251] rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio4-supply from device tree
[    2.807872] rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio5-supply from device tree
[    2.807923] rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio6-supply from device tree
[    2.807963] rockchip-iodomain ff100000.syscon:io-domains: Looking up pmuio-supply from device tree
[    2.809814] of_cfs_init
[    2.809870] of_cfs_init: OK
[    2.810795] ALSA device list:
[    2.810848]   No soundcards found.
[    2.810940] dwmmc_rockchip ff500000.mmc: IDMAC supports 32-bit address mode.
[    2.810980] dwmmc_rockchip ff500000.mmc: Using internal DMA controller.
[    2.810997] dwmmc_rockchip ff500000.mmc: Version ID is 270a
[    2.811048] dwmmc_rockchip ff500000.mmc: DW MMC controller at irq 50,32 bit host data width,256 deep fifo
[    2.811156] dwmmc_rockchip ff500000.mmc: Looking up vmmc-supply from device tree
[    2.811290] dwmmc_rockchip ff500000.mmc: Looking up vqmmc-supply from device tree
[    2.822943] mmc_host mmc1: Bus speed (slot 0) = 400000Hz (slot req 400000Hz, actual 400000HZ div = 0)
[    2.842561] Freeing unused kernel memory: 7680K
[    2.870356] Checked W+X mappings: passed, no W+X pages found
[    2.870395] Run /init as init process
[    2.870405]   with arguments:
[    2.870408]     /init
[    2.870410]     noquiet
[    2.870413]   with environment:
[    2.870415]     HOME=/
[    2.870418]     TERM=linux
[    2.870421]     BOOT_IMAGE=/boot/vmlinuz-6.1.54-10001-gd517e36a604d
[    2.884753] mmc_host mmc1: Bus speed (slot 0) = 150000000Hz (slot req 150000000Hz, actual 150000000HZ div = 0)
[    3.238879] dwmmc_rockchip ff520000.mmc: Busy; trying anyway
[    3.269771] dwmmc_rockchip ff500000.mmc: Successfully tuned phase to 204
[    3.269825] mmc1: new ultra high speed SDR104 SDHC card at address 0001
[    3.271304] mmcblk1: mmc1:0001 00000 29.1 GiB
[    3.273708]  mmcblk1: p1 p2
[    3.320120] rk808-rtc rk808-rtc: registered as rtc0
[    3.322029] rk808-rtc rk808-rtc: setting system clock to 2023-11-13T02:30:40 UTC (1699842640)
[    3.385281] phy phy-ff430000.phy.2: Looking up phy-supply from device tree
[    3.385307] phy phy-ff430000.phy.2: Looking up phy-supply property in node /phy@ff430000 failed
[    3.389493] rockchip-drm display-subsystem: bound ff370000.vop (ops vop_component_ops)
[    3.389606] dwhdmi-rockchip ff3c0000.hdmi: Looking up avdd-0v9-supply from device tree
[    3.389619] dwhdmi-rockchip ff3c0000.hdmi: Looking up avdd-0v9-supply property in node /hdmi@ff3c0000 failed
[    3.389651] dwhdmi-rockchip ff3c0000.hdmi: supply avdd-0v9 not found, using dummy regulator
[    3.389882] dwhdmi-rockchip ff3c0000.hdmi: Looking up avdd-1v8-supply from device tree
[    3.389906] dwhdmi-rockchip ff3c0000.hdmi: Looking up avdd-1v8-supply property in node /hdmi@ff3c0000 failed
[    3.389935] dwhdmi-rockchip ff3c0000.hdmi: supply avdd-1v8 not found, using dummy regulator
[    3.390268] dwhdmi-rockchip ff3c0000.hdmi: Detected HDMI TX controller v2.11a with HDCP (inno_dw_hdmi_phy2)
[    3.395480] dwhdmi-rockchip ff3c0000.hdmi: registered DesignWare HDMI I2C bus driver
[    3.396434] rockchip-drm display-subsystem: bound ff3c0000.hdmi (ops dw_hdmi_rockchip_ops)
[    3.401317] [drm] Initialized rockchip 1.0.0 20140818 for display-subsystem on minor 0
[    3.401442] rockchip-drm display-subsystem: [drm] Cannot find any crtc or sizes
[    3.401855] rockchip-drm display-subsystem: [drm] Cannot find any crtc or sizes
[    3.401905] rockchip-drm display-subsystem: [drm] Cannot find any crtc or sizes
[    3.657242] async_tx: api initialized (async)
[    3.738934] mmc_host mmc0: Timeout sending command (cmd 0x202000 arg 0x0 status 0x80202000)
[    3.752927] mmc_host mmc0: Bus speed (slot 0) = 300000Hz (slot req 300000Hz, actual 300000HZ div = 0)
[    3.792387] BTRFS: device label rootfs devid 1 transid 33100 /dev/mmcblk1p2 scanned by btrfs (277)
[    4.287826] dwmmc_rockchip ff520000.mmc: Busy; trying anyway
[    4.787864] mmc_host mmc0: Timeout sending command (cmd 0x202000 arg 0x0 status 0x80202000)
[    4.788468] BTRFS info (device mmcblk1p2): using crc32c (crc32c-generic) checksum algorithm
[    4.788511] BTRFS info (device mmcblk1p2): disk space caching is enabled
[    4.801769] mmc_host mmc0: Bus speed (slot 0) = 200000Hz (slot req 200000Hz, actual 200000HZ div = 0)
[    4.804405] BTRFS info (device mmcblk1p2): enabling ssd optimizations
[    5.338976] dwmmc_rockchip ff520000.mmc: Busy; trying anyway
[    5.429828] NET: Registered PF_INET6 protocol family
[    5.456350] Segment Routing with IPv6
[    5.456382] RPL Segment Routing with IPv6
[    5.456432] In-situ OAM (IOAM) with IPv6
[    5.543153] systemd[1]: systemd 247.3-7+deb11u4 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +ZSTD +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=unified)
[    5.543896] systemd[1]: Detected architecture arm64.
[    5.547989] systemd[1]: Set hostname to <RocPiHole>.
[    5.839020] mmc_host mmc0: Timeout sending command (cmd 0x202000 arg 0x0 status 0x80202000)
[    5.850951] mmc_host mmc0: Bus speed (slot 0) = 100000Hz (slot req 100000Hz, actual 100000HZ div = 0)
[    6.067528] systemd[1]: Condition check resulted in Root Slice being skipped.
[    6.067623] systemd[1]: Condition check resulted in System Slice being skipped.
[    6.070702] systemd[1]: Queued start job for default target Multi-User System.
[    6.096837] systemd[1]: Created slice system-getty.slice.
[    6.098631] systemd[1]: Created slice system-modprobe.slice.
[    6.100228] systemd[1]: Created slice system-systemd\x2dfsck.slice.
[    6.101724] systemd[1]: Created slice system-systemd\x2dgrowfs.slice.
[    6.103072] systemd[1]: Created slice User and Session Slice.
[    6.103669] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
[    6.104233] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
[    6.105187] systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point.
[    6.105646] systemd[1]: Reached target Local Encrypted Volumes.
[    6.106063] systemd[1]: Reached target Paths.
[    6.106382] systemd[1]: Reached target Slices.
[    6.106636] systemd[1]: Reached target Swap.
[    6.108820] systemd[1]: Listening on Syslog Socket.
[    6.109638] systemd[1]: Listening on fsck to fsckd communication Socket.
[    6.110226] systemd[1]: Listening on initctl Compatibility Named Pipe.
[    6.112575] systemd[1]: Listening on Journal Audit Socket.
[    6.113398] systemd[1]: Listening on Journal Socket (/dev/log).
[    6.114320] systemd[1]: Listening on Journal Socket.
[    6.116813] systemd[1]: Listening on udev Control Socket.
[    6.117598] systemd[1]: Listening on udev Kernel Socket.
[    6.121553] systemd[1]: Mounting Huge Pages File System...
[    6.125942] systemd[1]: Mounting POSIX Message Queue File System...
[    6.130623] systemd[1]: Mounting RPC Pipe File System...
[    6.135843] systemd[1]: Mounting Kernel Debug File System...
[    6.141109] systemd[1]: Mounting Kernel Trace File System...
[    6.141944] systemd[1]: Condition check resulted in Kernel Module supporting RPCSEC_GSS being skipped.
[    6.152403] systemd[1]: Starting Restore / save the current clock...
[    6.170646] systemd[1]: Starting Set the console keyboard layout...
[    6.178381] systemd[1]: Starting Create list of static device nodes for the current kernel...
[    6.185252] systemd[1]: Starting Load Kernel Module configfs...
[    6.193018] systemd[1]: Starting Load Kernel Module drm...
[    6.199615] systemd[1]: Starting Load Kernel Module fuse...
[    6.201126] systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped.
[    6.201400] systemd[1]: Condition check resulted in File System Check on Root Device being skipped.
[    6.212854] systemd[1]: Starting Journal Service...
[    6.219479] systemd[1]: Starting Load Kernel Modules...
[    6.224759] systemd[1]: Starting Remount Root and Kernel File Systems...
[    6.224927] fuse: init (API version 7.37)
[    6.233497] systemd[1]: Starting Coldplug All udev Devices...
[    6.247607] systemd[1]: Mounted Huge Pages File System.
[    6.248641] systemd[1]: Mounted POSIX Message Queue File System.
[    6.249663] systemd[1]: Mounted RPC Pipe File System.
[    6.250718] systemd[1]: Mounted Kernel Debug File System.
[    6.251863] systemd[1]: Mounted Kernel Trace File System.
[    6.255704] systemd[1]: Finished Restore / save the current clock.
[    6.261693] systemd[1]: Finished Create list of static device nodes for the current kernel.
[    6.264144] systemd[1]: modprobe@configfs.service: Succeeded.
[    6.265922] systemd[1]: Finished Load Kernel Module configfs.
[    6.269805] systemd[1]: modprobe@drm.service: Succeeded.
[    6.272089] systemd[1]: Finished Load Kernel Module drm.
[    6.277830] systemd[1]: modprobe@fuse.service: Succeeded.
[    6.279505] systemd[1]: Finished Load Kernel Module fuse.
[    6.282111] systemd[1]: Finished Load Kernel Modules.
[    6.299689] BTRFS info (device mmcblk1p2: state M): use zstd compression, level 3
[    6.311258] systemd[1]: Mounting FUSE Control File System...
[    6.315844] systemd[1]: Mounting Kernel Configuration File System...
[    6.325793] systemd[1]: Starting Apply Kernel Variables...
[    6.357969] systemd[1]: Finished Remount Root and Kernel File Systems.
[    6.359235] systemd[1]: Mounted FUSE Control File System.
[    6.360136] systemd[1]: Mounted Kernel Configuration File System.
[    6.364897] systemd[1]: Starting Grow File System on /...
[    6.370180] systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped.
[    6.370502] systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped.
[    6.374567] systemd[1]: Starting Load/Save Random Seed...
[    6.389394] systemd[1]: Starting Create System Users...
[    6.399583] dwmmc_rockchip ff520000.mmc: Busy; trying anyway
[    6.409064] systemd[1]: Finished Apply Kernel Variables.
[    6.431644] systemd[1]: Finished Grow File System on /.
[    6.508349] systemd[1]: Finished Load/Save Random Seed.
[    6.510686] systemd[1]: Finished Create System Users.
[    6.511710] systemd[1]: Condition check resulted in First Boot Complete being skipped.
[    6.515711] systemd[1]: Starting Create Static Device Nodes in /dev...
[    6.605224] systemd[1]: Finished Create Static Device Nodes in /dev.
[    6.605986] systemd[1]: Started Journal Service.
[    6.658532] systemd-journald[372]: Received client request to flush runtime journal.
[    6.899637] mmc_host mmc0: Timeout sending command (cmd 0x202000 arg 0x0 status 0x80202000)
[    7.928836] mc: Linux media interface: v0.10
[    7.940219] lima ff300000.gpu: Looking up mali-supply from device tree
[    7.940787] lima ff300000.gpu: gp - mali450 version major 0 minor 0
[    7.940857] lima ff300000.gpu: pp0 - mali450 version major 0 minor 0
[    7.940920] lima ff300000.gpu: pp1 - mali450 version major 0 minor 0
[    7.940954] lima ff300000.gpu: l2 cache 8K, 4-way, 64byte cache line, 128bit external bus
[    7.940965] lima ff300000.gpu: l2 cache 64K, 4-way, 64byte cache line, 128bit external bus
[    7.956945] lima ff300000.gpu: bus rate = 163840000
[    7.956972] lima ff300000.gpu: mod rate = 163840000
[    7.957066] lima ff300000.gpu: Looking up mali-supply from device tree
[    7.957104] vdd_logic: could not add device link ff300000.gpu: -EEXIST
[    7.958709] [drm] Initialized lima 1.1.0 20191231 for ff300000.gpu on minor 1
[    7.984331] rk3328-codec ff410000.codec: spk_depop_time use default value.
[    7.990524] videodev: Linux video capture interface: v2.00
[    8.017913] rockchip-saradc ff280000.adc: Looking up vref-supply from device tree
[    8.017936] rockchip-saradc ff280000.adc: Looking up vref-supply property in node /adc@ff280000 failed
[    8.017966] rockchip-saradc ff280000.adc: supply vref not found, using dummy regulator
[    8.019035] rockchip-saradc: probe of ff280000.adc failed with error -22
[    8.104815] rockchip_vdec: module is from the staging directory, the quality is unknown, you have been warned.
[    8.126444] rkvdec ff360000.video-codec: Adding to iommu group 3
[    8.126483] iommu: Failed to allocate default IOMMU domain of type 4 for group (null) - Falling back to IOMMU_DOMAIN_DMA
[    8.127887] hantro-vpu ff350000.video-codec: Adding to iommu group 2
[    8.127962] iommu: Failed to allocate default IOMMU domain of type 4 for group (null) - Falling back to IOMMU_DOMAIN_DMA
[    8.148442] hantro-vpu ff350000.video-codec: registered rockchip,rk3328-vpu-dec as /dev/video0
[    8.186006] Registered IR keymap rc-empty
[    8.186117] rc rc0: gpio_ir_recv as /devices/platform/ir-receiver/rc/rc0
[    8.186943] rc rc0: lirc_dev: driver gpio_ir_recv registered at minor = 0, raw IR receiver, no transmitter
[    8.187167] input: gpio_ir_recv as /devices/platform/ir-receiver/rc/rc0/input0
[    8.283938] input: rk805 pwrkey as /devices/platform/ff160000.i2c/i2c-1/1-0018/rk805-pwrkey/input/input1
[    9.371835] 8021q: 802.1Q VLAN Support v1.8
[    9.530631] cfg80211: Loading compiled-in X.509 certificates for regulatory database
[    9.584533] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
[    9.618448] cfg80211: loaded regulatory.db is malformed or signature is missing/invalid
[    9.625991] Adding 102396k swap on /var/swap.  Priority:-2 extents:1 across:102396k FS
[    9.724601] rk_gmac-dwmac ff540000.ethernet eth0: Register MEM_TYPE_PAGE_POOL RxQ-0
[    9.727031] rk_gmac-dwmac ff540000.ethernet eth0: PHY [stmmac-0:00] driver [RTL8211E Gigabit Ethernet] (irq=POLL)
[    9.727076] rk_gmac-dwmac ff540000.ethernet eth0: No Safety Features support found
[    9.727091] rk_gmac-dwmac ff540000.ethernet eth0: PTP not supported by HW
[    9.747621] rk_gmac-dwmac ff540000.ethernet eth0: configuring for phy/rgmii link mode
[    9.900431] openvswitch: Open vSwitch switching datapath
[   13.855717] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[   13.855877] rk_gmac-dwmac ff540000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx
[   15.277151] ICMPv6: process `dhcpcd' is using deprecated sysctl (syscall) net.ipv6.neigh.eth0.retrans_time - use net.ipv6.neigh.eth0.retrans_time_ms instead
roc@RocPiHole:~ $

deHakkelaar · November 13, 2023, 10:37pm

There is so much wrong to inspect/fix, that I'm inclined to say start over fresh again.
But this time in stages so first get Pi-hole up and test for a while before installing Unbound.
If thats working ok for a period, install the others like openvswitch etc.

But maybe someone else has a brilliant idea?

jfb · November 13, 2023, 11:03pm

This will temporarily reset the nameserver on the Pi to bypass Pi-Hole DNS.

sudo nano /etc/resolv.conf

Edit the nameserver line to nameserver 9.9.9.9 or your preferred third party DNS service, save and exit

Run

pihole -d

and upload the debug log.

Kevin_Klasmeier · November 14, 2023, 11:02pm

Here is the latest debug log after making the temporary nameserver change to 9.9.9.9

https://tricorder.pi-hole.net/z5xQLVOg/

Thank you for your help.

Kevin_Klasmeier · November 27, 2023, 10:18pm

I reimaged my ROC-RK3328-CC running Debian Bullseye and then installed PiHole again. Then after I used this documentation to install Unbound: unbound - Pi-hole documentation

I got the same same results, so I am concluding that the Debian Bullseye OS port for the ROC is at fault.

I reimaged my ROC-RK3328-CC running Ubuntu and then installed PiHole then Unbound. This has been successful. I have had no issues whatsoever with Unbound or with PiHole.

Since everything is working now, I am in good shape. I would recommend to anyone running the ROC-RO3328-CC to use Ubuntu instead of Debian Bullseye when trying to run PiHole and Unbound.

system · December 18, 2023, 10:18pm

This topic was automatically closed 21 days after the last reply. New replies are no longer allowed.