Migration Raspberry PI snapshot to ORDROID N2 hangs (high Core RAM Usage)

[rck777]

Hardware

• [X] Raspberry Pi 4 (Source Snapshot)
• [X] ODROID N2(+) (Destination Snapshot)
• [ ] ASUS Tinker [S]
• [ ] Intel NUC (or compatible)
• [ ] OVA (Open Virtualization Applicance, on Intel NUC or any other hardware, please add the Hypervisor you are using)

Home Assistant OS release:

• [ ] Fresh installation of release x.y
• [ ] Updated from version x.y
• [x] Migrate version 2020.12.1 and Home Assistant OS 5.9 (problem also in 5.8)

Migration to ODROID-N2 4Gig. I make a snapshot on Raspberry PI4 and restore snapshot on the new ODROID-N2. I restored two instances. Both have the same problem

• Home Assistant Frontend -> Configuration -> Info (use the copy button in the System Health block)
• Or use this command: ha info

  
  ~ $ ha info
  arch: aarch64
  channel: stable
  docker: 19.03.13
  features:

• reboot
• shutdown
• services
• network
• hostname
• hassos hassos: "5.9" homeassistant: 2020.12.1 hostname: homeassistant logging: info machine: odroid-n2 operating_system: Home Assistant OS 5.9 supervisor: 2020.12.7 supported: true supported_arch:
• aarch64
• armv7
• armhf timezone: Europe/Amsterdam

  **Supervisor logs:**

  20-12-21 21:16:07 INFO (SyncWorker_0) [supervisor.docker.addon] Starting Docker add-on homeassistant/aarch64-addon-ssh with version 8.9.1 20-12-21 21:16:12 INFO (MainThread) [supervisor.core] Start Home Assistant Core 20-12-21 21:16:12 INFO (SyncWorker_4) [supervisor.docker.interface] Starting homeassistant 20-12-21 21:16:12 INFO (MainThread) [supervisor.homeassistant.core] Wait until Home Assistant is ready 20-12-21 21:20:37 INFO (MainThread) [supervisor.homeassistant.api] Updated Home Assistant API token 20-12-21 21:21:08 INFO (MainThread) [supervisor.homeassistant.core] Detect a running Home Assistant instance 20-12-21 21:21:08 INFO (MainThread) [supervisor.addons] Phase 'AddonStartup.APPLICATION' starting 1 add-ons 20-12-21 21:21:08 INFO (SyncWorker_4) [supervisor.docker.interface] Cleaning addon_core_configurator application 20-12-21 21:21:09 INFO (SyncWorker_4) [supervisor.docker.addon] Starting Docker add-on homeassistant/aarch64-addon-configurator with version 5.2.0 20-12-21 21:21:14 INFO (MainThread) [supervisor.misc.tasks] All core tasks are scheduled 20-12-21 21:21:14 INFO (MainThread) [supervisor.misc.hwmon] Started Supervisor hardware monitor 20-12-21 21:21:14 INFO (MainThread) [supervisor.core] Supervisor is up and running 20-12-21 21:21:14 INFO (MainThread) [supervisor.host.info] Updating local host information 20-12-21 21:21:14 INFO (MainThread) [supervisor.updater] Fetching update data from https://version.home-assistant.io/stable.json 20-12-21 21:21:14 INFO (MainThread) [supervisor.resolution.fixup] Starting system autofix at state CoreState.RUNNING 20-12-21 21:21:14 INFO (MainThread) [supervisor.resolution.fixup] System autofix complete 20-12-21 21:21:14 INFO (MainThread) [supervisor.host.services] Updating service information 20-12-21 21:21:14 INFO (MainThread) [supervisor.host.network] Updating local network information [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] udev.sh: executing... [21:23:57] INFO: Update udev information [cont-init.d] udev.sh: exited 0. [cont-init.d] done. [services.d] starting services [services.d] done. [21:23:57] INFO: Starting local supervisor watchdog... 20-12-21 21:23:59 INFO (MainThread) [main] Initializing Supervisor setup 20-12-21 21:23:59 INFO (MainThread) [supervisor.bootstrap] Initializing Supervisor Sentry 20-12-21 21:23:59 INFO (MainThread) [supervisor.bootstrap] Seting up coresys for machine: odroid-n2 20-12-21 21:23:59 INFO (SyncWorker_0) [supervisor.docker.supervisor] Attaching to Supervisor homeassistant/aarch64-hassio-supervisor with version 2020.12.7 20-12-21 21:23:59 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state CoreState.INITIALIZE 20-12-21 21:23:59 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete 20-12-21 21:23:59 INFO (MainThread) [main] Setting up Supervisor 20-12-21 21:23:59 INFO (MainThread) [supervisor.api] Starting API on 172.30.32.2 20-12-21 21:23:59 INFO (MainThread) [supervisor.host.info] Updating local host information 20-12-21 21:23:59 INFO (MainThread) [supervisor.host.services] Updating service information 20-12-21 21:24:00 INFO (MainThread) [supervisor.host.network] Updating local network information 20-12-21 21:24:00 INFO (MainThread) [supervisor.host.sound] Updating PulseAudio information 20-12-21 21:24:00 INFO (MainThread) [supervisor.host] Host information reload completed 20-12-21 21:24:00 INFO (MainThread) [supervisor.host.apparmor] Loading AppArmor Profiles: {'hassio-supervisor'} 20-12-21 21:24:00 INFO (MainThread) [supervisor.host.services] Reloading local service hassos-apparmor.service 20-12-21 21:24:00 INFO (SyncWorker_0) [supervisor.docker.interface] Attaching to homeassistant/aarch64-hassio-dns with version 2020.11.0 20-12-21 21:24:00 INFO (MainThread) [supervisor.plugins.dns] Starting CoreDNS plugin 20-12-21 21:24:00 INFO (SyncWorker_0) [supervisor.docker.interface] Cleaning hassio_dns application 20-12-21 21:24:01 INFO (SyncWorker_0) [supervisor.docker.dns] Starting DNS homeassistant/aarch64-hassio-dns with version 2020.11.0 - 172.30.32.3 20-12-21 21:24:01 INFO (MainThread) [supervisor.plugins.dns] Updated /etc/resolv.conf 20-12-21 21:24:01 INFO (SyncWorker_0) [supervisor.docker.interface] Attaching to homeassistant/aarch64-hassio-audio with version 17 20-12-21 21:24:01 INFO (MainThread) [supervisor.plugins.audio] Starting Audio plugin 20-12-21 21:24:01 INFO (SyncWorker_0) [supervisor.docker.interface] Cleaning hassio_audio application 20-12-21 21:24:02 INFO (SyncWorker_0) [supervisor.docker.audio] Starting Audio homeassistant/aarch64-hassio-audio with version 17 - 172.30.32.4 20-12-21 21:24:02 INFO (SyncWorker_0) [supervisor.docker.interface] Attaching to homeassistant/aarch64-hassio-cli with version 2020.11.1 20-12-21 21:24:02 INFO (MainThread) [supervisor.plugins.cli] Starting CLI plugin 20-12-21 21:24:02 INFO (SyncWorker_0) [supervisor.docker.interface] Cleaning hassio_cli application 20-12-21 21:24:02 INFO (SyncWorker_0) [supervisor.docker.cli] Starting CLI homeassistant/aarch64-hassio-cli with version 2020.11.1 - 172.30.32.5 20-12-21 21:24:02 INFO (SyncWorker_0) [supervisor.docker.interface] Attaching to homeassistant/aarch64-hassio-observer with version 2020.10.1 20-12-21 21:24:03 INFO (SyncWorker_0) [supervisor.docker.interface] Attaching to homeassistant/aarch64-hassio-multicast with version 3 20-12-21 21:24:03 INFO (MainThread) [supervisor.plugins.multicast] Starting Multicast plugin 20-12-21 21:24:03 INFO (SyncWorker_0) [supervisor.docker.interface] Cleaning hassio_multicast application 20-12-21 21:24:03 INFO (SyncWorker_0) [supervisor.docker.multicast] Starting Multicast homeassistant/aarch64-hassio-multicast with version 3 - Host 20-12-21 21:24:03 INFO (MainThread) [supervisor.updater] Fetching update data from https://version.home-assistant.io/stable.json 20-12-21 21:24:03 INFO (SyncWorker_0) [supervisor.docker.interface] Attaching to homeassistant/odroid-n2-homeassistant with version 2020.12.1 20-12-21 21:24:03 INFO (MainThread) [supervisor.homeassistant.secrets] Loaded 9 Home Assistant secrets 20-12-21 21:24:03 INFO (MainThread) [supervisor.hassos] Detect HassOS 5.9 / BootSlot B 20-12-21 21:24:03 INFO (MainThread) [supervisor.store.git] Loading add-on /data/addons/core repository 20-12-21 21:24:03 INFO (MainThread) [supervisor.store.git] Loading add-on /data/addons/git/a0d7b954 repository 20-12-21 21:24:04 INFO (MainThread) [supervisor.store] Loading add-ons from store: 66 all - 66 new - 0 remove 20-12-21 21:24:04 INFO (MainThread) [supervisor.addons] Found 5 installed add-ons 20-12-21 21:24:04 INFO (SyncWorker_2) [supervisor.docker.interface] Attaching to homeassistant/aarch64-addon-samba with version 9.3.0 20-12-21 21:24:04 INFO (SyncWorker_4) [supervisor.docker.interface] Attaching to homeassistant/aarch64-addon-duckdns with version 1.12.1 20-12-21 21:24:04 INFO (SyncWorker_0) [supervisor.docker.interface] Attaching to homeassistant/aarch64-addon-ssh with version 8.9.1 20-12-21 21:24:04 INFO (SyncWorker_3) [supervisor.docker.interface] Attaching to homeassistant/aarch64-addon-check_config with version 3.6.0 20-12-21 21:24:04 INFO (SyncWorker_1) [supervisor.docker.interface] Attaching to homeassistant/aarch64-addon-configurator with version 5.2.0 20-12-21 21:24:04 INFO (MainThread) [supervisor.snapshots] Found 4 snapshot files 20-12-21 21:24:04 INFO (MainThread) [supervisor.discovery] Loaded 0 messages 20-12-21 21:24:04 INFO (MainThread) [supervisor.ingress] Loaded 0 ingress sessions 20-12-21 21:24:04 INFO (MainThread) [supervisor.resolution.check] Starting system checks with state CoreState.SETUP 20-12-21 21:24:04 INFO (MainThread) [supervisor.resolution.check] System checks complete 20-12-21 21:24:04 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state CoreState.SETUP 20-12-21 21:24:04 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete 20-12-21 21:24:04 INFO (MainThread) [main] Running Supervisor 20-12-21 21:24:04 INFO (MainThread) [supervisor.hassos] Rauc: B - marked slot kernel.1 as good 20-12-21 21:24:04 INFO (MainThread) [supervisor.addons] Phase 'AddonStartup.INITIALIZE' starting 0 add-ons 20-12-21 21:24:04 INFO (MainThread) [supervisor.addons] Phase 'AddonStartup.SYSTEM' starting 0 add-ons 20-12-21 21:24:04 INFO (MainThread) [supervisor.addons] Phase 'AddonStartup.SERVICES' starting 3 add-ons 20-12-21 21:24:04 INFO (SyncWorker_2) [supervisor.docker.interface] Cleaning addon_core_samba application 20-12-21 21:24:04 INFO (SyncWorker_2) [supervisor.docker.addon] Starting Docker add-on homeassistant/aarch64-addon-samba with version 9.3.0 20-12-21 21:24:04 INFO (SyncWorker_4) [supervisor.docker.interface] Cleaning addon_core_duckdns application 20-12-21 21:24:05 INFO (SyncWorker_4) [supervisor.docker.addon] Starting Docker add-on homeassistant/aarch64-addon-duckdns with version 1.12.1 20-12-21 21:24:05 INFO (SyncWorker_3) [supervisor.docker.interface] Cleaning addon_core_ssh application 20-12-21 21:24:06 INFO (SyncWorker_3) [supervisor.docker.addon] Starting Docker add-on homeassistant/aarch64-addon-ssh with version 8.9.1 20-12-21 21:24:11 INFO (MainThread) [supervisor.core] Start Home Assistant Core 20-12-21 21:24:11 INFO (SyncWorker_4) [supervisor.docker.interface] Starting homeassistant 20-12-21 21:24:11 INFO (MainThread) [supervisor.homeassistant.core] Wait until Home Assistant is ready 20-12-21 21:30:51 INFO (MainThread) [supervisor.homeassistant.api] Updated Home Assistant API token

  
  **Journal logs:**
  <!--

• Enable SSH on OS level and login, then use journalctl - command not found ;-( -->

Kernel logs:

[    0.000000] Booting Linux on physical CPU 0x0000000000 [0x410fd034]
[    0.000000] Linux version 5.9.15 (builder@fbbb00576698) (aarch64-buildroot-linux-gnu-gcc.br_real (Buildroot -g45d6d28) 9.3.0, GNU ld (GNU Binutils) 2.34) #1 SMP PREEMPT Fri Dec 18 20:11:38 UTC 2020
[    0.000000] Machine model: Hardkernel ODROID-N2Plus
[    0.000000] efi: UEFI not found.
[    0.000000] Reserved memory: created CMA memory pool at 0x00000000e0c00000, size 256 MiB
[    0.000000] OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool
[    0.000000] NUMA: No NUMA configuration found
[    0.000000] NUMA: Faking a node at [mem 0x0000000000000000-0x00000000f4e5afff]
[    0.000000] NUMA: NODE_DATA [mem 0xf465e100-0xf465ffff]
[    0.000000] Zone ranges:
[    0.000000]   DMA      [mem 0x0000000000000000-0x000000003fffffff]
[    0.000000]   DMA32    [mem 0x0000000040000000-0x00000000f4e5afff]
[    0.000000]   Normal   empty
[    0.000000] Movable zone start for each node
[    0.000000] Early memory node ranges
[    0.000000]   node   0: [mem 0x0000000000000000-0x0000000004ffffff]
[    0.000000]   node   0: [mem 0x0000000005300000-0x00000000f4e5afff]
[    0.000000] Zeroed struct page in unavailable ranges: 421 pages
[    0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x00000000f4e5afff]
[    0.000000] On node 0 totalpages: 1002331
[    0.000000]   DMA zone: 4096 pages used for memmap
[    0.000000]   DMA zone: 0 pages reserved
[    0.000000]   DMA zone: 261376 pages, LIFO batch:63
[    0.000000]   DMA32 zone: 11578 pages used for memmap
[    0.000000]   DMA32 zone: 740955 pages, LIFO batch:63
[    0.000000] psci: probing for conduit method from DT.
[    0.000000] psci: PSCIv1.0 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.1
[    0.000000] percpu: Embedded 23 pages/cpu s53912 r8192 d32104 u94208
[    0.000000] pcpu-alloc: s53912 r8192 d32104 u94208 alloc=23*4096
[    0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 [0] 4 [0] 5 
[    0.000000] Detected VIPT I-cache on CPU0
[    0.000000] CPU features: detected: ARM erratum 845719
[    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 986657
[    0.000000] Policy zone: DMA32
[    0.000000] Kernel command line: zram.enabled=1 zram.num_devices=3 apparmor=1 security=apparmor systemd.machine_id=d3b1ef06c37c4cefba76a26a375ad803 cgroup_enable=memory fsck.repair=yes root=PARTUUID=48617373-08 rootfstype=squashfs ro rootwait rauc.slot=B console=tty0 console=ttyAML0,115200n8
[    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 0x3bfff000-0x3ffff000] (64MB)
[    0.000000] Memory: 3578968K/4009324K available (13440K kernel code, 990K rwdata, 4160K rodata, 2560K init, 463K bss, 168212K reserved, 262144K cma-reserved)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=6, Nodes=1
[    0.000000] rcu: Preemptible hierarchical RCU implementation.
[    0.000000] rcu:     RCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=6.
[    0.000000]  Trampoline 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=6
[    0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
[    0.000000] GIC: Using split EOI/Deactivate mode
[    0.000000] irq_meson_gpio: 100 to 8 gpio interrupt mux initialized
[    0.000000] random: get_random_bytes called from start_kernel+0x32c/0x4ec with crng_init=0
[    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.000004] sched_clock: 56 bits at 24MHz, resolution 41ns, wraps every 4398046511097ns
[    0.000171] Console: colour dummy device 80x25
[    0.000525] printk: console [tty0] enabled
[    0.000610] Calibrating delay loop (skipped), value calculated using timer frequency.. 48.00 BogoMIPS (lpj=96000)
[    0.000630] pid_max: default: 32768 minimum: 301
[    0.000713] LSM: Security Framework initializing
[    0.000795] AppArmor: AppArmor initialized
[    0.000849] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
[    0.000877] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
[    0.002582] rcu: Hierarchical SRCU implementation.
[    0.004315] EFI services will not be available.
[    0.004720] smp: Bringing up secondary CPUs ...
[    0.005354] Detected VIPT I-cache on CPU1
[    0.005405] CPU1: Booted secondary processor 0x0000000001 [0x410fd034]
[    0.006552] CPU features: detected: ARM erratum 858921
[    0.006560] ARM_SMCCC_ARCH_WORKAROUND_1 missing from firmware
[    0.006567] Detected VIPT I-cache on CPU2
[    0.006591] arch_timer: Enabling local workaround for ARM erratum 858921
[    0.006606] arch_timer: CPU2: Trapping CNTVCT access
[    0.006614] CPU2: Booted secondary processor 0x0000000100 [0x410fd092]
[    0.007224] Detected VIPT I-cache on CPU3
[    0.007240] arch_timer: Enabling local workaround for ARM erratum 858921
[    0.007246] arch_timer: CPU3: Trapping CNTVCT access
[    0.007252] CPU3: Booted secondary processor 0x0000000101 [0x410fd092]
[    0.007825] Detected VIPT I-cache on CPU4
[    0.007841] arch_timer: Enabling local workaround for ARM erratum 858921
[    0.007847] arch_timer: CPU4: Trapping CNTVCT access
[    0.007853] CPU4: Booted secondary processor 0x0000000102 [0x410fd092]
[    0.008485] Detected VIPT I-cache on CPU5
[    0.008500] arch_timer: Enabling local workaround for ARM erratum 858921
[    0.008506] arch_timer: CPU5: Trapping CNTVCT access
[    0.008512] CPU5: Booted secondary processor 0x0000000103 [0x410fd092]
[    0.008583] smp: Brought up 1 node, 6 CPUs
[    0.008728] SMP: Total of 6 processors activated.
[    0.008741] CPU features: detected: 32-bit EL0 Support
[    0.008752] CPU features: detected: CRC32 instructions
[    0.008763] CPU features: detected: 32-bit EL1 Support
[    0.018974] CPU: All CPU(s) started at EL2
[    0.019038] alternatives: patching kernel code
[    0.020778] devtmpfs: initialized
[    0.026513] Registered cp15_barrier emulation handler
[    0.026536] Registered setend emulation handler
[    0.026547] KASLR disabled due to lack of seed
[    0.026791] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[    0.026813] futex hash table entries: 2048 (order: 5, 131072 bytes, linear)
[    0.030894] pinctrl core: initialized pinctrl subsystem
[    0.031218] DMI not present or invalid.
[    0.031547] NET: Registered protocol family 16
[    0.032918] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations
[    0.033100] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
[    0.033339] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
[    0.033358] audit: initializing netlink subsys (disabled)
[    0.033484] audit: type=2000 audit(0.032:1): state=initialized audit_enabled=0 res=1
[    0.033752] thermal_sys: Registered thermal governor 'step_wise'
[    0.033972] cpuidle: using governor menu
[    0.034260] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
[    0.034352] ASID allocator initialised with 65536 entries
[    0.035172] Serial: AMBA PL011 UART driver
[    0.060662] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages
[    0.060680] HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages
[    0.060689] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
[    0.060698] HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages
[    0.061435] cryptd: max_cpu_qlen set to 1000
[    0.062969] ACPI: Interpreter disabled.
[    0.063646] 5V: supplied by 12V
[    0.064286] VDDAO_3V3: supplied by 12V
[    0.064568] iommu: Default domain type: Translated 
[    0.064675] vgaarb: loaded
[    0.064874] SCSI subsystem initialized
[    0.064969] libata version 3.00 loaded.
[    0.065087] usbcore: registered new interface driver usbfs
[    0.065118] usbcore: registered new interface driver hub
[    0.065170] usbcore: registered new device driver usb
[    0.065380] mc: Linux media interface: v0.10
[    0.065399] videodev: Linux video capture interface: v2.00
[    0.065425] pps_core: LinuxPPS API ver. 1 registered
[    0.065433] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[    0.065447] PTP clock support registered
[    0.065556] EDAC MC: Ver: 3.0.0
[    0.065946] FPGA manager framework
[    0.065994] Advanced Linux Sound Architecture Driver Initialized.
[    0.066630] clocksource: Switched to clocksource arch_sys_counter
[    0.066805] VFS: Disk quotas dquot_6.6.0
[    0.066851] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[    0.067182] AppArmor: AppArmor Filesystem Enabled
[    0.067209] pnp: PnP ACPI: disabled
[    0.070316] NET: Registered protocol family 2
[    0.070693] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)
[    0.070725] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)
[    0.070876] TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear)
[    0.071070] TCP: Hash tables configured (established 32768 bind 32768)
[    0.071157] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear)
[    0.071198] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear)
[    0.071330] NET: Registered protocol family 1
[    0.071623] RPC: Registered named UNIX socket transport module.
[    0.071634] RPC: Registered udp transport module.
[    0.071641] RPC: Registered tcp transport module.
[    0.071648] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    0.071659] PCI: CLS 0 bytes, default 64
[    0.072573] kvm [1]: IPA Size Limit: 40bits
[    0.072932] kvm [1]: vgic interrupt IRQ1
[    0.073047] kvm [1]: Hyp mode initialized successfully
[    0.075040] Initialise system trusted keyrings
[    0.075111] workingset: timestamp_bits=44 max_order=20 bucket_order=0
[    0.078584] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[    0.079006] NFS: Registering the id_resolver key type
[    0.079030] Key type id_resolver registered
[    0.079037] Key type id_legacy registered
[    0.079092] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
[    0.079244] 9p: Installing v9fs 9p2000 file system support
[    0.107253] Key type asymmetric registered
[    0.107264] Asymmetric key parser 'x509' registered
[    0.107290] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 245)
[    0.107382] io scheduler mq-deadline registered
[    0.107391] io scheduler kyber registered
[    0.109585] gpio-447 (usb-hub-reset): hogged as output/high
[    0.117280] soc soc0: Amlogic Meson G12B (S922X) Revision 29:c (40:2) Detected
[    0.118562] VCC_3V3: supplied by VDDAO_3V3
[    0.118581] FLASH_1V8: supplied by VCC_3V3
[    0.118598] VCC_1V8: supplied by VCC_3V3
[    0.118612] VDDAO_1V8: supplied by VDDAO_3V3
[    0.118647] VDDCPU_A: supplied by regulator-dummy
[    0.118855] VDDCPU_B: supplied by regulator-dummy
[    0.120665] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
[    0.121912] ff803000.serial: ttyAML0 at MMIO 0xff803000 (irq = 17, base_baud = 1500000) is a meson_uart
[    1.090028] printk: console [ttyAML0] enabled
[    1.098579] loop: module loaded
[    1.098903] zram: Added device: zram0
[    1.101250] zram: Added device: zram1
[    1.104889] zram: Added device: zram2
[    1.111191] libphy: Fixed MDIO Bus: probed
[    1.112516] tun: Universal TUN/TAP device driver, 1.6
[    1.117936] thunder_xcv, ver 1.0
[    1.120581] thunder_bgx, ver 1.0
[    1.123767] nicpf, ver 1.0
[    1.126795] hclge is initializing
[    1.129723] hns3: Hisilicon Ethernet Network Driver for Hip08 Family - version
[    1.136863] hns3: Copyright (c) 2017 Huawei Corporation.
[    1.142146] e1000e: Intel(R) PRO/1000 Network Driver
[    1.147035] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
[    1.152924] igb: Intel(R) Gigabit Ethernet Network Driver
[    1.158247] igb: Copyright (c) 2007-2014 Intel Corporation.
[    1.163786] igbvf: Intel(R) Gigabit Virtual Function Network Driver
[    1.169976] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.
[    1.175940] sky2: driver version 1.30
[    1.179721] VFIO - User Level meta-driver version: 0.3
[    1.185758] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[    1.191038] ehci-pci: EHCI PCI platform driver
[    1.195444] ehci-platform: EHCI generic platform driver
[    1.200732] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[    1.206726] ohci-pci: OHCI PCI platform driver
[    1.211143] ohci-platform: OHCI generic platform driver
[    1.216764] usbcore: registered new interface driver uas
[    1.221585] usbcore: registered new interface driver usb-storage
[    1.227558] usbcore: registered new interface driver usbserial_generic
[    1.233989] usbserial: USB Serial support registered for generic
[    1.241329] i2c /dev entries driver
[    1.244944] rtc-pcf8563 0-0051: low voltage detected, date/time is not reliable.
[    1.250807] rtc-pcf8563 0-0051: registered as rtc0
[    1.255998] rtc-pcf8563 0-0051: low voltage detected, date/time is not reliable.
[    1.262787] rtc-pcf8563 0-0051: hctosys: unable to read the hardware clock
[    1.273049] cpufreq: cpufreq_online: CPU2: Running at unlisted initial frequency: 999999 KHz, changing to: 1000000 KHz
[    1.281314] sdhci: Secure Digital Host Controller Interface driver
[    1.286330] sdhci: Copyright(c) Pierre Ossman
[    1.290709] Synopsys Designware Multimedia Card Interface Driver
[    1.298870] meson-gx-mmc ffe07000.mmc: allocated mmc-pwrseq
[    1.328245] sdhci-pltfm: SDHCI platform and OF driver helper
[    1.328765] ledtrig-cpu: registered to indicate activity on CPUs
[    1.334324] meson-sm: secure-monitor enabled
[    1.338762] usbcore: registered new interface driver usbhid
[    1.343955] usbhid: USB HID core driver
[    1.349925] IPVS: Registered protocols ()
[    1.351739] IPVS: Connection hash table configured (size=4096, memory=64Kbytes)
[    1.359017] IPVS: ipvs loaded.
[    1.361979] IPVS: [rr] scheduler registered.
[    1.366449] NET: Registered protocol family 10
[    1.370929] Segment Routing with IPv6
[    1.374255] NET: Registered protocol family 17
[    1.378655] Bridge firewalling registered
[    1.382636] 9pnet: Installing 9P2000 support
[    1.386843] Key type dns_resolver registered
[    1.391236] registered taskstats version 1
[    1.395113] Loading compiled-in X.509 certificates
[    1.399886] AppArmor: AppArmor sha1 policy hashing enabled
[    1.405496] HUB_5V: supplied by 5V
[    1.408749] USB_PWR_EN: supplied by 5V
[    1.451862] dwc3-meson-g12a ffe09000.usb: USB2 ports: 2
[    1.451886] dwc3-meson-g12a ffe09000.usb: USB3 ports: 1
[    1.459176] dwc2 ff400000.usb: supply vusb_d not found, using dummy regulator
[    1.463719] dwc2 ff400000.usb: supply vusb_a not found, using dummy regulator
[    1.468941] mmc0: new HS200 MMC card at address 0001
[    1.470871] dwc2 ff400000.usb: EPs: 7, dedicated fifos, 712 entries in SPRAM
[    1.476004] mmcblk0: mmc0:0001 BJTD4R 29.1 GiB 
[    1.483126] xhci-hcd xhci-hcd.0.auto: xHCI Host Controller
[    1.487308] mmcblk0boot0: mmc0:0001 BJTD4R partition 1 4.00 MiB
[    1.492598] xhci-hcd xhci-hcd.0.auto: new USB bus registered, assigned bus number 1
[    1.498604] mmcblk0boot1: mmc0:0001 BJTD4R partition 2 4.00 MiB
[    1.506130] xhci-hcd xhci-hcd.0.auto: hcc params 0x0228fe6c hci version 0x110 quirks 0x0000000000010010
[    1.511977] mmcblk0rpmb: mmc0:0001 BJTD4R partition 3 4.00 MiB, chardev (241:0)
[    1.521246] xhci-hcd xhci-hcd.0.auto: irq 30, io mem 0xff500000
[    1.530594]  mmcblk0: p1 p2 < p5 p6 p7 p8 p9 > p3 p4
[    1.534590] hub 1-0:1.0: USB hub found
[    1.542986] hub 1-0:1.0: 2 ports detected
[    1.547053] xhci-hcd xhci-hcd.0.auto: xHCI Host Controller
[    1.552368] xhci-hcd xhci-hcd.0.auto: new USB bus registered, assigned bus number 2
[    1.559957] xhci-hcd xhci-hcd.0.auto: Host supports USB 3.0 SuperSpeed
[    1.566439] usb usb2: We don't know the algorithms for LPM for this host, disabling LPM.
[    1.574628] hub 2-0:1.0: USB hub found
[    1.578154] hub 2-0:1.0: 1 port detected
[    1.582260] dwc3-meson-g12a ffe09000.usb: switching to Device Mode
[    1.588693] meson-gx-mmc ffe05000.sd: Got CD GPIO
[    1.622289] printk: console [netcon0] enabled
[    1.622310] netconsole: network logging started
[    1.625944] ALSA device list:
[    1.628434]   No soundcards found.
[    1.638850] VFS: Mounted root (squashfs filesystem) readonly on device 179:8.
[    1.640989] devtmpfs: mounted
[    1.643774] Freeing unused kernel memory: 2560K
[    1.666660] Run /sbin/init as init process
[    1.666675]   with arguments:
[    1.666676]     /sbin/init
[    1.666677]   with environment:
[    1.666678]     HOME=/
[    1.666678]     TERM=linux
[    1.666679]     cgroup_enable=memory
[    1.698627] random: fast init done
[    1.733437] systemd[1]: System time before build time, advancing clock.
[    1.749513] systemd[1]: systemd 246 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)
[    1.765860] systemd[1]: Detected architecture arm64.
[    1.803647] systemd[1]: Set hostname to <homeassistant>.
[    1.803741] systemd[1]: Installed transient /etc/machine-id file.
[    1.866112] systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly.
[    1.882662] usb 1-1: new high-speed USB device number 2 using xhci-hcd
[    1.933626] systemd[1]: Queued start job for default target Multi-User System.
[    1.935716] random: systemd: uninitialized urandom read (16 bytes read)
[    1.943120] systemd[1]: Created slice system-getty.slice.
[    1.966698] random: systemd: uninitialized urandom read (16 bytes read)
[    1.968238] systemd[1]: Created slice system-modprobe.slice.
[    1.994674] random: systemd: uninitialized urandom read (16 bytes read)
[    1.996147] systemd[1]: Created slice system-serial\x2dgetty.slice.
[    2.019250] systemd[1]: Created slice system-systemd\x2dfsck.slice.
[    2.039165] systemd[1]: Created slice User and Session Slice.
[    2.058778] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
[    2.078706] hub 1-1:1.0: USB hub found
[    2.078715] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
[    2.078980] hub 1-1:1.0: 4 ports detected
[    2.106792] systemd[1]: Reached target HassOS hardware targets.
[    2.126661] systemd[1]: Reached target HassOS zram targets.
[    2.146699] systemd[1]: Reached target Paths.
[    2.162670] systemd[1]: Reached target Remote File Systems.
[    2.162768] usb 2-1: new SuperSpeed Gen 1 USB device number 2 using xhci-hcd
[    2.186663] systemd[1]: Reached target Slices.
[    2.204923] systemd[1]: Listening on Process Core Dump Socket.
[    2.206687] hub 2-1:1.0: USB hub found
[    2.209110] hub 2-1:1.0: 4 ports detected
[    2.230894] systemd[1]: Listening on Journal Audit Socket.
[    2.250787] systemd[1]: Listening on Journal Socket (/dev/log).
[    2.270803] systemd[1]: Listening on Journal Socket.
[    2.286834] systemd[1]: Listening on udev Control Socket.
[    2.306760] systemd[1]: Listening on udev Kernel Socket.
[    2.324269] systemd[1]: Mounting Huge Pages File System...
[    2.340343] systemd[1]: Mounting POSIX Message Queue File System...
[    2.358989] systemd[1]: Condition check resulted in Kernel Debug File System being skipped.
[    2.361791] systemd[1]: Condition check resulted in Kernel Trace File System being skipped.
[    2.372935] systemd[1]: Starting Create list of static device nodes for the current kernel...
[    2.401619] systemd[1]: Starting Load Kernel Module drm...
[    2.423828] systemd[1]: Starting Journal Service...
[    2.442079] systemd[1]: Starting Remount Root and Kernel File Systems...
[    2.465940] systemd[1]: Starting Coldplug All udev Devices...
[    2.486140] systemd[1]: Starting HassOS ZRAM swap...
[    2.504458] zram0: detected capacity change from 0 to 983982080
[    2.506568] systemd[1]: Starting HassOS ZRAM tmp...
[    2.512030] zram2: detected capacity change from 0 to 16777216
[    2.537847] systemd[1]: Starting HassOS ZRAM var...
[    2.540909] zram1: detected capacity change from 0 to 33554432
[    2.563150] systemd[1]: Started Journal Service.
[    2.721736] audit: type=1334 audit(1599912993.984:2): prog-id=5 op=LOAD
[    2.722794] audit: type=1334 audit(1599912993.988:3): prog-id=6 op=LOAD
[    2.892924] meson8b-dwmac ff3f0000.ethernet: IRQ eth_wake_irq not found
[    2.896767] panfrost ffe40000.gpu: clock rate = 24000000
[    2.900195] panfrost ffe40000.gpu: [drm:panfrost_devfreq_init [panfrost]] Failed to register cooling device
[    2.900380] meson8b-dwmac ff3f0000.ethernet: IRQ eth_lpi not found
[    2.913515] meson-vrtc ff8000a8.rtc: registered as rtc1
[    2.915749] meson-drm ff900000.vpu: Queued 2 outputs on vpu
[    2.917771] meson8b-dwmac ff3f0000.ethernet: PTP uses main clock
[    2.920850] meson8b-dwmac ff3f0000.ethernet: User ID: 0x11, Synopsys ID: 0x37
[    2.931333] panfrost ffe40000.gpu: supply mali not found, using dummy regulator
[    2.932891] meson8b-dwmac ff3f0000.ethernet:     DWMAC1000
[    2.942209] panfrost ffe40000.gpu: mali-g52 id 0x7212 major 0x0 minor 0x0 status 0x0
[    2.947908] meson8b-dwmac ff3f0000.ethernet: DMA HW capability register supported
[    2.952817] panfrost ffe40000.gpu: features: 00000000,13de77ff, issues: 00000000,00000400
[    2.959036] meson8b-dwmac ff3f0000.ethernet: RX Checksum Offload Engine supported
[    2.959039] meson8b-dwmac ff3f0000.ethernet: COE Type 2
[    2.959040] meson8b-dwmac ff3f0000.ethernet: TX Checksum insertion supported
[    2.959042] meson8b-dwmac ff3f0000.ethernet: Wake-Up On Lan supported
[    2.959105] meson8b-dwmac ff3f0000.ethernet: Normal descriptors
[    2.974868] Registered IR keymap rc-odroid
[    2.982123] meson-drm ff900000.vpu: CVBS Output connector not available
[    3.010540] panfrost ffe40000.gpu: Features: L2:0x07110206 Shader:0x00000000 Tiler:0x00000809 Mem:0x1 MMU:0x00002830 AS:0xff JS:0x7
[    3.010665] meson8b-dwmac ff3f0000.ethernet: Ring mode enabled
[    3.010668] meson8b-dwmac ff3f0000.ethernet: Enable RX Mitigation via HW Watchdog Timer
[    3.010883] libphy: stmmac: probed
[    3.011965] libphy: mdio_mux: probed
[    3.018694] rc_core: Loaded IR protocol module ir-nec-decoder, but protocol nec still not available
[    3.028940] panfrost ffe40000.gpu: shader_present=0x3 l2_present=0x1
[    3.034564] rc rc0: meson-ir as /devices/platform/soc/ff800000.bus/ff808000.ir/rc/rc0
[    3.048587] [drm] Initialized panfrost 1.1.0 20180908 for ffe40000.gpu on minor 0
[    3.049366] meson-dw-hdmi ff600000.hdmi-tx: Detected HDMI TX controller v2.01a with HDCP (meson_dw_hdmi_phy)
[    3.058495] input: meson-ir as /devices/platform/soc/ff800000.bus/ff808000.ir/rc/rc0/input0
[    3.064859] meson-dw-hdmi ff600000.hdmi-tx: registered DesignWare HDMI I2C bus driver
[    3.072618] meson-ir ff808000.ir: receiver initialized
[    3.080037] meson-drm ff900000.vpu: bound ff600000.hdmi-tx (ops meson_dw_hdmi_ops [meson_dw_hdmi])
[    3.119795] [drm] Initialized meson 1.0.0 20161109 for ff900000.vpu on minor 1
[    3.231048] libphy: mdio_mux: probed
[    3.291394] Console: switching to colour frame buffer device 128x48
[    3.314461] meson-drm ff900000.vpu: [drm] fb0: mesondrmfb frame buffer device
[    3.345587] axg-sound-card sound: ASoC: no DMI vendor name!
[    3.542689] Adding 960916k swap on /dev/zram0.  Priority:-2 extents:1 across:960916k SS
[    3.572138] EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Opts: (null)
[    3.579249] ext4 filesystem being mounted at /mnt/overlay supports timestamps until 2038 (0x7fffffff)
[    3.956550] EXT4-fs (mmcblk0p4): mounted filesystem with ordered data mode. Opts: (null)
[    4.547379] EXT4-fs (zram2): mounted filesystem without journal. Opts: nobarrier
[    4.547394] ext4 filesystem being mounted at /tmp supports timestamps until 2038 (0x7fffffff)
[    4.586954] EXT4-fs (zram1): mounted filesystem without journal. Opts: nobarrier
[    4.586969] ext4 filesystem being mounted at /var supports timestamps until 2038 (0x7fffffff)
[    5.436337] audit: type=1400 audit(1608585827.328:4): apparmor="STATUS" operation="profile_load" profile="unconfined" name="hassio-supervisor" pid=360 comm="apparmor_parser"
[    5.436348] audit: type=1400 audit(1608585827.328:4): apparmor="STATUS" operation="profile_load" profile="unconfined" name="hassio-supervisor///usr/bin/gdbus" pid=360 comm="apparmor_parser"
[    5.436353] audit: type=1400 audit(1608585827.328:4): apparmor="STATUS" operation="profile_load" profile="unconfined" name="hassio-supervisor///usr/bin/git" pid=360 comm="apparmor_parser"
[    5.436358] audit: type=1400 audit(1608585827.328:4): apparmor="STATUS" operation="profile_load" profile="unconfined" name="hassio-supervisor///usr/bin/socat" pid=360 comm="apparmor_parser"
[    5.459336] audit: type=1334 audit(1608585827.356:5): prog-id=7 op=LOAD
[    5.459463] audit: type=1334 audit(1608585827.356:6): prog-id=8 op=LOAD
[    5.467002] random: crng init done
[    5.467006] random: 7 urandom warning(s) missed due to ratelimiting
[    5.640324] cfg80211: Loading compiled-in X.509 certificates for regulatory database
[    5.646077] audit: type=1334 audit(1608585827.540:7): prog-id=9 op=LOAD
[    5.646084] audit: type=1334 audit(1608585827.540:8): prog-id=10 op=LOAD
[    5.663120] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
[    5.836308] meson8b-dwmac ff3f0000.ethernet eth0: PHY [0.0:00] driver [RTL8211F Gigabit Ethernet] (irq=31)
[    5.846635] meson8b-dwmac ff3f0000.ethernet eth0: No Safety Features support found
[    5.846642] meson8b-dwmac ff3f0000.ethernet eth0: PTP not supported by HW
[    5.846812] meson8b-dwmac ff3f0000.ethernet eth0: configuring for phy/rgmii link mode
[    8.855114] meson8b-dwmac ff3f0000.ethernet eth0: Link is Up - 1Gbps/Full - flow control off
[    8.855133] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[   11.561761] audit: type=1400 audit(1608585833.456:9): apparmor="STATUS" operation="profile_load" profile="unconfined" name="docker-default" pid=420 comm="apparmor_parser"
[   12.206846] audit: type=1325 audit(1608585834.104:10): table=nat family=2 entries=5 op=xt_replace pid=449 subj==unconfined comm="iptables"
[   12.209403] audit: type=1325 audit(1608585834.104:11): table=filter family=2 entries=4 op=xt_replace pid=451 subj==unconfined comm="iptables"
[   12.212240] audit: type=1325 audit(1608585834.108:12): table=filter family=2 entries=6 op=xt_replace pid=453 subj==unconfined comm="iptables"
[   12.214830] audit: type=1325 audit(1608585834.112:13): table=filter family=2 entries=8 op=xt_replace pid=455 subj==unconfined comm="iptables"
[   12.217623] audit: type=1325 audit(1608585834.112:14): table=filter family=2 entries=10 op=xt_replace pid=457 subj==unconfined comm="iptables"
[   12.220433] audit: type=1325 audit(1608585834.116:15): table=filter family=2 entries=11 op=xt_replace pid=459 subj==unconfined comm="iptables"
[   12.221861] audit: type=1325 audit(1608585834.116:16): table=filter family=2 entries=12 op=xt_replace pid=460 subj==unconfined comm="iptables"
[   12.227652] Initializing XFRM netlink socket
[   12.241549] audit: type=1325 audit(1608585834.136:17): table=nat family=2 entries=7 op=xt_replace pid=469 subj==unconfined comm="iptables"
[   12.246410] audit: type=1325 audit(1608585834.140:18): table=nat family=2 entries=8 op=xt_replace pid=471 subj==unconfined comm="iptables"
[   13.762089] hassio: port 1(veth4efe5e2) entered blocking state
[   13.762096] hassio: port 1(veth4efe5e2) entered disabled state
[   13.762286] device veth4efe5e2 entered promiscuous mode
[   13.762809] hassio: port 1(veth4efe5e2) entered blocking state
[   13.762817] hassio: port 1(veth4efe5e2) entered forwarding state
[   13.763154] hassio: port 1(veth4efe5e2) entered disabled state
[   13.973420] cgroup: cgroup: disabling cgroup2 socket matching due to net_prio or net_cls activation
[   14.203110] eth0: renamed from veth69651dd
[   14.231057] IPv6: ADDRCONF(NETDEV_CHANGE): veth4efe5e2: link becomes ready
[   14.231098] hassio: port 1(veth4efe5e2) entered blocking state
[   14.231100] hassio: port 1(veth4efe5e2) entered forwarding state
[   14.231154] IPv6: ADDRCONF(NETDEV_CHANGE): hassio: link becomes ready
[   14.365369] process 'docker/tmp/qemu-check116047839/check' started with executable stack
[   14.880011] docker0: port 1(veth3878a3b) entered blocking state
[   14.880016] docker0: port 1(veth3878a3b) entered disabled state
[   14.880111] device veth3878a3b entered promiscuous mode
[   14.898496] hassio: port 2(vethf5448d8) entered blocking state
[   14.898501] hassio: port 2(vethf5448d8) entered disabled state
[   14.898607] device vethf5448d8 entered promiscuous mode
[   14.898781] hassio: port 2(vethf5448d8) entered blocking state
[   14.898785] hassio: port 2(vethf5448d8) entered forwarding state
[   15.155174] eth0: renamed from vethb196016
[   15.175475] hassio: port 2(vethf5448d8) entered disabled state
[   15.175607] IPv6: ADDRCONF(NETDEV_CHANGE): veth3878a3b: link becomes ready
[   15.175689] docker0: port 1(veth3878a3b) entered blocking state
[   15.175693] docker0: port 1(veth3878a3b) entered forwarding state
[   15.175803] IPv6: ADDRCONF(NETDEV_CHANGE): docker0: link becomes ready
[   15.287121] eth1: renamed from veth132266e
[   15.315106] IPv6: ADDRCONF(NETDEV_CHANGE): vethf5448d8: link becomes ready
[   15.315155] hassio: port 2(vethf5448d8) entered blocking state
[   15.315158] hassio: port 2(vethf5448d8) entered forwarding state
[   15.617565] udevd[205]: starting version 3.2.9
[   15.624693] udevd[206]: starting eudev-3.2.9
[   19.054171] kauditd_printk_skb: 72 callbacks suppressed
[   19.054177] audit: type=1400 audit(1608585840.944:91): apparmor="STATUS" operation="profile_replace" info="same as current profile, skipping" profile="unconfined" name="hassio-supervisor" pid=1727 comm="apparmor_parser"
[   19.054193] audit: type=1400 audit(1608585840.944:91): apparmor="STATUS" operation="profile_replace" info="same as current profile, skipping" profile="unconfined" name="hassio-supervisor///usr/bin/gdbus" pid=1727 comm="apparmor_parser"
[   19.054201] audit: type=1400 audit(1608585840.944:91): apparmor="STATUS" operation="profile_replace" info="same as current profile, skipping" profile="unconfined" name="hassio-supervisor///usr/bin/git" pid=1727 comm="apparmor_parser"
[   19.054207] audit: type=1400 audit(1608585840.944:91): apparmor="STATUS" operation="profile_replace" info="same as current profile, skipping" profile="unconfined" name="hassio-supervisor///usr/bin/socat" pid=1727 comm="apparmor_parser"
[   19.300174] hassio: port 3(veth227699d) entered blocking state
[   19.300179] hassio: port 3(veth227699d) entered disabled state
[   19.300287] device veth227699d entered promiscuous mode
[   19.300330] audit: type=1700 audit(1608585841.196:92): dev=veth227699d prom=256 old_prom=0 auid=4294967295 uid=0 gid=0 ses=4294967295
[   19.576752] audit: type=1325 audit(1608585841.472:93): table=nat family=2 entries=0 op=xt_register pid=1777 subj==unconfined comm="iptables"
[   19.581264] audit: type=1325 audit(1608585841.476:94): table=filter family=2 entries=0 op=xt_register pid=1778 subj==unconfined comm="iptables"
[   19.585253] audit: type=1325 audit(1608585841.480:95): table=nat family=2 entries=5 op=xt_replace pid=1781 subj==unconfined comm="iptables"
[   19.586713] audit: type=1325 audit(1608585841.480:96): table=nat family=2 entries=7 op=xt_replace pid=1782 subj==unconfined comm="iptables"
[   19.589360] audit: type=1325 audit(1608585841.484:97): table=nat family=2 entries=8 op=xt_replace pid=1784 subj==unconfined comm="iptables"
[   19.659088] eth0: renamed from veth4f249b0
[   19.703078] IPv6: ADDRCONF(NETDEV_CHANGE): veth227699d: link becomes ready
[   19.703128] hassio: port 3(veth227699d) entered blocking state
[   19.703131] hassio: port 3(veth227699d) entered forwarding state
[   20.010309] hassio: port 4(vetha2fd360) entered blocking state
[   20.010314] hassio: port 4(vetha2fd360) entered disabled state
[   20.010495] device vetha2fd360 entered promiscuous mode
[   20.010747] hassio: port 4(vetha2fd360) entered blocking state
[   20.010751] hassio: port 4(vetha2fd360) entered forwarding state
[   20.339076] hassio: port 4(vetha2fd360) entered disabled state
[   20.339336] eth0: renamed from vethdaf5e78
[   20.363181] IPv6: ADDRCONF(NETDEV_CHANGE): vetha2fd360: link becomes ready
[   20.363235] hassio: port 4(vetha2fd360) entered blocking state
[   20.363238] hassio: port 4(vetha2fd360) entered forwarding state
[   20.648319] hassio: port 5(vethb53dd49) entered blocking state
[   20.648327] hassio: port 5(vethb53dd49) entered disabled state
[   20.648581] device vethb53dd49 entered promiscuous mode
[   20.649034] hassio: port 5(vethb53dd49) entered blocking state
[   20.649043] hassio: port 5(vethb53dd49) entered forwarding state
[   20.995486] eth0: renamed from veth0c2b154
[   21.023262] IPv6: ADDRCONF(NETDEV_CHANGE): vethb53dd49: link becomes ready
[   22.168358] udevd[496]: starting version 3.2.9
[   22.178585] udevd[497]: starting eudev-3.2.9
[   23.084306] hassio: port 6(veth8b58cf6) entered blocking state
[   23.084312] hassio: port 6(veth8b58cf6) entered disabled state
[   23.084425] device veth8b58cf6 entered promiscuous mode
[   23.427237] eth0: renamed from veth1a04560
[   23.447233] IPv6: ADDRCONF(NETDEV_CHANGE): veth8b58cf6: link becomes ready
[   23.447285] hassio: port 6(veth8b58cf6) entered blocking state
[   23.447288] hassio: port 6(veth8b58cf6) entered forwarding state
[   23.875928] hassio: port 7(veth25cba3f) entered blocking state
[   23.875934] hassio: port 7(veth25cba3f) entered disabled state
[   23.876125] device veth25cba3f entered promiscuous mode
[   23.876352] hassio: port 7(veth25cba3f) entered blocking state
[   23.876357] hassio: port 7(veth25cba3f) entered forwarding state
[   24.086752] hassio: port 7(veth25cba3f) entered disabled state
[   24.220921] kauditd_printk_skb: 39 callbacks suppressed
[   24.220927] audit: type=1325 audit(1608585846.116:137): table=nat family=2 entries=0 op=xt_register pid=3723 subj==unconfined comm="iptables"
[   24.228125] audit: type=1325 audit(1608585846.124:138): table=filter family=2 entries=0 op=xt_register pid=3724 subj==unconfined comm="iptables"
[   24.236816] audit: type=1325 audit(1608585846.132:139): table=nat family=2 entries=5 op=xt_replace pid=3727 subj==unconfined comm="iptables"
[   24.240155] audit: type=1325 audit(1608585846.136:140): table=nat family=2 entries=7 op=xt_replace pid=3728 subj==unconfined comm="iptables"
[   24.246210] audit: type=1325 audit(1608585846.140:141): table=nat family=2 entries=8 op=xt_replace pid=3730 subj==unconfined comm="iptables"
[   24.248419] audit: type=1325 audit(1608585846.144:142): table=nat family=2 entries=10 op=xt_replace pid=3731 subj==unconfined comm="iptables"
[   24.252888] audit: type=1325 audit(1608585846.148:143): table=nat family=2 entries=11 op=xt_replace pid=3732 subj==unconfined comm="iptables"
[   24.257466] audit: type=1325 audit(1608585846.152:144): table=nat family=2 entries=12 op=xt_replace pid=3733 subj==unconfined comm="iptables"
[   24.261712] audit: type=1325 audit(1608585846.156:145): table=nat family=2 entries=13 op=xt_replace pid=3734 subj==unconfined comm="iptables"
[   24.264731] audit: type=1325 audit(1608585846.160:146): table=nat family=2 entries=14 op=xt_replace pid=3735 subj==unconfined comm="iptables"
[   24.307821] eth0: renamed from veth40132b3
[   24.327671] IPv6: ADDRCONF(NETDEV_CHANGE): veth25cba3f: link becomes ready
[   24.327766] hassio: port 7(veth25cba3f) entered blocking state
[   24.327770] hassio: port 7(veth25cba3f) entered forwarding state
[   29.796603] udevd[192]: starting version 3.2.9
[   29.804963] udevd[193]: starting eudev-3.2.9
[   31.710669] USB_PWR_EN: disabling
[   31.710675] TF_IO: disabling
[   48.226716] audit: type=1334 audit(1608585870.124:147): prog-id=10 op=UNLOAD
[   48.226725] audit: type=1334 audit(1608585870.124:148): prog-id=9 op=UNLOAD
[  121.770727] hassio: port 8(veth2df8734) entered blocking state
[  121.770733] hassio: port 8(veth2df8734) entered disabled state
[  121.770992] device veth2df8734 entered promiscuous mode
[  121.771040] audit: type=1700 audit(1608586283.047:149): dev=veth2df8734 prom=256 old_prom=0 auid=4294967295 uid=0 gid=0 ses=4294967295
[  122.043254] audit: type=1325 audit(1608586283.319:150): table=nat family=2 entries=0 op=xt_register pid=5115 subj==unconfined comm="iptables"
[  122.054203] audit: type=1325 audit(1608586283.327:151): table=filter family=2 entries=0 op=xt_register pid=5116 subj==unconfined comm="iptables"
[  122.059371] audit: type=1325 audit(1608586283.335:152): table=nat family=2 entries=5 op=xt_replace pid=5119 subj==unconfined comm="iptables"
[  122.061256] audit: type=1325 audit(1608586283.335:153): table=nat family=2 entries=7 op=xt_replace pid=5120 subj==unconfined comm="iptables"
[  122.064718] audit: type=1325 audit(1608586283.339:154): table=nat family=2 entries=8 op=xt_replace pid=5122 subj==unconfined comm="iptables"
[  122.066532] audit: type=1325 audit(1608586283.339:155): table=nat family=2 entries=10 op=xt_replace pid=5123 subj==unconfined comm="iptables"
[  122.071304] audit: type=1325 audit(1608586283.347:156): table=nat family=2 entries=11 op=xt_replace pid=5124 subj==unconfined comm="iptables"
[  122.074161] audit: type=1325 audit(1608586283.347:157): table=nat family=2 entries=12 op=xt_replace pid=5125 subj==unconfined comm="iptables"
[  122.076581] audit: type=1325 audit(1608586283.351:158): table=nat family=2 entries=13 op=xt_replace pid=5126 subj==unconfined comm="iptables"
[  122.111602] eth0: renamed from veth361c504
[  122.131503] IPv6: ADDRCONF(NETDEV_CHANGE): veth2df8734: link becomes ready
[  122.131604] hassio: port 8(veth2df8734) entered blocking state
[  122.131608] hassio: port 8(veth2df8734) entered forwarding state
[  127.238943] kauditd_printk_skb: 1 callbacks suppressed
[  127.238949] audit: type=1334 audit(1608586288.515:160): prog-id=11 op=LOAD
[  127.239001] audit: type=1334 audit(1608586288.515:161): prog-id=12 op=LOAD
[  135.537460] hassio: port 7(veth25cba3f) entered disabled state
[  135.537790] veth40132b3: renamed from eth0
[  135.595061] hassio: port 7(veth25cba3f) entered disabled state
[  135.595646] device veth25cba3f left promiscuous mode
[  135.595668] hassio: port 7(veth25cba3f) entered disabled state
[  135.595742] audit: type=1700 audit(1608586296.867:162): dev=veth25cba3f prom=0 old_prom=256 auid=4294967295 uid=0 gid=0 ses=4294967295
[  135.790702] audit: type=1325 audit(1608586297.067:163): table=nat family=2 entries=15 op=xt_unregister pid=91 subj==unconfined comm="kworker/u12:1"
[  135.790715] audit: type=1325 audit(1608586297.067:164): table=filter family=2 entries=4 op=xt_unregister pid=91 subj==unconfined comm="kworker/u12:1"
[  136.055559] hassio: port 7(vethf8179a6) entered blocking state
[  136.055567] hassio: port 7(vethf8179a6) entered disabled state
[  136.055980] device vethf8179a6 entered promiscuous mode
[  136.056035] audit: type=1700 audit(1608586297.331:165): dev=vethf8179a6 prom=256 old_prom=0 auid=4294967295 uid=0 gid=0 ses=4294967295
[  136.056658] hassio: port 7(vethf8179a6) entered blocking state
[  136.056666] hassio: port 7(vethf8179a6) entered forwarding state
[  136.079804] audit: type=1325 audit(1608586297.355:166): table=nat family=2 entries=15 op=xt_replace pid=5659 subj==unconfined comm="iptables"
[  136.084291] audit: type=1325 audit(1608586297.359:167): table=filter family=2 entries=30 op=xt_replace pid=5661 subj==unconfined comm="iptables"
[  136.088978] audit: type=1325 audit(1608586297.363:168): table=nat family=2 entries=16 op=xt_replace pid=5663 subj==unconfined comm="iptables"
[  136.364862] audit: type=1325 audit(1608586297.639:169): table=nat family=2 entries=0 op=xt_register pid=5719 subj==unconfined comm="iptables"
[  136.370578] audit: type=1325 audit(1608586297.647:170): table=filter family=2 entries=0 op=xt_register pid=5720 subj==unconfined comm="iptables"
[  136.376576] audit: type=1325 audit(1608586297.651:171): table=nat family=2 entries=5 op=xt_replace pid=5723 subj==unconfined comm="iptables"
[  136.419086] eth0: renamed from vethd7252e0
[  136.438802] IPv6: ADDRCONF(NETDEV_CHANGE): vethf8179a6: link becomes ready
[  157.458053] kauditd_printk_skb: 7 callbacks suppressed
[  157.458057] audit: type=1334 audit(1608586318.735:179): prog-id=12 op=UNLOAD
[  157.458066] audit: type=1334 audit(1608586318.735:180): prog-id=11 op=UNLOAD
[  224.946918] rc rc0: two consecutive events of type space
~ $ 

Description of problem: After migration HA from Raspberry PI4 to ODROID-N2 system hangs after few minutes.

• installation with emmc image hassos_odroid-n2-5.8.img.xz (system = OK)

• Make first snapshot (system = OK)

• Upload snapshot file from Raspberry PI 4 with the same versions

• Restore snapshot

• After restore Core RAM Usage memory usage increases quickly and system hangs after a few minutes

• Restore only works when i not restore the folder Home assistant configuration folder (i deselect this folder in restore snapshot properties. The most important folder ;-(

• All USB hardware are disconnected at this time.

• Problem exists on two devices (a have two seperate HA installations)

[agners]

Hm, this is indeed interesting. It would be interesting which process' memory increases. Can you login onto the OS (using SSH, see https://developers.home-assistant.io/docs/operating-system/debugging/) and run the following command?

ps aux --sort -rss | head

[rck777]

Output memory usage

Hello, see below the log of ps. The 'python3 -m homeassistant --config /config' proces consuption of memory is high (within minutes 85.6%

ps aux --sort -rss | head USER PID %CPU %MEM VSZ RSS TTY STAT START TIME COMMAND root 5020 105 85.6 3636704 3291144 ? Ssl 19:29 5:35 python3 -m homeassistant --config /config root 1518 1.6 1.2 126140 47828 ? Ssl 19:29 0:05 python3 -m supervisor root 391 11.1 1.2 2155612 46456 ? Ssl 19:29 0:37 /usr/bin/dockerd -H fd:// --storage-driver=overlay2 --log-driver=journald --data-root /mnt/data/docker root 160 8.3 0.9 304968 37448 ? Rs 19:28 0:28 /usr/lib/systemd/systemd-journald root 399 0.5 0.5 2432832 21564 ? Ssl 19:29 0:01 containerd --config /var/run/docker/containerd/containerd.toml --log-level info root 2058 0.2 0.3 743840 12912 ? Ssl 19:29 0:00 coredns -conf /etc/corefile root 5331 0.4 0.3 27320 11988 ? Ss 19:30 0:01 /usr/bin/python3 /usr/bin/hass-configurator /etc/configurator.conf root 1150 0.0 0.1 1481364 6192 ? Ssl 19:29 0:00 docker container start --attach hassio_supervisor root 3192 0.5 0.1 94180 4592 ? S<sl 19:29 0:01 pulseaudio --system -vvv --disallow-exit --exit-idle-time=-1 --disable-shm

[rck777]

Problem found i think ;-) After i used ps command i also check the system messages with journalctl. Since I was in debug mode anyway. There are problems with the integration dsmr (Dutch Smart Meter Requirements). See log below. There are hundreds / thousands of error lines present about this error. So, i removed the integration and the system now seems stable.

Dec 21 20:22:04 homeassistant fb413cc9aaba[393]: File "/usr/src/homeassistant/homeassistant/components/dsmr/sensor.py", line 186, in connect_and_reconnect Dec 21 20:22:04 homeassistant fb413cc9aaba[393]: transport, protocol = await hass.loop.create_task(reader_factory()) Dec 21 20:22:04 homeassistant fb413cc9aaba[393]: File "/usr/local/lib/python3.8/asyncio/coroutines.py", line 124, in coro Dec 21 20:22:04 homeassistant fb413cc9aaba[393]: res = func(*args, *kw) Dec 21 20:22:04 homeassistant fb413cc9aaba[393]: File "/usr/local/lib/python3.8/site-packages/serial_asyncio/init.py", line 410, in create_serial_connection Dec 21 20:22:04 homeassistant fb413cc9aaba[393]: ser = serial.serial_for_url(args, **kwargs) Dec 21 20:22:04 homeassistant fb413cc9aaba[393]: File "/usr/local/lib/python3.8/site-packages/serial/init.py", line 88, in serial_for_url Dec 21 20:22:04 homeassistant fb413cc9aaba[393]: instance.open() Dec 21 20:22:04 homeassistant fb413cc9aaba[393]: File "/usr/local/lib/python3.8/site-packages/serial/serialposix.py", line 268, in open Dec 21 20:22:04 homeassistant fb413cc9aaba[393]: raise SerialException(msg.errno, "could not open port {}: {}".format(self._port, msg)) Dec 21 20:22:04 homeassistant fb413cc9aaba[393]: serial.serialutil.SerialException: [Errno 2] could not open port /dev/serial/by-id/usb-FTDI_P1_Converter_Cable_P17UI81-if00-port0: [Errno 2] No such file or directory: '/dev/serial/by-id/usb-FTDI_P1_Converter_Cable_P17UI81-if00-port0'

[agners]

Uh yeah that make sense. So did the serial device name /dev/serial/by-id/usb-FTDI_P1_Converter_Cable_P17UI81-if00-port0 change?

[rck777]

I did not connect any USB devices. So, there was actually no device. Only in the config. It seems a solution that a non-existent device ignored in de configuration? Config check was OK.

i removed the integration, insert P1 USB cable en enable config sensor:

• platform: dsmr port: /dev/serial/by-id/usb-FTDI_P1_Converter_Cable_P17UI81-if00-port0

The serial device name has remained the same. Right now it works

[agners]

Right now it works

So I guess it was the integration then which caused the high CPU/RAM usage?

[rck777]

The migrated instance form PI4 to ODROID N2 is very unstable at this moment. After remove and installation DSMR it goes a bit better but still crashes after about 12 hours. With debugging options are available to debugging automations?

[pznamenskii]

I believe I am experiencing the same, though I originally though it was caused by the HA update rather than migration from RPi3 to N2+: https://github.com/home-assistant/core/issues/44691

few hours after startup, HA is getting real slow: automations fire up with huge delay, my zigbee buttons react very poorly; and in around 12-15 hours goes totally unresponsive: nothing works anymore, even web UI, so I have to physically reboot N2.

[pznamenskii]

I might have found the cause:

ERROR (Recorder) [homeassistant.components.recorder] Error executing query: (sqlite3.DatabaseError) database disk image is malformed

removed config/home-assistant_v2.db and CPU+memory usage is way better now. I will monitor if the freeze issue is gone completely.

[rck777]

I also regularly have a corrupt database file. The problem remains even after deletion and restart. I am interested in your findings

[pznamenskii]

3.5 days so far, everything looking good. all I did was removing the corrupted database.

[stale[bot]]

This issue has been automatically marked as stale because it has not had recent activity. It will be closed if no further activity occurs. Thank you for your contributions.

[github-actions[bot]]

There hasn't been any activity on this issue recently. To keep our backlog manageable we have to clean old issues, as many of them have already been resolved with the latest updates. Please make sure to update to the latest Home Assistant OS version and check if that solves the issue. Let us know if that works for you by adding a comment 👍 This issue has now been marked as stale and will be closed if no further activity occurs. Thank you for your contributions.