search

home-assistant / operating-system

:beginner: Home Assistant Operating System
Apache License 2.0
4.68k stars 947 forks source link

Failed to start Grow File System on /mnt/data #1426

Closed MrAlfabet closed 3 years ago

MrAlfabet commented 3 years ago

Installed HassOS OVA 3.6 in Proxmox hypervisor way back when, upgrades always worked fine (all the way up to the last 5.X release). After updating to 6.0 however, I'm greeted with this message upon boot in the terminal/VNC:

[FAILED] Failed to start Grow File System on /mnt/data
See 'systemctl status systemd-growfs@mnt-data.service' for details.

The service status is the same as the guy in this thread: https://community.home-assistant.io/t/hass-os-6-0-vdi-after-upgrade-fails-every-boot-failed-to-start-grow-file-system-on-mnt-data/315819

I've tried to disable the service with systemctl disable, but that doesn't seem to work/persist through reboot.

Ctrl-D to continue works like a charm, no difference in performance is noticed from HA. Only after my full backup once a week (with reboot) do I need to login to the console and press ctrl-D.

My VM has a single disk (on zfs on my hypervisor) of 32GB and an EFI disk of 128K, OVMF (UEFI) bios, i440fx machine type (default), LSI 53C895A SCSI controller (default) and a virtio network device.

Home Assistant OS release:

System Health

version: core-2021.6.5 installation_type: Home Assistant OS dev: false hassio: true docker: true virtualenv: false python_version: 3.8.9 os_name: Linux os_version: 5.10.42 arch: x86_64 timezone: Europe/Amsterdam

GitHub API: ok Github API Calls Remaining: 4714 Installed Version: 1.12.4 Stage: running Available Repositories: 914 Installed Repositories: 13

logged_in: false can_reach_cert_server: ok can_reach_cloud_auth: ok can_reach_cloud: ok

host_os: Home Assistant OS 6.0 update_channel: stable supervisor_version: supervisor-2021.06.3 docker_version: 20.10.6 disk_total: 30.8 GB disk_used: 17.3 GB healthy: true supported: true board: ova supervisor_api: ok version_api: ok installed_addons: Check Home Assistant configuration (3.7.1), Terminal & SSH (9.1.3), Grafana (7.0.1), InfluxDB (4.1.1), File editor (5.3.1), Node-RED (9.1.4), Glances (0.12.2), Samba share (9.5.1), TasmoAdmin (0.15.0), Visual Studio Code (3.4.1), ESPHome (1.19.1), SQLite Web (3.1.0), Portainer (1.5.1), Zigbee2mqtt (1.19.1-1)

dashboards: 3 resources: 8 views: 7 mode: storage

Supervisor logs: 21-06-20 20:12:14 INFO (SyncWorker_1) [supervisor.docker.interface] Attaching to homeassistant/amd64-hassio-cli with version 2021.05.1 21-06-20 20:12:14 INFO (MainThread) [supervisor.plugins.cli] Starting CLI plugin 21-06-20 20:12:14 INFO (SyncWorker_1) [supervisor.docker.interface] Cleaning hassio_cli application 21-06-20 20:12:15 INFO (SyncWorker_1) [supervisor.docker.cli] Starting CLI homeassistant/amd64-hassio-cli with version 2021.05.1 - 172.30.32.5 21-06-20 20:12:15 INFO (SyncWorker_0) [supervisor.docker.interface] Attaching to ghcr.io/home-assistant/amd64-hassio-observer with version 2021.06.0 21-06-20 20:12:15 INFO (SyncWorker_0) [supervisor.docker.interface] Attaching to homeassistant/amd64-hassio-multicast with version 2021.04.0 21-06-20 20:12:15 INFO (MainThread) [supervisor.plugins.multicast] Starting Multicast plugin 21-06-20 20:12:15 INFO (SyncWorker_0) [supervisor.docker.interface] Cleaning hassio_multicast application 21-06-20 20:12:16 INFO (SyncWorker_0) [supervisor.docker.multicast] Starting Multicast homeassistant/amd64-hassio-multicast with version 2021.04.0 - Host 21-06-20 20:12:16 INFO (MainThread) [supervisor.updater] Fetching update data from https://version.home-assistant.io/stable.json 21-06-20 20:12:17 INFO (SyncWorker_0) [supervisor.docker.interface] Attaching to ghcr.io/home-assistant/qemux86-64-homeassistant with version 2021.6.5 21-06-20 20:12:17 INFO (MainThread) [supervisor.homeassistant.secrets] Loaded 3 Home Assistant secrets 21-06-20 20:12:17 INFO (MainThread) [supervisor.hassos] Detect Home Assistant Operating System 6.0 / BootSlot B 21-06-20 20:12:18 WARNING (MainThread) [supervisor.addons.validate] Add-on have full device access, and selective device access in the configuration. Please report this to the maintainer of Frigate NVR Beta (outdated) 21-06-20 20:12:18 WARNING (MainThread) [supervisor.addons.validate] Add-on have full device access, and selective device access in the configuration. Please report this to the maintainer of Frigate NVR 21-06-20 20:12:18 INFO (MainThread) [supervisor.store.git] Loading add-on /data/addons/core repository 21-06-20 20:12:18 INFO (MainThread) [supervisor.store.git] Loading add-on /data/addons/git/6e66619d repository 21-06-20 20:12:18 INFO (MainThread) [supervisor.store.git] Loading add-on /data/addons/git/45df7312 repository 21-06-20 20:12:18 INFO (MainThread) [supervisor.store.git] Loading add-on /data/addons/git/a0d7b954 repository 21-06-20 20:12:18 INFO (MainThread) [supervisor.store.git] Loading add-on /data/addons/git/ccab4aaf repository 21-06-20 20:12:18 INFO (MainThread) [supervisor.store.git] Loading add-on /data/addons/git/15ef4d2f repository 21-06-20 20:12:20 WARNING (MainThread) [supervisor.addons.validate] Add-on have full device access, and selective device access in the configuration. Please report this to the maintainer of Frigate NVR Beta (outdated) 21-06-20 20:12:20 WARNING (MainThread) [supervisor.addons.validate] Add-on have full device access, and selective device access in the configuration. Please report this to the maintainer of Frigate NVR 21-06-20 20:12:20 INFO (MainThread) [supervisor.store] Loading add-ons from store: 72 all - 72 new - 0 remove 21-06-20 20:12:20 INFO (MainThread) [supervisor.addons] Found 14 installed add-ons 21-06-20 20:12:20 INFO (SyncWorker_1) [supervisor.docker.interface] Attaching to ghcr.io/hassio-addons/node-red/amd64 with version 9.1.4 21-06-20 20:12:21 INFO (SyncWorker_2) [supervisor.docker.interface] Attaching to zigbee2mqtt/zigbee2mqtt-amd64 with version 1.19.1-1 21-06-20 20:12:21 INFO (SyncWorker_1) [supervisor.docker.interface] Attaching to homeassistant/amd64-addon-configurator with version 5.3.1 21-06-20 20:12:21 INFO (SyncWorker_7) [supervisor.docker.interface] Attaching to ghcr.io/hassio-addons/grafana/amd64 with version 7.0.1 21-06-20 20:12:21 INFO (SyncWorker_0) [supervisor.docker.interface] Attaching to ghcr.io/hassio-addons/sqlite-web/amd64 with version 3.1.0 21-06-20 20:12:21 INFO (SyncWorker_3) [supervisor.docker.interface] Attaching to ghcr.io/hassio-addons/influxdb/amd64 with version 4.1.1 21-06-20 20:12:21 INFO (SyncWorker_4) [supervisor.docker.interface] Attaching to homeassistant/amd64-addon-check_config with version 3.7.1 21-06-20 20:12:21 INFO (SyncWorker_5) [supervisor.docker.interface] Attaching to ghcr.io/hassio-addons/portainer/amd64 with version 1.5.1 21-06-20 20:12:21 INFO (SyncWorker_11) [supervisor.docker.interface] Attaching to esphome/esphome-hassio-amd64 with version 1.19.1 21-06-20 20:12:21 INFO (SyncWorker_8) [supervisor.docker.interface] Attaching to ghcr.io/hassio-addons/vscode/amd64 with version 3.4.1 21-06-20 20:12:21 INFO (SyncWorker_6) [supervisor.docker.interface] Attaching to homeassistant/amd64-addon-ssh with version 9.1.3 21-06-20 20:12:21 INFO (SyncWorker_9) [supervisor.docker.interface] Attaching to ghcr.io/hassio-addons/glances/amd64 with version 0.12.2 21-06-20 20:12:21 INFO (SyncWorker_10) [supervisor.docker.interface] Attaching to homeassistant/amd64-addon-samba with version 9.5.1 21-06-20 20:12:21 INFO (SyncWorker_2) [supervisor.docker.interface] Attaching to ghcr.io/hassio-addons/tasmoadmin/amd64 with version 0.15.0 21-06-20 20:12:21 INFO (MainThread) [supervisor.snapshots] Found 0 snapshot files 21-06-20 20:12:21 INFO (MainThread) [supervisor.discovery] Loaded 0 messages 21-06-20 20:12:21 INFO (MainThread) [supervisor.ingress] Loaded 8 ingress sessions 21-06-20 20:12:21 INFO (MainThread) [supervisor.resolution.check] Starting system checks with state CoreState.SETUP 21-06-20 20:12:21 INFO (MainThread) [supervisor.resolution.check] System checks complete 21-06-20 20:12:21 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state CoreState.SETUP 21-06-20 20:12:21 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete 21-06-20 20:12:21 INFO (MainThread) [supervisor.jobs] 'ResolutionFixup.run_autofix' blocked from execution, system is not running - CoreState.SETUP 21-06-20 20:12:21 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state CoreState.SETUP 21-06-20 20:12:21 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete 21-06-20 20:12:21 INFO (MainThread) [main] Running Supervisor 21-06-20 20:12:21 INFO (MainThread) [supervisor.hassos] Rauc: B - marked slot kernel.1 as good 21-06-20 20:12:21 INFO (MainThread) [supervisor.addons] Phase 'AddonStartup.INITIALIZE' starting 0 add-ons 21-06-20 20:12:21 INFO (MainThread) [supervisor.addons] Phase 'AddonStartup.SYSTEM' starting 1 add-ons 21-06-20 20:12:22 INFO (SyncWorker_5) [supervisor.docker.addon] Starting Docker add-on ghcr.io/hassio-addons/tasmoadmin/amd64 with version 0.15.0 21-06-20 20:12:27 INFO (MainThread) [supervisor.addons] Phase 'AddonStartup.SERVICES' starting 3 add-ons 21-06-20 20:12:29 INFO (SyncWorker_1) [supervisor.docker.addon] Starting Docker add-on ghcr.io/hassio-addons/grafana/amd64 with version 7.0.1 21-06-20 20:12:31 INFO (SyncWorker_10) [supervisor.docker.addon] Starting Docker add-on ghcr.io/hassio-addons/influxdb/amd64 with version 4.1.1 21-06-20 20:12:32 INFO (SyncWorker_0) [supervisor.docker.addon] Starting Docker add-on ghcr.io/hassio-addons/vscode/amd64 with version 3.4.1 21-06-20 20:12:32 INFO (MainThread) [supervisor.api.middleware.security] /dns/info access from a0d7b954_influxdb 21-06-20 20:12:37 INFO (MainThread) [supervisor.core] Start Home Assistant Core 21-06-20 20:12:37 INFO (SyncWorker_10) [supervisor.docker.interface] Starting homeassistant 21-06-20 20:12:37 INFO (MainThread) [supervisor.homeassistant.core] Wait until Home Assistant is ready 21-06-20 20:12:48 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state CoreState.STARTUP 21-06-20 20:12:48 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete 21-06-20 20:12:53 INFO (MainThread) [supervisor.homeassistant.api] Updated Home Assistant API token 21-06-20 20:13:03 INFO (MainThread) [supervisor.homeassistant.core] Detect a running Home Assistant instance 21-06-20 20:13:03 INFO (MainThread) [supervisor.addons] Phase 'AddonStartup.APPLICATION' starting 4 add-ons 21-06-20 20:13:04 INFO (SyncWorker_6) [supervisor.docker.interface] Cleaning addon_core_configurator application 21-06-20 20:13:05 INFO (SyncWorker_6) [supervisor.docker.addon] Starting Docker add-on homeassistant/amd64-addon-configurator with version 5.3.1 21-06-20 20:13:06 INFO (SyncWorker_2) [supervisor.docker.interface] Cleaning addon_a0d7b954_nodered application 21-06-20 20:13:07 INFO (SyncWorker_2) [supervisor.docker.addon] Starting Docker add-on ghcr.io/hassio-addons/node-red/amd64 with version 9.1.4 21-06-20 20:13:07 INFO (SyncWorker_8) [supervisor.docker.interface] Cleaning addon_15ef4d2f_esphome application 21-06-20 20:13:07 INFO (SyncWorker_8) [supervisor.docker.addon] Starting Docker add-on esphome/esphome-hassio-amd64 with version 1.19.1 21-06-20 20:13:07 INFO (SyncWorker_3) [supervisor.docker.interface] Cleaning addon_45df7312_zigbee2mqtt application 21-06-20 20:13:08 INFO (SyncWorker_3) [supervisor.docker.addon] Starting Docker add-on zigbee2mqtt/zigbee2mqtt-amd64 with version 1.19.1-1 21-06-20 20:13:13 INFO (MainThread) [supervisor.misc.tasks] All core tasks are scheduled 21-06-20 20:13:13 INFO (MainThread) [supervisor.core] Supervisor is up and running 21-06-20 20:13:13 INFO (MainThread) [supervisor.host.info] Updating local host information 21-06-20 20:13:13 INFO (MainThread) [supervisor.updater] Fetching update data from https://version.home-assistant.io/stable.json 21-06-20 20:13:13 INFO (MainThread) [supervisor.resolution.check] Starting system checks with state CoreState.RUNNING 21-06-20 20:13:13 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.FREE_SPACE/ContextType.SYSTEM 21-06-20 20:13:13 INFO (MainThread) [supervisor.resolution.module] Create new suggestion SuggestionType.CREATE_FULL_SNAPSHOT - ContextType.SYSTEM / None 21-06-20 20:13:13 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.PWNED/ContextType.ADDON 21-06-20 20:13:13 WARNING (MainThread) [supervisor.addons.options] Option 'interface' does not exist in the schema for Samba share (core_samba) 21-06-20 20:13:13 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.SECURITY/ContextType.CORE 21-06-20 20:13:13 INFO (MainThread) [supervisor.resolution.check] System checks complete 21-06-20 20:13:13 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state CoreState.RUNNING 21-06-20 20:13:14 INFO (MainThread) [supervisor.host.services] Updating service information 21-06-20 20:13:14 INFO (MainThread) [supervisor.host.network] Updating local network information 21-06-20 20:13:15 INFO (MainThread) [supervisor.host.sound] Updating PulseAudio information 21-06-20 20:13:15 INFO (MainThread) [supervisor.host] Host information reload completed 21-06-20 20:13:16 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete 21-06-20 20:13:16 INFO (MainThread) [supervisor.resolution.fixup] Starting system autofix at state CoreState.RUNNING 21-06-20 20:13:16 INFO (MainThread) [supervisor.resolution.fixup] System autofix complete 21-06-20 20:13:54 INFO (MainThread) [supervisor.api.proxy] Home Assistant WebSocket API request initialize 21-06-20 20:13:54 INFO (MainThread) [supervisor.api.proxy] WebSocket access from a0d7b954_nodered 21-06-20 20:13:54 INFO (MainThread) [supervisor.api.proxy] Home Assistant WebSocket API request running 21-06-20 20:13:58 INFO (MainThread) [supervisor.api.proxy] Home Assistant WebSocket API request initialize 21-06-20 20:13:58 INFO (MainThread) [supervisor.api.proxy] WebSocket access from a0d7b954_nodered 21-06-20 20:13:58 INFO (MainThread) [supervisor.api.proxy] Home Assistant WebSocket API request running

Journal logs:

Kernel logs:

I don't know why, but I can't for the life of me enable ssh on the host VM. Did the whole shebang with a usbstick (passthrough) with an authorized_keys file in ANSI and linux line endings, no dice ([supervisor.hardware.monitor] Ignore device /sys/devices/pci0000:00/0000:00:1e.0/0000:01:1b.0/usb2/2-2/2-2:1.0/host8/target8:0:0/8:0:0:0/block/sdb / failes to initialize by udev). Any other way to ssh into the root os? Or maybe access it from the terminal?

Description of problem:

agners commented 3 years ago

You get root shell access through virtual terminal (login using root, then use login to get to the root shell).

What happens if you try to run systemd-growfs manually by pressing enter to get to the root shell and executing /usr/lib/systemd/systemd-growfs /mnt/data/?

agners commented 3 years ago

Can you also check dmesg after trying to resize.

MrAlfabet commented 3 years ago

You get root shell access through virtual terminal (login using root, then use login to get to the root shell).

What happens if you try to run systemd-growfs manually by pressing enter to get to the root shell and executing /usr/lib/systemd/systemd-growfs /mnt/data/?

If I try to execute the growfs manually I get the same error 'operation not permitted' that is shown in the service logs.

What's the user/password for the core-ssh login? It's apparently not the same as logging into the ssh addon.

I was using this guide.

MrAlfabet commented 3 years ago

I see there's a new HA core update, would you rather have me try updating, or fixing this first?

MrAlfabet commented 3 years ago

Finally managed to get in. DMESG:

``` [ 0.000000] Linux version 5.10.42 (builder@0ec2c4e8c84a) (x86_64-buildroot-linux-gnu-gcc.br_real (Buildroot -gcb0fa11e) 9.3.0, GNU ld (GNU Binutils) 2.35.2) #1 SMP Wed Jun 9 00:30:56 UTC 2021 [ 0.000000] Command line: apparmor=1 security=apparmor console=tty1 bootchooser.active=B root=PARTUUID=a3ec664e-32ce-4665-95ea-7ae90ce9aa20 rootfstype=squashfs ro rootwait systemd.machine_id=1f5d06d548c349639e2f5629f42e2bb1 zram.enabled=1 zram.num_devices=3 [ 0.000000] x86/fpu: x87 FPU will use FXSAVE [ 0.000000] BIOS-provided physical RAM map: [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x00000000007fffff] usable [ 0.000000] BIOS-e820: [mem 0x0000000000800000-0x0000000000807fff] ACPI NVS [ 0.000000] BIOS-e820: [mem 0x0000000000808000-0x000000000080ffff] usable [ 0.000000] BIOS-e820: [mem 0x0000000000810000-0x00000000008fffff] ACPI NVS [ 0.000000] BIOS-e820: [mem 0x0000000000900000-0x00000000bf8eefff] usable [ 0.000000] BIOS-e820: [mem 0x00000000bf8ef000-0x00000000bfb6efff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000bfb6f000-0x00000000bfb7efff] ACPI data [ 0.000000] BIOS-e820: [mem 0x00000000bfb7f000-0x00000000bfbfefff] ACPI NVS [ 0.000000] BIOS-e820: [mem 0x00000000bfbff000-0x00000000bff1ffff] usable [ 0.000000] BIOS-e820: [mem 0x00000000bff20000-0x00000000bff3ffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000bff40000-0x00000000bfffffff] ACPI NVS [ 0.000000] BIOS-e820: [mem 0x0000000100000000-0x000000033fffffff] usable [ 0.000000] NX (Execute Disable) protection: active [ 0.000000] e820: update [mem 0xbe40c018-0xbe415a57] usable ==> usable [ 0.000000] e820: update [mem 0xbe40c018-0xbe415a57] usable ==> usable [ 0.000000] e820: update [mem 0xbe3e4018-0xbe40b457] usable ==> usable [ 0.000000] e820: update [mem 0xbe3e4018-0xbe40b457] usable ==> usable [ 0.000000] extended physical RAM map: [ 0.000000] reserve setup_data: [mem 0x0000000000000000-0x000000000009ffff] usable [ 0.000000] reserve setup_data: [mem 0x0000000000100000-0x00000000007fffff] usable [ 0.000000] reserve setup_data: [mem 0x0000000000800000-0x0000000000807fff] ACPI NVS [ 0.000000] reserve setup_data: [mem 0x0000000000808000-0x000000000080ffff] usable [ 0.000000] reserve setup_data: [mem 0x0000000000810000-0x00000000008fffff] ACPI NVS [ 0.000000] reserve setup_data: [mem 0x0000000000900000-0x00000000be3e4017] usable [ 0.000000] reserve setup_data: [mem 0x00000000be3e4018-0x00000000be40b457] usable [ 0.000000] reserve setup_data: [mem 0x00000000be40b458-0x00000000be40c017] usable [ 0.000000] reserve setup_data: [mem 0x00000000be40c018-0x00000000be415a57] usable [ 0.000000] reserve setup_data: [mem 0x00000000be415a58-0x00000000bf8eefff] usable [ 0.000000] reserve setup_data: [mem 0x00000000bf8ef000-0x00000000bfb6efff] reserved [ 0.000000] reserve setup_data: [mem 0x00000000bfb6f000-0x00000000bfb7efff] ACPI data [ 0.000000] reserve setup_data: [mem 0x00000000bfb7f000-0x00000000bfbfefff] ACPI NVS [ 0.000000] reserve setup_data: [mem 0x00000000bfbff000-0x00000000bff1ffff] usable [ 0.000000] reserve setup_data: [mem 0x00000000bff20000-0x00000000bff3ffff] reserved [ 0.000000] reserve setup_data: [mem 0x00000000bff40000-0x00000000bfffffff] ACPI NVS [ 0.000000] reserve setup_data: [mem 0x0000000100000000-0x000000033fffffff] usable [ 0.000000] efi: EFI v2.70 by EDK II [ 0.000000] efi: SMBIOS=0xbf9ac000 ACPI=0xbfb7e000 ACPI 2.0=0xbfb7e014 MEMATTR=0xbe721018 [ 0.000000] SMBIOS 2.8 present. [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 0.0.0 02/06/2015 [ 0.000000] Hypervisor detected: KVM [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 [ 0.000000] kvm-clock: cpu 0, msr 300cfb001, primary cpu clock [ 0.000000] kvm-clock: using sched offset of 6734985352 cycles [ 0.000018] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000029] tsc: Detected 2099.998 MHz processor [ 0.000250] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved [ 0.000253] e820: remove [mem 0x000a0000-0x000fffff] usable [ 0.000260] last_pfn = 0x340000 max_arch_pfn = 0x400000000 [ 0.000308] MTRR default type: write-back [ 0.000309] MTRR fixed ranges enabled: [ 0.000311] 00000-9FFFF write-back [ 0.000312] A0000-FFFFF uncachable [ 0.000313] MTRR variable ranges enabled: [ 0.000314] 0 base 00C0000000 mask FFC0000000 uncachable [ 0.000316] 1 base 0800000000 mask F800000000 uncachable [ 0.000316] 2 disabled [ 0.000317] 3 disabled [ 0.000318] 4 disabled [ 0.000318] 5 disabled [ 0.000319] 6 disabled [ 0.000319] 7 disabled [ 0.000341] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WC UC- UC [ 0.000354] last_pfn = 0xbff20 max_arch_pfn = 0x400000000 [ 0.020684] check: Scanning 1 areas for low memory corruption [ 0.023683] Secure boot disabled [ 0.023691] ACPI: Early table checksum verification disabled [ 0.023718] ACPI: RSDP 0x00000000BFB7E014 000024 (v02 BOCHS ) [ 0.023725] ACPI: XSDT 0x00000000BFB7D0E8 000054 (v01 BOCHS BXPCFACP 00000001 01000013) [ 0.023746] ACPI: FACP 0x00000000BFB79000 000074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001) [ 0.023763] ACPI: DSDT 0x00000000BFB7A000 002405 (v01 BOCHS BXPCDSDT 00000001 BXPC 00000001) [ 0.023773] ACPI: FACS 0x00000000BFBDC000 000040 [ 0.023787] ACPI: APIC 0x00000000BFB78000 0000B0 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001) [ 0.023793] ACPI: SSDT 0x00000000BFB77000 0000CA (v01 BOCHS VMGENID 00000001 BXPC 00000001) [ 0.023798] ACPI: HPET 0x00000000BFB76000 000038 (v01 BOCHS BXPCHPET 00000001 BXPC 00000001) [ 0.023804] ACPI: WAET 0x00000000BFB75000 000028 (v01 BOCHS BXPCWAET 00000001 BXPC 00000001) [ 0.023809] ACPI: BGRT 0x00000000BFB74000 000038 (v01 INTEL EDK2 00000002 01000013) [ 0.023815] ACPI: Reserving FACP table memory at [mem 0xbfb79000-0xbfb79073] [ 0.023816] ACPI: Reserving DSDT table memory at [mem 0xbfb7a000-0xbfb7c404] [ 0.023818] ACPI: Reserving FACS table memory at [mem 0xbfbdc000-0xbfbdc03f] [ 0.023819] ACPI: Reserving APIC table memory at [mem 0xbfb78000-0xbfb780af] [ 0.023820] ACPI: Reserving SSDT table memory at [mem 0xbfb77000-0xbfb770c9] [ 0.023821] ACPI: Reserving HPET table memory at [mem 0xbfb76000-0xbfb76037] [ 0.023823] ACPI: Reserving WAET table memory at [mem 0xbfb75000-0xbfb75027] [ 0.023824] ACPI: Reserving BGRT table memory at [mem 0xbfb74000-0xbfb74037] [ 0.023864] ACPI: Local APIC address 0xfee00000 [ 0.024304] No NUMA configuration found [ 0.024306] Faking a node at [mem 0x0000000000000000-0x000000033fffffff] [ 0.024317] NODE_DATA(0) allocated [mem 0x33fff4000-0x33fff7fff] [ 0.024371] Zone ranges: [ 0.024373] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.024375] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.024377] Normal [mem 0x0000000100000000-0x000000033fffffff] [ 0.024379] Movable zone start for each node [ 0.024381] Early memory node ranges [ 0.024382] node 0: [mem 0x0000000000001000-0x000000000009ffff] [ 0.024387] node 0: [mem 0x0000000000100000-0x00000000007fffff] [ 0.024389] node 0: [mem 0x0000000000808000-0x000000000080ffff] [ 0.024390] node 0: [mem 0x0000000000900000-0x00000000bf8eefff] [ 0.024391] node 0: [mem 0x00000000bfbff000-0x00000000bff1ffff] [ 0.024393] node 0: [mem 0x0000000100000000-0x000000033fffffff] [ 0.024398] Initmem setup node 0 [mem 0x0000000000001000-0x000000033fffffff] [ 0.024401] On node 0 totalpages: 3144375 [ 0.024404] DMA zone: 59 pages used for memmap [ 0.024405] DMA zone: 1815 pages reserved [ 0.024408] DMA zone: 3751 pages, LIFO batch:0 [ 0.027520] DMA zone: 29017 pages in unavailable ranges [ 0.027523] DMA32 zone: 12209 pages used for memmap [ 0.027525] DMA32 zone: 781328 pages, LIFO batch:63 [ 0.137485] DMA32 zone: 1008 pages in unavailable ranges [ 0.137491] Normal zone: 36864 pages used for memmap [ 0.137493] Normal zone: 2359296 pages, LIFO batch:63 [ 1.247458] ACPI: PM-Timer IO Port: 0xb008 [ 1.247466] ACPI: Local APIC address 0xfee00000 [ 1.247478] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 1.247547] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 1.247552] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 1.247557] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 1.247558] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 1.247563] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 1.247564] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 1.247567] ACPI: IRQ0 used by override. [ 1.247568] ACPI: IRQ5 used by override. [ 1.247569] ACPI: IRQ9 used by override. [ 1.247569] ACPI: IRQ10 used by override. [ 1.247570] ACPI: IRQ11 used by override. [ 1.247573] Using ACPI (MADT) for SMP configuration information [ 1.247575] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 1.247592] e820: update [mem 0xbe4fb000-0xbe51efff] usable ==> reserved [ 1.247613] smpboot: Allowing 8 CPUs, 0 hotplug CPUs [ 1.247651] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 1.247653] PM: hibernation: Registered nosave memory: [mem 0x000a0000-0x000fffff] [ 1.247655] PM: hibernation: Registered nosave memory: [mem 0x00800000-0x00807fff] [ 1.247657] PM: hibernation: Registered nosave memory: [mem 0x00810000-0x008fffff] [ 1.247659] PM: hibernation: Registered nosave memory: [mem 0xbe3e4000-0xbe3e4fff] [ 1.247661] PM: hibernation: Registered nosave memory: [mem 0xbe40b000-0xbe40bfff] [ 1.247662] PM: hibernation: Registered nosave memory: [mem 0xbe40c000-0xbe40cfff] [ 1.247664] PM: hibernation: Registered nosave memory: [mem 0xbe415000-0xbe415fff] [ 1.247666] PM: hibernation: Registered nosave memory: [mem 0xbe4fb000-0xbe51efff] [ 1.247668] PM: hibernation: Registered nosave memory: [mem 0xbf8ef000-0xbfb6efff] [ 1.247669] PM: hibernation: Registered nosave memory: [mem 0xbfb6f000-0xbfb7efff] [ 1.247670] PM: hibernation: Registered nosave memory: [mem 0xbfb7f000-0xbfbfefff] [ 1.247672] PM: hibernation: Registered nosave memory: [mem 0xbff20000-0xbff3ffff] [ 1.247673] PM: hibernation: Registered nosave memory: [mem 0xbff40000-0xbfffffff] [ 1.247674] PM: hibernation: Registered nosave memory: [mem 0xc0000000-0xffffffff] [ 1.247677] [mem 0xc0000000-0xffffffff] available for PCI devices [ 1.247678] Booting paravirtualized kernel on KVM [ 1.247682] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 1.254722] setup_percpu: NR_CPUS:64 nr_cpumask_bits:64 nr_cpu_ids:8 nr_node_ids:1 [ 1.440648] percpu: Embedded 54 pages/cpu s181976 r8192 d31016 u262144 [ 1.440667] pcpu-alloc: s181976 r8192 d31016 u262144 alloc=1*2097152 [ 1.440669] pcpu-alloc: [0] 0 1 2 3 4 5 6 7 [ 1.440711] kvm-guest: stealtime: cpu 0, msr 333c184c0 [ 1.440717] kvm-guest: PV spinlocks enabled [ 1.440721] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 1.440739] Built 1 zonelists, mobility grouping on. Total pages: 3093428 [ 1.440741] Policy zone: Normal [ 1.440744] Kernel command line: apparmor=1 security=apparmor console=tty1 bootchooser.active=B root=PARTUUID=a3ec664e-32ce-4665-95ea-7ae90ce9aa20 rootfstype=squashfs ro rootwait systemd.machine_id=1f5d06d548c349639e2f5629f42e2bb1 zram.enabled=1 zram.num_devices=3 [ 1.459416] Dentry cache hash table entries: 2097152 (order: 12, 16777216 bytes, linear) [ 1.468480] Inode-cache hash table entries: 1048576 (order: 11, 8388608 bytes, linear) [ 1.468659] mem auto-init: stack:off, heap alloc:off, heap free:off [ 1.608484] Memory: 12228104K/12577500K available (16395K kernel code, 2558K rwdata, 3884K rodata, 1388K init, 1168K bss, 349136K reserved, 0K cma-reserved) [ 1.608629] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=8, Nodes=1 [ 1.608677] Kernel/User page tables isolation: enabled [ 1.609258] rcu: Hierarchical RCU implementation. [ 1.609260] rcu: RCU event tracing is enabled. [ 1.609262] rcu: RCU restricting CPUs from NR_CPUS=64 to nr_cpu_ids=8. [ 1.609264] Tracing variant of Tasks RCU enabled. [ 1.609266] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 1.609267] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=8 [ 1.610317] NR_IRQS: 4352, nr_irqs: 488, preallocated irqs: 16 [ 1.610642] random: get_random_bytes called from start_kernel+0x375/0x54c with crng_init=0 [ 1.610760] Console: colour dummy device 80x25 [ 1.611032] printk: console [tty1] enabled [ 1.611076] ACPI: Core revision 20200925 [ 1.611392] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 1.611617] APIC: Switch to symmetric I/O mode setup [ 1.613676] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 1.613726] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x1e452ea631d, max_idle_ns: 440795244572 ns [ 1.613737] Calibrating delay loop (skipped) preset value.. 4199.99 BogoMIPS (lpj=2099998) [ 1.613745] pid_max: default: 32768 minimum: 301 [ 1.616036] LSM: Security Framework initializing [ 1.616133] AppArmor: AppArmor initialized [ 1.616476] Mount-cache hash table entries: 32768 (order: 6, 262144 bytes, linear) [ 1.616765] Mountpoint-cache hash table entries: 32768 (order: 6, 262144 bytes, linear) [ 1.617606] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 1.617610] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 1.617616] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization [ 1.617620] Spectre V2 : Mitigation: Full generic retpoline [ 1.617623] Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch [ 1.617626] Speculative Store Bypass: Vulnerable [ 1.617630] MDS: Vulnerable: Clear CPU buffers attempted, no microcode [ 1.618147] Freeing SMP alternatives memory: 48K [ 1.724830] smpboot: CPU0: Intel Common KVM processor (family: 0xf, model: 0x6, stepping: 0x1) [ 1.725361] Performance Events: unsupported Netburst CPU model 6 no PMU driver, software events only. [ 1.725509] rcu: Hierarchical SRCU implementation. [ 1.726175] smp: Bringing up secondary CPUs ... [ 1.726480] x86: Booting SMP configuration: [ 1.726484] .... node #0, CPUs: #1 [ 0.003150] kvm-clock: cpu 1, msr 300cfb041, secondary cpu clock [ 1.738763] kvm-guest: stealtime: cpu 1, msr 333c584c0 [ 1.739050] #2 [ 0.003150] kvm-clock: cpu 2, msr 300cfb081, secondary cpu clock [ 1.751757] kvm-guest: stealtime: cpu 2, msr 333c984c0 [ 1.752076] #3 [ 0.003150] kvm-clock: cpu 3, msr 300cfb0c1, secondary cpu clock [ 1.764782] kvm-guest: stealtime: cpu 3, msr 333cd84c0 [ 1.765156] #4 [ 0.003150] kvm-clock: cpu 4, msr 300cfb101, secondary cpu clock [ 1.777769] kvm-guest: stealtime: cpu 4, msr 333d184c0 [ 1.778090] #5 [ 0.003150] kvm-clock: cpu 5, msr 300cfb141, secondary cpu clock [ 1.790773] kvm-guest: stealtime: cpu 5, msr 333d584c0 [ 1.791128] #6 [ 0.003150] kvm-clock: cpu 6, msr 300cfb181, secondary cpu clock [ 1.802761] kvm-guest: stealtime: cpu 6, msr 333d984c0 [ 1.804067] #7 [ 0.003150] kvm-clock: cpu 7, msr 300cfb1c1, secondary cpu clock [ 1.815756] kvm-guest: stealtime: cpu 7, msr 333dd84c0 [ 1.815889] smp: Brought up 1 node, 8 CPUs [ 1.815898] smpboot: Max logical packages: 1 [ 1.815903] smpboot: Total of 8 processors activated (33599.96 BogoMIPS) [ 1.818179] devtmpfs: initialized [ 1.818751] x86/mm: Memory block size: 128MB [ 1.821921] PM: Registering ACPI NVS region [mem 0x00800000-0x00807fff] (32768 bytes) [ 1.821921] PM: Registering ACPI NVS region [mem 0x00810000-0x008fffff] (983040 bytes) [ 1.821942] PM: Registering ACPI NVS region [mem 0xbfb7f000-0xbfbfefff] (524288 bytes) [ 1.821975] PM: Registering ACPI NVS region [mem 0xbff40000-0xbfffffff] (786432 bytes) [ 1.822128] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 1.822144] futex hash table entries: 2048 (order: 5, 131072 bytes, linear) [ 1.823047] PM: RTC time: 11:18:35, date: 2021-06-21 [ 1.823506] NET: Registered protocol family 16 [ 1.823828] audit: initializing netlink subsys (disabled) [ 1.824199] thermal_sys: Registered thermal governor 'step_wise' [ 1.824201] thermal_sys: Registered thermal governor 'user_space' [ 1.824412] audit: type=2000 audit(1624274316.517:1): state=initialized audit_enabled=0 res=1 [ 1.824745] cpuidle: using governor menu [ 1.824751] ACPI: bus type PCI registered [ 1.824959] PCI: Using configuration type 1 for base access [ 1.828070] Kprobes globally optimized [ 1.828932] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 1.831819] ACPI: Added _OSI(Module Device) [ 1.831823] ACPI: Added _OSI(Processor Device) [ 1.831826] ACPI: Added _OSI(3.0 _SCP Extensions) [ 1.831829] ACPI: Added _OSI(Processor Aggregator Device) [ 1.831832] ACPI: Added _OSI(Linux-Dell-Video) [ 1.831835] ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) [ 1.831837] ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) [ 1.832682] ACPI: 2 ACPI AML tables successfully acquired and loaded [ 1.833716] ACPI: Interpreter enabled [ 1.833750] ACPI: (supports S0 S3 S4 S5) [ 1.833753] ACPI: Using IOAPIC for interrupt routing [ 1.833770] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 1.833974] ACPI: Enabled 3 GPEs in block 00 to 0F [ 1.840032] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 1.840048] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 1.840068] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 1.840129] PCI host bridge to bus 0000:00 [ 1.840135] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 1.840138] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 1.840141] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 1.840145] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 1.840148] pci_bus 0000:00: root bus resource [mem 0x800000000-0x87fffffff window] [ 1.840153] pci_bus 0000:00: root bus resource [bus 00-ff] [ 1.840237] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 1.841107] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 1.842107] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 1.846138] pci 0000:00:01.1: reg 0x20: [io 0xd2e0-0xd2ef] [ 1.847773] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 1.847778] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 1.847781] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 1.847784] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 1.848041] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 [ 1.852128] pci 0000:00:01.2: reg 0x20: [io 0xd2c0-0xd2df] [ 1.854456] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 1.855192] pci 0000:00:01.3: quirk: [io 0xb000-0xb03f] claimed by PIIX4 ACPI [ 1.855209] pci 0000:00:01.3: quirk: [io 0xb100-0xb10f] claimed by PIIX4 SMB [ 1.855569] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 [ 1.858479] pci 0000:00:02.0: reg 0x10: [mem 0xc0000000-0xc0ffffff pref] [ 1.861470] pci 0000:00:02.0: reg 0x18: [mem 0xc1443000-0xc1443fff] [ 1.867777] pci 0000:00:02.0: reg 0x30: [mem 0xffff0000-0xffffffff pref] [ 1.868009] pci 0000:00:02.0: BAR 0: assigned to efifb [ 1.868467] pci 0000:00:03.0: [1af4:1002] type 00 class 0x00ff00 [ 1.869244] pci 0000:00:03.0: reg 0x10: [io 0xd240-0xd27f] [ 1.874738] pci 0000:00:03.0: reg 0x20: [mem 0x800000000-0x800003fff 64bit pref] [ 1.876906] pci 0000:00:07.0: [8086:2922] type 00 class 0x010601 [ 1.881742] pci 0000:00:07.0: reg 0x20: [io 0xd2a0-0xd2bf] [ 1.883738] pci 0000:00:07.0: reg 0x24: [mem 0xc1442000-0xc1442fff] [ 1.886229] pci 0000:00:08.0: [1af4:1003] type 00 class 0x078000 [ 1.887358] pci 0000:00:08.0: reg 0x10: [io 0xd200-0xd23f] [ 1.888737] pci 0000:00:08.0: reg 0x14: [mem 0xc1441000-0xc1441fff] [ 1.892370] pci 0000:00:08.0: reg 0x20: [mem 0x800004000-0x800007fff 64bit pref] [ 1.895785] pci 0000:00:12.0: [1af4:1000] type 00 class 0x020000 [ 1.897375] pci 0000:00:12.0: reg 0x10: [io 0xd280-0xd29f] [ 1.898737] pci 0000:00:12.0: reg 0x14: [mem 0xc1440000-0xc1440fff] [ 1.902396] pci 0000:00:12.0: reg 0x20: [mem 0x800008000-0x80000bfff 64bit pref] [ 1.903737] pci 0000:00:12.0: reg 0x30: [mem 0xfffc0000-0xffffffff pref] [ 1.905100] pci 0000:00:1e.0: [1b36:0001] type 01 class 0x060400 [ 1.907738] pci 0000:00:1e.0: reg 0x10: [mem 0x80000d000-0x80000d0ff 64bit] [ 1.910354] pci 0000:00:1f.0: [1b36:0001] type 01 class 0x060400 [ 1.911737] pci 0000:00:1f.0: reg 0x10: [mem 0x80000c000-0x80000c0ff 64bit] [ 1.914880] pci_bus 0000:01: extended config space not accessible [ 1.915306] pci 0000:01:1b.0: [1033:0194] type 00 class 0x0c0330 [ 1.915999] pci 0000:01:1b.0: reg 0x10: [mem 0xc1200000-0xc1203fff 64bit] [ 1.919749] pci 0000:00:1e.0: PCI bridge to [bus 01] [ 1.919786] pci 0000:00:1e.0: bridge window [io 0xd000-0xdfff] [ 1.919813] pci 0000:00:1e.0: bridge window [mem 0xc1200000-0xc13fffff] [ 1.920627] pci_bus 0000:02: extended config space not accessible [ 1.921033] pci 0000:00:1f.0: PCI bridge to [bus 02] [ 1.921061] pci 0000:00:1f.0: bridge window [io 0xc000-0xcfff] [ 1.921087] pci 0000:00:1f.0: bridge window [mem 0xc1000000-0xc11fffff] [ 1.923119] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 10 *11) [ 1.923293] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 10 *11) [ 1.923433] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 *10 11) [ 1.923575] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 *10 11) [ 1.923661] ACPI: PCI Interrupt Link [LNKS] (IRQs *9) [ 1.924627] iommu: Default domain type: Translated [ 1.924890] pci 0000:00:02.0: vgaarb: setting as boot VGA device [ 1.924896] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none [ 1.924901] pci 0000:00:02.0: vgaarb: bridge control possible [ 1.924908] vgaarb: loaded [ 1.925213] SCSI subsystem initialized [ 1.925777] libata version 3.00 loaded. [ 1.925853] ACPI: bus type USB registered [ 1.925909] usbcore: registered new interface driver usbfs [ 1.925909] usbcore: registered new interface driver hub [ 1.925909] usbcore: registered new device driver usb [ 1.925909] mc: Linux media interface: v0.10 [ 1.925909] videodev: Linux video capture interface: v2.00 [ 1.925909] pps_core: LinuxPPS API ver. 1 registered [ 1.925909] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 1.925909] PTP clock support registered [ 1.925957] Registered efivars operations [ 1.925957] Advanced Linux Sound Architecture Driver Initialized. [ 1.926743] Bluetooth: Core ver 2.22 [ 1.926743] NET: Registered protocol family 31 [ 1.926743] Bluetooth: HCI device and connection manager initialized [ 1.926743] Bluetooth: HCI socket layer initialized [ 1.926743] Bluetooth: L2CAP socket layer initialized [ 1.926743] Bluetooth: SCO socket layer initialized [ 1.926743] NetLabel: Initializing [ 1.926743] NetLabel: domain hash size = 128 [ 1.926743] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 1.926807] NetLabel: unlabeled traffic allowed by default [ 1.926940] PCI: Using ACPI for IRQ routing [ 1.926945] PCI: pci_cache_line_size set to 64 bytes [ 1.927004] pci 0000:00:01.1: can't claim BAR 4 [io 0xd2e0-0xd2ef]: address conflict with PCI Bus 0000:01 [io 0xd000-0xdfff] [ 1.927038] pci 0000:00:01.2: can't claim BAR 4 [io 0xd2c0-0xd2df]: address conflict with PCI Bus 0000:01 [io 0xd000-0xdfff] [ 1.927079] pci 0000:00:03.0: can't claim BAR 0 [io 0xd240-0xd27f]: address conflict with PCI Bus 0000:01 [io 0xd000-0xdfff] [ 1.927114] pci 0000:00:07.0: can't claim BAR 4 [io 0xd2a0-0xd2bf]: address conflict with PCI Bus 0000:01 [io 0xd000-0xdfff] [ 1.927132] pci 0000:00:08.0: can't claim BAR 0 [io 0xd200-0xd23f]: address conflict with PCI Bus 0000:01 [io 0xd000-0xdfff] [ 1.927150] pci 0000:00:12.0: can't claim BAR 0 [io 0xd280-0xd29f]: address conflict with PCI Bus 0000:01 [io 0xd000-0xdfff] [ 1.927350] e820: reserve RAM buffer [mem 0x00810000-0x008fffff] [ 1.927355] e820: reserve RAM buffer [mem 0xbe3e4018-0xbfffffff] [ 1.927357] e820: reserve RAM buffer [mem 0xbe40c018-0xbfffffff] [ 1.927359] e820: reserve RAM buffer [mem 0xbe4fb000-0xbfffffff] [ 1.927360] e820: reserve RAM buffer [mem 0xbf8ef000-0xbfffffff] [ 1.927362] e820: reserve RAM buffer [mem 0xbff20000-0xbfffffff] [ 1.927535] hpet: 3 channels of 0 reserved for per-cpu timers [ 1.927561] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 1.927736] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 1.930877] clocksource: Switched to clocksource kvm-clock [ 2.092000] VFS: Disk quotas dquot_6.6.0 [ 2.092044] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 2.092378] AppArmor: AppArmor Filesystem Enabled [ 2.092418] pnp: PnP ACPI init [ 2.092550] pnp 00:00: Plug and Play ACPI device, IDs PNP0303 (active) [ 2.092574] pnp 00:01: Plug and Play ACPI device, IDs PNP0f13 (active) [ 2.092597] pnp 00:02: [dma 2] [ 2.092623] pnp 00:02: Plug and Play ACPI device, IDs PNP0700 (active) [ 2.092642] pnp 00:03: Plug and Play ACPI device, IDs PNP0b00 (active) [ 2.093021] pnp: PnP ACPI: found 4 devices [ 2.099859] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 2.099922] NET: Registered protocol family 2 [ 2.102206] IP idents hash table entries: 262144 (order: 9, 2097152 bytes, linear) [ 2.104856] tcp_listen_portaddr_hash hash table entries: 8192 (order: 5, 131072 bytes, linear) [ 2.105050] TCP established hash table entries: 131072 (order: 8, 1048576 bytes, linear) [ 2.106236] TCP bind hash table entries: 65536 (order: 8, 1048576 bytes, linear) [ 2.107277] TCP: Hash tables configured (established 131072 bind 65536) [ 2.107507] UDP hash table entries: 8192 (order: 6, 262144 bytes, linear) [ 2.107815] UDP-Lite hash table entries: 8192 (order: 6, 262144 bytes, linear) [ 2.108237] NET: Registered protocol family 1 [ 2.109102] RPC: Registered named UNIX socket transport module. [ 2.109110] RPC: Registered udp transport module. [ 2.109114] RPC: Registered tcp transport module. [ 2.109118] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 2.109132] pci 0000:00:02.0: can't claim BAR 6 [mem 0xffff0000-0xffffffff pref]: no compatible bridge window [ 2.109147] pci 0000:00:12.0: can't claim BAR 6 [mem 0xfffc0000-0xffffffff pref]: no compatible bridge window [ 2.109220] pci 0000:00:12.0: BAR 6: assigned [mem 0xc1400000-0xc143ffff pref] [ 2.109230] pci 0000:00:02.0: BAR 6: assigned [mem 0xc1450000-0xc145ffff pref] [ 2.109239] pci 0000:00:03.0: BAR 0: assigned [io 0x1000-0x103f] [ 2.110595] pci 0000:00:08.0: BAR 0: assigned [io 0x1040-0x107f] [ 2.111895] pci 0000:00:01.2: BAR 4: assigned [io 0x1080-0x109f] [ 2.113189] pci 0000:00:07.0: BAR 4: assigned [io 0x10a0-0x10bf] [ 2.114304] pci 0000:00:12.0: BAR 0: assigned [io 0x10c0-0x10df] [ 2.115110] pci 0000:00:01.1: BAR 4: assigned [io 0x10e0-0x10ef] [ 2.115832] pci 0000:00:1e.0: PCI bridge to [bus 01] [ 2.115851] pci 0000:00:1e.0: bridge window [io 0xd000-0xdfff] [ 2.117143] pci 0000:00:1e.0: bridge window [mem 0xc1200000-0xc13fffff] [ 2.119559] pci 0000:00:1f.0: PCI bridge to [bus 02] [ 2.119579] pci 0000:00:1f.0: bridge window [io 0xc000-0xcfff] [ 2.120858] pci 0000:00:1f.0: bridge window [mem 0xc1000000-0xc11fffff] [ 2.122932] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 2.122938] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 2.122942] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 2.122945] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 2.122948] pci_bus 0000:00: resource 8 [mem 0x800000000-0x87fffffff window] [ 2.122952] pci_bus 0000:01: resource 0 [io 0xd000-0xdfff] [ 2.122955] pci_bus 0000:01: resource 1 [mem 0xc1200000-0xc13fffff] [ 2.122958] pci_bus 0000:02: resource 0 [io 0xc000-0xcfff] [ 2.122960] pci_bus 0000:02: resource 1 [mem 0xc1000000-0xc11fffff] [ 2.123084] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 2.123121] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 2.123152] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 2.147218] PCI Interrupt Link [LNKD] enabled at IRQ 10 [ 2.170997] pci 0000:00:01.2: quirk_usb_early_handoff+0x0/0x5f0 took 46671 usecs [ 2.171092] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] [ 2.197691] PCI Interrupt Link [LNKB] enabled at IRQ 11 [ 2.222508] PCI Interrupt Link [LNKA] enabled at IRQ 11 [ 2.247503] pci 0000:01:1b.0: quirk_usb_early_handoff+0x0/0x5f0 took 74514 usecs [ 2.247548] PCI: CLS 0 bytes, default 64 [ 2.247691] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.247695] software IO TLB: mapped [mem 0x00000000b7efe000-0x00000000bbefe000] (64MB) [ 2.247912] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x1e452ea631d, max_idle_ns: 440795244572 ns [ 2.251294] check: Scanning for low memory corruption every 60 seconds [ 2.251895] Initialise system trusted keyrings [ 2.252225] workingset: timestamp_bits=40 max_order=22 bucket_order=0 [ 2.255016] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ 2.255494] NFS: Registering the id_resolver key type [ 2.255507] Key type id_resolver registered [ 2.255510] Key type id_legacy registered [ 2.268516] Key type asymmetric registered [ 2.268533] Asymmetric key parser 'x509' registered [ 2.268557] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) [ 2.268714] io scheduler mq-deadline registered [ 2.268719] io scheduler kyber registered [ 2.269459] hv_vmbus: registering driver hyperv_fb [ 2.269479] efifb: probing for efifb [ 2.269513] efifb: framebuffer at 0xc0000000, using 1876k, total 1875k [ 2.269517] efifb: mode is 800x600x32, linelength=3200, pages=1 [ 2.269519] efifb: scrolling: redraw [ 2.269522] efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 [ 2.271809] Console: switching to colour frame buffer device 100x37 [ 2.272945] fb0: EFI VGA frame buffer device [ 2.273156] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.273249] ACPI: Power Button [PWRF] [ 2.298687] PCI Interrupt Link [LNKC] enabled at IRQ 10 [ 2.350199] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.351122] Non-volatile memory driver v1.3 [ 2.351311] Linux agpgart interface v0.103 [ 2.401197] loop: module loaded [ 2.401561] zram: Added device: zram0 [ 2.401784] zram: Added device: zram1 [ 2.401973] zram: Added device: zram2 [ 2.402029] Guest personality initialized and is inactive [ 2.402909] VMCI host device registered (name=vmci, major=10, minor=62) [ 2.403519] Initialized host personality [ 2.404204] VMware PVSCSI driver - version 1.0.7.0-k [ 2.404838] hv_vmbus: registering driver hv_storvsc [ 2.406205] ahci 0000:00:07.0: version 3.0 [ 2.430826] ahci 0000:00:07.0: AHCI 0001.0000 32 slots 6 ports 1.5 Gbps 0x3f impl SATA mode [ 2.431432] ahci 0000:00:07.0: flags: 64bit ncq only [ 2.434485] scsi host0: ahci [ 2.435499] scsi host1: ahci [ 2.436458] scsi host2: ahci [ 2.437399] scsi host3: ahci [ 2.493358] scsi host4: ahci [ 2.495143] scsi host5: ahci [ 2.495883] ata1: SATA max UDMA/133 abar m4096@0xc1442000 port 0xc1442100 irq 24 [ 2.496411] ata2: SATA max UDMA/133 abar m4096@0xc1442000 port 0xc1442180 irq 24 [ 2.496942] ata3: SATA max UDMA/133 abar m4096@0xc1442000 port 0xc1442200 irq 24 [ 2.497414] ata4: SATA max UDMA/133 abar m4096@0xc1442000 port 0xc1442280 irq 24 [ 2.497913] ata5: SATA max UDMA/133 abar m4096@0xc1442000 port 0xc1442300 irq 24 [ 2.498363] ata6: SATA max UDMA/133 abar m4096@0xc1442000 port 0xc1442380 irq 24 [ 2.498919] ata_piix 0000:00:01.1: version 2.13 [ 2.499949] scsi host6: ata_piix [ 2.500842] scsi host7: ata_piix [ 2.501399] ata7: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0x10e0 irq 14 [ 2.501831] ata8: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0x10e8 irq 15 [ 2.502922] tun: Universal TUN/TAP device driver, 1.6 [ 2.503567] ata7: port disabled--ignoring [ 2.504144] ata8: port disabled--ignoring [ 2.506356] e100: Intel(R) PRO/100 Network Driver [ 2.506781] e100: Copyright(c) 1999-2006 Intel Corporation [ 2.507218] e1000: Intel(R) PRO/1000 Network Driver [ 2.507645] e1000: Copyright (c) 1999-2006 Intel Corporation. [ 2.508141] e1000e: Intel(R) PRO/1000 Network Driver [ 2.508545] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. [ 2.509039] sky2: driver version 1.30 [ 2.509468] VMware vmxnet3 virtual NIC driver - version 1.5.0.0-k-NAPI [ 2.509914] hv_vmbus: registering driver hv_netvsc [ 2.510356] Fusion MPT base driver 3.04.20 [ 2.510751] Copyright (c) 1999-2008 LSI Corporation [ 2.511218] Fusion MPT SPI Host driver 3.04.20 [ 2.511694] Fusion MPT SAS Host driver 3.04.20 [ 2.512282] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver [ 2.512846] ehci-pci: EHCI PCI platform driver [ 2.513455] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver [ 2.513946] ohci-pci: OHCI PCI platform driver [ 2.514431] uhci_hcd: USB Universal Host Controller Interface driver [ 2.539023] uhci_hcd 0000:00:01.2: UHCI Host Controller [ 2.539702] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1 [ 2.540389] uhci_hcd 0000:00:01.2: irq 10, io base 0x00001080 [ 2.541103] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 5.10 [ 2.541573] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 2.542069] usb usb1: Product: UHCI Host Controller [ 2.542559] usb usb1: Manufacturer: Linux 5.10.42 uhci_hcd [ 2.543067] usb usb1: SerialNumber: 0000:00:01.2 [ 2.543785] hub 1-0:1.0: USB hub found [ 2.544307] hub 1-0:1.0: 2 ports detected [ 2.569236] xhci_hcd 0000:01:1b.0: xHCI Host Controller [ 2.569984] xhci_hcd 0000:01:1b.0: new USB bus registered, assigned bus number 2 [ 2.571270] xhci_hcd 0000:01:1b.0: hcc params 0x00080001 hci version 0x100 quirks 0x0000000000000014 [ 2.574168] usb usb2: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.10 [ 2.574795] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 2.575374] usb usb2: Product: xHCI Host Controller [ 2.575962] usb usb2: Manufacturer: Linux 5.10.42 xhci-hcd [ 2.576543] usb usb2: SerialNumber: 0000:01:1b.0 [ 2.577317] hub 2-0:1.0: USB hub found [ 2.577984] hub 2-0:1.0: 4 ports detected [ 2.578958] xhci_hcd 0000:01:1b.0: xHCI Host Controller [ 2.579622] xhci_hcd 0000:01:1b.0: new USB bus registered, assigned bus number 3 [ 2.580205] xhci_hcd 0000:01:1b.0: Host supports USB 3.0 SuperSpeed [ 2.580957] usb usb3: We don't know the algorithms for LPM for this host, disabling LPM. [ 2.581555] usb usb3: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 5.10 [ 2.582156] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 2.582738] usb usb3: Product: xHCI Host Controller [ 2.583330] usb usb3: Manufacturer: Linux 5.10.42 xhci-hcd [ 2.583923] usb usb3: SerialNumber: 0000:01:1b.0 [ 2.584678] hub 3-0:1.0: USB hub found [ 2.585373] hub 3-0:1.0: 4 ports detected [ 2.586378] usbcore: registered new interface driver usblp [ 2.587039] usbcore: registered new interface driver usb-storage [ 2.587683] usbcore: registered new interface driver usbserial_generic [ 2.588276] usbserial: USB Serial support registered for generic [ 2.588889] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 2.590799] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 2.591543] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 2.592905] rtc_cmos 00:03: RTC can wake from S4 [ 2.594188] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 2.595655] rtc_cmos 00:03: registered as rtc0 [ 2.596355] rtc_cmos 00:03: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 2.597533] device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com [ 2.598205] usbcore: registered new interface driver btusb [ 2.598832] intel_pstate: CPU model not supported [ 2.599438] EFI Variables Facility v0.08 2004-May-17 [ 2.602987] hid: raw HID events driver (C) Jiri Kosina [ 2.603834] usbcore: registered new interface driver usbhid [ 2.604430] usbhid: USB HID core driver [ 2.697919] hpet: Lost 5 RTC interrupts [ 2.699607] IPVS: Registered protocols () [ 2.700263] IPVS: Connection hash table configured (size=4096, memory=64Kbytes) [ 2.700978] IPVS: ipvs loaded. [ 2.701540] IPVS: [rr] scheduler registered. [ 2.703345] NET: Registered protocol family 10 [ 2.705111] Segment Routing with IPv6 [ 2.706423] sit: IPv6, IPv4 and MPLS over IPv4 tunneling driver [ 2.707413] NET: Registered protocol family 17 [ 2.708337] Bridge firewalling registered [ 2.709029] Key type dns_resolver registered [ 2.897404] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [ 2.901288] ata6: SATA link down (SStatus 0 SControl 300) [ 2.901151] IPI shorthand broadcast: enabled [ 2.902601] sched_clock: Marking stable (2899715262, 2150809)->(2921347706, -19481635) [ 2.904370] ata4: SATA link down (SStatus 0 SControl 300) [ 2.904543] registered taskstats version 1 [ 2.905807] Loading compiled-in X.509 certificates [ 2.905943] ata5: SATA link down (SStatus 0 SControl 300) [ 2.906556] AppArmor: AppArmor sha1 policy hashing enabled [ 2.908101] ata2: SATA link down (SStatus 0 SControl 300) [ 2.909115] PM: Magic number: 9:16:328 [ 2.909891] printk: console [netcon0] enabled [ 2.910269] ata3: SATA link down (SStatus 0 SControl 300) [ 2.910465] netconsole: network logging started [ 2.911872] ata1.00: ATA-7: QEMU HARDDISK, 2.5+, max UDMA/100 [ 2.911902] ALSA device list: [ 2.912462] ata1.00: 67108864 sectors, multi 16: LBA48 NCQ (depth 32) [ 2.913052] No soundcards found. [ 2.913638] ata1.00: applying bridge limits [ 2.915008] ata1.00: configured for UDMA/100 [ 2.915792] scsi 0:0:0:0: Direct-Access ATA QEMU HARDDISK 2.5+ PQ: 0 ANSI: 5 [ 2.916991] sd 0:0:0:0: [sda] 67108864 512-byte logical blocks: (34.4 GB/32.0 GiB) [ 2.917801] sd 0:0:0:0: [sda] Write Protect is off [ 2.918346] sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00 [ 2.918370] sd 0:0:0:0: Attached scsi generic sg0 type 0 [ 2.919018] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [ 2.924449] sda: sda1 sda2 sda3 sda4 sda5 sda6 sda7 sda8 [ 2.926003] sd 0:0:0:0: [sda] Attached SCSI disk [ 2.950800] usb 1-1: new full-speed USB device number 2 using uhci_hcd [ 3.012831] usb 2-1: new full-speed USB device number 2 using xhci_hcd [ 3.089230] usb 1-1: not running at top speed; connect to a high speed hub [ 3.124936] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 [ 3.125604] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 [ 3.126226] usb 1-1: Product: QEMU USB Tablet [ 3.126839] usb 1-1: Manufacturer: QEMU [ 3.127416] usb 1-1: SerialNumber: 28754-0000:00:01.2-1 [ 3.136971] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:01.2/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input4 [ 3.138531] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:01.2-1/input0 [ 3.142610] usb 2-1: New USB device found, idVendor=1a86, idProduct=7523, bcdDevice= 2.64 [ 3.143307] usb 2-1: New USB device strings: Mfr=0, Product=2, SerialNumber=0 [ 3.143982] usb 2-1: Product: USB Serial [ 3.325729] random: fast init done [ 3.328141] input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input3 [ 3.329377] md: Waiting for all devices to be available before autodetect [ 3.330583] md: If you don't use raid, use raid=noautodetect [ 3.331760] md: Autodetecting RAID arrays. [ 3.332910] md: autorun ... [ 3.334021] md: ... autorun DONE. [ 3.339137] VFS: Mounted root (squashfs filesystem) readonly on device 8:5. [ 3.340788] devtmpfs: mounted [ 3.342639] Freeing unused kernel image (initmem) memory: 1388K [ 3.344789] Write protecting the kernel read-only data: 22528k [ 3.348512] Freeing unused kernel image (text/rodata gap) memory: 2036K [ 3.349828] Freeing unused kernel image (rodata/data gap) memory: 212K [ 3.350706] Run /sbin/init as init process [ 3.351744] with arguments: [ 3.351747] /sbin/init [ 3.351747] with environment: [ 3.351749] HOME=/ [ 3.351750] TERM=linux [ 3.439664] 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) [ 3.442824] systemd[1]: Detected virtualization kvm. [ 3.443545] systemd[1]: Detected architecture x86-64. [ 3.462138] systemd[1]: Set hostname to . [ 3.462985] systemd[1]: Installed transient /etc/machine-id file. [ 3.634081] systemd[1]: Queued start job for default target Multi-User System. [ 3.636003] random: systemd: uninitialized urandom read (16 bytes read) [ 3.656540] systemd[1]: Created slice system-ha\x2dcli.slice. [ 3.658204] random: systemd: uninitialized urandom read (16 bytes read) [ 3.659946] systemd[1]: Created slice system-modprobe.slice. [ 3.661518] random: systemd: uninitialized urandom read (16 bytes read) [ 3.663112] systemd[1]: Created slice system-systemd\x2dfsck.slice. [ 3.665627] systemd[1]: Created slice system-systemd\x2dgrowfs.slice. [ 3.667958] systemd[1]: Created slice User and Session Slice. [ 3.669568] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. [ 3.671110] systemd[1]: Started Forward Password Requests to Wall Directory Watch. [ 3.672822] systemd[1]: Reached target Local Encrypted Volumes. [ 3.675478] systemd[1]: Reached target HassOS hardware targets. [ 3.678198] systemd[1]: Reached target HassOS zram targets. [ 3.680968] systemd[1]: Reached target Paths. [ 3.682529] systemd[1]: Reached target Remote Encrypted Volumes. [ 3.684091] systemd[1]: Reached target Remote File Systems. [ 3.685639] systemd[1]: Reached target Slices. [ 3.688500] systemd[1]: Listening on D-Bus System Message Bus Socket. [ 3.690166] systemd[1]: Listening on Device-mapper event daemon FIFOs. [ 3.694084] systemd[1]: Listening on Process Core Dump Socket. [ 3.696006] systemd[1]: Listening on Journal Audit Socket. [ 3.697855] systemd[1]: Listening on Journal Socket (/dev/log). [ 3.699702] systemd[1]: Listening on Journal Socket. [ 3.701911] systemd[1]: Listening on udev Control Socket. [ 3.703530] systemd[1]: Listening on udev Kernel Socket. [ 3.707063] systemd[1]: Mounting Huge Pages File System... [ 3.711018] systemd[1]: Mounting POSIX Message Queue File System... [ 3.714825] systemd[1]: Mounting Kernel Debug File System... [ 3.718139] systemd[1]: Mounting Kernel Trace File System... [ 3.721647] systemd[1]: Starting Availability of block devices... [ 3.726163] systemd[1]: Started D-Bus System Message Bus. [ 3.735784] systemd[1]: Starting Home Assistant OS Agent... [ 3.741481] systemd[1]: Condition check resulted in Create list of static device nodes for the current kernel being skipped. [ 3.745072] systemd[1]: Starting Monitoring of LVM2 mirrors, snapshots etc. using dmeventd or progress polling... [ 3.750503] systemd[1]: Starting Load Kernel Module configfs... [ 3.754114] systemd[1]: Starting Load Kernel Module drm... [ 3.758323] systemd[1]: Starting Load Kernel Module fuse... [ 3.765656] systemd[1]: Starting Journal Service... [ 3.771422] systemd[1]: Starting Remount Root and Kernel File Systems... [ 3.804248] systemd[1]: Starting Wait Until Kernel Time Synchronized... [ 3.810331] systemd[1]: Starting Create Static Device Nodes in /dev... [ 3.816731] systemd[1]: Starting Coldplug All udev Devices... [ 3.824108] systemd[1]: Starting Disk Manager... [ 3.829434] systemd[1]: Starting HassOS ZRAM swap... [ 3.833871] systemd[1]: Starting HassOS ZRAM tmp... [ 3.837890] systemd[1]: Starting HassOS ZRAM var... [ 3.843142] systemd[1]: Mounted Huge Pages File System. [ 3.844953] systemd[1]: Mounted POSIX Message Queue File System. [ 3.846781] systemd[1]: Mounted Kernel Debug File System. [ 3.848373] zram2: detected capacity change from 0 to 16777216 [ 3.848545] systemd[1]: Mounted Kernel Trace File System. [ 3.851886] zram1: detected capacity change from 0 to 33554432 [ 3.852161] systemd[1]: Finished Availability of block devices. [ 3.854977] systemd[1]: modprobe@configfs.service: Succeeded. [ 3.856722] systemd[1]: Finished Load Kernel Module configfs. [ 3.858720] systemd[1]: modprobe@drm.service: Succeeded. [ 3.860109] systemd[1]: Finished Load Kernel Module drm. [ 3.861813] systemd[1]: Started Journal Service. [ 3.864856] zram0: detected capacity change from 0 to 3138297856 [ 3.901893] audit: type=1334 audit(1624274318.595:2): prog-id=5 op=LOAD [ 3.902818] audit: type=1334 audit(1624274318.596:3): prog-id=6 op=LOAD [ 4.073065] virtio_net virtio2 enp0s18: renamed from eth0 [ 4.162948] usbcore: registered new interface driver ch341 [ 4.164335] usbserial: USB Serial support registered for ch341-uart [ 4.165102] ch341 2-1:1.0: ch341-uart converter detected [ 4.174755] usb 2-1: ch341-uart converter now attached to ttyUSB0 [ 4.282484] FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. [ 4.297095] EXT4-fs (sda7): mounted filesystem with ordered data mode. Opts: (null) [ 4.298170] ext4 filesystem being mounted at /mnt/overlay supports timestamps until 2038 (0x7fffffff) [ 4.753519] random: crng init done [ 4.753525] random: 7 urandom warning(s) missed due to ratelimiting [ 4.798006] Adding 3064740k swap on /dev/zram0. Priority:-2 extents:1 across:3064740k SS [ 4.889549] EXT4-fs (zram2): mounted filesystem without journal. Opts: nobarrier [ 4.889560] ext4 filesystem being mounted at /tmp supports timestamps until 2038 (0x7fffffff) [ 4.892674] EXT4-fs (zram1): mounted filesystem without journal. Opts: nobarrier [ 4.892682] ext4 filesystem being mounted at /var supports timestamps until 2038 (0x7fffffff) [ 5.855787] EXT4-fs (sda8): warning: mounting fs with errors, running e2fsck is recommended [ 5.859905] EXT4-fs (sda8): mounted filesystem with ordered data mode. Opts: (null) [ 5.883500] EXT4-fs warning (device sda8): ext4_resize_begin:72: There are errors in the filesystem, so online resizing is not allowed [ 5.899649] systemd-journald[163]: Received client request to flush runtime journal. [ 17.698829] audit: type=1334 audit(1624274332.391:4): prog-id=4 op=UNLOAD [ 17.698835] audit: type=1334 audit(1624274332.391:5): prog-id=3 op=UNLOAD [ 17.713310] audit: type=1334 audit(1624274332.406:6): prog-id=6 op=UNLOAD [ 17.714074] audit: type=1334 audit(1624274332.407:7): prog-id=5 op=UNLOAD [ 17.943886] audit: type=1334 audit(1624274332.637:8): prog-id=7 op=LOAD [ 17.944276] audit: type=1334 audit(1624274332.637:9): prog-id=8 op=LOAD [ 17.983488] audit: type=1334 audit(1624274332.676:10): prog-id=9 op=LOAD [ 17.984039] audit: type=1334 audit(1624274332.676:11): prog-id=10 op=LOAD [ 18.038847] EXT4-fs warning (device sda8): ext4_resize_begin:72: There are errors in the filesystem, so online resizing is not allowed [ 18.098182] audit: type=1334 audit(1624274332.791:12): prog-id=11 op=LOAD [ 18.098393] audit: type=1334 audit(1624274332.791:13): prog-id=12 op=LOAD [ 18.314947] cfg80211: Loading compiled-in X.509 certificates for regulatory database [ 18.320432] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' [ 20.230610] Initializing XFRM netlink socket [ 20.587349] hassio: port 1(veth6ab59e3) entered blocking state [ 20.587352] hassio: port 1(veth6ab59e3) entered disabled state [ 20.587425] device veth6ab59e3 entered promiscuous mode [ 20.587556] hassio: port 1(veth6ab59e3) entered blocking state [ 20.587558] hassio: port 1(veth6ab59e3) entered forwarding state [ 20.587583] IPv6: ADDRCONF(NETDEV_CHANGE): hassio: link becomes ready [ 20.588046] hassio: port 1(veth6ab59e3) entered disabled state [ 21.249449] cgroup: cgroup: disabling cgroup2 socket matching due to net_prio or net_cls activation [ 21.620918] eth0: renamed from veth27c27d6 [ 21.628315] IPv6: ADDRCONF(NETDEV_CHANGE): veth6ab59e3: link becomes ready [ 21.628426] hassio: port 1(veth6ab59e3) entered blocking state [ 21.628429] hassio: port 1(veth6ab59e3) entered forwarding state [ 48.733517] kauditd_printk_skb: 80 callbacks suppressed [ 48.733525] audit: type=1334 audit(1624274363.427:92): prog-id=14 op=UNLOAD [ 48.733547] audit: type=1334 audit(1624274363.427:93): prog-id=13 op=UNLOAD [ 49.243157] docker0: port 1(vethb363b91) entered blocking state [ 49.243162] docker0: port 1(vethb363b91) entered disabled state [ 49.243404] device vethb363b91 entered promiscuous mode [ 49.243506] audit: type=1700 audit(1624274363.936:94): dev=vethb363b91 prom=256 old_prom=0 auid=4294967295 uid=0 gid=0 ses=4294967295 [ 49.306310] hassio: port 2(veth0785bbb) entered blocking state [ 49.306314] hassio: port 2(veth0785bbb) entered disabled state [ 49.306493] device veth0785bbb entered promiscuous mode [ 49.306562] audit: type=1700 audit(1624274364.000:95): dev=veth0785bbb prom=256 old_prom=0 auid=4294967295 uid=0 gid=0 ses=4294967295 [ 49.306603] hassio: port 2(veth0785bbb) entered blocking state [ 49.306605] hassio: port 2(veth0785bbb) entered forwarding state [ 49.714658] eth0: renamed from veth631cd8d [ 49.723474] hassio: port 2(veth0785bbb) entered disabled state [ 49.723564] IPv6: ADDRCONF(NETDEV_CHANGE): vethb363b91: link becomes ready [ 49.723604] docker0: port 1(vethb363b91) entered blocking state [ 49.723605] docker0: port 1(vethb363b91) entered forwarding state [ 49.723661] IPv6: ADDRCONF(NETDEV_CHANGE): docker0: link becomes ready [ 49.806995] audit: type=1325 audit(1624274364.502:96): table=nat family=2 entries=0 op=xt_register pid=1160 subj==unconfined comm="iptables" [ 49.814141] audit: type=1325 audit(1624274364.509:97): table=filter family=2 entries=0 op=xt_register pid=1161 subj==unconfined comm="iptables" [ 49.819907] audit: type=1325 audit(1624274364.514:98): table=nat family=2 entries=5 op=xt_replace pid=1164 subj==unconfined comm="iptables" [ 49.822540] audit: type=1325 audit(1624274364.517:99): table=nat family=2 entries=7 op=xt_replace pid=1165 subj==unconfined comm="iptables" [ 49.826509] audit: type=1325 audit(1624274364.521:100): table=nat family=2 entries=8 op=xt_replace pid=1167 subj==unconfined comm="iptables" [ 49.828803] audit: type=1325 audit(1624274364.523:101): table=nat family=2 entries=10 op=xt_replace pid=1168 subj==unconfined comm="iptables" [ 49.853547] eth1: renamed from veth434fbc8 [ 49.860190] IPv6: ADDRCONF(NETDEV_CHANGE): veth0785bbb: link becomes ready [ 49.860240] hassio: port 2(veth0785bbb) entered blocking state [ 49.860242] hassio: port 2(veth0785bbb) entered forwarding state [ 53.751961] kauditd_printk_skb: 8 callbacks suppressed [ 53.751966] audit: type=1400 audit(1624274368.449:110): apparmor="STATUS" operation="profile_replace" info="same as current profile, skipping" profile="unconfined" name="1f3d020e_hassos_ssh_configurator_addon" pid=1760 comm="apparmor_parser" [ 53.766928] audit: type=1400 audit(1624274368.461:111): apparmor="STATUS" operation="profile_replace" info="same as current profile, skipping" profile="unconfined" name="hassio-supervisor" pid=1762 comm="apparmor_parser" [ 53.766939] audit: type=1400 audit(1624274368.461:111): apparmor="STATUS" operation="profile_replace" info="same as current profile, skipping" profile="unconfined" name="hassio-supervisor///usr/bin/gdbus" pid=1762 comm="apparmor_parser" [ 53.766949] audit: type=1400 audit(1624274368.461:111): apparmor="STATUS" operation="profile_replace" info="same as current profile, skipping" profile="unconfined" name="hassio-supervisor///usr/bin/git" pid=1762 comm="apparmor_parser" [ 54.765841] hassio: port 3(vethcae8fc1) entered blocking state [ 54.765846] hassio: port 3(vethcae8fc1) entered disabled state [ 54.766134] device vethcae8fc1 entered promiscuous mode [ 54.766266] audit: type=1700 audit(1624274369.466:112): dev=vethcae8fc1 prom=256 old_prom=0 auid=4294967295 uid=0 gid=0 ses=4294967295 [ 55.237031] audit: type=1325 audit(1624274369.937:113): table=nat family=2 entries=0 op=xt_register pid=1848 subj==unconfined comm="iptables" [ 55.243421] audit: type=1325 audit(1624274369.944:114): table=filter family=2 entries=0 op=xt_register pid=1849 subj==unconfined comm="iptables" [ 55.249304] audit: type=1325 audit(1624274369.950:115): table=nat family=2 entries=5 op=xt_replace pid=1852 subj==unconfined comm="iptables" [ 55.251317] audit: type=1325 audit(1624274369.952:116): table=nat family=2 entries=7 op=xt_replace pid=1853 subj==unconfined comm="iptables" [ 55.254638] audit: type=1325 audit(1624274369.955:117): table=nat family=2 entries=8 op=xt_replace pid=1855 subj==unconfined comm="iptables" [ 55.280726] eth0: renamed from veth91e9d21 [ 55.290263] IPv6: ADDRCONF(NETDEV_CHANGE): vethcae8fc1: link becomes ready [ 55.290300] hassio: port 3(vethcae8fc1) entered blocking state [ 55.290303] hassio: port 3(vethcae8fc1) entered forwarding state [ 55.812973] hassio: port 4(veth1556d51) entered blocking state [ 55.812977] hassio: port 4(veth1556d51) entered disabled state [ 55.813088] device veth1556d51 entered promiscuous mode [ 56.823806] eth0: renamed from veth60e35fb [ 56.830956] IPv6: ADDRCONF(NETDEV_CHANGE): veth1556d51: link becomes ready [ 56.831007] hassio: port 4(veth1556d51) entered blocking state [ 56.831009] hassio: port 4(veth1556d51) entered forwarding state [ 57.474386] hassio: port 5(veth40381c2) entered blocking state [ 57.474390] hassio: port 5(veth40381c2) entered disabled state [ 57.474526] device veth40381c2 entered promiscuous mode [ 57.474755] hassio: port 5(veth40381c2) entered blocking state [ 57.474757] hassio: port 5(veth40381c2) entered forwarding state [ 57.833827] hassio: port 5(veth40381c2) entered disabled state [ 57.901935] eth0: renamed from veth1d6912a [ 57.912119] IPv6: ADDRCONF(NETDEV_CHANGE): veth40381c2: link becomes ready [ 57.912171] hassio: port 5(veth40381c2) entered blocking state [ 57.912174] hassio: port 5(veth40381c2) entered forwarding state [ 66.324447] hassio: port 6(veth278ea64) entered blocking state [ 66.324454] hassio: port 6(veth278ea64) entered disabled state [ 66.324608] device veth278ea64 entered promiscuous mode [ 66.324683] kauditd_printk_skb: 27 callbacks suppressed [ 66.324689] audit: type=1700 audit(1624274381.031:145): dev=veth278ea64 prom=256 old_prom=0 auid=4294967295 uid=0 gid=0 ses=4294967295 [ 66.375130] audit: type=1325 audit(1624274381.082:146): table=nat family=2 entries=17 op=xt_replace pid=3325 subj==unconfined comm="iptables" [ 66.380113] audit: type=1325 audit(1624274381.087:147): table=filter family=2 entries=36 op=xt_replace pid=3327 subj==unconfined comm="iptables" [ 66.384544] audit: type=1325 audit(1624274381.091:148): table=nat family=2 entries=18 op=xt_replace pid=3329 subj==unconfined comm="iptables" [ 66.787920] audit: type=1325 audit(1624274381.496:149): table=nat family=2 entries=0 op=xt_register pid=3410 subj==unconfined comm="iptables" [ 66.793857] audit: type=1325 audit(1624274381.502:150): table=filter family=2 entries=0 op=xt_register pid=3411 subj==unconfined comm="iptables" [ 66.799412] audit: type=1325 audit(1624274381.507:151): table=nat family=2 entries=5 op=xt_replace pid=3414 subj==unconfined comm="iptables" [ 66.801328] audit: type=1325 audit(1624274381.509:152): table=nat family=2 entries=7 op=xt_replace pid=3415 subj==unconfined comm="iptables" [ 66.804907] audit: type=1325 audit(1624274381.513:153): table=nat family=2 entries=8 op=xt_replace pid=3417 subj==unconfined comm="iptables" [ 66.806809] audit: type=1325 audit(1624274381.515:154): table=nat family=2 entries=10 op=xt_replace pid=3418 subj==unconfined comm="iptables" [ 66.833252] eth0: renamed from vethd23b369 [ 66.840964] IPv6: ADDRCONF(NETDEV_CHANGE): veth278ea64: link becomes ready [ 66.841022] hassio: port 6(veth278ea64) entered blocking state [ 66.841024] hassio: port 6(veth278ea64) entered forwarding state [ 72.343179] hassio: port 7(veth8bfc87e) entered blocking state [ 72.343185] hassio: port 7(veth8bfc87e) entered disabled state [ 72.343415] device veth8bfc87e entered promiscuous mode [ 72.343561] kauditd_printk_skb: 4 callbacks suppressed [ 72.343563] audit: type=1700 audit(1624274387.053:159): dev=veth8bfc87e prom=256 old_prom=0 auid=4294967295 uid=0 gid=0 ses=4294967295 [ 72.795794] audit: type=1325 audit(1624274387.506:160): table=nat family=2 entries=0 op=xt_register pid=6330 subj==unconfined comm="iptables" [ 72.801959] audit: type=1325 audit(1624274387.512:161): table=filter family=2 entries=0 op=xt_register pid=6331 subj==unconfined comm="iptables" [ 72.808213] audit: type=1325 audit(1624274387.518:162): table=nat family=2 entries=5 op=xt_replace pid=6334 subj==unconfined comm="iptables" [ 72.810553] audit: type=1325 audit(1624274387.521:163): table=nat family=2 entries=7 op=xt_replace pid=6335 subj==unconfined comm="iptables" [ 72.814418] audit: type=1325 audit(1624274387.524:164): table=nat family=2 entries=8 op=xt_replace pid=6337 subj==unconfined comm="iptables" [ 72.816177] audit: type=1325 audit(1624274387.526:165): table=nat family=2 entries=10 op=xt_replace pid=6338 subj==unconfined comm="iptables" [ 72.819368] audit: type=1325 audit(1624274387.529:166): table=nat family=2 entries=11 op=xt_replace pid=6339 subj==unconfined comm="iptables" [ 72.821891] audit: type=1325 audit(1624274387.532:167): table=nat family=2 entries=12 op=xt_replace pid=6340 subj==unconfined comm="iptables" [ 72.824333] audit: type=1325 audit(1624274387.534:168): table=nat family=2 entries=13 op=xt_replace pid=6341 subj==unconfined comm="iptables" [ 72.837369] eth0: renamed from vethf45d430 [ 72.850843] IPv6: ADDRCONF(NETDEV_CHANGE): veth8bfc87e: link becomes ready [ 72.850913] hassio: port 7(veth8bfc87e) entered blocking state [ 72.850915] hassio: port 7(veth8bfc87e) entered forwarding state [ 73.331231] hassio: port 8(vethca85a59) entered blocking state [ 73.331235] hassio: port 8(vethca85a59) entered disabled state [ 73.331419] device vethca85a59 entered promiscuous mode [ 73.331924] hassio: port 8(vethca85a59) entered blocking state [ 73.331926] hassio: port 8(vethca85a59) entered forwarding state [ 73.344333] hassio: port 8(vethca85a59) entered disabled state [ 74.589143] eth0: renamed from vethdcf8511 [ 74.605629] IPv6: ADDRCONF(NETDEV_CHANGE): vethca85a59: link becomes ready [ 74.605717] hassio: port 8(vethca85a59) entered blocking state [ 74.605720] hassio: port 8(vethca85a59) entered forwarding state [ 75.462132] hassio: port 9(veth36e339a) entered blocking state [ 75.462145] hassio: port 9(veth36e339a) entered disabled state [ 75.462277] device veth36e339a entered promiscuous mode [ 75.462473] hassio: port 9(veth36e339a) entered blocking state [ 75.462475] hassio: port 9(veth36e339a) entered forwarding state [ 75.609676] hassio: port 9(veth36e339a) entered disabled state [ 76.436492] eth0: renamed from vethe54f1cb [ 76.448707] IPv6: ADDRCONF(NETDEV_CHANGE): veth36e339a: link becomes ready [ 76.448773] hassio: port 9(veth36e339a) entered blocking state [ 76.448776] hassio: port 9(veth36e339a) entered forwarding state [ 82.908057] kauditd_printk_skb: 26 callbacks suppressed [ 82.908062] audit: type=1334 audit(1624274397.618:195): prog-id=18 op=UNLOAD [ 82.908071] audit: type=1334 audit(1624274397.618:196): prog-id=17 op=UNLOAD [ 89.853767] audit: type=1334 audit(1624274404.567:197): prog-id=16 op=UNLOAD [ 89.853775] audit: type=1334 audit(1624274404.567:198): prog-id=15 op=UNLOAD [ 108.158913] hassio: port 10(veth981eedd) entered blocking state [ 108.158919] hassio: port 10(veth981eedd) entered disabled state [ 108.159113] device veth981eedd entered promiscuous mode [ 108.159292] audit: type=1700 audit(1624274422.873:199): dev=veth981eedd prom=256 old_prom=0 auid=4294967295 uid=0 gid=0 ses=4294967295 [ 108.606659] audit: type=1325 audit(1624274423.321:200): table=nat family=2 entries=0 op=xt_register pid=8713 subj==unconfined comm="iptables" [ 108.618301] audit: type=1325 audit(1624274423.332:201): table=filter family=2 entries=0 op=xt_register pid=8716 subj==unconfined comm="iptables" [ 108.624207] audit: type=1325 audit(1624274423.338:202): table=nat family=2 entries=5 op=xt_replace pid=8719 subj==unconfined comm="iptables" [ 108.626523] audit: type=1325 audit(1624274423.341:203): table=nat family=2 entries=7 op=xt_replace pid=8720 subj==unconfined comm="iptables" [ 108.630023] audit: type=1325 audit(1624274423.344:204): table=nat family=2 entries=8 op=xt_replace pid=8722 subj==unconfined comm="iptables" [ 108.632006] audit: type=1325 audit(1624274423.346:205): table=nat family=2 entries=10 op=xt_replace pid=8723 subj==unconfined comm="iptables" [ 108.634690] audit: type=1325 audit(1624274423.349:206): table=nat family=2 entries=11 op=xt_replace pid=8724 subj==unconfined comm="iptables" [ 108.637005] audit: type=1325 audit(1624274423.351:207): table=nat family=2 entries=12 op=xt_replace pid=8725 subj==unconfined comm="iptables" [ 108.640049] audit: type=1325 audit(1624274423.354:208): table=nat family=2 entries=13 op=xt_replace pid=8726 subj==unconfined comm="iptables" [ 108.656938] eth0: renamed from veth1054229 [ 108.664842] IPv6: ADDRCONF(NETDEV_CHANGE): veth981eedd: link becomes ready [ 108.664900] hassio: port 10(veth981eedd) entered blocking state [ 108.664902] hassio: port 10(veth981eedd) entered forwarding state [ 111.183636] hassio: port 11(veth7f0d993) entered blocking state [ 111.183642] hassio: port 11(veth7f0d993) entered disabled state [ 111.183797] device veth7f0d993 entered promiscuous mode [ 111.722585] eth0: renamed from vethf8748ac [ 111.733199] IPv6: ADDRCONF(NETDEV_CHANGE): veth7f0d993: link becomes ready [ 111.733236] hassio: port 11(veth7f0d993) entered blocking state [ 111.733238] hassio: port 11(veth7f0d993) entered forwarding state [ 117.243003] kauditd_printk_skb: 15 callbacks suppressed [ 117.243015] audit: type=1334 audit(1624274431.957:224): prog-id=19 op=LOAD [ 117.243322] audit: type=1334 audit(1624274431.958:225): prog-id=20 op=LOAD [ 117.595591] audit: type=1334 audit(1624274432.310:226): prog-id=21 op=LOAD [ 117.596119] audit: type=1334 audit(1624274432.310:227): prog-id=22 op=LOAD ```
agners commented 3 years ago

Hm, it seems that this is the culprit:

[ 5.883500] EXT4-fs warning (device sda8): ext4_resize_begin:72: There are errors in the filesystem, so online resizing is not allowed
...
[ 18.038847] EXT4-fs warning (device sda8): ext4_resize_begin:72: There are errors in the filesystem, so online resizing is not allowed

Normally the file system should get checked on startup, can you check the logs using:

systemctl status systemd-fsck@dev-disk-by\\x2dlabel-hassos\\x2ddata.service

I think manually running the check again should involve something like

systemctl stop mnt-data.service
systemctl stop systemd-fsck@dev-disk-by\\x2dlabel-hassos\\x2ddata.service
systemctl start systemd-fsck@dev-disk-by\\x2dlabel-hassos\\x2ddata.service
MrAlfabet commented 3 years ago

During startup I get the message [FAILED] Failed to start File System Check on /dev/disk/by-label/hassos-data, and then to run the command you specified above.

systemctl status systemd-fsck@dev-disk-by\\x2dlabel-hassos\\x2ddata.service
systemd-fsck@dev-disk-by\x2dlabel-hassos\x2ddata.service - File System Check on /dev/disk/by-label/hassos-data
     Loaded: loaded (/usr/lib/systemd/system/systemd-fsck@.service; static)
     Active: active (exited) since Mon 2021-06-21 11:18:52 UTC; 1h 28min ago
       Docs: man:systemd-fsck@.service(8)
    Process: 415 ExecStart=/usr/lib/systemd/systemd-fsck /dev/disk/by-label/hassos-data (code=exited, status=0/SUCCESS)
   Main PID: 415 (code=exited, status=0/SUCCESS)

Jun 21 11:18:52 homeassistant systemd[1]: Starting File System Check on /dev/disk/by-label/hassos-data...
Jun 21 11:18:52 homeassistant systemd[1]: Finished File System Check on /dev/disk/by-label/hassos-data.
agners commented 3 years ago

During startup I get the message [FAILED] Failed to start File System Check on /dev/disk/by-label/hassos-data, and then to run the command you specified above.

That explains why growing the partition then fails.

What is fsck saying?

umount -A /dev/disk/by-label/hassos-data
fsck.ext4 /dev/disk/by-label/hassos-data
MrAlfabet commented 3 years ago

During startup I get the message [FAILED] Failed to start File System Check on /dev/disk/by-label/hassos-data, and then to run the command you specified above.

That explains why growing the partition then fails.

What is fsck saying?

umount -A /dev/disk/by-label/hassos-data
fsck.ext4 /dev/disk/by-label/hassos-data

What do I have to stop to unmount /mnt/data? I stopped HA core, but still get 'target is busy' when trying to unmount.

agners commented 3 years ago

Hm, if you started Home Assistant OS completely, then there are quite some services which use that partition.

I think we can ask systemd to fix the file system. Can you edit cmdline.txt on the boot partition (on the target in /mnt/boot, or the first partition of the disk) and add fsck.repair=yes and then reboot?

MrAlfabet commented 3 years ago

Hm, if you started Home Assistant OS completely, then there are quite some services which use that partition.

I think we can ask systemd to fix the file system. Can you edit cmdline.txt on the boot partition (on the target in /mnt/boot, or the first partition of the disk) and add fsck.repair=yes and then reboot?

Check passed, now I just get the growfs FAILED error on boot (like I did in the beginning)

systemctl status systemd-growfs@mnt-data.service
● systemd-growfs@mnt-data.service - Grow File System on /mnt/data
     Loaded: loaded (/usr/lib/systemd/system/systemd-growfs@.service; static)
     Active: failed (Result: exit-code) since Mon 2021-06-21 13:49:53 UTC; 1min 59s ago
       Docs: man:systemd-growfs@.service(8)
    Process: 417 ExecStart=/usr/lib/systemd/systemd-growfs /mnt/data (code=exited, status=1/FAILURE)
   Main PID: 417 (code=exited, status=1/FAILURE)

Jun 21 13:49:53 homeassistant systemd[1]: Starting Grow File System on /mnt/data...
Jun 21 13:49:53 homeassistant systemd-growfs[417]: Failed to resize "/mnt/data" to 33628864000 bytes: Operation not permitted
Jun 21 13:49:53 homeassistant systemd[1]: systemd-growfs@mnt-data.service: Main process exited, code=exited, status=1/FAILURE
Jun 21 13:49:53 homeassistant systemd[1]: systemd-growfs@mnt-data.service: Failed with result 'exit-code'.
Jun 21 13:49:53 homeassistant systemd[1]: Failed to start Grow File System on /mnt/data.
dmesg
[    0.000000] Linux version 5.10.42 (builder@0ec2c4e8c84a) (x86_64-buildroot-linux-gnu-gcc.br_real (Buildroot -gcb0fa11e) 9.3.0, GNU ld (GNU Binutils) 2.35.2) #1 SMP Wed Jun 9 00:30:56 UTC 2021
[    0.000000] Command line: apparmor=1 security=apparmor console=tty1 bootchooser.active=B  root=PARTUUID=a3ec664e-32ce-4665-95ea-7ae90ce9aa20 rootfstype=squashfs ro rootwait systemd.machine_id=1f5d06d548c349639e2f5629f42e2bb1 zram.enabled=1 zram.num_devices=3
[    0.000000] x86/fpu: x87 FPU will use FXSAVE
[    0.000000] BIOS-provided physical RAM map:
[    0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable
[    0.000000] BIOS-e820: [mem 0x0000000000100000-0x00000000007fffff] usable
[    0.000000] BIOS-e820: [mem 0x0000000000800000-0x0000000000807fff] ACPI NVS
[    0.000000] BIOS-e820: [mem 0x0000000000808000-0x000000000080ffff] usable
[    0.000000] BIOS-e820: [mem 0x0000000000810000-0x00000000008fffff] ACPI NVS
[    0.000000] BIOS-e820: [mem 0x0000000000900000-0x00000000bf8eefff] usable
[    0.000000] BIOS-e820: [mem 0x00000000bf8ef000-0x00000000bfb6efff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000bfb6f000-0x00000000bfb7efff] ACPI data
[    0.000000] BIOS-e820: [mem 0x00000000bfb7f000-0x00000000bfbfefff] ACPI NVS
[    0.000000] BIOS-e820: [mem 0x00000000bfbff000-0x00000000bff1ffff] usable
[    0.000000] BIOS-e820: [mem 0x00000000bff20000-0x00000000bff3ffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000bff40000-0x00000000bfffffff] ACPI NVS
[    0.000000] BIOS-e820: [mem 0x0000000100000000-0x000000033fffffff] usable
[    0.000000] NX (Execute Disable) protection: active
[    0.000000] e820: update [mem 0xbe410018-0xbe419a57] usable ==> usable
[    0.000000] e820: update [mem 0xbe410018-0xbe419a57] usable ==> usable
[    0.000000] e820: update [mem 0xbe3e8018-0xbe40f457] usable ==> usable
[    0.000000] e820: update [mem 0xbe3e8018-0xbe40f457] usable ==> usable
[    0.000000] extended physical RAM map:
[    0.000000] reserve setup_data: [mem 0x0000000000000000-0x000000000009ffff] usable
[    0.000000] reserve setup_data: [mem 0x0000000000100000-0x00000000007fffff] usable
[    0.000000] reserve setup_data: [mem 0x0000000000800000-0x0000000000807fff] ACPI NVS
[    0.000000] reserve setup_data: [mem 0x0000000000808000-0x000000000080ffff] usable
[    0.000000] reserve setup_data: [mem 0x0000000000810000-0x00000000008fffff] ACPI NVS
[    0.000000] reserve setup_data: [mem 0x0000000000900000-0x00000000be3e8017] usable
[    0.000000] reserve setup_data: [mem 0x00000000be3e8018-0x00000000be40f457] usable
[    0.000000] reserve setup_data: [mem 0x00000000be40f458-0x00000000be410017] usable
[    0.000000] reserve setup_data: [mem 0x00000000be410018-0x00000000be419a57] usable
[    0.000000] reserve setup_data: [mem 0x00000000be419a58-0x00000000bf8eefff] usable
[    0.000000] reserve setup_data: [mem 0x00000000bf8ef000-0x00000000bfb6efff] reserved
[    0.000000] reserve setup_data: [mem 0x00000000bfb6f000-0x00000000bfb7efff] ACPI data
[    0.000000] reserve setup_data: [mem 0x00000000bfb7f000-0x00000000bfbfefff] ACPI NVS
[    0.000000] reserve setup_data: [mem 0x00000000bfbff000-0x00000000bff1ffff] usable
[    0.000000] reserve setup_data: [mem 0x00000000bff20000-0x00000000bff3ffff] reserved
[    0.000000] reserve setup_data: [mem 0x00000000bff40000-0x00000000bfffffff] ACPI NVS
[    0.000000] reserve setup_data: [mem 0x0000000100000000-0x000000033fffffff] usable
[    0.000000] efi: EFI v2.70 by EDK II
[    0.000000] efi: SMBIOS=0xbf9ac000 ACPI=0xbfb7e000 ACPI 2.0=0xbfb7e014 MEMATTR=0xbe611298
[    0.000000] SMBIOS 2.8 present.
[    0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 0.0.0 02/06/2015
[    0.000000] Hypervisor detected: KVM
[    0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
[    0.000000] kvm-clock: cpu 0, msr 26a8fb001, primary cpu clock
[    0.000000] kvm-clock: using sched offset of 9013816464325 cycles
[    0.000012] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
[    0.000032] tsc: Detected 2099.998 MHz processor
[    0.000457] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
[    0.000460] e820: remove [mem 0x000a0000-0x000fffff] usable
[    0.000466] last_pfn = 0x340000 max_arch_pfn = 0x400000000
[    0.000520] MTRR default type: write-back
[    0.000526] MTRR fixed ranges enabled:
[    0.000528]   00000-9FFFF write-back
[    0.000529]   A0000-FFFFF uncachable
[    0.000530] MTRR variable ranges enabled:
[    0.000532]   0 base 00C0000000 mask FFC0000000 uncachable
[    0.000533]   1 base 0800000000 mask F800000000 uncachable
[    0.000534]   2 disabled
[    0.000534]   3 disabled
[    0.000535]   4 disabled
[    0.000535]   5 disabled
[    0.000536]   6 disabled
[    0.000536]   7 disabled
[    0.000559] x86/PAT: Configuration [0-7]: WB  WC  UC- UC  WB  WC  UC- UC
[    0.000572] last_pfn = 0xbff20 max_arch_pfn = 0x400000000
[    0.023103] check: Scanning 1 areas for low memory corruption
[    0.027633] Secure boot disabled
[    0.027648] ACPI: Early table checksum verification disabled
[    0.027695] ACPI: RSDP 0x00000000BFB7E014 000024 (v02 BOCHS )
[    0.027705] ACPI: XSDT 0x00000000BFB7D0E8 000054 (v01 BOCHS  BXPCFACP 00000001      01000013)
[    0.027728] ACPI: FACP 0x00000000BFB79000 000074 (v01 BOCHS  BXPCFACP 00000001 BXPC 00000001)
[    0.027748] ACPI: DSDT 0x00000000BFB7A000 002405 (v01 BOCHS  BXPCDSDT 00000001 BXPC 00000001)
[    0.027758] ACPI: FACS 0x00000000BFBDC000 000040
[    0.027764] ACPI: APIC 0x00000000BFB78000 0000B0 (v01 BOCHS  BXPCAPIC 00000001 BXPC 00000001)
[    0.027770] ACPI: SSDT 0x00000000BFB77000 0000CA (v01 BOCHS  VMGENID  00000001 BXPC 00000001)
[    0.027776] ACPI: HPET 0x00000000BFB76000 000038 (v01 BOCHS  BXPCHPET 00000001 BXPC 00000001)
[    0.027782] ACPI: WAET 0x00000000BFB75000 000028 (v01 BOCHS  BXPCWAET 00000001 BXPC 00000001)
[    0.027788] ACPI: BGRT 0x00000000BFB74000 000038 (v01 INTEL  EDK2     00000002      01000013)
[    0.027794] ACPI: Reserving FACP table memory at [mem 0xbfb79000-0xbfb79073]
[    0.027796] ACPI: Reserving DSDT table memory at [mem 0xbfb7a000-0xbfb7c404]
[    0.027797] ACPI: Reserving FACS table memory at [mem 0xbfbdc000-0xbfbdc03f]
[    0.027798] ACPI: Reserving APIC table memory at [mem 0xbfb78000-0xbfb780af]
[    0.027800] ACPI: Reserving SSDT table memory at [mem 0xbfb77000-0xbfb770c9]
[    0.027801] ACPI: Reserving HPET table memory at [mem 0xbfb76000-0xbfb76037]
[    0.027803] ACPI: Reserving WAET table memory at [mem 0xbfb75000-0xbfb75027]
[    0.027804] ACPI: Reserving BGRT table memory at [mem 0xbfb74000-0xbfb74037]
[    0.027845] ACPI: Local APIC address 0xfee00000
[    0.028333] No NUMA configuration found
[    0.028335] Faking a node at [mem 0x0000000000000000-0x000000033fffffff]
[    0.028350] NODE_DATA(0) allocated [mem 0x33fff4000-0x33fff7fff]
[    0.028469] Zone ranges:
[    0.028477]   DMA      [mem 0x0000000000001000-0x0000000000ffffff]
[    0.028482]   DMA32    [mem 0x0000000001000000-0x00000000ffffffff]
[    0.028484]   Normal   [mem 0x0000000100000000-0x000000033fffffff]
[    0.028486] Movable zone start for each node
[    0.028487] Early memory node ranges
[    0.028489]   node   0: [mem 0x0000000000001000-0x000000000009ffff]
[    0.028493]   node   0: [mem 0x0000000000100000-0x00000000007fffff]
[    0.028495]   node   0: [mem 0x0000000000808000-0x000000000080ffff]
[    0.028496]   node   0: [mem 0x0000000000900000-0x00000000bf8eefff]
[    0.028498]   node   0: [mem 0x00000000bfbff000-0x00000000bff1ffff]
[    0.028499]   node   0: [mem 0x0000000100000000-0x000000033fffffff]
[    0.028504] Initmem setup node 0 [mem 0x0000000000001000-0x000000033fffffff]
[    0.028506] On node 0 totalpages: 3144375
[    0.028510]   DMA zone: 59 pages used for memmap
[    0.028511]   DMA zone: 1815 pages reserved
[    0.028515]   DMA zone: 3751 pages, LIFO batch:0
[    0.030235]   DMA zone: 29017 pages in unavailable ranges
[    0.030237]   DMA32 zone: 12209 pages used for memmap
[    0.030238]   DMA32 zone: 781328 pages, LIFO batch:63
[    0.060451]   DMA32 zone: 1008 pages in unavailable ranges
[    0.060457]   Normal zone: 36864 pages used for memmap
[    0.060458]   Normal zone: 2359296 pages, LIFO batch:63
[    0.157138] ACPI: PM-Timer IO Port: 0xb008
[    0.157146] ACPI: Local APIC address 0xfee00000
[    0.157159] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
[    0.157234] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
[    0.157240] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
[    0.157252] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
[    0.157254] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
[    0.157262] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
[    0.157263] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
[    0.157266] ACPI: IRQ0 used by override.
[    0.157267] ACPI: IRQ5 used by override.
[    0.157268] ACPI: IRQ9 used by override.
[    0.157269] ACPI: IRQ10 used by override.
[    0.157269] ACPI: IRQ11 used by override.
[    0.157273] Using ACPI (MADT) for SMP configuration information
[    0.157276] ACPI: HPET id: 0x8086a201 base: 0xfed00000
[    0.157301] e820: update [mem 0xbe4ff000-0xbe522fff] usable ==> reserved
[    0.157320] smpboot: Allowing 8 CPUs, 0 hotplug CPUs
[    0.157372] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]
[    0.157374] PM: hibernation: Registered nosave memory: [mem 0x000a0000-0x000fffff]
[    0.157376] PM: hibernation: Registered nosave memory: [mem 0x00800000-0x00807fff]
[    0.157378] PM: hibernation: Registered nosave memory: [mem 0x00810000-0x008fffff]
[    0.157380] PM: hibernation: Registered nosave memory: [mem 0xbe3e8000-0xbe3e8fff]
[    0.157385] PM: hibernation: Registered nosave memory: [mem 0xbe40f000-0xbe40ffff]
[    0.157387] PM: hibernation: Registered nosave memory: [mem 0xbe410000-0xbe410fff]
[    0.157389] PM: hibernation: Registered nosave memory: [mem 0xbe419000-0xbe419fff]
[    0.157391] PM: hibernation: Registered nosave memory: [mem 0xbe4ff000-0xbe522fff]
[    0.157393] PM: hibernation: Registered nosave memory: [mem 0xbf8ef000-0xbfb6efff]
[    0.157394] PM: hibernation: Registered nosave memory: [mem 0xbfb6f000-0xbfb7efff]
[    0.157395] PM: hibernation: Registered nosave memory: [mem 0xbfb7f000-0xbfbfefff]
[    0.157397] PM: hibernation: Registered nosave memory: [mem 0xbff20000-0xbff3ffff]
[    0.157398] PM: hibernation: Registered nosave memory: [mem 0xbff40000-0xbfffffff]
[    0.157399] PM: hibernation: Registered nosave memory: [mem 0xc0000000-0xffffffff]
[    0.157402] [mem 0xc0000000-0xffffffff] available for PCI devices
[    0.157404] Booting paravirtualized kernel on KVM
[    0.157408] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
[    0.165040] setup_percpu: NR_CPUS:64 nr_cpumask_bits:64 nr_cpu_ids:8 nr_node_ids:1
[    0.168054] percpu: Embedded 54 pages/cpu s181976 r8192 d31016 u262144
[    0.168068] pcpu-alloc: s181976 r8192 d31016 u262144 alloc=1*2097152
[    0.168070] pcpu-alloc: [0] 0 1 2 3 4 5 6 7
[    0.168118] kvm-guest: stealtime: cpu 0, msr 333c184c0
[    0.168127] kvm-guest: PV spinlocks enabled
[    0.168145] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear)
[    0.168172] Built 1 zonelists, mobility grouping on.  Total pages: 3093428
[    0.168175] Policy zone: Normal
[    0.168179] Kernel command line: apparmor=1 security=apparmor console=tty1 bootchooser.active=B  root=PARTUUID=a3ec664e-32ce-4665-95ea-7ae90ce9aa20 rootfstype=squashfs ro rootwait systemd.machine_id=1f5d06d548c349639e2f5629f42e2bb1 zram.enabled=1 zram.num_devices=3
[    0.185138] Dentry cache hash table entries: 2097152 (order: 12, 16777216 bytes, linear)
[    0.191479] Inode-cache hash table entries: 1048576 (order: 11, 8388608 bytes, linear)
[    0.191734] mem auto-init: stack:off, heap alloc:off, heap free:off
[    0.292695] Memory: 12228216K/12577500K available (16395K kernel code, 2558K rwdata, 3884K rodata, 1388K init, 1168K bss, 349024K reserved, 0K cma-reserved)
[    0.292803] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=8, Nodes=1
[    0.292840] Kernel/User page tables isolation: enabled
[    0.293532] rcu: Hierarchical RCU implementation.
[    0.293537] rcu:     RCU event tracing is enabled.
[    0.293539] rcu:     RCU restricting CPUs from NR_CPUS=64 to nr_cpu_ids=8.
[    0.293543]  Tracing variant of Tasks RCU enabled.
[    0.293545] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.
[    0.293546] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=8
[    0.294864] NR_IRQS: 4352, nr_irqs: 488, preallocated irqs: 16
[    0.295195] random: get_random_bytes called from start_kernel+0x375/0x54c with crng_init=0
[    0.295334] Console: colour dummy device 80x25
[    0.295578] printk: console [tty1] enabled
[    0.295617] ACPI: Core revision 20200925
[    0.295922] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
[    0.296123] APIC: Switch to symmetric I/O mode setup
[    0.297948] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[    0.297996] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x1e452ea631d, max_idle_ns: 440795244572 ns
[    0.298005] Calibrating delay loop (skipped) preset value.. 4199.99 BogoMIPS (lpj=2099998)
[    0.298013] pid_max: default: 32768 minimum: 301
[    0.301039] LSM: Security Framework initializing
[    0.301131] AppArmor: AppArmor initialized
[    0.301353] Mount-cache hash table entries: 32768 (order: 6, 262144 bytes, linear)
[    0.301681] Mountpoint-cache hash table entries: 32768 (order: 6, 262144 bytes, linear)
[    0.302534] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
[    0.302539] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
[    0.302547] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization
[    0.302552] Spectre V2 : Mitigation: Full generic retpoline
[    0.302554] Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch
[    0.302557] Speculative Store Bypass: Vulnerable
[    0.302561] MDS: Vulnerable: Clear CPU buffers attempted, no microcode
[    0.303081] Freeing SMP alternatives memory: 48K
[    0.409154] smpboot: CPU0: Intel Common KVM processor (family: 0xf, model: 0x6, stepping: 0x1)
[    0.409665] Performance Events: unsupported Netburst CPU model 6 no PMU driver, software events only.
[    0.409831] rcu: Hierarchical SRCU implementation.
[    0.410675] smp: Bringing up secondary CPUs ...
[    0.411097] x86: Booting SMP configuration:
[    0.411101] .... node  #0, CPUs:      #1
[    0.002899] kvm-clock: cpu 1, msr 26a8fb041, secondary cpu clock
[    0.423038] kvm-guest: stealtime: cpu 1, msr 333c584c0
[    0.423391]  #2
[    0.002899] kvm-clock: cpu 2, msr 26a8fb081, secondary cpu clock
[    0.436034] kvm-guest: stealtime: cpu 2, msr 333c984c0
[    0.436490]  #3
[    0.002899] kvm-clock: cpu 3, msr 26a8fb0c1, secondary cpu clock
[    0.449030] kvm-guest: stealtime: cpu 3, msr 333cd84c0
[    0.449430]  #4
[    0.002899] kvm-clock: cpu 4, msr 26a8fb101, secondary cpu clock
[    0.463023] kvm-guest: stealtime: cpu 4, msr 333d184c0
[    0.463458]  #5
[    0.002899] kvm-clock: cpu 5, msr 26a8fb141, secondary cpu clock
[    0.475065] kvm-guest: stealtime: cpu 5, msr 333d584c0
[    0.476387]  #6
[    0.002899] kvm-clock: cpu 6, msr 26a8fb181, secondary cpu clock
[    0.488025] kvm-guest: stealtime: cpu 6, msr 333d984c0
[    0.489229]  #7
[    0.002899] kvm-clock: cpu 7, msr 26a8fb1c1, secondary cpu clock
[    0.501049] kvm-guest: stealtime: cpu 7, msr 333dd84c0
[    0.501157] smp: Brought up 1 node, 8 CPUs
[    0.501164] smpboot: Max logical packages: 1
[    0.501167] smpboot: Total of 8 processors activated (33599.96 BogoMIPS)
[    0.503274] devtmpfs: initialized
[    0.503332] x86/mm: Memory block size: 128MB
[    0.505221] PM: Registering ACPI NVS region [mem 0x00800000-0x00807fff] (32768 bytes)
[    0.505221] PM: Registering ACPI NVS region [mem 0x00810000-0x008fffff] (983040 bytes)
[    0.505221] PM: Registering ACPI NVS region [mem 0xbfb7f000-0xbfbfefff] (524288 bytes)
[    0.505230] PM: Registering ACPI NVS region [mem 0xbff40000-0xbfffffff] (786432 bytes)
[    0.505361] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
[    0.505375] futex hash table entries: 2048 (order: 5, 131072 bytes, linear)
[    0.505734] PM: RTC time: 13:48:43, date: 2021-06-21
[    0.506359] NET: Registered protocol family 16
[    0.506606] audit: initializing netlink subsys (disabled)
[    0.507489] thermal_sys: Registered thermal governor 'step_wise'
[    0.507491] thermal_sys: Registered thermal governor 'user_space'
[    0.507535] audit: type=2000 audit(1624283322.282:1): state=initialized audit_enabled=0 res=1
[    0.507552] cpuidle: using governor menu
[    0.507552] ACPI: bus type PCI registered
[    0.507552] PCI: Using configuration type 1 for base access
[    0.511933] Kprobes globally optimized
[    0.512184] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
[    0.516132] ACPI: Added _OSI(Module Device)
[    0.516138] ACPI: Added _OSI(Processor Device)
[    0.516141] ACPI: Added _OSI(3.0 _SCP Extensions)
[    0.516143] ACPI: Added _OSI(Processor Aggregator Device)
[    0.516153] ACPI: Added _OSI(Linux-Dell-Video)
[    0.516155] ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio)
[    0.516158] ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics)
[    0.517513] ACPI: 2 ACPI AML tables successfully acquired and loaded
[    0.518587] ACPI: Interpreter enabled
[    0.518616] ACPI: (supports S0 S3 S4 S5)
[    0.518619] ACPI: Using IOAPIC for interrupt routing
[    0.518636] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[    0.518830] ACPI: Enabled 3 GPEs in block 00 to 0F
[    0.525103] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[    0.525134] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3]
[    0.525155] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge.
[    0.525223] PCI host bridge to bus 0000:00
[    0.525231] pci_bus 0000:00: root bus resource [io  0x0000-0x0cf7 window]
[    0.525235] pci_bus 0000:00: root bus resource [io  0x0d00-0xffff window]
[    0.525238] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
[    0.525242] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]
[    0.525245] pci_bus 0000:00: root bus resource [mem 0x800000000-0x87fffffff window]
[    0.525262] pci_bus 0000:00: root bus resource [bus 00-ff]
[    0.525362] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000
[    0.526168] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100
[    0.527222] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180
[    0.531414] pci 0000:00:01.1: reg 0x20: [io  0xd2e0-0xd2ef]
[    0.533043] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io  0x01f0-0x01f7]
[    0.533049] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io  0x03f6]
[    0.533052] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io  0x0170-0x0177]
[    0.533055] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io  0x0376]
[    0.533304] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300
[    0.537008] pci 0000:00:01.2: reg 0x20: [io  0xd2c0-0xd2df]
[    0.540109] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000
[    0.540835] pci 0000:00:01.3: quirk: [io  0xb000-0xb03f] claimed by PIIX4 ACPI
[    0.540854] pci 0000:00:01.3: quirk: [io  0xb100-0xb10f] claimed by PIIX4 SMB
[    0.541207] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000
[    0.543799] pci 0000:00:02.0: reg 0x10: [mem 0xc0000000-0xc0ffffff pref]
[    0.547054] pci 0000:00:02.0: reg 0x18: [mem 0xc1443000-0xc1443fff]
[    0.553644] pci 0000:00:02.0: reg 0x30: [mem 0xffff0000-0xffffffff pref]
[    0.554191] pci 0000:00:02.0: BAR 0: assigned to efifb
[    0.555107] pci 0000:00:03.0: [1af4:1002] type 00 class 0x00ff00
[    0.556011] pci 0000:00:03.0: reg 0x10: [io  0xd240-0xd27f]
[    0.562016] pci 0000:00:03.0: reg 0x20: [mem 0x800000000-0x800003fff 64bit pref]
[    0.564326] pci 0000:00:07.0: [8086:2922] type 00 class 0x010601
[    0.569011] pci 0000:00:07.0: reg 0x20: [io  0xd2a0-0xd2bf]
[    0.570006] pci 0000:00:07.0: reg 0x24: [mem 0xc1442000-0xc1442fff]
[    0.573309] pci 0000:00:08.0: [1af4:1003] type 00 class 0x078000
[    0.575007] pci 0000:00:08.0: reg 0x10: [io  0xd200-0xd23f]
[    0.576006] pci 0000:00:08.0: reg 0x14: [mem 0xc1441000-0xc1441fff]
[    0.580949] pci 0000:00:08.0: reg 0x20: [mem 0x800004000-0x800007fff 64bit pref]
[    0.585280] pci 0000:00:12.0: [1af4:1000] type 00 class 0x020000
[    0.587006] pci 0000:00:12.0: reg 0x10: [io  0xd280-0xd29f]
[    0.588619] pci 0000:00:12.0: reg 0x14: [mem 0xc1440000-0xc1440fff]
[    0.592006] pci 0000:00:12.0: reg 0x20: [mem 0x800008000-0x80000bfff 64bit pref]
[    0.593587] pci 0000:00:12.0: reg 0x30: [mem 0xfffc0000-0xffffffff pref]
[    0.594979] pci 0000:00:1e.0: [1b36:0001] type 01 class 0x060400
[    0.598008] pci 0000:00:1e.0: reg 0x10: [mem 0x80000d000-0x80000d0ff 64bit]
[    0.600566] pci 0000:00:1f.0: [1b36:0001] type 01 class 0x060400
[    0.602006] pci 0000:00:1f.0: reg 0x10: [mem 0x80000c000-0x80000c0ff 64bit]
[    0.605106] pci_bus 0000:01: extended config space not accessible
[    0.605533] pci 0000:01:1b.0: [1033:0194] type 00 class 0x0c0330
[    0.606006] pci 0000:01:1b.0: reg 0x10: [mem 0xc1200000-0xc1203fff 64bit]
[    0.610689] pci 0000:00:1e.0: PCI bridge to [bus 01]
[    0.610723] pci 0000:00:1e.0:   bridge window [io  0xd000-0xdfff]
[    0.610750] pci 0000:00:1e.0:   bridge window [mem 0xc1200000-0xc13fffff]
[    0.611580] pci_bus 0000:02: extended config space not accessible
[    0.612131] pci 0000:00:1f.0: PCI bridge to [bus 02]
[    0.612160] pci 0000:00:1f.0:   bridge window [io  0xc000-0xcfff]
[    0.612186] pci 0000:00:1f.0:   bridge window [mem 0xc1000000-0xc11fffff]
[    0.614474] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 10 *11)
[    0.614647] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 10 *11)
[    0.614820] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 *10 11)
[    0.614963] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 *10 11)
[    0.615030] ACPI: PCI Interrupt Link [LNKS] (IRQs *9)
[    0.616386] iommu: Default domain type: Translated
[    0.616437] pci 0000:00:02.0: vgaarb: setting as boot VGA device
[    0.616437] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none
[    0.616437] pci 0000:00:02.0: vgaarb: bridge control possible
[    0.616437] vgaarb: loaded
[    0.616683] SCSI subsystem initialized
[    0.617259] libata version 3.00 loaded.
[    0.618006] ACPI: bus type USB registered
[    0.618006] usbcore: registered new interface driver usbfs
[    0.618006] usbcore: registered new interface driver hub
[    0.618006] usbcore: registered new device driver usb
[    0.618006] mc: Linux media interface: v0.10
[    0.618006] videodev: Linux video capture interface: v2.00
[    0.618006] pps_core: LinuxPPS API ver. 1 registered
[    0.618006] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[    0.618006] PTP clock support registered
[    0.618268] Registered efivars operations
[    0.618416] Advanced Linux Sound Architecture Driver Initialized.
[    0.618818] Bluetooth: Core ver 2.22
[    0.618842] NET: Registered protocol family 31
[    0.618848] Bluetooth: HCI device and connection manager initialized
[    0.618868] Bluetooth: HCI socket layer initialized
[    0.618872] Bluetooth: L2CAP socket layer initialized
[    0.618895] Bluetooth: SCO socket layer initialized
[    0.618917] NetLabel: Initializing
[    0.618920] NetLabel:  domain hash size = 128
[    0.618922] NetLabel:  protocols = UNLABELED CIPSOv4 CALIPSO
[    0.618971] NetLabel:  unlabeled traffic allowed by default
[    0.619146] PCI: Using ACPI for IRQ routing
[    0.619151] PCI: pci_cache_line_size set to 64 bytes
[    0.619244] pci 0000:00:01.1: can't claim BAR 4 [io  0xd2e0-0xd2ef]: address conflict with PCI Bus 0000:01 [io  0xd000-0xdfff]
[    0.619271] pci 0000:00:01.2: can't claim BAR 4 [io  0xd2c0-0xd2df]: address conflict with PCI Bus 0000:01 [io  0xd000-0xdfff]
[    0.619320] pci 0000:00:03.0: can't claim BAR 0 [io  0xd240-0xd27f]: address conflict with PCI Bus 0000:01 [io  0xd000-0xdfff]
[    0.619348] pci 0000:00:07.0: can't claim BAR 4 [io  0xd2a0-0xd2bf]: address conflict with PCI Bus 0000:01 [io  0xd000-0xdfff]
[    0.619370] pci 0000:00:08.0: can't claim BAR 0 [io  0xd200-0xd23f]: address conflict with PCI Bus 0000:01 [io  0xd000-0xdfff]
[    0.619395] pci 0000:00:12.0: can't claim BAR 0 [io  0xd280-0xd29f]: address conflict with PCI Bus 0000:01 [io  0xd000-0xdfff]
[    0.619634] e820: reserve RAM buffer [mem 0x00810000-0x008fffff]
[    0.619639] e820: reserve RAM buffer [mem 0xbe3e8018-0xbfffffff]
[    0.619641] e820: reserve RAM buffer [mem 0xbe410018-0xbfffffff]
[    0.619642] e820: reserve RAM buffer [mem 0xbe4ff000-0xbfffffff]
[    0.619644] e820: reserve RAM buffer [mem 0xbf8ef000-0xbfffffff]
[    0.619645] e820: reserve RAM buffer [mem 0xbff20000-0xbfffffff]
[    0.620125] hpet: 3 channels of 0 reserved for per-cpu timers
[    0.620166] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
[    0.620176] hpet0: 3 comparators, 64-bit 100.000000 MHz counter
[    0.624181] clocksource: Switched to clocksource kvm-clock
[    0.785343] VFS: Disk quotas dquot_6.6.0
[    0.785388] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[    0.785727] AppArmor: AppArmor Filesystem Enabled
[    0.785755] pnp: PnP ACPI init
[    0.785880] pnp 00:00: Plug and Play ACPI device, IDs PNP0303 (active)
[    0.785910] pnp 00:01: Plug and Play ACPI device, IDs PNP0f13 (active)
[    0.785928] pnp 00:02: [dma 2]
[    0.785958] pnp 00:02: Plug and Play ACPI device, IDs PNP0700 (active)
[    0.785990] pnp 00:03: Plug and Play ACPI device, IDs PNP0b00 (active)
[    0.786363] pnp: PnP ACPI: found 4 devices
[    0.796335] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
[    0.796409] NET: Registered protocol family 2
[    0.799093] IP idents hash table entries: 262144 (order: 9, 2097152 bytes, linear)
[    0.801873] tcp_listen_portaddr_hash hash table entries: 8192 (order: 5, 131072 bytes, linear)
[    0.801994] TCP established hash table entries: 131072 (order: 8, 1048576 bytes, linear)
[    0.803985] TCP bind hash table entries: 65536 (order: 8, 1048576 bytes, linear)
[    0.805341] TCP: Hash tables configured (established 131072 bind 65536)
[    0.805496] UDP hash table entries: 8192 (order: 6, 262144 bytes, linear)
[    0.805678] UDP-Lite hash table entries: 8192 (order: 6, 262144 bytes, linear)
[    0.805974] NET: Registered protocol family 1
[    0.806620] RPC: Registered named UNIX socket transport module.
[    0.806627] RPC: Registered udp transport module.
[    0.806629] RPC: Registered tcp transport module.
[    0.806631] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    0.806640] pci 0000:00:02.0: can't claim BAR 6 [mem 0xffff0000-0xffffffff pref]: no compatible bridge window
[    0.806645] pci 0000:00:12.0: can't claim BAR 6 [mem 0xfffc0000-0xffffffff pref]: no compatible bridge window
[    0.806666] pci 0000:00:12.0: BAR 6: assigned [mem 0xc1400000-0xc143ffff pref]
[    0.806671] pci 0000:00:02.0: BAR 6: assigned [mem 0xc1450000-0xc145ffff pref]
[    0.806675] pci 0000:00:03.0: BAR 0: assigned [io  0x1000-0x103f]
[    0.807463] pci 0000:00:08.0: BAR 0: assigned [io  0x1040-0x107f]
[    0.808221] pci 0000:00:01.2: BAR 4: assigned [io  0x1080-0x109f]
[    0.808898] pci 0000:00:07.0: BAR 4: assigned [io  0x10a0-0x10bf]
[    0.809622] pci 0000:00:12.0: BAR 0: assigned [io  0x10c0-0x10df]
[    0.810298] pci 0000:00:01.1: BAR 4: assigned [io  0x10e0-0x10ef]
[    0.810950] pci 0000:00:1e.0: PCI bridge to [bus 01]
[    0.810968] pci 0000:00:1e.0:   bridge window [io  0xd000-0xdfff]
[    0.812078] pci 0000:00:1e.0:   bridge window [mem 0xc1200000-0xc13fffff]
[    0.814230] pci 0000:00:1f.0: PCI bridge to [bus 02]
[    0.814252] pci 0000:00:1f.0:   bridge window [io  0xc000-0xcfff]
[    0.815332] pci 0000:00:1f.0:   bridge window [mem 0xc1000000-0xc11fffff]
[    0.817587] pci_bus 0000:00: resource 4 [io  0x0000-0x0cf7 window]
[    0.817592] pci_bus 0000:00: resource 5 [io  0x0d00-0xffff window]
[    0.817601] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]
[    0.817605] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window]
[    0.817608] pci_bus 0000:00: resource 8 [mem 0x800000000-0x87fffffff window]
[    0.817612] pci_bus 0000:01: resource 0 [io  0xd000-0xdfff]
[    0.817614] pci_bus 0000:01: resource 1 [mem 0xc1200000-0xc13fffff]
[    0.817618] pci_bus 0000:02: resource 0 [io  0xc000-0xcfff]
[    0.817620] pci_bus 0000:02: resource 1 [mem 0xc1000000-0xc11fffff]
[    0.818766] pci 0000:00:01.0: PIIX3: Enabling Passive Release
[    0.818797] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
[    0.818821] pci 0000:00:01.0: Activating ISA DMA hang workarounds
[    0.842151] PCI Interrupt Link [LNKD] enabled at IRQ 10
[    0.865730] pci 0000:00:01.2: quirk_usb_early_handoff+0x0/0x5f0 took 45728 usecs
[    0.866031] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
[    0.889660] PCI Interrupt Link [LNKB] enabled at IRQ 11
[    0.913303] PCI Interrupt Link [LNKA] enabled at IRQ 11
[    0.937458] pci 0000:01:1b.0: quirk_usb_early_handoff+0x0/0x5f0 took 69644 usecs
[    0.937528] PCI: CLS 0 bytes, default 64
[    0.937747] PCI-DMA: Using software bounce buffering for IO (SWIOTLB)
[    0.937756] software IO TLB: mapped [mem 0x00000000b7efe000-0x00000000bbefe000] (64MB)
[    0.937927] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x1e452ea631d, max_idle_ns: 440795244572 ns
[    0.940918] check: Scanning for low memory corruption every 60 seconds
[    0.941688] Initialise system trusted keyrings
[    0.941887] workingset: timestamp_bits=40 max_order=22 bucket_order=0
[    0.944576] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[    0.945016] NFS: Registering the id_resolver key type
[    0.945029] Key type id_resolver registered
[    0.945032] Key type id_legacy registered
[    0.958235] Key type asymmetric registered
[    0.958257] Asymmetric key parser 'x509' registered
[    0.958288] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249)
[    0.958526] io scheduler mq-deadline registered
[    0.958532] io scheduler kyber registered
[    0.959438] hv_vmbus: registering driver hyperv_fb
[    0.959460] efifb: probing for efifb
[    0.959504] efifb: framebuffer at 0xc0000000, using 1876k, total 1875k
[    0.959507] efifb: mode is 800x600x32, linelength=3200, pages=1
[    0.959510] efifb: scrolling: redraw
[    0.959512] efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0
[    0.961815] Console: switching to colour frame buffer device 100x37
[    0.962940] fb0: EFI VGA frame buffer device
[    0.963174] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0
[    0.963271] ACPI: Power Button [PWRF]
[    0.989047] PCI Interrupt Link [LNKC] enabled at IRQ 10
[    1.041606] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
[    1.042522] Non-volatile memory driver v1.3
[    1.042596] Linux agpgart interface v0.103
[    1.051990] loop: module loaded
[    1.052219] zram: Added device: zram0
[    1.052414] zram: Added device: zram1
[    1.052648] zram: Added device: zram2
[    1.052703] Guest personality initialized and is inactive
[    1.053495] VMCI host device registered (name=vmci, major=10, minor=62)
[    1.054232] Initialized host personality
[    1.055112] VMware PVSCSI driver - version 1.0.7.0-k
[    1.055875] hv_vmbus: registering driver hv_storvsc
[    1.057474] ahci 0000:00:07.0: version 3.0
[    1.083097] ahci 0000:00:07.0: AHCI 0001.0000 32 slots 6 ports 1.5 Gbps 0x3f impl SATA mode
[    1.083727] ahci 0000:00:07.0: flags: 64bit ncq only
[    1.087480] scsi host0: ahci
[    1.088654] scsi host1: ahci
[    1.089678] scsi host2: ahci
[    1.090662] scsi host3: ahci
[    1.091627] scsi host4: ahci
[    1.092746] scsi host5: ahci
[    1.093432] ata1: SATA max UDMA/133 abar m4096@0xc1442000 port 0xc1442100 irq 24
[    1.093973] ata2: SATA max UDMA/133 abar m4096@0xc1442000 port 0xc1442180 irq 24
[    1.094504] ata3: SATA max UDMA/133 abar m4096@0xc1442000 port 0xc1442200 irq 24
[    1.095015] ata4: SATA max UDMA/133 abar m4096@0xc1442000 port 0xc1442280 irq 24
[    1.095501] ata5: SATA max UDMA/133 abar m4096@0xc1442000 port 0xc1442300 irq 24
[    1.095968] ata6: SATA max UDMA/133 abar m4096@0xc1442000 port 0xc1442380 irq 24
[    1.096786] ata_piix 0000:00:01.1: version 2.13
[    1.098185] scsi host6: ata_piix
[    1.099228] scsi host7: ata_piix
[    1.099730] ata7: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0x10e0 irq 14
[    1.100178] ata8: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0x10e8 irq 15
[    1.101125] ata7: port disabled--ignoring
[    1.101279] ata8: port disabled--ignoring
[    1.101299] tun: Universal TUN/TAP device driver, 1.6
[    1.104385] e100: Intel(R) PRO/100 Network Driver
[    1.104804] e100: Copyright(c) 1999-2006 Intel Corporation
[    1.105280] e1000: Intel(R) PRO/1000 Network Driver
[    1.105706] e1000: Copyright (c) 1999-2006 Intel Corporation.
[    1.106183] e1000e: Intel(R) PRO/1000 Network Driver
[    1.106626] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
[    1.107086] sky2: driver version 1.30
[    1.107553] VMware vmxnet3 virtual NIC driver - version 1.5.0.0-k-NAPI
[    1.107992] hv_vmbus: registering driver hv_netvsc
[    1.108450] Fusion MPT base driver 3.04.20
[    1.108894] Copyright (c) 1999-2008 LSI Corporation
[    1.109362] Fusion MPT SPI Host driver 3.04.20
[    1.109842] Fusion MPT SAS Host driver 3.04.20
[    1.110445] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[    1.110916] ehci-pci: EHCI PCI platform driver
[    1.111389] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[    1.111856] ohci-pci: OHCI PCI platform driver
[    1.112326] uhci_hcd: USB Universal Host Controller Interface driver
[    1.137535] uhci_hcd 0000:00:01.2: UHCI Host Controller
[    1.138227] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1
[    1.138924] uhci_hcd 0000:00:01.2: irq 10, io base 0x00001080
[    1.139677] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 5.10
[    1.140226] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    1.140724] usb usb1: Product: UHCI Host Controller
[    1.141270] usb usb1: Manufacturer: Linux 5.10.42 uhci_hcd
[    1.141790] usb usb1: SerialNumber: 0000:00:01.2
[    1.142513] hub 1-0:1.0: USB hub found
[    1.143060] hub 1-0:1.0: 2 ports detected
[    1.169234] xhci_hcd 0000:01:1b.0: xHCI Host Controller
[    1.169892] xhci_hcd 0000:01:1b.0: new USB bus registered, assigned bus number 2
[    1.171064] xhci_hcd 0000:01:1b.0: hcc params 0x00080001 hci version 0x100 quirks 0x0000000000000014
[    1.173966] usb usb2: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.10
[    1.174588] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    1.175190] usb usb2: Product: xHCI Host Controller
[    1.175760] usb usb2: Manufacturer: Linux 5.10.42 xhci-hcd
[    1.176384] usb usb2: SerialNumber: 0000:01:1b.0
[    1.177213] hub 2-0:1.0: USB hub found
[    1.177842] hub 2-0:1.0: 4 ports detected
[    1.178834] xhci_hcd 0000:01:1b.0: xHCI Host Controller
[    1.179490] xhci_hcd 0000:01:1b.0: new USB bus registered, assigned bus number 3
[    1.180081] xhci_hcd 0000:01:1b.0: Host supports USB 3.0 SuperSpeed
[    1.180875] usb usb3: We don't know the algorithms for LPM for this host, disabling LPM.
[    1.181512] usb usb3: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 5.10
[    1.182130] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    1.182720] usb usb3: Product: xHCI Host Controller
[    1.183346] usb usb3: Manufacturer: Linux 5.10.42 xhci-hcd
[    1.183931] usb usb3: SerialNumber: 0000:01:1b.0
[    1.184728] hub 3-0:1.0: USB hub found
[    1.185426] hub 3-0:1.0: 4 ports detected
[    1.186429] usbcore: registered new interface driver usblp
[    1.187055] usbcore: registered new interface driver usb-storage
[    1.187660] usbcore: registered new interface driver usbserial_generic
[    1.188281] usbserial: USB Serial support registered for generic
[    1.188949] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
[    1.190754] serio: i8042 KBD port at 0x60,0x64 irq 1
[    1.192436] serio: i8042 AUX port at 0x60,0x64 irq 12
[    1.193606] rtc_cmos 00:03: RTC can wake from S4
[    1.194949] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1
[    1.196692] rtc_cmos 00:03: registered as rtc0
[    1.197704] rtc_cmos 00:03: alarms up to one day, y3k, 242 bytes nvram, hpet irqs
[    1.199810] device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com
[    1.200638] usbcore: registered new interface driver btusb
[    1.201342] intel_pstate: CPU model not supported
[    1.201964] EFI Variables Facility v0.08 2004-May-17
[    1.205193] hid: raw HID events driver (C) Jiri Kosina
[    1.206140] usbcore: registered new interface driver usbhid
[    1.206790] usbhid: USB HID core driver
[    1.209181] IPVS: Registered protocols ()
[    1.209801] IPVS: Connection hash table configured (size=4096, memory=64Kbytes)
[    1.210575] IPVS: ipvs loaded.
[    1.211201] IPVS: [rr] scheduler registered.
[    1.212682] NET: Registered protocol family 10
[    1.214019] Segment Routing with IPv6
[    1.215157] sit: IPv6, IPv4 and MPLS over IPv4 tunneling driver
[    1.215982] NET: Registered protocol family 17
[    1.216655] Bridge firewalling registered
[    1.217262] Key type dns_resolver registered
[    1.219038] IPI shorthand broadcast: enabled
[    1.219662] sched_clock: Marking stable (1217105832, 1899954)->(1245431900, -26426114)
[    1.220625] registered taskstats version 1
[    1.221198] Loading compiled-in X.509 certificates
[    1.221836] AppArmor: AppArmor sha1 policy hashing enabled
[    1.222997] PM:   Magic number: 9:743:837
[    1.223770] printk: console [netcon0] enabled
[    1.224395] netconsole: network logging started
[    1.225337] ALSA device list:
[    1.225911]   No soundcards found.
[    1.498722] ata5: SATA link down (SStatus 0 SControl 300)
[    1.500398] ata4: SATA link down (SStatus 0 SControl 300)
[    1.501238] ata3: SATA link down (SStatus 0 SControl 300)
[    1.502454] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[    1.503198] ata1.00: ATA-7: QEMU HARDDISK, 2.5+, max UDMA/100
[    1.503745] ata1.00: 67108864 sectors, multi 16: LBA48 NCQ (depth 32)
[    1.504380] ata1.00: applying bridge limits
[    1.505220] ata2: SATA link down (SStatus 0 SControl 300)
[    1.506028] ata6: SATA link down (SStatus 0 SControl 300)
[    1.506745] ata1.00: configured for UDMA/100
[    1.507504] scsi 0:0:0:0: Direct-Access     ATA      QEMU HARDDISK    2.5+ PQ: 0 ANSI: 5
[    1.508338] sd 0:0:0:0: Attached scsi generic sg0 type 0
[    1.508439] sd 0:0:0:0: [sda] 67108864 512-byte logical blocks: (34.4 GB/32.0 GiB)
[    1.509402] sd 0:0:0:0: [sda] Write Protect is off
[    1.509921] sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00
[    1.509944] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[    1.513590]  sda: sda1 sda2 sda3 sda4 sda5 sda6 sda7 sda8
[    1.514977] sd 0:0:0:0: [sda] Attached SCSI disk
[    1.550119] usb 1-1: new full-speed USB device number 2 using uhci_hcd
[    1.612132] usb 2-1: new full-speed USB device number 2 using xhci_hcd
[    1.689951] usb 1-1: not running at top speed; connect to a high speed hub
[    1.725216] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00
[    1.725842] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10
[    1.726439] usb 1-1: Product: QEMU USB Tablet
[    1.726985] usb 1-1: Manufacturer: QEMU
[    1.727539] usb 1-1: SerialNumber: 28754-0000:00:01.2-1
[    1.737048] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:01.2/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input4
[    1.738435] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:01.2-1/input0
[    1.742304] usb 2-1: New USB device found, idVendor=1a86, idProduct=7523, bcdDevice= 2.64
[    1.742940] usb 2-1: New USB device strings: Mfr=0, Product=2, SerialNumber=0
[    1.743579] usb 2-1: Product: USB Serial
[    1.914140] random: fast init done
[    1.916337] input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input3
[    1.917681] md: Waiting for all devices to be available before autodetect
[    1.918338] md: If you don't use raid, use raid=noautodetect
[    1.918974] md: Autodetecting RAID arrays.
[    1.919646] md: autorun ...
[    1.920338] md: ... autorun DONE.
[    1.923368] VFS: Mounted root (squashfs filesystem) readonly on device 8:5.
[    1.924746] devtmpfs: mounted
[    1.926599] Freeing unused kernel image (initmem) memory: 1388K
[    1.927354] Write protecting the kernel read-only data: 22528k
[    1.930790] Freeing unused kernel image (text/rodata gap) memory: 2036K
[    1.932680] Freeing unused kernel image (rodata/data gap) memory: 212K
[    1.934098] Run /sbin/init as init process
[    1.935313]   with arguments:
[    1.935315]     /sbin/init
[    1.935316]   with environment:
[    1.935318]     HOME=/
[    1.935319]     TERM=linux
[    2.040563] 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)
[    2.043620] systemd[1]: Detected virtualization kvm.
[    2.044387] systemd[1]: Detected architecture x86-64.
[    2.059025] systemd[1]: Set hostname to <homeassistant>.
[    2.059858] systemd[1]: Installed transient /etc/machine-id file.
[    2.250335] systemd[1]: Queued start job for default target Multi-User System.
[    2.252104] random: systemd: uninitialized urandom read (16 bytes read)
[    2.272359] systemd[1]: Created slice system-ha\x2dcli.slice.
[    2.273958] random: systemd: uninitialized urandom read (16 bytes read)
[    2.275577] systemd[1]: Created slice system-modprobe.slice.
[    2.277124] random: systemd: uninitialized urandom read (16 bytes read)
[    2.278722] systemd[1]: Created slice system-systemd\x2dfsck.slice.
[    2.281211] systemd[1]: Created slice system-systemd\x2dgrowfs.slice.
[    2.283545] systemd[1]: Created slice User and Session Slice.
[    2.285135] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
[    2.286720] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
[    2.288342] systemd[1]: Reached target Local Encrypted Volumes.
[    2.289913] systemd[1]: Reached target HassOS hardware targets.
[    2.291481] systemd[1]: Reached target HassOS zram targets.
[    2.293073] systemd[1]: Reached target Paths.
[    2.294646] systemd[1]: Reached target Remote Encrypted Volumes.
[    2.296234] systemd[1]: Reached target Remote File Systems.
[    2.297781] systemd[1]: Reached target Slices.
[    2.300381] systemd[1]: Listening on D-Bus System Message Bus Socket.
[    2.302052] systemd[1]: Listening on Device-mapper event daemon FIFOs.
[    2.306028] systemd[1]: Listening on Process Core Dump Socket.
[    2.308040] systemd[1]: Listening on Journal Audit Socket.
[    2.309953] systemd[1]: Listening on Journal Socket (/dev/log).
[    2.311788] systemd[1]: Listening on Journal Socket.
[    2.314195] systemd[1]: Listening on udev Control Socket.
[    2.315924] systemd[1]: Listening on udev Kernel Socket.
[    2.319534] systemd[1]: Mounting Huge Pages File System...
[    2.323564] systemd[1]: Mounting POSIX Message Queue File System...
[    2.327281] systemd[1]: Mounting Kernel Debug File System...
[    2.330556] systemd[1]: Mounting Kernel Trace File System...
[    2.334195] systemd[1]: Starting Availability of block devices...
[    2.338901] systemd[1]: Started D-Bus System Message Bus.
[    2.351302] systemd[1]: Starting Home Assistant OS Agent...
[    2.356022] systemd[1]: Condition check resulted in Create list of static device nodes for the current kernel being skipped.
[    2.360049] systemd[1]: Starting Monitoring of LVM2 mirrors, snapshots etc. using dmeventd or progress polling...
[    2.367375] systemd[1]: Starting Load Kernel Module configfs...
[    2.371937] systemd[1]: Starting Load Kernel Module drm...
[    2.377256] systemd[1]: Starting Load Kernel Module fuse...
[    2.389577] systemd[1]: Starting Journal Service...
[    2.393779] systemd[1]: Starting Remount Root and Kernel File Systems...
[    2.397965] systemd[1]: Starting Wait Until Kernel Time Synchronized...
[    2.401926] systemd[1]: Starting Create Static Device Nodes in /dev...
[    2.406432] systemd[1]: Starting Coldplug All udev Devices...
[    2.411785] systemd[1]: Starting Disk Manager...
[    2.417375] systemd[1]: Starting HassOS ZRAM swap...
[    2.424398] systemd[1]: Starting HassOS ZRAM tmp...
[    2.430528] systemd[1]: Starting HassOS ZRAM var...
[    2.437962] systemd[1]: Mounted Huge Pages File System.
[    2.440800] systemd[1]: Mounted POSIX Message Queue File System.
[    2.442357] zram1: detected capacity change from 0 to 33554432
[    2.442479] zram2: detected capacity change from 0 to 16777216
[    2.446738] systemd[1]: Mounted Kernel Debug File System.
[    2.451160] systemd[1]: Mounted Kernel Trace File System.
[    2.457413] systemd[1]: Finished Availability of block devices.
[    2.460213] systemd[1]: modprobe@configfs.service: Succeeded.
[    2.462394] systemd[1]: Finished Load Kernel Module configfs.
[    2.465138] systemd[1]: modprobe@drm.service: Succeeded.
[    2.467265] systemd[1]: Finished Load Kernel Module drm.
[    2.469738] systemd[1]: modprobe@fuse.service: Succeeded.
[    2.471766] systemd[1]: Finished Load Kernel Module fuse.
[    2.475730] systemd[1]: Finished Remount Root and Kernel File Systems.
[    2.477402] zram0: detected capacity change from 0 to 3138297856
[    2.478936] systemd[1]: Condition check resulted in FUSE Control File System being skipped.
[    2.480754] systemd[1]: Condition check resulted in Kernel Configuration File System being skipped.
[    2.496773] systemd[1]: Finished Create Static Device Nodes in /dev.
[    2.503487] audit: type=1334 audit(1624283324.278:2): prog-id=5 op=LOAD
[    2.504555] audit: type=1334 audit(1624283324.279:3): prog-id=6 op=LOAD
[    2.506297] systemd[1]: Starting Rule-based Manager for Device Events and Files...
[    2.509881] systemd[1]: Finished Monitoring of LVM2 mirrors, snapshots etc. using dmeventd or progress polling.
[    2.513411] systemd[1]: Started Journal Service.
[    2.787164] virtio_net virtio2 enp0s18: renamed from eth0
[    2.813557] usbcore: registered new interface driver ch341
[    2.815944] usbserial: USB Serial support registered for ch341-uart
[    2.820281] ch341 2-1:1.0: ch341-uart converter detected
[    2.847177] usb 2-1: ch341-uart converter now attached to ttyUSB0
[    2.960241] random: crng init done
[    2.961769] random: 7 urandom warning(s) missed due to ratelimiting
[    3.052485] EXT4-fs (zram1): mounted filesystem without journal. Opts: nobarrier
[    3.054436] ext4 filesystem being mounted at /var supports timestamps until 2038 (0x7fffffff)
[    3.090335] Adding 3064740k swap on /dev/zram0.  Priority:-2 extents:1 across:3064740k SS
[    3.116251] EXT4-fs (zram2): mounted filesystem without journal. Opts: nobarrier
[    3.116935] ext4 filesystem being mounted at /tmp supports timestamps until 2038 (0x7fffffff)
[    3.141228] FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
[    7.168659] EXT4-fs (sda7): mounted filesystem with ordered data mode. Opts: (null)
[    7.169421] ext4 filesystem being mounted at /mnt/overlay supports timestamps until 2038 (0x7fffffff)
[    7.302084] EXT4-fs (sda8): warning: mounting fs with errors, running e2fsck is recommended
[    7.309564] EXT4-fs (sda8): mounted filesystem with ordered data mode. Opts: (null)
[    7.335143] EXT4-fs warning (device sda8): ext4_resize_begin:72: There are errors in the filesystem, so online resizing is not allowed
[    7.364422] systemd-journald[163]: Received client request to flush runtime journal.
[   71.793302] audit: type=1334 audit(1624283393.568:4): prog-id=4 op=UNLOAD
[   71.793307] audit: type=1334 audit(1624283393.568:5): prog-id=3 op=UNLOAD
[   71.799004] audit: type=1334 audit(1624283393.573:6): prog-id=6 op=UNLOAD
[   71.799453] audit: type=1334 audit(1624283393.574:7): prog-id=5 op=UNLOAD
[   72.076216] audit: type=1334 audit(1624283393.851:8): prog-id=7 op=LOAD
[   72.076749] audit: type=1334 audit(1624283393.851:9): prog-id=8 op=LOAD
[   72.096650] audit: type=1334 audit(1624283393.871:10): prog-id=9 op=LOAD
[   72.097026] audit: type=1334 audit(1624283393.871:11): prog-id=10 op=LOAD
[   72.142464] EXT4-fs warning (device sda8): ext4_resize_begin:72: There are errors in the filesystem, so online resizing is not allowed
[   72.213196] audit: type=1400 audit(1624283393.986:12): apparmor="STATUS" operation="profile_load" profile="unconfined" name="1f3d020e_hassos_ssh_configurator_addon" pid=432 comm="apparmor_parser"
[   72.216878] audit: type=1334 audit(1624283393.991:13): prog-id=11 op=LOAD
[   72.425381] cfg80211: Loading compiled-in X.509 certificates for regulatory database
[   72.434699] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
[   75.307691] Initializing XFRM netlink socket
[   75.685574] hassio: port 1(veth95959bd) entered blocking state
[   75.685578] hassio: port 1(veth95959bd) entered disabled state
[   75.685656] device veth95959bd entered promiscuous mode
[   75.685832] hassio: port 1(veth95959bd) entered blocking state
[   75.685835] hassio: port 1(veth95959bd) entered forwarding state
[   75.685866] IPv6: ADDRCONF(NETDEV_CHANGE): hassio: link becomes ready
[   75.686326] hassio: port 1(veth95959bd) entered disabled state
[   76.122789] cgroup: cgroup: disabling cgroup2 socket matching due to net_prio or net_cls activation
[   76.513506] eth0: renamed from veth884d923
[   76.521507] IPv6: ADDRCONF(NETDEV_CHANGE): veth95959bd: link becomes ready
[   76.521551] hassio: port 1(veth95959bd) entered blocking state
[   76.521554] hassio: port 1(veth95959bd) entered forwarding state
[   92.922629] docker0: port 1(vethc0f0c05) entered blocking state
[   92.922645] docker0: port 1(vethc0f0c05) entered disabled state
[   92.922781] device vethc0f0c05 entered promiscuous mode
[   92.922841] kauditd_printk_skb: 80 callbacks suppressed
[   92.922849] audit: type=1700 audit(1624283414.697:92): dev=vethc0f0c05 prom=256 old_prom=0 auid=4294967295 uid=0 gid=0 ses=4294967295
[   92.990146] hassio: port 2(veth5179973) entered blocking state
[   92.990150] hassio: port 2(veth5179973) entered disabled state
[   92.990261] device veth5179973 entered promiscuous mode
[   92.990304] audit: type=1700 audit(1624283414.765:93): dev=veth5179973 prom=256 old_prom=0 auid=4294967295 uid=0 gid=0 ses=4294967295
[   92.990412] hassio: port 2(veth5179973) entered blocking state
[   92.990414] hassio: port 2(veth5179973) entered forwarding state
[   93.346846] eth0: renamed from veth162eecf
[   93.354450] hassio: port 2(veth5179973) entered disabled state
[   93.354535] IPv6: ADDRCONF(NETDEV_CHANGE): vethc0f0c05: link becomes ready
[   93.354575] docker0: port 1(vethc0f0c05) entered blocking state
[   93.354578] docker0: port 1(vethc0f0c05) entered forwarding state
[   93.354636] IPv6: ADDRCONF(NETDEV_CHANGE): docker0: link becomes ready
[   93.426418] audit: type=1325 audit(1624283415.201:94): table=nat family=2 entries=0 op=xt_register pid=1158 subj==unconfined comm="iptables"
[   93.431968] audit: type=1325 audit(1624283415.206:95): table=filter family=2 entries=0 op=xt_register pid=1159 subj==unconfined comm="iptables"
[   93.437358] audit: type=1325 audit(1624283415.212:96): table=nat family=2 entries=5 op=xt_replace pid=1162 subj==unconfined comm="iptables"
[   93.439785] audit: type=1325 audit(1624283415.214:97): table=nat family=2 entries=7 op=xt_replace pid=1163 subj==unconfined comm="iptables"
[   93.445788] audit: type=1325 audit(1624283415.220:98): table=nat family=2 entries=8 op=xt_replace pid=1165 subj==unconfined comm="iptables"
[   93.447466] audit: type=1325 audit(1624283415.222:99): table=nat family=2 entries=10 op=xt_replace pid=1166 subj==unconfined comm="iptables"
[   93.449780] audit: type=1325 audit(1624283415.224:100): table=nat family=2 entries=11 op=xt_replace pid=1167 subj==unconfined comm="iptables"
[   93.451932] audit: type=1325 audit(1624283415.226:101): table=nat family=2 entries=12 op=xt_replace pid=1168 subj==unconfined comm="iptables"
[   93.466605] eth1: renamed from vethe9564da
[   93.477644] IPv6: ADDRCONF(NETDEV_CHANGE): veth5179973: link becomes ready
[   93.477692] hassio: port 2(veth5179973) entered blocking state
[   93.477694] hassio: port 2(veth5179973) entered forwarding state
[   97.937049] hassio: port 3(vethd552a32) entered blocking state
[   97.937053] hassio: port 3(vethd552a32) entered disabled state
[   97.937199] device vethd552a32 entered promiscuous mode
[   97.937236] kauditd_printk_skb: 8 callbacks suppressed
[   97.937237] audit: type=1700 audit(1624283419.712:108): dev=vethd552a32 prom=256 old_prom=0 auid=4294967295 uid=0 gid=0 ses=4294967295
[   98.333868] audit: type=1325 audit(1624283420.108:109): table=nat family=2 entries=0 op=xt_register pid=1846 subj==unconfined comm="iptables"
[   98.338596] audit: type=1325 audit(1624283420.113:110): table=filter family=2 entries=0 op=xt_register pid=1847 subj==unconfined comm="iptables"
[   98.344383] audit: type=1325 audit(1624283420.119:111): table=nat family=2 entries=5 op=xt_replace pid=1850 subj==unconfined comm="iptables"
[   98.346094] audit: type=1325 audit(1624283420.120:112): table=nat family=2 entries=7 op=xt_replace pid=1851 subj==unconfined comm="iptables"
[   98.349248] audit: type=1325 audit(1624283420.124:113): table=nat family=2 entries=8 op=xt_replace pid=1853 subj==unconfined comm="iptables"
[   98.350971] audit: type=1325 audit(1624283420.125:114): table=nat family=2 entries=10 op=xt_replace pid=1854 subj==unconfined comm="iptables"
[   98.353743] audit: type=1325 audit(1624283420.128:115): table=nat family=2 entries=11 op=xt_replace pid=1855 subj==unconfined comm="iptables"
[   98.355975] audit: type=1325 audit(1624283420.130:116): table=nat family=2 entries=12 op=xt_replace pid=1856 subj==unconfined comm="iptables"
[   98.358080] audit: type=1325 audit(1624283420.132:117): table=nat family=2 entries=13 op=xt_replace pid=1857 subj==unconfined comm="iptables"
[   98.372522] eth0: renamed from vethd401656
[   98.378491] IPv6: ADDRCONF(NETDEV_CHANGE): vethd552a32: link becomes ready
[   98.378528] hassio: port 3(vethd552a32) entered blocking state
[   98.378530] hassio: port 3(vethd552a32) entered forwarding state
[   99.376320] hassio: port 4(veth795bd81) entered blocking state
[   99.376323] hassio: port 4(veth795bd81) entered disabled state
[   99.376431] device veth795bd81 entered promiscuous mode
[   99.937715] eth0: renamed from veth61cc157
[   99.955450] IPv6: ADDRCONF(NETDEV_CHANGE): veth795bd81: link becomes ready
[   99.955514] hassio: port 4(veth795bd81) entered blocking state
[   99.955517] hassio: port 4(veth795bd81) entered forwarding state
[  100.549467] hassio: port 5(veth861864e) entered blocking state
[  100.549471] hassio: port 5(veth861864e) entered disabled state
[  100.549576] device veth861864e entered promiscuous mode
[  101.015413] eth0: renamed from veth25d1f1d
[  101.023674] IPv6: ADDRCONF(NETDEV_CHANGE): veth861864e: link becomes ready
[  101.023748] hassio: port 5(veth861864e) entered blocking state
[  101.023752] hassio: port 5(veth861864e) entered forwarding state
[  108.250635] hassio: port 6(vetha561a7b) entered blocking state
[  108.250638] hassio: port 6(vetha561a7b) entered disabled state
[  108.250846] device vetha561a7b entered promiscuous mode
[  108.250946] kauditd_printk_skb: 23 callbacks suppressed
[  108.250948] audit: type=1700 audit(1624283430.033:141): dev=vetha561a7b prom=256 old_prom=0 auid=4294967295 uid=0 gid=0 ses=4294967295
[  108.306343] audit: type=1325 audit(1624283430.088:142): table=nat family=2 entries=17 op=xt_replace pid=3294 subj==unconfined comm="iptables"
[  108.310955] audit: type=1325 audit(1624283430.093:143): table=filter family=2 entries=36 op=xt_replace pid=3296 subj==unconfined comm="iptables"
[  108.316082] audit: type=1325 audit(1624283430.098:144): table=nat family=2 entries=18 op=xt_replace pid=3298 subj==unconfined comm="iptables"
[  108.701002] audit: type=1325 audit(1624283430.484:145): table=nat family=2 entries=0 op=xt_register pid=3378 subj==unconfined comm="iptables"
[  108.708258] audit: type=1325 audit(1624283430.491:146): table=filter family=2 entries=0 op=xt_register pid=3380 subj==unconfined comm="iptables"
[  108.715157] audit: type=1325 audit(1624283430.498:147): table=nat family=2 entries=5 op=xt_replace pid=3384 subj==unconfined comm="iptables"
[  108.717073] audit: type=1325 audit(1624283430.500:148): table=nat family=2 entries=7 op=xt_replace pid=3385 subj==unconfined comm="iptables"
[  108.720576] audit: type=1325 audit(1624283430.503:149): table=nat family=2 entries=8 op=xt_replace pid=3387 subj==unconfined comm="iptables"
[  108.723107] audit: type=1325 audit(1624283430.506:150): table=nat family=2 entries=10 op=xt_replace pid=3388 subj==unconfined comm="iptables"
[  108.745354] eth0: renamed from vetha370d50
[  108.755153] IPv6: ADDRCONF(NETDEV_CHANGE): vetha561a7b: link becomes ready
[  108.755212] hassio: port 6(vetha561a7b) entered blocking state
[  108.755214] hassio: port 6(vetha561a7b) entered forwarding state
[  114.452139] hassio: port 7(veth2090542) entered blocking state
[  114.452145] hassio: port 7(veth2090542) entered disabled state
[  114.452413] device veth2090542 entered promiscuous mode
[  114.452461] kauditd_printk_skb: 4 callbacks suppressed
[  114.452463] audit: type=1700 audit(1624283436.241:155): dev=veth2090542 prom=256 old_prom=0 auid=4294967295 uid=0 gid=0 ses=4294967295
[  114.855897] audit: type=1325 audit(1624283436.645:156): table=nat family=2 entries=0 op=xt_register pid=6297 subj==unconfined comm="iptables"
[  114.860495] audit: type=1325 audit(1624283436.650:157): table=filter family=2 entries=0 op=xt_register pid=6298 subj==unconfined comm="iptables"
[  114.866472] audit: type=1325 audit(1624283436.656:158): table=nat family=2 entries=5 op=xt_replace pid=6301 subj==unconfined comm="iptables"
[  114.868125] audit: type=1325 audit(1624283436.657:159): table=nat family=2 entries=7 op=xt_replace pid=6302 subj==unconfined comm="iptables"
[  114.871309] audit: type=1325 audit(1624283436.660:160): table=nat family=2 entries=8 op=xt_replace pid=6304 subj==unconfined comm="iptables"
[  114.873080] audit: type=1325 audit(1624283436.662:161): table=nat family=2 entries=10 op=xt_replace pid=6305 subj==unconfined comm="iptables"
[  114.875506] audit: type=1325 audit(1624283436.665:162): table=nat family=2 entries=11 op=xt_replace pid=6306 subj==unconfined comm="iptables"
[  114.877896] audit: type=1325 audit(1624283436.667:163): table=nat family=2 entries=12 op=xt_replace pid=6307 subj==unconfined comm="iptables"
[  114.880051] audit: type=1325 audit(1624283436.669:164): table=nat family=2 entries=13 op=xt_replace pid=6308 subj==unconfined comm="iptables"
[  114.896538] eth0: renamed from veth11503c4
[  114.910644] IPv6: ADDRCONF(NETDEV_CHANGE): veth2090542: link becomes ready
[  114.910704] hassio: port 7(veth2090542) entered blocking state
[  114.910707] hassio: port 7(veth2090542) entered forwarding state
[  115.446504] hassio: port 8(veth3c1ae08) entered blocking state
[  115.446509] hassio: port 8(veth3c1ae08) entered disabled state
[  115.446599] device veth3c1ae08 entered promiscuous mode
[  115.446898] hassio: port 8(veth3c1ae08) entered blocking state
[  115.446901] hassio: port 8(veth3c1ae08) entered forwarding state
[  115.451849] hassio: port 8(veth3c1ae08) entered disabled state
[  115.926258] eth0: renamed from veth1910f83
[  115.937457] IPv6: ADDRCONF(NETDEV_CHANGE): veth3c1ae08: link becomes ready
[  115.937540] hassio: port 8(veth3c1ae08) entered blocking state
[  115.937542] hassio: port 8(veth3c1ae08) entered forwarding state
[  116.512022] hassio: port 9(veth598ad87) entered blocking state
[  116.512028] hassio: port 9(veth598ad87) entered disabled state
[  116.512114] device veth598ad87 entered promiscuous mode
[  116.512219] hassio: port 9(veth598ad87) entered blocking state
[  116.512221] hassio: port 9(veth598ad87) entered forwarding state
[  116.513630] hassio: port 9(veth598ad87) entered disabled state
[  116.996922] eth0: renamed from veth0aa8389
[  117.004926] IPv6: ADDRCONF(NETDEV_CHANGE): veth598ad87: link becomes ready
[  117.004982] hassio: port 9(veth598ad87) entered blocking state
[  117.004984] hassio: port 9(veth598ad87) entered forwarding state
agners commented 3 years ago

Hm, there are still errors:

[    7.335143] EXT4-fs warning (device sda8): ext4_resize_begin:72: There are errors in the filesystem, so online resizing is not allowed

When it gets stuck during boot up, and you use "enter" instead of Ctrl+D, you should get a root prompt where a manual fsck with the following commands should be possible:

umount -A /dev/disk/by-label/hassos-data
fsck.ext4 /dev/disk/by-label/hassos-data

From a running system, you get to a similar state using systemctl isolate rescue.target and systemctl stop systemd-journald.

MrAlfabet commented 3 years ago

umount: /var/log/journal: target is busy.

Even at the boot hang....

I did get the 'cant fscheck' error again though, even though the cmdline.txt still contains the fsck=yes line.

MrAlfabet commented 3 years ago

Alright, after stopping systemd-journald I could unmount the data volume. Check started and gave me the following things:

Inodes that were part of a corrupted orphan linked list found. (8 fixed)
Deleted inode XXXXXX has zero dtime.
Block bitmap differences: a lot of numbers here
Free blocks count wrong for group #30 (8458, counted 9002).
Same for group #209
Free block count wrong
Inode bitmap differences: more numbers
more lines with free inodes count wrong

rebooted, and everything works fine now!

So, to recap:

Press <enter> when the system stops during boot
systemctl stop systemd-journald
umount -A /dev/disk/by-label/hassos-data
fsck.ext4 /dev/disk/by-label/hassos-data
Keep pressing <enter> through all the prompts
reboot
agners commented 3 years ago

Cool, thanks for the update.

I did get the 'cant fscheck' error again though, even though the cmdline.txt still contains the fsck=yes line.

Did you had the fsck.repair=yes (note the repair) option set? From what I understand this should be equivalent to run ext4.fsck -y, so I am a bit surprised that this did not resolve the issue on its own.

MrAlfabet commented 3 years ago

Did you had the fsck.repair=yes (note the repair) option set? From what I understand this should be equivalent to run ext4.fsck -y, so I am a bit surprised that this did not resolve the issue on its own.

Yea, I did have it set. Removed it again now that everything is working.

bgautrea commented 3 years ago

So, to recap:

Press <enter> when the system stops during boot
systemctl stop systemd-journald
umount -A /dev/disk/by-label/hassos-data
fsck.ext4 /dev/disk/by-label/hassos-data
Keep pressing <enter> through all the prompts
reboot

Thank you @MrAlfabet for this summary... worked for me too!

tvl9ops commented 3 years ago

Had the same problem, your solution worked for me, too. Thanks!

LeatheryStranger commented 3 years ago

Had the same problem, your solution worked for me, too. Thanks!

Silverridge commented 2 years ago

Thanks @MrAlfabet, this resolved my most annoying problem too!

josedeone commented 2 years ago

So, to recap:

Press <enter> when the system stops during boot
systemctl stop systemd-journald
umount -A /dev/disk/by-label/hassos-data
fsck.ext4 /dev/disk/by-label/hassos-data
Keep pressing <enter> through all the prompts
reboot

Thank you @MrAlfabet for this summary... worked for me too!

thank you it wokk here aswell

agners commented 1 year ago

It seems that often systemd-journald is immeaditly started after stopping. To stop systemd-journald and all its socket activators entirely to successfully unmount, use this command before stopping systemd-journald:

systemctl stop systemd-journald-audit.socket systemd-journald-dev-log.socket systemd-journald.socket

So:

Press <enter> when the system stops during boot
systemctl stop systemd-journald-audit.socket systemd-journald-dev-log.socket systemd-journald.socket systemd-journald.service 
umount -A /dev/disk/by-label/hassos-data
fsck.ext4 /dev/disk/by-label/hassos-data
Keep pressing <enter> through all the prompts
reboot
MrAlfabet commented 1 year ago

@agners two remarks: the disable --now already performs a stop of the service, and if you fully disable these services, you'll have to enable them afterwards (which you're not doing for some reason) or you could run into trouble later.

agners commented 1 year ago

@agners two remarks: the disable --now already performs a stop of the service

Hm, are you sure this is the case? I only list .socket in that command.

you'll have to enable them afterwards

HAOS does not have a writeable /etc, so disable will only be a runtime disable. But yeah, --now just stops them immediately, probably systemctl stop is what we want actually. I've updated the comment.

Fonsos commented 1 year ago

I'm having this issue after update to Home Assistant OS 10.4, but after running

umount -A /dev/disk/by-label/hassos-data

I got this: image

After changing the order of the first line to stop journald.service, I cant unmount the disk because /mnt/data is busy

Is there any way I can get the system running or should I get a new VM created and use yesterday's backup?

Thanks for your help!

agners commented 1 year ago

It would be interesting what is the culprit that the Grow service fails. Do you have EXT4 warnings as well in dmesg? (you can also check journalctl -k -b 0, or journalctl -k -b -1 for the previous boot).

Fonsos commented 1 year ago

This are the last lines of the log:

image
mykm203 commented 1 year ago

I also have the same problem with rescue mode. After Press when the system stops during boot systemctl stop systemd-journald-audit.socket systemd-journald-dev-log.socket systemd-journald.socket systemd-journald.service umount -A /dev/disk/by-label/hassos-data Still have /mnt/data/ - target is busy Looks like systemd-journald immediately restarted. Could you help with restoring HA.

HA Last version

costa-alex commented 1 year ago

I also have the same problem with rescue mode. After Press when the system stops during boot systemctl stop systemd-journald-audit.socket systemd-journald-dev-log.socket systemd-journald.socket systemd-journald.service umount -A /dev/disk/by-label/hassos-data Still have /mnt/data/ - target is busy Looks like systemd-journald immediately restarted. Could you help with restoring HA.

HA Last version

Having the same issue. Even after the systemctl stop command, the umount always returns target is busy.

Any help is appreciated. Thanks

agners commented 1 year ago

Since HAOS 10.x swap space is active on the same partition. Besides stopping all the service, use swapoff -a as well.

mykm203 commented 1 year ago

Thanks a lot. It's unmounted, but stillnot fixed. Given error: "Couldn't fix parent of inode 137432: Couldn't find parent directory entry"

In previous msg stated NULL inode, should be /lost+found

agners commented 1 year ago

This sounds like a corrupted file system, unfortunately :cry: I'd recommend to set up a new system, potentially replace hardware if you suspect hardware failure.

mykm203 commented 1 year ago

Yes.it's corrupted file system, it was VirtualBox disk. Really I need obly to extract last full backup. Can you assist how to do it?

agners commented 1 year ago

This really gets into data recovery. It is also possible that your backups are not recoverable anymore. But this issue tracker is not really the place to discuss these kinds of recovery steps.

I'd suggest to search for VirtualBox data recovery how-to's. Once you have access to the disk/data, the partition labeled hassos-data contains the backups. They are stored in the supervisor -> backups directory. The name is part of the metadata inside the backups so its a bit hard to pick the last. Probably best is to sort by date and pick the last large backup (which presumably is a full backup).

piotrek204 commented 6 months ago

Hi, I have a very similar issue, but in my case it's executable/dev/bin/plymouth is missing, skipping: No such file or directory. I can do "unmounted" as described above but after reboot still the same situation.

remarkov commented 5 months ago

Hi @piotrek204 , not sure if you managed to fix your issue, but I just stumbled across the similar issue with my HA setup after a double power failure and had to spend a couple of hours before I figured out how to fix it. First of all, I also had this executable/dev/bin/plymouth is missing, skipping: No such file or directory. as the last entry in the journal but that's not the reason for the failure to boot. During many reboots I did I notice that there's another error that quickly shows up during the boot. It was saying 

Failed to start Docker Application Container Engine.
See 'systemctl status docker.service' for details.

That gave me the clue that something is wrong with the docker service. I tried to start the service manually and got immediately rebooted. After some more searching I found this article and decided to try the trick with local-kv.db. Apparently in HA the file location is different so I ended up with just 

# mv /mnt/data/docker/network/files/local-kv.db /tmp/old-local-kv.db
# reboot

And the next boot HA loaded properly without any errors and all my config was present, no issues, no backup restore needed. Even if you already managed to fix your issue I am leaving my solution here to save time for someone else in the future.

sylwinc commented 1 month ago

Thank you very much for your post, it worked for me as well!!! You've saved me few hours to find the solution.