Skip to content

Instantly share code, notes, and snippets.

@Taneb

Taneb/aszlig.txt Secret

Created January 29, 2019 17:40
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save Taneb/611faa2437a17d5446c1e4d43c2a59ff to your computer and use it in GitHub Desktop.
Save Taneb/611faa2437a17d5446c1e4d43c2a59ff to your computer and use it in GitHub Desktop.
starting VDE switch for network 1
running the VM test script
machine: waiting for unit ‘multi-user.target’
machine: running command: systemctl --no-pager show "multi-user.target"
machine: waiting for the VM to finish booting
machine: starting vm
machine# Formatting '/build/vm-state-machine/machine.qcow2', fmt=qcow2 size=536870912 cluster_size=65536 lazy_refcounts=off refcount_bits=16
machine: QEMU running (pid 597)
machine# c[?7lSeaBIOS (version rel-1.11.2-0-gf9626ccb91-prebuilt.qemu-project.org)
machine#
machine#
machine# iPXE (http://ipxe.org) 00:03.0 C980 PCI2.10 PnP PMM+17F910B0+17EF10B0 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 17F910B0 17EF10B0 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)... oc[?7lk
[ 0.000000] Linux version 4.19.7 (nixbld@localhost) (gcc version 7.3.0 (GCC)) #1-NixOS SMP Wed Dec 5 18:32:14 UTC 2018
machine# [ 0.000000] Command line: loglevel=8 console=ttyS0 panic=1 boot.panic_on_fail dyndbg="file fs/overlayfs/* +p" init=/nix/store/50abrqsa1gqj0qf818nmng75f7cdlin6-nixos-system-machine-19.03pre-git/init regInfo=/nix/store/pjwxi9m7b4xxvfaayx51dfhxmhh5y6sg-closure-info/registration console=hvc1 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-0x0000000017fdbfff] usable
machine# [ 0.000000] BIOS-e820: [mem 0x0000000017fdc000-0x0000000017ffffff] 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.11.2-0-gf9626ccb91-prebuilt.qemu-project.org 04/01/2014
machine# [ 0.000000] tsc: Fast TSC calibration using PIT
machine# [ 0.000000] tsc: Detected 3696.053 MHz processor
machine# [ 0.006264] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
machine# [ 0.006397] e820: remove [mem 0x000a0000-0x000fffff] usable
machine# [ 0.006523] last_pfn = 0x17fdc max_arch_pfn = 0x400000000
machine# [ 0.006868] MTRR default type: write-back
machine# [ 0.006900] MTRR fixed ranges enabled:
machine# [ 0.006997] 00000-9FFFF write-back
machine# [ 0.007018] A0000-BFFFF uncachable
machine# [ 0.007036] C0000-FFFFF write-protect
machine# [ 0.007050] MTRR variable ranges enabled:
machine# [ 0.007147] 0 base 0080000000 mask FF80000000 uncachable
machine# [ 0.007171] 1 disabled
machine# [ 0.007180] 2 disabled
machine# [ 0.007188] 3 disabled
machine# [ 0.007195] 4 disabled
machine# [ 0.007202] 5 disabled
machine# [ 0.007209] 6 disabled
machine# [ 0.007216] 7 disabled
machine# [ 0.007442] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WC UC- UC
machine# [ 0.018607] found SMP MP-table at [mem 0x000f58f0-0x000f58ff] mapped at [(____ptrval____)]
machine# [ 0.020061] Scanning 1 areas for low memory corruption
machine# [ 0.020462] Base memory trampoline at [(____ptrval____)] 99000 size 24576
machine# [ 0.020960] BRK [0x06a01000, 0x06a01fff] PGTABLE
machine# [ 0.021073] BRK [0x06a02000, 0x06a02fff] PGTABLE
machine# [ 0.021121] BRK [0x06a03000, 0x06a03fff] PGTABLE
machine# [ 0.022480] BRK [0x06a04000, 0x06a04fff] PGTABLE
machine# [ 0.023320] BRK [0x06a05000, 0x06a05fff] PGTABLE
machine# [ 0.023698] RAMDISK: [mem 0x176a9000-0x17fcffff]
machine# [ 0.024070] ACPI: Early table checksum verification disabled
machine# [ 0.024747] ACPI: RSDP 0x00000000000F5700 000014 (v00 BOCHS )
machine# [ 0.024902] ACPI: RSDT 0x0000000017FE157C 000030 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001)
machine# [ 0.025294] ACPI: FACP 0x0000000017FE1458 000074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001)
machine# [ 0.025667] ACPI: DSDT 0x0000000017FE0040 001418 (v01 BOCHS BXPCDSDT 00000001 BXPC 00000001)
machine# [ 0.025733] ACPI: FACS 0x0000000017FE0000 000040
machine# [ 0.025789] ACPI: APIC 0x0000000017FE14CC 000078 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001)
machine# [ 0.025822] ACPI: HPET 0x0000000017FE1544 000038 (v01 BOCHS BXPCHPET 00000001 BXPC 00000001)
machine# [ 0.026171] ACPI: Local APIC address 0xfee00000
machine# [ 0.027196] No NUMA configuration found
machine# [ 0.027222] Faking a node at [mem 0x0000000000000000-0x0000000017fdbfff]
machine# [ 0.027666] NODE_DATA(0) allocated [mem 0x17fd8000-0x17fdbfff]
machine# [ 0.029473] Zone ranges:
machine# [ 0.029516] DMA [mem 0x0000000000001000-0x0000000000ffffff]
machine# [ 0.029554] DMA32 [mem 0x0000000001000000-0x0000000017fdbfff]
machine# [ 0.029568] Normal empty
machine# [ 0.029587] Movable zone start for each node
machine# [ 0.029613] Early memory node ranges
machine# [ 0.029637] node 0: [mem 0x0000000000001000-0x000000000009efff]
machine# [ 0.029652] node 0: [mem 0x0000000000100000-0x0000000017fdbfff]
machine# [ 0.031405] Reserved but unavailable: 134 pages
machine# [ 0.031540] Initmem setup node 0 [mem 0x0000000000001000-0x0000000017fdbfff]
machine# [ 0.031667] On node 0 totalpages: 98170
machine# [ 0.031754] DMA zone: 64 pages used for memmap
machine# [ 0.031777] DMA zone: 21 pages reserved
machine# [ 0.031826] DMA zone: 3998 pages, LIFO batch:0
machine# [ 0.032631] DMA32 zone: 1472 pages used for memmap
machine# [ 0.032657] DMA32 zone: 94172 pages, LIFO batch:31
machine# [ 0.048038] ACPI: PM-Timer IO Port: 0x608
machine# [ 0.048084] ACPI: Local APIC address 0xfee00000
machine# [ 0.048369] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
machine# [ 0.048641] IOAPIC[0]: apic_id 0, version 32, address 0xfec00000, GSI 0-23
machine# [ 0.048734] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
machine# [ 0.048913] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
machine# [ 0.048941] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
machine# [ 0.049010] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
machine# [ 0.049023] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
machine# [ 0.049083] ACPI: IRQ0 used by override.
machine# [ 0.049126] ACPI: IRQ5 used by override.
machine# [ 0.049136] ACPI: IRQ9 used by override.
machine# [ 0.049143] ACPI: IRQ10 used by override.
machine# [ 0.049150] ACPI: IRQ11 used by override.
machine# [ 0.049192] Using ACPI (MADT) for SMP configuration information
machine# [ 0.049234] ACPI: HPET id: 0x8086a201 base: 0xfed00000
machine# [ 0.049502] smpboot: Allowing 1 CPUs, 0 hotplug CPUs
machine# [ 0.050154] PM: Registered nosave memory: [mem 0x00000000-0x00000fff]
machine# [ 0.050192] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff]
machine# [ 0.050215] PM: Registered nosave memory: [mem 0x000a0000-0x000effff]
machine# [ 0.050224] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff]
machine# [ 0.050308] [mem 0x18000000-0xfffbffff] available for PCI devices
machine# [ 0.050334] Booting paravirtualized kernel on bare hardware
machine# [ 0.050554] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
machine# [ 0.631482] random: get_random_bytes called from start_kernel+0x94/0x4d4 with crng_init=0
machine# [ 0.632011] setup_percpu: NR_CPUS:384 nr_cpumask_bits:384 nr_cpu_ids:1 nr_node_ids:1
machine# [ 0.644858] percpu: Embedded 44 pages/cpu @(____ptrval____) s141272 r8192 d30760 u2097152
machine# [ 0.645098] pcpu-alloc: s141272 r8192 d30760 u2097152 alloc=1*2097152
machine# [ 0.645148] pcpu-alloc: [0] 0
machine# [ 0.646418] Built 1 zonelists, mobility grouping on. Total pages: 96613
machine# [ 0.646436] Policy zone: DMA32
machine# [ 0.646556] Kernel command line: loglevel=8 console=ttyS0 panic=1 boot.panic_on_fail dyndbg="file fs/overlayfs/* +p" init=/nix/store/50abrqsa1gqj0qf818nmng75f7cdlin6-nixos-system-machine-19.03pre-git/init regInfo=/nix/store/pjwxi9m7b4xxvfaayx51dfhxmhh5y6sg-closure-info/registration console=hvc1 console=ttyS0
machine# [ 0.648716] Calgary: detecting Calgary via BIOS EBDA area
machine# [ 0.648758] Calgary: Unable to locate Rio Grande table in EBDA - bailing!
machine# [ 0.671951] Memory: 354936K/392680K available (10252K kernel code, 1125K rwdata, 1932K rodata, 1456K init, 804K bss, 37744K reserved, 0K cma-reserved)
machine# [ 0.675656] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
machine# [ 0.676698] Kernel/User page tables isolation: enabled
machine# [ 0.677863] ftrace: allocating 28488 entries in 112 pages
machine# [ 0.732858] rcu: Hierarchical RCU implementation.
machine# [ 0.732923] rcu: RCU event tracing is enabled.
machine# [ 0.732946] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.
machine# [ 0.733015] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
machine# [ 0.746891] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16
machine# [ 0.752386] Console: colour VGA+ 80x25
machine# [ 0.767023] console [ttyS0] enabled
machine# [ 0.767622] ACPI: Core revision 20180810
machine# [ 0.771216] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
machine# [ 0.772673] hpet clockevent registered
machine# [ 0.775135] APIC: Switch to symmetric I/O mode setup
machine# [ 0.778493] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
machine# [ 0.783846] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x6a8d8bd8ebc, max_idle_ns: 881590655894 ns
machine# [ 0.785095] Calibrating delay loop (skipped), value calculated using timer frequency.. 7392.10 BogoMIPS (lpj=3696053)
machine# [ 0.785287] pid_max: default: 32768 minimum: 301
machine# [ 0.786743] Security Framework initialized
machine# [ 0.786954] Yama: becoming mindful.
machine# [ 0.788838] AppArmor: AppArmor initialized
machine# [ 0.789914] Dentry cache hash table entries: 65536 (order: 7, 524288 bytes)
machine# [ 0.790378] Inode-cache hash table entries: 32768 (order: 6, 262144 bytes)
machine# [ 0.790732] Mount-cache hash table entries: 1024 (order: 1, 8192 bytes)
machine# [ 0.790919] Mountpoint-cache hash table entries: 1024 (order: 1, 8192 bytes)
machine# [ 0.800160] mce: CPU supports 10 MCE banks
machine# [ 0.801022] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
machine# [ 0.801115] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
machine# [ 0.801345] Spectre V2 : Mitigation: Full generic retpoline
machine# [ 0.801443] Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch
machine# [ 0.801646] Speculative Store Bypass: Vulnerable
machine# [ 1.007244] Freeing SMP alternatives memory: 28K
machine# [ 1.027287] random: fast init done
machine# [ 1.027287] smpboot: CPU0: Intel Common KVM processor (family: 0xf, model: 0x6, stepping: 0x1)
machine# [ 1.029920] Performance Events: unsupported Netburst CPU model 6 no PMU driver, software events only.
machine# [ 1.031161] rcu: Hierarchical SRCU implementation.
machine# [ 1.038781] smp: Bringing up secondary CPUs ...
machine# [ 1.038911] smp: Brought up 1 node, 1 CPU
machine# [ 1.039068] smpboot: Max logical packages: 1
machine# [ 1.039350] smpboot: Total of 1 processors activated (7392.10 BogoMIPS)
machine# [ 1.046900] devtmpfs: initialized
machine# [ 1.050980] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
machine# [ 1.051351] futex hash table entries: 256 (order: 2, 16384 bytes)
machine# [ 1.053756] pinctrl core: initialized pinctrl subsystem
machine# [ 1.060343] NET: Registered protocol family 16
machine# [ 1.061990] audit: initializing netlink subsys (disabled)
machine# [ 1.064117] cpuidle: using governor menu
machine# [ 1.064749] ACPI: bus type PCI registered
machine# [ 1.064863] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
machine# [ 1.066223] PCI: Using configuration type 1 for base access
machine# [ 1.066617] audit: type=2000 audit(1548783391.288:1): state=initialized audit_enabled=0 res=1
machine# [ 1.078401] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
machine# [ 1.081654] ACPI: Added _OSI(Module Device)
machine# [ 1.081742] ACPI: Added _OSI(Processor Device)
machine# [ 1.081887] ACPI: Added _OSI(3.0 _SCP Extensions)
machine# [ 1.082006] ACPI: Added _OSI(Processor Aggregator Device)
machine# [ 1.082212] ACPI: Added _OSI(Linux-Dell-Video)
machine# [ 1.082353] ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio)
machine# [ 1.091934] ACPI: 1 ACPI AML tables successfully acquired and loaded
machine# [ 1.103045] ACPI: Interpreter enabled
machine# [ 1.103710] ACPI: (supports S0 S3 S4 S5)
machine# [ 1.103813] ACPI: Using IOAPIC for interrupt routing
machine# [ 1.104427] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
machine# [ 1.105547] ACPI: Enabled 2 GPEs in block 00 to 0F
machine# [ 1.129211] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
machine# [ 1.129539] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI]
machine# [ 1.129795] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM
machine# [ 1.130180] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge.
machine# [ 1.132644] acpiphp: Slot [3] registered
machine# [ 1.132834] acpiphp: Slot [4] registered
machine# [ 1.132997] acpiphp: Slot [5] registered
machine# [ 1.133316] acpiphp: Slot [6] registered
machine# [ 1.133472] acpiphp: Slot [7] registered
machine# [ 1.133633] acpiphp: Slot [8] registered
machine# [ 1.133854] acpiphp: Slot [9] registered
machine# [ 1.134045] acpiphp: Slot [10] registered
machine# [ 1.134309] acpiphp: Slot [11] registered
machine# [ 1.134486] acpiphp: Slot [12] registered
machine# [ 1.134712] acpiphp: Slot [13] registered
machine# [ 1.134906] acpiphp: Slot [14] registered
machine# [ 1.135094] acpiphp: Slot [15] registered
machine# [ 1.135343] acpiphp: Slot [16] registered
machine# [ 1.135540] acpiphp: Slot [17] registered
machine# [ 1.135744] acpiphp: Slot [18] registered
machine# [ 1.135936] acpiphp: Slot [19] registered
machine# [ 1.136114] acpiphp: Slot [20] registered
machine# [ 1.136370] acpiphp: Slot [21] registered
machine# [ 1.136566] acpiphp: Slot [22] registered
machine# [ 1.136734] acpiphp: Slot [23] registered
machine# [ 1.136914] acpiphp: Slot [24] registered
machine# [ 1.137117] acpiphp: Slot [25] registered
machine# [ 1.137352] acpiphp: Slot [26] registered
machine# [ 1.137552] acpiphp: Slot [27] registered
machine# [ 1.137755] acpiphp: Slot [28] registered
machine# [ 1.137948] acpiphp: Slot [29] registered
machine# [ 1.138125] acpiphp: Slot [30] registered
machine# [ 1.138334] acpiphp: Slot [31] registered
machine# [ 1.138587] PCI host bridge to bus 0000:00
machine# [ 1.138769] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]
machine# [ 1.138889] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]
machine# [ 1.139052] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
machine# [ 1.139204] pci_bus 0000:00: root bus resource [mem 0x18000000-0xfebfffff window]
machine# [ 1.139323] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window]
machine# [ 1.139564] pci_bus 0000:00: root bus resource [bus 00-ff]
machine# [ 1.140105] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000
machine# [ 1.142883] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100
machine# [ 1.143591] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180
machine# [ 1.144887] pci 0000:00:01.1: reg 0x20: [io 0xc1c0-0xc1cf]
machine# [ 1.146320] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7]
machine# [ 1.146476] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6]
machine# [ 1.146672] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177]
machine# [ 1.146842] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376]
machine# [ 1.147714] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300
machine# [ 1.148949] pci 0000:00:01.2: reg 0x20: [io 0xc0c0-0xc0df]
machine# [ 1.150818] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000
machine# [ 1.151175] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI
machine# [ 1.151339] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB
machine# [ 1.152006] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000
machine# [ 1.152287] pci 0000:00:02.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref]
machine# [ 1.154287] pci 0000:00:02.0: reg 0x18: [mem 0xfebd0000-0xfebd0fff]
machine# [ 1.156259] pci 0000:00:02.0: reg 0x30: [mem 0xfebc0000-0xfebcffff pref]
machine# [ 1.157213] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000
machine# [ 1.158287] pci 0000:00:03.0: reg 0x10: [io 0xc0e0-0xc0ff]
machine# [ 1.159287] pci 0000:00:03.0: reg 0x14: [mem 0xfebd1000-0xfebd1fff]
machine# [ 1.161820] pci 0000:00:03.0: reg 0x20: [mem 0xfe000000-0xfe003fff 64bit pref]
machine# [ 1.162287] pci 0000:00:03.0: reg 0x30: [mem 0xfeb40000-0xfeb7ffff pref]
machine# [ 1.163918] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00
machine# [ 1.164287] pci 0000:00:04.0: reg 0x10: [io 0xc100-0xc11f]
machine# [ 1.165287] pci 0000:00:04.0: reg 0x20: [mem 0xfe004000-0xfe007fff 64bit pref]
machine# [ 1.167511] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200
machine# [ 1.168287] pci 0000:00:05.0: reg 0x10: [io 0xc120-0xc13f]
machine# [ 1.169254] pci 0000:00:05.0: reg 0x14: [mem 0xfebd2000-0xfebd2fff]
machine# [ 1.170287] pci 0000:00:05.0: reg 0x20: [mem 0xfe008000-0xfe00bfff 64bit pref]
machine# [ 1.172747] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200
machine# [ 1.173287] pci 0000:00:06.0: reg 0x10: [io 0xc140-0xc15f]
machine# [ 1.174177] pci 0000:00:06.0: reg 0x14: [mem 0xfebd3000-0xfebd3fff]
machine# [ 1.175287] pci 0000:00:06.0: reg 0x20: [mem 0xfe00c000-0xfe00ffff 64bit pref]
machine# [ 1.176929] pci 0000:00:07.0: [1af4:1009] type 00 class 0x000200
machine# [ 1.178168] pci 0000:00:07.0: reg 0x10: [io 0xc160-0xc17f]
machine# [ 1.179144] pci 0000:00:07.0: reg 0x14: [mem 0xfebd4000-0xfebd4fff]
machine# [ 1.182287] pci 0000:00:07.0: reg 0x20: [mem 0xfe010000-0xfe013fff 64bit pref]
machine# [ 1.183913] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000
machine# [ 1.185152] pci 0000:00:08.0: reg 0x10: [io 0xc180-0xc19f]
machine# [ 1.186149] pci 0000:00:08.0: reg 0x14: [mem 0xfebd5000-0xfebd5fff]
machine# [ 1.187287] pci 0000:00:08.0: reg 0x20: [mem 0xfe014000-0xfe017fff 64bit pref]
machine# [ 1.188152] pci 0000:00:08.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref]
machine# [ 1.188956] pci 0000:00:09.0: [1af4:1003] type 00 class 0x078000
machine# [ 1.189287] pci 0000:00:09.0: reg 0x10: [io 0xc000-0xc03f]
machine# [ 1.190175] pci 0000:00:09.0: reg 0x14: [mem 0xfebd6000-0xfebd6fff]
machine# [ 1.192287] pci 0000:00:09.0: reg 0x20: [mem 0xfe018000-0xfe01bfff 64bit pref]
machine# [ 1.194446] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000
machine# [ 1.195287] pci 0000:00:0a.0: reg 0x10: [io 0xc040-0xc07f]
machine# [ 1.196143] pci 0000:00:0a.0: reg 0x14: [mem 0xfebd7000-0xfebd7fff]
machine# [ 1.197287] pci 0000:00:0a.0: reg 0x20: [mem 0xfe01c000-0xfe01ffff 64bit pref]
machine# [ 1.198913] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00
machine# [ 1.199910] pci 0000:00:0b.0: reg 0x10: [io 0xc1a0-0xc1bf]
machine# [ 1.200287] pci 0000:00:0b.0: reg 0x20: [mem 0xfe020000-0xfe023fff 64bit pref]
machine# [ 1.201751] pci 0000:00:0c.0: [1af4:1001] type 00 class 0x010000
machine# [ 1.202287] pci 0000:00:0c.0: reg 0x10: [io 0xc080-0xc0bf]
machine# [ 1.203133] pci 0000:00:0c.0: reg 0x14: [mem 0xfebd8000-0xfebd8fff]
machine# [ 1.204287] pci 0000:00:0c.0: reg 0x20: [mem 0xfe024000-0xfe027fff 64bit pref]
machine# [ 1.209920] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
machine# [ 1.210570] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
machine# [ 1.211034] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
machine# [ 1.211581] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
machine# [ 1.211862] ACPI: PCI Interrupt Link [LNKS] (IRQs *9)
machine# [ 1.216287] pci 0000:00:02.0: vgaarb: setting as boot VGA device
machine# [ 1.216287] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none
machine# [ 1.216341] pci 0000:00:02.0: vgaarb: bridge control possible
machine# [ 1.216497] vgaarb: loaded
machine# [ 1.218345] PCI: Using ACPI for IRQ routing
machine# [ 1.218511] PCI: pci_cache_line_size set to 64 bytes
machine# [ 1.218890] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff]
machine# [ 1.219082] e820: reserve RAM buffer [mem 0x17fdc000-0x17ffffff]
machine# [ 1.223478] NetLabel: Initializing
machine# [ 1.223543] NetLabel: domain hash size = 128
machine# [ 1.223633] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO
machine# [ 1.224673] NetLabel: unlabeled traffic allowed by default
machine# [ 1.226750] HPET: 3 timers in total, 0 timers will be used for per-cpu timer
machine# [ 1.227015] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
machine# [ 1.227151] hpet0: 3 comparators, 64-bit 100.000000 MHz counter
machine# [ 1.231724] clocksource: Switched to clocksource tsc-early
machine# [ 1.296096] VFS: Disk quotas dquot_6.6.0
machine# [ 1.296319] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
machine# [ 1.299055] AppArmor: AppArmor Filesystem Enabled
machine# [ 1.299559] pnp: PnP ACPI init
machine# [ 1.300812] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active)
machine# [ 1.301262] pnp 00:01: Plug and Play ACPI device, IDs PNP0303 (active)
machine# [ 1.301576] pnp 00:02: Plug and Play ACPI device, IDs PNP0f13 (active)
machine# [ 1.301838] pnp 00:03: [dma 2]
machine# [ 1.302040] pnp 00:03: Plug and Play ACPI device, IDs PNP0700 (active)
machine# [ 1.302458] pnp 00:04: Plug and Play ACPI device, IDs PNP0400 (active)
machine# [ 1.302838] pnp 00:05: Plug and Play ACPI device, IDs PNP0501 (active)
machine# [ 1.303924] pnp: PnP ACPI: found 6 devices
machine# [ 1.324173] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
machine# [ 1.324728] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]
machine# [ 1.324836] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]
machine# [ 1.324957] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]
machine# [ 1.325113] pci_bus 0000:00: resource 7 [mem 0x18000000-0xfebfffff window]
machine# [ 1.325226] pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window]
machine# [ 1.325968] NET: Registered protocol family 2
machine# [ 1.329281] tcp_listen_portaddr_hash hash table entries: 256 (order: 0, 4096 bytes)
machine# [ 1.329497] TCP established hash table entries: 4096 (order: 3, 32768 bytes)
machine# [ 1.329756] TCP bind hash table entries: 4096 (order: 4, 65536 bytes)
machine# [ 1.330034] TCP: Hash tables configured (established 4096 bind 4096)
machine# [ 1.330798] UDP hash table entries: 256 (order: 1, 8192 bytes)
machine# [ 1.331131] UDP-Lite hash table entries: 256 (order: 1, 8192 bytes)
machine# [ 1.332113] NET: Registered protocol family 1
machine# [ 1.332418] pci 0000:00:01.0: PIIX3: Enabling Passive Release
machine# [ 1.332589] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
machine# [ 1.332740] pci 0000:00:01.0: Activating ISA DMA hang workarounds
machine# [ 1.447755] PCI Interrupt Link [LNKD] enabled at IRQ 11
machine# [ 1.560845] pci 0000:00:01.2: quirk_usb_early_handoff+0x0/0x6b0 took 222535 usecs
machine# [ 1.561322] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
machine# [ 1.561531] PCI: CLS 0 bytes, default 64
machine# [ 1.564238] Trying to unpack rootfs image as initramfs...
machine# [ 2.019979] Freeing initrd memory: 9372K
machine# [ 2.021045] Scanning for low memory corruption every 60 seconds
machine# [ 2.024498] Initialise system trusted keyrings
machine# [ 2.026732] workingset: timestamp_bits=40 max_order=17 bucket_order=0
machine# [ 2.035017] zbud: loaded
machine# [ 2.043694] Key type asymmetric registered
machine# [ 2.043830] Asymmetric key parser 'x509' registered
machine# [ 2.044133] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250)
machine# [ 2.044836] io scheduler noop registered
machine# [ 2.044947] io scheduler deadline registered
machine# [ 2.045318] io scheduler cfq registered (default)
machine# [ 2.045608] io scheduler mq-deadline registered
machine# [ 2.045681] io scheduler kyber registered
machine# [ 2.048906] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
machine# [ 2.070442] 00:05: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
machine# [ 2.097210] brd: module loaded
machine# [ 2.099039] sched_clock: Marking stable (2073453897, 24862166)->(2228294802, -129978739)
machine# [ 2.101008] registered taskstats version 1
machine# [ 2.101115] Loading compiled-in X.509 certificates
machine# [ 2.101827] zswap: loaded using pool lzo/zbud
machine# [ 2.103485] AppArmor: AppArmor sha1 policy hashing enabled
machine# [ 2.152485] Freeing unused kernel image memory: 1456K
machine# [ 2.153951] Write protecting the kernel read-only data: 14336k
machine# [ 2.156945] Freeing unused kernel image memory: 2012K
machine# [ 2.157456] Freeing unused kernel image memory: 116K
machine# [ 2.157944] Run /init as init process
machine#
machine# <<< NixOS Stage 1 >>>
machine#
machine# loading module virtio_balloon...
machine# [ 2.869894] stage-1-init: loading module virtio_balloon...
machine# loading module virtio_console...
machine# [ 2.958912] stage-1-init: loading module virtio_console...
machine# loading module virtio_rng...
machine# [ 3.031080] stage-1-init: loading module virtio_rng...
machine# [ 3.047302] tsc: Refined TSC clocksource calibration: 3696.068 MHz
machine# [ 3.047695] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x6a8da790e6c, max_idle_ns: 881590663759 ns
machine# [ 3.048036] clocksource: Switched to clocksource tsc
machine# loading module dm_mod...
machine# [ 3.101463] stage-1-init: loading module dm_mod...
machine# [ 3.183393] device-mapper: ioctl: 4.39.0-ioctl (2018-04-03) initialised: dm-devel@redhat.com
machine# running udev...
machine# [ 3.189566] stage-1-init: running udev...
machine# [ 3.306537] systemd-udevd[92]: starting version 239
machine# [ 4.564380] rtc_cmos 00:00: RTC can wake from S4
machine# [ 4.642946] rtc_cmos 00:00: registered as rtc0
machine# [ 4.651674] rtc_cmos 00:00: alarms up to one day, y3k, 114 bytes nvram, hpet irqs
machine# [ 4.675965] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
machine# [ 4.710882] serio: i8042 KBD port at 0x60,0x64 irq 1
machine# [ 4.711288] serio: i8042 AUX port at 0x60,0x64 irq 12
machine# [ 4.951930] SCSI subsystem initialized
machine# [ 5.001608] ACPI: bus type USB registered
machine# [ 5.002255] usbcore: registered new interface driver usbfs
machine# [ 5.008602] usbcore: registered new interface driver hub
machine# [ 5.016711] usbcore: registered new device driver usb
machine# [ 5.119007] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
machine# [ 5.173982] uhci_hcd: USB Universal Host Controller Interface driver
machine# [ 5.233543] libata version 3.00 loaded.
machine# [ 5.255427] ata_piix 0000:00:01.1: version 2.13
machine# [ 5.289719] scsi host0: ata_piix
machine# [ 5.300529] scsi host1: ata_piix
machine# [ 5.301157] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc1c0 irq 14
machine# [ 5.301313] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc1c8 irq 15
machine# [ 5.465730] ata2.01: NODEV after polling detection
machine# [ 5.466754] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100
machine# [ 5.481151] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5
machine# [ 5.531519] PCI Interrupt Link [LNKC] enabled at IRQ 10
machine# [ 5.533033] uhci_hcd 0000:00:01.2: UHCI Host Controller
machine# [ 5.533508] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1
machine# [ 5.533912] uhci_hcd 0000:00:01.2: detected 2 ports
machine# [ 5.534306] uhci_hcd 0000:00:01.2: irq 11, io base 0x0000c0c0
machine# [ 5.545857] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 4.19
machine# [ 5.546024] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
machine# [ 5.546178] usb usb1: Product: UHCI Host Controller
machine# [ 5.546278] usb usb1: Manufacturer: Linux 4.19.7 uhci_hcd
machine# [ 5.546458] usb usb1: SerialNumber: 0000:00:01.2
machine# [ 5.556438] hub 1-0:1.0: USB hub found
machine# [ 5.556894] hub 1-0:1.0: 2 ports detected
machine# [ 5.802709] random: crng init done
machine# [ 5.888516] usb 1-1: new full-speed USB device number 2 using uhci_hcd
machine# [ 5.927213] PCI Interrupt Link [LNKA] enabled at IRQ 10
machine# [ 6.052435] PCI Interrupt Link [LNKB] enabled at IRQ 11
machine# [ 6.053111] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00
machine# [ 6.053262] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=5
machine# [ 6.053453] usb 1-1: Product: QEMU USB Tablet
machine# [ 6.053528] usb 1-1: Manufacturer: QEMU
machine# [ 6.053609] usb 1-1: SerialNumber: 42
machine# [ 6.609157] console [hvc1] enabled
machine# [ 7.424261] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
machine# [ 7.665934] 9pnet: Installing 9P2000 support
machine# [ 7.689576] virtio_blk virtio9: [vda] 1048576 512-byte logical blocks (537 MB/512 MiB)
machine# [ 7.726012] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray
machine# [ 7.726499] cdrom: Uniform CD-ROM driver Revision: 3.20
machine# [ 7.754569] sr 1:0:0:0: Attached scsi CD-ROM sr0
machine# [ 7.828123] hidraw: raw HID events driver (C) Jiri Kosina
machine# [ 7.915867] usbcore: registered new interface driver usbhid
machine# [ 7.916160] usbhid: USB HID core driver
machine# [ 7.969505] 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# [ 7.974074] 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# kbd_mode: KDSKBMODE: Inappropriate ioctl for device
machine# %G[ 8.472330] stage-1-init: kbd_mode: KDSKBMODE: Inappropriate ioctl for device
machine# starting device mapper and LVM...
machine# [ 8.526030] stage-1-init: starting device mapper and LVM...
machine# [ 8.750560] clocksource: Switched to clocksource acpi_pm
machine# mke2fs 1.44.4 (18-Aug-2018)
machine# [ 8.827851] stage-1-init: mke2fs 1.44.4 (18-Aug-2018)
machine# Creating filesystem with 131072 4k blocks and 32768 inodes
machine# [ 8.856959] stage-1-init: Creating filesystem with 131072 4k blocks and 32768 inodes
machine# Filesystem UUID: 5003bad4-95e8-440c-a00d-666eeea37e63
machine# Superblock backups stored on blocks:
machine# 32768, 98304
machine#
machine# Allocating group tables: 0/4[ 8.864112] stage-1-init: Filesystem UUID: 5003bad4-95e8-440c-a00d-666eeea37e63
machine#  done
machine# Writing inode tables: [ 8.870787] stage-1-init: Superblock backups stored on blocks:
machine# 0/4 done
machine# [ 8.878251] stage-1-init: 32768, 98304
machine# [ 8.886079] stage-1-init: Allocating group tables: 0/4 done
machine# Creating journal (4096 blocks): [ 8.892619] stage-1-init: Writing inode tables: 0/4 done
machine# done
machine# [ 8.969224] stage-1-init: Creating journal (4096 blocks): done
machine# Writing superblocks and filesystem accounting information: 0/4 done
machine#
machine# [ 9.050971] stage-1-init: Writing superblocks and filesystem accounting information: 0/4 done
machine# checking /dev/vda...
machine# [ 9.238531] stage-1-init: checking /dev/vda...
machine# fsck (busybox 1.29.3)
machine# [ 9.259693] stage-1-init: fsck (busybox 1.29.3)
machine# [fsck.ext4 (1) -- /mnt-root/] fsck.ext4 -a /dev/vda
machine# [ 9.267753] stage-1-init: [fsck.ext4 (1) -- /mnt-root/] fsck.ext4 -a /dev/vda
machine# /dev/vda: clean, 11/32768 files, 6353/131072 blocks
machine# [ 9.316199] stage-1-init: /dev/vda: clean, 11/32768 files, 6353/131072 blocks
machine# mounting /dev/vda on /...
machine# [ 9.332058] stage-1-init: mounting /dev/vda on /...
machine# [ 9.834854] EXT4-fs (vda): mounted filesystem with ordered data mode. Opts: (null)
machine# mounting store on /nix/store...
machine# [ 9.931490] stage-1-init: mounting store on /nix/store...
machine# [ 10.064838] FS-Cache: Loaded
machine# [ 10.098545] 9p: Installing v9fs 9p2000 file system support
machine# [ 10.099311] FS-Cache: Netfs '9p' registered for caching
machine# mounting shared on /tmp/shared...[ 10.326577] stage-1-init: mounting shared on /tmp/shared...
machine#
machine# mounting xchg on /tmp/xchg...
machine# [ 10.481610] stage-1-init: mounting xchg on /tmp/xchg...
machine#
machine# <<< NixOS Stage 2 >>>
machine#
machine# [ 12.389891] EXT4-fs (vda): re-mounted. Opts: (null)
machine# [ 12.399667] booting system configuration /nix/store/50abrqsa1gqj0qf818nmng75f7cdlin6-nixos-system-machine-19.03pre-git
machine# [ 13.435656] stage-2-init: running activation script...
machine# running activation script...
machine# setting up /etc...
machine# [ 15.133099] stage-2-init: setting up /etc...
machine# error: changing ownership of path '/nix/store': Invalid argument
machine# [ 23.881921] stage-2-init: error: changing ownership of path '/nix/store': Invalid argument
machine# starting systemd...
machine# [ 24.472389] NET: Registered protocol family 10
machine# [ 24.482094] Segment Routing with IPv6
machine# [ 24.573619] systemd[1]: systemd 239 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)
machine# [ 24.575868] systemd[1]: Detected virtualization qemu.
machine# [ 24.576297] systemd[1]: Detected architecture x86-64.
machine# [ 24.606704] systemd[1]: Set hostname to <machine>.
machine# [ 24.608055] systemd[1]: Initializing machine ID from random generator.
machine# [ 25.459763] systemd-fstab-generator[403]: Checking was requested for "store", but it is not a device.
machine# [ 25.465095] systemd-fstab-generator[403]: Checking was requested for "shared", but it is not a device.
machine# [ 25.466871] systemd-fstab-generator[403]: Checking was requested for "xchg", but it is not a device.
machine# [ 26.490743] systemd[1]: Listening on initctl Compatibility Named Pipe.
machine# [ 26.492991] systemd[1]: Reached target Containers.
machine# [ 26.495098] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
machine# [ 26.514631] systemd[1]: Created slice system-serial\x2dgetty.slice.
machine# [ 26.519238] systemd[1]: Created slice system-getty.slice.
machine# [ 27.056389] loop: module loaded
machine# [ 28.293791] EXT4-fs (vda): re-mounted. Opts: (null)
machine# [ 29.260790] audit: type=1130 audit(1548783419.511:2): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-sysctl comm="systemd" exe="/nix/store/7j4j6z5w6bpfj75krglxbma8wh78f6j3-systemd-239/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
machine# [ 29.446028] audit: type=1130 audit(1548783419.697:3): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/nix/store/7j4j6z5w6bpfj75krglxbma8wh78f6j3-systemd-239/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
machine# [ 29.575357] systemd[1]: Starting Rebuild Journal Catalog...
machine# [ 29.749028] systemd[1]: Starting udev Kernel Device Manager...
machine# [ 29.822075] audit: type=1127 audit(1548783420.073:4): pid=421 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg=' comm="systemd-update-utmp" exe="/nix/store/7j4j6z5w6bpfj75krglxbma8wh78f6j3-systemd-239/lib/systemd/systemd-update-utmp" hostname=? addr=? terminal=? res=success'
machine# [ 29.839780] systemd[1]: Started Load/Save Random Seed.
machine# [ 29.848963] audit: type=1130 audit(1548783420.100:5): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-random-seed comm="systemd" exe="/nix/store/7j4j6z5w6bpfj75krglxbma8wh78f6j3-systemd-239/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
machine# [ 30.035196] audit: type=1325 audit(1548783420.227:6): table=filter family=2 entries=0
machine# [ 30.048602] audit: type=1300 audit(1548783420.227:6): arch=c000003e syscall=175 success=yes exit=0 a0=18b3ba0 a1=1ee0 a2=41af66 a3=0 items=0 ppid=111 pid=425 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="modprobe" exe="/nix/store/4k44jax206vaxl17ajra77qclqjm9lln-kmod-25/bin/kmod" subj==unconfined key=(null)
machine# [ 30.054604] audit: type=1327 audit(1548783420.227:6): proctitle=2F6E69782F73746F72652F346B34346A61783230367661786C3137616A7261373771636C716A6D396C6C6E2D6B6D6F642D32352F62696E2F6D6F6470726F6265002D71002D2D0069707461626C655F66696C746572
machine# [ 30.165009] systemd[1]: Started Update UTMP about System Boot/Shutdown.
machine# [ 30.170968] audit: type=1130 audit(1548783420.422:7): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-update-utmp comm="systemd" exe="/nix/store/7j4j6z5w6bpfj75krglxbma8wh78f6j3-systemd-239/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
machine# [ 30.837675] systemd[1]: Started Rebuild Journal Catalog.
machine# [ 30.838473] audit: type=1130 audit(1548783421.089:8): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-journal-catalog-update comm="systemd" exe="/nix/store/7j4j6z5w6bpfj75krglxbma8wh78f6j3-systemd-239/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
machine# [ 30.928652] systemd[1]: Starting Update is Completed...
machine# [ 31.083886] audit: type=1325 audit(1548783421.327:9): table=filter family=10 entries=0
machine# [ 31.623707] systemd[1]: Started Update is Completed.
machine# [ 31.635109] systemd[1]: Started udev Kernel Device Manager.
machine# [ 33.218463] systemd[1]: Started Journal Service.
machine# [ 33.401307] systemd-modules-load[409]: Inserted module 'loop'
machine# [ 33.480885] systemd-modules-load[409]: Failed to find module 'gcov-proc'
machine# [ 33.554224] systemd[1]: Starting Flush Journal to Persistent Storage...
machine# [ 34.239828] systemd-journald[415]: Received request to flush runtime journal from PID 1
machine# [ 34.897581] kauditd_printk_skb: 5 callbacks suppressed
machine# [ 34.897658] audit: type=1325 audit(1548783425.147:13): table=filter family=2 entries=4
machine# [ 34.906712] audit: type=1300 audit(1548783425.147:13): arch=c000003e syscall=54 success=yes exit=0 a0=4 a1=0 a2=40 a3=1445900 items=0 ppid=419 pid=455 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="/nix/store/xypia5js0vaymxp8i6kpyi35r8wh8v3g-iptables-1.6.2/bin/xtables-multi" subj==unconfined key=(null)
machine# [ 34.908187] audit: type=1327 audit(1548783425.147:13): proctitle=69707461626C6573002D77002D4E006E69786F732D66772D616363657074
machine# [ 35.093348] audit: type=1325 audit(1548783425.344:14): table=filter family=10 entries=4
machine# [ 35.098497] audit: type=1300 audit(1548783425.344:14): arch=c000003e syscall=54 success=yes exit=0 a0=4 a1=29 a2=40 a3=829a20 items=0 ppid=419 pid=456 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="ip6tables" exe="/nix/store/xypia5js0vaymxp8i6kpyi35r8wh8v3g-iptables-1.6.2/bin/xtables-multi" subj==unconfined key=(null)
machine# [ 35.102594] audit: type=1327 audit(1548783425.344:14): proctitle=6970367461626C6573002D77002D4E006E69786F732D66772D616363657074
machine# [ 35.235919] audit: type=1130 audit(1548783425.487:15): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-journal-flush comm="systemd" exe="/nix/store/7j4j6z5w6bpfj75krglxbma8wh78f6j3-systemd-239/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
machine# [ 35.317124] systemd[1]: Started Flush Journal to Persistent Storage.
machine# [ 35.373775] audit: type=1325 audit(1548783425.625:16): table=filter family=2 entries=6
machine# [ 35.344274] systemd[1]: Starting Create Volatile Files and Directories...
machine# [ 35.380885] audit: type=1300 audit(1548783425.625:16): arch=c000003e syscall=54 success=yes exit=0 a0=4 a1=0 a2=40 a3=1e0e260 items=0 ppid=419 pid=458 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="/nix/store/xypia5js0vaymxp8i6kpyi35r8wh8v3g-iptables-1.6.2/bin/xtables-multi" subj==unconfined key=(null)
machine# [ 35.383429] audit: type=1327 audit(1548783425.625:16): proctitle=69707461626C6573002D77002D41006E69786F732D66772D616363657074002D6A00414343455054
machine# [ 35.427009] systemd[1]: Started udev Coldplug all Devices.
machine# [ 35.453855] systemd[1]: Starting udev Wait for Complete Device Initialization...
machine# [ 36.273899] systemd[1]: Started Create Volatile Files and Directories.
machine# [ 37.585911] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3
machine# [ 37.639105] ACPI: Power Button [PWRF]
machine# [ 38.795668] parport_pc 00:04: reported by Plug and Play ACPI
machine# [ 38.841560] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]
machine# [ 39.140069] Floppy drive(s): fd0 is 2.88M AMI BIOS
machine# [ 39.178479] FDC 0 is a S82078B
machine# [ 39.613782] Linux agpgart interface v0.103
machine# [ 39.965637] kauditd_printk_skb: 65 callbacks suppressed
machine# [ 39.965681] audit: type=1325 audit(1548783430.217:40): table=raw family=2 entries=6
machine# [ 39.970926] audit: type=1300 audit(1548783430.217:40): arch=c000003e syscall=54 success=yes exit=0 a0=4 a1=0 a2=40 a3=1e90680 items=0 ppid=419 pid=498 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="/nix/store/xypia5js0vaymxp8i6kpyi35r8wh8v3g-iptables-1.6.2/bin/xtables-multi" subj==unconfined key=(null)
machine# [ 39.973652] audit: type=1327 audit(1548783430.217:40): proctitle=69707461626C6573002D7400726177002D41006E69786F732D66772D727066696C746572002D7000756470002D2D73706F7274003637002D2D64706F7274003638002D6A0052455455524E
machine# [ 40.107782] audit: type=1325 audit(1548783430.359:41): table=raw family=2 entries=7
machine# [ 40.110251] audit: type=1300 audit(1548783430.359:41): arch=c000003e syscall=54 success=yes exit=0 a0=4 a1=0 a2=40 a3=1f367c0 items=0 ppid=419 pid=499 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="/nix/store/xypia5js0vaymxp8i6kpyi35r8wh8v3g-iptables-1.6.2/bin/xtables-multi" subj==unconfined key=(null)
machine# [ 40.113632] audit: type=1327 audit(1548783430.359:41): proctitle=69707461626C6573002D7400726177002D41006E69786F732D66772D727066696C746572002D7300302E302E302E30002D64003235352E3235352E3235352E323535002D7000756470002D2D73706F7274003638002D2D64706F7274003637002D6A0052455455524E
machine# [ 40.220037] audit: type=1325 audit(1548783430.472:42): table=raw family=2 entries=8
machine# [ 40.229094] audit: type=1300 audit(1548783430.472:42): arch=c000003e syscall=54 success=yes exit=0 a0=4 a1=0 a2=40 a3=d6f6c0 items=0 ppid=419 pid=500 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="/nix/store/xypia5js0vaymxp8i6kpyi35r8wh8v3g-iptables-1.6.2/bin/xtables-multi" subj==unconfined key=(null)
machine# [ 40.233602] audit: type=1327 audit(1548783430.472:42): proctitle=69707461626C6573002D77002D7400726177002D41006E69786F732D66772D727066696C746572002D6A0044524F50
machine# [ 40.339985] audit: type=1325 audit(1548783430.592:43): table=raw family=10 entries=6
machine# [ 41.174192] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0
machine# [ 44.146914] mousedev: PS/2 mouse device common for all mice
machine# [ 44.775677] systemd[1]: Started Firewall.
machine# [ 44.943566] input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input4
machine# [ 44.958969] systemd[1]: Found device /dev/ttyS0.
machine# [ 44.965633] systemd[1]: Reached target Network (Pre).
machine# [ 47.905777] [drm] Found bochs VGA, ID 0xb0c0.
machine# [ 47.906139] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.
machine# [ 47.942753] [TTM] Zone kernel: Available graphics memory: 183960 kiB
machine# [ 47.943137] [TTM] Initializing pool allocator
machine# [ 47.950674] [TTM] Initializing DMA pool allocator
machine# [ 47.958840] systemd[1]: Found device Virtio network device.
machine# [ 48.101445] fbcon: bochsdrmfb (fb0) is primary device
machine# [ 48.203132] Console: switching to colour frame buffer device 128x48
machine# [ 48.397706] bochs-drm 0000:00:02.0: fb0: bochsdrmfb frame buffer device
machine# [ 48.416573] [drm] Initialized bochs-drm 1.0.0 20130925 for 0000:00:02.0 on minor 0
machine# [ 49.000716] ppdev: user-space parallel port driver
machine# [ 49.352858] systemd[1]: Found device /dev/hvc0.
machine# [ 49.498779] systemd[1]: Found device /dev/hvc1.
machine# [ 53.103604] kauditd_printk_skb: 51 callbacks suppressed
machine# [ 53.105012] audit: type=1130 audit(1548783443.353:61): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-udev-settle comm="systemd" exe="/nix/store/7j4j6z5w6bpfj75krglxbma8wh78f6j3-systemd-239/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
machine# [ 53.103904] systemd[1]: Started udev Wait for Complete Device Initialization.
machine# [ 53.163890] systemd[1]: Reached target System Initialization.
machine# [ 53.169365] systemd[1]: Listening on Nix Daemon Socket.
machine# [ 53.177120] systemd[1]: Started Daily Cleanup of Temporary Directories.
machine# [ 53.181328] systemd[1]: Reached target Timers.
machine# [ 53.187783] systemd[1]: Listening on D-Bus System Message Bus Socket.
machine# [ 53.190752] systemd[1]: Reached target Sockets.
machine# [ 53.195437] systemd[1]: Reached target Basic System.
machine# [ 53.221891] systemd[1]: Starting Address configuration of eth1...
machine# [ 53.269743] systemd[1]: Starting Link configuration of eth1...
machine# [ 53.334093] systemd[1]: Starting Name Service Cache Daemon...
machine# [ 53.431848] systemd[1]: Starting Kernel Auditing...
machine# [ 53.536813] systemd[1]: Started backdoor.service.
machine# [ 53.575796] audit: type=1130 audit(1548783443.827:62): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=backdoor comm="systemd" exe="/nix/store/7j4j6z5w6bpfj75krglxbma8wh78f6j3-systemd-239/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
machine# [ 53.678119] 8v5xqy84f881k6n4pp4gxaksri4w82qv-unit-script-network-link-eth1-start[544]: Configuring link...
machine# [ 53.730368] systemd[1]: Starting DHCP Client...
machine# [ 54.093235] 8v5xqy84f881k6n4pp4gxaksri4w82qv-unit-script-network-link-eth1-start[544]: bringing up interface... done
machine# [ 54.162098] systemd[1]: Started Link configuration of eth1.
machine# [ 54.195744] audit: type=1130 audit(1548783444.447:63): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=network-link-eth1 comm="systemd" exe="/nix/store/7j4j6z5w6bpfj75krglxbma8wh78f6j3-systemd-239/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
machine# [ 54.196527] systemd[1]: Reached target All Network Interfaces (deprecated).
machine# [ 54.237967] 5ymg5n228x6apzwshzf4327ch49yv753-audit-disable[546]: No rules
machine# [ 54.297347] dhcpcd[548]: dev: loaded udev
machine# [ 54.442529] audit: type=1305 audit(1548783444.693:64): audit_enabled=0 old=1 auid=4294967295 ses=4294967295 subj==unconfined res=1
machine# [ 54.506218] systemd[1]: Started Kernel Auditing.
machine# [ 54.636221] w3p2xh2p7zdqmvjxmz8686f1pajls8lx-unit-script-network-addresses-eth1-start[543]: adding address 192.168.1.1/24... done
machine# [ 54.829907] 8021q: 802.1Q VLAN Support v1.8
machine# [ 54.833984] 8021q: adding VLAN 0 to HW filter on device eth1
machine# [ 55.309110] nscd[572]: 572 monitoring file `/etc/passwd` (1)
machine# [ 55.386063] nscd[572]: 572 monitoring directory `/etc` (2)
machine# [ 55.419470] nscd[572]: 572 monitoring file `/etc/group` (3)
machine# [ 55.448312] nscd[572]: 572 monitoring directory `/etc` (2)
machine# [ 55.490419] systemd[1]: Started Address configuration of eth1.
machine# [ 55.515809] nscd[572]: 572 monitoring file `/etc/hosts` (4)
machine# [ 55.525462] nscd[572]: 572 monitoring directory `/etc` (2)
machine# [ 55.544063] nscd[572]: 572 monitoring file `/etc/resolv.conf` (5)
machine# [ 55.561011] nscd[572]: 572 monitoring directory `/etc` (2)
machine# [ 55.720800] systemd[1]: Starting Networking Setup...
machine# [ 56.516540] cfg80211: Loading compiled-in X.509 certificates for regulatory database
machine# [ 56.655406] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
machine# [ 56.762084] systemd[1]: Started D-Bus System Message Bus.
machine# [ 56.987878] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
machine# [ 56.992689] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2
machine# [ 56.993281] cfg80211: failed to load regulatory.db
machine# connecting to host...
machine# [ 57.735829] dbus-daemon[590]: dbus[590]: Unknown username "systemd-timesync" in message bus configuration file
machine: connected to guest root shell
machine# sh: cannot set terminal process group (-1): Inappropriate ioctl for device
machine# sh: no job control in this shell
machine# [ 59.676554] systemd[1]: Started Name Service Cache Daemon.
machine# [ 59.718268] systemd[1]: Reached target User and Group Name Lookups.
machine: exit status 0
machine: running command: systemctl list-jobs --full 2>&1
machine# [ 59.815720] systemd[1]: Starting Login Service...
machine# [ 59.833111] systemd[1]: Reached target Host and Network Name Lookups.
machine: exit status 0
machine# [ 60.487275] systemd[1]: Started Networking Setup.
machine# [ 60.545056] systemd[1]: Starting Extra networking commands....
machine# [ 60.801910] systemd-logind[642]: New seat seat0.
machine# [ 60.843451] systemd[1]: Started Extra networking commands..
machine# [ 60.925031] systemd-logind[642]: Watching system buttons on /dev/input/event2 (Power Button)
machine# [ 60.942144] systemd-logind[642]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)
machine# [ 61.004420] 8021q: adding VLAN 0 to HW filter on device eth0
machine# [ 61.006196] dhcpcd[548]: eth0: waiting for carrier
machine# [ 61.019116] dhcpcd[548]: eth0: carrier acquired
machine# [ 61.033972] systemd[1]: Started Login Service.
machine# [ 61.220385] dhcpcd[548]: DUID 00:01:00:01:23:e3:4b:db:52:54:00:12:34:56
machine# [ 61.223110] dhcpcd[548]: eth0: IAID 00:12:34:56
machine# [ 61.231662] dhcpcd[548]: eth0: adding address fe80::5054:ff:fe12:3456
machine# [ 61.303423] dhcpcd[548]: eth0: soliciting an IPv6 router
machine: running command: systemctl --no-pager show "multi-user.target"
machine: exit status 0
machine: running command: systemctl list-jobs --full 2>&1
machine# [ 61.872558] NET: Registered protocol family 17
machine# [ 61.892372] dhcpcd[548]: eth0: soliciting a DHCP lease
machine# [ 61.932045] dhcpcd[548]: eth0: offered 10.0.2.15 from 10.0.2.2
machine# [ 61.941825] dhcpcd[548]: eth0: leased 10.0.2.15 for 86400 seconds
machine# [ 61.985624] dhcpcd[548]: eth0: adding route to 10.0.2.0/24
machine# [ 61.990533] dhcpcd[548]: eth0: adding default route via 10.0.2.2
machine: exit status 0
machine# [ 62.988900] nscd[572]: 572 monitored file `/etc/resolv.conf` was written to
machine# [ 63.228051] systemd[1]: Stopping Name Service Cache Daemon...
machine: running command: systemctl --no-pager show "multi-user.target"
machine# [ 63.307983] systemd[1]: Stopped Name Service Cache Daemon.
machine# [ 63.451851] systemd[1]: Starting Name Service Cache Daemon...
machine: exit status 0
machine: running command: systemctl list-jobs --full 2>&1
machine# [ 64.223923] dhcpcd[548]: Failed to try-reload-or-restart ntpd.service: Unit ntpd.service not found.
machine# [ 64.250674] dhcpcd[548]: Failed to try-reload-or-restart openntpd.service: Unit openntpd.service not found.
machine# [ 64.262291] dhcpcd[548]: Failed to try-reload-or-restart chronyd.service: Unit chronyd.service not found.
machine# [ 64.321666] dhcpcd[548]: forked to background, child pid 714
machine# [ 64.357273] dhcpcd[714]: eth0: Router Advertisement from fe80::2
machine# [ 64.373410] dhcpcd[714]: eth0: adding address fec0::5054:ff:fe12:3456/64
machine# [ 64.395836] dhcpcd[714]: eth0: adding route to fec0::/64
machine# [ 64.413140] systemd[1]: Started DHCP Client.
machine# [ 64.427261] dhcpcd[714]: eth0: adding default route via fe80::2
machine# [ 64.508208] systemd[1]: Reached target Network.
machine: exit status 0
machine# [ 64.553940] systemd[1]: Starting Permit User Sessions...
machine# [ 64.561935] systemd[1]: Reached target Network is Online.
machine# [ 64.611972] nscd[717]: 717 monitoring file `/etc/passwd` (1)
machine# [ 64.616282] nscd[717]: 717 monitoring directory `/etc` (2)
machine# [ 64.633778] nscd[717]: 717 monitoring file `/etc/group` (3)
machine# [ 64.638948] nscd[717]: 717 monitoring directory `/etc` (2)
machine# [ 64.647927] nscd[717]: 717 monitoring file `/etc/hosts` (4)
machine# [ 64.654383] nscd[717]: 717 monitoring directory `/etc` (2)
machine# [ 64.667230] nscd[717]: 717 monitoring file `/etc/resolv.conf` (5)
machine# [ 64.672911] nscd[717]: 717 monitoring directory `/etc` (2)
machine# [ 65.110204] systemd[1]: Started Permit User Sessions.
machine# [ 65.204288] systemd[1]: Started Getty on tty1.
machine# [ 65.266764] systemd[1]: Started Serial Getty on hvc1.
machine# [ 65.283283] systemd[1]: Reached target Login Prompts.
machine# [ 65.298955] systemd[1]: Reached target Multi-User System.
machine# [ 65.389738] systemd[1]: Started Name Service Cache Daemon.
machine# [ 65.445442] systemd[1]: Startup finished in 24.155s (kernel) + 41.260s (userspace) = 1min 5.415s.
machine: running command: systemctl --no-pager show "multi-user.target"
machine: exit status 0
machine: must succeed: /nix/store/0ymrx2f1c5xsc7d95dhvgpyvznncw0lz-reproduce-overlay-regression.sh 2>&1
machine# [ 66.798951] mkdir(work/work, 040000) = 0
machine# [ 66.803627] tmpfile(work/work, 0100000) = 0
machine# [ 66.806046] setxattr(work/work, "trusted.overlay.opaque", "0", 1, 0x0) = 0
machine# [ 77.185136] open(000000004e1a27e4[/find/l], 0100040) -> (00000000c64566ab, 00)
machine: exit status 1
machine: output: execve("/tmp/tmp.VxNbUaLNCK/result/find", ["/tmp/tmp.VxNbUaLNCK/result/find", "/", "-maxdepth", "1"], 0x7ffc1b61eff0 /* 37 vars */) = -1 EPERM (Operation not permitted)
openat(AT_FDCWD, "/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/share/locale/locale.alias", O_RDONLY|O_CLOEXEC) = 3
fstat(3, {st_mode=S_IFREG|0444, st_size=2997, ...}) = 0
read(3, "# Locale name alias data base.\n#"..., 8192) = 2997
read(3, "", 8192) = 0
close(3) = 0
openat(AT_FDCWD, "/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/share/locale/en_US.UTF-8/LC_MESSAGES/libc.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/share/locale/en_US.utf8/LC_MESSAGES/libc.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/share/locale/en_US/LC_MESSAGES/libc.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/share/locale/en.UTF-8/LC_MESSAGES/libc.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/share/locale/en.utf8/LC_MESSAGES/libc.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/share/locale/en/LC_MESSAGES/libc.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
fstat(2, {st_mode=S_IFCHR|0600, st_rdev=makedev(229, 0), ...}) = 0
ioctl(2, TCGETS, {B38400 -opost -isig -icanon -echo ...}) = 0
write(2, "strace: exec: Operation not perm"..., 38strace: exec: Operation not permitted
) = 38
getpid() = 754
exit_group(1) = ?
+++ exited with 1 +++
error: command `/nix/store/0ymrx2f1c5xsc7d95dhvgpyvznncw0lz-reproduce-overlay-regression.sh 2>&1' did not succeed (exit code 1)
command `/nix/store/0ymrx2f1c5xsc7d95dhvgpyvznncw0lz-reproduce-overlay-regression.sh 2>&1' did not succeed (exit code 1)
cleaning up
killing machine (pid 597)
vde_switch: EOF on stdin, cleaning up and exiting
vde_switch: Could not remove ctl dir '/build/vde1.ctl': Directory not empty
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment