home-assistant / operating-system

:beginner: Home Assistant Operating System
Apache License 2.0
4.93k stars 972 forks source link

HassOS - ohci-pci HC died; cleaning up => USB devices disconnecting #612

Closed boesing closed 4 years ago

boesing commented 4 years ago
HassOS release with the issue: arch x86_64
dev false
docker true
hassio true
os_name Linux
os_version 4.19.107
python_version 3.7.7
timezone Europe/Berlin
version 0.107.5
virtualenv false

Supervisor logs: None.

Journal logs: None as of hassOS

Kernel logs:

[    0.000000] Linux version 4.19.107 (builder@6e8f57a351c2) (gcc version 7.4.0 (Buildroot 2019.02.9-g834754d9)) #1 SMP Fri Mar 6 14:07:57 UTC 2020
[    0.000000] Command line: apparmor=1 security=apparmor console=tty1 bootchooser.active=A root=PARTUUID=8d3d53e3-6d49-4c38-8349-aff6859e82fd rootfstype=squashfs ro rootwait zram.enabled=1 zram.num_devices=3
[    0.000000] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'
[    0.000000] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'
[    0.000000] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'
[    0.000000] x86/fpu: xstate_offset[2]:  576, xstate_sizes[2]:  256
[    0.000000] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format.
[    0.000000] BIOS-provided physical RAM map:
[    0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable
[    0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003dd63fff] usable
[    0.000000] BIOS-e820: [mem 0x000000003dd64000-0x000000003dd64fff] ACPI data
[    0.000000] BIOS-e820: [mem 0x000000003dd65000-0x000000003de90fff] usable
[    0.000000] BIOS-e820: [mem 0x000000003de91000-0x000000003df1afff] reserved
[    0.000000] BIOS-e820: [mem 0x000000003df1b000-0x000000003ef9afff] usable
[    0.000000] BIOS-e820: [mem 0x000000003ef9b000-0x000000003eff2fff] reserved
[    0.000000] BIOS-e820: [mem 0x000000003eff3000-0x000000003effafff] ACPI data
[    0.000000] BIOS-e820: [mem 0x000000003effb000-0x000000003effefff] ACPI NVS
[    0.000000] BIOS-e820: [mem 0x000000003efff000-0x000000003f46afff] usable
[    0.000000] BIOS-e820: [mem 0x000000003f46b000-0x000000003ffeffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000ffc00000-0x00000000ffffffff] reserved
[    0.000000] NX (Execute Disable) protection: active
[    0.000000] efi: EFI v2.70 by EDK II
[    0.000000] efi:  ACPI=0x3effa000  ACPI 2.0=0x3effa014  SMBIOS=0x3effd000  MPS=0x3effc000 
[    0.000000] SMBIOS 2.5 present.
[    0.000000] DMI: innotek GmbH VirtualBox/VirtualBox, BIOS VirtualBox 12/01/2006
[    0.000000] Hypervisor detected: KVM
[    0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
[    0.000000] kvm-clock: cpu 0, msr 9791001, primary cpu clock
[    0.000000] kvm-clock: using sched offset of 2817919756 cycles
[    0.000001] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
[    0.000003] tsc: Detected 2808.000 MHz processor
[    0.001878] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
[    0.001879] e820: remove [mem 0x000a0000-0x000fffff] usable
[    0.001882] last_pfn = 0x3f46b max_arch_pfn = 0x400000000
[    0.001890] MTRR default type: uncachable
[    0.001891] MTRR variable ranges disabled:
[    0.001891] Disabled
[    0.001892] x86/PAT: MTRRs disabled, skipping PAT initialization too.
[    0.001893] CPU MTRRs all blank - virtualized system.
[    0.001895] x86/PAT: Configuration [0-7]: WB  WT  UC- UC  WB  WT  UC- UC  
[    0.001936] found SMP MP-table at [mem 0x0009fff0-0x0009ffff]
[    0.001948] Scanning 1 areas for low memory corruption
[    0.001968] BRK [0x09a01000, 0x09a01fff] PGTABLE
[    0.001970] BRK [0x09a02000, 0x09a02fff] PGTABLE
[    0.001970] BRK [0x09a03000, 0x09a03fff] PGTABLE
[    0.001987] BRK [0x09a04000, 0x09a04fff] PGTABLE
[    0.002035] BRK [0x09a05000, 0x09a05fff] PGTABLE
[    0.002047] BRK [0x09a06000, 0x09a06fff] PGTABLE
[    0.002092] BRK [0x09a07000, 0x09a07fff] PGTABLE
[    0.002123] BRK [0x09a08000, 0x09a08fff] PGTABLE
[    0.002143] Secure boot disabled
[    0.002149] ACPI: Early table checksum verification disabled
[    0.002151] ACPI: RSDP 0x000000003EFFA014 000024 (v02 VBOX  )
[    0.002154] ACPI: XSDT 0x000000003EFF90E8 000044 (v01 VBOX   VBOXFACP 00000001      01000013)
[    0.002159] ACPI: FACP 0x000000003EFF7000 0000F4 (v04 VBOX   VBOXFACP 00000001 ASL  00000061)
[    0.002163] ACPI: DSDT 0x000000003EFF4000 002325 (v02 VBOX   VBOXBIOS 00000002 INTL 20100528)
[    0.002165] ACPI: FACS 0x000000003EFFE000 000040
[    0.002168] ACPI: APIC 0x000000003EFF8000 000054 (v02 VBOX   VBOXAPIC 00000001 ASL  00000061)
[    0.002170] ACPI: SSDT 0x000000003EFF3000 0001CC (v01 VBOX   VBOXCPUT 00000002 INTL 20100528)
[    0.002172] ACPI: BGRT 0x000000003DD64000 000038 (v01 INTEL  EDK2     00000002      01000013)
[    0.002178] ACPI: Local APIC address 0xfee00000
[    0.002461] No NUMA configuration found
[    0.002462] Faking a node at [mem 0x0000000000000000-0x000000003f46afff]
[    0.002464] NODE_DATA(0) allocated [mem 0x3f214000-0x3f217fff]
[    0.002475] Zone ranges:
[    0.002476]   DMA      [mem 0x0000000000001000-0x0000000000ffffff]
[    0.002478]   DMA32    [mem 0x0000000001000000-0x000000003f46afff]
[    0.002478]   Normal   empty
[    0.002479] Movable zone start for each node
[    0.002480] Early memory node ranges
[    0.002481]   node   0: [mem 0x0000000000001000-0x000000000009ffff]
[    0.002481]   node   0: [mem 0x0000000000100000-0x000000003dd63fff]
[    0.002482]   node   0: [mem 0x000000003dd65000-0x000000003de90fff]
[    0.002482]   node   0: [mem 0x000000003df1b000-0x000000003ef9afff]
[    0.002483]   node   0: [mem 0x000000003efff000-0x000000003f46afff]
[    0.004543] Zeroed struct page in unavailable ranges: 3301 pages
[    0.004545] Initmem setup node 0 [mem 0x0000000000001000-0x000000003f46afff]
[    0.004548] On node 0 totalpages: 258843
[    0.004549]   DMA zone: 64 pages used for memmap
[    0.004549]   DMA zone: 22 pages reserved
[    0.004549]   DMA zone: 3999 pages, LIFO batch:0
[    0.004618]   DMA32 zone: 3986 pages used for memmap
[    0.004619]   DMA32 zone: 254844 pages, LIFO batch:63
[    0.013746] ACPI: PM-Timer IO Port: 0xb008
[    0.013750] ACPI: Local APIC address 0xfee00000
[    0.013790] IOAPIC[0]: apic_id 1, version 32, address 0xfec00000, GSI 0-23
[    0.013793] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
[    0.013795] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 low level)
[    0.013796] ACPI: IRQ0 used by override.
[    0.013797] ACPI: IRQ9 used by override.
[    0.013798] Using ACPI (MADT) for SMP configuration information
[    0.013803] smpboot: Allowing 1 CPUs, 0 hotplug CPUs
[    0.013819] PM: Registered nosave memory: [mem 0x00000000-0x00000fff]
[    0.013820] PM: Registered nosave memory: [mem 0x000a0000-0x000fffff]
[    0.013821] PM: Registered nosave memory: [mem 0x3dd64000-0x3dd64fff]
[    0.013821] PM: Registered nosave memory: [mem 0x3de91000-0x3df1afff]
[    0.013822] PM: Registered nosave memory: [mem 0x3ef9b000-0x3eff2fff]
[    0.013823] PM: Registered nosave memory: [mem 0x3eff3000-0x3effafff]
[    0.013823] PM: Registered nosave memory: [mem 0x3effb000-0x3effefff]
[    0.013824] [mem 0x3fff0000-0xffbfffff] available for PCI devices
[    0.013825] Booting paravirtualized kernel on KVM
[    0.013827] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
[    0.089467] random: get_random_bytes called from start_kernel+0x8f/0x4bc with crng_init=0
[    0.089474] setup_percpu: NR_CPUS:64 nr_cpumask_bits:64 nr_cpu_ids:1 nr_node_ids:1
[    0.090457] percpu: Embedded 44 pages/cpu s142040 r8192 d29992 u2097152
[    0.090461] pcpu-alloc: s142040 r8192 d29992 u2097152 alloc=1*2097152
[    0.090462] pcpu-alloc: [0] 0 
[    0.090479] Built 1 zonelists, mobility grouping on.  Total pages: 254771
[    0.090479] Policy zone: DMA32
[    0.090494] Kernel command line: apparmor=1 security=apparmor console=tty1 bootchooser.active=A root=PARTUUID=8d3d53e3-6d49-4c38-8349-aff6859e82fd rootfstype=squashfs ro rootwait zram.enabled=1 zram.num_devices=3
[    0.090665] Calgary: detecting Calgary via BIOS EBDA area
[    0.090666] Calgary: Unable to locate Rio Grande table in EBDA - bailing!
[    0.092055] Memory: 964172K/1035372K available (14348K kernel code, 1482K rwdata, 3280K rodata, 1452K init, 2604K bss, 71200K reserved, 0K cma-reserved)
[    0.092893] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
[    0.092897] Kernel/User page tables isolation: enabled
[    0.093724] rcu: Hierarchical RCU implementation.
[    0.093725] rcu:     RCU event tracing is enabled.
[    0.093726] rcu:     RCU restricting CPUs from NR_CPUS=64 to nr_cpu_ids=1.
[    0.093726] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
[    0.093821] NR_IRQS: 4352, nr_irqs: 256, preallocated irqs: 16
[    0.093996] Console: colour dummy device 80x25
[    0.094068] console [tty1] enabled
[    0.094075] ACPI: Core revision 20180810
[    0.094150] APIC: Switch to symmetric I/O mode setup
[    0.094861] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[    0.094876] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2879c5f06f2, max_idle_ns: 440795220049 ns
[    0.094890] Calibrating delay loop (skipped) preset value.. 5616.00 BogoMIPS (lpj=2808000)
[    0.094893] pid_max: default: 32768 minimum: 301
[    0.095901] Security Framework initialized
[    0.095912] AppArmor: AppArmor initialized
[    0.095972] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes)
[    0.096892] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes)
[    0.096899] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes)
[    0.096901] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes)
[    0.097063] process: using mwait in idle threads
[    0.097067] Last level iTLB entries: 4KB 64, 2MB 8, 4MB 8
[    0.097068] Last level dTLB entries: 4KB 64, 2MB 0, 4MB 0, 1GB 4
[    0.097070] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization
[    0.097072] Spectre V2 : Mitigation: Full generic retpoline
[    0.097073] Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch
[    0.097074] Speculative Store Bypass: Vulnerable
[    0.097104] MDS: Mitigation: Clear CPU buffers
[    0.111434] Freeing SMP alternatives memory: 48K
[    0.215199] smpboot: CPU0: Intel(R) Core(TM) i7-8569U CPU @ 2.80GHz (family: 0x6, model: 0x8e, stepping: 0xa)
[    0.215265] Performance Events: unsupported p6 CPU model 142 no PMU driver, software events only.
[    0.215287] rcu: Hierarchical SRCU implementation.
[    0.215357] smp: Bringing up secondary CPUs ...
[    0.215359] smp: Brought up 1 node, 1 CPU
[    0.215360] smpboot: Max logical packages: 1
[    0.215362] smpboot: Total of 1 processors activated (5616.00 BogoMIPS)
[    0.215430] devtmpfs: initialized
[    0.215580] PM: Registering ACPI NVS region [mem 0x3effb000-0x3effefff] (16384 bytes)
[    0.215601] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
[    0.215605] futex hash table entries: 256 (order: 2, 16384 bytes)
[    0.215647] RTC time: 12:12:36, date: 03/24/20
[    0.215692] NET: Registered protocol family 16
[    0.215762] audit: initializing netlink subsys (disabled)
[    0.215829] cpuidle: using governor menu
[    0.215878] ACPI: bus type PCI registered
[    0.215878] PCI: Using configuration type 1 for base access
[    0.217891] audit: type=2000 audit(1585051960.403:1): state=initialized audit_enabled=0 res=1
[    0.220796] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
[    0.220893] ACPI: Added _OSI(Module Device)
[    0.220895] ACPI: Added _OSI(Processor Device)
[    0.220896] ACPI: Added _OSI(3.0 _SCP Extensions)
[    0.220897] ACPI: Added _OSI(Processor Aggregator Device)
[    0.220899] ACPI: Added _OSI(Linux-Dell-Video)
[    0.220900] ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio)
[    0.222128] ACPI: 2 ACPI AML tables successfully acquired and loaded
[    0.224258] ACPI: Interpreter enabled
[    0.224266] ACPI: (supports S0 S5)
[    0.224268] ACPI: Using IOAPIC for interrupt routing
[    0.224365] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[    0.224436] ACPI: Enabled 2 GPEs in block 00 to 07
[    0.227314] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[    0.227318] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI]
[    0.227479] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI]
[    0.227484] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge.
[    0.227557] PCI host bridge to bus 0000:00
[    0.227560] pci_bus 0000:00: root bus resource [io  0x0000-0x0cf7 window]
[    0.227561] pci_bus 0000:00: root bus resource [io  0x0d00-0xffff window]
[    0.227563] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
[    0.227565] pci_bus 0000:00: root bus resource [mem 0x40000000-0xfdffffff window]
[    0.227567] pci_bus 0000:00: root bus resource [bus 00-ff]
[    0.227610] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000
[    0.228189] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100
[    0.228934] pci 0000:00:01.1: [8086:7111] type 00 class 0x01018a
[    0.229279] pci 0000:00:01.1: reg 0x20: [io  0xc180-0xc18f]
[    0.229420] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io  0x01f0-0x01f7]
[    0.229423] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io  0x03f6]
[    0.229424] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io  0x0170-0x0177]
[    0.229426] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io  0x0376]
[    0.229688] pci 0000:00:02.0: [15ad:0405] type 00 class 0x030000
[    0.230093] pci 0000:00:02.0: reg 0x10: [io  0xc170-0xc17f]
[    0.230537] pci 0000:00:02.0: reg 0x14: [mem 0x80000000-0x80ffffff pref]
[    0.230917] pci 0000:00:02.0: reg 0x18: [mem 0x81400000-0x815fffff]
[    0.232898] pci 0000:00:02.0: BAR 1: assigned to efifb
[    0.233244] pci 0000:00:03.0: [8086:100e] type 00 class 0x020000
[    0.233589] pci 0000:00:03.0: reg 0x10: [mem 0x81600000-0x8161ffff]
[    0.233976] pci 0000:00:03.0: reg 0x18: [io  0xc1a0-0xc1a7]
[    0.235435] pci 0000:00:04.0: [80ee:cafe] type 00 class 0x088000
[    0.235948] pci 0000:00:04.0: reg 0x10: [io  0xc140-0xc15f]
[    0.236202] pci 0000:00:04.0: reg 0x14: [mem 0x81000000-0x813fffff]
[    0.236455] pci 0000:00:04.0: reg 0x18: [mem 0x81620000-0x81623fff pref]
[    0.237929] pci 0000:00:05.0: [8086:2415] type 00 class 0x040100
[    0.238162] pci 0000:00:05.0: reg 0x10: [io  0xc000-0xc0ff]
[    0.238249] pci 0000:00:05.0: reg 0x14: [io  0xc100-0xc13f]
[    0.238752] pci 0000:00:06.0: [106b:003f] type 00 class 0x0c0310
[    0.238972] pci 0000:00:06.0: reg 0x10: [mem 0x81626000-0x81626fff]
[    0.240609] pci 0000:00:07.0: [8086:7113] type 00 class 0x068000
[    0.241146] pci 0000:00:07.0: quirk: [io  0xb000-0xb03f] claimed by PIIX4 ACPI
[    0.241159] pci 0000:00:07.0: quirk: [io  0x4100-0x410f] claimed by PIIX4 SMB
[    0.241440] pci 0000:00:0d.0: [8086:2829] type 00 class 0x010601
[    0.241770] pci 0000:00:0d.0: reg 0x10: [io  0xc198-0xc19f]
[    0.241981] pci 0000:00:0d.0: reg 0x14: [io  0xc1ac-0xc1af]
[    0.242902] pci 0000:00:0d.0: reg 0x18: [io  0xc190-0xc197]
[    0.243143] pci 0000:00:0d.0: reg 0x1c: [io  0xc1a8-0xc1ab]
[    0.243376] pci 0000:00:0d.0: reg 0x20: [io  0xc160-0xc16f]
[    0.243606] pci 0000:00:0d.0: reg 0x24: [mem 0x81624000-0x81625fff]
[    0.245195] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 9 10 *11)
[    0.245323] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 9 10 *11)
[    0.245386] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 9 *10 11)
[    0.245462] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 9 *10 11)
[    0.245649] pci 0000:00:02.0: vgaarb: setting as boot VGA device
[    0.245651] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none
[    0.245653] pci 0000:00:02.0: vgaarb: bridge control possible
[    0.245655] vgaarb: loaded
[    0.245712] SCSI subsystem initialized
[    0.245804] libata version 3.00 loaded.
[    0.245838] ACPI: bus type USB registered
[    0.245860] usbcore: registered new interface driver usbfs
[    0.245872] usbcore: registered new interface driver hub
[    0.245877] usbcore: registered new device driver usb
[    0.245878] pps_core: LinuxPPS API ver. 1 registered
[    0.245878] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[    0.245878] PTP clock support registered
[    0.245878] EDAC MC: Ver: 3.0.0
[    0.246093] Registered efivars operations
[    0.246116] Advanced Linux Sound Architecture Driver Initialized.
[    0.246122] PCI: Using ACPI for IRQ routing
[    0.246124] PCI: pci_cache_line_size set to 64 bytes
[    0.246289] e820: reserve RAM buffer [mem 0x3dd64000-0x3fffffff]
[    0.246292] e820: reserve RAM buffer [mem 0x3de91000-0x3fffffff]
[    0.246293] e820: reserve RAM buffer [mem 0x3ef9b000-0x3fffffff]
[    0.246293] e820: reserve RAM buffer [mem 0x3f46b000-0x3fffffff]
[    0.246357] Bluetooth: Core ver 2.22
[    0.246361] NET: Registered protocol family 31
[    0.246362] Bluetooth: HCI device and connection manager initialized
[    0.246367] Bluetooth: HCI socket layer initialized
[    0.246368] Bluetooth: L2CAP socket layer initialized
[    0.246371] Bluetooth: SCO socket layer initialized
[    0.246380] NetLabel: Initializing
[    0.246381] NetLabel:  domain hash size = 128
[    0.246382] NetLabel:  protocols = UNLABELED CIPSOv4 CALIPSO
[    0.246395] NetLabel:  unlabeled traffic allowed by default
[    0.246519] clocksource: Switched to clocksource kvm-clock
[    0.250679] VFS: Disk quotas dquot_6.6.0
[    0.250679] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[    0.250679] AppArmor: AppArmor Filesystem Enabled
[    0.250679] pnp: PnP ACPI init
[    0.250679] pnp 00:00: Plug and Play ACPI device, IDs PNP0303 (active)
[    0.252777] pnp 00:01: Plug and Play ACPI device, IDs PNP0f03 (active)
[    0.253565] pnp: PnP ACPI: found 2 devices
[    0.259674] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
[    0.260134] pci_bus 0000:00: resource 4 [io  0x0000-0x0cf7 window]
[    0.260135] pci_bus 0000:00: resource 5 [io  0x0d00-0xffff window]
[    0.260136] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]
[    0.260136] pci_bus 0000:00: resource 7 [mem 0x40000000-0xfdffffff window]
[    0.260168] NET: Registered protocol family 2
[    0.260244] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes)
[    0.260255] TCP established hash table entries: 8192 (order: 4, 65536 bytes)
[    0.260263] TCP bind hash table entries: 8192 (order: 5, 131072 bytes)
[    0.260270] TCP: Hash tables configured (established 8192 bind 8192)
[    0.260290] UDP hash table entries: 512 (order: 2, 16384 bytes)
[    0.260293] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes)
[    0.260311] NET: Registered protocol family 1
[    0.260359] RPC: Registered named UNIX socket transport module.
[    0.260360] RPC: Registered udp transport module.
[    0.260362] RPC: Registered tcp transport module.
[    0.260363] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    0.260471] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
[    0.260485] pci 0000:00:01.0: Activating ISA DMA hang workarounds
[    0.260543] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
[    0.261366] PCI: CLS 0 bytes, default 64
[    0.261462] RAPL PMU: API unit is 2^-32 Joules, 5 fixed counters, 10737418240 ms ovfl timer
[    0.261464] RAPL PMU: hw unit of domain pp0-core 2^-0 Joules
[    0.261466] RAPL PMU: hw unit of domain package 2^-0 Joules
[    0.261467] RAPL PMU: hw unit of domain dram 2^-0 Joules
[    0.261468] RAPL PMU: hw unit of domain pp1-gpu 2^-0 Joules
[    0.261469] RAPL PMU: hw unit of domain psys 2^-0 Joules
[    0.261472] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2879c5f06f2, max_idle_ns: 440795220049 ns
[    0.261490] platform rtc_cmos: registered platform RTC device (no PNP device found)
[    0.261562] Scanning for low memory corruption every 60 seconds
[    0.261959] Initialise system trusted keyrings
[    0.262067] workingset: timestamp_bits=40 max_order=18 bucket_order=0
[    0.262889] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[    0.262925] NFS: Registering the id_resolver key type
[    0.262925] Key type id_resolver registered
[    0.262925] Key type id_legacy registered
[    0.262925] Key type asymmetric registered
[    0.262925] Asymmetric key parser 'x509' registered
[    0.262925] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251)
[    0.262925] io scheduler noop registered
[    0.262925] io scheduler deadline registered
[    0.262925] io scheduler cfq registered (default)
[    0.262925] io scheduler mq-deadline registered
[    0.262925] io scheduler kyber registered
[    0.262925] hv_vmbus: registering driver hyperv_fb
[    0.262925] efifb: probing for efifb
[    0.262925] efifb: framebuffer at 0x80000000, using 3072k, total 3072k
[    0.262925] efifb: mode is 1024x768x32, linelength=4096, pages=1
[    0.262925] efifb: scrolling: redraw
[    0.262925] efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0
[    0.262925] Console: switching to colour frame buffer device 128x48
[    0.262925] fb0: EFI VGA frame buffer device
[    0.267575] ACPI: AC Adapter [AC] (on-line)
[    0.267670] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0
[    0.267711] ACPI: Power Button [PWRF]
[    0.267831] input: Sleep Button as /devices/LNXSYSTM:00/LNXSLPBN:00/input/input1
[    0.267870] ACPI: Sleep Button [SLPF]
[    0.268140] ACPI: Video Device [GFX0] (multi-head: yes  rom: no  post: no)
[    0.268213] input: Video Bus as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/LNXVIDEO:00/input/input2
[    0.269174] battery: ACPI: Battery Slot [BAT0] (battery present)
[    0.269302] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
[    0.269550] Non-volatile memory driver v1.3
[    0.269599] Linux agpgart interface v0.103
[    0.270789] loop: module loaded
[    0.270902] zram: Added device: zram0
[    0.270978] zram: Added device: zram1
[    0.271171] zram: Added device: zram2
[    0.271211] Guest personality initialized and is inactive
[    0.271298] VMCI host device registered (name=vmci, major=10, minor=62)
[    0.271352] Initialized host personality
[    0.271893] VMware PVSCSI driver - version 1.0.7.0-k
[    0.271942] hv_vmbus: registering driver hv_storvsc
[    0.272079] ahci 0000:00:0d.0: version 3.0
[    0.272453] ahci 0000:00:0d.0: SSS flag set, parallel bus scan disabled
[    0.272596] ahci 0000:00:0d.0: AHCI 0001.0100 32 slots 1 ports 3 Gbps 0x1 impl SATA mode
[    0.273775] ahci 0000:00:0d.0: flags: 64bit ncq stag only ccc 
[    0.274399] scsi host0: ahci
[    0.274781] ata1: SATA max UDMA/133 abar m8192@0x81624000 port 0x81624100 irq 21
[    0.275132] ata_piix 0000:00:01.1: version 2.13
[    0.275581] scsi host1: ata_piix
[    0.275948] scsi host2: ata_piix
[    0.276312] ata2: PATA max UDMA/33 cmd 0x1f0 ctl 0x3f6 bmdma 0xc180 irq 14
[    0.276627] ata3: PATA max UDMA/33 cmd 0x170 ctl 0x376 bmdma 0xc188 irq 15
[    0.277480] tun: Universal TUN/TAP device driver, 1.6
[    0.277865] e100: Intel(R) PRO/100 Network Driver, 3.5.24-k2-NAPI
[    0.278156] e100: Copyright(c) 1999-2006 Intel Corporation
[    0.278986] e1000: Intel(R) PRO/1000 Network Driver - version 7.3.21-k8-NAPI
[    0.279324] e1000: Copyright (c) 1999-2006 Intel Corporation.
[    0.443103] ata3.00: ATAPI: VBOX CD-ROM, 1.0, max UDMA/133
[    0.582895] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
[    0.584783] ata1.00: ATA-6: VBOX HARDDISK, 1.0, max UDMA/133
[    0.585528] ata1.00: 67108864 sectors, multi 128: LBA48 NCQ (depth 32)
[    0.590925] ata1.00: configured for UDMA/133
[    0.591377] scsi 0:0:0:0: Direct-Access     ATA      VBOX HARDDISK    1.0  PQ: 0 ANSI: 5
[    0.591901] sd 0:0:0:0: [sda] 67108864 512-byte logical blocks: (34.4 GB/32.0 GiB)
[    0.592294] sd 0:0:0:0: [sda] Write Protect is off
[    0.592649] sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00
[    0.592654] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[    0.593077] sd 0:0:0:0: Attached scsi generic sg0 type 0
[    0.593743] scsi 2:0:0:0: CD-ROM            VBOX     CD-ROM           1.0  PQ: 0 ANSI: 5
[    0.617478] sr 2:0:0:0: [sr0] scsi3-mmc drive: 32x/32x xa/form2 tray
[    0.619128] cdrom: Uniform CD-ROM driver Revision: 3.20
[    0.619699]  sda: sda1 sda2 sda3 sda4 sda5 sda6 sda7 sda8
[    0.620281] sd 0:0:0:0: [sda] Attached SCSI disk
[    0.620715] sr 2:0:0:0: Attached scsi CD-ROM sr0
[    0.620855] sr 2:0:0:0: Attached scsi generic sg1 type 5
[    0.661176] e1000 0000:00:03.0 eth0: (PCI:33MHz:32-bit) 08:00:27:eb:c2:c8
[    0.662867] e1000 0000:00:03.0 eth0: Intel(R) PRO/1000 Network Connection
[    0.663300] e1000e: Intel(R) PRO/1000 Network Driver - 3.2.6-k
[    0.663674] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
[    0.663858] sky2: driver version 1.30
[    0.663858] VMware vmxnet3 virtual NIC driver - version 1.4.16.0-k-NAPI
[    0.663858] hv_vmbus: registering driver hv_netvsc
[    0.663858] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[    0.663858] ehci-pci: EHCI PCI platform driver
[    0.663858] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[    0.663858] ohci-pci: OHCI PCI platform driver
[    0.667062] ohci-pci 0000:00:06.0: OHCI PCI host controller
[    0.667438] ohci-pci 0000:00:06.0: new USB bus registered, assigned bus number 1
[    0.667849] ohci-pci 0000:00:06.0: irq 22, io mem 0x81626000
[    0.720419] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 4.19
[    0.722176] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    0.722564] usb usb1: Product: OHCI PCI host controller
[    0.722944] usb usb1: Manufacturer: Linux 4.19.107 ohci_hcd
[    0.723167] usb usb1: SerialNumber: 0000:00:06.0
[    0.723167] hub 1-0:1.0: USB hub found
[    0.724246] hub 1-0:1.0: 12 ports detected
[    0.725131] uhci_hcd: USB Universal Host Controller Interface driver
[    0.725555] usbcore: registered new interface driver usblp
[    0.725973] usbcore: registered new interface driver usb-storage
[    0.726403] usbcore: registered new interface driver usbserial_generic
[    0.726773] usbserial: USB Serial support registered for generic
[    0.726945] i8042: PNP: PS/2 Controller [PNP0303:PS2K,PNP0f03:PS2M] at 0x60,0x64 irq 1,12
[    0.727975] serio: i8042 KBD port at 0x60,0x64 irq 1
[    0.728459] serio: i8042 AUX port at 0x60,0x64 irq 12
[    0.729090] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input3
[    0.730344] rtc_cmos rtc_cmos: registered as rtc0
[    0.730732] rtc_cmos rtc_cmos: alarms up to one day, 114 bytes nvram
[    0.731260] device-mapper: ioctl: 4.39.0-ioctl (2018-04-03) initialised: dm-devel@redhat.com
[    0.731651] usbcore: registered new interface driver btusb
[    0.732027] EFI Variables Facility v0.08 2004-May-17
[    0.732125] hidraw: raw HID events driver (C) Jiri Kosina
[    0.732125] usbcore: registered new interface driver usbhid
[    0.732125] usbhid: USB HID core driver
[    0.734693] IPVS: Registered protocols ()
[    0.735074] IPVS: Connection hash table configured (size=4096, memory=64Kbytes)
[    0.735212] IPVS: ipvs loaded.
[    0.735212] IPVS: [rr] scheduler registered.
[    0.736717] NET: Registered protocol family 10
[    0.737199] Segment Routing with IPv6
[    0.737425] sit: IPv6, IPv4 and MPLS over IPv4 tunneling driver
[    0.737425] NET: Registered protocol family 17
[    0.737425] Bridge firewalling registered
[    0.737425] Key type dns_resolver registered
[    0.737425] mce: Using 0 MCE banks
[    0.739778] sched_clock: Marking stable (738771127, 898848)->(740291936, -621961)
[    0.741296] registered taskstats version 1
[    0.741723] Loading compiled-in X.509 certificates
[    0.742108] AppArmor: AppArmor sha1 policy hashing enabled
[    0.742584]   Magic number: 12:225:229
[    0.742975] console [netcon0] enabled
[    0.743313] netconsole: network logging started
[    0.743701] cfg80211: Loading compiled-in X.509 certificates for regulatory database
[    0.744344] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
[    0.744976] ALSA device list:
[    0.745333]   No soundcards found.
[    0.745736] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2
[    0.746278] cfg80211: failed to load regulatory.db
[    0.936688] random: fast init done
[    0.938690] input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input5
[    0.939230] md: Waiting for all devices to be available before autodetect
[    0.939609] md: If you don't use raid, use raid=noautodetect
[    0.940097] md: Autodetecting RAID arrays.
[    0.940460] md: autorun ...
[    0.940819] md: ... autorun DONE.
[    0.942883] VFS: Mounted root (squashfs filesystem) readonly on device 8:3.
[    0.945920] devtmpfs: mounted
[    0.947231] Freeing unused kernel image memory: 1452K
[    0.949043] Write protecting the kernel read-only data: 20480k
[    0.949716] Freeing unused kernel image memory: 2000K
[    0.950199] Freeing unused kernel image memory: 816K
[    0.950577] Run /sbin/init as init process
[    0.994792] systemd[1]: systemd 240 running in system mode. (-PAM -AUDIT -SELINUX -IMA -APPARMOR -SMACK +SYSVINIT +UTMP -LIBCRYPTSETUP +GCRYPT -GNUTLS -ACL -XZ -LZ4 -SECCOMP +BLKID -ELFUTILS +KMOD -IDN2 -IDN -PCRE2 default-hierarchy=hybrid)
[    0.996841] systemd[1]: Detected virtualization oracle.
[    0.997229] systemd[1]: Detected architecture x86-64.
[    1.002321] systemd[1]: Set hostname to <homeassistant>.
[    1.003511] systemd[1]: Initializing machine ID from random generator.
[    1.003982] systemd[1]: Installed transient /etc/machine-id file.
[    1.004794] systemd[1]: Failed to bump fs.file-max, ignoring: Invalid argument
[    1.043940] systemd[1]: /usr/lib/systemd/system/vmtoolsd.service:7: PIDFile= references path below legacy directory /var/run/, updating /var/run/vmtoolsd.pid → /run/vmtoolsd.pid; please update the unit file accordingly.
[    1.058785] systemd[1]: Listening on udev Control Socket.
[    1.062854] systemd[1]: Starting HassOS ZRAM tmp...
[    1.082371] zram2: detected capacity change from 0 to 16777216
[    1.103346] zram0: detected capacity change from 0 to 253788160
[    1.124384] zram1: detected capacity change from 0 to 33554432
[    1.129651] usb 1-1: new full-speed USB device number 2 using ohci-pci
[    1.264350] e1000 0000:00:03.0 enp0s3: renamed from eth0
[    1.391404] usb 1-1: New USB device found, idVendor=80ee, idProduct=0021, bcdDevice= 1.00
[    1.393074] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=0
[    1.393446] usb 1-1: Product: USB Tablet
[    1.393807] usb 1-1: Manufacturer: VirtualBox
[    1.405071] input: VirtualBox USB Tablet as /devices/pci0000:00/0000:00:06.0/usb1/1-1/1-1:1.0/0003:80EE:0021.0001/input/input6
[    1.411377] hid-generic 0003:80EE:0021.0001: input,hidraw0: USB HID v1.10 Mouse [VirtualBox USB Tablet] on usb-0000:00:06.0-1/input0
[    1.477345] FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
[    1.508196] EXT4-fs (sda7): 1 orphan inode deleted
[    1.508593] EXT4-fs (sda7): recovery complete
[    1.513693] EXT4-fs (sda7): mounted filesystem with ordered data mode. Opts: (null)
[    1.627269] random: crng init done
[    1.668609] EXT4-fs (zram1): mounted filesystem without journal. Opts: nobarrier
[    1.701007] EXT4-fs (sda8): recovery complete
[    1.713769] systemd-journald[1192]: Received request to flush runtime journal from PID 1
[    1.715260] EXT4-fs (sda8): mounted filesystem with ordered data mode. Opts: (null)
[    1.750868] Adding 247836k swap on /dev/zram0.  Priority:-2 extents:1 across:247836k SS
[    1.777964] EXT4-fs (zram2): mounted filesystem without journal. Opts: nobarrier
[    2.165293] audit: type=1400 audit(1585051962.352:2): apparmor="STATUS" operation="profile_load" profile="unconfined" name="hassio-supervisor" pid=2426 comm="apparmor_parser"
[    2.165907] audit: type=1400 audit(1585051962.352:2): apparmor="STATUS" operation="profile_load" profile="unconfined" name="hassio-supervisor///usr/bin/gdbus" pid=2426 comm="apparmor_parser"
[    2.166752] audit: type=1400 audit(1585051962.352:2): apparmor="STATUS" operation="profile_load" profile="unconfined" name="hassio-supervisor///usr/bin/git" pid=2426 comm="apparmor_parser"
[    2.169738] audit: type=1400 audit(1585051962.352:2): apparmor="STATUS" operation="profile_load" profile="unconfined" name="hassio-supervisor///usr/bin/socat" pid=2426 comm="apparmor_parser"
[    2.171670] audit: type=1300 audit(1585051962.352:2): arch=c000003e syscall=1 success=yes exit=69732 a0=6 a1=7f02a4066010 a2=11064 a3=fc items=0 ppid=2425 pid=2426 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="apparmor_parser" exe="/usr/sbin/apparmor_parser" subj==unconfined key=(null)
[    2.174628] audit: type=1327 audit(1585051962.352:2): proctitle=61707061726D6F725F706172736572002D72002D57002D4C002F6D6E742F646174612F73757065727669736F722F61707061726D6F722F6361636865002F6D6E742F646174612F73757065727669736F722F61707061726D6F722F68617373696F2D73757065727669736F72
[    2.202723] IPv6: ADDRCONF(NETDEV_UP): enp0s3: link is not ready
[    2.207228] IPv6: ADDRCONF(NETDEV_UP): enp0s3: link is not ready
[    4.224059] e1000: enp0s3 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: RX
[    4.226185] IPv6: ADDRCONF(NETDEV_CHANGE): enp0s3: link becomes ready
[    4.836929] audit: type=1400 audit(1585051965.024:3): apparmor="STATUS" operation="profile_load" profile="unconfined" name="docker-default" pid=2477 comm="apparmor_parser"
[    4.839356] audit: type=1300 audit(1585051965.024:3): arch=c000003e syscall=1 success=yes exit=7945 a0=4 a1=10bcc40 a2=1f09 a3=fc items=0 ppid=2476 pid=2477 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="apparmor_parser" exe="/usr/sbin/apparmor_parser" subj==unconfined key=(null)
[    4.840871] audit: type=1327 audit(1585051965.024:3): proctitle=61707061726D6F725F706172736572002D4B72002F6D6E742F646174612F646F636B65722F746D702F646F636B65722D64656661756C74313032343832363338
[    5.126510] Initializing XFRM netlink socket
[    5.164432] IPv6: ADDRCONF(NETDEV_UP): docker0: link is not ready
[    5.203534] IPv6: ADDRCONF(NETDEV_UP): hassio: link is not ready
[    5.225450] kauditd_printk_skb: 93 callbacks suppressed
[    5.225450] audit: type=1325 audit(1585051965.412:35): table=nat family=2 entries=15
[    5.227905] audit: type=1300 audit(1585051965.412:35): arch=c000003e syscall=54 success=yes exit=0 a0=4 a1=0 a2=40 a3=256a480 items=0 ppid=2454 pid=2593 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="iptables" exe="/usr/sbin/xtables-legacy-multi" subj==unconfined key=(null)
[    5.231609] audit: type=1327 audit(1585051965.412:35): proctitle=2F7573722F7362696E2F69707461626C6573002D2D77616974002D74006E6174002D4100444F434B4552002D7000746370002D6400302F30002D2D64706F72740038383834002D6A00444E4154002D2D746F2D64657374696E6174696F6E003137322E33302E33332E303A383838340000002D690068617373696F
[    5.236324] audit: type=1325 audit(1585051965.417:36): table=filter family=2 entries=26
[    5.239581] audit: type=1300 audit(1585051965.417:36): arch=c000003e syscall=54 success=yes exit=0 a0=4 a1=0 a2=40 a3=2626300 items=0 ppid=2454 pid=2595 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="iptables" exe="/usr/sbin/xtables-legacy-multi" subj==unconfined key=(null)
[    5.243772] audit: type=1327 audit(1585051965.417:36): proctitle=2F7573722F7362696E2F69707461626C6573002D2D77616974002D740066696C746572002D4100444F434B45520000002D690068617373696F002D6F0068617373696F002D7000746370002D64003137322E33302E33332E30002D2D64706F72740038383834002D6A00414343455054
[    5.245689] audit: type=1325 audit(1585051965.421:37): table=nat family=2 entries=16
[    5.246340] audit: type=1300 audit(1585051965.421:37): arch=c000003e syscall=54 success=yes exit=0 a0=4 a1=0 a2=40 a3=19a9580 items=0 ppid=2454 pid=2597 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="iptables" exe="/usr/sbin/xtables-legacy-multi" subj==unconfined key=(null)
[    5.253326] audit: type=1327 audit(1585051965.421:37): proctitle=2F7573722F7362696E2F69707461626C6573002D2D77616974002D74006E6174002D4100504F5354524F5554494E47002D7000746370002D73003137322E33302E33332E30002D64003137322E33302E33332E30002D2D64706F72740038383834002D6A004D415351554552414445
[    5.259190] audit: type=1325 audit(1585051965.431:38): table=nat family=2 entries=17
[    6.461901] docker0: port 1(veth22e24b3) entered blocking state
[    6.463856] docker0: port 1(veth22e24b3) entered disabled state
[    6.466513] device veth22e24b3 entered promiscuous mode
[    6.473830] IPv6: ADDRCONF(NETDEV_UP): veth22e24b3: link is not ready
[    6.487447] hassio: port 1(veth51b33d3) entered blocking state
[    6.489806] hassio: port 1(veth51b33d3) entered disabled state
[    6.494951] device veth51b33d3 entered promiscuous mode
[    6.497923] IPv6: ADDRCONF(NETDEV_UP): veth51b33d3: link is not ready
[    6.498504] hassio: port 1(veth51b33d3) entered blocking state
[    6.499180] hassio: port 1(veth51b33d3) entered forwarding state
[    6.499778] hassio: port 1(veth51b33d3) entered disabled state
[    6.686729] eth0: renamed from veth4dc0623
[    6.688486] IPv6: ADDRCONF(NETDEV_CHANGE): veth22e24b3: link becomes ready
[    6.689017] docker0: port 1(veth22e24b3) entered blocking state
[    6.689529] docker0: port 1(veth22e24b3) entered forwarding state
[    6.690052] IPv6: ADDRCONF(NETDEV_CHANGE): docker0: link becomes ready
[    6.738722] eth1: renamed from vethc070507
[    6.740533] IPv6: ADDRCONF(NETDEV_CHANGE): veth51b33d3: link becomes ready
[    6.741383] hassio: port 1(veth51b33d3) entered blocking state
[    6.741861] hassio: port 1(veth51b33d3) entered forwarding state
[    6.742346] IPv6: ADDRCONF(NETDEV_CHANGE): hassio: link becomes ready
[    6.899993] udevd[180]: starting version 3.2.9
[    6.909519] udevd[181]: starting eudev-3.2.9
[    8.634137] hassio: port 2(veth4eaf4b3) entered blocking state
[    8.635790] hassio: port 2(veth4eaf4b3) entered disabled state
[    8.637663] device veth4eaf4b3 entered promiscuous mode
[    8.647906] IPv6: ADDRCONF(NETDEV_UP): veth4eaf4b3: link is not ready
[    8.746218] hassio: port 3(veth92511b6) entered blocking state
[    8.747844] hassio: port 3(veth92511b6) entered disabled state
[    8.751538] device veth92511b6 entered promiscuous mode
[    8.760963] IPv6: ADDRCONF(NETDEV_UP): veth92511b6: link is not ready
[    8.761495] hassio: port 3(veth92511b6) entered blocking state
[    8.761888] hassio: port 3(veth92511b6) entered forwarding state
[    9.053614] eth0: renamed from veth5f42b42
[    9.055633] hassio: port 3(veth92511b6) entered disabled state
[    9.056019] IPv6: ADDRCONF(NETDEV_CHANGE): veth4eaf4b3: link becomes ready
[    9.056382] hassio: port 2(veth4eaf4b3) entered blocking state
[    9.056725] hassio: port 2(veth4eaf4b3) entered forwarding state
[    9.117092] eth0: renamed from veth2ef6538
[    9.118811] IPv6: ADDRCONF(NETDEV_CHANGE): veth92511b6: link becomes ready
[    9.119264] hassio: port 3(veth92511b6) entered blocking state
[    9.119768] hassio: port 3(veth92511b6) entered forwarding state
[    9.433665] udevd[316]: starting version 3.2.9
[    9.443888] udevd[317]: starting eudev-3.2.9
[    9.729111] hassio: port 4(veth320a73b) entered blocking state
[    9.730549] hassio: port 4(veth320a73b) entered disabled state
[    9.735750] device veth320a73b entered promiscuous mode
[    9.739499] IPv6: ADDRCONF(NETDEV_UP): veth320a73b: link is not ready
[    9.940448] eth0: renamed from veth7d0d861
[    9.942203] IPv6: ADDRCONF(NETDEV_CHANGE): veth320a73b: link becomes ready
[    9.942571] hassio: port 4(veth320a73b) entered blocking state
[    9.942910] hassio: port 4(veth320a73b) entered forwarding state
[   15.119211] hassio: port 5(veth1e7a8ee) entered blocking state
[   15.120862] hassio: port 5(veth1e7a8ee) entered disabled state
[   15.122533] device veth1e7a8ee entered promiscuous mode
[   15.123637] kauditd_printk_skb: 311 callbacks suppressed
[   15.123638] audit: type=1700 audit(1585051975.307:141): dev=veth1e7a8ee prom=256 old_prom=0 auid=4294967295 uid=0 gid=0 ses=4294967295
[   15.137747] audit: type=1300 audit(1585051975.307:141): arch=c000003e syscall=44 success=yes exit=40 a0=c a1=c001558c60 a2=28 a3=0 items=0 ppid=1 pid=2454 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="dockerd" exe="/usr/bin/dockerd" subj==unconfined key=(null)
[   15.142166] audit: type=1327 audit(1585051975.307:141): proctitle=2F7573722F62696E2F646F636B657264002D480066643A2F2F002D2D73746F726167652D6472697665723D6F7665726C617932002D2D6C6F672D6472697665723D6A6F75726E616C64002D2D646174612D726F6F74002F6D6E742F646174612F646F636B6572
[   15.144762] IPv6: ADDRCONF(NETDEV_UP): veth1e7a8ee: link is not ready
[   15.221128] hassio: port 6(veth36b4841) entered blocking state
[   15.223175] hassio: port 6(veth36b4841) entered disabled state
[   15.228671] device veth36b4841 entered promiscuous mode
[   15.230253] audit: type=1700 audit(1585051975.409:142): dev=veth36b4841 prom=256 old_prom=0 auid=4294967295 uid=0 gid=0 ses=4294967295
[   15.231890] audit: type=1300 audit(1585051975.409:142): arch=c000003e syscall=44 success=yes exit=40 a0=c a1=c0014d19e0 a2=28 a3=0 items=0 ppid=1 pid=2454 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="dockerd" exe="/usr/bin/dockerd" subj==unconfined key=(null)
[   15.233399] audit: type=1327 audit(1585051975.409:142): proctitle=2F7573722F62696E2F646F636B657264002D480066643A2F2F002D2D73746F726167652D6472697665723D6F7665726C617932002D2D6C6F672D6472697665723D6A6F75726E616C64002D2D646174612D726F6F74002F6D6E742F646174612F646F636B6572
[   15.236282] IPv6: ADDRCONF(NETDEV_UP): veth36b4841: link is not ready
[   15.237012] hassio: port 6(veth36b4841) entered blocking state
[   15.237845] hassio: port 6(veth36b4841) entered forwarding state
[   15.264619] audit: type=1325 audit(1585051975.452:143): table=nat family=2 entries=21
[   15.266365] audit: type=1300 audit(1585051975.452:143): arch=c000003e syscall=54 success=yes exit=0 a0=4 a1=0 a2=40 a3=1add100 items=0 ppid=2454 pid=4404 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="iptables" exe="/usr/sbin/xtables-legacy-multi" subj==unconfined key=(null)
[   15.269569] audit: type=1327 audit(1585051975.452:143): proctitle=2F7573722F7362696E2F69707461626C6573002D2D77616974002D74006E6174002D4100444F434B4552002D7000746370002D6400302F30002D2D64706F72740038343835002D6A00444E4154002D2D746F2D64657374696E6174696F6E003137322E33302E33332E323A383438350000002D690068617373696F
[   15.285717] audit: type=1325 audit(1585051975.471:144): table=filter family=2 entries=33
[   15.558201] eth0: renamed from vethb095cf7
[   15.560098] hassio: port 6(veth36b4841) entered disabled state
[   15.560687] IPv6: ADDRCONF(NETDEV_CHANGE): veth1e7a8ee: link becomes ready
[   15.561307] hassio: port 5(veth1e7a8ee) entered blocking state
[   15.561872] hassio: port 5(veth1e7a8ee) entered forwarding state
[   15.623218] eth0: renamed from vethfc30515
[   15.626528] IPv6: ADDRCONF(NETDEV_CHANGE): veth36b4841: link becomes ready
[   15.627193] hassio: port 6(veth36b4841) entered blocking state
[   15.627765] hassio: port 6(veth36b4841) entered forwarding state
[   21.099453] udevd[180]: starting version 3.2.8
[   21.112317] udevd[181]: starting eudev-3.2.8
[   41.074342] hassio: port 7(vetha80961c) entered blocking state
[   41.076012] hassio: port 7(vetha80961c) entered disabled state
[   41.084874] device vetha80961c entered promiscuous mode
[   41.085524] kauditd_printk_skb: 65 callbacks suppressed
[   41.085525] audit: type=1700 audit(1585051998.354:166): dev=vetha80961c prom=256 old_prom=0 auid=4294967295 uid=0 gid=0 ses=4294967295
[   41.089421] audit: type=1300 audit(1585051998.354:166): arch=c000003e syscall=44 success=yes exit=40 a0=c a1=c0008d1f80 a2=28 a3=0 items=0 ppid=1 pid=2454 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="dockerd" exe="/usr/bin/dockerd" subj==unconfined key=(null)
[   41.091559] audit: type=1327 audit(1585051998.354:166): proctitle=2F7573722F62696E2F646F636B657264002D480066643A2F2F002D2D73746F726167652D6472697665723D6F7665726C617932002D2D6C6F672D6472697665723D6A6F75726E616C64002D2D646174612D726F6F74002F6D6E742F646174612F646F636B6572
[   41.094929] IPv6: ADDRCONF(NETDEV_UP): vetha80961c: link is not ready
[   41.190475] hassio: port 8(vethdba7265) entered blocking state
[   41.192088] hassio: port 8(vethdba7265) entered disabled state
[   41.199815] device vethdba7265 entered promiscuous mode
[   41.201448] audit: type=1700 audit(1585051998.470:167): dev=vethdba7265 prom=256 old_prom=0 auid=4294967295 uid=0 gid=0 ses=4294967295
[   41.203142] audit: type=1300 audit(1585051998.470:167): arch=c000003e syscall=44 success=yes exit=40 a0=c a1=c000b7d020 a2=28 a3=0 items=0 ppid=1 pid=2454 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="dockerd" exe="/usr/bin/dockerd" subj==unconfined key=(null)
[   41.205787] audit: type=1327 audit(1585051998.470:167): proctitle=2F7573722F62696E2F646F636B657264002D480066643A2F2F002D2D73746F726167652D6472697665723D6F7665726C617932002D2D6C6F672D6472697665723D6A6F75726E616C64002D2D646174612D726F6F74002F6D6E742F646174612F646F636B6572
[   41.207892] IPv6: ADDRCONF(NETDEV_UP): vethdba7265: link is not ready
[   41.208450] hassio: port 8(vethdba7265) entered blocking state
[   41.209005] hassio: port 8(vethdba7265) entered forwarding state
[   41.413885] audit: type=1325 audit(1585051998.693:168): table=nat family=2 entries=0
[   41.417232] audit: type=1300 audit(1585051998.693:168): arch=c000003e syscall=55 success=yes exit=0 a0=4 a1=0 a2=40 a3=7ffde2fdf35c items=0 ppid=6280 pid=6290 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="iptables" exe="/usr/sbin/xtables-legacy-multi" subj==unconfined key=(null)
[   41.424962] audit: type=1327 audit(1585051998.693:168): proctitle=2F7573722F7362696E2F69707461626C6573002D2D77616974002D74006E6174002D4C002D6E
[   41.440940] audit: type=1325 audit(1585051998.720:169): table=filter family=2 entries=0
[   41.465826] eth0: renamed from veth35a95e5
[   41.467571] hassio: port 8(vethdba7265) entered disabled state
[   41.468112] IPv6: ADDRCONF(NETDEV_CHANGE): vetha80961c: link becomes ready
[   41.468634] hassio: port 7(vetha80961c) entered blocking state
[   41.469221] hassio: port 7(vetha80961c) entered forwarding state
[   41.506184] eth0: renamed from vethbca7186
[   41.511660] IPv6: ADDRCONF(NETDEV_CHANGE): vethdba7265: link becomes ready
[   41.512246] hassio: port 8(vethdba7265) entered blocking state
[   41.512808] hassio: port 8(vethdba7265) entered forwarding state
[   71.298119] usb 1-2: new full-speed USB device number 3 using ohci-pci
[   71.554261] usb 1-2: New USB device found, idVendor=0451, idProduct=16a8, bcdDevice= 0.09
[   71.556114] usb 1-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[   71.556725] usb 1-2: Product: TI CC2531 USB CDC
[   71.557289] usb 1-2: Manufacturer: Texas Instruments
[   71.557967] usb 1-2: SerialNumber: __0X00124B0018E22290
[   71.565947] cdc_acm 1-2:1.0: ttyACM0: USB ACM device
[   71.573941] usbcore: registered new interface driver cdc_acm
[   71.574529] cdc_acm: USB Abstract Control Model driver for USB modems and ISDN adapters
[  110.255905] ohci-pci 0000:00:06.0: frame counter not updating; disabled
[  110.258272] ohci-pci 0000:00:06.0: HC died; cleaning up
[  110.261072] usb 1-1: USB disconnect, device number 2
[  110.262286] usb 1-2: USB disconnect, device number 3
[  113.465578] udevd[180]: starting version 3.2.8
[  113.511178] udevd[181]: starting eudev-3.2.8

Description of problem:

Hey there, if I connect my USB device, it gets disconnected after almost exactly 60 seconds.

I am using Virtualbox on OSX Cataline with installed extension pack and forwarding the USB device to my virtual machine running HassOS (used the VMDK, converted to VDI, extended to 32GB, etc.).

I've found this launchpad bug: https://bugs.launchpad.net/ubuntu/+source/linux/+bug/1634737

It says that there might be a problem with the kernel version but as I dont have access to HassOS host machine, I cannot verify if I am still on a probably bugged kernel version.

Does anyone had this issue before and could help me solving this issue? I want to run hassio on my Pi 4 which arrives on wednesday but until then, I would love to configure it inside my virtualbox.

My devices are not reconnecting after this. I have to fully restart virtualbox to make it work again.

boesing commented 4 years ago

Switched to Raspberry Pi4. No issues in there. If you're fine with that VMDK on OSX does not provide permanent access to an USB device, feel free to close as I continue working on the Pi now. 👍

nschwermann commented 3 years ago

Also having this issue on running home assistant with virtual box on mac :(

Warrenvan1 commented 2 years ago

Hi i got this error

c2] ehci-pci 0000:00:1a.0: hc died cleaning up

Warrenvan1 commented 2 years ago

c2] ehci-pci 0000:00:1a.0: fatal error