great-squeaker-hyperkit.log

[    0.000000] Linux version 4.15.0-88-generic (buildd@lgw01-amd64-036) (gcc version 7.4.0 (Ubuntu 7.4.0-1ubuntu1~18.04.1)) #88-Ubuntu SMP Tue Feb 11 20:11:34 UTC 2020 (Ubuntu 4.15.0-88.88-generic 4.15.18)
[    0.000000] Command line: earlyprintk=serial console=ttyS0 root=/dev/sda1 rw panic=1 no_timer_check
[    0.000000] KERNEL supported cpus:
[    0.000000]   Intel GenuineIntel
[    0.000000]   AMD AuthenticAMD
[    0.000000]   Centaur CentaurHauls
[    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] e820: BIOS-provided physical RAM map:
[    0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
[    0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003fffffff] usable
[    0.000000] bootconsole [earlyser0] enabled
[    0.000000] ERROR: earlyprintk= earlyser already used
[    0.000000] NX (Execute Disable) protection: active
[    0.000000] SMBIOS 2.6 present.
[    0.000000] DMI:  BHYVE, BIOS 1.00 03/14/2014
[    0.000000] e820: last_pfn = 0x40000 max_arch_pfn = 0x400000000
[    0.000000] MTRR: Disabled
[    0.000000] x86/PAT: MTRRs disabled, skipping PAT initialization too.
[    0.000000] CPU MTRRs all blank - virtualized system.
[    0.000000] x86/PAT: Configuration [0-7]: WB  WT  UC- UC  WB  WT  UC- UC  
Memory KASLR using RDRAND RDTSC...
[    0.000000] found SMP MP-table at [mem 0x000f0000-0x000f000f]
[    0.000000] Scanning 1 areas for low memory corruption
[    0.000000] Using GB pages for direct mapping
[    0.000000] RAMDISK: [mem 0x3ed40000-0x3fffffff]
[    0.000000] ACPI: Early table checksum verification disabled
[    0.000000] ACPI: RSDP 0x00000000000F2400 000024 (v02 BHYVE )
[    0.000000] ACPI: XSDT 0x00000000000F2480 000044 (v01 BHYVE  BVXSDT   00000001 INTL 20140828)
[    0.000000] ACPI: APIC 0x00000000000F2500 00005A (v01 BHYVE  BVMADT   00000001 INTL 20140828)
[    0.000000] ACPI: FACP 0x00000000000F2A00 00010C (v05 BHYVE  BVFACP   00000001 INTL 20140828)
[    0.000000] ACPI: DSDT 0x00000000000F2C00 000A2D (v02 BHYVE  BVDSDT   00000001 INTL 20140828)
[    0.000000] ACPI: FACS 0x00000000000F2BC0 000040
[    0.000000] ACPI: FACS 0x00000000000F2BC0 000040
[    0.000000] ACPI: HPET 0x00000000000F2B40 000038 (v01 BHYVE  BVHPET   00000001 INTL 20140828)
[    0.000000] ACPI: MCFG 0x00000000000F2B80 00003C (v01 BHYVE  BVMCFG   00000001 INTL 20140828)
[    0.000000] Setting APIC routing to physical flat.
[    0.000000] No NUMA configuration found
[    0.000000] Faking a node at [mem 0x0000000000000000-0x000000003fffffff]
[    0.000000] NODE_DATA(0) allocated [mem 0x3ed15000-0x3ed3ffff]
[    0.000000] tsc: Unable to calibrate against PIT
[    0.000000] tsc: No reference (HPET/PMTIMER) available
[    0.000000] Zone ranges:
[    0.000000]   DMA      [mem 0x0000000000001000-0x0000000000ffffff]
[    0.000000]   DMA32    [mem 0x0000000001000000-0x000000003fffffff]
[    0.000000]   Normal   empty
[    0.000000]   Device   empty
[    0.000000] Movable zone start for each node
[    0.000000] Early memory node ranges
[    0.000000]   node   0: [mem 0x0000000000001000-0x000000000009efff]
[    0.000000]   node   0: [mem 0x0000000000100000-0x000000003fffffff]
[    0.000000] Reserved but unavailable: 98 pages
[    0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x000000003fffffff]
[    0.000000] ACPI: PM-Timer IO Port: 0x408
[    0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] high edge lint[0x1])
[    0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 high edge)
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 low level)
[    0.000000] Using ACPI (MADT) for SMP configuration information
[    0.000000] ACPI: HPET id: 0x80860701 base: 0xfed00000
[    0.000000] smpboot: Allowing 1 CPUs, 0 hotplug CPUs
[    0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff]
[    0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x000fffff]
[    0.000000] e820: [mem 0x40000000-0xffffffff] available for PCI devices
[    0.000000] Booting paravirtualized kernel on bare hardware
[    0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645519600211568 ns
[    0.000000] random: get_random_bytes called from start_kernel+0x99/0x4fd with crng_init=0
[    0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1
[    0.000000] percpu: Embedded 45 pages/cpu s147456 r8192 d28672 u2097152
[    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 257929
[    0.000000] Policy zone: DMA32
[    0.000000] Kernel command line: earlyprintk=serial console=ttyS0 root=/dev/sda1 rw panic=1 no_timer_check
[    0.000000] Memory: 983836K/1048184K available (12300K kernel code, 2481K rwdata, 4264K rodata, 2428K init, 2712K bss, 64348K reserved, 0K cma-reserved)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
[    0.000000] Kernel/User page tables isolation: enabled
[    0.000000] ftrace: allocating 39344 entries in 154 pages
[    0.000000] Hierarchical RCU implementation.
[    0.000000] 	RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=1.
[    0.000000] 	Tasks RCU enabled.
[    0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
[    0.000000] NR_IRQS: 524544, nr_irqs: 256, preallocated irqs: 16
[    0.000000] Console: colour dummy device 80x25
[    0.000000] console [ttyS0] enabled
[    0.000000] console [ttyS0] enabled
[    0.000000] bootconsole [earlyser0] disabled
[    0.000000] bootconsole [earlyser0] disabled
[    0.000000] ACPI: Core revision 20170831
[    0.000000] ACPI BIOS Warning (bug): Incorrect checksum in table [DSDT] - 0x80, should be 0xDD (20170831/tbprint-211)
[    0.000000] ACPI: 1 ACPI AML tables successfully acquired and loaded
[    0.000000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 191126044627 ns
[    0.000000] APIC: Switch to symmetric I/O mode setup
[    0.000000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[    0.012000] tsc: HPET/PMTIMER calibration failed. Using PIT calibration.
[    0.012000] tsc: Detected 2192.866 MHz processor
[    0.012000] Calibrating delay loop (skipped), value calculated using timer frequency.. 4385.73 BogoMIPS (lpj=8771464)
[    0.012000] pid_max: default: 32768 minimum: 301
[    0.012000] Security Framework initialized
[    0.012000] Yama: becoming mindful.
[    0.012000] AppArmor: AppArmor initialized
[    0.012000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes)
[    0.012418] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes)
[    0.014026] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes)
[    0.016056] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes)
[    0.018728] Last level iTLB entries: 4KB 1024, 2MB 1024, 4MB 1024
[    0.020000] Last level dTLB entries: 4KB 1024, 2MB 1024, 4MB 1024, 1GB 4
[    0.020000] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization
[    0.020000] Spectre V2 : Mitigation: Full generic retpoline
[    0.020000] Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch
[    0.020000] Speculative Store Bypass: Vulnerable
[    0.020000] MDS: Vulnerable: Clear CPU buffers attempted, no microcode
[    0.024372] Freeing SMP alternatives memory: 36K
[    0.055595] smpboot: CPU0: Intel(R) Core(TM) i7-4770HQ CPU @ 2.20GHz (family: 0x6, model: 0x46, stepping: 0x1)
[    0.056000] Performance Events: unsupported p6 CPU model 70 no PMU driver, software events only.
[    0.056000] Hierarchical SRCU implementation.
[    0.056000] NMI watchdog: Perf event create on CPU 0 failed with -2
[    0.056000] NMI watchdog: Perf NMI watchdog permanently disabled
[    0.056000] smp: Bringing up secondary CPUs ...
[    0.056000] smp: Brought up 1 node, 1 CPU
[    0.056000] smpboot: Max logical packages: 1
[    0.056000] smpboot: Total of 1 processors activated (4385.73 BogoMIPS)
[    0.056000] devtmpfs: initialized
[    0.056120] x86/mm: Memory block size: 128MB
[    0.057801] evm: security.selinux
[    0.058566] evm: security.SMACK64
[    0.059328] evm: security.SMACK64EXEC
[    0.060005] evm: security.SMACK64TRANSMUTE
[    0.060976] evm: security.SMACK64MMAP
[    0.061872] evm: security.apparmor
[    0.062652] evm: security.ima
[    0.063339] evm: security.capability
[    0.064414] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[    0.066901] futex hash table entries: 256 (order: 2, 16384 bytes)
[    0.068000] pinctrl core: initialized pinctrl subsystem
[    0.068000] RTC time:  6:10:03, date: 02/22/20
[    0.068000] NET: Registered protocol family 16
[    0.068000] audit: initializing netlink subsys (disabled)
[    0.068000] cpuidle: using governor ladder
[    0.068000] cpuidle: using governor menu
[    0.068000] ACPI FADT declares the system doesn't support PCIe ASPM, so disable it
[    0.068000] ACPI: bus type PCI registered
[    0.068000] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
[    0.068375] PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xe0000000-0xefffffff] (base 0xe0000000)
[    0.070453] PCI: not using MMCONFIG
[    0.071252] PCI: Using configuration type 1 for base access
[    0.072000] audit: type=2000 audit(1582351803.064:1): state=initialized audit_enabled=0 res=1
[    0.072000] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages
[    0.072000] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
[    0.072000] ACPI: Added _OSI(Module Device)
[    0.072010] ACPI: Added _OSI(Processor Device)
[    0.073018] ACPI: Added _OSI(3.0 _SCP Extensions)
[    0.074081] ACPI: Added _OSI(Processor Aggregator Device)
[    0.075341] ACPI: Added _OSI(Linux-Dell-Video)
[    0.076019] ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio)
[    0.077202] ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics)
[    0.079232] ACPI: Interpreter enabled
[    0.080000] ACPI: (supports S0 S5)
[    0.080000] ACPI: Using IOAPIC for interrupt routing
[    0.080000] PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xe0000000-0xefffffff] (base 0xe0000000)
[    0.080000] PCI: MMCONFIG at [mem 0xe0000000-0xefffffff] reserved in ACPI motherboard resources
[    0.080067] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[    0.084000] ACPI: PCI Root Bridge [PC00] (domain 0000 [bus 00])
[    0.084000] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI]
[    0.084000] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM
[    0.084000] acpi PNP0A03:00: host bridge window [mem 0x00000000-0xd0000fffff window] ([0x8000000000-0xd0000fffff] ignored, not CPU addressable)
[    0.084000] acpi PNP0A03:00: host bridge window expanded to [mem 0x00000000-0x7fffffffff window]; [mem 0x00000000-0x7fffffffff window] ignored
[    0.084000] PCI host bridge to bus 0000:00
[    0.084035] pci_bus 0000:00: root bus resource [io  0x0000-0x0cf7 window]
[    0.085828] pci_bus 0000:00: root bus resource [io  0x0d00-0x1fff window]
[    0.087167] pci_bus 0000:00: root bus resource [io  0x2000-0x205f window]
[    0.088000] pci_bus 0000:00: root bus resource [mem 0x00000000-0x7fffffffff window]
[    0.088000] pci_bus 0000:00: root bus resource [bus 00]
[    0.088000] ACPI: PCI Interrupt Link [LNKA] (IRQs 3 4 *5 6 7 9 10 11 12 14 15)
[    0.088152] ACPI: PCI Interrupt Link [LNKB] (IRQs 3 4 5 *6 7 9 10 11 12 14 15)
[    0.089912] ACPI: PCI Interrupt Link [LNKC] (IRQs 3 4 5 6 *7 9 10 11 12 14 15)
[    0.091717] ACPI: PCI Interrupt Link [LNKD] (IRQs 3 4 5 6 7 9 *10 11 12 14 15)
[    0.092000] ACPI: PCI Interrupt Link [LNKE] (IRQs 3 4 5 6 7 9 10 11 12 14 15) *0, disabled.
[    0.092000] ACPI: PCI Interrupt Link [LNKF] (IRQs 3 4 5 6 7 9 10 11 12 14 15) *0, disabled.
[    0.092000] ACPI: PCI Interrupt Link [LNKG] (IRQs 3 4 5 6 7 9 10 11 12 14 15) *0, disabled.
[    0.092000] ACPI: PCI Interrupt Link [LNKH] (IRQs 3 4 5 6 7 9 10 11 12 14 15) *0, disabled.
[    0.092000] SCSI subsystem initialized
[    0.092000] vgaarb: loaded
[    0.092000] ACPI: bus type USB registered
[    0.092040] usbcore: registered new interface driver usbfs
[    0.093285] usbcore: registered new interface driver hub
[    0.094499] usbcore: registered new device driver usb
[    0.095978] EDAC MC: Ver: 3.0.0
[    0.096000] PCI: Using ACPI for IRQ routing
[    0.140896] NetLabel: Initializing
[    0.141692] NetLabel:  domain hash size = 128
[    0.142710] NetLabel:  protocols = UNLABELED CIPSOv4 CALIPSO
[    0.144043] NetLabel:  unlabeled traffic allowed by default
[    0.145634] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0, 0, 0, 0, 0, 0
[    0.147027] hpet0: 8 comparators, 32-bit 10.000000 MHz counter
[    0.148000] clocksource: Switched to clocksource hpet
[    0.172136] VFS: Disk quotas dquot_6.6.0
[    0.172136] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[    0.186901] AppArmor: AppArmor Filesystem Enabled
[    0.187999] pnp: PnP ACPI init
[    0.189241] system 00:00: [io  0x0220-0x0223] has been reserved
[    0.190496] system 00:00: [io  0x0224-0x0227] has been reserved
[    0.190496] system 00:00: [io  0x04d0-0x04d1] has been reserved
[    0.193783] system 00:00: [io  0x0400-0x0407] has been reserved
[    0.195153] system 00:00: [mem 0xe0000000-0xefffffff] has been reserved
[    0.196781] pnp: PnP ACPI: found 4 devices
[    0.205952] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
[    0.205952] pci 0000:00:01.0: BAR 6: assigned [mem 0x40000000-0x400007ff pref]
[    0.205952] pci 0000:00:01.1: BAR 6: assigned [mem 0x40000800-0x40000fff pref]
[    0.205952] pci 0000:00:02.0: BAR 6: assigned [mem 0x40001000-0x400017ff pref]
[    0.214000] pci 0000:00:05.0: BAR 6: assigned [mem 0x40001800-0x40001fff pref]
[    0.216120] pci 0000:00:1f.0: BAR 6: assigned [mem 0x40002000-0x400027ff pref]
[    0.218042] NET: Registered protocol family 2
[    0.219477] TCP established hash table entries: 8192 (order: 4, 65536 bytes)
[    0.220817] TCP bind hash table entries: 8192 (order: 5, 131072 bytes)
[    0.221955] TCP: Hash tables configured (established 8192 bind 8192)
[    0.221955] UDP hash table entries: 512 (order: 2, 16384 bytes)
[    0.221955] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes)
[    0.226365] NET: Registered protocol family 1
[    0.227376] pci 0000:00:1f.0: Activating ISA DMA hang workarounds
[    0.228793] Unpacking initramfs...
[    0.792227] Freeing initrd memory: 19200K
[    0.792227] Scanning for low memory corruption every 60 seconds
[    0.792227] Initialise system trusted keyrings
[    0.792227] Key type blacklist registered
[    0.792227] workingset: timestamp_bits=36 max_order=18 bucket_order=0
[    0.802839] zbud: loaded
[    0.804242] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[    0.805952] fuse init (API version 7.26)
[    0.810297] Key type asymmetric registered
[    0.810927] Asymmetric key parser 'x509' registered
[    0.812511] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 246)
[    0.814463] io scheduler noop registered
[    0.815420] io scheduler deadline registered
[    0.816393] io scheduler cfq registered (default)
[    0.816393] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0
[    0.816393] ACPI: Power Button [PWRF]
[    0.816393] virtio-pci 0000:00:02.0: virtio_pci: leaving for legacy driver
[    0.816393] virtio-pci 0000:00:05.0: virtio_pci: leaving for legacy driver
[    0.816393] Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled
[    0.849465] 00:01: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
[    0.874664] 00:02: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A
[    0.879498] Linux agpgart interface v0.103
[    0.885251] loop: module loaded
[    0.886359] libphy: Fixed MDIO Bus: probed
[    0.887292] tun: Universal TUN/TAP device driver, 1.6
[    0.888520] PPP generic driver version 2.4.2
[    0.889551] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[    0.890039] ehci-pci: EHCI PCI platform driver
[    0.890039] ehci-platform: EHCI generic platform driver
[    0.890039] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[    0.890039] ohci-pci: OHCI PCI platform driver
[    0.890039] ohci-platform: OHCI generic platform driver
[    0.896915] uhci_hcd: USB Universal Host Controller Interface driver
[    0.898401] i8042: PNP: No PS/2 controller found.
[    0.899555] mousedev: PS/2 mouse device common for all mice
[    0.900873] ACPI Error: Could not enable RealTimeClock event (20170831/evxfevnt-218)
[    0.902837] ACPI Warning: Could not enable fixed event - RealTimeClock (4) (20170831/evxface-654)
[    0.905582] rtc_cmos 00:03: rtc core: registered rtc_cmos as rtc0
[    0.907230] rtc_cmos 00:03: alarms up to one day, y3k, 114 bytes nvram
[    0.908716] i2c /dev entries driver
[    0.909592] device-mapper: uevent: version 1.0.3
[    0.910734] device-mapper: ioctl: 4.37.0-ioctl (2017-09-20) initialised: dm-devel@redhat.com
[    0.912726] ledtrig-cpu: registered to indicate activity on CPUs
[    0.914466] NET: Registered protocol family 10
[    0.920577] Segment Routing with IPv6
[    0.921457] NET: Registered protocol family 17
[    0.922545] Key type dns_resolver registered
[    0.923669] mce: Using 0 MCE banks
[    0.924124] RAS: Correctable Errors collector initialized.
[    0.924124] sched_clock: Marking stable (920124000, 0)->(1219732327, -299608327)
[    0.927617] registered taskstats version 1
[    0.928559] Loading compiled-in X.509 certificates
[    0.932589] Loaded X.509 cert 'Build time autogenerated kernel key: f0020782f0d3a548186fb3f47aed88387a71e859'
[    0.934824] zswap: loaded using pool lzo/zbud
[    0.940247] Key type big_key registered
[    0.941129] Key type trusted registered
[    0.944024] Key type encrypted registered
[    0.944941] AppArmor: AppArmor sha1 policy hashing enabled
[    0.946181] ima: No TPM chip found, activating TPM-bypass! (rc=-19)
[    0.947590] ima: Allocated hash algorithm: sha1
[    0.948656] evm: HMAC attrs: 0x1
[    0.949842]   Magic number: 8:877:165
[    0.950996] rtc_cmos 00:03: setting system clock to 2020-02-22 06:10:04 UTC (1582351804)
[    0.953073] BIOS EDD facility v0.16 2004-Jun-25, 0 devices found
[    0.954422] EDD information not available.
[    0.957766] Freeing unused kernel image memory: 2428K
[    0.977284] Write protecting the kernel read-only data: 20480k
[    0.979598] Freeing unused kernel image memory: 2008K
[    0.981452] Freeing unused kernel image memory: 1880K
[    0.992377] x86/mm: Checked W+X mappings: passed, no W+X pages found.
[    0.993690] x86/mm: Checking user space page tables
[    1.002566] x86/mm: Checked W+X mappings: passed, no W+X pages found.
Loading, please wait...
starting version 237
[    1.192288] ahci 0000:00:01.0: SSS flag set, parallel bus scan disabled
[    1.194022] ahci 0000:00:01.0: AHCI 0001.0300 32 slots 6 ports 6 Gbps 0x1 impl SATA mode
[    1.195825] ahci 0000:00:01.0: flags: 64bit ncq sntf ilck stag pm led clo pio slum part sxs apst 
[    1.221021] scsi host0: ahci
[    1.228068] scsi host1: ahci
[    1.235585] scsi host2: ahci
[    1.243506] AVX2 version of gcm_enc/dec engaged.
[    1.244556] AES CTR mode by8 optimization enabled
[    1.245675] scsi host3: ahci
[    1.253367] scsi host4: ahci
[    1.259769] scsi host5: ahci
[    1.260507] ata1: SATA max UDMA/133 abar m1024@0xc0000000 port 0xc0000100 irq 24
[    1.262294] ata2: DUMMY
[    1.262796] ata3: DUMMY
[    1.263327] ata4: DUMMY
[    1.263896] ata5: DUMMY
[    1.264465] ata6: DUMMY
[    1.271675] ahci 0000:00:01.1: can't derive routing for PCI INT B
[    1.273055] ahci 0000:00:01.1: PCI INT B: no GSI
[    1.274544] ahci 0000:00:01.1: SSS flag set, parallel bus scan disabled
[    1.276265] ahci 0000:00:01.1: AHCI 0001.0300 32 slots 6 ports 6 Gbps 0x1 impl SATA mode
[    1.278089] ahci 0000:00:01.1: flags: 64bit ncq sntf ilck stag pm led clo pio slum part sxs apst 
[    1.311073] scsi host6: ahci
[    1.316739] scsi host7: ahci
[    1.322115] scsi host8: ahci
[    1.328615] scsi host9: ahci
[    1.335813] virtio_net virtio0 enp0s2: renamed from eth0
[    1.337257] scsi host10: ahci
[    1.344723] scsi host11: ahci
[    1.345480] ata7: SATA max UDMA/133 abar m1024@0xc0000400 port 0xc0000500 irq 28
[    1.347132] ata8: DUMMY
[    1.347704] ata9: DUMMY
[    1.348273] ata10: DUMMY
[    1.348860] ata11: DUMMY
[    1.349447] ata12: DUMMY
[    1.654230] ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
[    1.656461] ata1.00: ATA-9: BHYVE SATA DISK, 001, max UDMA/133
[    1.658048] ata1.00: 10485760 sectors, multi 128: LBA48 NCQ (depth 31/32)
[    1.659745] ata1.00: ATA Identify Device Log not supported
[    1.661049] ata1.00: Security Log not supported
[    1.662075] ata1.00: applying bridge limits
[    1.663431] ata1.00: ATA Identify Device Log not supported
[    1.664669] ata1.00: Security Log not supported
[    1.665695] ata1.00: configured for UDMA/100
[    1.667156] scsi 0:0:0:0: Direct-Access     ATA      BHYVE SATA DISK  001  PQ: 0 ANSI: 5
[    1.669948] sd 0:0:0:0: [sda] 10485760 512-byte logical blocks: (5.37 GB/5.00 GiB)
[    1.671777] sd 0:0:0:0: [sda] Write Protect is off
[    1.673262] sd 0:0:0:0: Attached scsi generic sg0 type 0
[    1.674802] ata7: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
[    1.676360] ata7.00: ATAPI: BHYVE SATA DVD ROM, 001, max UDMA/133
[    1.677979] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[    1.680530] ata7.00: configured for UDMA/133
[    1.682364] scsi 6:0:0:0: CD-ROM            BHYVE    BHYVE DVD-ROM    001  PQ: 0 ANSI: 5
[    1.685532] sr 6:0:0:0: [sr0] scsi3-mmc drive: 0x/0x xa/form2 caddy
[    1.686946] cdrom: Uniform CD-ROM driver Revision: 3.20
[    1.690805] sr 6:0:0:0: Attached scsi generic sg1 type 5
[    1.735563]  sda: sda1 sda14 sda15
[    1.737211] sd 0:0:0:0: [sda] Attached SCSI disk
[    2.890845] tsc: Refined TSC clocksource calibration: 2193.335 MHz
[    2.891887] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x1f9d9abb247, max_idle_ns: 440795308291 ns
Begin: Loading essential drivers ... [    3.137267] raid6: sse2x1   gen()  6920 MB/s
[    3.197666] raid6: sse2x1   xor()  5868 MB/s
[    3.253168] raid6: sse2x2   gen()  9626 MB/s
[    3.305527] raid6: sse2x2   xor()  6368 MB/s
[    3.362202] raid6: sse2x4   gen() 11131 MB/s
[    3.407444] raid6: sse2x4   xor()  6333 MB/s
[    3.471718] raid6: avx2x1   gen() 16234 MB/s
[    3.538581] raid6: avx2x1   xor() 10927 MB/s
[    3.597907] raid6: avx2x2   gen() 21432 MB/s
[    3.655362] raid6: avx2x2   xor() 13487 MB/s
[    3.718544] raid6: avx2x4   gen() 19996 MB/s
[    3.765067] raid6: avx2x4   xor() 12312 MB/s
[    3.766041] raid6: using algorithm avx2x2 gen() 21432 MB/s
[    3.767274] raid6: .... xor() 13487 MB/s, rmw enabled
[    3.768414] raid6: using avx2x2 recovery algorithm
[    3.772758] xor: automatically using best checksumming function   avx       
[    3.776702] async_tx: api initialized (async)
done.
Begin: Running /scripts/init-premount ... done.
Begin: Mounting root file system ... Begin: Running /scripts/local-top ... done.
Begin: Running /scripts/local-premount ... [    3.859727] Btrfs loaded, crc32c=crc32c-intel
Scanning for Btrfs filesystems
[    3.878872] random: fast init done
[    3.903803] clocksource: Switched to clocksource tsc
done.
[    3.918602] random: wait-for-root: uninitialized urandom read (16 bytes read)
[    3.920251] random: wait-for-root: uninitialized urandom read (16 bytes read)
[    3.921855] random: wait-for-root: uninitialized urandom read (16 bytes read)
Warning: fsck not present, so skipping root file system
[    3.938094] EXT4-fs (sda1): mounted filesystem with ordered data mode. Opts: (null)
done.
Begin: Running /scripts/local-bottom ... done.
Begin: Running /scripts/init-bottom ... done.
[    4.210594] ip_tables: (C) 2000-2006 Netfilter Core Team
[    4.222691] random: crng init done
[    4.223544] random: 6 urandom warning(s) missed due to ratelimiting
[    4.236935] systemd[1]: systemd 237 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)
[    4.242017] systemd[1]: Detected virtualization bhyve.
[    4.243100] systemd[1]: Detected architecture x86-64.

Welcome to Ubuntu 18.04.4 LTS!

[    4.248519] systemd[1]: Set hostname to <great-squeaker>.
[    4.676029] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
[  OK  ] Started Forward Password Requests to Wall Directory Watch.
[    4.679185] systemd[1]: Created slice System Slice.
[  OK  ] Created slice System Slice.
[    4.681398] systemd[1]: Listening on Journal Socket.
[  OK  ] Listening on Journal Socket.
[    4.684227] systemd[1]: Mounting POSIX Message Queue File System...
         Mounting POSIX Message Queue File System...
[    4.686291] systemd[1]: Listening on Journal Socket (/dev/log).
[  OK  ] Listening on Journal Socket (/dev/log).
[    4.692369] systemd[1]: Starting Load Kernel Modules...
         Starting Load Kernel Modules...
[  OK  ] Listening on Network Service Netlink Socket.
         Starting Create list of required st…ce nodes for the current kernel...
[  OK  ] Listening on udev Control Socket.
[  OK  ] Listening on /dev/initctl Compatibility Named Pipe.
[  OK  ] Created slice system-serial\x2dgetty.slice.
[    4.719666] Loading iSCSI transport class v2.0-870.
         Starting Set the console keyboard layout...
[  OK  ] Listening on Journal Audit Socket.
[  OK  ] Listening on Device-mapper event daemon FIFOs.
[  OK  ] Listening on Syslog Socket.
[    4.734408] iscsi: registered transport (tcp)
[  OK  ] Created slice User and Session Slice.
[  OK  ] Reached target Slices.
[  OK  ] Listening on LVM2 metadata daemon socket.
         Starting Monitoring of LVM2 mirrors…ng dmeventd or progress polling...
[  OK  ] Reached target User and Group Name Lookups.
[  OK  ] Listening on udev Kernel Socket.
         Mounting Kernel Debug File System...
         Mounting Huge Pages File System...
         Starting udev Coldplug all Devices...
         Starting Remount Root and Kernel File Systems...
[  OK  ] Listening on LVM2 poll daemon socket.
         Starting Journal Service...
[  OK  ] Reached target Swap.
         Starting Uncomplicated firewall...
[  OK  ] Set up automount Arbitrary Executab…rmats File System Automount Point.
[  OK  ] Mounted POSIX Message Queue File System.
[    4.846198] EXT4-fs (sda1): re-mounted. Opts: (null)
[  OK  ] Started Create list of required sta…vice nodes for the current kernel.
[  OK  ] Mounted Kernel Debug File System.
[  OK  ] Mounted Huge Pages File System.
         Starting Create Static Device Nodes in /dev...
[  OK  ] Started Remount Root and Kernel File Systems.
         Starting Load/Save Random Seed...
[  OK  ] Started Uncomplicated firewall.
[  OK  ] Started Create Static Device Nodes in /dev.
         Starting udev Kernel Device Manager...
[  OK  ] Started LVM2 metadata daemon.
[  OK  ] Started udev Coldplug all Devices.
[  OK  ] Started Load/Save Random Seed.
[  OK  ] Started udev Kernel Device Manager.
[  OK  ] Started Journal Service.
         Starting Flush Journal to Persistent Storage...
[    5.093512] systemd-journald[431]: Received request to flush runtime journal from PID 1
[  OK  ] Started Monitoring of LVM2 mirrors,…sing dmeventd or progress polling.
[    5.110210] iscsi: registered transport (iser)
[  OK  ] Started Load Kernel Modules.
         Starting Apply Kernel Variables...
         Mounting Kernel Configuration File System...
         Mounting FUSE Control File System...
[  OK  ] Mounted Kernel Configuration File System.
[  OK  ] Mounted FUSE Control File System.
[  OK  ] Started Apply Kernel Variables.
[  OK  ] Started Flush Journal to Persistent Storage.
[  OK  ] Found device /dev/ttyS0.
[  OK  ] Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
[  OK  ] Found device BHYVE_SATA_DISK UEFI.
[  OK  ] Started Set the console keyboard layout.
[  OK  ] Reached target Local File Systems (Pre).
         Mounting /boot/efi...
[  OK  ] Started Dispatch Password Requests to Console Directory Watch.
[  OK  ] Reached target Local Encrypted Volumes.
[  OK  ] Mounted /boot/efi.
[  OK  ] Reached target Local File Systems.
         Starting AppArmor initialization...
         Starting ebtables ruleset management...
         Starting Tell Plymouth To Write Out Runtime Data...
         Starting Set console font and keymap...
         Starting Create Volatile Files and Directories...
[  OK  ] Started Set console font and keymap.
[  OK  ] Started Tell Plymouth To Write Out Runtime Data.
[  OK  ] Started Create Volatile Files and Directories.
         Starting Network Time Synchronization...
         Starting Update UTMP about System Boot/Shutdown...
[  OK  ] Started Update UTMP about System Boot/Shutdown.
[  OK  ] Started ebtables ruleset management.
[  OK  ] Started Network Time Synchronization.
[  OK  ] Reached target System Time Synchronized.
[  OK  ] Started AppArmor initialization.
         Starting Initial cloud-init job (pre-networking)...
[    9.696493] cloud-init[657]: Cloud-init v. 19.4-33-gbb4131a2-0ubuntu1~18.04.1 running 'init-local' at Sat, 22 Feb 2020 06:10:12 +0000. Up 9.33 seconds.
[  OK  ] Started Initial cloud-init job (pre-networking).
[  OK  ] Reached target Network (Pre).
         Starting Network Service...
[  OK  ] Started Network Service.
         Starting Wait for Network to be Configured...
         Starting Network Name Resolution...
[  OK  ] Started Network Name Resolution.
[  OK  ] Reached target Network.
[  OK  ] Reached target Host and Network Name Lookups.
[  OK  ] Started Wait for Network to be Configured.
         Starting Initial cloud-init job (metadata service crawler)...
[   12.229130] cloud-init[740]: Cloud-init v. 19.4-33-gbb4131a2-0ubuntu1~18.04.1 running 'init' at Sat, 22 Feb 2020 06:10:15 +0000. Up 11.71 seconds.
[   12.232519] cloud-init[740]: ci-info: ++++++++++++++++++++++++++++++++++++++Net device info+++++++++++++++++++++++++++++++++++++++
[   12.239908] cloud-init[740]: ci-info: +--------+------+-----------------------------+---------------+--------+-------------------+
[   12.244080] cloud-init[740]: ci-info: | Device |  Up  |           Address           |      Mask     | Scope  |     Hw-Address    |
[   12.248062] cloud-init[740]: ci-info: +--------+------+-----------------------------+---------------+--------+-------------------+
[   12.254464] cloud-init[740]: ci-info: | enp0s2 | True |         192.168.64.9        | 255.255.255.0 | global | 7a:7c:04:f3:ee:2e |
[   12.264811] cloud-init[740]: ci-info: | enp0s2 | True | fe80::787c:4ff:fef3:ee2e/64 |       .       |  link  | 7a:7c:04:f3:ee:2e |
[   12.267369] cloud-init[740]: ci-info: |   lo   | True |          127.0.0.1          |   255.0.0.0   |  host  |         .         |
[   12.271936] cloud-init[740]: ci-info: |   lo   | True |           ::1/128           |       .       |  host  |         .         |
[   12.277244] cloud-init[740]: ci-info: +--------+------+-----------------------------+---------------+--------+-------------------+
[   12.288086] cloud-init[740]: ci-info: +++++++++++++++++++++++++++++++Route IPv4 info+++++++++++++++++++++++++++++++
[   12.290589] cloud-init[740]: ci-info: +-------+--------------+--------------+-----------------+-----------+-------+
[   12.292788] cloud-init[740]: ci-info: | Route | Destination  |   Gateway    |     Genmask     | Interface | Flags |
[   12.294961] cloud-init[740]: ci-info: +-------+--------------+--------------+-----------------+-----------+-------+
[   12.297127] cloud-init[740]: ci-info: |   0   |   0.0.0.0    | 192.168.64.1 |     0.0.0.0     |   enp0s2  |   UG  |
[   12.305484] cloud-init[740]: ci-info: |   1   | 192.168.64.0 |   0.0.0.0    |  255.255.255.0  |   enp0s2  |   U   |
[   12.309697] cloud-init[740]: ci-info: |   2   | 192.168.64.1 |   0.0.0.0    | 255.255.255.255 |   enp0s2  |   UH  |
[   12.314761] cloud-init[740]: ci-info: +-------+--------------+--------------+-----------------+-----------+-------+
[   12.319578] cloud-init[740]: ci-info: +++++++++++++++++++Route IPv6 info+++++++++++++++++++
[   12.324916] cloud-init[740]: ci-info: +-------+-------------+---------+-----------+-------+
[   12.329048] cloud-init[740]: ci-info: | Route | Destination | Gateway | Interface | Flags |
[   12.330639] cloud-init[740]: ci-info: +-------+-------------+---------+-----------+-------+
[   12.333965] cloud-init[740]: ci-info: |   1   |  fe80::/64  |    ::   |   enp0s2  |   U   |
[   12.336813] cloud-init[740]: ci-info: |   3   |    local    |    ::   |   enp0s2  |   U   |
[   12.339374] cloud-init[740]: ci-info: |   4   |   ff00::/8  |    ::   |   enp0s2  |   U   |
[   12.340844] cloud-init[740]: ci-info: +-------+-------------+---------+-----------+-------+
[  OK  ] Started Initial cloud-init job (metadata service crawler).
[  OK  ] Reached target System Initialization.
[  OK  ] Listening on D-Bus System Message Bus Socket.
[  OK  ] Started Daily Cleanup of Temporary Directories.
[  OK  ] Started Message of the Day.
[  OK  ] Started Daily apt download activities.
[  OK  ] Started Daily apt upgrade and clean activities.
[  OK  ] Listening on ACPID Listen Socket.
         Starting Socket activation for snappy daemon.
[  OK  ] Listening on UUID daemon activation socket.
[  OK  ] Started ACPI Events Check.
[  OK  ] Reached target Paths.
[  OK  ] Started Discard unused blocks once a week.
[  OK  ] Reached target Timers.
         Starting LXD - unix socket.
[  OK  ] Listening on Open-iSCSI iscsid Socket.
[  OK  ] Reached target Network is Online.
[  OK  ] Reached target Remote File Systems (Pre).
[  OK  ] Reached target Remote File Systems.
         Starting Availability of block devices...
[  OK  ] Reached target Cloud-config availability.
[  OK  ] Listening on Socket activation for snappy daemon.
[  OK  ] Listening on LXD - unix socket.
[  OK  ] Started Availability of block devices.
[  OK  ] Reached target Sockets.
[  OK  ] Reached target Basic System.
         Starting System Logging Service...
[  OK  ] Started FUSE filesystem for LXC.
         Starting Accounts Service...
[  OK  ] Started irqbalance daemon.
         Starting Pollinate to seed the pseudo random number generator...
         Starting LSB: automatic crash report generation...
[  OK  ] Started D-Bus System Message Bus.
         Starting Dispatcher daemon for systemd-networkd...
         Starting Login Service...
         Starting LXD - container startup/shutdown...
         Starting Permit User Sessions...
         Starting LSB: Record successful boot for GRUB...
[  OK  ] Started Deferred execution scheduler.
         Starting Snappy daemon...
[  OK  ] Started Regular background program processing daemon.
[  OK  ] Started System Logging Service.
[  OK  ] Started Permit User Sessions.
         Starting Terminate Plymouth Boot Screen...
         Starting Hold until boot process finishes up...
[  OK  ] Started Hold until boot process finishes up.
         Starting Set console scheme...
[  OK  ] Started Serial Getty on ttyS0.
[  OK  ] Started Terminate Plymouth Boot Screen.
[  OK  ] Started Set console scheme.
[  OK  ] Created slice system-getty.slice.
[  OK  ] Started Getty on tty1.
[  OK  ] Reached target Login Prompts.
[  OK  ] Started LSB: automatic crash report generation.
[  OK  ] Started Login Service.
[  OK  ] Started Unattended Upgrades Shutdown.
         Starting Authorization Manager...
[  OK  ] Started LXD - container startup/shutdown.
[  OK  ] Started Authorization Manager.
[  OK  ] Started Accounts Service.
[  OK  ] Started LSB: Record successful boot for GRUB.
[  OK  ] Started Dispatcher daemon for systemd-networkd.
[  OK  ] Started Snappy daemon.
         Starting Wait until snapd is fully seeded...
[  OK  ] Started Wait until snapd is fully seeded.
         Starting Apply the settings specified in cloud-config...
[   15.103722] cloud-init[1035]: Cloud-init v. 19.4-33-gbb4131a2-0ubuntu1~18.04.1 running 'modules:config' at Sat, 22 Feb 2020 06:10:18 +0000. Up 14.88 seconds.
[  OK  ] Started Apply the settings specified in cloud-config.


Ubuntu 18.04.4 LTS great-squeaker ttyS0

great-squeaker login: [   24.873682] cloud-init[1116]: Cloud-init v. 19.4-33-gbb4131a2-0ubuntu1~18.04.1 running 'modules:final' at Sat, 22 Feb 2020 06:10:28 +0000. Up 24.69 seconds.
[   24.876402] cloud-init[1116]: Cloud-init v. 19.4-33-gbb4131a2-0ubuntu1~18.04.1 finished at Sat, 22 Feb 2020 06:10:28 +0000. Datasource DataSourceNoCloud [seed=/dev/sr0][dsmode=net].  Up 24.86 seconds

multipassd.log

[2020-02-22T14:10:02.714] [info] [great-squeaker] process program '/Library/Application Support/com.canonical.multipass/bin/hyperkit'
[2020-02-22T14:10:02.714] [info] [great-squeaker] process arguments '-c, 1, -m, 1024M, -u, -A, -H, -U, d03f7f13-9bb8-3adb-8e29-5d16629fd2f3, -s, 0:0,hostbridge, -s, 2:0,virtio-net, -s, 5,virtio-rnd, -s, 31,lpc, -l, com1,autopty=/var/root/Library/Application Support/multipassd/vault/instances/great-squeaker/pty,log=/Library/Logs/Multipass/great-squeaker-hyperkit.log, -s, 1:0,ahci-hd,file:///var/root/Library/Application Support/multipassd/vault/instances/great-squeaker/ubuntu-18.04-server-cloudimg-amd64.img?sync=os&buffered=1,format=qcow,qcow-config=discard=true;compact_after_unmaps=262144;keep_erased=262144;runtime_asserts=false, -s, 1:1,ahci-cd,/var/root/Library/Application Support/multipassd/vault/instances/great-squeaker/cloud-init-config.iso, -f, kexec,/var/root/Library/Application Support/multipassd/vault/instances/great-squeaker/ubuntu-18.04-server-cloudimg-amd64-vmlinuz-generic,/var/root/Library/Application Support/multipassd/vault/instances/great-squeaker/ubuntu-18.04-server-cloudimg-amd64-initrd-generic,earlyprintk=serial console=ttyS0 root=/dev/sda1 rw panic=1 no_timer_check'
[2020-02-22T14:10:02.715] [info] [great-squeaker] process state changed to Starting
[2020-02-22T14:10:02.719] [info] [great-squeaker] process state changed to Running
[2020-02-22T14:10:02.743] [info] [great-squeaker] mirage_block_open: block_config = file:///var/root/Library/Application Support/multipassd/vault/instances/great-squeaker/ubuntu-18.04-server-cloudimg-amd64.img?sync=os&buffered=1 and qcow_config = discard=true;compact_after_unmaps=262144;keep_erased=262144;runtime_asserts=false and stats_config = None

[2020-02-22T14:10:02.784] [info] [great-squeaker] hyperkit: [INFO] Resized file to 18588 clusters (2379264 sectors)
[2020-02-22T14:10:02.784] [info] [great-squeaker] hyperkit: [INFO] block recycler starting with keep_erased = 2048
[2020-02-22T14:10:02.784] [info] [great-squeaker] hyperkit: [INFO] image has 0 free sectors and 18584 used sectors
[2020-02-22T14:10:02.784] [info] [great-squeaker] mirage_block_open: block_config = file:///var/root/Library/Application Support/multipassd/vault/instances/great-squeaker/ubuntu-18.04-server-cloudimg-amd64.img?sync=os&buffered=1 and qcow_config = discard=true;compact_after_unmaps=262144;keep_erased=262144;runtime_asserts=false and stats_config = None returning 0
mirage_block_stat

[2020-02-22T14:10:02.785] [info] [great-squeaker] fcntl(F_PUNCHHOLE) failed: host filesystem does not support sparse files: Operation not permitted
[2020-02-22T14:10:03.523] [info] [great-squeaker] rdmsr to register 0x140 on vcpu 0
[2020-02-22T14:10:04.598] [info] [great-squeaker] rdmsr to register 0x34 on vcpu 0
[2020-02-22T14:10:07.804] [info] [great-squeaker] hyperkit: [INFO] block recycler: triggering background flush: 18584 used; 0 junk; 0 erased; 0 available; 0 copies; 0 roots; 0 Copying; 0 Copied; 0 Flushed; 0 Referenced; max_cluster = 18587
[2020-02-22T14:10:13.119] [info] [great-squeaker] hyperkit: [INFO] Allocator: 18584 used; 0 junk; 0 erased; 0 available; 0 copies; 0 roots; 0 Copying; 0 Copied; 0 Flushed; 0 Referenced; max_cluster = 18587
[2020-02-22T14:10:13.119] [info] [great-squeaker] hyperkit: [INFO] Allocator: file contains cluster 0 .. 18587 will enlarge file to 0 .. 19099
[2020-02-22T14:10:13.119] [info] [great-squeaker] hyperkit: [INFO] resize: adding available clusters (Node ((x 18588) (y 19099) (l Empty) (r Empty) (h 1) (cardinal 512)))