Home Assistant - refused to connect at random

Hi, I’ve noticed recently that when attempting to access Home Assistant via internal or external IP it returns the common error “refused to connect”.

It has recently become more problematic without any obvious reason for it.

Temporary workaround
Power cycle

Hardware
Raspberry Pi 4 4Gb
Powered via PoE via PoE hat from Unifi 24 PoE switch
128Gb SSD used for storing Home Assistant
Has a static IP address

Home Assistant
Core Version: core-2021.11.5
Supervisor Version: supervisor-2021.10.8
OS: Home Assistant OS 6.6
Deployment: production
Python version: 3…7

Integrations
Alexa
CO2 Signal
ESPHome
HACS
Mobile App
Mosquito broker
Tasmota
WLED

Addons (all running latest version)
Duck DNS
ESPHome
Home Assistant Google Drive Backup
Mosquitto broker
Samba share
Studio Code Server
Terminal & SSH

Logs

Core

2021-12-04 10:07:52 ERROR (SyncWorker_19) [homeassistant.components.google.calendar] Unable to connect to Google
2021-12-04 10:07:57 ERROR (SyncWorker_41) [homeassistant.components.google.calendar] Unable to connect to Google
2021-12-04 10:08:02 ERROR (SyncWorker_38) [homeassistant.components.google.calendar] Unable to connect to Google
2021-12-04 10:08:07 ERROR (SyncWorker_53) [homeassistant.components.google.calendar] Unable to connect to Google
2021-12-04 10:16:21 WARNING (MainThread) [homeassistant.components.unifi] Lost connection to UniFi controller
2021-12-04 10:23:52 ERROR (SyncWorker_59) [homeassistant.components.google.calendar] Unable to connect to Google
2021-12-04 10:23:57 ERROR (SyncWorker_22) [homeassistant.components.google.calendar] Unable to connect to Google
2021-12-04 10:24:02 ERROR (SyncWorker_20) [homeassistant.components.google.calendar] Unable to connect to Google
2021-12-04 10:24:07 ERROR (SyncWorker_62) [homeassistant.components.google.calendar] Unable to connect to Google
2021-12-04 10:27:00 ERROR (MainThread) [alexapy.alexaapi] Giving up _static_request(...) after 5 tries (alexapy.aiohttp.client_exceptions.ClientConnectorError: Cannot connect to host alexa.amazon.co.uk:443 ssl:<ssl.SSLContext object at 0x7f842bd3c0> [Try again])
2021-12-04 10:27:00 WARNING (MainThread) [alexapy.helpers] alexaapi.get_dnd_state((<alexapy.alexalogin.AlexaLogin object at 0x7f845164c0>,), {}): A connection error occured: An exception of type ClientConnectorError occurred. Arguments:
(ConnectionKey(host='alexa.amazon.co.uk', port=443, is_ssl=True, ssl=<ssl.SSLContext object at 0x7f842bd3c0>, proxy=None, proxy_auth=None, proxy_headers_hash=3842574276470763602), gaierror(-3, 'Try again'))
2021-12-04 10:27:00 ERROR (MainThread) [alexapy.alexaapi] Giving up _static_request(...) after 5 tries (alexapy.aiohttp.client_exceptions.ClientConnectorError: Cannot connect to host alexa.amazon.co.uk:443 ssl:<ssl.SSLContext object at 0x7f842bd3c0> [Try again])
2021-12-04 10:27:00 WARNING (MainThread) [alexapy.helpers] alexaapi.get_device_preferences((<alexapy.alexalogin.AlexaLogin object at 0x7f845164c0>,), {}): A connection error occured: An exception of type ClientConnectorError occurred. Arguments:
(ConnectionKey(host='alexa.amazon.co.uk', port=443, is_ssl=True, ssl=<ssl.SSLContext object at 0x7f842bd3c0>, proxy=None, proxy_auth=None, proxy_headers_hash=3842574276470763602), gaierror(-3, 'Try again'))
2021-12-04 10:27:00 ERROR (MainThread) [alexapy.alexaapi] Giving up _static_request(...) after 5 tries (alexapy.aiohttp.client_exceptions.ClientConnectorError: Cannot connect to host alexa.amazon.co.uk:443 ssl:<ssl.SSLContext object at 0x7f842bd3c0> [Try again])
2021-12-04 10:27:00 WARNING (MainThread) [alexapy.helpers] alexaapi.get_bluetooth((<alexapy.alexalogin.AlexaLogin object at 0x7f845164c0>,), {}): A connection error occured: An exception of type ClientConnectorError occurred. Arguments:
(ConnectionKey(host='alexa.amazon.co.uk', port=443, is_ssl=True, ssl=<ssl.SSLContext object at 0x7f842bd3c0>, proxy=None, proxy_auth=None, proxy_headers_hash=3842574276470763602), gaierror(-3, 'Try again'))
2021-12-04 10:27:00 ERROR (MainThread) [custom_components.alexa_media] Error fetching alexa_media data: Error communicating with API: 
2021-12-04 10:27:06 ERROR (MainThread) [alexapy.alexaapi] Giving up _static_request(...) after 5 tries (alexapy.aiohttp.client_exceptions.ClientConnectorError: Cannot connect to host alexa.amazon.co.uk:443 ssl:<ssl.SSLContext object at 0x7f842bd3c0> [Try again])
2021-12-04 10:27:06 WARNING (MainThread) [alexapy.helpers] alexaapi.get_devices((<alexapy.alexalogin.AlexaLogin object at 0x7f845164c0>,), {}): A connection error occured: An exception of type ClientConnectorError occurred. Arguments:
(ConnectionKey(host='alexa.amazon.co.uk', port=443, is_ssl=True, ssl=<ssl.SSLContext object at 0x7f842bd3c0>, proxy=None, proxy_auth=None, proxy_headers_hash=3842574276470763602), gaierror(-3, 'Try again'))
2021-12-04 10:31:05 ERROR (SyncWorker_51) [homeassistant.components.co2signal] Unexpected exception
Traceback (most recent call last):
  File "/usr/local/lib/python3.9/site-packages/urllib3/connection.py", line 174, in _new_conn
    conn = connection.create_connection(
  File "/usr/local/lib/python3.9/site-packages/urllib3/util/connection.py", line 73, in create_connection
    for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):
  File "/usr/local/lib/python3.9/socket.py", line 954, in getaddrinfo
    for res in _socket.getaddrinfo(host, port, family, type, proto, flags):
socket.gaierror: [Errno -3] Try again
During handling of the above exception, another exception occurred:
Traceback (most recent call last):
  File "/usr/local/lib/python3.9/site-packages/urllib3/connectionpool.py", line 699, in urlopen
    httplib_response = self._make_request(
  File "/usr/local/lib/python3.9/site-packages/urllib3/connectionpool.py", line 382, in _make_request
    self._validate_conn(conn)
  File "/usr/local/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1010, in _validate_conn
    conn.connect()
  File "/usr/local/lib/python3.9/site-packages/urllib3/connection.py", line 358, in connect
    conn = self._new_conn()
  File "/usr/local/lib/python3.9/site-packages/urllib3/connection.py", line 186, in _new_conn
    raise NewConnectionError(
urllib3.exceptions.NewConnectionError: <urllib3.connection.HTTPSConnection object at 0x7f633b8ca0>: Failed to establish a new connection: [Errno -3] Try again
During handling of the above exception, another exception occurred:
Traceback (most recent call last):
  File "/usr/local/lib/python3.9/site-packages/requests/adapters.py", line 439, in send
    resp = conn.urlopen(
  File "/usr/local/lib/python3.9/site-packages/urllib3/connectionpool.py", line 755, in urlopen
    retries = retries.increment(
  File "/usr/local/lib/python3.9/site-packages/urllib3/util/retry.py", line 574, in increment
    raise MaxRetryError(_pool, url, error or ResponseError(cause))
urllib3.exceptions.MaxRetryError: HTTPSConnectionPool(host='api.co2signal.com', port=443): Max retries exceeded with url: /v1/latest?lon=-6.421350538730621&lat=54.420568623488926 (Caused by NewConnectionError('<urllib3.connection.HTTPSConnection object at 0x7f633b8ca0>: Failed to establish a new connection: [Errno -3] Try again'))
During handling of the above exception, another exception occurred:
Traceback (most recent call last):
  File "/usr/src/homeassistant/homeassistant/components/co2signal/__init__.py", line 119, in get_data
    data = CO2Signal.get_latest(
  File "/usr/local/lib/python3.9/site-packages/CO2Signal/co2signal.py", line 34, in get_latest
    latest_data = (requests
  File "/usr/local/lib/python3.9/site-packages/requests/api.py", line 75, in get
    return request('get', url, params=params, **kwargs)
  File "/usr/local/lib/python3.9/site-packages/requests/api.py", line 61, in request
    return session.request(method=method, url=url, **kwargs)
  File "/usr/local/lib/python3.9/site-packages/requests/sessions.py", line 542, in request
    resp = self.send(prep, **send_kwargs)
  File "/usr/local/lib/python3.9/site-packages/requests/sessions.py", line 655, in send
    r = adapter.send(request, **kwargs)
  File "/usr/local/lib/python3.9/site-packages/requests/adapters.py", line 516, in send
    raise ConnectionError(e, request=request)
requests.exceptions.ConnectionError: HTTPSConnectionPool(host='api.co2signal.com', port=443): Max retries exceeded with url: /v1/latest?lon=-6.421350538730621&lat=54.420568623488926 (Caused by NewConnectionError('<urllib3.connection.HTTPSConnection object at 0x7f633b8ca0>: Failed to establish a new connection: [Errno -3] Try again'))
2021-12-04 10:31:05 ERROR (MainThread) [homeassistant.components.co2signal] Error fetching co2signal data: 
[s6-init] making user provided files available at /var/run/s6/etc...exited 0.
[s6-init] ensuring user provided files have correct perms...exited 0.
[fix-attrs.d] applying ownership & permissions fixes...
[fix-attrs.d] done.
[cont-init.d] executing container initialization scripts...
[cont-init.d] done.
[services.d] starting services
[services.d] done.
2021-12-09 13:21:48 WARNING (SyncWorker_1) [homeassistant.loader] We found a custom integration hacs which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant
2021-12-09 13:21:48 WARNING (SyncWorker_2) [homeassistant.loader] We found a custom integration google_keep which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant
2021-12-09 13:21:48 WARNING (SyncWorker_0) [homeassistant.loader] We found a custom integration alexa_media which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant
2021-12-09 13:21:49 WARNING (Recorder) [homeassistant.components.recorder.util] The system could not validate that the sqlite3 database at //config/home-assistant_v2.db was shutdown cleanly
2021-12-09 13:21:49 WARNING (Recorder) [homeassistant.components.recorder.util] Ended unfinished session (id=193 from 2021-12-07 14:33:42.564818)
2021-12-09 13:21:52 WARNING (MainThread) [homeassistant.components.webhook] Received message for unregistered webhook 508e90729b07cbaf840007dd1684567b62424b2db68437a7a8d860fc600e0c64 from 10.0.10.1
2021-12-09 13:21:52 WARNING (MainThread) [homeassistant.components.webhook] Received message for unregistered webhook 508e90729b07cbaf840007dd1684567b62424b2db68437a7a8d860fc600e0c64 from 10.0.10.1
2021-12-09 13:21:52 WARNING (MainThread) [homeassistant.components.webhook] Received message for unregistered webhook 508e90729b07cbaf840007dd1684567b62424b2db68437a7a8d860fc600e0c64 from 10.0.10.1
2021-12-09 13:22:23 WARNING (MainThread) [alexapy.alexawebsocket] mac_dms not detected; websocket likely won't connect
2021-12-09 13:22:40 WARNING (MainThread) [aioesphomeapi.reconnect_logic] Can't connect to ESPHome API for 10.0.30.107 @ 10.0.30.107: Error connecting to ('10.0.30.107', 6053): [Errno 113] Connect call failed ('10.0.30.107', 6053)
2021-12-09 13:22:45 WARNING (MainThread) [homeassistant.components.calendar] Setup of calendar platform google is taking over 10 seconds.
2021-12-09 13:22:49 WARNING (MainThread) [homeassistant.config_entries] Config entry 'christmas-tree' for wled integration not ready yet: Invalid response from API: Error occurred while communicating with WLED device at 10.0.30.21; Retrying in background
2021-12-09 13:22:51 WARNING (MainThread) [homeassistant.config_entries] Config entry 'Picture Frame - Right' for wled integration not ready yet: Invalid response from API: Timeout occurred while connecting to WLED device at 10.0.30.115; Retrying in background
2021-12-09 13:22:52 WARNING (MainThread) [homeassistant.bootstrap] Waiting on integrations to complete setup: wled
2021-12-09 13:22:57 WARNING (MainThread) [homeassistant.config_entries] Config entry 'Picture Frame - Left' for wled integration not ready yet: Invalid response from API: Error occurred while communicating with WLED device at 10.0.30.188; Retrying in background

Host

[    0.000000] Booting Linux on physical CPU 0x0000000000 [0x410fd083]
[    0.000000] Linux version 5.10.17-v8 (builder@35cad91a4189) (aarch64-buildroot-linux-gnu-gcc.br_real (Buildroot -gb91d6fc7) 9.4.0, GNU ld (GNU Binutils) 2.35.2) #1 SMP PREEMPT Tue Oct 26 21:49:24 UTC 2021
[    0.000000] Machine model: Raspberry Pi 4 Model B Rev 1.2
[    0.000000] efi: UEFI not found.
[    0.000000] Reserved memory: created CMA memory pool at 0x000000002ac00000, size 64 MiB
[    0.000000] OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool
[    0.000000] Zone ranges:
[    0.000000]   DMA      [mem 0x0000000000000000-0x000000003fffffff]
[    0.000000]   DMA32    [mem 0x0000000040000000-0x00000000fbffffff]
[    0.000000]   Normal   empty
[    0.000000] Movable zone start for each node
[    0.000000] Early memory node ranges
[    0.000000]   node   0: [mem 0x0000000000000000-0x000000003b2fffff]
[    0.000000]   node   0: [mem 0x0000000040000000-0x00000000fbffffff]
[    0.000000] Zeroed struct page in unavailable ranges: 256 pages
[    0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x00000000fbffffff]
[    0.000000] On node 0 totalpages: 1012480
[    0.000000]   DMA zone: 3788 pages used for memmap
[    0.000000]   DMA zone: 0 pages reserved
[    0.000000]   DMA zone: 242432 pages, LIFO batch:63
[    0.000000]   DMA32 zone: 12032 pages used for memmap
[    0.000000]   DMA32 zone: 770048 pages, LIFO batch:63
[    0.000000] percpu: Embedded 32 pages/cpu s91352 r8192 d31528 u131072
[    0.000000] pcpu-alloc: s91352 r8192 d31528 u131072 alloc=32*4096
[    0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 
[    0.000000] Detected PIPT I-cache on CPU0
[    0.000000] CPU features: detected: Spectre-v2
[    0.000000] CPU features: detected: Spectre-v4
[    0.000000] CPU features: detected: ARM errata 1165522, 1319367, or 1530923
[    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 996660
[    0.000000] Kernel command line: zram.enabled=1 zram.num_devices=3 apparmor=1 security=apparmor rootwait systemd.machine_id=e84712fd0e2e439c8d86ff808b4e8be0 cgroup_enable=memory fsck.repair=yes coherent_pool=1M 8250.nr_uarts=1 snd_bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=0 bcm2708_fb.fbheight=0 bcm2708_fb.fbswap=1 smsc95xx.macaddr=DC:A6:32:A8:DE:BB vc_mem.mem_base=0x3eb00000 vc_mem.mem_size=0x3ff00000  dwc_otg.lpm_enable=0 console=tty1 root=PARTUUID=8d3d53e3-6d49-4c38-8349-aff6859e82fd rootfstype=squashfs ro rauc.slot=A
[    0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)
[    0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
[    0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off
[    0.000000] software IO TLB: mapped [mem 0x0000000037300000-0x000000003b300000] (64MB)
[    0.000000] Memory: 3814556K/4049920K available (12096K kernel code, 1962K rwdata, 4160K rodata, 3840K init, 1261K bss, 169828K reserved, 65536K cma-reserved)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[    0.000000] ftrace: allocating 39239 entries in 154 pages
[    0.000000] ftrace: allocated 154 pages with 4 groups
[    0.000000] rcu: Preemptible hierarchical RCU implementation.
[    0.000000] rcu: 	RCU event tracing is enabled.
[    0.000000] rcu: 	RCU restricting CPUs from NR_CPUS=256 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] GIC: Using split EOI/Deactivate mode
[    0.000000] random: get_random_bytes called from start_kernel+0x3b8/0x57c with crng_init=0
[    0.000000] arch_timer: cp15 timer(s) running at 54.00MHz (phys).
[    0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0xc743ce346, max_idle_ns: 440795203123 ns
[    0.000014] sched_clock: 56 bits at 54MHz, resolution 18ns, wraps every 4398046511102ns
[    0.000576] Console: colour dummy device 80x25
[    0.001912] printk: console [tty1] enabled
[    0.002050] Calibrating delay loop (skipped), value calculated using timer frequency.. 108.00 BogoMIPS (lpj=216000)
[    0.002147] pid_max: default: 32768 minimum: 301
[    0.002485] LSM: Security Framework initializing
[    0.002745] AppArmor: AppArmor initialized
[    0.003211] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
[    0.003362] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
[    0.010432] rcu: Hierarchical SRCU implementation.
[    0.012883] EFI services will not be available.
[    0.014125] smp: Bringing up secondary CPUs ...
[    0.016556] Detected PIPT I-cache on CPU1
[    0.016703] CPU1: Booted secondary processor 0x0000000001 [0x410fd083]
[    0.019256] Detected PIPT I-cache on CPU2
[    0.019370] CPU2: Booted secondary processor 0x0000000002 [0x410fd083]
[    0.021971] Detected PIPT I-cache on CPU3
[    0.022081] CPU3: Booted secondary processor 0x0000000003 [0x410fd083]
[    0.022440] smp: Brought up 1 node, 4 CPUs
[    0.022648] SMP: Total of 4 processors activated.
[    0.022706] CPU features: detected: 32-bit EL0 Support
[    0.022760] CPU features: detected: CRC32 instructions
[    0.022817] CPU features: detected: 32-bit EL1 Support
[    0.111196] CPU: All CPU(s) started at EL2
[    0.111375] alternatives: patching kernel code
[    0.114532] devtmpfs: initialized
[    0.139520] Enabled cp15_barrier support
[    0.139653] Enabled setend support
[    0.140105] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[    0.140210] futex hash table entries: 1024 (order: 4, 65536 bytes, linear)
[    0.144816] pinctrl core: initialized pinctrl subsystem
[    0.146518] DMI not present or invalid.
[    0.147423] NET: Registered protocol family 16
[    0.155122] DMA: preallocated 1024 KiB GFP_KERNEL pool for atomic allocations
[    0.155779] DMA: preallocated 1024 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
[    0.158053] DMA: preallocated 1024 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
[    0.158243] audit: initializing netlink subsys (disabled)
[    0.159058] audit: type=2000 audit(0.156:1): state=initialized audit_enabled=0 res=1
[    0.160136] thermal_sys: Registered thermal governor 'step_wise'
[    0.161318] cpuidle: using governor menu
[    0.162521] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
[    0.162961] ASID allocator initialised with 65536 entries
[    0.163290] Serial: AMBA PL011 UART driver
[    0.227945] bcm2835-mbox fe00b880.mailbox: mailbox enabled
[    0.238150] raspberrypi-firmware soc:firmware: Attached to firmware from 2021-05-27T14:02:15, variant start
[    0.242105] raspberrypi-firmware soc:firmware: Firmware hash is 7d9a298cda813f747b51fe17e1e417e7bf5ca94d
[    0.318337] bcm2835-dma fe007000.dma: DMA legacy API manager, dmachans=0x1
[    0.327326] vgaarb: loaded
[    0.328267] SCSI subsystem initialized
[    0.328783] usbcore: registered new interface driver usbfs
[    0.328942] usbcore: registered new interface driver hub
[    0.329121] usbcore: registered new device driver usb
[    0.329870] usb_phy_generic phy: supply vcc not found, using dummy regulator
[    0.330849] mc: Linux media interface: v0.10
[    0.334377] clocksource: Switched to clocksource arch_sys_counter
[    2.780148] VFS: Disk quotas dquot_6.6.0
[    2.780414] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[    2.780828] FS-Cache: Loaded
[    2.781348] CacheFiles: Loaded
[    2.783190] AppArmor: AppArmor Filesystem Enabled
[    2.808245] NET: Registered protocol family 2
[    2.810281] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)
[    2.810499] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)
[    2.811198] TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear)
[    2.811804] TCP: Hash tables configured (established 32768 bind 32768)
[    2.812287] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear)
[    2.812457] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear)
[    2.813197] NET: Registered protocol family 1
[    2.815223] RPC: Registered named UNIX socket transport module.
[    2.815288] RPC: Registered udp transport module.
[    2.815338] RPC: Registered tcp transport module.
[    2.815386] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    2.815458] PCI: CLS 0 bytes, default 64
[    2.821058] hw perfevents: enabled with armv8_cortex_a72 PMU driver, 7 counters available
[    2.821733] kvm [1]: IPA Size Limit: 44 bits
[    2.824537] kvm [1]: vgic interrupt IRQ9
[    2.825168] kvm [1]: Hyp mode initialized successfully
[    2.830055] Initialise system trusted keyrings
[    2.830838] workingset: timestamp_bits=46 max_order=20 bucket_order=0
[    2.845612] zbud: loaded
[    2.849705] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[    2.850314] FS-Cache: Netfs 'nfs' registered for caching
[    2.851834] NFS: Registering the id_resolver key type
[    2.851943] Key type id_resolver registered
[    2.851997] Key type id_legacy registered
[    2.852300] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
[    2.855097] Key type asymmetric registered
[    2.855162] Asymmetric key parser 'x509' registered
[    2.855294] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)
[    2.855894] io scheduler mq-deadline registered
[    2.855956] io scheduler kyber registered
[    2.865017] brcm-pcie fd500000.pcie: host bridge /scb/pcie@7d500000 ranges:
[    2.865123] brcm-pcie fd500000.pcie:   No bus range found for /scb/pcie@7d500000, using [bus 00-ff]
[    2.865328] brcm-pcie fd500000.pcie:      MEM 0x0600000000..0x063fffffff -> 0x00c0000000
[    2.865588] brcm-pcie fd500000.pcie:   IB MEM 0x0000000000..0x00bfffffff -> 0x0400000000
[    2.916554] brcm-pcie fd500000.pcie: link up, 5.0 GT/s PCIe x1 (SSC)
[    2.917420] brcm-pcie fd500000.pcie: PCI host bridge to bus 0000:00
[    2.917497] pci_bus 0000:00: root bus resource [bus 00-ff]
[    2.917566] pci_bus 0000:00: root bus resource [mem 0x600000000-0x63fffffff] (bus address [0xc0000000-0xffffffff])
[    2.917794] pci 0000:00:00.0: [14e4:2711] type 01 class 0x060400
[    2.918534] pci 0000:00:00.0: PME# supported from D0 D3hot
[    2.928300] pci 0000:01:00.0: [1106:3483] type 00 class 0x0c0330
[    2.928526] pci 0000:01:00.0: reg 0x10: [mem 0x00000000-0x00000fff 64bit]
[    2.929248] pci 0000:01:00.0: PME# supported from D0 D3cold
[    2.946828] pci 0000:00:00.0: BAR 8: assigned [mem 0x600000000-0x6000fffff]
[    2.946921] pci 0000:01:00.0: BAR 0: assigned [mem 0x600000000-0x600000fff 64bit]
[    2.947039] pci 0000:00:00.0: PCI bridge to [bus 01]
[    2.947119] pci 0000:00:00.0:   bridge window [mem 0x600000000-0x6000fffff]
[    2.948624] bcm2708_fb soc:fb: Unable to determine number of FBs. Disabling driver.
[    2.948736] bcm2708_fb: probe of soc:fb failed with error -2
[    2.959912] Serial: 8250/16550 driver, 1 ports, IRQ sharing enabled
[    2.966206] iproc-rng200 fe104000.rng: hwrng registered
[    2.967194] vc-mem: phys_addr:0x00000000 mem_base=0x3eb00000 mem_size:0x3ff00000(1023 MiB)
[    2.969165] gpiomem-bcm2835 fe200000.gpiomem: Initialised: Registers at 0xfe200000
[    2.970129] cacheinfo: Unable to detect cache hierarchy for CPU 0
[    2.995717] brd: module loaded
[    3.022637] loop: module loaded
[    3.023991] zram: Added device: zram0
[    3.025225] zram: Added device: zram1
[    3.026495] zram: Added device: zram2
[    3.029847] Loading iSCSI transport class v2.0-870.
[    3.036789] libphy: Fixed MDIO Bus: probed
[    3.039055] tun: Universal TUN/TAP device driver, 1.6
[    3.040912] bcmgenet fd580000.ethernet: GENET 5.0 EPHY: 0x0000
[    3.043427] libphy: bcmgenet MII bus: probed
[    3.090781] unimac-mdio unimac-mdio.-19: Broadcom UniMAC MDIO bus
[    3.093152] usbcore: registered new interface driver r8152
[    3.093334] usbcore: registered new interface driver lan78xx
[    3.095725] pci 0000:00:00.0: enabling device (0000 -> 0002)
[    3.095839] xhci_hcd 0000:01:00.0: enabling device (0000 -> 0002)
[    3.096085] xhci_hcd 0000:01:00.0: xHCI Host Controller
[    3.096186] xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 1
[    3.097704] xhci_hcd 0000:01:00.0: hcc params 0x002841eb hci version 0x100 quirks 0x0000030000000890
[    3.100192] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.10
[    3.100276] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    3.100343] usb usb1: Product: xHCI Host Controller
[    3.100400] usb usb1: Manufacturer: Linux 5.10.17-v8 xhci-hcd
[    3.100458] usb usb1: SerialNumber: 0000:01:00.0
[    3.102039] hub 1-0:1.0: USB hub found
[    3.102256] hub 1-0:1.0: 1 port detected
[    3.103743] xhci_hcd 0000:01:00.0: xHCI Host Controller
[    3.103846] xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 2
[    3.103936] xhci_hcd 0000:01:00.0: Host supports USB 3.0 SuperSpeed
[    3.104913] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 5.10
[    3.104990] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    3.105056] usb usb2: Product: xHCI Host Controller
[    3.105111] usb usb2: Manufacturer: Linux 5.10.17-v8 xhci-hcd
[    3.105167] usb usb2: SerialNumber: 0000:01:00.0
[    3.106865] hub 2-0:1.0: USB hub found
[    3.107053] hub 2-0:1.0: 4 ports detected
[    3.110589] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
[    3.111218] dwc_otg: FIQ enabled
[    3.111246] dwc_otg: NAK holdoff enabled
[    3.111270] dwc_otg: FIQ split-transaction FSM enabled
[    3.111302] Module dwc_common_port init
[    3.112463] usbcore: registered new interface driver uas
[    3.112739] usbcore: registered new interface driver usb-storage
[    3.113027] usbcore: registered new interface driver usbserial_generic
[    3.113137] usbserial: USB Serial support registered for generic
[    3.113651] mousedev: PS/2 mouse device common for all mice
[    3.118008] bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer
[    3.132133] cpufreq: cpufreq_online: CPU0: Running at unlisted initial frequency: 250000 KHz, changing to: 300000 KHz
[    3.133882] sdhci: Secure Digital Host Controller Interface driver
[    3.133934] sdhci: Copyright(c) Pierre Ossman
[    3.135262] sdhci-pltfm: SDHCI platform and OF driver helper
[    3.141608] ledtrig-cpu: registered to indicate activity on CPUs
[    3.141730] hid: raw HID events driver (C) Jiri Kosina
[    3.141836] usbcore: registered new interface driver usbhid
[    3.141846] usbhid: USB HID core driver
[    3.146152] IPVS: Registered protocols (TCP, UDP, SCTP, AH, ESP)
[    3.146195] IPVS: Connection hash table configured (size=4096, memory=64Kbytes)
[    3.146301] IPVS: ipvs loaded.
[    3.146340] IPVS: [rr] scheduler registered.
[    3.147325] NET: Registered protocol family 10
[    3.148520] Segment Routing with IPv6
[    3.148631] NET: Registered protocol family 17
[    3.148708] Bridge firewalling registered
[    3.148807] Key type dns_resolver registered
[    3.149397] registered taskstats version 1
[    3.149425] Loading compiled-in X.509 certificates
[    3.149812] Key type ._fscrypt registered
[    3.149831] Key type .fscrypt registered
[    3.149847] Key type fscrypt-provisioning registered
[    3.149931] AppArmor: AppArmor sha1 policy hashing enabled
[    3.158464] uart-pl011 fe201000.serial: there is not valid maps for state default
[    3.158692] uart-pl011 fe201000.serial: cts_event_workaround enabled
[    3.158791] fe201000.serial: ttyAMA0 at MMIO 0xfe201000 (irq = 21, base_baud = 0) is a PL011 rev2
[    3.166520] bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver
[    3.171270] printk: console [netcon0] enabled
[    3.171288] netconsole: network logging started
[    3.171455] of_cfs_init
[    3.171537] of_cfs_init: OK
[    3.203971] mmc0: SDHCI controller on fe340000.emmc2 [fe340000.emmc2] using ADMA
[    3.205859] Waiting for root device PARTUUID=8d3d53e3-6d49-4c38-8349-aff6859e82fd...
[    3.442440] usb 1-1: new high-speed USB device number 2 using xhci_hcd
[    3.593085] usb 1-1: New USB device found, idVendor=2109, idProduct=3431, bcdDevice= 4.21
[    3.593156] usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0
[    3.593209] usb 1-1: Product: USB2.0 Hub
[    3.596303] hub 1-1:1.0: USB hub found
[    3.596707] hub 1-1:1.0: 4 ports detected
[    3.718721] usb 2-1: new SuperSpeed Gen 1 USB device number 2 using xhci_hcd
[    3.741119] usb 2-1: New USB device found, idVendor=13fd, idProduct=3960, bcdDevice= 1.10
[    3.741188] usb 2-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[    3.741241] usb 2-1: Product: External
[    3.741287] usb 2-1: Manufacturer: Generic 
[    3.741333] usb 2-1: SerialNumber: 5953323031393230303134342020202020202020
[    3.745455] usb-storage 2-1:1.0: USB Mass Storage device detected
[    3.747021] scsi host0: usb-storage 2-1:1.0
[    3.782432] random: fast init done
[    4.775826] scsi 0:0:0:0: Direct-Access     Generic  External         0110 PQ: 0 ANSI: 6
[    4.777595] sd 0:0:0:0: [sda] 250069679 512-byte logical blocks: (128 GB/119 GiB)
[    4.778780] sd 0:0:0:0: [sda] Write Protect is off
[    4.778842] sd 0:0:0:0: [sda] Mode Sense: 1f 00 10 08
[    4.779828] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, supports DPO and FUA
[    4.824717]  sda: sda1 sda2 sda3 sda4 sda5 sda6 sda7 sda8
[    4.829304] sd 0:0:0:0: [sda] Attached SCSI disk
[    4.840405] VFS: Mounted root (squashfs filesystem) readonly on device 8:3.
[    4.842862] devtmpfs: mounted
[    4.851408] Freeing unused kernel memory: 3840K
[    4.870461] Run /sbin/init as init process
[    4.870499]   with arguments:
[    4.870515]     /sbin/init
[    4.870531]   with environment:
[    4.870546]     HOME=/
[    4.870561]     TERM=linux
[    5.039606] systemd[1]: System time before build time, advancing clock.
[    5.092494] systemd[1]: systemd 247 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=hybrid)
[    5.093138] systemd[1]: Detected architecture arm64.
[    5.139849] systemd[1]: Set hostname to <homeassistant>.
[    5.140074] systemd[1]: Installed transient /etc/machine-id file.
[    5.558872] systemd[1]: Queued start job for default target Multi-User System.
[    5.559918] random: systemd: uninitialized urandom read (16 bytes read)
[    5.586859] systemd[1]: Created slice Slice /system/ha-cli.
[    5.587252] random: systemd: uninitialized urandom read (16 bytes read)
[    5.588845] systemd[1]: Created slice Slice /system/modprobe.
[    5.589066] random: systemd: uninitialized urandom read (16 bytes read)
[    5.590764] systemd[1]: Created slice Slice /system/systemd-fsck.
[    5.592750] systemd[1]: Created slice Slice /system/systemd-growfs.
[    5.594438] systemd[1]: Created slice User and Session Slice.
[    5.594865] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
[    5.595188] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
[    5.595496] systemd[1]: Reached target Local Encrypted Volumes.
[    5.595694] systemd[1]: Reached target HassOS zram targets.
[    5.595906] systemd[1]: Reached target Paths.
[    5.596085] systemd[1]: Reached target Remote Encrypted Volumes.
[    5.596247] systemd[1]: Reached target Remote File Systems.
[    5.596417] systemd[1]: Reached target Slices.
[    5.598268] systemd[1]: Listening on D-Bus System Message Bus Socket.
[    5.601635] systemd[1]: Listening on Process Core Dump Socket.
[    5.603456] systemd[1]: Listening on Journal Audit Socket.
[    5.603976] systemd[1]: Listening on Journal Socket (/dev/log).
[    5.604482] systemd[1]: Listening on Journal Socket.
[    5.606754] systemd[1]: Listening on udev Control Socket.
[    5.607346] systemd[1]: Listening on udev Kernel Socket.
[    5.607960] systemd[1]: Condition check resulted in Huge Pages File System being skipped.
[    5.611718] systemd[1]: Mounting POSIX Message Queue File System...
[    5.617158] systemd[1]: Mounting Kernel Debug File System...
[    5.622551] systemd[1]: Mounting Kernel Trace File System...
[    5.627323] systemd[1]: Started D-Bus System Message Bus.
[    5.637433] systemd[1]: Starting Home Assistant OS Agent...
[    5.653356] systemd[1]: Starting Create list of static device nodes for the current kernel...
[    5.657942] systemd[1]: Starting Load Kernel Module configfs...
[    5.662512] systemd[1]: Starting Load Kernel Module drm...
[    5.666964] systemd[1]: Starting Load Kernel Module fuse...
[    5.673616] systemd[1]: Starting Journal Service...
[    5.677574] systemd[1]: Starting Remount Root and Kernel File Systems...
[    5.681838] systemd[1]: Starting Wait Until Kernel Time Synchronized...
[    5.685937] systemd[1]: Starting Coldplug All udev Devices...
[    5.690091] systemd[1]: Starting Disk Manager...
[    5.694895] systemd[1]: Starting HassOS ZRAM swap...
[    5.699711] systemd[1]: Starting HassOS ZRAM tmp...
[    5.707447] systemd[1]: Starting HassOS ZRAM var...
[    5.714810] systemd[1]: Mounted POSIX Message Queue File System.
[    5.715420] systemd[1]: Mounted Kernel Debug File System.
[    5.715852] systemd[1]: Mounted Kernel Trace File System.
[    5.718394] systemd[1]: Finished Create list of static device nodes for the current kernel.
[    5.719473] systemd[1]: [email protected]: Succeeded.
[    5.720933] systemd[1]: Finished Load Kernel Module configfs.
[    5.723680] systemd[1]: Finished Remount Root and Kernel File Systems.
[    5.728120] systemd[1]: Mounting Kernel Configuration File System...
[    5.732124] systemd[1]: Starting Create Static Device Nodes in /dev...
[    5.741016] systemd[1]: Mounted Kernel Configuration File System.
[    5.768075] fuse: init (API version 7.32)
[    5.770937] systemd[1]: [email protected]: Succeeded.
[    5.773060] systemd[1]: Finished Load Kernel Module fuse.
[    5.778533] systemd[1]: Mounting FUSE Control File System...
[    5.789779] systemd[1]: Mounted FUSE Control File System.
[    5.836421] systemd[1]: Started Journal Service.
[    5.897157] zram1: detected capacity change from 0 to 33554432
[    5.897226] zram2: detected capacity change from 0 to 16777216
[    5.901375] zram0: detected capacity change from 0 to 994287616
[    6.006165] audit: type=1334 audit(1628260987.959:2): prog-id=5 op=LOAD
[    6.006245] audit: type=1334 audit(1628260987.959:3): prog-id=6 op=LOAD
[    6.354618] rpivid-mem feb00000.hevc-decoder: rpivid-hevcmem initialised: Registers at 0xfeb00000 length 0x00010000
[    6.354884] rpivid-mem feb10000.rpivid-local-intc: rpivid-intcmem initialised: Registers at 0xfeb10000 length 0x00001000
[    6.355095] rpivid-mem feb20000.h264-decoder: rpivid-h264mem initialised: Registers at 0xfeb20000 length 0x00010000
[    6.355297] rpivid-mem feb30000.vp9-decoder: rpivid-vp9mem initialised: Registers at 0xfeb30000 length 0x00010000
[    6.419839] vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned.
[    6.424913] bcm2835_vc_sm_cma_probe: Videocore shared memory driver
[    6.424960] [vc_sm_connected_init]: start
[    6.428407] [vc_sm_connected_init]: installed successfully
[    6.462292] snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned.
[    6.463258] videodev: Linux video capture interface: v2.00
[    6.464565] bcm2835_audio bcm2835_audio: card created with 8 channels
[    6.475486] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
[    6.475489] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
[    6.477649] bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned.
[    6.479057] bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned.
[    6.480707] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
[    6.481232] bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned.
[    6.487840] bcm2835-codec bcm2835-codec: Device registered as /dev/video10
[    6.487887] bcm2835-codec bcm2835-codec: Loaded V4L2 decode
[    6.488229] bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13
[    6.501556] bcm2835-codec bcm2835-codec: Device registered as /dev/video11
[    6.501596] bcm2835-codec bcm2835-codec: Loaded V4L2 encode
[    6.501925] bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14
[    6.502413] bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15
[    6.503563] bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16
[    6.503588] bcm2835-isp bcm2835-isp: Register output node 0 with media controller
[    6.503604] bcm2835-isp bcm2835-isp: Register capture node 1 with media controller
[    6.503617] bcm2835-isp bcm2835-isp: Register capture node 2 with media controller
[    6.503630] bcm2835-isp bcm2835-isp: Register capture node 3 with media controller
[    6.503763] bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp
[    6.504119] bcm2835-codec bcm2835-codec: Device registered as /dev/video12
[    6.504146] bcm2835-codec bcm2835-codec: Loaded V4L2 isp
[    6.753783] FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
[    6.970611] EXT4-fs (sda7): mounted filesystem with ordered data mode. Opts: (null)
[    6.970655] ext4 filesystem being mounted at /mnt/overlay supports timestamps until 2038 (0x7fffffff)
[    6.986504] Adding 970980k swap on /dev/zram0.  Priority:-2 extents:1 across:970980k SSFS
[    7.800864] EXT4-fs (sda8): mounted filesystem with ordered data mode. Opts: (null)
[    7.847163] EXT4-fs (sda8): resizing filesystem from 31080273 to 31080273 blocks
[    7.848189] random: crng init done
[    7.848202] random: 7 urandom warning(s) missed due to ratelimiting
[    7.956577] EXT4-fs (zram2): mounted filesystem without journal. Opts: nobarrier
[    7.956612] ext4 filesystem being mounted at /tmp supports timestamps until 2038 (0x7fffffff)
[    7.964246] EXT4-fs (zram1): mounted filesystem without journal. Opts: nobarrier
[    7.964276] ext4 filesystem being mounted at /var supports timestamps until 2038 (0x7fffffff)
[    8.093205] systemd-journald[115]: Received client request to flush runtime journal.
[    8.108271] systemd-journald[115]: File /var/log/journal/e84712fd0e2e439c8d86ff808b4e8be0/system.journal corrupted or uncleanly shut down, renaming and replacing.
[   12.221938] audit: type=1334 audit(1639031138.075:4): prog-id=7 op=LOAD
[   12.222239] audit: type=1334 audit(1639031138.075:5): prog-id=8 op=LOAD
[   13.701468] audit: type=1400 audit(1639031139.539:6): apparmor="STATUS" operation="profile_load" profile="unconfined" name="hassio-supervisor" pid=361 comm="apparmor_parser"
[   13.701500] audit: type=1400 audit(1639031139.539:6): apparmor="STATUS" operation="profile_load" profile="unconfined" name="hassio-supervisor///usr/bin/gdbus" pid=361 comm="apparmor_parser"
[   13.701522] audit: type=1400 audit(1639031139.539:6): apparmor="STATUS" operation="profile_load" profile="unconfined" name="hassio-supervisor///usr/bin/git" pid=361 comm="apparmor_parser"
[   14.717635] audit: type=1334 audit(1639031140.571:7): prog-id=9 op=LOAD
[   14.717717] audit: type=1334 audit(1639031140.571:8): prog-id=10 op=LOAD
[   14.936535] cfg80211: Loading compiled-in X.509 certificates for regulatory database
[   15.006849] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
[   15.074167] bcmgenet fd580000.ethernet: configuring instance for external RGMII (RX delay)
[   15.074465] bcmgenet fd580000.ethernet eth0: Link is Down
[   19.174467] bcmgenet fd580000.ethernet eth0: Link is Up - 1Gbps/Full - flow control off
[   19.174499] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[   22.856735] audit: type=1400 audit(1639031148.711:9): apparmor="STATUS" operation="profile_load" profile="unconfined" name="docker-default" pid=433 comm="apparmor_parser"
[   33.766379] vcc-sd: disabling
[   41.814743] audit: type=1325 audit(1639031167.643:10): table=nat family=2 entries=5 op=xt_replace pid=468 subj==unconfined comm="iptables"
[   41.846499] audit: type=1325 audit(1639031167.683:11): table=filter family=2 entries=4 op=xt_replace pid=470 subj==unconfined comm="iptables"
[   41.886660] audit: type=1325 audit(1639031167.715:12): table=filter family=2 entries=6 op=xt_replace pid=472 subj==unconfined comm="iptables"
[   41.934942] audit: type=1325 audit(1639031167.759:13): table=filter family=2 entries=8 op=xt_replace pid=474 subj==unconfined comm="iptables"
[   41.978580] audit: type=1325 audit(1639031167.807:14): table=filter family=2 entries=10 op=xt_replace pid=476 subj==unconfined comm="iptables"
[   42.018705] audit: type=1325 audit(1639031167.851:15): table=filter family=2 entries=11 op=xt_replace pid=478 subj==unconfined comm="iptables"
[   42.046459] audit: type=1325 audit(1639031167.887:16): table=filter family=2 entries=12 op=xt_replace pid=479 subj==unconfined comm="iptables"
[   42.068570] Initializing XFRM netlink socket
[   42.138481] audit: type=1325 audit(1639031167.971:17): table=nat family=2 entries=7 op=xt_replace pid=487 subj==unconfined comm="iptables"
[   42.170493] audit: type=1325 audit(1639031168.011:18): table=nat family=2 entries=8 op=xt_replace pid=489 subj==unconfined comm="iptables"
[   42.214639] audit: type=1325 audit(1639031168.047:19): table=filter family=2 entries=12 op=xt_replace pid=492 subj==unconfined comm="iptables"
[   47.003565] kauditd_printk_skb: 56 callbacks suppressed
[   47.003587] audit: type=1325 audit(1639056051.230:76): table=nat family=2 entries=17 op=xt_replace pid=849 subj==unconfined comm="iptables"
[   47.038636] audit: type=1325 audit(1639056051.270:77): table=filter family=2 entries=27 op=xt_replace pid=851 subj==unconfined comm="iptables"
[   47.082831] audit: type=1325 audit(1639056051.310:78): table=nat family=2 entries=16 op=xt_replace pid=853 subj==unconfined comm="iptables"
[   47.670666] audit: type=1325 audit(1639056051.882:79): table=nat family=2 entries=15 op=xt_replace pid=887 subj==unconfined comm="iptables"
[   47.722761] audit: type=1325 audit(1639056051.938:80): table=filter family=2 entries=26 op=xt_replace pid=889 subj==unconfined comm="iptables"
[   47.770732] audit: type=1325 audit(1639056051.994:81): table=nat family=2 entries=14 op=xt_replace pid=891 subj==unconfined comm="iptables"
[   48.882471] audit: type=1325 audit(1639056053.110:82): table=nat family=2 entries=13 op=xt_replace pid=954 subj==unconfined comm="iptables"
[   48.922726] audit: type=1325 audit(1639056053.150:83): table=nat family=2 entries=12 op=xt_replace pid=956 subj==unconfined comm="iptables"
[   48.958683] audit: type=1325 audit(1639056053.190:84): table=filter family=2 entries=25 op=xt_replace pid=958 subj==unconfined comm="iptables"
[   48.998498] audit: type=1325 audit(1639056053.226:85): table=filter family=2 entries=24 op=xt_replace pid=960 subj==unconfined comm="iptables"
[   49.867214] hassio: port 1(vethee28b60) entered blocking state
[   49.867229] hassio: port 1(vethee28b60) entered disabled state
[   49.867858] device vethee28b60 entered promiscuous mode
[   50.471738] cgroup: cgroup: disabling cgroup2 socket matching due to net_prio or net_cls activation

Host

[   51.276419] eth0: renamed from veth44de876
[   51.295262] IPv6: ADDRCONF(NETDEV_CHANGE): vethee28b60: link becomes ready
[   51.295360] hassio: port 1(vethee28b60) entered blocking state
[   51.295366] hassio: port 1(vethee28b60) entered forwarding state
[   51.295472] IPv6: ADDRCONF(NETDEV_CHANGE): hassio: link becomes ready
[   53.324770] docker0: port 1(veth02158a0) entered blocking state
[   53.324785] docker0: port 1(veth02158a0) entered disabled state
[   53.324963] device veth02158a0 entered promiscuous mode
[   53.325041] kauditd_printk_skb: 31 callbacks suppressed
[   53.325046] audit: type=1700 audit(1639056057.574:117): dev=veth02158a0 prom=256 old_prom=0 auid=4294967295 uid=0 gid=0 ses=4294967295
[   53.365622] hassio: port 2(veth2a46b17) entered blocking state
[   53.365637] hassio: port 2(veth2a46b17) entered disabled state
[   53.365847] device veth2a46b17 entered promiscuous mode
[   53.365913] audit: type=1700 audit(1639056057.614:118): dev=veth2a46b17 prom=256 old_prom=0 auid=4294967295 uid=0 gid=0 ses=4294967295
[   53.366144] hassio: port 2(veth2a46b17) entered blocking state
[   53.366155] hassio: port 2(veth2a46b17) entered forwarding state
[   53.885213] eth0: renamed from veth447ccae
[   53.899468] hassio: port 2(veth2a46b17) entered disabled state
[   53.899600] IPv6: ADDRCONF(NETDEV_CHANGE): veth02158a0: link becomes ready
[   53.899720] docker0: port 1(veth02158a0) entered blocking state
[   53.899727] docker0: port 1(veth02158a0) entered forwarding state
[   53.899860] IPv6: ADDRCONF(NETDEV_CHANGE): docker0: link becomes ready
[   54.058760] audit: type=1325 audit(1639056058.282:119): table=nat family=2 entries=0 op=xt_register pid=1438 subj==unconfined comm="iptables"
[   54.102647] audit: type=1325 audit(1639056058.330:120): table=filter family=2 entries=0 op=xt_register pid=1439 subj==unconfined comm="iptables"
[   54.146502] audit: type=1325 audit(1639056058.366:121): table=nat family=2 entries=5 op=xt_replace pid=1449 subj==unconfined comm="iptables"
[   54.174469] audit: type=1325 audit(1639056058.402:122): table=nat family=2 entries=7 op=xt_replace pid=1450 subj==unconfined comm="iptables"
[   54.202502] audit: type=1325 audit(1639056058.430:123): table=nat family=2 entries=8 op=xt_replace pid=1452 subj==unconfined comm="iptables"
[   54.242610] audit: type=1325 audit(1639056058.462:124): table=nat family=2 entries=10 op=xt_replace pid=1454 subj==unconfined comm="iptables"
[   54.274657] audit: type=1325 audit(1639056058.506:125): table=nat family=2 entries=11 op=xt_replace pid=1455 subj==unconfined comm="iptables"
[   54.306790] audit: type=1325 audit(1639056058.538:126): table=nat family=2 entries=12 op=xt_replace pid=1456 subj==unconfined comm="iptables"
[   54.455434] eth1: renamed from vethae9dced
[   54.480540] IPv6: ADDRCONF(NETDEV_CHANGE): veth2a46b17: link becomes ready
[   54.480754] hassio: port 2(veth2a46b17) entered blocking state
[   54.480769] hassio: port 2(veth2a46b17) entered forwarding state
[   60.576380] kauditd_printk_skb: 2 callbacks suppressed
[   60.576387] audit: type=1334 audit(1639056064.826:129): prog-id=11 op=LOAD
[   60.576466] audit: type=1334 audit(1639056064.826:130): prog-id=12 op=LOAD
[   60.770813] audit: type=1334 audit(1639056065.022:131): prog-id=13 op=LOAD
[   60.770947] audit: type=1334 audit(1639056065.022:132): prog-id=14 op=LOAD
[   63.596894] audit: type=1400 audit(1639056067.838:133): apparmor="STATUS" operation="profile_replace" info="same as current profile, skipping" profile="unconfined" name="hassio-supervisor" pid=1808 comm="apparmor_parser"
[   63.596952] audit: type=1400 audit(1639056067.838:133): apparmor="STATUS" operation="profile_replace" info="same as current profile, skipping" profile="unconfined" name="hassio-supervisor///usr/bin/gdbus" pid=1808 comm="apparmor_parser"
[   63.596990] audit: type=1400 audit(1639056067.838:133): apparmor="STATUS" operation="profile_replace" info="same as current profile, skipping" profile="unconfined" name="hassio-supervisor///usr/bin/git" pid=1808 comm="apparmor_parser"
[   64.339271] hassio: port 3(vethf723e14) entered blocking state
[   64.339285] hassio: port 3(vethf723e14) entered disabled state
[   64.339651] device vethf723e14 entered promiscuous mode
[   64.339741] audit: type=1700 audit(1639056068.590:134): dev=vethf723e14 prom=256 old_prom=0 auid=4294967295 uid=0 gid=0 ses=4294967295
[   64.862650] audit: type=1325 audit(1639056069.086:135): table=nat family=2 entries=0 op=xt_register pid=1877 subj==unconfined comm="iptables"
[   64.898621] audit: type=1325 audit(1639056069.130:136): table=filter family=2 entries=0 op=xt_register pid=1878 subj==unconfined comm="iptables"
[   65.239963] eth0: renamed from veth5e7059a
[   65.259840] IPv6: ADDRCONF(NETDEV_CHANGE): vethf723e14: link becomes ready
[   65.260000] hassio: port 3(vethf723e14) entered blocking state
[   65.260012] hassio: port 3(vethf723e14) entered forwarding state
[   65.767733] hassio: port 4(veth777fa4a) entered blocking state
[   65.767749] hassio: port 4(veth777fa4a) entered disabled state
[   65.768024] device veth777fa4a entered promiscuous mode
[   65.768119] kauditd_printk_skb: 8 callbacks suppressed
[   65.768124] audit: type=1700 audit(1639056070.018:145): dev=veth777fa4a prom=256 old_prom=0 auid=4294967295 uid=0 gid=0 ses=4294967295
[   66.310447] audit: type=1325 audit(1639056070.538:146): table=nat family=2 entries=0 op=xt_register pid=2175 subj==unconfined comm="iptables"
[   66.358716] audit: type=1325 audit(1639056070.582:147): table=filter family=2 entries=0 op=xt_register pid=2184 subj==unconfined comm="iptables"
[   66.398584] audit: type=1325 audit(1639056070.622:148): table=nat family=2 entries=5 op=xt_replace pid=2188 subj==unconfined comm="iptables"
[   66.426583] audit: type=1325 audit(1639056070.654:149): table=nat family=2 entries=7 op=xt_replace pid=2193 subj==unconfined comm="iptables"
[   66.458694] audit: type=1325 audit(1639056070.690:150): table=nat family=2 entries=8 op=xt_replace pid=2195 subj==unconfined comm="iptables"
[   66.490684] audit: type=1325 audit(1639056070.718:151): table=nat family=2 entries=10 op=xt_replace pid=2196 subj==unconfined comm="iptables"
[   66.530995] audit: type=1325 audit(1639056070.754:152): table=nat family=2 entries=11 op=xt_replace pid=2197 subj==unconfined comm="iptables"
[   66.566574] audit: type=1325 audit(1639056070.798:153): table=nat family=2 entries=12 op=xt_replace pid=2198 subj==unconfined comm="iptables"
[   66.606900] audit: type=1325 audit(1639056070.830:154): table=nat family=2 entries=13 op=xt_replace pid=2199 subj==unconfined comm="iptables"
[   66.680926] eth0: renamed from veth235009f
[   66.705512] IPv6: ADDRCONF(NETDEV_CHANGE): veth777fa4a: link becomes ready
[   66.705731] hassio: port 4(veth777fa4a) entered blocking state
[   66.705748] hassio: port 4(veth777fa4a) entered forwarding state
[   67.955918] hassio: port 5(veth78760e9) entered blocking state
[   67.955932] hassio: port 5(veth78760e9) entered disabled state
[   67.956634] device veth78760e9 entered promiscuous mode
[   68.848844] eth0: renamed from veth5282653
[   68.885403] IPv6: ADDRCONF(NETDEV_CHANGE): veth78760e9: link becomes ready
[   68.885715] hassio: port 5(veth78760e9) entered blocking state
[   68.885739] hassio: port 5(veth78760e9) entered forwarding state
[   76.931118] hassio: port 6(vethb9d8593) entered blocking state
[   76.931134] hassio: port 6(vethb9d8593) entered disabled state
[   76.931470] device vethb9d8593 entered promiscuous mode
[   76.931553] kauditd_printk_skb: 12 callbacks suppressed
[   76.931558] audit: type=1700 audit(1639056081.155:167): dev=vethb9d8593 prom=256 old_prom=0 auid=4294967295 uid=0 gid=0 ses=4294967295
[   77.007136] audit: type=1325 audit(1639056081.198:168): table=nat family=2 entries=15 op=xt_replace pid=3257 subj==unconfined comm="iptables"
[   77.051807] audit: type=1325 audit(1639056081.253:169): table=filter family=2 entries=30 op=xt_replace pid=3259 subj==unconfined comm="iptables"
[   77.096742] audit: type=1325 audit(1639056081.296:170): table=nat family=2 entries=16 op=xt_replace pid=3261 subj==unconfined comm="iptables"
[   77.153862] audit: type=1325 audit(1639056081.355:171): table=nat family=2 entries=17 op=xt_replace pid=3278 subj==unconfined comm="iptables"
[   77.198582] audit: type=1325 audit(1639056081.398:172): table=filter family=2 entries=31 op=xt_replace pid=3280 subj==unconfined comm="iptables"
[   77.239575] audit: type=1325 audit(1639056081.425:173): table=nat family=2 entries=18 op=xt_replace pid=3283 subj==unconfined comm="iptables"
[   77.296643] audit: type=1325 audit(1639056081.500:174): table=nat family=2 entries=19 op=xt_replace pid=3302 subj==unconfined comm="iptables"
[   77.337588] audit: type=1325 audit(1639056081.535:175): table=filter family=2 entries=32 op=xt_replace pid=3304 subj==unconfined comm="iptables"
[   77.382465] audit: type=1325 audit(1639056081.578:176): table=nat family=2 entries=20 op=xt_replace pid=3306 subj==unconfined comm="iptables"
[   78.426738] eth0: renamed from vethd2e091d
[   78.446910] IPv6: ADDRCONF(NETDEV_CHANGE): vethb9d8593: link becomes ready
[   78.447018] hassio: port 6(vethb9d8593) entered blocking state
[   78.447026] hassio: port 6(vethb9d8593) entered forwarding state
[   84.680847] hassio: port 7(veth24bea08) entered blocking state
[   84.680865] hassio: port 7(veth24bea08) entered disabled state
[   84.681098] device veth24bea08 entered promiscuous mode
[   84.681176] kauditd_printk_skb: 13 callbacks suppressed
[   84.681181] audit: type=1700 audit(1639056088.804:190): dev=veth24bea08 prom=256 old_prom=0 auid=4294967295 uid=0 gid=0 ses=4294967295
[   85.288238] audit: type=1325 audit(1639056089.392:191): table=nat family=2 entries=0 op=xt_register pid=4085 subj==unconfined comm="iptables"
[   85.312400] audit: type=1325 audit(1639056089.416:192): table=filter family=2 entries=0 op=xt_register pid=4086 subj==unconfined comm="iptables"
[   85.348767] audit: type=1325 audit(1639056089.444:193): table=nat family=2 entries=5 op=xt_replace pid=4089 subj==unconfined comm="iptables"
[   85.380875] audit: type=1325 audit(1639056089.471:194): table=nat family=2 entries=7 op=xt_replace pid=4090 subj==unconfined comm="iptables"
[   85.421199] audit: type=1325 audit(1639056089.507:195): table=nat family=2 entries=8 op=xt_replace pid=4094 subj==unconfined comm="iptables"
[   85.449325] audit: type=1325 audit(1639056089.543:196): table=nat family=2 entries=10 op=xt_replace pid=4095 subj==unconfined comm="iptables"
[   85.481616] audit: type=1325 audit(1639056089.571:197): table=nat family=2 entries=11 op=xt_replace pid=4096 subj==unconfined comm="iptables"
[   85.517851] audit: type=1325 audit(1639056089.602:198): table=nat family=2 entries=12 op=xt_replace pid=4097 subj==unconfined comm="iptables"
[   85.558119] audit: type=1325 audit(1639056089.638:199): table=nat family=2 entries=13 op=xt_replace pid=4101 subj==unconfined comm="iptables"
[   85.620824] eth0: renamed from veth4667ec9
[   85.649086] IPv6: ADDRCONF(NETDEV_CHANGE): veth24bea08: link becomes ready
[   85.649391] hassio: port 7(veth24bea08) entered blocking state
[   85.649400] hassio: port 7(veth24bea08) entered forwarding state
[   86.219734] hassio: port 8(vethb75a164) entered blocking state
[   86.221921] hassio: port 8(vethb75a164) entered disabled state
[   86.222230] device vethb75a164 entered promiscuous mode
[   87.536796] eth0: renamed from veth0e38b20
[   87.557140] IPv6: ADDRCONF(NETDEV_CHANGE): vethb75a164: link becomes ready
[   87.557323] hassio: port 8(vethb75a164) entered blocking state
[   87.557333] hassio: port 8(vethb75a164) entered forwarding state
[   88.300656] hassio: port 9(vethbaf023a) entered blocking state
[   88.300671] hassio: port 9(vethbaf023a) entered disabled state
[   88.300912] device vethbaf023a entered promiscuous mode
[   88.303221] hassio: port 9(vethbaf023a) entered blocking state
[   88.303239] hassio: port 9(vethbaf023a) entered forwarding state
[   88.575065] hassio: port 9(vethbaf023a) entered disabled state
[   89.237267] eth0: renamed from vethb15228a
[   89.255186] IPv6: ADDRCONF(NETDEV_CHANGE): vethbaf023a: link becomes ready
[   89.255307] hassio: port 9(vethbaf023a) entered blocking state
[   89.255315] hassio: port 9(vethbaf023a) entered forwarding state
[   91.193423] kauditd_printk_skb: 26 callbacks suppressed
[   91.193431] audit: type=1334 audit(1639056095.283:226): prog-id=12 op=UNLOAD
[   91.193453] audit: type=1334 audit(1639056095.283:227): prog-id=11 op=UNLOAD
[   91.213695] audit: type=1334 audit(1639056095.303:228): prog-id=14 op=UNLOAD
[   91.213719] audit: type=1334 audit(1639056095.303:229): prog-id=13 op=UNLOAD
[  181.321945] hassio: port 10(vetha3cc667) entered blocking state
[  181.321961] hassio: port 10(vetha3cc667) entered disabled state
[  181.322761] device vetha3cc667 entered promiscuous mode
[  181.323578] audit: type=1700 audit(1639056185.335:230): dev=vetha3cc667 prom=256 old_prom=0 auid=4294967295 uid=0 gid=0 ses=4294967295
[  181.376985] audit: type=1325 audit(1639056185.371:231): table=nat family=2 entries=25 op=xt_replace pid=6297 subj==unconfined comm="iptables"
[  181.405143] audit: type=1325 audit(1639056185.399:232): table=filter family=2 entries=35 op=xt_replace pid=6299 subj==unconfined comm="iptables"
[  181.445128] audit: type=1325 audit(1639056185.427:233): table=nat family=2 entries=26 op=xt_replace pid=6301 subj==unconfined comm="iptables"
[  182.029003] audit: type=1325 audit(1639056186.011:234): table=nat family=2 entries=0 op=xt_register pid=6373 subj==unconfined comm="iptables"
[  182.061046] audit: type=1325 audit(1639056186.055:235): table=filter family=2 entries=0 op=xt_register pid=6374 subj==unconfined comm="iptables"
[  182.109018] audit: type=1325 audit(1639056186.091:236): table=nat family=2 entries=5 op=xt_replace pid=6377 subj==unconfined comm="iptables"
[  182.145233] audit: type=1325 audit(1639056186.127:237): table=nat family=2 entries=7 op=xt_replace pid=6378 subj==unconfined comm="iptables"
[  182.201081] audit: type=1325 audit(1639056186.171:238): table=nat family=2 entries=8 op=xt_replace pid=6380 subj==unconfined comm="iptables"
[  182.225044] audit: type=1325 audit(1639056186.219:239): table=nat family=2 entries=10 op=xt_replace pid=6381 subj==unconfined comm="iptables"
[  182.388922] eth0: renamed from veth4f7d20d
[  182.422885] IPv6: ADDRCONF(NETDEV_CHANGE): vetha3cc667: link becomes ready
[  182.423051] hassio: port 10(vetha3cc667) entered blocking state
[  182.423062] hassio: port 10(vetha3cc667) entered forwarding state
[  188.358395] kauditd_printk_skb: 4 callbacks suppressed
[  188.358403] audit: type=1334 audit(1639056192.370:244): prog-id=15 op=LOAD
[  188.359602] audit: type=1334 audit(1639056192.370:245): prog-id=16 op=LOAD
[  188.768448] audit: type=1334 audit(1639056192.778:246): prog-id=17 op=LOAD
[  188.769103] audit: type=1334 audit(1639056192.778:247): prog-id=18 op=LOAD
[  218.739548] audit: type=1334 audit(1639056222.831:248): prog-id=16 op=UNLOAD
[  218.739634] audit: type=1334 audit(1639056222.831:249): prog-id=15 op=UNLOAD
[  219.104678] audit: type=1334 audit(1639056223.200:250): prog-id=18 op=UNLOAD
[  219.104718] audit: type=1334 audit(1639056223.200:251): prog-id=17 op=UNLOAD
[ 7788.171081] audit: type=1334 audit(1639063792.371:252): prog-id=19 op=LOAD
[ 7788.171163] audit: type=1334 audit(1639063792.371:253): prog-id=20 op=LOAD
[ 7788.482575] audit: type=1334 audit(1639063792.683:254): prog-id=21 op=LOAD
[ 7788.482667] audit: type=1334 audit(1639063792.683:255): prog-id=22 op=LOAD
[ 7818.530473] audit: type=1334 audit(1639063822.731:256): prog-id=20 op=UNLOAD
[ 7818.530504] audit: type=1334 audit(1639063822.731:257): prog-id=19 op=UNLOAD
[ 7818.832196] audit: type=1334 audit(1639063823.031:258): prog-id=22 op=UNLOAD
[ 7818.832245] audit: type=1334 audit(1639063823.031:259): prog-id=21 op=UNLOAD

Hi,

first some questions for you:

after a restart, do the history of some sensor that suppose to change constantly is fixed for a time until the restart? (like CPU temperature)

do the local automation work when you don’t have access? (like Zigbee or ESPHome )

and finally, do you have a sensor for the load, disk use, processor use, memory use?
image
(something like that:)

This looks a bit like a network issue, but your core logs only show entries after the network issue occured.
Do you have some storm protection active on your switch?

Answer 1
From checking between 02:00 and 15:00 today I can see that the readings are constant for battery temperature, I do have some other readings but obviously we know temperature is meant to change as seen below.

So issue has possibly occurred between 06:15 and 06:45 today.

Answer 2
No automations work.

For example I had an automation to turn on a MQTT switch at a set time but nothing happened.

Answer 3
Unfortunately I don’t have sensors for this but would be more than happy to add it, the only info I have which doesn’t show historical is the one found in System.

Would you be able to provide the config sensor for yours?

I would have a second Pi4 (4Gb) running the same hardware such as SSD and PoE but it would be Pi OS with Docker, this has seen pretty much 0% downtime on the same Unifi 24 PoE switch.

I had checked the config on the port and can confirm Storm Control isn’t turned on as seen below.

Does you switch have logs for if link is dropped on the PoE port? Not the PoE link, but the network link?

TBH I wouldn’t be able to confirm that only because I haven’t seen any errors before on it, I do know the controller will report if for example an AP has lost connection.

I do know when I ping the Pi it responds but its when attempting to access it where I get the error.

okay it seems that it’s more that HA freeze than becoming unavailable
here is some discussion about that:

the trick for the sensor is in the last one, but her is mine:

# temperature cpu
- platform: command_line
  name: CPU Temperature
  command: "cat /sys/class/thermal/thermal_zone0/temp"
  # If errors occur, make sure configuration file is encoded as UTF-8
  unit_of_measurement: "°C"
  value_template: '{{ value | multiply(0.001) | round(2) }}'
  scan_interval: 30

# Example configuration.yaml entry
- platform: systemmonitor
  resources:
    - type: disk_use_percent
      arg: /config
    - type: memory_free
    - type: disk_use
    - type: load_1m
    - type: load_5m
    - type: load_15m
    - type: processor_use
    - type: memory_use_percent
    - type: last_boot

I had that problem recently but it disappeared after I use the sensor to alert me when it’s too high:

- id: '1633543522497'
  alias: alert possesseur
  description: ''
  trigger:
  - platform: numeric_state
    entity_id: sensor.processor_use_percent
    above: '80'
  condition: []
  action:
  - service: notify.mobile_app_cell_cascano
    data:
      title: alert prossesseur
      message: en haut de 80%
  mode: single

you can trigger a restart when some value go too high for a workaround in the mean time

You have a network issue for sure, since all the errors in the core log you posted is about connection issues.

Try to connect to port 4357 with the local IP on your HA when it is working correct and see if you get a responce.
If you do then connect again when the problem occurs.

How do you connect to your HA?
Local IP or Local URL or external URL?

Ok thank you, I’ll check these 2 other threads out, in the meantime as a better way of handling the short term solution I’ve setup the graph and the automation to alert me.

image

1 Like

I had tried port 4357 just now via the local IP and received “refused to connect” error eventhough I can access it via 8123 at this time without issue.

I will try what @cascano42 has suggested.

I would connect via both local IP and external URL.

Both would use HTTPS.

Ok slight update, I’ve made the changes as mentioned in that ticket, thank you @cascano42 for that.

I’ve also added to my Home Assistant to monitor the SWAP in the meantime.

image

1 Like

The observer is not part of HA so even though you have set up SSL you need to use http:// for port 4357

well, if your internet connection have issues, then SSL will be hit too, since certifacates might need to be looked up at the CAs that issued them.
For now try to use only http and see if the issue still exist then.

Got it thanks, think when I was entering the IP it was automatically using HTTPS.

I’ll keep an eye on this next time I experience the issue.

image

Slight update, I haven’t noticed the SWAP being anywhere near full as seen below, think the max I have ever seen it is 2Mb.

Ok so… unresponsive again :frowning:

Before I power cycled the port I tried the following:

  • Accessing via internal, external and internal HTTP port 4357 - message: refused to connect
  • Checking port via Unifi, shows power is being supplied along with TX and RX indicating data is being sent/received
  • Home Assistant dropped off Unifi Client list to show its connected

After power cycling the port:

  • Can access internal, external and internal HTTP 4357 without issue
  • Checked the HA monitor graph to find the below, issue occurred right after 00:24:28 GMT
  • Checked SWAP used and had never went above 0.8Mb but has 2,996.1Mb to play with

Not sure of what to make of the graph, the spike you see at the very end is when it is rebooting.

image

image

Anyone got any ideas?

I know that even installing this on a different Pi 4 or installing from scratch makes no difference as already tested.

No suggestions, but following because I’m intermittently having similar issues