gistfile1.txt

starting VDE switch for network 1
running the VM test script
machine: starting vm
machine# Formatting '/build/vm-state-machine/machine.qcow2', fmt=qcow2 size=8589934592 cluster_size=65536 lazy_refcounts=off refcount_bits=16
machine# Formatting 'empty2.qcow2', fmt=qcow2 size=536870912 cluster_size=65536 lazy_refcounts=off refcount_bits=16
machine: QEMU running (pid 597)
machine: must succeed: echo hello
machine: waiting for the VM to finish booting
machine# c[?7lSeaBIOS (version rel-1.12.0-0-ga698c8995f-prebuilt.qemu.org)
machine# 
machine# 
machine# iPXE (http://ipxe.org) 00:03.0 C980 PCI2.10 PnP PMM+3FF90F20+3FEF0F20 C980
machine# Press Ctrl-B to configure iPXE (PCI 00:03.0)...
                                                                               
machine# 
machine# 
machine# 
machine# 
machine# iPXE (http://ipxe.org) 00:08.0 CA80 PCI2.10 PnP PMM 3FF90F20 3FEF0F20 CA80
machine# Press Ctrl-B to configure iPXE (PCI 00:08.0)...
                                                                               
machine# 
machine# 
machine# Booting from ROM...
machine# Probing EDD (edd=off to disable)... ok
machine# c[?7l[    0.000000] Linux version 4.19.33 (nixbld@localhost) (gcc version 7.4.0 (GCC)) #1-NixOS SMP Wed Apr 3 04:26:31 UTC 2019
machine# [    0.000000] Command line: console=ttyS0 panic=1 boot.panic_on_fail loglevel=7 init=/nix/store/rqhkkal72jxgsaq7h82s79g3dk0hmid8-nixos-system-machine-19.09.git.acbdaa5/init regInfo=/nix/store/6s8bihxgvhpxlcqbgn9c32910504y0bl-closure-info/registration console=ttyS0 
machine# [    0.000000] x86/fpu: x87 FPU will use FXSAVE
machine# [    0.000000] BIOS-provided physical RAM map:
machine# [    0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
machine# [    0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
machine# [    0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
machine# [    0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd9fff] usable
machine# [    0.000000] BIOS-e820: [mem 0x000000003ffda000-0x000000003fffffff] reserved
machine# [    0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
machine# [    0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
machine# [    0.000000] NX (Execute Disable) protection: active
machine# [    0.000000] SMBIOS 2.8 present.
machine# [    0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.12.0-0-ga698c8995f-prebuilt.qemu.org 04/01/2014
machine# [    0.000000] Hypervisor detected: KVM
machine# [    0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
machine# [    0.000000] kvm-clock: cpu 0, msr cd52001, primary cpu clock
machine# [    0.000000] kvm-clock: using sched offset of 1392720592 cycles
machine# [    0.000001] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
machine# [    0.000003] tsc: Detected 3292.064 MHz processor
machine# [    0.001357] last_pfn = 0x3ffda max_arch_pfn = 0x400000000
machine# [    0.001400] x86/PAT: Configuration [0-7]: WB  WC  UC- UC  WB  WC  UC- UC  
machine# [    0.007139] found SMP MP-table at [mem 0x000f5870-0x000f587f] mapped at [(____ptrval____)]
machine# [    0.007160] Scanning 1 areas for low memory corruption
machine# [    0.007304] RAMDISK: [mem 0x3f66c000-0x3ffcffff]
machine# [    0.007320] ACPI: Early table checksum verification disabled
machine# [    0.007366] ACPI: RSDP 0x00000000000F5680 000014 (v00 BOCHS )
machine# [    0.007369] ACPI: RSDT 0x000000003FFE156F 000030 (v01 BOCHS  BXPCRSDT 00000001 BXPC 00000001)
machine# [    0.007373] ACPI: FACP 0x000000003FFE144B 000074 (v01 BOCHS  BXPCFACP 00000001 BXPC 00000001)
machine# [    0.007377] ACPI: DSDT 0x000000003FFE0040 00140B (v01 BOCHS  BXPCDSDT 00000001 BXPC 00000001)
machine# [    0.007380] ACPI: FACS 0x000000003FFE0000 000040
machine# [    0.007382] ACPI: APIC 0x000000003FFE14BF 000078 (v01 BOCHS  BXPCAPIC 00000001 BXPC 00000001)
machine# [    0.007385] ACPI: HPET 0x000000003FFE1537 000038 (v01 BOCHS  BXPCHPET 00000001 BXPC 00000001)
machine# [    0.007713] No NUMA configuration found
machine# [    0.007714] Faking a node at [mem 0x0000000000000000-0x000000003ffd9fff]
machine# [    0.007716] NODE_DATA(0) allocated [mem 0x3ffd6000-0x3ffd9fff]
machine# [    0.007913] Zone ranges:
machine# [    0.007914]   DMA      [mem 0x0000000000001000-0x0000000000ffffff]
machine# [    0.007915]   DMA32    [mem 0x0000000001000000-0x000000003ffd9fff]
machine# [    0.007916]   Normal   empty
machine# [    0.007917] Movable zone start for each node
machine# [    0.007918] Early memory node ranges
machine# [    0.007918]   node   0: [mem 0x0000000000001000-0x000000000009efff]
machine# [    0.007919]   node   0: [mem 0x0000000000100000-0x000000003ffd9fff]
machine# [    0.008093] Reserved but unavailable: 98 pages
machine# [    0.008094] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd9fff]
machine# [    0.014490] ACPI: PM-Timer IO Port: 0x608
machine# [    0.014503] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
machine# [    0.014545] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
machine# [    0.014548] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
machine# [    0.014549] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
machine# [    0.014550] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
machine# [    0.014551] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
machine# [    0.014552] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
machine# [    0.014556] Using ACPI (MADT) for SMP configuration information
machine# [    0.014557] ACPI: HPET id: 0x8086a201 base: 0xfed00000
machine# [    0.014565] smpboot: Allowing 1 CPUs, 0 hotplug CPUs
machine# [    0.014580] PM: Registered nosave memory: [mem 0x00000000-0x00000fff]
machine# [    0.014581] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff]
machine# [    0.014582] PM: Registered nosave memory: [mem 0x000a0000-0x000effff]
machine# [    0.014583] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff]
machine# [    0.014584] [mem 0x40000000-0xfeffbfff] available for PCI devices
machine# [    0.014585] Booting paravirtualized kernel on KVM
machine# [    0.014587] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
machine# [    0.080298] random: get_random_bytes called from start_kernel+0x94/0x4ce with crng_init=0
machine# [    0.080306] setup_percpu: NR_CPUS:384 nr_cpumask_bits:384 nr_cpu_ids:1 nr_node_ids:1
machine# [    0.080566] percpu: Embedded 44 pages/cpu @(____ptrval____) s141272 r8192 d30760 u2097152
machine# [    0.080589] KVM setup async PF for cpu 0
machine# [    0.080594] kvm-stealtime: cpu 0, msr 3e216180
machine# [    0.080599] Built 1 zonelists, mobility grouping on.  Total pages: 257891
machine# [    0.080599] Policy zone: DMA32
machine# [    0.080601] Kernel command line: console=ttyS0 panic=1 boot.panic_on_fail loglevel=7 init=/nix/store/rqhkkal72jxgsaq7h82s79g3dk0hmid8-nixos-system-machine-19.09.git.acbdaa5/init regInfo=/nix/store/6s8bihxgvhpxlcqbgn9c32910504y0bl-closure-info/registration console=ttyS0 
machine# [    0.082913] Memory: 999560K/1048032K available (10252K kernel code, 1135K rwdata, 1932K rodata, 1440K init, 812K bss, 48472K reserved, 0K cma-reserved)
machine# [    0.083128] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
machine# [    0.083132] Kernel/User page tables isolation: enabled
machine# [    0.083160] ftrace: allocating 28444 entries in 112 pages
machine# [    0.091423] rcu: Hierarchical RCU implementation.
machine# [    0.091424] rcu: 	RCU event tracing is enabled.
machine# [    0.091425] rcu: 	RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.
machine# [    0.091426] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
machine# [    0.093273] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16
machine# [    0.100503] Console: colour VGA+ 80x25
machine# [    0.185177] console [ttyS0] enabled
machine# [    0.185759] ACPI: Core revision 20180810
machine# [    0.186605] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
machine# [    0.188109] APIC: Switch to symmetric I/O mode setup
machine# [    0.189212] x2apic enabled
machine# [    0.189959] Switched APIC routing to physical x2apic.
machine# [    0.192104] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
machine# [    0.193028] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2f740365dde, max_idle_ns: 440795326451 ns
machine# [    0.194674] Calibrating delay loop (skipped) preset value.. 6584.12 BogoMIPS (lpj=3292064)
machine# [    0.195665] pid_max: default: 32768 minimum: 301
machine# [    0.196679] Security Framework initialized
machine# [    0.197665] Yama: becoming mindful.
machine# [    0.198237] AppArmor: AppArmor initialized
machine# [    0.198971] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes)
machine# [    0.199702] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes)
machine# [    0.201666] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes)
machine# [    0.202668] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes)
machine# [    0.203870] mce: CPU supports 10 MCE banks
machine# [    0.204706] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
machine# [    0.205509] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
machine# [    0.205666] Spectre V2 : Mitigation: Full generic retpoline
machine# [    0.206664] Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch
machine# [    0.207665] Speculative Store Bypass: Vulnerable
machine# [    0.215235] Freeing SMP alternatives memory: 28K
machine# [    0.217662] smpboot: CPU0: Intel Common KVM processor (family: 0xf, model: 0x6, stepping: 0x1)
machine# [    0.217750] Performance Events: unsupported Netburst CPU model 6 no PMU driver, software events only.
machine# [    0.218699] rcu: Hierarchical SRCU implementation.
machine# [    0.219933] smp: Bringing up secondary CPUs ...
machine# [    0.220665] smp: Brought up 1 node, 1 CPU
machine# [    0.221665] smpboot: Max logical packages: 1
machine# [    0.222316] smpboot: Total of 1 processors activated (6584.12 BogoMIPS)
machine# [    0.222790] devtmpfs: initialized
machine# [    0.223699] x86/mm: Memory block size: 128MB
machine# [    0.224833] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
machine# [    0.225668] futex hash table entries: 256 (order: 2, 16384 bytes)
machine# [    0.226693] pinctrl core: initialized pinctrl subsystem
machine# [    0.227775] NET: Registered protocol family 16
machine# [    0.228715] audit: initializing netlink subsys (disabled)
machine# [    0.229690] audit: type=2000 audit(1554692178.237:1): state=initialized audit_enabled=0 res=1
machine# [    0.230721] cpuidle: using governor menu
machine# [    0.231699] ACPI: bus type PCI registered
machine# [    0.232328] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
machine# [    0.232763] PCI: Using configuration type 1 for base access
machine# [    0.234962] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
machine# [    0.235980] ACPI: Added _OSI(Module Device)
machine# [    0.236687] ACPI: Added _OSI(Processor Device)
machine# [    0.237676] ACPI: Added _OSI(3.0 _SCP Extensions)
machine# [    0.238416] ACPI: Added _OSI(Processor Aggregator Device)
machine# [    0.238681] ACPI: Added _OSI(Linux-Dell-Video)
machine# [    0.239673] ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio)
machine# [    0.241065] ACPI: 1 ACPI AML tables successfully acquired and loaded
machine# [    0.242768] ACPI: Interpreter enabled
machine# [    0.243675] ACPI: (supports S0 S3 S4 S5)
machine# [    0.244284] ACPI: Using IOAPIC for interrupt routing
machine# [    0.244675] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
machine# [    0.245737] ACPI: Enabled 2 GPEs in block 00 to 0F
machine# [    0.248181] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
machine# [    0.248668] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI]
machine# [    0.249669] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM
machine# [    0.250671] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge.
machine# [    0.251781] acpiphp: Slot [3] registered
machine# [    0.252701] acpiphp: Slot [4] registered
machine# [    0.253336] acpiphp: Slot [5] registered
machine# [    0.253701] acpiphp: Slot [6] registered
machine# [    0.254679] acpiphp: Slot [7] registered
machine# [    0.255325] acpiphp: Slot [8] registered
machine# [    0.255705] acpiphp: Slot [9] registered
machine# [    0.256343] acpiphp: Slot [10] registered
machine# [    0.256702] acpiphp: Slot [11] registered
machine# [    0.257701] acpiphp: Slot [12] registered
machine# [    0.258359] acpiphp: Slot [13] registered
machine# [    0.258701] acpiphp: Slot [14] registered
machine# [    0.259700] acpiphp: Slot [15] registered
machine# [    0.260358] acpiphp: Slot [16] registered
machine# [    0.260715] acpiphp: Slot [17] registered
machine# [    0.261705] acpiphp: Slot [18] registered
machine# [    0.262363] acpiphp: Slot [19] registered
machine# [    0.262700] acpiphp: Slot [20] registered
machine# [    0.263701] acpiphp: Slot [21] registered
machine# [    0.264356] acpiphp: Slot [22] registered
machine# [    0.264701] acpiphp: Slot [23] registered
machine# [    0.265701] acpiphp: Slot [24] registered
machine# [    0.266350] acpiphp: Slot [25] registered
machine# [    0.266701] acpiphp: Slot [26] registered
machine# [    0.267701] acpiphp: Slot [27] registered
machine# [    0.268380] acpiphp: Slot [28] registered
machine# [    0.268700] acpiphp: Slot [29] registered
machine# [    0.269701] acpiphp: Slot [30] registered
machine# [    0.270363] acpiphp: Slot [31] registered
machine# [    0.270677] PCI host bridge to bus 0000:00
machine# [    0.271666] pci_bus 0000:00: root bus resource [io  0x0000-0x0cf7 window]
machine# [    0.272666] pci_bus 0000:00: root bus resource [io  0x0d00-0xffff window]
machine# [    0.273666] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
machine# [    0.274666] pci_bus 0000:00: root bus resource [mem 0x40000000-0xfebfffff window]
machine# [    0.275666] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window]
machine# [    0.276666] pci_bus 0000:00: root bus resource [bus 00-ff]
machine# [    0.284053] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io  0x01f0-0x01f7]
machine# [    0.284666] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io  0x03f6]
machine# [    0.285666] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io  0x0170-0x0177]
machine# [    0.286666] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io  0x0376]
machine# [    0.294368] pci 0000:00:01.3: quirk: [io  0x0600-0x063f] claimed by PIIX4 ACPI
machine# [    0.294699] pci 0000:00:01.3: quirk: [io  0x0700-0x070f] claimed by PIIX4 SMB
machine# [    0.401411] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
machine# [    0.401812] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
machine# [    0.402800] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
machine# [    0.403797] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
machine# [    0.404746] ACPI: PCI Interrupt Link [LNKS] (IRQs *9)
machine# [    0.405902] pci 0000:00:02.0: vgaarb: setting as boot VGA device
machine# [    0.406662] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none
machine# [    0.406667] pci 0000:00:02.0: vgaarb: bridge control possible
machine# [    0.407665] vgaarb: loaded
machine# [    0.408228] PCI: Using ACPI for IRQ routing
machine# [    0.409050] NetLabel: Initializing
machine# [    0.409665] NetLabel:  domain hash size = 128
machine# [    0.410336] NetLabel:  protocols = UNLABELED CIPSOv4 CALIPSO
machine# [    0.410676] NetLabel:  unlabeled traffic allowed by default
machine# [    0.411772] HPET: 3 timers in total, 0 timers will be used for per-cpu timer
machine# [    0.412708] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
machine# [    0.413665] hpet0: 3 comparators, 64-bit 100.000000 MHz counter
machine# [    0.419717] clocksource: Switched to clocksource kvm-clock
machine# [    0.426573] VFS: Disk quotas dquot_6.6.0
machine# [    0.427177] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
machine# [    0.428336] AppArmor: AppArmor Filesystem Enabled
machine# [    0.429091] pnp: PnP ACPI init
machine# [    0.429955] pnp: PnP ACPI: found 6 devices
machine# [    0.436031] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
machine# [    0.437420] NET: Registered protocol family 2
machine# [    0.438179] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes)
machine# [    0.439374] TCP established hash table entries: 8192 (order: 4, 65536 bytes)
machine# [    0.440458] TCP bind hash table entries: 8192 (order: 5, 131072 bytes)
machine# [    0.441474] TCP: Hash tables configured (established 8192 bind 8192)
machine# [    0.442474] UDP hash table entries: 512 (order: 2, 16384 bytes)
machine# [    0.443341] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes)
machine# [    0.444333] NET: Registered protocol family 1
machine# [    0.445013] pci 0000:00:01.0: PIIX3: Enabling Passive Release
machine# [    0.445888] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
machine# [    0.446784] pci 0000:00:01.0: Activating ISA DMA hang workarounds
machine# [    0.461328] PCI Interrupt Link [LNKD] enabled at IRQ 11
machine# [    0.476219] pci 0000:00:01.2: quirk_usb_early_handoff+0x0/0x6b0 took 27825 usecs
machine# [    0.477376] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
machine# [    0.478755] Trying to unpack rootfs image as initramfs...
machine# [    0.574644] Freeing initrd memory: 9616K
machine# [    0.575308] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2f740365dde, max_idle_ns: 440795326451 ns
machine# [    0.576911] Scanning for low memory corruption every 60 seconds
machine# [    0.578473] Initialise system trusted keyrings
machine# [    0.579178] workingset: timestamp_bits=40 max_order=18 bucket_order=0
machine# [    0.580891] zbud: loaded
machine# [    0.581702] Key type asymmetric registered
machine# [    0.582297] Asymmetric key parser 'x509' registered
machine# [    0.583095] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250)
machine# [    0.584224] io scheduler noop registered
machine# [    0.584843] io scheduler deadline registered
machine# [    0.585542] io scheduler cfq registered (default)
machine# [    0.586245] io scheduler mq-deadline registered
machine# [    0.586943] io scheduler kyber registered
machine# [    0.587751] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
machine# [    0.612288] 00:05: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
machine# [    0.615024] brd: module loaded
machine# [    0.615697] sched_clock: Marking stable (519427353, 96240628)->(725838042, -110170061)
machine# [    0.616970] registered taskstats version 1
machine# [    0.617575] Loading compiled-in X.509 certificates
machine# [    0.618335] zswap: loaded using pool lzo/zbud
machine# [    0.619029] AppArmor: AppArmor sha1 policy hashing enabled
machine# [    0.621639] Freeing unused kernel image memory: 1440K
machine# [    0.623683] Write protecting the kernel read-only data: 14336k
machine# [    0.624897] Freeing unused kernel image memory: 2012K
machine# [    0.625721] Freeing unused kernel image memory: 116K
machine# [    0.626521] Run /init as init process
machine# 
machine# <<< NixOS Stage 1 >>>
machine# 
machine# loading module virtio_balloon...
machine# loading module virtio_console...
machine# loading module virtio_rng...
machine# loading module dm_mod...
machine# [    0.663285] device-mapper: ioctl: 4.39.0-ioctl (2018-04-03) initialised: dm-devel@redhat.com
machine# running udev...
machine# [    0.668959] systemd-udevd[91]: starting version 239
machine# [    0.712871] rtc_cmos 00:00: RTC can wake from S4
machine# [    0.732694] rtc_cmos 00:00: registered as rtc0
machine# [    0.733367] rtc_cmos 00:00: alarms up to one day, y3k, 114 bytes nvram, hpet irqs
machine# [    0.735708] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
machine# [    0.744377] serio: i8042 KBD port at 0x60,0x64 irq 1
machine# [    0.750896] serio: i8042 AUX port at 0x60,0x64 irq 12
machine# [    0.774857] SCSI subsystem initialized
machine# [    0.784157] ACPI: bus type USB registered
machine# [    0.786694] usbcore: registered new interface driver usbfs
machine# [    0.787488] usbcore: registered new interface driver hub
machine# [    0.794081] PCI Interrupt Link [LNKC] enabled at IRQ 10
machine# [    0.794892] usbcore: registered new device driver usb
machine# [    0.810664] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
machine# [    0.821450] uhci_hcd: USB Universal Host Controller Interface driver
machine# [    0.831681] scsi host0: ata_piix
machine# [    0.838682] scsi host1: ata_piix
machine# [    0.839221] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc1c0 irq 14
machine# [    0.840321] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc1c8 irq 15
machine# [    0.861609] uhci_hcd 0000:00:01.2: UHCI Host Controller
machine# [    0.862365] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1
machine# [    0.863541] uhci_hcd 0000:00:01.2: detected 2 ports
machine# [    0.864435] random: fast init done
machine# [    0.866686] random: crng init done
machine# [    0.869755] uhci_hcd 0000:00:01.2: irq 11, io base 0x0000c0c0
machine# [    0.874692] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 4.19
machine# [    0.875952] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
machine# [    0.877059] usb usb1: Product: UHCI Host Controller
machine# [    0.877832] usb usb1: Manufacturer: Linux 4.19.33 uhci_hcd
machine# [    0.878658] usb usb1: SerialNumber: 0000:00:01.2
machine# [    0.883412] hub 1-0:1.0: USB hub found
machine# [    0.884031] hub 1-0:1.0: 2 ports detected
machine# [    0.890917] PCI Interrupt Link [LNKA] enabled at IRQ 10
machine# [    0.907223] PCI Interrupt Link [LNKB] enabled at IRQ 11
machine# [    1.006398] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100
machine# [    1.008226] scsi 1:0:0:0: CD-ROM            QEMU     QEMU DVD-ROM     2.5+ PQ: 0 ANSI: 5
machine# [    1.207750] usb 1-1: new full-speed USB device number 2 using uhci_hcd
machine# [    1.372199] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00
machine# [    1.373507] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=5
machine# [    1.374597] usb 1-1: Product: QEMU USB Tablet
machine# [    1.375332] usb 1-1: Manufacturer: QEMU
machine# [    1.375969] usb 1-1: SerialNumber: 42
machine# [   60.781742] systemd-udevd[92]: seq 648 '/devices/pci0000:00/0000:00:05.0' is taking a long time
machine# [   60.783047] systemd-udevd[92]: seq 653 '/devices/pci0000:00/0000:00:0a.0' is taking a long time
machine# [   60.784513] systemd-udevd[92]: seq 652 '/devices/pci0000:00/0000:00:09.0' is taking a long time
machine# [   60.785993] systemd-udevd[92]: seq 651 '/devices/pci0000:00/0000:00:08.0' is taking a long time
machine# [   60.787436] systemd-udevd[92]: seq 649 '/devices/pci0000:00/0000:00:06.0' is taking a long time
machine# [   60.788900] systemd-udevd[92]: seq 650 '/devices/pci0000:00/0000:00:07.0' is taking a long time
machine# [   60.790336] systemd-udevd[92]: seq 647 '/devices/pci0000:00/0000:00:04.0' is taking a long time
machine# [   60.791685] systemd-udevd[92]: seq 646 '/devices/pci0000:00/0000:00:03.0' is taking a long time
machine# [   61.781714] systemd-udevd[92]: seq 654 '/devices/pci0000:00/0000:00:0b.0' is taking a long time
machine# [   61.783032] systemd-udevd[92]: seq 655 '/devices/pci0000:00/0000:00:0c.0' is taking a long time
machine# kbd_mode: KDSKBMODE: Inappropriate ioctl for device
machine# %Gstarting device mapper and LVM...
machine# [  121.000823] clocksource: Switched to clocksource acpi_pm
machine# mke2fs 1.44.5 (15-Dec-2018)
machine# The file /dev/vdb does not exist and no size was specified.
machine# waiting for device /dev/vdb to appear.......................
machine# Timed out waiting for device /dev/vdb, trying to mount anyway.
machine# [  146.744569] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
machine# [  146.817568] 9pnet: Installing 9P2000 support
machine# [  146.907071] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray
machine# [  146.908111] cdrom: Uniform CD-ROM driver Revision: 3.20
machine# [  146.932100] hidraw: raw HID events driver (C) Jiri Kosina
machine# [  146.948604] usbcore: registered new interface driver usbhid
machine# [  146.949416] usbhid: USB HID core driver
machine# [  150.708613] virtio_blk virtio8: [vda] 16777216 512-byte logical blocks (8.59 GB/8.00 GiB)
machine# [  150.714431] virtio_blk virtio9: [vdb] 1048576 512-byte logical blocks (537 MB/512 MiB)
machine# [  150.720632] 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/input2
machine# [  150.722417] 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
machine# cannot check filesystem with type "auto"!
machine# mounting /dev/vdb on /...
machine# mount: mounting /dev/vdb on /mnt-root/ failed: No such file or directory
machine# [  150.919662] Kernel panic - not syncing: Attempted to kill init! exitcode=0x00000100
machine# [  150.919662] 
machine# [  150.921082] CPU: 0 PID: 1 Comm: init Not tainted 4.19.33 #1-NixOS
machine# [  150.922029] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.12.0-0-ga698c8995f-prebuilt.qemu.org 04/01/2014
machine# [  150.923709] Call Trace:
machine# [  150.924117]  dump_stack+0x5c/0x7b
machine# [  150.924644]  panic+0xe4/0x242
machine# [  150.925126]  do_exit+0xb52/0xb60
machine# [  150.925651]  ? handle_mm_fault+0xdc/0x210
machine# [  150.926297]  do_group_exit+0x3a/0xa0
machine# [  150.926851]  __x64_sys_exit_group+0x14/0x20
machine# [  150.927532]  do_syscall_64+0x4e/0x100
machine# [  150.928117]  entry_SYSCALL_64_after_hwframe+0x44/0xa9
machine# [  150.928886] RIP: 0033:0x7fa0c6999676
machine# [  150.929474] Code: Bad RIP value.
machine# [  150.929995] RSP: 002b:00007ffef2522ea8 EFLAGS: 00000202 ORIG_RAX: 00000000000000e7
machine# [  150.931134] RAX: ffffffffffffffda RBX: 000000000169f704 RCX: 00007fa0c6999676
machine# [  150.932214] RDX: 0000000000000001 RSI: 000000000000003c RDI: 0000000000000001
machine# [  150.933313] RBP: 0000000000000001 R08: 00000000000000e7 R09: ffffffffffffff80
machine# [  150.934393] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffef2523238
machine# [  150.935486] R13: 00007ffef2523230 R14: 0000000000000000 R15: 0000000000000000
machine# [  150.936731] Kernel Offset: 0xee00000 from 0xffffffff81000000 (relocation range: 0xffffffff80000000-0xffffffffbfffffff)
machine# [  150.938335] Rebooting in 1 seconds..
vde_switch: EOF data port: Interrupted system call
(153.51 seconds)
(153.51 seconds)
error: the VM quit before connecting
(153.58 seconds)
the VM quit before connecting
vde_switch: EOF on stdin, cleaning up and exiting
cleaning up
killing machine (pid 597)
(0.00 seconds)