Skip to content

Instantly share code, notes, and snippets.

@basvandijk

basvandijk/strongswan-swanctl-test-failure.log

Last active August 31, 2017 07:13
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 basvandijk/a2de93d8c93ce925838c1dbf2ee1d925 to your computer and use it in GitHub Desktop.
Save basvandijk/a2de93d8c93ce925838c1dbf2ee1d925 to your computer and use it in GitHub Desktop.
Download ZIP
Raw
strongswan-swanctl-test-failure.log
starting VDE switch for network 0
starting VDE switch for network 1
running the VM test script
starting all VMs
carol: starting vm
carol# Formatting '/tmp/nix-build-vm-test-run-strongswan-swanctl.drv-0/vm-state-carol/carol.qcow2', fmt=qcow2 size=536870912 encryption=off cluster_size=65536 lazy_refcounts=off refcount_bits=16
carol# qemu-system-x86_64: -net nic,vlan=0,model=virtio: 'vlan' is deprecated. Please use 'netdev' instead.
carol: QEMU running (pid 10052)
moon: starting vm
moon# Formatting '/tmp/nix-build-vm-test-run-strongswan-swanctl.drv-0/vm-state-moon/moon.qcow2', fmt=qcow2 size=536870912 encryption=off cluster_size=65536 lazy_refcounts=off refcount_bits=16
moon# qemu-system-x86_64: -net nic,vlan=0,model=virtio: 'vlan' is deprecated. Please use 'netdev' instead.
moon: QEMU running (pid 10063)
alice: starting vm
alice# Formatting '/tmp/nix-build-vm-test-run-strongswan-swanctl.drv-0/vm-state-alice/alice.qcow2', fmt=qcow2 size=536870912 encryption=off cluster_size=65536 lazy_refcounts=off refcount_bits=16
alice# qemu-system-x86_64: -net nic,vlan=0,model=virtio: 'vlan' is deprecated. Please use 'netdev' instead.
alice: QEMU running (pid 10075)
carol: waiting for success: ping -c 1 alice
carol: running command: ping -c 1 alice
carol: waiting for the VM to finish booting
carol# [ 0.000000] Linux version 4.9.45 (nixbld@localhost) (gcc version 6.4.0 (GCC) ) #1-NixOS SMP Fri Aug 25 00:12:55 UTC 2017
carol# [ 0.000000] Command line: loglevel=7 console=ttyS0 panic=1 boot.panic_on_fail init=/nix/store/46pp0pn6wh7m5qngvlb17gxckxvj57i2-nixos-system-carol-17.09.git.b1bab8c/init regInfo=/nix/store/cnz31d45dxrhw41i75wadl01f2xy912p-reginfo
carol# [ 0.000000] x86/fpu: Legacy x87 FPU detected.
carol# [ 0.000000] x86/fpu: Using 'eager' FPU context switches.
carol# [ 0.000000] e820: BIOS-provided physical RAM map:
carol# [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
carol# [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
carol# [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
carol# [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x0000000017fdbfff] usable
carol# [ 0.000000] BIOS-e820: [mem 0x0000000017fdc000-0x0000000017ffffff] reserved
carol# [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
carol# [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
carol# [ 0.000000] NX (Execute Disable) protection: active
carol# [ 0.000000] SMBIOS 2.8 present.
carol# [ 0.000000] Hypervisor detected: KVM
carol# [ 0.000000] e820: last_pfn = 0x17fdc max_arch_pfn = 0x400000000
carol# [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WC UC- UC
carol# [ 0.000000] found SMP MP-table at [mem 0x000f6a70-0x000f6a7f] mapped at [ffff9cd9400f6a70]
carol# [ 0.000000] Scanning 1 areas for low memory corruption
carol# [ 0.000000] RAMDISK: [mem 0x17999000-0x17fcffff]
carol# [ 0.000000] ACPI: Early table checksum verification disabled
carol# [ 0.000000] ACPI: RSDP 0x00000000000F6880 000014 (v00 BOCHS )
carol# [ 0.000000] ACPI: RSDT 0x0000000017FE154E 000030 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001)
carol# [ 0.000000] ACPI: FACP 0x0000000017FE142A 000074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001)
carol# [ 0.000000] ACPI: DSDT 0x0000000017FE0040 0013EA (v01 BOCHS BXPCDSDT 00000001 BXPC 00000001)
carol# [ 0.000000] ACPI: FACS 0x0000000017FE0000 000040
carol# [ 0.000000] ACPI: APIC 0x0000000017FE149E 000078 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001)
carol# [ 0.000000] ACPI: HPET 0x0000000017FE1516 000038 (v01 BOCHS BXPCHPET 00000001 BXPC 00000001)
carol# [ 0.000000] No NUMA configuration found
carol# [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000017fdbfff]
carol# [ 0.000000] NODE_DATA(0) allocated [mem 0x17fd8000-0x17fdbfff]
carol# [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
carol# [ 0.000000] kvm-clock: cpu 0, msr 0:17fd2001, primary cpu clock
carol# [ 0.000000] kvm-clock: using sched offset of 428272222 cycles
carol# [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
carol# [ 0.000000] Zone ranges:
carol# [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff]
carol# [ 0.000000] DMA32 [mem 0x0000000001000000-0x0000000017fdbfff]
carol# [ 0.000000] Normal empty
carol# [ 0.000000] Movable zone start for each node
carol# [ 0.000000] Early memory node ranges
carol# [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff]
carol# [ 0.000000] node 0: [mem 0x0000000000100000-0x0000000017fdbfff]
carol# [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000017fdbfff]
carol# [ 0.000000] ACPI: PM-Timer IO Port: 0x608
carol# [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
carol# [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
carol# [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
carol# [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
carol# [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
carol# [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
carol# [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
carol# [ 0.000000] Using ACPI (MADT) for SMP configuration information
carol# [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000
carol# [ 0.000000] smpboot: Allowing 1 CPUs, 0 hotplug CPUs
carol# [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff]
carol# [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff]
carol# [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff]
carol# [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff]
carol# [ 0.000000] e820: [mem 0x18000000-0xfeffbfff] available for PCI devices
carol# [ 0.000000] Booting paravirtualized kernel on KVM
carol# [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
carol# [ 0.000000] setup_percpu: NR_CPUS:384 nr_cpumask_bits:384 nr_cpu_ids:1 nr_node_ids:1
carol# [ 0.000000] percpu: Embedded 35 pages/cpu @ffff9cd957600000 s102424 r8192 d32744 u2097152
carol# [ 0.000000] KVM setup async PF for cpu 0
carol# [ 0.000000] kvm-stealtime: cpu 0, msr 1760d940
carol# [ 0.000000] Built 1 zonelists in Node order, mobility grouping on. Total pages: 96613
carol# [ 0.000000] Policy zone: DMA32
carol# [ 0.000000] Kernel command line: loglevel=7 console=ttyS0 panic=1 boot.panic_on_fail init=/nix/store/46pp0pn6wh7m5qngvlb17gxckxvj57i2-nixos-system-carol-17.09.git.b1bab8c/init regInfo=/nix/store/cnz31d45dxrhw41i75wadl01f2xy912p-reginfo
carol# [ 0.000000] PID hash table entries: 2048 (order: 2, 16384 bytes)
carol# [ 0.000000] Memory: 368520K/392680K available (5562K kernel code, 986K rwdata, 1864K rodata, 1308K init, 780K bss, 24160K reserved, 0K cma-reserved)
carol# [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
carol# [ 0.000000] Hierarchical RCU implementation.
carol# [ 0.000000] Build-time adjustment of leaf fanout to 64.
carol# [ 0.000000] RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.
carol# [ 0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=64, nr_cpu_ids=1
carol# [ 0.000000] NR_IRQS:24832 nr_irqs:256 16
carol# [ 0.000000] Console: colour VGA+ 80x25
carol# [ 0.000000] console [ttyS0] enabled
carol# [ 0.000000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
carol# [ 0.000000] tsc: Detected 2793.544 MHz processor
carol# [ 0.047874] Calibrating delay loop (skipped) preset value.. 5587.08 BogoMIPS (lpj=2793544)
carol# [ 0.048401] pid_max: default: 32768 minimum: 301
carol# [ 0.048730] ACPI: Core revision 20160831
carol# [ 0.049510] ACPI: 1 ACPI AML tables successfully acquired and loaded
carol# [ 0.049961] Security Framework initialized
carol# [ 0.050231] Yama: becoming mindful.
carol# [ 0.050476] AppArmor: AppArmor initialized
carol# [ 0.050791] Dentry cache hash table entries: 65536 (order: 7, 524288 bytes)
carol# [ 0.051299] Inode-cache hash table entries: 32768 (order: 6, 262144 bytes)
carol# [ 0.051794] Mount-cache hash table entries: 1024 (order: 1, 8192 bytes)
carol# [ 0.052216] Mountpoint-cache hash table entries: 1024 (order: 1, 8192 bytes)
carol# [ 0.052831] CPU: Physical Processor ID: 0
carol# [ 0.053103] mce: CPU supports 10 MCE banks
carol# [ 0.053406] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
carol# [ 0.053763] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
carol# [ 0.059780] Freeing SMP alternatives memory: 24K
carol# [ 0.062827] ftrace: allocating 22936 entries in 90 pages
moon# [ 0.000000] Linux version 4.9.45 (nixbld@localhost) (gcc version 6.4.0 (GCC) ) #1-NixOS SMP Fri Aug 25 00:12:55 UTC 2017
carol# [ 0.075808] smpboot: Max logical packages: 1
carol# [ 0.076223] x2apic enabled
moon# [ 0.000000] Command line: loglevel=7 console=ttyS0 panic=1 boot.panic_on_fail init=/nix/store/yvvvfxb627dfc12h8nqgr4ryq1zaggpb-nixos-system-moon-17.09.git.b1bab8c/init regInfo=/nix/store/vxmywb0r1bbqp4xf2g73xf4l0qhm1ndf-reginfo
carol# [ 0.076532] Switched APIC routing to physical x2apic.
moon# [ 0.000000] x86/fpu: Legacy x87 FPU detected.
moon# [ 0.000000] x86/fpu: Using 'eager' FPU context switches.
carol# [ 0.077381] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
moon# [ 0.000000] e820: BIOS-provided physical RAM map:
moon# [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
moon# [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
moon# [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
moon# [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x0000000017fdbfff] usable
moon# [ 0.000000] BIOS-e820: [mem 0x0000000017fdc000-0x0000000017ffffff] reserved
moon# [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
moon# [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
moon# [ 0.000000] NX (Execute Disable) protection: active
moon# [ 0.000000] SMBIOS 2.8 present.
moon# [ 0.000000] Hypervisor detected: KVM
moon# [ 0.000000] e820: last_pfn = 0x17fdc max_arch_pfn = 0x400000000
moon# [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WC UC- UC
moon# [ 0.000000] found SMP MP-table at [mem 0x000f6a70-0x000f6a7f] mapped at [ffff8afec00f6a70]
moon# [ 0.000000] Scanning 1 areas for low memory corruption
moon# [ 0.000000] RAMDISK: [mem 0x17999000-0x17fcffff]
moon# [ 0.000000] ACPI: Early table checksum verification disabled
moon# [ 0.000000] ACPI: RSDP 0x00000000000F6880 000014 (v00 BOCHS )
moon# [ 0.000000] ACPI: RSDT 0x0000000017FE154E 000030 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001)
moon# [ 0.000000] ACPI: FACP 0x0000000017FE142A 000074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001)
moon# [ 0.000000] ACPI: DSDT 0x0000000017FE0040 0013EA (v01 BOCHS BXPCDSDT 00000001 BXPC 00000001)
moon# [ 0.000000] ACPI: FACS 0x0000000017FE0000 000040
moon# [ 0.000000] ACPI: APIC 0x0000000017FE149E 000078 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001)
moon# [ 0.000000] ACPI: HPET 0x0000000017FE1516 000038 (v01 BOCHS BXPCHPET 00000001 BXPC 00000001)
moon# [ 0.000000] No NUMA configuration found
moon# [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000017fdbfff]
moon# [ 0.000000] NODE_DATA(0) allocated [mem 0x17fd8000-0x17fdbfff]
moon# [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
moon# [ 0.000000] kvm-clock: cpu 0, msr 0:17fd2001, primary cpu clock
moon# [ 0.000000] kvm-clock: using sched offset of 427585231 cycles
moon# [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
moon# [ 0.000000] Zone ranges:
moon# [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff]
moon# [ 0.000000] DMA32 [mem 0x0000000001000000-0x0000000017fdbfff]
moon# [ 0.000000] Normal empty
moon# [ 0.000000] Movable zone start for each node
moon# [ 0.000000] Early memory node ranges
moon# [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff]
moon# [ 0.000000] node 0: [mem 0x0000000000100000-0x0000000017fdbfff]
moon# [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000017fdbfff]
moon# [ 0.000000] ACPI: PM-Timer IO Port: 0x608
moon# [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
moon# [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
moon# [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
moon# [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
moon# [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
moon# [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
moon# [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
moon# [ 0.000000] Using ACPI (MADT) for SMP configuration information
moon# [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000
moon# [ 0.000000] smpboot: Allowing 1 CPUs, 0 hotplug CPUs
moon# [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff]
moon# [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff]
moon# [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff]
moon# [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff]
moon# [ 0.000000] e820: [mem 0x18000000-0xfeffbfff] available for PCI devices
moon# [ 0.000000] Booting paravirtualized kernel on KVM
moon# [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
moon# [ 0.000000] setup_percpu: NR_CPUS:384 nr_cpumask_bits:384 nr_cpu_ids:1 nr_node_ids:1
moon# [ 0.000000] percpu: Embedded 35 pages/cpu @ffff8afed7600000 s102424 r8192 d32744 u2097152
moon# [ 0.000000] KVM setup async PF for cpu 0
moon# [ 0.000000] kvm-stealtime: cpu 0, msr 1760d940
moon# [ 0.000000] Built 1 zonelists in Node order, mobility grouping on. Total pages: 96613
moon# [ 0.000000] Policy zone: DMA32
moon# [ 0.000000] Kernel command line: loglevel=7 console=ttyS0 panic=1 boot.panic_on_fail init=/nix/store/yvvvfxb627dfc12h8nqgr4ryq1zaggpb-nixos-system-moon-17.09.git.b1bab8c/init regInfo=/nix/store/vxmywb0r1bbqp4xf2g73xf4l0qhm1ndf-reginfo
moon# [ 0.000000] PID hash table entries: 2048 (order: 2, 16384 bytes)
moon# [ 0.000000] Memory: 368520K/392680K available (5562K kernel code, 986K rwdata, 1864K rodata, 1308K init, 780K bss, 24160K reserved, 0K cma-reserved)
moon# [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
moon# [ 0.000000] Hierarchical RCU implementation.
moon# [ 0.000000] Build-time adjustment of leaf fanout to 64.
moon# [ 0.000000] RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.
moon# [ 0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=64, nr_cpu_ids=1
moon# [ 0.000000] NR_IRQS:24832 nr_irqs:256 16
moon# [ 0.000000] Console: colour VGA+ 80x25
moon# [ 0.000000] console [ttyS0] enabled
moon# [ 0.000000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
moon# [ 0.000000] tsc: Detected 2793.544 MHz processor
moon# [ 0.055698] Calibrating delay loop (skipped) preset value.. 5587.08 BogoMIPS (lpj=2793544)
moon# [ 0.056233] pid_max: default: 32768 minimum: 301
moon# [ 0.056575] ACPI: Core revision 20160831
moon# [ 0.057365] ACPI: 1 ACPI AML tables successfully acquired and loaded
moon# [ 0.057836] Security Framework initialized
moon# [ 0.058120] Yama: becoming mindful.
moon# [ 0.058354] AppArmor: AppArmor initialized
moon# [ 0.058685] Dentry cache hash table entries: 65536 (order: 7, 524288 bytes)
moon# [ 0.059197] Inode-cache hash table entries: 32768 (order: 6, 262144 bytes)
moon# [ 0.059674] Mount-cache hash table entries: 1024 (order: 1, 8192 bytes)
moon# [ 0.060102] Mountpoint-cache hash table entries: 1024 (order: 1, 8192 bytes)
moon# [ 0.060703] CPU: Physical Processor ID: 0
moon# [ 0.060971] mce: CPU supports 10 MCE banks
moon# [ 0.061266] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
moon# [ 0.061615] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
moon# [ 0.067492] Freeing SMP alternatives memory: 24K
alice# [ 0.000000] Linux version 4.9.45 (nixbld@localhost) (gcc version 6.4.0 (GCC) ) #1-NixOS SMP Fri Aug 25 00:12:55 UTC 2017
moon# [ 0.070583] ftrace: allocating 22936 entries in 90 pages
alice# [ 0.000000] Command line: loglevel=7 console=ttyS0 panic=1 boot.panic_on_fail init=/nix/store/fls53cd45966dq403iqvj0cb04qk1zn5-nixos-system-alice-17.09.git.b1bab8c/init regInfo=/nix/store/4wl88n7izi75rdyy7h78dh2ivz6b2cfy-reginfo
alice# [ 0.000000] x86/fpu: Legacy x87 FPU detected.
alice# [ 0.000000] x86/fpu: Using 'eager' FPU context switches.
alice# [ 0.000000] e820: BIOS-provided physical RAM map:
alice# [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
alice# [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
alice# [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
alice# [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x0000000017fdbfff] usable
alice# [ 0.000000] BIOS-e820: [mem 0x0000000017fdc000-0x0000000017ffffff] reserved
alice# [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
alice# [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
alice# [ 0.000000] NX (Execute Disable) protection: active
alice# [ 0.000000] SMBIOS 2.8 present.
alice# [ 0.000000] Hypervisor detected: KVM
alice# [ 0.000000] e820: last_pfn = 0x17fdc max_arch_pfn = 0x400000000
alice# [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WC UC- UC
alice# [ 0.000000] found SMP MP-table at [mem 0x000f6a70-0x000f6a7f] mapped at [ffff8a71c00f6a70]
alice# [ 0.000000] Scanning 1 areas for low memory corruption
alice# [ 0.000000] RAMDISK: [mem 0x17999000-0x17fcffff]
alice# [ 0.000000] ACPI: Early table checksum verification disabled
alice# [ 0.000000] ACPI: RSDP 0x00000000000F6880 000014 (v00 BOCHS )
alice# [ 0.000000] ACPI: RSDT 0x0000000017FE154E 000030 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001)
alice# [ 0.000000] ACPI: FACP 0x0000000017FE142A 000074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001)
alice# [ 0.000000] ACPI: DSDT 0x0000000017FE0040 0013EA (v01 BOCHS BXPCDSDT 00000001 BXPC 00000001)
alice# [ 0.000000] ACPI: FACS 0x0000000017FE0000 000040
moon# [ 0.083702] smpboot: Max logical packages: 1
alice# [ 0.000000] ACPI: APIC 0x0000000017FE149E 000078 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001)
moon# [ 0.084083] x2apic enabled
moon# [ 0.084392] Switched APIC routing to physical x2apic.
alice# [ 0.000000] ACPI: HPET 0x0000000017FE1516 000038 (v01 BOCHS BXPCHPET 00000001 BXPC 00000001)
alice# [ 0.000000] No NUMA configuration found
moon# [ 0.085221] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
alice# [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000017fdbfff]
alice# [ 0.000000] NODE_DATA(0) allocated [mem 0x17fd8000-0x17fdbfff]
alice# [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
alice# [ 0.000000] kvm-clock: cpu 0, msr 0:17fd2001, primary cpu clock
alice# [ 0.000000] kvm-clock: using sched offset of 419645326 cycles
alice# [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
alice# [ 0.000000] Zone ranges:
alice# [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff]
alice# [ 0.000000] DMA32 [mem 0x0000000001000000-0x0000000017fdbfff]
alice# [ 0.000000] Normal empty
alice# [ 0.000000] Movable zone start for each node
alice# [ 0.000000] Early memory node ranges
alice# [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff]
alice# [ 0.000000] node 0: [mem 0x0000000000100000-0x0000000017fdbfff]
alice# [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000017fdbfff]
alice# [ 0.000000] ACPI: PM-Timer IO Port: 0x608
alice# [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
alice# [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
alice# [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
alice# [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
alice# [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
alice# [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
alice# [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
alice# [ 0.000000] Using ACPI (MADT) for SMP configuration information
alice# [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000
alice# [ 0.000000] smpboot: Allowing 1 CPUs, 0 hotplug CPUs
alice# [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff]
alice# [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff]
alice# [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff]
alice# [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff]
alice# [ 0.000000] e820: [mem 0x18000000-0xfeffbfff] available for PCI devices
alice# [ 0.000000] Booting paravirtualized kernel on KVM
alice# [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
alice# [ 0.000000] setup_percpu: NR_CPUS:384 nr_cpumask_bits:384 nr_cpu_ids:1 nr_node_ids:1
alice# [ 0.000000] percpu: Embedded 35 pages/cpu @ffff8a71d7600000 s102424 r8192 d32744 u2097152
alice# [ 0.000000] KVM setup async PF for cpu 0
alice# [ 0.000000] kvm-stealtime: cpu 0, msr 1760d940
alice# [ 0.000000] Built 1 zonelists in Node order, mobility grouping on. Total pages: 96613
alice# [ 0.000000] Policy zone: DMA32
alice# [ 0.000000] Kernel command line: loglevel=7 console=ttyS0 panic=1 boot.panic_on_fail init=/nix/store/fls53cd45966dq403iqvj0cb04qk1zn5-nixos-system-alice-17.09.git.b1bab8c/init regInfo=/nix/store/4wl88n7izi75rdyy7h78dh2ivz6b2cfy-reginfo
alice# [ 0.000000] PID hash table entries: 2048 (order: 2, 16384 bytes)
alice# [ 0.000000] Memory: 368520K/392680K available (5562K kernel code, 986K rwdata, 1864K rodata, 1308K init, 780K bss, 24160K reserved, 0K cma-reserved)
alice# [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
alice# [ 0.000000] Hierarchical RCU implementation.
alice# [ 0.000000] Build-time adjustment of leaf fanout to 64.
alice# [ 0.000000] RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.
alice# [ 0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=64, nr_cpu_ids=1
alice# [ 0.000000] NR_IRQS:24832 nr_irqs:256 16
alice# [ 0.000000] Console: colour VGA+ 80x25
alice# [ 0.000000] console [ttyS0] enabled
alice# [ 0.000000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
alice# [ 0.000000] tsc: Detected 2793.544 MHz processor
alice# [ 0.055994] Calibrating delay loop (skipped) preset value.. 5587.08 BogoMIPS (lpj=2793544)
alice# [ 0.056679] pid_max: default: 32768 minimum: 301
alice# [ 0.057061] ACPI: Core revision 20160831
alice# [ 0.057922] ACPI: 1 ACPI AML tables successfully acquired and loaded
alice# [ 0.058463] Security Framework initialized
alice# [ 0.058815] Yama: becoming mindful.
alice# [ 0.059109] AppArmor: AppArmor initialized
alice# [ 0.059477] Dentry cache hash table entries: 65536 (order: 7, 524288 bytes)
alice# [ 0.060101] Inode-cache hash table entries: 32768 (order: 6, 262144 bytes)
alice# [ 0.060711] Mount-cache hash table entries: 1024 (order: 1, 8192 bytes)
alice# [ 0.061241] Mountpoint-cache hash table entries: 1024 (order: 1, 8192 bytes)
alice# [ 0.061954] CPU: Physical Processor ID: 0
alice# [ 0.062294] mce: CPU supports 10 MCE banks
alice# [ 0.062683] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
alice# [ 0.063110] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
carol# [ 0.179565] smpboot: CPU0: Intel Common KVM processor (family: 0xf, model: 0x6, stepping: 0x1)
carol# [ 0.180224] Performance Events: unsupported Netburst CPU model 6 no PMU driver, software events only.
carol# [ 0.181248] x86: Booted up 1 node, 1 CPUs
carol# [ 0.181572] smpboot: Total of 1 processors activated (5587.08 BogoMIPS)
carol# [ 0.182228] devtmpfs: initialized
carol# [ 0.182622] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
carol# [ 0.183336] futex hash table entries: 256 (order: 2, 16384 bytes)
carol# [ 0.183819] pinctrl core: initialized pinctrl subsystem
carol# [ 0.184320] NET: Registered protocol family 16
carol# [ 0.184774] cpuidle: using governor menu
carol# [ 0.185102] ACPI: bus type PCI registered
alice# [ 0.069146] Freeing SMP alternatives memory: 24K
carol# [ 0.185416] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
carol# [ 0.185965] PCI: Using configuration type 1 for base access
carol# [ 0.186742] HugeTLB registered 2 MB page size, pre-allocated 0 pages
carol# [ 0.187305] ACPI: Added _OSI(Module Device)
carol# [ 0.187629] ACPI: Added _OSI(Processor Device)
carol# [ 0.187963] ACPI: Added _OSI(3.0 _SCP Extensions)
alice# [ 0.072205] ftrace: allocating 22936 entries in 90 pages
carol# [ 0.188315] ACPI: Added _OSI(Processor Aggregator Device)
carol# [ 0.189951] ACPI: Interpreter enabled
carol# [ 0.190186] ACPI: (supports S0 S3 S4 S5)
carol# [ 0.190434] ACPI: Using IOAPIC for interrupt routing
carol# [ 0.190775] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
carol# [ 0.192779] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
carol# [ 0.193263] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI]
carol# [ 0.193815] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM
carol# [ 0.194340] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge.
carol# [ 0.195307] acpiphp: Slot [3] registered
carol# [ 0.195643] acpiphp: Slot [4] registered
carol# [ 0.195976] acpiphp: Slot [5] registered
carol# [ 0.196309] acpiphp: Slot [6] registered
carol# [ 0.196649] acpiphp: Slot [7] registered
carol# [ 0.196980] acpiphp: Slot [8] registered
carol# [ 0.197312] acpiphp: Slot [9] registered
carol# [ 0.197655] acpiphp: Slot [10] registered
carol# [ 0.197994] acpiphp: Slot [11] registered
carol# [ 0.198329] acpiphp: Slot [12] registered
carol# [ 0.198677] acpiphp: Slot [13] registered
carol# [ 0.199013] acpiphp: Slot [14] registered
carol# [ 0.199545] acpiphp: Slot [15] registered
carol# [ 0.199877] acpiphp: Slot [16] registered
carol# [ 0.200211] acpiphp: Slot [17] registered
carol# [ 0.200542] acpiphp: Slot [18] registered
carol# [ 0.200877] acpiphp: Slot [19] registered
alice# [ 0.085086] smpboot: Max logical packages: 1
carol# [ 0.201203] acpiphp: Slot [20] registered
alice# [ 0.085547] x2apic enabled
carol# [ 0.201537] acpiphp: Slot [21] registered
carol# [ 0.201870] acpiphp: Slot [22] registered
alice# [ 0.085905] Switched APIC routing to physical x2apic.
carol# [ 0.202133] acpiphp: Slot [23] registered
carol# [ 0.202411] acpiphp: Slot [24] registered
carol# [ 0.202682] acpiphp: Slot [25] registered
carol# [ 0.202947] acpiphp: Slot [26] registered
alice# [ 0.086814] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
carol# [ 0.203211] acpiphp: Slot [27] registered
carol# [ 0.203486] acpiphp: Slot [28] registered
carol# [ 0.203756] acpiphp: Slot [29] registered
carol# [ 0.204021] acpiphp: Slot [30] registered
carol# [ 0.204286] acpiphp: Slot [31] registered
carol# [ 0.204546] PCI host bridge to bus 0000:00
carol# [ 0.204809] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]
carol# [ 0.205224] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]
carol# [ 0.205646] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
carol# [ 0.206122] pci_bus 0000:00: root bus resource [mem 0x18000000-0xfebfffff window]
carol# [ 0.206584] pci_bus 0000:00: root bus resource [bus 00-ff]
carol# [ 0.213321] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7]
carol# [ 0.213773] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6]
carol# [ 0.214179] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177]
carol# [ 0.214621] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376]
carol# [ 0.223225] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI
carol# [ 0.223687] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB
moon# [ 0.187405] smpboot: CPU0: Intel Common KVM processor (family: 0xf, model: 0x6, stepping: 0x1)
moon# [ 0.187990] Performance Events: unsupported Netburst CPU model 6 no PMU driver, software events only.
moon# [ 0.188961] x86: Booted up 1 node, 1 CPUs
moon# [ 0.189295] smpboot: Total of 1 processors activated (5587.08 BogoMIPS)
moon# [ 0.189981] devtmpfs: initialized
moon# [ 0.190380] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
moon# [ 0.191153] futex hash table entries: 256 (order: 2, 16384 bytes)
moon# [ 0.191663] pinctrl core: initialized pinctrl subsystem
moon# [ 0.192189] NET: Registered protocol family 16
moon# [ 0.192653] cpuidle: using governor menu
moon# [ 0.193000] ACPI: bus type PCI registered
moon# [ 0.193325] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
moon# [ 0.193905] PCI: Using configuration type 1 for base access
moon# [ 0.194711] HugeTLB registered 2 MB page size, pre-allocated 0 pages
moon# [ 0.195309] ACPI: Added _OSI(Module Device)
moon# [ 0.195652] ACPI: Added _OSI(Processor Device)
moon# [ 0.196010] ACPI: Added _OSI(3.0 _SCP Extensions)
moon# [ 0.196389] ACPI: Added _OSI(Processor Aggregator Device)
moon# [ 0.198105] ACPI: Interpreter enabled
moon# [ 0.198423] ACPI: (supports S0 S3 S4 S5)
moon# [ 0.198740] ACPI: Using IOAPIC for interrupt routing
moon# [ 0.199152] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
moon# [ 0.201165] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
moon# [ 0.201660] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI]
moon# [ 0.202211] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM
moon# [ 0.202742] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge.
moon# [ 0.203722] acpiphp: Slot [3] registered
moon# [ 0.204061] acpiphp: Slot [4] registered
moon# [ 0.204438] acpiphp: Slot [5] registered
moon# [ 0.204811] acpiphp: Slot [6] registered
moon# [ 0.205180] acpiphp: Slot [7] registered
moon# [ 0.205532] acpiphp: Slot [8] registered
moon# [ 0.205865] acpiphp: Slot [9] registered
moon# [ 0.206203] acpiphp: Slot [10] registered
moon# [ 0.206550] acpiphp: Slot [11] registered
moon# [ 0.206888] acpiphp: Slot [12] registered
moon# [ 0.207231] acpiphp: Slot [13] registered
moon# [ 0.207732] acpiphp: Slot [14] registered
moon# [ 0.208081] acpiphp: Slot [15] registered
moon# [ 0.208426] acpiphp: Slot [16] registered
moon# [ 0.208767] acpiphp: Slot [17] registered
moon# [ 0.209109] acpiphp: Slot [18] registered
moon# [ 0.209455] acpiphp: Slot [19] registered
moon# [ 0.209793] acpiphp: Slot [20] registered
moon# [ 0.210137] acpiphp: Slot [21] registered
moon# [ 0.210483] acpiphp: Slot [22] registered
moon# [ 0.210820] acpiphp: Slot [23] registered
moon# [ 0.211164] acpiphp: Slot [24] registered
moon# [ 0.211511] acpiphp: Slot [25] registered
moon# [ 0.211849] acpiphp: Slot [26] registered
moon# [ 0.212192] acpiphp: Slot [27] registered
moon# [ 0.212539] acpiphp: Slot [28] registered
moon# [ 0.212877] acpiphp: Slot [29] registered
moon# [ 0.213219] acpiphp: Slot [30] registered
moon# [ 0.213566] acpiphp: Slot [31] registered
moon# [ 0.213895] PCI host bridge to bus 0000:00
moon# [ 0.214229] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]
moon# [ 0.214769] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]
moon# [ 0.215309] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
moon# [ 0.215900] pci_bus 0000:00: root bus resource [mem 0x18000000-0xfebfffff window]
moon# [ 0.216496] pci_bus 0000:00: root bus resource [bus 00-ff]
moon# [ 0.223476] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7]
moon# [ 0.224044] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6]
moon# [ 0.224564] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177]
moon# [ 0.225130] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376]
moon# [ 0.233340] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI
moon# [ 0.233925] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB
alice# [ 0.188633] smpboot: CPU0: Intel Common KVM processor (family: 0xf, model: 0x6, stepping: 0x1)
alice# [ 0.189342] Performance Events: unsupported Netburst CPU model 6 no PMU driver, software events only.
alice# [ 0.190396] x86: Booted up 1 node, 1 CPUs
alice# [ 0.190722] smpboot: Total of 1 processors activated (5587.08 BogoMIPS)
alice# [ 0.191407] devtmpfs: initialized
alice# [ 0.191805] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
alice# [ 0.192556] futex hash table entries: 256 (order: 2, 16384 bytes)
alice# [ 0.193061] pinctrl core: initialized pinctrl subsystem
alice# [ 0.193587] NET: Registered protocol family 16
alice# [ 0.194048] cpuidle: using governor menu
alice# [ 0.194395] ACPI: bus type PCI registered
alice# [ 0.194716] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
alice# [ 0.195279] PCI: Using configuration type 1 for base access
alice# [ 0.196078] HugeTLB registered 2 MB page size, pre-allocated 0 pages
alice# [ 0.196679] ACPI: Added _OSI(Module Device)
alice# [ 0.197011] ACPI: Added _OSI(Processor Device)
alice# [ 0.197365] ACPI: Added _OSI(3.0 _SCP Extensions)
alice# [ 0.197738] ACPI: Added _OSI(Processor Aggregator Device)
alice# [ 0.199363] ACPI: Interpreter enabled
alice# [ 0.199678] ACPI: (supports S0 S3 S4 S5)
alice# [ 0.199990] ACPI: Using IOAPIC for interrupt routing
alice# [ 0.200395] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
alice# [ 0.202390] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
alice# [ 0.202890] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI]
alice# [ 0.203432] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM
alice# [ 0.203959] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge.
alice# [ 0.204929] acpiphp: Slot [3] registered
alice# [ 0.205254] acpiphp: Slot [4] registered
alice# [ 0.205588] acpiphp: Slot [5] registered
alice# [ 0.205926] acpiphp: Slot [6] registered
alice# [ 0.206252] acpiphp: Slot [7] registered
alice# [ 0.206581] acpiphp: Slot [8] registered
alice# [ 0.206917] acpiphp: Slot [9] registered
alice# [ 0.207243] acpiphp: Slot [10] registered
alice# [ 0.207579] acpiphp: Slot [11] registered
alice# [ 0.207920] acpiphp: Slot [12] registered
alice# [ 0.208252] acpiphp: Slot [13] registered
alice# [ 0.208590] acpiphp: Slot [14] registered
alice# [ 0.209069] acpiphp: Slot [15] registered
alice# [ 0.209409] acpiphp: Slot [16] registered
alice# [ 0.209750] acpiphp: Slot [17] registered
alice# [ 0.210081] acpiphp: Slot [18] registered
alice# [ 0.210417] acpiphp: Slot [19] registered
alice# [ 0.210756] acpiphp: Slot [20] registered
alice# [ 0.211088] acpiphp: Slot [21] registered
alice# [ 0.211424] acpiphp: Slot [22] registered
alice# [ 0.211765] acpiphp: Slot [23] registered
alice# [ 0.212098] acpiphp: Slot [24] registered
alice# [ 0.212438] acpiphp: Slot [25] registered
alice# [ 0.212780] acpiphp: Slot [26] registered
alice# [ 0.213111] acpiphp: Slot [27] registered
alice# [ 0.213453] acpiphp: Slot [28] registered
alice# [ 0.213794] acpiphp: Slot [29] registered
alice# [ 0.214124] acpiphp: Slot [30] registered
alice# [ 0.214462] acpiphp: Slot [31] registered
alice# [ 0.214794] PCI host bridge to bus 0000:00
alice# [ 0.215115] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]
alice# [ 0.215554] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]
alice# [ 0.215967] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
alice# [ 0.216421] pci_bus 0000:00: root bus resource [mem 0x18000000-0xfebfffff window]
alice# [ 0.216875] pci_bus 0000:00: root bus resource [bus 00-ff]
alice# [ 0.223302] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7]
alice# [ 0.223749] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6]
alice# [ 0.224133] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177]
alice# [ 0.224567] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376]
carol# [ 0.339241] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
carol# [ 0.341772] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
carol# [ 0.342313] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
carol# [ 0.342869] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
carol# [ 0.343384] ACPI: PCI Interrupt Link [LNKS] (IRQs *9)
carol# [ 0.343914] ACPI: Enabled 2 GPEs in block 00 to 0F
carol# [ 0.344411] vgaarb: setting as boot device: PCI:0000:00:02.0
carol# [ 0.344854] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none
carol# [ 0.345490] vgaarb: loaded
carol# [ 0.345717] vgaarb: bridge control possible 0000:00:02.0
carol# [ 0.346202] PCI: Using ACPI for IRQ routing
carol# [ 0.346719] NetLabel: Initializing
carol# [ 0.346988] NetLabel: domain hash size = 128
carol# [ 0.347331] NetLabel: protocols = UNLABELED CIPSOv4
carol# [ 0.347741] NetLabel: unlabeled traffic allowed by default
carol# [ 0.348238] HPET: 3 timers in total, 0 timers will be used for per-cpu timer
carol# [ 0.348802] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
carol# [ 0.349215] hpet0: 3 comparators, 64-bit 100.000000 MHz counter
alice# [ 0.233170] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI
alice# [ 0.233633] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB
carol# [ 0.356836] clocksource: Switched to clocksource kvm-clock
carol# [ 0.360268] VFS: Disk quotas dquot_6.6.0
carol# [ 0.360604] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
carol# [ 0.361194] AppArmor: AppArmor Filesystem Enabled
carol# [ 0.361601] pnp: PnP ACPI init
carol# [ 0.362118] pnp: PnP ACPI: found 6 devices
carol# [ 0.367775] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
carol# [ 0.368521] NET: Registered protocol family 2
carol# [ 0.368968] TCP established hash table entries: 4096 (order: 3, 32768 bytes)
carol# [ 0.369532] TCP bind hash table entries: 4096 (order: 4, 65536 bytes)
carol# [ 0.370050] TCP: Hash tables configured (established 4096 bind 4096)
carol# [ 0.370566] UDP hash table entries: 256 (order: 1, 8192 bytes)
carol# [ 0.371034] UDP-Lite hash table entries: 256 (order: 1, 8192 bytes)
carol# [ 0.371560] NET: Registered protocol family 1
carol# [ 0.371923] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
carol# [ 0.372396] pci 0000:00:01.0: PIIX3: Enabling Passive Release
carol# [ 0.372868] pci 0000:00:01.0: Activating ISA DMA hang workarounds
carol# [ 0.384160] ACPI: PCI Interrupt Link [LNKD] enabled at IRQ 11
carol# [ 0.395769] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
carol# [ 0.396524] Trying to unpack rootfs image as initramfs...
moon# [ 0.375364] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
moon# [ 0.375806] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
moon# [ 0.376239] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
moon# [ 0.376671] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
moon# [ 0.377083] ACPI: PCI Interrupt Link [LNKS] (IRQs *9)
moon# [ 0.377501] ACPI: Enabled 2 GPEs in block 00 to 0F
moon# [ 0.377896] vgaarb: setting as boot device: PCI:0000:00:02.0
moon# [ 0.378245] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none
moon# [ 0.379847] vgaarb: loaded
moon# [ 0.380020] vgaarb: bridge control possible 0000:00:02.0
moon# [ 0.380416] PCI: Using ACPI for IRQ routing
moon# [ 0.380851] NetLabel: Initializing
moon# [ 0.381068] NetLabel: domain hash size = 128
moon# [ 0.381339] NetLabel: protocols = UNLABELED CIPSOv4
moon# [ 0.381653] NetLabel: unlabeled traffic allowed by default
moon# [ 0.382039] HPET: 3 timers in total, 0 timers will be used for per-cpu timer
moon# [ 0.382484] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
moon# [ 0.382813] hpet0: 3 comparators, 64-bit 100.000000 MHz counter
moon# [ 0.387282] clocksource: Switched to clocksource kvm-clock
carol# [ 0.450165] Freeing initrd memory: 6364K
carol# [ 0.450594] Scanning for low memory corruption every 60 seconds
moon# [ 0.390701] VFS: Disk quotas dquot_6.6.0
carol# [ 0.451222] audit: initializing netlink subsys (disabled)
moon# [ 0.390974] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
carol# [ 0.451588] audit: type=2000 audit(1504161757.906:1): initialized
moon# [ 0.391454] AppArmor: AppArmor Filesystem Enabled
moon# [ 0.391777] pnp: PnP ACPI init
carol# [ 0.452138] workingset: timestamp_bits=40 max_order=17 bucket_order=0
moon# [ 0.392343] pnp: PnP ACPI: found 6 devices
carol# [ 0.453382] zbud: loaded
carol# [ 0.453796] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251)
carol# [ 0.454279] io scheduler noop registered
carol# [ 0.454532] io scheduler deadline registered
carol# [ 0.454806] io scheduler cfq registered (default)
carol# [ 0.455142] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
carol# [ 0.455491] pciehp: PCI Express Hot Plug Controller Driver version: 0.4
carol# [ 0.455972] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
moon# [ 0.398260] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
moon# [ 0.398858] NET: Registered protocol family 2
moon# [ 0.399230] TCP established hash table entries: 4096 (order: 3, 32768 bytes)
moon# [ 0.399679] TCP bind hash table entries: 4096 (order: 4, 65536 bytes)
moon# [ 0.400087] TCP: Hash tables configured (established 4096 bind 4096)
moon# [ 0.400489] UDP hash table entries: 256 (order: 1, 8192 bytes)
moon# [ 0.400850] UDP-Lite hash table entries: 256 (order: 1, 8192 bytes)
moon# [ 0.401255] NET: Registered protocol family 1
moon# [ 0.401536] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
moon# [ 0.401906] pci 0000:00:01.0: PIIX3: Enabling Passive Release
moon# [ 0.402273] pci 0000:00:01.0: Activating ISA DMA hang workarounds
alice# [ 0.352274] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
alice# [ 0.352716] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
alice# [ 0.353132] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
alice# [ 0.353552] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
alice# [ 0.353955] ACPI: PCI Interrupt Link [LNKS] (IRQs *9)
alice# [ 0.355418] ACPI: Enabled 2 GPEs in block 00 to 0F
alice# [ 0.355811] vgaarb: setting as boot device: PCI:0000:00:02.0
alice# [ 0.356161] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none
alice# [ 0.356657] vgaarb: loaded
alice# [ 0.356830] vgaarb: bridge control possible 0000:00:02.0
alice# [ 0.357202] PCI: Using ACPI for IRQ routing
alice# [ 0.357621] NetLabel: Initializing
moon# [ 0.413439] ACPI: PCI Interrupt Link [LNKD] enabled at IRQ 11
alice# [ 0.357894] NetLabel: domain hash size = 128
alice# [ 0.358230] NetLabel: protocols = UNLABELED CIPSOv4
alice# [ 0.358549] NetLabel: unlabeled traffic allowed by default
alice# [ 0.358928] HPET: 3 timers in total, 0 timers will be used for per-cpu timer
alice# [ 0.359373] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
alice# [ 0.359704] hpet0: 3 comparators, 64-bit 100.000000 MHz counter
carol# [ 0.478287] 00:05: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
alice# [ 0.363165] clocksource: Switched to clocksource kvm-clock
carol# [ 0.481167] brd: module loaded
carol# [ 0.481579] microcode: sig=0xf61, pf=0x1, revision=0x1
carol# [ 0.481951] microcode: Microcode Update Driver: v2.01 <tigran@aivazian.fsnet.co.uk>, Peter Oruba
carol# [ 0.482546] registered taskstats version 1
carol# [ 0.482815] zswap: loaded using pool lzo/zbud
carol# [ 0.483138] AppArmor: AppArmor sha1 policy hashing enabled
alice# [ 0.367230] VFS: Disk quotas dquot_6.6.0
alice# [ 0.367497] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
alice# [ 0.367991] AppArmor: AppArmor Filesystem Enabled
alice# [ 0.368403] pnp: PnP ACPI init
carol# [ 0.484552] Freeing unused kernel memory: 1308K
alice# [ 0.368888] pnp: PnP ACPI: found 6 devices
carol# [ 0.484942] Write protecting the kernel read-only data: 8192k
carol# [ 0.485515] Freeing unused kernel memory: 564K
moon# [ 0.425244] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
carol# [ 0.486044] Freeing unused kernel memory: 184K
moon# [ 0.426005] Trying to unpack rootfs image as initramfs...
carol#
carol# <<< NixOS Stage 1 >>>
carol#
alice# [ 0.374643] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
alice# [ 0.375235] NET: Registered protocol family 2
alice# [ 0.375602] TCP established hash table entries: 4096 (order: 3, 32768 bytes)
alice# [ 0.376041] TCP bind hash table entries: 4096 (order: 4, 65536 bytes)
alice# [ 0.376455] TCP: Hash tables configured (established 4096 bind 4096)
alice# [ 0.376861] UDP hash table entries: 256 (order: 1, 8192 bytes)
alice# [ 0.377230] UDP-Lite hash table entries: 256 (order: 1, 8192 bytes)
alice# [ 0.377637] NET: Registered protocol family 1
alice# [ 0.377914] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
alice# [ 0.378291] pci 0000:00:01.0: PIIX3: Enabling Passive Release
alice# [ 0.378660] pci 0000:00:01.0: Activating ISA DMA hang workarounds
carol# loading module virtio_balloon...
carol# loading module virtio_console...
carol# loading module virtio_rng...
carol# loading module dm_mod...
alice# [ 0.389826] ACPI: PCI Interrupt Link [LNKD] enabled at IRQ 11
carol# [ 0.506959] device-mapper: ioctl: 4.35.0-ioctl (2016-06-23) initialised: dm-devel@redhat.com
carol# running udev...
carol# [ 0.509424] systemd-udevd[99]: starting version 234
alice# [ 0.402060] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
alice# [ 0.402688] Trying to unpack rootfs image as initramfs...
carol# [ 0.528691] rtc_cmos 00:00: RTC can wake from S4
carol# [ 0.534141] rtc_cmos 00:00: rtc core: registered rtc_cmos as rtc0
carol# [ 0.534605] rtc_cmos 00:00: alarms up to one day, y3k, 114 bytes nvram, hpet irqs
carol# [ 0.537019] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
moon# [ 0.480685] Freeing initrd memory: 6364K
moon# [ 0.481049] Scanning for low memory corruption every 60 seconds
moon# [ 0.481582] audit: initializing netlink subsys (disabled)
moon# [ 0.481930] audit: type=2000 audit(1504161757.980:1): initialized
moon# [ 0.482468] workingset: timestamp_bits=40 max_order=17 bucket_order=0
moon# [ 0.483699] zbud: loaded
moon# [ 0.484072] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251)
moon# [ 0.484553] io scheduler noop registered
moon# [ 0.484798] io scheduler deadline registered
moon# [ 0.485060] io scheduler cfq registered (default)
moon# [ 0.485391] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
moon# [ 0.485737] pciehp: PCI Express Hot Plug Controller Driver version: 0.4
moon# [ 0.486202] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
carol# [ 0.550973] serio: i8042 KBD port at 0x60,0x64 irq 1
carol# [ 0.551288] serio: i8042 AUX port at 0x60,0x64 irq 12
carol# [ 0.564671] SCSI subsystem initialized
moon# [ 0.508489] 00:05: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
moon# [ 0.510485] brd: module loaded
moon# [ 0.510786] microcode: sig=0xf61, pf=0x1, revision=0x1
moon# [ 0.511133] microcode: Microcode Update Driver: v2.01 <tigran@aivazian.fsnet.co.uk>, Peter Oruba
moon# [ 0.511721] registered taskstats version 1
moon# [ 0.511986] zswap: loaded using pool lzo/zbud
moon# [ 0.512299] AppArmor: AppArmor sha1 policy hashing enabled
alice# [ 0.457639] Freeing initrd memory: 6364K
moon# [ 0.513668] Freeing unused kernel memory: 1308K
alice# [ 0.457964] Scanning for low memory corruption every 60 seconds
moon# [ 0.513961] Write protecting the kernel read-only data: 8192k
moon# [ 0.514436] Freeing unused kernel memory: 564K
alice# [ 0.458690] audit: initializing netlink subsys (disabled)
moon# [ 0.514963] Freeing unused kernel memory: 184K
alice# [ 0.459141] audit: type=2000 audit(1504161758.022:1): initialized
alice# [ 0.459787] workingset: timestamp_bits=40 max_order=17 bucket_order=0
moon#
moon# <<< NixOS Stage 1 >>>
moon#
alice# [ 0.461116] zbud: loaded
alice# [ 0.461498] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251)
alice# [ 0.461967] io scheduler noop registered
alice# [ 0.462219] io scheduler deadline registered
alice# [ 0.462491] io scheduler cfq registered (default)
alice# [ 0.462807] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
alice# [ 0.463149] pciehp: PCI Express Hot Plug Controller Driver version: 0.4
carol# [ 0.579581] ACPI: bus type USB registered
alice# [ 0.463619] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
carol# [ 0.582865] usbcore: registered new interface driver usbfs
carol# [ 0.583317] usbcore: registered new interface driver hub
moon# loading module virtio_balloon...
carol# [ 0.586064] usbcore: registered new device driver usb
moon# loading module virtio_console...
moon# loading module virtio_rng...
moon# loading module dm_mod...
carol# [ 0.592783] ACPI: PCI Interrupt Link [LNKC] enabled at IRQ 10
moon# [ 0.536504] device-mapper: ioctl: 4.35.0-ioctl (2016-06-23) initialised: dm-devel@redhat.com
moon# running udev...
carol# [ 0.598710] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
moon# [ 0.539154] systemd-udevd[99]: starting version 234
alice# [ 0.485880] 00:05: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
alice# [ 0.487833] brd: module loaded
alice# [ 0.488148] microcode: sig=0xf61, pf=0x1, revision=0x1
alice# [ 0.488495] microcode: Microcode Update Driver: v2.01 <tigran@aivazian.fsnet.co.uk>, Peter Oruba
alice# [ 0.489083] registered taskstats version 1
alice# [ 0.489366] zswap: loaded using pool lzo/zbud
alice# [ 0.489668] AppArmor: AppArmor sha1 policy hashing enabled
carol# [ 0.605794] uhci_hcd: USB Universal Host Controller Interface driver
alice# [ 0.491093] Freeing unused kernel memory: 1308K
alice# [ 0.491470] Write protecting the kernel read-only data: 8192k
alice# [ 0.492037] Freeing unused kernel memory: 564K
alice# [ 0.492651] Freeing unused kernel memory: 184K
alice#
alice# <<< NixOS Stage 1 >>>
alice#
alice# loading module virtio_balloon...
alice# loading module virtio_console...
moon# [ 0.562057] rtc_cmos 00:00: RTC can wake from S4
alice# loading module virtio_rng...
moon# [ 0.564259] rtc_cmos 00:00: rtc core: registered rtc_cmos as rtc0
carol# [ 0.624724] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
moon# [ 0.564945] rtc_cmos 00:00: alarms up to one day, y3k, 114 bytes nvram, hpet irqs
alice# loading module dm_mod...
moon# [ 0.566913] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
moon# [ 0.567872] serio: i8042 KBD port at 0x60,0x64 irq 1
moon# [ 0.568185] serio: i8042 AUX port at 0x60,0x64 irq 12
alice# [ 0.514696] device-mapper: ioctl: 4.35.0-ioctl (2016-06-23) initialised: dm-devel@redhat.com
alice# running udev...
carol# [ 0.632455] scsi host0: ata_piix
carol# [ 0.632852] scsi host1: ata_piix
carol# [ 0.633206] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc140 irq 14
alice# [ 0.517508] systemd-udevd[99]: starting version 234
carol# [ 0.633750] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc148 irq 15
carol# [ 0.645971] uhci_hcd 0000:00:01.2: UHCI Host Controller
carol# [ 0.646301] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1
carol# [ 0.646808] uhci_hcd 0000:00:01.2: detected 2 ports
carol# [ 0.647173] uhci_hcd 0000:00:01.2: irq 11, io base 0x0000c080
carol# [ 0.647581] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001
carol# [ 0.648005] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
carol# [ 0.648466] usb usb1: Product: UHCI Host Controller
carol# [ 0.648875] usb usb1: Manufacturer: Linux 4.9.45 uhci_hcd
carol# [ 0.649304] usb usb1: SerialNumber: 0000:00:01.2
carol# [ 0.649907] hub 1-0:1.0: USB hub found
carol# [ 0.650218] hub 1-0:1.0: 2 ports detected
alice# [ 0.535958] rtc_cmos 00:00: RTC can wake from S4
moon# [ 0.595209] SCSI subsystem initialized
alice# [ 0.541614] rtc_cmos 00:00: rtc core: registered rtc_cmos as rtc0
carol# [ 0.662005] ACPI: PCI Interrupt Link [LNKA] enabled at IRQ 10
alice# [ 0.548178] rtc_cmos 00:00: alarms up to one day, y3k, 114 bytes nvram, hpet irqs
alice# [ 0.548816] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
moon# [ 0.608361] ACPI: bus type USB registered
moon# [ 0.608641] usbcore: registered new interface driver usbfs
moon# [ 0.608990] usbcore: registered new interface driver hub
alice# [ 0.557195] serio: i8042 KBD port at 0x60,0x64 irq 1
moon# [ 0.613299] usbcore: registered new device driver usb
alice# [ 0.557600] serio: i8042 AUX port at 0x60,0x64 irq 12
carol# [ 0.674420] ACPI: PCI Interrupt Link [LNKB] enabled at IRQ 11
moon# [ 0.617589] ACPI: PCI Interrupt Link [LNKC] enabled at IRQ 10
moon# [ 0.623624] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
moon# [ 0.630874] uhci_hcd: USB Universal Host Controller Interface driver
alice# [ 0.577088] SCSI subsystem initialized
alice# [ 0.581145] ACPI: bus type USB registered
alice# [ 0.585686] usbcore: registered new interface driver usbfs
alice# [ 0.586042] usbcore: registered new interface driver hub
alice# [ 0.589189] usbcore: registered new device driver usb
moon# [ 0.647465] scsi host0: ata_piix
moon# [ 0.648296] scsi host1: ata_piix
moon# [ 0.648599] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc160 irq 14
moon# [ 0.649060] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc168 irq 15
alice# [ 0.602480] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
alice# [ 0.604682] ACPI: PCI Interrupt Link [LNKC] enabled at IRQ 10
moon# [ 0.662178] uhci_hcd 0000:00:01.2: UHCI Host Controller
moon# [ 0.662525] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1
moon# [ 0.662992] uhci_hcd 0000:00:01.2: detected 2 ports
moon# [ 0.663374] uhci_hcd 0000:00:01.2: irq 11, io base 0x0000c080
moon# [ 0.663784] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001
moon# [ 0.664213] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
moon# [ 0.664803] usb usb1: Product: UHCI Host Controller
alice# [ 0.609047] uhci_hcd: USB Universal Host Controller Interface driver
moon# [ 0.665122] usb usb1: Manufacturer: Linux 4.9.45 uhci_hcd
moon# [ 0.665472] usb usb1: SerialNumber: 0000:00:01.2
moon# [ 0.666412] hub 1-0:1.0: USB hub found
moon# [ 0.666662] hub 1-0:1.0: 2 ports detected
carol# [ 0.734280] 9pnet: Installing 9P2000 support
alice# [ 0.624516] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
moon# [ 0.692947] ACPI: PCI Interrupt Link [LNKA] enabled at IRQ 10
alice# [ 0.646191] uhci_hcd 0000:00:01.2: UHCI Host Controller
alice# [ 0.646621] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1
alice# [ 0.647219] uhci_hcd 0000:00:01.2: detected 2 ports
alice# [ 0.647666] uhci_hcd 0000:00:01.2: irq 11, io base 0x0000c080
alice# [ 0.648173] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001
alice# [ 0.648703] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
alice# [ 0.649280] usb usb1: Product: UHCI Host Controller
alice# [ 0.649675] usb usb1: Manufacturer: Linux 4.9.45 uhci_hcd
alice# [ 0.650098] usb usb1: SerialNumber: 0000:00:01.2
alice# [ 0.650657] hub 1-0:1.0: USB hub found
alice# [ 0.650966] hub 1-0:1.0: 2 ports detected
moon# [ 0.707730] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
alice# [ 0.652705] scsi host0: ata_piix
alice# [ 0.653076] scsi host1: ata_piix
alice# [ 0.653443] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc140 irq 14
alice# [ 0.653972] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc148 irq 15
moon# [ 0.718501] ACPI: PCI Interrupt Link [LNKB] enabled at IRQ 11
alice# [ 0.665818] ACPI: PCI Interrupt Link [LNKA] enabled at IRQ 10
carol# [ 0.792360] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100
carol# [ 0.793124] ata2.00: configured for MWDMA2
carol# [ 0.793787] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5
alice# [ 0.678035] ACPI: PCI Interrupt Link [LNKB] enabled at IRQ 11
carol# [ 0.809157] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray
carol# [ 0.809728] cdrom: Uniform CD-ROM driver Revision: 3.20
moon# [ 0.792020] 9pnet: Installing 9P2000 support
alice# [ 0.736272] 9pnet: Installing 9P2000 support
carol# [ 0.856443] random: fast init done
moon# [ 0.817779] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100
moon# [ 0.818653] ata2.00: configured for MWDMA2
moon# [ 0.819301] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5
moon# [ 0.834692] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray
moon# [ 0.835271] cdrom: Uniform CD-ROM driver Revision: 3.20
alice# [ 0.815827] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100
alice# [ 0.816730] ata2.00: configured for MWDMA2
alice# [ 0.817396] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5
moon# [ 0.883278] random: fast init done
alice# [ 0.832619] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray
alice# [ 0.833200] cdrom: Uniform CD-ROM driver Revision: 3.20
carol# kbd_mode: KDSKBMODE: Inappropriate ioctl for device
carol# starting device mapper and LVM...
%carol# [ 0.958304] clocksource: Switched to clocksource acpi_pm
carol# [ 0.959866] usb 1-1: new full-speed USB device number 2 using uhci_hcd
carol# mke2fs 1.43.4 (31-Jan-2017)
carol# Creating filesystem with 131072 4k blocks and 32768 inodes
carol# Filesystem UUID: 546275ba-2d28-49e3-b4aa-d49221dac0c9
carol# Superblock backups stored on blocks:
carol# 32768, 98304
carol#
carol# Allocating group tables: done
carol# Writing inode tables: done
carol# Creating journal (4096 blocks): done
alice# [ 0.879594] random: fast init done
moon# [ 0.977346] usb 1-1: new full-speed USB device number 2 using uhci_hcd
moon# kbd_mode: KDSKBMODE: Inappropriate ioctl for device
moon# starting device mapper and LVM...
%carol# Writing superblocks and filesystem accounting information: done
carol#
moon# [ 0.994713] clocksource: Switched to clocksource acpi_pm
carol# checking /dev/vda...
carol# fsck (busybox 1.27.2)
carol# [fsck.ext4 (1) -- /mnt-root/] fsck.ext4 -a /dev/vda
moon# mke2fs 1.43.4 (31-Jan-2017)
moon# Creating filesystem with 131072 4k blocks and 32768 inodes
carol# /dev/vda: clean, 11/32768 files, 6353/131072 blocks
moon# Filesystem UUID: b2dc2b8e-4048-4c3e-83f2-d3c47aec1416
moon# Superblock backups stored on blocks:
moon# 32768, 98304
moon#
moon# Allocating group tables: done
moon# Writing inode tables: done
carol# mounting /dev/vda on /...
moon# Creating journal (4096 blocks): done
alice# [ 0.967204] usb 1-1: new full-speed USB device number 2 using uhci_hcd
alice# kbd_mode: KDSKBMODE: Inappropriate ioctl for device
alice# starting device mapper and LVM...
%alice# [ 0.994111] clocksource: Switched to clocksource acpi_pm
carol# [ 1.113200] usb 1-1: New USB device found, idVendor=0627, idProduct=0001
alice# mke2fs 1.43.4 (31-Jan-2017)
carol# [ 1.113896] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=5
alice# Creating filesystem with 131072 4k blocks and 32768 inodes
carol# [ 1.114653] usb 1-1: Product: QEMU USB Tablet
alice# Filesystem UUID: dd3831e1-a110-4c45-8848-11899a55b15e
carol# [ 1.115114] usb 1-1: Manufacturer: QEMU
carol# [ 1.115537] usb 1-1: SerialNumber: 42
alice# Superblock backups stored on blocks:
alice# 32768, 98304
alice#
alice# Allocating group tables: done
alice# Writing inode tables: done
alice# Creating journal (4096 blocks): done
carol# [ 1.125196] hidraw: raw HID events driver (C) Jiri Kosina
carol# [ 1.132896] usbcore: registered new interface driver usbhid
carol# [ 1.133373] usbhid: USB HID core driver
carol# [ 1.134621] 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
carol# [ 1.135492] 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
carol# [ 1.140658] EXT4-fs (vda): mounted filesystem with ordered data mode. Opts: (null)
carol# mounting store on /nix/.ro-store...
carol# [ 1.147734] FS-Cache: Loaded
carol# [ 1.150524] 9p: Installing v9fs 9p2000 file system support
carol# [ 1.151797] FS-Cache: Netfs '9p' registered for caching
carol# mounting tmpfs on /nix/.rw-store...
carol# mounting shared on /tmp/shared...
carol# mounting xchg on /tmp/xchg...
carol# mounting overlay filesystem on /nix/store...
moon# Writing superblocks and filesystem accounting information: done
moon#
moon# checking /dev/vda...
moon# fsck (busybox 1.27.2)
moon# [fsck.ext4 (1) -- /mnt-root/] fsck.ext4 -a /dev/vda
moon# /dev/vda: clean, 11/32768 files, 6353/131072 blocks
moon# [ 1.131865] usb 1-1: New USB device found, idVendor=0627, idProduct=0001
moon# [ 1.132312] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=5
moon# [ 1.132749] usb 1-1: Product: QEMU USB Tablet
moon# [ 1.133044] usb 1-1: Manufacturer: QEMU
moon# [ 1.133306] usb 1-1: SerialNumber: 42
moon# [ 1.143232] hidraw: raw HID events driver (C) Jiri Kosina
moon# [ 1.151506] usbcore: registered new interface driver usbhid
moon# [ 1.151856] usbhid: USB HID core driver
moon# [ 1.153290] 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
moon# [ 1.154087] 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
moon# mounting /dev/vda on /...
alice# Writing superblocks and filesystem accounting information: [ 1.120544] usb 1-1: New USB device found, idVendor=0627, idProduct=0001
alice# [ 1.121219] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=5
alice# [ 1.121910] usb 1-1: Product: QEMU USB Tablet
alice# [ 1.122300] usb 1-1: Manufacturer: QEMU
alice# [ 1.122767] usb 1-1: SerialNumber: 42
carol#
alice# done
alice#
carol# <<< NixOS Stage 2 >>>
carol#
alice# [ 1.133939] hidraw: raw HID events driver (C) Jiri Kosina
carol# [ 1.260067] EXT4-fs (vda): re-mounted. Opts: (null)
alice# [ 1.144278] usbcore: registered new interface driver usbhid
alice# [ 1.144796] usbhid: USB HID core driver
carol# [ 1.261091] booting system configuration /nix/store/46pp0pn6wh7m5qngvlb17gxckxvj57i2-nixos-system-carol-17.09.git.b1bab8c
alice# [ 1.146030] 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
alice# [ 1.147081] 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
alice# checking /dev/vda...
alice# fsck (busybox 1.27.2)
alice# [fsck.ext4 (1) -- /mnt-root/] fsck.ext4 -a /dev/vda
alice# /dev/vda: clean, 11/32768 files, 6353/131072 blocks
moon# [ 1.210751] EXT4-fs (vda): mounted filesystem with ordered data mode. Opts: (null)
moon# mounting store on /nix/.ro-store...
moon# [ 1.217809] FS-Cache: Loaded
alice# mounting /dev/vda on /...
moon# [ 1.220797] 9p: Installing v9fs 9p2000 file system support
moon# [ 1.222158] FS-Cache: Netfs '9p' registered for caching
moon# mounting tmpfs on /nix/.rw-store...
moon# mounting shared on /tmp/shared...
moon# mounting xchg on /tmp/xchg...
moon# mounting overlay filesystem on /nix/store...
alice# [ 1.207977] EXT4-fs (vda): mounted filesystem with ordered data mode. Opts: (null)
alice# mounting store on /nix/.ro-store...
alice# [ 1.215856] FS-Cache: Loaded
alice# [ 1.218887] 9p: Installing v9fs 9p2000 file system support
alice# [ 1.220019] FS-Cache: Netfs '9p' registered for caching
alice# mounting tmpfs on /nix/.rw-store...
alice# mounting shared on /tmp/shared...
carol# running activation script...
alice# mounting xchg on /tmp/xchg...
alice# mounting overlay filesystem on /nix/store...
moon#
moon# <<< NixOS Stage 2 >>>
moon#
moon# [ 1.327354] EXT4-fs (vda): re-mounted. Opts: (null)
moon# [ 1.328284] booting system configuration /nix/store/yvvvfxb627dfc12h8nqgr4ryq1zaggpb-nixos-system-moon-17.09.git.b1bab8c
alice#
alice# <<< NixOS Stage 2 >>>
alice#
alice# [ 1.336311] EXT4-fs (vda): re-mounted. Opts: (null)
alice# [ 1.337417] booting system configuration /nix/store/fls53cd45966dq403iqvj0cb04qk1zn5-nixos-system-alice-17.09.git.b1bab8c
carol# [ 1.479906] tsc: Refined TSC clocksource calibration: 2793.665 MHz
carol# [ 1.480522] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2844e06aae4, max_idle_ns: 440795276424 ns
moon# running activation script...
alice# running activation script...
moon# [ 1.497357] tsc: Refined TSC clocksource calibration: 2793.667 MHz
moon# [ 1.497858] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2844e200148, max_idle_ns: 440795211042 ns
carol# setting up /etc...
alice# [ 1.487242] tsc: Refined TSC clocksource calibration: 2793.667 MHz
alice# [ 1.487699] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2844e200148, max_idle_ns: 440795211042 ns
moon# setting up /etc...
alice# setting up /etc...
carol# Initializing machine ID from random generator.
moon# Initializing machine ID from random generator.
alice# Initializing machine ID from random generator.
carol# [ 2.271015] random: crng init done
moon# [ 2.300451] random: crng init done
alice# [ 2.281611] random: crng init done
carol# starting systemd...
moon# starting systemd...
alice# starting systemd...
carol# [ 2.655263] NET: Registered protocol family 10
carol# [ 2.662392] ip_tables: (C) 2000-2006 Netfilter Core Team
carol# [ 2.668281] systemd[1]: systemd 234 running in system mode. (+PAM +AUDIT -SELINUX +IMA +APPARMOR -SMACK -SYSVINIT +UTMP -LIBCRYPTSETUP +GCRYPT -GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID -ELFUTILS +KMOD -IDN2 -IDN default-hierarchy=hybrid)
carol# [ 2.670332] systemd[1]: Detected virtualization kvm.
carol# [ 2.670847] systemd[1]: Detected architecture x86-64.
carol# [ 2.672335] systemd[1]: Set hostname to <carol>.
moon# [ 2.628684] NET: Registered protocol family 10
moon# [ 2.632886] ip_tables: (C) 2000-2006 Netfilter Core Team
carol# [ 2.693708] systemd-fstab-generator[479]: Checking was requested for "store", but it is not a device.
carol# [ 2.696780] systemd-fstab-generator[479]: Checking was requested for "shared", but it is not a device.
moon# [ 2.636172] systemd[1]: systemd 234 running in system mode. (+PAM +AUDIT -SELINUX +IMA +APPARMOR -SMACK -SYSVINIT +UTMP -LIBCRYPTSETUP +GCRYPT -GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID -ELFUTILS +KMOD -IDN2 -IDN default-hierarchy=hybrid)
moon# [ 2.637781] systemd[1]: Detected virtualization kvm.
moon# [ 2.638097] systemd[1]: Detected architecture x86-64.
carol# [ 2.698040] systemd-fstab-generator[479]: Checking was requested for "xchg", but it is not a device.
moon# [ 2.639173] systemd[1]: Set hostname to <moon>.
alice# [ 2.583549] NET: Registered protocol family 10
alice# [ 2.589164] ip_tables: (C) 2000-2006 Netfilter Core Team
alice# [ 2.593932] systemd[1]: systemd 234 running in system mode. (+PAM +AUDIT -SELINUX +IMA +APPARMOR -SMACK -SYSVINIT +UTMP -LIBCRYPTSETUP +GCRYPT -GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID -ELFUTILS +KMOD -IDN2 -IDN default-hierarchy=hybrid)
alice# [ 2.596115] systemd[1]: Detected virtualization kvm.
alice# [ 2.596676] systemd[1]: Detected architecture x86-64.
alice# [ 2.597965] systemd[1]: Set hostname to <alice>.
moon# [ 2.659477] systemd-fstab-generator[479]: Checking was requested for "store", but it is not a device.
moon# [ 2.661195] systemd-fstab-generator[479]: Checking was requested for "shared", but it is not a device.
moon# [ 2.664350] systemd-fstab-generator[479]: Checking was requested for "xchg", but it is not a device.
alice# [ 2.618928] systemd-fstab-generator[466]: Checking was requested for "store", but it is not a device.
alice# [ 2.622508] systemd-fstab-generator[466]: Checking was requested for "shared", but it is not a device.
alice# [ 2.623551] systemd-fstab-generator[466]: Checking was requested for "xchg", but it is not a device.
carol# [ 2.894849] systemd[1]: Listening on udev Control Socket.
carol# [ 2.895577] systemd[1]: Reached target Security Keys.
carol# [ 2.896152] systemd[1]: Reached target Swap.
carol# [ 2.896744] systemd[1]: Listening on Journal Audit Socket.
carol# [ 2.897426] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
carol# [ 2.898526] systemd[1]: Created slice System Slice.
moon# [ 2.856102] systemd[1]: Listening on Journal Socket (/dev/log).
moon# [ 2.856604] systemd[1]: Listening on Journal Socket.
moon# [ 2.856974] systemd[1]: Reached target Remote File Systems.
moon# [ 2.857448] systemd[1]: Reached target Security Keys.
moon# [ 2.857947] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
moon# [ 2.858596] systemd[1]: Reached target Swap.
alice# [ 2.810664] systemd[1]: Created slice System Slice.
alice# [ 2.811890] systemd[1]: Mounting Kernel Debug File System...
alice# [ 2.813122] systemd[1]: Mounting Huge Pages File System...
alice# [ 2.813960] systemd[1]: Created slice system-getty.slice.
alice# [ 2.814521] systemd[1]: Reached target Swap.
alice# [ 2.814961] systemd[1]: Listening on udev Control Socket.
carol# [ 2.940845] EXT4-fs (vda): re-mounted. Opts: (null)
carol# [ 2.954175] audit: type=1130 audit(1504161759.995:2): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=kmod-static-nodes comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
moon# [ 2.896137] EXT4-fs (vda): re-mounted. Opts: (null)
alice# [ 2.850464] EXT4-fs (vda): re-mounted. Opts: (null)
carol# [ 2.965646] audit: type=1130 audit(1504161760.006:3): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-remount-fs comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
moon# [ 2.913044] audit: type=1130 audit(1504161759.917:2): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=kmod-static-nodes comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
moon# [ 2.919640] audit: type=1130 audit(1504161759.924:3): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-remount-fs comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
carol# [ 2.982742] loop: module loaded
moon# [ 2.922538] loop: module loaded
alice# [ 2.872936] audit: type=1130 audit(1504161759.877:2): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=kmod-static-nodes comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
moon# [ 2.931361] nf_conntrack version 0.5.0 (3072 buckets, 12288 max)
carol# [ 2.995087] audit: type=1127 audit(1504161760.036:4): pid=506 uid=0 auid=4294967295 ses=4294967295 msg=' comm="systemd-update-utmp" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd-update-utmp" hostname=? addr=? terminal=? res=success'
alice# [ 2.881481] loop: module loaded
alice# [ 2.883834] audit: type=1130 audit(1504161759.888:3): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-remount-fs comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
carol# [ 3.007164] audit: type=1130 audit(1504161760.048:5): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-random-seed comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
moon# [ 2.956747] audit: type=1127 audit(1504161759.961:4): pid=506 uid=0 auid=4294967295 ses=4294967295 msg=' comm="systemd-update-utmp" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd-update-utmp" hostname=? addr=? terminal=? res=success'
moon# [ 2.976338] audit: type=1130 audit(1504161759.980:5): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-update-utmp comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
moon# [ 2.978459] audit: type=1130 audit(1504161759.983:6): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-random-seed comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
carol# [ 3.024060] audit: type=1130 audit(1504161760.065:6): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
moon# [ 2.982606] audit: type=1130 audit(1504161759.987:7): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
carol# [ 3.038874] audit: type=1130 audit(1504161760.079:7): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-update-utmp comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
carol# [ 3.066845] audit: type=1130 audit(1504161760.107:8): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-journal-catalog-update comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
alice# [ 2.930873] audit: type=1127 audit(1504161759.935:4): pid=494 uid=0 auid=4294967295 ses=4294967295 msg=' comm="systemd-update-utmp" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd-update-utmp" hostname=? addr=? terminal=? res=success'
moon# [ 3.007618] audit: type=1130 audit(1504161760.012:8): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-journal-catalog-update comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
carol# [ 3.070534] audit: type=1130 audit(1504161760.111:9): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-modules-load comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
moon# [ 3.039166] audit: type=1130 audit(1504161760.043:9): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-modules-load comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
carol# [ 3.100425] audit: type=1130 audit(1504161760.141:10): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-udev-trigger comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
alice# [ 2.931169] audit: type=1130 audit(1504161759.935:5): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-random-seed comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
moon# [ 3.047595] audit: type=1130 audit(1504161760.052:10): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-udev-trigger comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
alice# [ 2.951721] audit: type=1130 audit(1504161759.956:6): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-update-utmp comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
alice# [ 2.955089] audit: type=1130 audit(1504161759.959:7): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
alice# [ 2.977246] audit: type=1130 audit(1504161759.981:8): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-modules-load comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
alice# [ 2.994927] audit: type=1130 audit(1504161759.999:9): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-journal-catalog-update comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
carol# [ 3.163336] ip6_tables: (C) 2000-2006 Netfilter Core Team
alice# [ 3.005659] audit: type=1130 audit(1504161760.010:10): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-sysctl comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
moon# [ 3.115567] ip6_tables: (C) 2000-2006 Netfilter Core Team
alice# [ 3.064247] ip6_tables: (C) 2000-2006 Netfilter Core Team
carol# [ 3.220765] systemd-journald[492]: Received request to flush runtime journal from PID 1
moon# [ 3.195000] systemd-journald[488]: Received request to flush runtime journal from PID 1
alice# [ 3.186108] systemd-journald[476]: Received request to flush runtime journal from PID 1
carol# [ 3.194547] systemd-modules-load[491]: Inserted module 'cpufreq_ondemand'
carol# [ 3.198401] nscd[545]: 545 monitoring file `/etc/passwd` (1)
carol# [ 3.203336] systemd-modules-load[491]: Inserted module 'loop'
carol# [ 3.207729] nscd[545]: 545 monitoring directory `/etc` (2)
carol# [ 3.211617] systemd-modules-load[491]: Inserted module 'snd_pcm_oss'
carol# [ 3.216962] nscd[545]: 545 monitoring file `/etc/group` (3)
carol# [ 3.228252] systemd-modules-load[491]: Failed to find module 'gcov-proc'
carol# [ 3.237475] nscd[545]: 545 monitoring directory `/etc` (2)
carol# [ 3.241759] systemd-udevd[509]: Specified group 'kvm' unknown
carol# [ 3.247680] nscd[545]: 545 monitoring file `/etc/hosts` (4)
moon# [ 3.171115] systemd-modules-load[487]: Inserted module 'cpufreq_ondemand'
moon# [ 3.173509] nscd[567]: 567 monitoring file `/etc/passwd` (1)
carol# [ 3.251290] systemd[1]: Starting Flush Journal to Persistent Storage...
moon# [ 3.175396] systemd-modules-load[487]: Inserted module 'loop'
carol# [ 3.254094] nscd[545]: 545 monitoring directory `/etc` (2)
moon# [ 3.177159] nscd[567]: 567 monitoring directory `/etc` (2)
carol# [ 3.255205] systemd[1]: Reached target System Initialization.
moon# [ 3.179132] systemd-modules-load[487]: Inserted module 'nf_nat_ftp'
carol# [ 3.257692] nscd[545]: 545 monitoring file `/etc/resolv.conf` (5)
moon# [ 3.182171] nscd[567]: 567 monitoring file `/etc/group` (3)
carol# [ 3.260829] systemd[1]: Started Daily Cleanup of Temporary Directories.
carol# [ 3.264650] nscd[545]: 545 monitoring directory `/etc` (2)
moon# [ 3.187356] systemd-udevd[510]: Specified group 'kvm' unknown
carol# [ 3.269072] systemd[1]: Reached target Timers.
moon# [ 3.191480] nscd[567]: 567 monitoring directory `/etc` (2)
moon# [ 3.195127] systemd-modules-load[487]: Inserted module 'snd_pcm_oss'
moon# [ 3.196117] nscd[567]: 567 monitoring file `/etc/hosts` (4)
carol# [ 3.274205] systemd[1]: Listening on Nix Daemon Socket.
moon# [ 3.198606] systemd-modules-load[487]: Failed to find module 'gcov-proc'
carol# [ 3.276542] systemd[1]: Listening on D-Bus System Message Bus Socket.
moon# [ 3.200354] nscd[567]: 567 monitoring directory `/etc` (2)
carol# [ 3.279095] systemd[1]: Reached target Sockets.
moon# [ 3.204359] systemd[1]: Reached target System Initialization.
carol# [ 3.283496] systemd[1]: Reached target Basic System.
moon# [ 3.208301] nscd[567]: 567 monitoring file `/etc/resolv.conf` (5)
carol# [ 3.287863] systemd[1]: Starting Name Service Cache Daemon...
moon# [ 3.211292] systemd[1]: Listening on Nix Daemon Socket.
carol# [ 3.293203] systemd[1]: Starting Kernel Auditing...
moon# [ 3.216334] nscd[567]: 567 monitoring directory `/etc` (2)
carol# [ 3.297955] systemd[1]: Starting Store Sound Card State...
moon# [ 3.222079] systemd[1]: Listening on D-Bus System Message Bus Socket.
alice# [ 3.178404] systemd-modules-load[474]: Inserted module 'cpufreq_ondemand'
carol# [ 3.303615] systemd[1]: Started Store Sound Card State.
moon# [ 3.226812] systemd[1]: Reached target Sockets.
alice# [ 3.182085] nscd[551]: 551 monitoring file `/etc/passwd` (1)
carol# [ 3.308577] systemd[1]: Started Setup Virtual Console.
moon# [ 3.231279] systemd[1]: Started Daily Cleanup of Temporary Directories.
carol# [ 3.479779] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3
alice# [ 3.187085] systemd-modules-load[474]: Inserted module 'loop'
carol# [ 3.314100] [ 3.482262] ACPI: Power Button [PWRF]
carol# 18f7jhsyjkq7d0aaygnm7jra31776wlw-audit-disable[527]: No rules
alice# [ 3.191107] nscd[551]: 551 monitoring directory `/etc` (2)
moon# [ 3.237127] systemd[1]: Reached target Timers.
moon# [ 3.426145] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3
carol# [ 3.317710] systemd[1]: Started Kernel Auditing.
moon# [ 3.241791] systemd[1]: Reached target Basic System.
carol# [ 3.320528] systemd[1]: Started Name Service Cache Daemon.
moon# [ 3.428334] ACPI: Power Button [PWRF]
alice# [ 3.196319] systemd-modules-load[474]: Inserted module 'snd_pcm_oss'
moon# [ 3.243533] systemd[1]: Starting Kernel Auditing...
carol# [ 3.323094] systemd[1]: Reached target Host and Network Name Lookups.
alice# [ 3.198390] nscd[551]: 551 monitoring file `/etc/group` (3)
alice# [ 3.202299] systemd-modules-load[474]: Failed to find module 'gcov-proc'
moon# [ 3.246236] systemd[1]: Starting Store Sound Card State...
carol# [ 3.324739] systemd[1]: Reached target User and Group Name Lookups.
alice# [ 3.204209] nscd[551]: 551 monitoring directory `/etc` (2)
moon# [ 3.249859] 18f7jhsyjkq7d0aaygnm7jra31776wlw-audit-disable[545]: No rules
alice# [ 3.206361] systemd-udevd[496]: Specified group 'kvm' unknown
carol# [ 3.329247] systemd[1]: Starting Login Service...
moon# [ 3.253861] systemd[1]: Starting Name Service Cache Daemon...
alice# [ 3.209272] nscd[551]: 551 monitoring file `/etc/hosts` (4)
carol# [ 3.333705] systemd[1]: Started D-Bus System Message Bus.
alice# [ 3.212756] systemd[1]: Reached target System Initialization.
moon# [ 3.259929] systemd[1]: Starting Flush Journal to Persistent Storage...
carol# [ 3.337665] systemd[1]: Started Flush Journal to Persistent Storage.
alice# [ 3.215755] nscd[551]: 551 monitoring directory `/etc` (2)
carol# [ 3.339739] systemd[1]: Starting Create Volatile Files and Directories...
moon# [ 3.262614] systemd[1]: Started Store Sound Card State.
alice# [ 3.394178] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3
carol# [ 3.341752] systemd-logind[564]: New seat seat0.
moon# [ 3.265470] systemd[1]: Started Kernel Auditing.
alice# [ 3.219990] systemd[1]: Listening on Nix Daemon Socket.
alice# [ 3.220764] nscd[551]: 551 monitoring file `/etc/resolv.conf` (5)[ 3.396559] ACPI: Power Button [PWRF]
alice#
carol# [ 3.345742] systemd[1]: Started Login Service.
alice# [ 3.223578] systemd[1]: Started Daily Cleanup of Temporary Directories.
moon# [ 3.268549] systemd[1]: Started Name Service Cache Daemon.
carol# [ 3.348288] systemd[1]: Started Create Volatile Files and Directories.
alice# [ 3.226775] nscd[551]: 551 monitoring directory `/etc` (2)
moon# [ 3.273112] systemd[1]: Reached target Host and Network Name Lookups.
alice# [ 3.232666] systemd[1]: Reached target Timers.
moon# [ 3.277249] systemd[1]: Reached target User and Group Name Lookups.
carol# [ 3.528720] parport_pc 00:04: reported by Plug and Play ACPI
moon# [ 3.282091] systemd[1]: Starting Login Service...
alice# [ 3.238293] systemd[1]: Listening on D-Bus System Message Bus Socket.
moon# [ 3.285794] systemd[1]: Started D-Bus System Message Bus.
moon# [ 3.289861] systemd-logind[590]: New seat seat0.
alice# [ 3.244087] systemd[1]: Reached target Sockets.
carol# [ 3.537636] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]
moon# [ 3.478606] parport_pc 00:04: reported by Plug and Play ACPI
moon# [ 3.293900] systemd[1]: Started Login Service.
alice# [ 3.249311] systemd[1]: Reached target Basic System.
moon# [ 3.298124] systemd[1]: Started Flush Journal to Persistent Storage.
alice# [ 3.254786] systemd[1]: Starting Kernel Auditing...
moon# [ 3.301491] systemd[ 3.487626] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]
moon# [1]: Starting Create Volatile Files and Directories...
alice# [ 3.259378] systemd[1]: Starting Store Sound Card State...
moon# [ 3.307185] systemd[1]: Started Create Volatile Files and Directories.
alice# [ 3.265269] systemd[1]: Starting Name Service Cache Daemon...
alice# [ 3.268327] 18f7jhsyjkq7d0aaygnm7jra31776wlw-audit-disable[532]: No rules
alice# [ 3.444907] parport_pc 00:04: reported by Plug and Play ACPI
alice# [ 3.270149] systemd[1]: Starting Flush Journal to Persistent Storage...
alice# [ 3.272652] systemd[1]: Started Store Sound Card State.
alice# [ 3.275737] systemd[1]: Started Kernel Auditing.
alice# [ 3.280232] systemd[1]: Started Name Service Cache Daemon.
moon# [ 3.513576] Floppy drive(s): fd0 is 2.88M AMI BIOS
alice# [ 3.458745] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]
carol# [ 3.577453] Floppy drive(s): fd0 is 2.88M AMI BIOS
alice# [ 3.285431] systemd[1]: Reached target User and Group Name Lookups.
carol# [ 3.579317] Linux agpgart interface v0.103
alice# [ 3.289124] systemd[1]: Starting Login Service...
alice# [ 3.292171] systemd[1]: Reached target Host and Network Name Lookups.
moon# [ 3.525976] FDC 0 is a S82078B
carol# [ 3.586830] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0
alice# [ 3.296832] systemd[1]: Started D-Bus System Message Bus.
carol# [ 3.590383] FDC 0 is a S82078B
alice# [ 3.300441] systemd-logind[568]: New seat seat0.
alice# [ 3.303706] systemd[1]: Started Login Service.
moon# [ 3.537126] Linux agpgart interface v0.103
alice# [ 3.307044] systemd[1]: Started Flush Journal to Persistent Storage.
alice# [ 3.311819] systemd[1]: Starting Create Volatile Files and Directories...
alice# [ 3.317354] systemd[1]: Started Create Volatile Files and Directories.
alice# [ 3.506696] Floppy drive(s): fd0 is 2.88M AMI BIOS
alice# [ 3.518638] FDC 0 is a S82078B
moon# [ 3.575193] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0
carol# [ 3.641615] mousedev: PS/2 mouse device common for all mice
alice# [ 3.529233] Linux agpgart interface v0.103
carol# [ 3.646868] nf_conntrack version 0.5.0 (3072 buckets, 12288 max)
moon# [ 3.586566] mousedev: PS/2 mouse device common for all mice
carol# [ 3.485642] systemd[1]: Found device Virtio network device.
alice# [ 3.539426] nf_conntrack version 0.5.0 (3072 buckets, 12288 max)
alice# [ 3.558533] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0
moon# [ 3.442887] systemd[1]: Found device Virtio network device.
alice# [ 3.576063] mousedev: PS/2 mouse device common for all mice
carol# [ 3.535189] systemd[1]: Found device /dev/ttyS0.
carol# [ 3.706593] [drm] Initialized
moon# [ 3.468605] systemd[1]: Found device Virtio network device.
moon# [ 3.496758] systemd[1]: Found device /dev/ttyS0.
moon# [ 3.688917] [drm] Initialized
alice# [ 3.462227] systemd[1]: Found device Virtio network device.
carol# [ 3.763145] [drm] Found bochs VGA, ID 0xb0c0.
carol# [ 3.763614] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.
carol# [ 3.774070] [TTM] Zone kernel: Available graphics memory: 188482 kiB
carol# [ 3.774550] [TTM] Initializing pool allocator
carol# [ 3.775444] [TTM] Initializing DMA pool allocator
alice# [ 3.495678] systemd[1]: Found device /dev/ttyS0.
alice# [ 3.675245] [drm] Initialized
alice# [ 3.514999] systemd[1]: Started Firewall.
alice# [ 3.515581] systemd[1]: Reached target Network (Pre).
alice# [ 3.517226] systemd[1]: Starting Address configuration of eth1...
alice# [ 3.518405] systemd[1]: Starting Link configuration of eth1...
moon# [ 3.752396] [drm] Found bochs VGA, ID 0xb0c0.
moon# [ 3.752916] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.
alice# [ 3.525172] network-link-eth1-start[641]: Configuring link...
alice# [ 3.526697] network-addresses-eth1-start[640]: bringing up interface...
alice# [ 3.529364] systemd[1]: Started Link configuration of eth1.
alice# [ 3.532585] systemd[1]: Reached target All Network Interfaces (deprecated).
moon# [ 3.765938] [TTM] Zone kernel: Available graphics memory: 188482 kiB
carol# [ 3.781653] fbcon: bochsdrmfb (fb0) is primary device
moon# [ 3.766668] [TTM] Initializing pool allocator
moon# [ 3.767275] [TTM] Initializing DMA pool allocator
carol# [ 3.825737] Console: switching to colour frame buffer device 128x48
carol# [ 3.839579] bochs-drm 0000:00:02.0: fb0: bochsdrmfb frame buffer device
carol# [ 3.643063] systemd[1]: Started Firewall.
alice# [ 3.548971] network-addresses-eth1-start[640]: added ip 192.168.0.1/24
carol# [ 3.673024] systemd[1]: Reached target Network (Pre).
alice# [ 3.551243] systemd[1]: Started Address configuration of eth1.
alice# [ 3.552537] systemd[1]: Starting Networking Setup...
carol# [ 3.845211] [drm] Initialized bochs-drm 1.0.0 20130925 for 0000:00:02.0 on minor 0
carol# [ 3.681148] systemd[1]: Starting Link configuration of eth1...
carol# [ 3.691196] network-link-eth1-start[655]: Configuring link...
moon# [ 3.772309] fbcon: bochsdrmfb (fb0) is primary device
carol# [ 3.701523] systemd[1]: Starting Address configuration of eth1...
alice# [ 3.759229] [drm] Found bochs VGA, ID 0xb0c0.
alice# [ 3.759709] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.
moon# [ 3.808904] Console: switching to colour frame buffer device 128x48
carol# [ 3.708615] network-addresses-eth1-start[656]: bringing up interface...
moon# [ 3.820599] bochs-drm 0000:00:02.0: fb0: bochsdrmfb frame buffer device
moon# [ 3.602323] systemd[1]: Found device /dev/hvc0.
alice# [ 3.766984] [TTM] Zone kernel: Available graphics memory: 188482 kiB
alice# [ 3.767723] [TTM] Initializing pool allocator
alice# [ 3.768182] [TTM] Initializing DMA pool allocator
carol# [ 3.713885] network-addresses-eth1-start[656]: added ip 192.168.1.2/24
moon# [ 3.639124] [ 3.824893] [drm] Initialized bochs-drm 1.0.0 20130925 for 0000:00:02.0 on minor 0
moon# systemd[1]: Started backdoor.service.
carol# [ 3.721053] systemd[1]: Started Link configuration of eth1.
carol# [ 3.728515] systemd[1]: Reached target All Network Interfaces (deprecated).
carol# [ 3.736417] systemd[1]: Found device /dev/hvc0.
moon# [ 3.666052] systemd[1]: Started Firewall.
carol# [ 3.741707] systemd[1]: Started backdoor.service.
moon# [ 3.667599] systemd[1]: Reached target Network (Pre).
moon# [ 3.668323] systemd[1]: Starting Link configuration of eth1...
carol# [ 3.746127] systemd[1]: Started Address configuration of eth1.
carol# connecting to host...
carol# [ 3.752202] systemd[1]: Starting Networking Setup...
moon# [ 3.679284] systemd[1]: Starting Address configuration of eth2...
carol: connected to guest root shell
alice# [ 3.774028] fbcon: bochsdrmfb (fb0) is primary device
carol# sh: cannot set terminal process group (-1): Inappropriate ioctl for device
carol# sh: no job control in this shell
moon# [ 3.689080] network-addresses-eth2-start[719]: bringing up interface...
alice# [ 3.816094] Console: switching to colour frame buffer device 128x48
moon# [ 3.702755] systemd[1]: Starting Link configuration of eth2...
alice# [ 3.839575] bochs-drm 0000:00:02.0: fb0: bochsdrmfb frame buffer device
alice# [ 3.637654] systemd[1]: Found device /dev/hvc0.
moon# [ 3.708968] network-link-eth1-start[718]: Configuring link...
alice# [ 3.665862] systemd[1]: Started backdoor.service.
alice# [ 3.844266] [drm] Initialized bochs-drm 1.0.0 20130925 for 0000:00:02.0 on minor 0
alice# [ 3.670116] systemd[1]: Started Networking Setup.
moon# [ 3.718466] connecting to host...
moon# network-link-eth2-start[720]: Configuring link...
alice# [ 3.675668] systemd[1]: Starting Extra networking commands....
moon# [ 3.728376] systemd[1]: Starting Address configuration of eth1...
alice# [ 3.685810] systemd[1]: Started Extra networking commands..
carol# [ 3.816217] systemd[1]: Started Networking Setup.
carol# [ 3.816903] systemd[1]: Starting Extra networking commands....
moon# [ 3.738605] network-addresses-eth2-start[719]: added ip 192.168.1.3/24
alice# [ 3.693911] systemd[1]: Reached target Network.
carol# [ 3.824047] systemd[1]: Started Extra networking commands..
moon# [ 3.745412] network-addresses-eth1-start[722]: bringing up interface...
carol# [ 3.824696] systemd[1]: Reached target Network.
moon# [ 3.747364] network-addresses-eth1-start[722]: added ip 192.168.0.3/24
moon# sh: cannot set terminal process group (-1): Inappropriate ioctl for device
moon# sh: no job control in this shell
carol# [ 3.827530] systemd[1]: Starting Permit User Sessions...
moon# [ 3.753468] systemd[1]: Started Link configuration of eth1.
alice# [ 3.707152] systemd[1]: Reached target Network is Online.
alice# [ 3.711207] systemd[1]: Starting Permit User Sessions...
moon# [ 3.758279] systemd[1]: Started Link configuration of eth2.
moon# [ 3.759824] systemd[1]: Reached target All Network Interfaces (deprecated).
carol# [ 3.837600] connect: Network is unreachable
carol: exit status 2
alice# [ 3.715878] systemd[1]: Started Permit User Sessions.
alice# [ 3.718415] systemd[1]: Started Getty on tty1.
carol# systemd[1]: Reached target Network is Online.
moon# [ 3.763197] systemd[1]: Started Address configuration of eth1.
alice# [ 3.720722] systemd[1]: Reached target Login Prompts.
moon# [ 3.767840] systemd[1]: Started Address configuration of eth2.
alice# [ 3.723906] systemd[1]: Reached target Multi-User System.
carol# [ 3.845892] systemd[1]: Starting strongSwan IPsec IKEv1/IKEv2 daemon using swanctl...
moon# [ 3.771537] systemd[1]: Starting Networking Setup...
carol# [ 3.851914] systemd[1]: Started Permit User Sessions.
alice# [ 3.726950] systemd[1]: Startup finished in 2.367s (kernel) + 1.327s (userspace) = 3.695s.
carol# [ 3.854640] systemd[1]: Started Getty on tty1.
alice# connecting to host...
carol# [ 3.859309] systemd[1]: Reached target Login Prompts.
alice# sh: cannot set terminal process group (-1): Inappropriate ioctl for device
alice# sh: no job control in this shell
carol# [ 4.042899] ppdev: user-space parallel port driver
alice# [ 3.940093] ppdev: user-space parallel port driver
moon# [ 3.999414] ppdev: user-space parallel port driver
moon# [ 3.817751] systemd[1]: Started Networking Setup.
moon# [ 3.818588] systemd[1]: Starting Extra networking commands....
moon# [ 3.827119] systemd[1]: Started Extra networking commands..
moon# [ 3.830154] systemd[1]: Reached target Network.
moon# [ 3.835462] systemd[1]: Reached target Network is Online.
alice# [ 3.791803] systemd-logind[568]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)
moon# [ 3.839547] systemd[1]: Starting strongSwan IPsec IKEv1/IKEv2 daemon using swanctl...
alice# [ 3.794512] systemd-logind[568]: Watching system buttons on /dev/input/event2 (Power Button)
carol# [ 3.923150] systemd-logind[564]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)
moon# [ 3.842755] systemd[1]: Starting Permit User Sessions...
carol# [ 3.927539] systemd-logind[564]: Watching system buttons on /dev/input/event2 (Power Button)
moon# [ 3.849708] systemd[1]: Started Permit User Sessions.
moon# [ 3.852372] systemd[1]: Started Getty on tty1.
moon# [ 3.855056] systemd[1]: Reached target Login Prompts.
carol# [ 4.139404] NET: Registered protocol family 38
moon# [ 3.895397] systemd-logind[590]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)
moon# [ 3.899255] systemd-logind[590]: Watching system buttons on /dev/input/event2 (Power Button)
moon# [ 4.153462] NET: Registered protocol family 38
carol# [ 4.299356] camellia-x86_64: performance on this CPU would be suboptimal: disabling camellia-x86_64.
carol# [ 4.304572] input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input4
carol# [ 4.311467] camellia-x86_64: performance on this CPU would be suboptimal: disabling camellia-x86_64.
carol# [ 4.314942] camellia-x86_64: performance on this CPU would be suboptimal: disabling camellia-x86_64.
moon# [ 4.277633] camellia-x86_64: performance on this CPU would be suboptimal: disabling camellia-x86_64.
moon# [ 4.284920] camellia-x86_64: performance on this CPU would be suboptimal: disabling camellia-x86_64.
moon# [ 4.288022] camellia-x86_64: performance on this CPU would be suboptimal: disabling camellia-x86_64.
moon# [ 4.289983] input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input4
alice# [ 4.280039] input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input4
carol# [ 4.477835] CPU feature 'AVX registers' is not supported.
carol# [ 4.499669] blowfish-x86_64: performance on this CPU would be suboptimal: disabling blowfish-x86_64.
moon# [ 4.445280] CPU feature 'AVX registers' is not supported.
moon# [ 4.471303] blowfish-x86_64: performance on this CPU would be suboptimal: disabling blowfish-x86_64.
carol# [ 4.532470] CPU feature 'AVX registers' is not supported.
carol# [ 4.537180] CPU feature 'AVX registers' is not supported.
moon# [ 4.505507] CPU feature 'AVX registers' is not supported.
moon# [ 4.510020] CPU feature 'AVX registers' is not supported.
carol# [ 4.570504] twofish-x86_64-3way: performance on this CPU would be suboptimal: disabling twofish-x86_64-3way.
carol# [ 4.574464] twofish-x86_64-3way: performance on this CPU would be suboptimal: disabling twofish-x86_64-3way.
moon# [ 4.550804] twofish-x86_64-3way: performance on this CPU would be suboptimal: disabling twofish-x86_64-3way.
carol# [ 4.611816] NET: Registered protocol family 17
moon# [ 4.555974] twofish-x86_64-3way: performance on this CPU would be suboptimal: disabling twofish-x86_64-3way.
carol# [ 4.648992] Initializing XFRM netlink socket
moon# [ 4.590631] NET: Registered protocol family 17
carol# [ 4.486524] charon-systemd[716]: dnscert plugin is disabled
carol# [ 4.487424] charon-systemd[716]: using forecast interface eth1
carol# [ 4.488333] charon-systemd[716]: joining forecast multicast groups: 224.0.0.1,224.0.0.22,224.0.0.251,224.0.0.252,239.255.255.250
carol# [ 4.489295] charon-systemd[716]: loading ca certificates from '/nix/store/jdcviy5z25xamq35g8k9qbdpskkx3w9g-strongswan-5.6.0/etc/ipsec.d/cacerts'
carol# [ 4.491499] charon-systemd[716]: loading aa certificates from '/nix/store/jdcviy5z25xamq35g8k9qbdpskkx3w9g-strongswan-5.6.0/etc/ipsec.d/aacerts'
carol# [ 4.493421] charon-systemd[716]: loading ocsp signer certificates from '/nix/store/jdcviy5z25xamq35g8k9qbdpskkx3w9g-strongswan-5.6.0/etc/ipsec.d/ocspcerts'
carol# [ 4.495272] charon-systemd[716]: loading attribute certificates from '/nix/store/jdcviy5z25xamq35g8k9qbdpskkx3w9g-strongswan-5.6.0/etc/ipsec.d/acerts'
carol# [ 4.497059] charon-systemd[716]: loading crls from '/nix/store/jdcviy5z25xamq35g8k9qbdpskkx3w9g-strongswan-5.6.0/etc/ipsec.d/crls'
carol# [ 4.498541] charon-systemd[716]: loading secrets from '/nix/store/jdcviy5z25xamq35g8k9qbdpskkx3w9g-strongswan-5.6.0/etc/ipsec.secrets'
carol# [ 4.501820] charon-systemd[716]: opening triplet file /nix/store/jdcviy5z25xamq35g8k9qbdpskkx3w9g-strongswan-5.6.0/etc/ipsec.d/triplets.dat failed: No such file or directory
carol# [ 4.503594] charon-systemd[716]: no script for ext-auth script defined, disabled
carol# [ 4.504839] charon-systemd[716]: loaded plugins: charon-systemd charon-systemd unbound pkcs11 aes des rc2 sha2 sha1 md5 random nonce x509 revocation constraints acert pubkey pkcs1 pkcs7 pkcs8 pkcs12 pgp dnskey sshkey dnscert pem af-alg fips-prf gmp curve25519 chapoly xcbc cmac hmac attr kernel-netlink resolve socket-default connmark forecast farp stroke vici updown eap-identity eap-sim eap-sim-pcsc eap-aka eap-aka-3gpp2 eap-simaka-pseudonym eap-simaka-reauth eap-md5 eap-gtc eap-mschapv2 xauth-generic xauth-eap xauth-pam dhcp
carol# [ 4.507824] charon-systemd[716]: spawning 16 worker threads
moon# [ 4.621496] Initializing XFRM netlink socket
moon# [ 4.441897] charon-systemd[775]: dnscert plugin is disabled
moon# [ 4.442788] charon-systemd[775]: using forecast interface eth1
moon# [ 4.443667] charon-systemd[775]: joining forecast multicast groups: 224.0.0.1,224.0.0.22,224.0.0.251,224.0.0.252,239.255.255.250
moon# [ 4.444712] charon-systemd[775]: loading ca certificates from '/nix/store/jdcviy5z25xamq35g8k9qbdpskkx3w9g-strongswan-5.6.0/etc/ipsec.d/cacerts'
moon# [ 4.446712] charon-systemd[775]: loading aa certificates from '/nix/store/jdcviy5z25xamq35g8k9qbdpskkx3w9g-strongswan-5.6.0/etc/ipsec.d/aacerts'
carol# [ 4.525709] charon-systemd[716]: loaded IKE shared key with id 'ike-moon' for: '192.168.1.3'
carol# [ 4.526669] swanctl[921]: no authorities found, 0 unloaded
moon# [ 4.448284] charon-systemd[775]: loading ocsp signer certificates from '/nix/store/jdcviy5z25xamq35g8k9qbdpskkx3w9g-strongswan-5.6.0/etc/ipsec.d/ocspcerts'
carol# [ 4.527406] swanctl[921]: no pools found, 0 unloaded
moon# [ 4.450203] charon-systemd[775]: loading attribute certificates from '/nix/store/jdcviy5z25xamq35g8k9qbdpskkx3w9g-strongswan-5.6.0/etc/ipsec.d/acerts'
carol# [ 4.528419] charon-systemd[716]: added vici connection: home
moon# [ 4.451526] charon-systemd[775]: loading crls from '/nix/store/jdcviy5z25xamq35g8k9qbdpskkx3w9g-strongswan-5.6.0/etc/ipsec.d/crls'
carol# [ 4.529581] charon-systemd[716]: initiating 'home'
carol# [ 4.531679] charon-systemd[716]: initiating IKE_SA home[1] to 192.168.1.3
moon# [ 4.452721] charon-systemd[775]: loading secrets from '/nix/store/jdcviy5z25xamq35g8k9qbdpskkx3w9g-strongswan-5.6.0/etc/ipsec.secrets'
carol# [ 4.532771] charon-systemd[716]: generating IKE_SA_INIT request 0 [ SA KE No N(NATD_S_IP) N(NATD_D_IP) N(FRAG_SUP) N(HASH_ALG) N(REDIR_SUP) ]
carol# [ 4.534397] charon-systemd[716]: sending packet: from 192.168.1.2[500] to 192.168.1.3[500] (242 bytes)
moon# [ 4.456336] charon-systemd[775]: opening triplet file /nix/store/jdcviy5z25xamq35g8k9qbdpskkx3w9g-strongswan-5.6.0/etc/ipsec.d/triplets.dat failed: No such file or directory
carol# [ 4.535992] charon-systemd[716]: received packet: from 192.168.1.3[500] to 192.168.1.2[500] (36 bytes)
moon# [ 4.458327] charon-systemd[775]: no script for ext-auth script defined, disabled
carol# [ 4.537317] charon-systemd[716]: parsed IKE_SA_INIT response 0 [ N(NO_PROP) ]
carol# [ 4.538963] charon-systemd[716]: received NO_PROPOSAL_CHOSEN notify error
moon# [ 4.459768] charon-systemd[775]: loaded plugins: charon-systemd charon-systemd unbound pkcs11 aes des rc2 sha2 sha1 md5 random nonce x509 revocation constraints acert pubkey pkcs1 pkcs7 pkcs8 pkcs12 pgp dnskey sshkey dnscert pem af-alg fips-prf gmp curve25519 chapoly xcbc cmac hmac attr kernel-netlink resolve socket-default connmark forecast farp stroke vici updown eap-identity eap-sim eap-sim-pcsc eap-aka eap-aka-3gpp2 eap-simaka-pseudonym eap-simaka-reauth eap-md5 eap-gtc eap-mschapv2 xauth-generic xauth-eap xauth-pam dhcp
carol# [ 4.540044] swanctl[921]: loaded ike secret 'ike-moon'
moon# [ 4.462667] charon-systemd[775]: spawning 16 worker threads
carol# [ 4.540762] swanctl[921]: loaded connection 'home'
moon# [ 4.463841] charon-systemd[775]: received packet: from 192.168.1.2[500] to 192.168.1.3[500] (242 bytes)
moon# [ 4.465962] charon-systemd[775]: parsed IKE_SA_INIT request 0 [ SA KE No N(NATD_S_IP) N(NATD_D_IP) N(FRAG_SUP) N(HASH_ALG) N(REDIR_SUP) ]
carol# [ 4.541469] swanctl[921]: successfully loaded 1 connections, 0 unloaded
moon# [ 4.467392] charon-systemd[775]: no IKE config found for 192.168.1.3...192.168.1.2, sending NO_PROPOSAL_CHOSEN
carol# [ 4.545815] systemd[1]: Started strongSwan IPsec IKEv1/IKEv2 daemon using swanctl.
carol# [ 4.546934] systemd[1]: Reached target Multi-User System.
carol# [ 4.548058] systemd[1]: Startup finished in 2.424s (kernel) + 2.119s (userspace) = 4.544s.
moon# [ 4.468821] charon-systemd[775]: generating IKE_SA_INIT response 0 [ N(NO_PROP) ]
moon# [ 4.472515] charon-systemd[775]: sending packet: from 192.168.1.3[500] to 192.168.1.2[500] (36 bytes)
moon# [ 4.482034] charon-systemd[775]: loaded IKE shared key with id 'ike-carol' for: '192.168.1.2'
moon# [ 4.482873] swanctl[980]: no authorities found, 0 unloaded
moon# [ 4.484137] swanctl[980]: no pools found, 0 unloaded
moon# [ 4.484692] charon-systemd[775]: added vici connection: rw
moon# [ 4.488253] swanctl[980]: loaded ike secret 'ike-carol'
moon# [ 4.488760] swanctl[980]: loaded connection 'rw'
moon# [ 4.489447] swanctl[980]: successfully loaded 1 connections, 0 unloaded
moon# [ 4.495132] systemd[1]: Started strongSwan IPsec IKEv1/IKEv2 daemon using swanctl.
moon# [ 4.495964] systemd[1]: Reached target Multi-User System.
moon# [ 4.497153] systemd[1]: Startup finished in 2.406s (kernel) + 2.088s (userspace) = 4.494s.
carol: running command: ping -c 1 alice
carol# connect: Network is unreachable
carol: exit status 2
carol: running command: ping -c 1 alice
carol# connect: Network is unreachable
carol: exit status 2
carol: running command: ping -c 1 alice
carol# connect: Network is unreachable
carol: exit status 2
carol: running command: ping -c 1 alice
carol# connect: Network is unreachable
carol: exit status 2
carol: running command: ping -c 1 alice
carol# connect: Network is unreachable
carol: exit status 2
carol: running command: ping -c 1 alice
carol# connect: Network is unreachable
carol: exit status 2
carol: running command: ping -c 1 alice
carol# connect: Network is unreachable
carol: exit status 2
carol: running command: ping -c 1 alice
carol# connect: Network is unreachable
carol: exit status 2
carol: running command: ping -c 1 alice
carol# connect: Network is unreachable
carol: exit status 2
carol: running command: ping -c 1 alice
carol# connect: Network is unreachable
carol: exit status 2
carol: running command: ping -c 1 alice
carol# connect: Network is unreachable
carol: exit status 2
carol: running command: ping -c 1 alice
carol# connect: Network is unreachable
carol: exit status 2
carol: running command: ping -c 1 alice
carol# connect: Network is unreachable
carol: exit status 2
carol: running command: ping -c 1 alice
carol# connect: Network is unreachable
carol: exit status 2
carol: running command: ping -c 1 alice
carol# connect: Network is unreachable
carol: exit status 2
carol: running command: ping -c 1 alice
carol# connect: Network is unreachable
carol: exit status 2
carol: running command: ping -c 1 alice
carol# connect: Network is unreachable
carol: exit status 2
^Cerror: interrupted by the user
Raw
strongswan-swanctl-test-success.log
$ nix-build nixos/release.nix -A tests.strongswan-swanctl --no-out-link
these derivations will be built:
/nix/store/z5gf5ikhyr57g3k2wslgwhzc2i6mg4mr-vm-test-run-strongswan-swanctl.drv
building path(s) ‘/nix/store/i9ds8vrc95hk1y6ywd0hqbwr9vcvjc31-vm-test-run-strongswan-swanctl’
starting VDE switch for network 0
starting VDE switch for network 1
running the VM test script
starting all VMs
alice: starting vm
alice# Formatting '/tmp/nix-build-vm-test-run-strongswan-swanctl.drv-0/vm-state-alice/alice.qcow2', fmt=qcow2 size=536870912 encryption=off cluster_size=65536 lazy_refcounts=off refcount_bits=16
alice# qemu-system-x86_64: -net nic,vlan=0,model=virtio: 'vlan' is deprecated. Please use 'netdev' instead.
alice: QEMU running (pid 19229)
carol: starting vm
carol# Formatting '/tmp/nix-build-vm-test-run-strongswan-swanctl.drv-0/vm-state-carol/carol.qcow2', fmt=qcow2 size=536870912 encryption=off cluster_size=65536 lazy_refcounts=off refcount_bits=16
carol# qemu-system-x86_64: -net nic,vlan=0,model=virtio: 'vlan' is deprecated. Please use 'netdev' instead.
carol: QEMU running (pid 19240)
moon: starting vm
moon# Formatting '/tmp/nix-build-vm-test-run-strongswan-swanctl.drv-0/vm-state-moon/moon.qcow2', fmt=qcow2 size=536870912 encryption=off cluster_size=65536 lazy_refcounts=off refcount_bits=16
moon# qemu-system-x86_64: -net nic,vlan=0,model=virtio: 'vlan' is deprecated. Please use 'netdev' instead.
moon: QEMU running (pid 19252)
carol: waiting for success: ping -c 1 alice
carol: running command: ping -c 1 alice
carol: waiting for the VM to finish booting
alice# [ 0.000000] Linux version 4.9.45 (nixbld@localhost) (gcc version 6.4.0 (GCC) ) #1-NixOS SMP Fri Aug 25 00:12:55 UTC 2017
alice# [ 0.000000] Command line: loglevel=7 console=ttyS0 panic=1 boot.panic_on_fail init=/nix/store/fls53cd45966dq403iqvj0cb04qk1zn5-nixos-system-alice-17.09.git.b1bab8c/init regInfo=/nix/store/4wl88n7izi75rdyy7h78dh2ivz6b2cfy-reginfo
alice# [ 0.000000] x86/fpu: Legacy x87 FPU detected.
alice# [ 0.000000] x86/fpu: Using 'eager' FPU context switches.
alice# [ 0.000000] e820: BIOS-provided physical RAM map:
alice# [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
alice# [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
alice# [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
alice# [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x0000000017fdbfff] usable
alice# [ 0.000000] BIOS-e820: [mem 0x0000000017fdc000-0x0000000017ffffff] reserved
alice# [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
alice# [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
alice# [ 0.000000] NX (Execute Disable) protection: active
alice# [ 0.000000] SMBIOS 2.8 present.
alice# [ 0.000000] Hypervisor detected: KVM
alice# [ 0.000000] e820: last_pfn = 0x17fdc max_arch_pfn = 0x400000000
alice# [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WC UC- UC
alice# [ 0.000000] found SMP MP-table at [mem 0x000f6a70-0x000f6a7f] mapped at [ffff960c800f6a70]
alice# [ 0.000000] Scanning 1 areas for low memory corruption
alice# [ 0.000000] RAMDISK: [mem 0x17999000-0x17fcffff]
alice# [ 0.000000] ACPI: Early table checksum verification disabled
alice# [ 0.000000] ACPI: RSDP 0x00000000000F6880 000014 (v00 BOCHS )
alice# [ 0.000000] ACPI: RSDT 0x0000000017FE154E 000030 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001)
alice# [ 0.000000] ACPI: FACP 0x0000000017FE142A 000074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001)
alice# [ 0.000000] ACPI: DSDT 0x0000000017FE0040 0013EA (v01 BOCHS BXPCDSDT 00000001 BXPC 00000001)
alice# [ 0.000000] ACPI: FACS 0x0000000017FE0000 000040
alice# [ 0.000000] ACPI: APIC 0x0000000017FE149E 000078 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001)
alice# [ 0.000000] ACPI: HPET 0x0000000017FE1516 000038 (v01 BOCHS BXPCHPET 00000001 BXPC 00000001)
alice# [ 0.000000] No NUMA configuration found
alice# [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000017fdbfff]
alice# [ 0.000000] NODE_DATA(0) allocated [mem 0x17fd8000-0x17fdbfff]
alice# [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
alice# [ 0.000000] kvm-clock: cpu 0, msr 0:17fd2001, primary cpu clock
alice# [ 0.000000] kvm-clock: using sched offset of 418542272 cycles
alice# [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
alice# [ 0.000000] Zone ranges:
alice# [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff]
alice# [ 0.000000] DMA32 [mem 0x0000000001000000-0x0000000017fdbfff]
alice# [ 0.000000] Normal empty
alice# [ 0.000000] Movable zone start for each node
alice# [ 0.000000] Early memory node ranges
alice# [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff]
alice# [ 0.000000] node 0: [mem 0x0000000000100000-0x0000000017fdbfff]
alice# [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000017fdbfff]
alice# [ 0.000000] ACPI: PM-Timer IO Port: 0x608
alice# [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
alice# [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
alice# [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
alice# [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
alice# [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
alice# [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
alice# [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
alice# [ 0.000000] Using ACPI (MADT) for SMP configuration information
alice# [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000
alice# [ 0.000000] smpboot: Allowing 1 CPUs, 0 hotplug CPUs
alice# [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff]
alice# [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff]
alice# [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff]
alice# [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff]
alice# [ 0.000000] e820: [mem 0x18000000-0xfeffbfff] available for PCI devices
alice# [ 0.000000] Booting paravirtualized kernel on KVM
alice# [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
alice# [ 0.000000] setup_percpu: NR_CPUS:384 nr_cpumask_bits:384 nr_cpu_ids:1 nr_node_ids:1
alice# [ 0.000000] percpu: Embedded 35 pages/cpu @ffff960c97600000 s102424 r8192 d32744 u2097152
alice# [ 0.000000] KVM setup async PF for cpu 0
alice# [ 0.000000] kvm-stealtime: cpu 0, msr 1760d940
alice# [ 0.000000] Built 1 zonelists in Node order, mobility grouping on. Total pages: 96613
alice# [ 0.000000] Policy zone: DMA32
alice# [ 0.000000] Kernel command line: loglevel=7 console=ttyS0 panic=1 boot.panic_on_fail init=/nix/store/fls53cd45966dq403iqvj0cb04qk1zn5-nixos-system-alice-17.09.git.b1bab8c/init regInfo=/nix/store/4wl88n7izi75rdyy7h78dh2ivz6b2cfy-reginfo
alice# [ 0.000000] PID hash table entries: 2048 (order: 2, 16384 bytes)
alice# [ 0.000000] Memory: 368520K/392680K available (5562K kernel code, 986K rwdata, 1864K rodata, 1308K init, 780K bss, 24160K reserved, 0K cma-reserved)
alice# [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
alice# [ 0.000000] Hierarchical RCU implementation.
alice# [ 0.000000] Build-time adjustment of leaf fanout to 64.
alice# [ 0.000000] RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.
alice# [ 0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=64, nr_cpu_ids=1
alice# [ 0.000000] NR_IRQS:24832 nr_irqs:256 16
alice# [ 0.000000] Console: colour VGA+ 80x25
alice# [ 0.000000] console [ttyS0] enabled
alice# [ 0.000000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
alice# [ 0.000000] tsc: Detected 2793.544 MHz processor
alice# [ 0.054696] Calibrating delay loop (skipped) preset value.. 5587.08 BogoMIPS (lpj=2793544)
alice# [ 0.055240] pid_max: default: 32768 minimum: 301
alice# [ 0.055584] ACPI: Core revision 20160831
alice# [ 0.056366] ACPI: 1 ACPI AML tables successfully acquired and loaded
alice# [ 0.056811] Security Framework initialized
alice# [ 0.057085] Yama: becoming mindful.
alice# [ 0.057329] AppArmor: AppArmor initialized
alice# [ 0.057628] Dentry cache hash table entries: 65536 (order: 7, 524288 bytes)
alice# [ 0.058135] Inode-cache hash table entries: 32768 (order: 6, 262144 bytes)
alice# [ 0.058624] Mount-cache hash table entries: 1024 (order: 1, 8192 bytes)
alice# [ 0.059054] Mountpoint-cache hash table entries: 1024 (order: 1, 8192 bytes)
alice# [ 0.059658] CPU: Physical Processor ID: 0
alice# [ 0.059940] mce: CPU supports 10 MCE banks
alice# [ 0.060234] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
alice# [ 0.060590] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
alice# [ 0.066458] Freeing SMP alternatives memory: 24K
alice# [ 0.069486] ftrace: allocating 22936 entries in 90 pages
alice# [ 0.082651] smpboot: Max logical packages: 1
alice# [ 0.083069] x2apic enabled
alice# [ 0.083393] Switched APIC routing to physical x2apic.
alice# [ 0.084238] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
carol# [ 0.000000] Linux version 4.9.45 (nixbld@localhost) (gcc version 6.4.0 (GCC) ) #1-NixOS SMP Fri Aug 25 00:12:55 UTC 2017
carol# [ 0.000000] Command line: loglevel=7 console=ttyS0 panic=1 boot.panic_on_fail init=/nix/store/46pp0pn6wh7m5qngvlb17gxckxvj57i2-nixos-system-carol-17.09.git.b1bab8c/init regInfo=/nix/store/cnz31d45dxrhw41i75wadl01f2xy912p-reginfo
carol# [ 0.000000] x86/fpu: Legacy x87 FPU detected.
carol# [ 0.000000] x86/fpu: Using 'eager' FPU context switches.
carol# [ 0.000000] e820: BIOS-provided physical RAM map:
carol# [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
carol# [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
carol# [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
carol# [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x0000000017fdbfff] usable
carol# [ 0.000000] BIOS-e820: [mem 0x0000000017fdc000-0x0000000017ffffff] reserved
carol# [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
carol# [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
carol# [ 0.000000] NX (Execute Disable) protection: active
carol# [ 0.000000] SMBIOS 2.8 present.
carol# [ 0.000000] Hypervisor detected: KVM
carol# [ 0.000000] e820: last_pfn = 0x17fdc max_arch_pfn = 0x400000000
carol# [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WC UC- UC
carol# [ 0.000000] found SMP MP-table at [mem 0x000f6a70-0x000f6a7f] mapped at [ffff953f800f6a70]
carol# [ 0.000000] Scanning 1 areas for low memory corruption
carol# [ 0.000000] RAMDISK: [mem 0x17999000-0x17fcffff]
carol# [ 0.000000] ACPI: Early table checksum verification disabled
carol# [ 0.000000] ACPI: RSDP 0x00000000000F6880 000014 (v00 BOCHS )
carol# [ 0.000000] ACPI: RSDT 0x0000000017FE154E 000030 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001)
carol# [ 0.000000] ACPI: FACP 0x0000000017FE142A 000074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001)
carol# [ 0.000000] ACPI: DSDT 0x0000000017FE0040 0013EA (v01 BOCHS BXPCDSDT 00000001 BXPC 00000001)
carol# [ 0.000000] ACPI: FACS 0x0000000017FE0000 000040
carol# [ 0.000000] ACPI: APIC 0x0000000017FE149E 000078 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001)
carol# [ 0.000000] ACPI: HPET 0x0000000017FE1516 000038 (v01 BOCHS BXPCHPET 00000001 BXPC 00000001)
carol# [ 0.000000] No NUMA configuration found
carol# [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000017fdbfff]
carol# [ 0.000000] NODE_DATA(0) allocated [mem 0x17fd8000-0x17fdbfff]
carol# [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
carol# [ 0.000000] kvm-clock: cpu 0, msr 0:17fd2001, primary cpu clock
carol# [ 0.000000] kvm-clock: using sched offset of 428734423 cycles
carol# [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
carol# [ 0.000000] Zone ranges:
carol# [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff]
carol# [ 0.000000] DMA32 [mem 0x0000000001000000-0x0000000017fdbfff]
carol# [ 0.000000] Normal empty
carol# [ 0.000000] Movable zone start for each node
carol# [ 0.000000] Early memory node ranges
carol# [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff]
carol# [ 0.000000] node 0: [mem 0x0000000000100000-0x0000000017fdbfff]
carol# [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000017fdbfff]
carol# [ 0.000000] ACPI: PM-Timer IO Port: 0x608
carol# [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
carol# [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
carol# [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
carol# [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
carol# [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
carol# [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
carol# [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
carol# [ 0.000000] Using ACPI (MADT) for SMP configuration information
carol# [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000
carol# [ 0.000000] smpboot: Allowing 1 CPUs, 0 hotplug CPUs
carol# [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff]
carol# [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff]
carol# [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff]
carol# [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff]
carol# [ 0.000000] e820: [mem 0x18000000-0xfeffbfff] available for PCI devices
carol# [ 0.000000] Booting paravirtualized kernel on KVM
carol# [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
carol# [ 0.000000] setup_percpu: NR_CPUS:384 nr_cpumask_bits:384 nr_cpu_ids:1 nr_node_ids:1
carol# [ 0.000000] percpu: Embedded 35 pages/cpu @ffff953f97600000 s102424 r8192 d32744 u2097152
carol# [ 0.000000] KVM setup async PF for cpu 0
carol# [ 0.000000] kvm-stealtime: cpu 0, msr 1760d940
carol# [ 0.000000] Built 1 zonelists in Node order, mobility grouping on. Total pages: 96613
carol# [ 0.000000] Policy zone: DMA32
carol# [ 0.000000] Kernel command line: loglevel=7 console=ttyS0 panic=1 boot.panic_on_fail init=/nix/store/46pp0pn6wh7m5qngvlb17gxckxvj57i2-nixos-system-carol-17.09.git.b1bab8c/init regInfo=/nix/store/cnz31d45dxrhw41i75wadl01f2xy912p-reginfo
carol# [ 0.000000] PID hash table entries: 2048 (order: 2, 16384 bytes)
carol# [ 0.000000] Memory: 368520K/392680K available (5562K kernel code, 986K rwdata, 1864K rodata, 1308K init, 780K bss, 24160K reserved, 0K cma-reserved)
carol# [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
carol# [ 0.000000] Hierarchical RCU implementation.
carol# [ 0.000000] Build-time adjustment of leaf fanout to 64.
carol# [ 0.000000] RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.
carol# [ 0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=64, nr_cpu_ids=1
carol# [ 0.000000] NR_IRQS:24832 nr_irqs:256 16
carol# [ 0.000000] Console: colour VGA+ 80x25
carol# [ 0.000000] console [ttyS0] enabled
carol# [ 0.000000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
carol# [ 0.000000] tsc: Detected 2793.544 MHz processor
carol# [ 0.046845] Calibrating delay loop (skipped) preset value.. 5587.08 BogoMIPS (lpj=2793544)
carol# [ 0.047381] pid_max: default: 32768 minimum: 301
carol# [ 0.047689] ACPI: Core revision 20160831
carol# [ 0.048452] ACPI: 1 ACPI AML tables successfully acquired and loaded
carol# [ 0.048900] Security Framework initialized
carol# [ 0.049161] Yama: becoming mindful.
carol# [ 0.049390] AppArmor: AppArmor initialized
carol# [ 0.049685] Dentry cache hash table entries: 65536 (order: 7, 524288 bytes)
carol# [ 0.050186] Inode-cache hash table entries: 32768 (order: 6, 262144 bytes)
carol# [ 0.050669] Mount-cache hash table entries: 1024 (order: 1, 8192 bytes)
carol# [ 0.051091] Mountpoint-cache hash table entries: 1024 (order: 1, 8192 bytes)
carol# [ 0.051694] CPU: Physical Processor ID: 0
carol# [ 0.051964] mce: CPU supports 10 MCE banks
carol# [ 0.052250] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
carol# [ 0.052608] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
carol# [ 0.058433] Freeing SMP alternatives memory: 24K
carol# [ 0.061426] ftrace: allocating 22936 entries in 90 pages
carol# [ 0.074245] smpboot: Max logical packages: 1
carol# [ 0.074732] x2apic enabled
carol# [ 0.075092] Switched APIC routing to physical x2apic.
carol# [ 0.076039] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
moon# [ 0.000000] Linux version 4.9.45 (nixbld@localhost) (gcc version 6.4.0 (GCC) ) #1-NixOS SMP Fri Aug 25 00:12:55 UTC 2017
moon# [ 0.000000] Command line: loglevel=7 console=ttyS0 panic=1 boot.panic_on_fail init=/nix/store/yvvvfxb627dfc12h8nqgr4ryq1zaggpb-nixos-system-moon-17.09.git.b1bab8c/init regInfo=/nix/store/vxmywb0r1bbqp4xf2g73xf4l0qhm1ndf-reginfo
moon# [ 0.000000] x86/fpu: Legacy x87 FPU detected.
moon# [ 0.000000] x86/fpu: Using 'eager' FPU context switches.
moon# [ 0.000000] e820: BIOS-provided physical RAM map:
moon# [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
alice# [ 0.186352] smpboot: CPU0: Intel Common KVM processor (family: 0xf, model: 0x6, stepping: 0x1)
moon# [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
alice# [ 0.186939] Performance Events: unsupported Netburst CPU model 6 no PMU driver, software events only.
moon# [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
alice# [ 0.187870] x86: Booted up 1 node, 1 CPUs
moon# [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x0000000017fdbfff] usable
alice# [ 0.188153] smpboot: Total of 1 processors activated (5587.08 BogoMIPS)
alice# [ 0.188736] devtmpfs: initialized
moon# [ 0.000000] BIOS-e820: [mem 0x0000000017fdc000-0x0000000017ffffff] reserved
moon# [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
alice# [ 0.189097] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
alice# [ 0.189727] futex hash table entries: 256 (order: 2, 16384 bytes)
moon# [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
alice# [ 0.190140] pinctrl core: initialized pinctrl subsystem
moon# [ 0.000000] NX (Execute Disable) protection: active
moon# [ 0.000000] SMBIOS 2.8 present.
alice# [ 0.190596] NET: Registered protocol family 16
moon# [ 0.000000] Hypervisor detected: KVM
alice# [ 0.190998] cpuidle: using governor menu
alice# [ 0.191287] ACPI: bus type PCI registered
moon# [ 0.000000] e820: last_pfn = 0x17fdc max_arch_pfn = 0x400000000
alice# [ 0.191551] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
moon# [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WC UC- UC
alice# [ 0.192035] PCI: Using configuration type 1 for base access
moon# [ 0.000000] found SMP MP-table at [mem 0x000f6a70-0x000f6a7f] mapped at [ffff9911400f6a70]
alice# [ 0.192744] HugeTLB registered 2 MB page size, pre-allocated 0 pages
moon# [ 0.000000] Scanning 1 areas for low memory corruption
alice# [ 0.193250] ACPI: Added _OSI(Module Device)
moon# [ 0.000000] RAMDISK: [mem 0x17999000-0x17fcffff]
alice# [ 0.193540] ACPI: Added _OSI(Processor Device)
moon# [ 0.000000] ACPI: Early table checksum verification disabled
alice# [ 0.193851] ACPI: Added _OSI(3.0 _SCP Extensions)
alice# [ 0.194157] ACPI: Added _OSI(Processor Aggregator Device)
moon# [ 0.000000] ACPI: RSDP 0x00000000000F6880 000014 (v00 BOCHS )
moon# [ 0.000000] ACPI: RSDT 0x0000000017FE154E 000030 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001)
moon# [ 0.000000] ACPI: FACP 0x0000000017FE142A 000074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001)
alice# [ 0.195729] ACPI: Interpreter enabled
alice# [ 0.196014] ACPI: (supports S0 S3 S4 S5)
alice# [ 0.196268] ACPI: Using IOAPIC for interrupt routing
moon# [ 0.000000] ACPI: DSDT 0x0000000017FE0040 0013EA (v01 BOCHS BXPCDSDT 00000001 BXPC 00000001)
moon# [ 0.000000] ACPI: FACS 0x0000000017FE0000 000040
alice# [ 0.196597] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
moon# [ 0.000000] ACPI: APIC 0x0000000017FE149E 000078 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001)
moon# [ 0.000000] ACPI: HPET 0x0000000017FE1516 000038 (v01 BOCHS BXPCHPET 00000001 BXPC 00000001)
moon# [ 0.000000] No NUMA configuration found
alice# [ 0.198524] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
moon# [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000017fdbfff]
alice# [ 0.198950] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI]
moon# [ 0.000000] NODE_DATA(0) allocated [mem 0x17fd8000-0x17fdbfff]
alice# [ 0.199397] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM
moon# [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
alice# [ 0.199844] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge.
moon# [ 0.000000] kvm-clock: cpu 0, msr 0:17fd2001, primary cpu clock
alice# [ 0.200623] acpiphp: Slot [3] registered
moon# [ 0.000000] kvm-clock: using sched offset of 430563780 cycles
alice# [ 0.200915] acpiphp: Slot [4] registered
alice# [ 0.201189] acpiphp: Slot [5] registered
alice# [ 0.201459] acpiphp: Slot [6] registered
moon# [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
alice# [ 0.201727] acpiphp: Slot [7] registered
moon# [ 0.000000] Zone ranges:
alice# [ 0.202015] acpiphp: Slot [8] registered
alice# [ 0.202288] acpiphp: Slot [9] registered
moon# [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff]
alice# [ 0.202558] acpiphp: Slot [10] registered
alice# [ 0.202854] acpiphp: Slot [11] registered
moon# [ 0.000000] DMA32 [mem 0x0000000001000000-0x0000000017fdbfff]
alice# [ 0.203122] acpiphp: Slot [12] registered
moon# [ 0.000000] Normal empty
alice# [ 0.203416] acpiphp: Slot [13] registered
moon# [ 0.000000] Movable zone start for each node
alice# [ 0.203687] acpiphp: Slot [14] registered
moon# [ 0.000000] Early memory node ranges
alice# [ 0.203979] acpiphp: Slot [15] registered
alice# [ 0.204256] acpiphp: Slot [16] registered
moon# [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff]
alice# [ 0.204532] acpiphp: Slot [17] registered
moon# [ 0.000000] node 0: [mem 0x0000000000100000-0x0000000017fdbfff]
alice# [ 0.204826] acpiphp: Slot [18] registered
alice# [ 0.205234] acpiphp: Slot [19] registered
moon# [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000017fdbfff]
alice# [ 0.205509] acpiphp: Slot [20] registered
moon# [ 0.000000] ACPI: PM-Timer IO Port: 0x608
alice# [ 0.205798] acpiphp: Slot [21] registered
alice# [ 0.206088] acpiphp: Slot [22] registered
moon# [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
alice# [ 0.206362] acpiphp: Slot [23] registered
alice# [ 0.206644] acpiphp: Slot [24] registered
moon# [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
alice# [ 0.206926] acpiphp: Slot [25] registered
alice# [ 0.207206] acpiphp: Slot [26] registered
moon# [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
alice# [ 0.207479] acpiphp: Slot [27] registered
moon# [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
alice# [ 0.207794] acpiphp: Slot [28] registered
alice# [ 0.208171] acpiphp: Slot [29] registered
moon# [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
alice# [ 0.208532] acpiphp: Slot [30] registered
moon# [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
alice# [ 0.208907] acpiphp: Slot [31] registered
alice# [ 0.209266] PCI host bridge to bus 0000:00
moon# [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
alice# [ 0.209617] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]
moon# [ 0.000000] Using ACPI (MADT) for SMP configuration information
moon# [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000
alice# [ 0.210187] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]
moon# [ 0.000000] smpboot: Allowing 1 CPUs, 0 hotplug CPUs
alice# [ 0.210762] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
moon# [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff]
alice# [ 0.211381] pci_bus 0000:00: root bus resource [mem 0x18000000-0xfebfffff window]
moon# [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff]
alice# [ 0.211984] pci_bus 0000:00: root bus resource [bus 00-ff]
moon# [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff]
moon# [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff]
moon# [ 0.000000] e820: [mem 0x18000000-0xfeffbfff] available for PCI devices
moon# [ 0.000000] Booting paravirtualized kernel on KVM
moon# [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
moon# [ 0.000000] setup_percpu: NR_CPUS:384 nr_cpumask_bits:384 nr_cpu_ids:1 nr_node_ids:1
moon# [ 0.000000] percpu: Embedded 35 pages/cpu @ffff991157600000 s102424 r8192 d32744 u2097152
moon# [ 0.000000] KVM setup async PF for cpu 0
moon# [ 0.000000] kvm-stealtime: cpu 0, msr 1760d940
moon# [ 0.000000] Built 1 zonelists in Node order, mobility grouping on. Total pages: 96613
moon# [ 0.000000] Policy zone: DMA32
moon# [ 0.000000] Kernel command line: loglevel=7 console=ttyS0 panic=1 boot.panic_on_fail init=/nix/store/yvvvfxb627dfc12h8nqgr4ryq1zaggpb-nixos-system-moon-17.09.git.b1bab8c/init regInfo=/nix/store/vxmywb0r1bbqp4xf2g73xf4l0qhm1ndf-reginfo
moon# [ 0.000000] PID hash table entries: 2048 (order: 2, 16384 bytes)
alice# [ 0.218911] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7]
moon# [ 0.000000] Memory: 368520K/392680K available (5562K kernel code, 986K rwdata, 1864K rodata, 1308K init, 780K bss, 24160K reserved, 0K cma-reserved)
alice# [ 0.219482] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6]
moon# [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
moon# [ 0.000000] Hierarchical RCU implementation.
moon# [ 0.000000] Build-time adjustment of leaf fanout to 64.
alice# [ 0.220032] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177]
moon# [ 0.000000] RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.
alice# [ 0.220666] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376]
moon# [ 0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=64, nr_cpu_ids=1
moon# [ 0.000000] NR_IRQS:24832 nr_irqs:256 16
moon# [ 0.000000] Console: colour VGA+ 80x25
moon# [ 0.000000] console [ttyS0] enabled
moon# [ 0.000000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
moon# [ 0.000000] tsc: Detected 2793.544 MHz processor
moon# [ 0.055220] Calibrating delay loop (skipped) preset value.. 5587.08 BogoMIPS (lpj=2793544)
moon# [ 0.055921] pid_max: default: 32768 minimum: 301
moon# [ 0.056307] ACPI: Core revision 20160831
moon# [ 0.057157] ACPI: 1 ACPI AML tables successfully acquired and loaded
moon# [ 0.057699] Security Framework initialized
moon# [ 0.058058] Yama: becoming mindful.
moon# [ 0.058358] AppArmor: AppArmor initialized
moon# [ 0.058725] Dentry cache hash table entries: 65536 (order: 7, 524288 bytes)
moon# [ 0.059366] Inode-cache hash table entries: 32768 (order: 6, 262144 bytes)
moon# [ 0.059980] Mount-cache hash table entries: 1024 (order: 1, 8192 bytes)
moon# [ 0.060516] Mountpoint-cache hash table entries: 1024 (order: 1, 8192 bytes)
alice# [ 0.229303] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI
moon# [ 0.061240] CPU: Physical Processor ID: 0
alice# [ 0.229922] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB
moon# [ 0.061584] mce: CPU supports 10 MCE banks
moon# [ 0.061976] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
moon# [ 0.062411] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
moon# [ 0.068458] Freeing SMP alternatives memory: 24K
moon# [ 0.071622] ftrace: allocating 22936 entries in 90 pages
moon# [ 0.084488] smpboot: Max logical packages: 1
moon# [ 0.084979] x2apic enabled
moon# [ 0.085337] Switched APIC routing to physical x2apic.
moon# [ 0.086267] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
carol# [ 0.178540] smpboot: CPU0: Intel Common KVM processor (family: 0xf, model: 0x6, stepping: 0x1)
carol# [ 0.179258] Performance Events: unsupported Netburst CPU model 6 no PMU driver, software events only.
carol# [ 0.180145] x86: Booted up 1 node, 1 CPUs
carol# [ 0.180408] smpboot: Total of 1 processors activated (5587.08 BogoMIPS)
carol# [ 0.180974] devtmpfs: initialized
carol# [ 0.181302] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
carol# [ 0.181935] futex hash table entries: 256 (order: 2, 16384 bytes)
carol# [ 0.182379] pinctrl core: initialized pinctrl subsystem
carol# [ 0.182835] NET: Registered protocol family 16
carol# [ 0.183209] cpuidle: using governor menu
carol# [ 0.183485] ACPI: bus type PCI registered
carol# [ 0.183743] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
carol# [ 0.184205] PCI: Using configuration type 1 for base access
carol# [ 0.184906] HugeTLB registered 2 MB page size, pre-allocated 0 pages
carol# [ 0.185388] ACPI: Added _OSI(Module Device)
carol# [ 0.185657] ACPI: Added _OSI(Processor Device)
carol# [ 0.185937] ACPI: Added _OSI(3.0 _SCP Extensions)
carol# [ 0.186229] ACPI: Added _OSI(Processor Aggregator Device)
carol# [ 0.187737] ACPI: Interpreter enabled
carol# [ 0.187980] ACPI: (supports S0 S3 S4 S5)
carol# [ 0.188227] ACPI: Using IOAPIC for interrupt routing
carol# [ 0.188551] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
carol# [ 0.190370] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
carol# [ 0.190765] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI]
carol# [ 0.191193] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM
carol# [ 0.191609] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge.
carol# [ 0.192374] acpiphp: Slot [3] registered
carol# [ 0.192634] acpiphp: Slot [4] registered
carol# [ 0.192893] acpiphp: Slot [5] registered
carol# [ 0.193152] acpiphp: Slot [6] registered
carol# [ 0.193411] acpiphp: Slot [7] registered
carol# [ 0.193678] acpiphp: Slot [8] registered
carol# [ 0.193936] acpiphp: Slot [9] registered
carol# [ 0.194319] acpiphp: Slot [10] registered
carol# [ 0.194716] acpiphp: Slot [11] registered
carol# [ 0.195111] acpiphp: Slot [12] registered
carol# [ 0.195514] acpiphp: Slot [13] registered
carol# [ 0.195913] acpiphp: Slot [14] registered
carol# [ 0.196318] acpiphp: Slot [15] registered
carol# [ 0.196596] acpiphp: Slot [16] registered
carol# [ 0.196833] acpiphp: Slot [17] registered
carol# [ 0.197249] acpiphp: Slot [18] registered
carol# [ 0.197585] acpiphp: Slot [19] registered
carol# [ 0.197928] acpiphp: Slot [20] registered
carol# [ 0.198271] acpiphp: Slot [21] registered
carol# [ 0.198622] acpiphp: Slot [22] registered
carol# [ 0.198962] acpiphp: Slot [23] registered
carol# [ 0.199302] acpiphp: Slot [24] registered
carol# [ 0.199653] acpiphp: Slot [25] registered
carol# [ 0.199994] acpiphp: Slot [26] registered
carol# [ 0.200336] acpiphp: Slot [27] registered
carol# [ 0.200684] acpiphp: Slot [28] registered
carol# [ 0.201022] acpiphp: Slot [29] registered
carol# [ 0.201366] acpiphp: Slot [30] registered
carol# [ 0.201714] acpiphp: Slot [31] registered
carol# [ 0.202041] PCI host bridge to bus 0000:00
carol# [ 0.202375] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]
carol# [ 0.202913] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]
carol# [ 0.203452] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
carol# [ 0.204045] pci_bus 0000:00: root bus resource [mem 0x18000000-0xfebfffff window]
carol# [ 0.204642] pci_bus 0000:00: root bus resource [bus 00-ff]
carol# [ 0.211026] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7]
carol# [ 0.211599] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6]
carol# [ 0.212111] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177]
carol# [ 0.212675] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376]
carol# [ 0.220956] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI
carol# [ 0.221539] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB
alice# [ 0.346495] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
alice# [ 0.347076] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
alice# [ 0.347620] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
alice# [ 0.348067] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
alice# [ 0.348492] ACPI: PCI Interrupt Link [LNKS] (IRQs *9)
alice# [ 0.348910] ACPI: Enabled 2 GPEs in block 00 to 0F
alice# [ 0.349316] vgaarb: setting as boot device: PCI:0000:00:02.0
alice# [ 0.349671] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none
alice# [ 0.350191] vgaarb: loaded
alice# [ 0.350377] vgaarb: bridge control possible 0000:00:02.0
alice# [ 0.350769] PCI: Using ACPI for IRQ routing
alice# [ 0.351202] NetLabel: Initializing
alice# [ 0.351435] NetLabel: domain hash size = 128
alice# [ 0.351707] NetLabel: protocols = UNLABELED CIPSOv4
alice# [ 0.352039] NetLabel: unlabeled traffic allowed by default
alice# [ 0.352435] HPET: 3 timers in total, 0 timers will be used for per-cpu timer
alice# [ 0.352889] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
alice# [ 0.353227] hpet0: 3 comparators, 64-bit 100.000000 MHz counter
alice# [ 0.355692] clocksource: Switched to clocksource kvm-clock
moon# [ 0.187833] smpboot: CPU0: Intel Common KVM processor (family: 0xf, model: 0x6, stepping: 0x1)
moon# [ 0.188542] Performance Events: unsupported Netburst CPU model 6 no PMU driver, software events only.
moon# [ 0.189593] x86: Booted up 1 node, 1 CPUs
moon# [ 0.189929] smpboot: Total of 1 processors activated (5587.08 BogoMIPS)
alice# [ 0.359055] VFS: Disk quotas dquot_6.6.0
moon# [ 0.190610] devtmpfs: initialized
alice# [ 0.359316] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
alice# [ 0.359801] AppArmor: AppArmor Filesystem Enabled
alice# [ 0.360120] pnp: PnP ACPI init
moon# [ 0.191010] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
alice# [ 0.360562] pnp: PnP ACPI: found 6 devices
moon# [ 0.191774] futex hash table entries: 256 (order: 2, 16384 bytes)
moon# [ 0.192287] pinctrl core: initialized pinctrl subsystem
moon# [ 0.192805] NET: Registered protocol family 16
moon# [ 0.193273] cpuidle: using governor menu
moon# [ 0.193620] ACPI: bus type PCI registered
moon# [ 0.193950] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
moon# [ 0.194521] PCI: Using configuration type 1 for base access
moon# [ 0.195321] HugeTLB registered 2 MB page size, pre-allocated 0 pages
moon# [ 0.195923] ACPI: Added _OSI(Module Device)
moon# [ 0.196257] ACPI: Added _OSI(Processor Device)
moon# [ 0.196611] ACPI: Added _OSI(3.0 _SCP Extensions)
moon# [ 0.196994] ACPI: Added _OSI(Processor Aggregator Device)
alice# [ 0.366146] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
alice# [ 0.366765] NET: Registered protocol family 2
alice# [ 0.367124] TCP established hash table entries: 4096 (order: 3, 32768 bytes)
moon# [ 0.198697] ACPI: Interpreter enabled
alice# [ 0.367565] TCP bind hash table entries: 4096 (order: 4, 65536 bytes)
moon# [ 0.199019] ACPI: (supports S0 S3 S4 S5)
alice# [ 0.367979] TCP: Hash tables configured (established 4096 bind 4096)
moon# [ 0.199335] ACPI: Using IOAPIC for interrupt routing
alice# [ 0.368381] UDP hash table entries: 256 (order: 1, 8192 bytes)
alice# [ 0.368751] UDP-Lite hash table entries: 256 (order: 1, 8192 bytes)
moon# [ 0.199741] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
alice# [ 0.369152] NET: Registered protocol family 1
alice# [ 0.369435] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
alice# [ 0.369813] pci 0000:00:01.0: PIIX3: Enabling Passive Release
alice# [ 0.370178] pci 0000:00:01.0: Activating ISA DMA hang workarounds
moon# [ 0.201723] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
moon# [ 0.202229] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI]
moon# [ 0.202774] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM
moon# [ 0.203311] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge.
moon# [ 0.204288] acpiphp: Slot [3] registered
moon# [ 0.204618] acpiphp: Slot [4] registered
moon# [ 0.204964] acpiphp: Slot [5] registered
moon# [ 0.205296] acpiphp: Slot [6] registered
moon# [ 0.205629] acpiphp: Slot [7] registered
moon# [ 0.205974] acpiphp: Slot [8] registered
moon# [ 0.206308] acpiphp: Slot [9] registered
moon# [ 0.206646] acpiphp: Slot [10] registered
moon# [ 0.206921] acpiphp: Slot [11] registered
moon# [ 0.207182] acpiphp: Slot [12] registered
moon# [ 0.207441] acpiphp: Slot [13] registered
moon# [ 0.207701] acpiphp: Slot [14] registered
moon# [ 0.208202] acpiphp: Slot [15] registered
moon# [ 0.208463] acpiphp: Slot [16] registered
moon# [ 0.208722] acpiphp: Slot [17] registered
moon# [ 0.208996] acpiphp: Slot [18] registered
moon# [ 0.209257] acpiphp: Slot [19] registered
moon# [ 0.209516] acpiphp: Slot [20] registered
moon# [ 0.209776] acpiphp: Slot [21] registered
moon# [ 0.210045] acpiphp: Slot [22] registered
moon# [ 0.210306] acpiphp: Slot [23] registered
moon# [ 0.210566] acpiphp: Slot [24] registered
moon# [ 0.210827] acpiphp: Slot [25] registered
moon# [ 0.211101] acpiphp: Slot [26] registered
moon# [ 0.211361] acpiphp: Slot [27] registered
moon# [ 0.211623] acpiphp: Slot [28] registered
moon# [ 0.211884] acpiphp: Slot [29] registered
moon# [ 0.212145] acpiphp: Slot [30] registered
moon# [ 0.212402] acpiphp: Slot [31] registered
moon# [ 0.212655] PCI host bridge to bus 0000:00
moon# [ 0.212912] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]
moon# [ 0.213322] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]
alice# [ 0.382399] ACPI: PCI Interrupt Link [LNKD] enabled at IRQ 11
moon# [ 0.213750] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
moon# [ 0.214324] pci_bus 0000:00: root bus resource [mem 0x18000000-0xfebfffff window]
moon# [ 0.214900] pci_bus 0000:00: root bus resource [bus 00-ff]
moon# [ 0.222511] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7]
moon# [ 0.223064] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6]
moon# [ 0.223554] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177]
moon# [ 0.224061] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376]
alice# [ 0.393994] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
alice# [ 0.394583] Trying to unpack rootfs image as initramfs...
moon# [ 0.233328] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI
moon# [ 0.233783] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB
carol# [ 0.339409] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
carol# [ 0.339983] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
carol# [ 0.340519] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
carol# [ 0.341051] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
carol# [ 0.342513] ACPI: PCI Interrupt Link [LNKS] (IRQs *9)
carol# [ 0.342912] ACPI: Enabled 2 GPEs in block 00 to 0F
carol# [ 0.343299] vgaarb: setting as boot device: PCI:0000:00:02.0
carol# [ 0.343652] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none
carol# [ 0.344134] vgaarb: loaded
carol# [ 0.344298] vgaarb: bridge control possible 0000:00:02.0
carol# [ 0.344672] PCI: Using ACPI for IRQ routing
carol# [ 0.345085] NetLabel: Initializing
carol# [ 0.345298] NetLabel: domain hash size = 128
carol# [ 0.345568] NetLabel: protocols = UNLABELED CIPSOv4
carol# [ 0.345874] NetLabel: unlabeled traffic allowed by default
carol# [ 0.346246] HPET: 3 timers in total, 0 timers will be used for per-cpu timer
carol# [ 0.346696] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
carol# [ 0.347045] hpet0: 3 comparators, 64-bit 100.000000 MHz counter
carol# [ 0.349649] clocksource: Switched to clocksource kvm-clock
carol# [ 0.352944] VFS: Disk quotas dquot_6.6.0
carol# [ 0.353209] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
carol# [ 0.353660] AppArmor: AppArmor Filesystem Enabled
carol# [ 0.353970] pnp: PnP ACPI init
carol# [ 0.354386] pnp: PnP ACPI: found 6 devices
carol# [ 0.359808] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
carol# [ 0.360625] NET: Registered protocol family 2
carol# [ 0.361125] TCP established hash table entries: 4096 (order: 3, 32768 bytes)
carol# [ 0.361776] TCP bind hash table entries: 4096 (order: 4, 65536 bytes)
carol# [ 0.362281] TCP: Hash tables configured (established 4096 bind 4096)
carol# [ 0.362683] UDP hash table entries: 256 (order: 1, 8192 bytes)
carol# [ 0.363041] UDP-Lite hash table entries: 256 (order: 1, 8192 bytes)
carol# [ 0.363440] NET: Registered protocol family 1
carol# [ 0.363718] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
carol# [ 0.364070] pci 0000:00:01.0: PIIX3: Enabling Passive Release
carol# [ 0.364385] pci 0000:00:01.0: Activating ISA DMA hang workarounds
alice# [ 0.449204] Freeing initrd memory: 6364K
alice# [ 0.449526] Scanning for low memory corruption every 60 seconds
alice# [ 0.450062] audit: initializing netlink subsys (disabled)
alice# [ 0.450408] audit: type=2000 audit(1504163494.781:1): initialized
alice# [ 0.450956] workingset: timestamp_bits=40 max_order=17 bucket_order=0
alice# [ 0.452183] zbud: loaded
alice# [ 0.452550] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251)
carol# [ 0.376434] ACPI: PCI Interrupt Link [LNKD] enabled at IRQ 11
alice# [ 0.453034] io scheduler noop registered
alice# [ 0.453287] io scheduler deadline registered
alice# [ 0.453556] io scheduler cfq registered (default)
alice# [ 0.453900] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
alice# [ 0.454244] pciehp: PCI Express Hot Plug Controller Driver version: 0.4
alice# [ 0.454722] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
carol# [ 0.388675] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
carol# [ 0.389251] Trying to unpack rootfs image as initramfs...
alice# [ 0.477307] 00:05: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
alice# [ 0.479238] brd: module loaded
alice# [ 0.479536] microcode: sig=0xf61, pf=0x1, revision=0x1
alice# [ 0.479888] microcode: Microcode Update Driver: v2.01 <tigran@aivazian.fsnet.co.uk>, Peter Oruba
alice# [ 0.480472] registered taskstats version 1
alice# [ 0.480758] zswap: loaded using pool lzo/zbud
alice# [ 0.481057] AppArmor: AppArmor sha1 policy hashing enabled
alice# [ 0.482391] Freeing unused kernel memory: 1308K
alice# [ 0.482680] Write protecting the kernel read-only data: 8192k
alice# [ 0.483149] Freeing unused kernel memory: 564K
alice# [ 0.483674] Freeing unused kernel memory: 184K
alice#
alice# <<< NixOS Stage 1 >>>
alice#
alice# loading module virtio_balloon...
alice# loading module virtio_console...
alice# loading module virtio_rng...
alice# loading module dm_mod...
alice# [ 0.504579] device-mapper: ioctl: 4.35.0-ioctl (2016-06-23) initialised: dm-devel@redhat.com
alice# running udev...
alice# [ 0.507143] systemd-udevd[99]: starting version 234
carol# [ 0.445029] Freeing initrd memory: 6364K
carol# [ 0.445357] Scanning for low memory corruption every 60 seconds
carol# [ 0.445862] audit: initializing netlink subsys (disabled)
carol# [ 0.446204] audit: type=2000 audit(1504163494.855:1): initialized
carol# [ 0.446739] workingset: timestamp_bits=40 max_order=17 bucket_order=0
carol# [ 0.447960] zbud: loaded
carol# [ 0.448325] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251)
carol# [ 0.448801] io scheduler noop registered
carol# [ 0.449043] io scheduler deadline registered
carol# [ 0.449303] io scheduler cfq registered (default)
carol# [ 0.449623] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
carol# [ 0.449976] pciehp: PCI Express Hot Plug Controller Driver version: 0.4
alice# [ 0.526448] rtc_cmos 00:00: RTC can wake from S4
carol# [ 0.450535] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
alice# [ 0.531654] rtc_cmos 00:00: rtc core: registered rtc_cmos as rtc0
alice# [ 0.532145] rtc_cmos 00:00: alarms up to one day, y3k, 114 bytes nvram, hpet irqs
alice# [ 0.532639] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
alice# [ 0.534310] serio: i8042 KBD port at 0x60,0x64 irq 1
alice# [ 0.534623] serio: i8042 AUX port at 0x60,0x64 irq 12
carol# [ 0.472887] 00:05: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
moon# [ 0.382151] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
carol# [ 0.474794] brd: module loaded
moon# [ 0.382587] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
carol# [ 0.475099] microcode: sig=0xf61, pf=0x1, revision=0x1
carol# [ 0.475440] microcode: Microcode Update Driver: v2.01 <tigran@aivazian.fsnet.co.uk>, Peter Oruba
carol# [ 0.476232] registered taskstats version 1
carol# [ 0.476625] zswap: loaded using pool lzo/zbud
carol# [ 0.477073] AppArmor: AppArmor sha1 policy hashing enabled
moon# [ 0.383017] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
moon# [ 0.385503] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
moon# [ 0.385927] ACPI: PCI Interrupt Link [LNKS] (IRQs *9)
carol# [ 0.478573] Freeing unused kernel memory: 1308K
moon# [ 0.386342] ACPI: Enabled 2 GPEs in block 00 to 0F
carol# [ 0.478862] Write protecting the kernel read-only data: 8192k
moon# [ 0.386747] vgaarb: setting as boot device: PCI:0000:00:02.0
carol# [ 0.479378] Freeing unused kernel memory: 564K
moon# [ 0.387104] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none
moon# [ 0.387603] vgaarb: loaded
carol# [ 0.479996] Freeing unused kernel memory: 184K
moon# [ 0.387775] vgaarb: bridge control possible 0000:00:02.0
moon# [ 0.388168] PCI: Using ACPI for IRQ routing
carol#
moon# [ 0.388601] NetLabel: Initializing
carol# <<< NixOS Stage 1 >>>
carol#
moon# [ 0.388820] NetLabel: domain hash size = 128
moon# [ 0.389104] NetLabel: protocols = UNLABELED CIPSOv4
moon# [ 0.389417] NetLabel: unlabeled traffic allowed by default
moon# [ 0.389799] HPET: 3 timers in total, 0 timers will be used for per-cpu timer
moon# [ 0.390248] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
moon# [ 0.390578] hpet0: 3 comparators, 64-bit 100.000000 MHz counter
moon# [ 0.394058] clocksource: Switched to clocksource kvm-clock
moon# [ 0.398130] VFS: Disk quotas dquot_6.6.0
carol# loading module virtio_balloon...
moon# [ 0.398398] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
moon# [ 0.398856] AppArmor: AppArmor Filesystem Enabled
moon# [ 0.399180] pnp: PnP ACPI init
moon# [ 0.399604] pnp: PnP ACPI: found 6 devices
alice# [ 0.569536] SCSI subsystem initialized
carol# loading module virtio_console...
carol# loading module virtio_rng...
alice# [ 0.573032] ACPI: bus type USB registered
carol# loading module dm_mod...
alice# [ 0.573396] usbcore: registered new interface driver usbfs
moon# [ 0.405169] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
moon# [ 0.405739] NET: Registered protocol family 2
moon# [ 0.406092] TCP established hash table entries: 4096 (order: 3, 32768 bytes)
moon# [ 0.406524] TCP bind hash table entries: 4096 (order: 4, 65536 bytes)
moon# [ 0.406918] TCP: Hash tables configured (established 4096 bind 4096)
moon# [ 0.407311] UDP hash table entries: 256 (order: 1, 8192 bytes)
moon# [ 0.407667] UDP-Lite hash table entries: 256 (order: 1, 8192 bytes)
moon# [ 0.408067] NET: Registered protocol family 1
alice# [ 0.576880] usbcore: registered new interface driver hub
moon# [ 0.408340] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
moon# [ 0.408707] pci 0000:00:01.0: PIIX3: Enabling Passive Release
moon# [ 0.409112] pci 0000:00:01.0: Activating ISA DMA hang workarounds
carol# [ 0.501514] device-mapper: ioctl: 4.35.0-ioctl (2016-06-23) initialised: dm-devel@redhat.com
carol# running udev...
alice# [ 0.578333] usbcore: registered new device driver usb
carol# [ 0.504362] systemd-udevd[99]: starting version 234
moon# [ 0.420371] ACPI: PCI Interrupt Link [LNKD] enabled at IRQ 11
alice# [ 0.592523] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
alice# [ 0.593633] ACPI: PCI Interrupt Link [LNKC] enabled at IRQ 10
moon# [ 0.431990] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
moon# [ 0.432583] Trying to unpack rootfs image as initramfs...
alice# [ 0.603662] uhci_hcd: USB Universal Host Controller Interface driver
carol# [ 0.528137] rtc_cmos 00:00: RTC can wake from S4
carol# [ 0.529349] rtc_cmos 00:00: rtc core: registered rtc_cmos as rtc0
carol# [ 0.531182] rtc_cmos 00:00: alarms up to one day, y3k, 114 bytes nvram, hpet irqs
alice# [ 0.615579] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
carol# [ 0.542680] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
carol# [ 0.543632] serio: i8042 KBD port at 0x60,0x64 irq 1
carol# [ 0.544660] serio: i8042 AUX port at 0x60,0x64 irq 12
alice# [ 0.637749] uhci_hcd 0000:00:01.2: UHCI Host Controller
alice# [ 0.640254] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1
alice# [ 0.640867] uhci_hcd 0000:00:01.2: detected 2 ports
alice# [ 0.641318] uhci_hcd 0000:00:01.2: irq 11, io base 0x0000c080
alice# [ 0.641866] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001
alice# [ 0.642407] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
alice# [ 0.642970] usb usb1: Product: UHCI Host Controller
alice# [ 0.643273] usb usb1: Manufacturer: Linux 4.9.45 uhci_hcd
alice# [ 0.643601] usb usb1: SerialNumber: 0000:00:01.2
alice# [ 0.644113] hub 1-0:1.0: USB hub found
carol# [ 0.567542] SCSI subsystem initialized
alice# [ 0.644358] hub 1-0:1.0: 2 ports detected
carol# [ 0.569637] ACPI: bus type USB registered
alice# [ 0.646344] scsi host0: ata_piix
alice# [ 0.646687] scsi host1: ata_piix
alice# [ 0.646976] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc140 irq 14
alice# [ 0.647395] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc148 irq 15
carol# [ 0.573674] usbcore: registered new interface driver usbfs
carol# [ 0.574033] usbcore: registered new interface driver hub
carol# [ 0.577042] usbcore: registered new device driver usb
moon# [ 0.489107] Freeing initrd memory: 6364K
moon# [ 0.489419] Scanning for low memory corruption every 60 seconds
moon# [ 0.489913] audit: initializing netlink subsys (disabled)
moon# [ 0.490263] audit: type=2000 audit(1504163494.974:1): initialized
alice# [ 0.659147] ACPI: PCI Interrupt Link [LNKA] enabled at IRQ 10
moon# [ 0.490872] workingset: timestamp_bits=40 max_order=17 bucket_order=0
moon# [ 0.492225] zbud: loaded
moon# [ 0.492650] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251)
moon# [ 0.493274] io scheduler noop registered
moon# [ 0.493602] io scheduler deadline registered
moon# [ 0.493981] io scheduler cfq registered (default)
moon# [ 0.494411] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
moon# [ 0.494850] pciehp: PCI Express Hot Plug Controller Driver version: 0.4
moon# [ 0.495466] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
carol# [ 0.591045] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
alice# [ 0.672564] ACPI: PCI Interrupt Link [LNKB] enabled at IRQ 11
carol# [ 0.598437] uhci_hcd: USB Universal Host Controller Interface driver
carol# [ 0.599438] ACPI: PCI Interrupt Link [LNKC] enabled at IRQ 10
moon# [ 0.518302] 00:05: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
carol# [ 0.611333] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
moon# [ 0.520465] brd: module loaded
moon# [ 0.520843] microcode: sig=0xf61, pf=0x1, revision=0x1
moon# [ 0.521302] microcode: Microcode Update Driver: v2.01 <tigran@aivazian.fsnet.co.uk>, Peter Oruba
moon# [ 0.522087] registered taskstats version 1
moon# [ 0.522437] zswap: loaded using pool lzo/zbud
moon# [ 0.522827] AppArmor: AppArmor sha1 policy hashing enabled
moon# [ 0.524335] Freeing unused kernel memory: 1308K
moon# [ 0.524695] Write protecting the kernel read-only data: 8192k
moon# [ 0.525269] Freeing unused kernel memory: 564K
moon# [ 0.525877] Freeing unused kernel memory: 184K
moon#
moon# <<< NixOS Stage 1 >>>
moon#
moon# loading module virtio_balloon...
moon# loading module virtio_console...
moon# loading module virtio_rng...
moon# loading module dm_mod...
carol# [ 0.636241] uhci_hcd 0000:00:01.2: UHCI Host Controller
carol# [ 0.636688] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1
carol# [ 0.637291] uhci_hcd 0000:00:01.2: detected 2 ports
carol# [ 0.637761] uhci_hcd 0000:00:01.2: irq 11, io base 0x0000c080
carol# [ 0.638274] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001
carol# [ 0.638827] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
carol# [ 0.639424] usb usb1: Product: UHCI Host Controller
carol# [ 0.639824] usb usb1: Manufacturer: Linux 4.9.45 uhci_hcd
moon# [ 0.547512] device-mapper: ioctl: 4.35.0-ioctl (2016-06-23) initialised: dm-devel@redhat.com
carol# [ 0.640255] usb usb1: SerialNumber: 0000:00:01.2
moon# running udev...
carol# [ 0.640842] hub 1-0:1.0: USB hub found
carol# [ 0.641157] hub 1-0:1.0: 2 ports detected
moon# [ 0.550173] systemd-udevd[99]: starting version 234
carol# [ 0.642964] scsi host0: ata_piix
carol# [ 0.643353] scsi host1: ata_piix
carol# [ 0.643716] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc140 irq 14
carol# [ 0.644261] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc148 irq 15
carol# [ 0.656356] ACPI: PCI Interrupt Link [LNKA] enabled at IRQ 10
alice# [ 0.734109] 9pnet: Installing 9P2000 support
moon# [ 0.571040] rtc_cmos 00:00: RTC can wake from S4
moon# [ 0.575212] rtc_cmos 00:00: rtc core: registered rtc_cmos as rtc0
moon# [ 0.575670] rtc_cmos 00:00: alarms up to one day, y3k, 114 bytes nvram, hpet irqs
carol# [ 0.668730] ACPI: PCI Interrupt Link [LNKB] enabled at IRQ 11
moon# [ 0.576957] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
moon# [ 0.577894] serio: i8042 KBD port at 0x60,0x64 irq 1
moon# [ 0.590993] serio: i8042 AUX port at 0x60,0x64 irq 12
moon# [ 0.606041] SCSI subsystem initialized
moon# [ 0.613644] ACPI: bus type USB registered
moon# [ 0.613938] usbcore: registered new interface driver usbfs
moon# [ 0.619072] usbcore: registered new interface driver hub
moon# [ 0.621071] usbcore: registered new device driver usb
moon# [ 0.626795] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
moon# [ 0.630024] ACPI: PCI Interrupt Link [LNKC] enabled at IRQ 10
carol# [ 0.727405] 9pnet: Installing 9P2000 support
moon# [ 0.638866] uhci_hcd: USB Universal Host Controller Interface driver
alice# [ 0.812102] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100
alice# [ 0.812880] ata2.00: configured for MWDMA2
alice# [ 0.813577] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5
moon# [ 0.658082] scsi host0: ata_piix
moon# [ 0.658785] scsi host1: ata_piix
moon# [ 0.659027] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc160 irq 14
moon# [ 0.659445] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc168 irq 15
alice# [ 0.829149] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray
alice# [ 0.829785] cdrom: Uniform CD-ROM driver Revision: 3.20
moon# [ 0.672438] uhci_hcd 0000:00:01.2: UHCI Host Controller
moon# [ 0.672758] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1
moon# [ 0.673242] uhci_hcd 0000:00:01.2: detected 2 ports
moon# [ 0.673623] uhci_hcd 0000:00:01.2: irq 11, io base 0x0000c080
moon# [ 0.674053] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001
moon# [ 0.674485] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
moon# [ 0.674945] usb usb1: Product: UHCI Host Controller
moon# [ 0.675416] usb usb1: Manufacturer: Linux 4.9.45 uhci_hcd
moon# [ 0.675746] usb usb1: SerialNumber: 0000:00:01.2
moon# [ 0.676654] hub 1-0:1.0: USB hub found
moon# [ 0.676910] hub 1-0:1.0: 2 ports detected
moon# [ 0.703635] ACPI: PCI Interrupt Link [LNKA] enabled at IRQ 10
alice# [ 0.876301] random: fast init done
carol# [ 0.802148] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100
carol# [ 0.802878] ata2.00: configured for MWDMA2
carol# [ 0.803443] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5
moon# [ 0.718892] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
carol# [ 0.819007] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray
carol# [ 0.819530] cdrom: Uniform CD-ROM driver Revision: 3.20
moon# [ 0.729335] ACPI: PCI Interrupt Link [LNKB] enabled at IRQ 11
carol# [ 0.831832] random: fast init done
alice# [ 0.955731] usb 1-1: new full-speed USB device number 2 using uhci_hcd
alice# kbd_mode: KDSKBMODE: Inappropriate ioctl for device
alice# starting device mapper and LVM...
%moon# [ 0.803458] 9pnet: Installing 9P2000 support
alice# [ 0.977389] clocksource: Switched to clocksource acpi_pm
alice# mke2fs 1.43.4 (31-Jan-2017)
alice# Creating filesystem with 131072 4k blocks and 32768 inodes
alice# Filesystem UUID: 375b4a64-9265-4097-a4a0-96de6f5faa53
alice# Superblock backups stored on blocks:
alice# 32768, 98304
alice#
alice# Allocating group tables: done
alice# Writing inode tables: done
alice# Creating journal (4096 blocks): done
moon# [ 0.820575] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100
moon# [ 0.821230] ata2.00: configured for MWDMA2
moon# [ 0.821783] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5
moon# [ 0.837467] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray
moon# [ 0.838075] cdrom: Uniform CD-ROM driver Revision: 3.20
carol# [ 0.953686] usb 1-1: new full-speed USB device number 2 using uhci_hcd
carol# kbd_mode: KDSKBMODE: Inappropriate ioctl for device
carol# starting device mapper and LVM...
%moon# [ 0.884710] random: fast init done
carol# [ 0.977879] clocksource: Switched to clocksource acpi_pm
carol# mke2fs 1.43.4 (31-Jan-2017)
carol# Creating filesystem with 131072 4k blocks and 32768 inodes
carol# Filesystem UUID: 6b39b1e7-39af-49d3-b8bc-e57370677795
carol# Superblock backups stored on blocks:
carol# 32768, 98304
carol#
carol# Allocating group tables: done
carol# Writing inode tables: done
carol# Creating journal (4096 blocks): done
alice# Writing superblocks and filesystem accounting information: done
alice#
alice# checking /dev/vda...
alice# fsck (busybox 1.27.2)
alice# [fsck.ext4 (1) -- /mnt-root/] fsck.ext4 -a /dev/vda
alice# /dev/vda: clean, 11/32768 files, 6353/131072 blocks
alice# [ 1.109080] usb 1-1: New USB device found, idVendor=0627, idProduct=0001
alice# [ 1.109919] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=5
alice# [ 1.110807] usb 1-1: Product: QEMU USB Tablet
alice# [ 1.111331] usb 1-1: Manufacturer: QEMU
alice# [ 1.111812] usb 1-1: SerialNumber: 42
alice# mounting /dev/vda on /...
alice# [ 1.123935] hidraw: raw HID events driver (C) Jiri Kosina
alice# [ 1.138916] usbcore: registered new interface driver usbhid
alice# [ 1.139251] usbhid: USB HID core driver
alice# [ 1.140787] 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
alice# [ 1.141545] 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
moon# [ 0.988110] usb 1-1: new full-speed USB device number 2 using uhci_hcd
moon# kbd_mode: KDSKBMODE: Inappropriate ioctl for device
moon# starting device mapper and LVM...
%moon# [ 0.996860] clocksource: Switched to clocksource acpi_pm
moon# mke2fs 1.43.4 (31-Jan-2017)
alice# [ 1.168817] EXT4-fs (vda): mounted filesystem with ordered data mode. Opts: (null)
moon# Creating filesystem with 131072 4k blocks and 32768 inodes
moon# Filesystem UUID: a159b5a8-3006-4040-9f14-a147d962cee8
moon# Superblock backups stored on blocks:
moon# 32768, 98304
moon#
alice# mounting store on /nix/.ro-store...
moon# Allocating group tables: done
moon# Writing inode tables: done
alice# [ 1.175070] FS-Cache: Loaded
alice# [ 1.177628] 9p: Installing v9fs 9p2000 file system support
moon# Creating journal (4096 blocks): done
alice# [ 1.178456] FS-Cache: Netfs '9p' registered for caching
alice# mounting tmpfs on /nix/.rw-store...
carol# Writing superblocks and filesystem accounting information: done
carol#
alice# mounting shared on /tmp/shared...
alice# mounting xchg on /tmp/xchg...
carol# [ 1.109281] usb 1-1: New USB device found, idVendor=0627, idProduct=0001
carol# [ 1.109775] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=5
carol# [ 1.110240] usb 1-1: Product: QEMU USB Tablet
carol# [ 1.110526] usb 1-1: Manufacturer: QEMU
carol# [ 1.110810] usb 1-1: SerialNumber: 42
alice# mounting overlay filesystem on /nix/store...
carol# checking /dev/vda...
carol# fsck (busybox 1.27.2)
carol# [fsck.ext4 (1) -- /mnt-root/] fsck.ext4 -a /dev/vda
carol# [ 1.120921] hidraw: raw HID events driver (C) Jiri Kosina
carol# /dev/vda: clean, 11/32768 files, 6353/131072 blocks
carol# [ 1.128922] usbcore: registered new interface driver usbhid
carol# [ 1.129331] usbhid: USB HID core driver
carol# [ 1.130757] 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
carol# [ 1.131565] 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
carol# mounting /dev/vda on /...
carol# [ 1.187287] EXT4-fs (vda): mounted filesystem with ordered data mode. Opts: (null)
carol# mounting store on /nix/.ro-store...
alice#
alice# <<< NixOS Stage 2 >>>
alice#
carol# [ 1.194027] FS-Cache: Loaded
carol# [ 1.197275] 9p: Installing v9fs 9p2000 file system support
carol# [ 1.198438] FS-Cache: Netfs '9p' registered for caching
carol# mounting tmpfs on /nix/.rw-store...
moon# Writing superblocks and filesystem accounting information: done
moon#
carol# mounting shared on /tmp/shared...
carol# mounting xchg on /tmp/xchg...
moon# checking /dev/vda...
moon# fsck (busybox 1.27.2)
moon# [fsck.ext4 (1) -- /mnt-root/] fsck.ext4 -a /dev/vda
alice# [ 1.284772] EXT4-fs (vda): re-mounted. Opts: (null)
carol# mounting overlay filesystem on /nix/store...
alice# [ 1.285627] booting system configuration /nix/store/fls53cd45966dq403iqvj0cb04qk1zn5-nixos-system-alice-17.09.git.b1bab8c
moon# /dev/vda: clean, 11/32768 files, 6353/131072 blocks
moon# mounting /dev/vda on /...
moon# [ 1.140188] usb 1-1: New USB device found, idVendor=0627, idProduct=0001
moon# [ 1.140857] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=5
moon# [ 1.141569] usb 1-1: Product: QEMU USB Tablet
moon# [ 1.141996] usb 1-1: Manufacturer: QEMU
moon# [ 1.142416] usb 1-1: SerialNumber: 42
moon# [ 1.163145] hidraw: raw HID events driver (C) Jiri Kosina
moon# [ 1.174332] usbcore: registered new interface driver usbhid
moon# [ 1.174742] usbhid: USB HID core driver
moon# [ 1.176198] 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
moon# [ 1.177183] 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
moon# [ 1.186416] EXT4-fs (vda): mounted filesystem with ordered data mode. Opts: (null)
moon# mounting store on /nix/.ro-store...
carol#
carol# <<< NixOS Stage 2 >>>
carol#
moon# [ 1.194910] FS-Cache: Loaded
moon# [ 1.198100] 9p: Installing v9fs 9p2000 file system support
moon# [ 1.200606] FS-Cache: Netfs '9p' registered for caching
moon# mounting tmpfs on /nix/.rw-store...
alice# running activation script...
moon# mounting shared on /tmp/shared...
moon# mounting xchg on /tmp/xchg...
carol# [ 1.302399] EXT4-fs (vda): re-mounted. Opts: (null)
carol# [ 1.303305] booting system configuration /nix/store/46pp0pn6wh7m5qngvlb17gxckxvj57i2-nixos-system-carol-17.09.git.b1bab8c
moon# mounting overlay filesystem on /nix/store...
carol# running activation script...
moon#
moon# <<< NixOS Stage 2 >>>
moon#
alice# [ 1.483755] tsc: Refined TSC clocksource calibration: 2793.642 MHz
alice# [ 1.484156] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2844ca3f242, max_idle_ns: 440795202126 ns
moon# [ 1.329945] EXT4-fs (vda): re-mounted. Opts: (null)
moon# [ 1.331210] booting system configuration /nix/store/yvvvfxb627dfc12h8nqgr4ryq1zaggpb-nixos-system-moon-17.09.git.b1bab8c
carol# [ 1.481736] tsc: Refined TSC clocksource calibration: 2793.645 MHz
carol# [ 1.482352] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2844cd69ed4, max_idle_ns: 440795236303 ns
alice# setting up /etc...
moon# running activation script...
moon# [ 1.500111] tsc: Refined TSC clocksource calibration: 2793.640 MHz
moon# [ 1.500537] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2844c8a9bfc, max_idle_ns: 440795267508 ns
carol# setting up /etc...
moon# setting up /etc...
alice# Initializing machine ID from random generator.
carol# Initializing machine ID from random generator.
moon# Initializing machine ID from random generator.
alice# [ 2.273386] random: crng init done
carol# [ 2.270499] random: crng init done
moon# [ 2.301769] random: crng init done
alice# starting systemd...
alice# [ 2.567542] NET: Registered protocol family 10
alice# [ 2.571610] ip_tables: (C) 2000-2006 Netfilter Core Team
alice# [ 2.574711] systemd[1]: systemd 234 running in system mode. (+PAM +AUDIT -SELINUX +IMA +APPARMOR -SMACK -SYSVINIT +UTMP -LIBCRYPTSETUP +GCRYPT -GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID -ELFUTILS +KMOD -IDN2 -IDN default-hierarchy=hybrid)
alice# [ 2.576006] systemd[1]: Detected virtualization kvm.
alice# [ 2.576321] systemd[1]: Detected architecture x86-64.
alice# [ 2.577087] systemd[1]: Set hostname to <alice>.
alice# [ 2.591950] systemd-fstab-generator[461]: Checking was requested for "store", but it is not a device.
alice# [ 2.593276] systemd-fstab-generator[461]: Checking was requested for "shared", but it is not a device.
alice# [ 2.595726] systemd-fstab-generator[461]: Checking was requested for "xchg", but it is not a device.
carol# starting systemd...
carol# [ 2.592756] NET: Registered protocol family 10
carol# [ 2.597531] ip_tables: (C) 2000-2006 Netfilter Core Team
carol# [ 2.601705] systemd[1]: systemd 234 running in system mode. (+PAM +AUDIT -SELINUX +IMA +APPARMOR -SMACK -SYSVINIT +UTMP -LIBCRYPTSETUP +GCRYPT -GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID -ELFUTILS +KMOD -IDN2 -IDN default-hierarchy=hybrid)
carol# [ 2.603821] systemd[1]: Detected virtualization kvm.
carol# [ 2.604340] systemd[1]: Detected architecture x86-64.
carol# [ 2.605440] systemd[1]: Set hostname to <carol>.
moon# starting systemd...
carol# [ 2.623520] systemd-fstab-generator[479]: Checking was requested for "store", but it is not a device.
carol# [ 2.624869] systemd-fstab-generator[479]: Checking was requested for "shared", but it is not a device.
carol# [ 2.628099] systemd-fstab-generator[479]: Checking was requested for "xchg", but it is not a device.
alice# [ 2.770410] systemd[1]: Listening on Journal Socket (/dev/log).
alice# [ 2.771076] systemd[1]: Listening on udev Kernel Socket.
alice# [ 2.771629] systemd[1]: Listening on /dev/initctl Compatibility Named Pipe.
alice# [ 2.772315] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
alice# [ 2.773077] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
alice# [ 2.773854] systemd[1]: Reached target Swap.
moon# [ 2.612515] NET: Registered protocol family 10
moon# [ 2.618321] ip_tables: (C) 2000-2006 Netfilter Core Team
moon# [ 2.622803] systemd[1]: systemd 234 running in system mode. (+PAM +AUDIT -SELINUX +IMA +APPARMOR -SMACK -SYSVINIT +UTMP -LIBCRYPTSETUP +GCRYPT -GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID -ELFUTILS +KMOD -IDN2 -IDN default-hierarchy=hybrid)
moon# [ 2.624673] systemd[1]: Detected virtualization kvm.
moon# [ 2.625111] systemd[1]: Detected architecture x86-64.
moon# [ 2.626504] systemd[1]: Set hostname to <moon>.
moon# [ 2.648748] systemd-fstab-generator[471]: Checking was requested for "store", but it is not a device.
alice# [ 2.818314] EXT4-fs (vda): re-mounted. Opts: (null)
moon# [ 2.650241] systemd-fstab-generator[471]: Checking was requested for "shared", but it is not a device.
moon# [ 2.651553] systemd-fstab-generator[471]: Checking was requested for "xchg", but it is not a device.
alice# [ 2.828874] audit: type=1130 audit(1504163496.851:2): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=kmod-static-nodes comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
alice# [ 2.834820] loop: module loaded
alice# [ 2.839164] audit: type=1130 audit(1504163496.861:3): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-remount-fs comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
alice# [ 2.879880] audit: type=1127 audit(1504163496.902:4): pid=488 uid=0 auid=4294967295 ses=4294967295 msg=' comm="systemd-update-utmp" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd-update-utmp" hostname=? addr=? terminal=? res=success'
alice# [ 2.891752] audit: type=1130 audit(1504163496.913:5): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-random-seed comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
carol# [ 2.830567] systemd[1]: Listening on Journal Socket.
carol# [ 2.831007] systemd[1]: Reached target Swap.
carol# [ 2.831370] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
carol# [ 2.831999] systemd[1]: Listening on Journal Socket (/dev/log).
carol# [ 2.832463] systemd[1]: Reached target Remote File Systems.
carol# [ 2.833019] systemd[1]: Listening on Journal Audit Socket.
carol# [ 2.873760] EXT4-fs (vda): re-mounted. Opts: (null)
carol# [ 2.898639] audit: type=1130 audit(1504163496.919:2): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=kmod-static-nodes comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
alice# [ 2.924005] audit: type=1130 audit(1504163496.946:6): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-update-utmp comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
carol# [ 2.902022] loop: module loaded
carol# [ 2.909155] audit: type=1130 audit(1504163496.930:3): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-remount-fs comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
alice# [ 2.924276] audit: type=1130 audit(1504163496.946:7): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
alice# [ 2.948408] audit: type=1130 audit(1504163496.970:8): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-modules-load comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
alice# [ 2.981991] audit: type=1130 audit(1504163497.004:9): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-journal-catalog-update comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
alice# [ 2.984731] audit: type=1130 audit(1504163497.006:10): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-sysctl comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
moon# [ 2.861390] systemd[1]: Listening on udev Kernel Socket.
moon# [ 2.862109] systemd[1]: Listening on /dev/initctl Compatibility Named Pipe.
moon# [ 2.863029] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
moon# [ 2.864019] systemd[1]: Listening on Journal Audit Socket.
moon# [ 2.864741] systemd[1]: Reached target Security Keys.
moon# [ 2.865502] systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount.
alice# [ 3.039961] ip6_tables: (C) 2000-2006 Netfilter Core Team
moon# [ 2.908794] EXT4-fs (vda): re-mounted. Opts: (null)
moon# [ 2.920628] audit: type=1130 audit(1504163496.923:2): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=kmod-static-nodes comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
moon# [ 2.931910] loop: module loaded
carol# [ 2.961193] audit: type=1127 audit(1504163496.982:4): pid=507 uid=0 auid=4294967295 ses=4294967295 msg=' comm="systemd-update-utmp" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd-update-utmp" hostname=? addr=? terminal=? res=success'
moon# [ 2.940339] audit: type=1130 audit(1504163496.942:3): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-remount-fs comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
moon# [ 2.945889] nf_conntrack version 0.5.0 (3072 buckets, 12288 max)
carol# [ 2.965050] audit: type=1130 audit(1504163496.986:5): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-random-seed comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
carol# [ 2.972495] audit: type=1130 audit(1504163496.993:6): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
carol# [ 2.980908] audit: type=1130 audit(1504163497.002:7): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-update-utmp comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
moon# [ 2.975408] audit: type=1127 audit(1504163496.977:4): pid=498 uid=0 auid=4294967295 ses=4294967295 msg=' comm="systemd-update-utmp" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd-update-utmp" hostname=? addr=? terminal=? res=success'
carol# [ 2.998613] audit: type=1130 audit(1504163497.019:8): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-modules-load comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
carol# [ 3.033626] audit: type=1130 audit(1504163497.054:9): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-journal-catalog-update comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
carol# [ 3.038453] audit: type=1130 audit(1504163497.059:10): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-sysctl comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
alice# [ 3.169112] systemd-journald[470]: Received request to flush runtime journal from PID 1
carol# [ 3.095416] ip6_tables: (C) 2000-2006 Netfilter Core Team
moon# [ 2.998097] audit: type=1130 audit(1504163496.999:5): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-random-seed comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
moon# [ 3.004791] audit: type=1130 audit(1504163497.007:6): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-update-utmp comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
moon# [ 3.004949] audit: type=1130 audit(1504163497.007:7): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
moon# [ 3.040287] audit: type=1130 audit(1504163497.042:8): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-journal-catalog-update comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
moon# [ 3.055104] audit: type=1130 audit(1504163497.056:9): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-modules-load comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
moon# [ 3.070803] audit: type=1130 audit(1504163497.072:10): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-sysctl comm="systemd" exe="/nix/store/4vf9y0c8qkzcixq1x0dky37f7blx1qxh-systemd-234/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
moon# [ 3.121433] ip6_tables: (C) 2000-2006 Netfilter Core Team
carol# [ 3.038435] systemd-modules-load[490]: Inserted module 'cpufreq_ondemand'
carol# [ 3.051679] nscd[558]: 558 monitoring file `/etc/passwd` (1)
carol# [ 3.229043] systemd-journald[484]: Received request to flush runtime journal from PID 1
alice# [ 3.183326] systemd-modules-load[466]: Inserted module 'cpufreq_ondemand'
alice# [ 3.185292] nscd[566]: 566 monitoring file `/etc/passwd` (1)
alice# [ 3.189318] systemd-modules-load[466]: Inserted module 'loop'
alice# [ 3.194849] nscd[566]: 566 monitoring directory `/etc` (2)
alice# [ 3.200581] systemd-modules-load[466]: Inserted module 'snd_pcm_oss'
alice# [ 3.201246] nscd[566]: 566 monitoring file `/etc/group` (3)
alice# [ 3.203362] systemd-modules-load[466]: Failed to find module 'gcov-proc'
alice# [ 3.205677] nscd[566]: 566 monitoring directory `/etc` (2)
alice# [ 3.209437] systemd-udevd[492]: Specified group 'kvm' unknown
alice# [ 3.213455] nscd[566]: 566 monitoring file `/etc/hosts` (4)
alice# [ 3.388339] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3
alice# [ 3.219426] systemd[ 3.391660] ACPI: Power Button [PWRF]
alice# [1]: Starting Flush Journal to Persistent Storage...
alice# [ 3.224855] nscd[566]: 566 monitoring directory `/etc` (2)
alice# [ 3.230974] systemd[1]: Reached target System Initialization.
alice# [ 3.235725] nscd[566]: 566 monitoring file `/etc/resolv.conf` (5)
alice# [ 3.241908] systemd[1]: Listening on D-Bus System Message Bus Socket.
alice# [ 3.246027] nscd[566]: 566 monitoring directory `/etc` (2)
alice# [ 3.251338] systemd[1]: Started Daily Cleanup of Temporary Directories.
alice# [ 3.253628] systemd[1]: Reached target Timers.
alice# [ 3.256902] systemd[1]: Listening on Nix Daemon Socket.
alice# [ 3.261723] systemd[1]: Reached target Sockets.
alice# [ 3.266523] systemd[1]: Reached target Basic System.
moon# [ 3.273349] systemd-journald[481]: Received request to flush runtime journal from PID 1
alice# [ 3.272119] systemd[1]: Starting Kernel Auditing...
carol# [ 3.196232] systemd-modules-load[490]: Inserted module 'loop'
alice# [ 3.445335] parport_pc 00:04: reported by Plug and Play ACPI
alice# [ 3.445821] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]
alice# [ 3.274910] systemd[1]: Starting Name Service Cache Daemon...
alice# [ 3.277317] systemd[1]: Starting Store Sound Card State...
carol# [ 3.206122] nscd[558]: 558 monitoring directory `/etc` (2)
alice# [ 3.281406] 18f7jhsyjkq7d0aaygnm7jra31776wlw-audit-disable[545]: No rules
alice# [ 3.285988] systemd[1]: Started Setup Virtual Console.
carol# [ 3.211443] systemd-modules-load[490]: Inserted module 'snd_pcm_oss'
carol# [ 3.216239] nscd[558]: 558 monitoring file `/etc/group` (3)
alice# [ 3.291129] systemd[1]: Started Store Sound Card State.
carol# [ 3.218221] systemd-modules-load[490]: Failed to find module 'gcov-proc'
carol# [ 3.220228] nscd[558]: 558 monitoring directory `/etc` (2)
carol# [ 3.221234] systemd-udevd[510]: Specified group 'kvm' unknown
alice# [ 3.295592] systemd[1]: Started Kernel Auditing.
carol# [ 3.225380] nscd[558]: 558 monitoring file `/etc/hosts` (4)
alice# [ 3.300148] systemd[1]: Started Name Service Cache Daemon.
carol# [ 3.228855] systemd[1]: Reached target System Initialization.
alice# [ 3.306979] systemd[1]: Reached target Host and Network Name Lookups.
carol# [ 3.235692] nscd[558]: 558 monitoring directory `/etc` (2)
alice# [ 3.312119] systemd[1]: Reached target User and Group Name Lookups.
carol# [ 3.239115] systemd[1]: Started Daily Cleanup of Temporary Directories.
alice# [ 3.316843] systemd[1]: Starting Login Service...
carol# [ 3.243825] nscd[558]: 558 monitoring file `/etc/resolv.conf` (5)
carol# [ 3.247616] systemd[ 3.418373] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3
carol# [1]: Reached target Timers.
alice# [ 3.322139] systemd[1]: Started D-Bus System Message Bus.
carol# [ 3.420400] ACPI: Power Button [PWRF]
alice# [ 3.326531] systemd-logind[583]: New seat seat0.
carol# [ 3.253754] nscd[558]: 558 monitoring directory `/etc` (2)
alice# [ 3.330364] systemd[1]: Started Login Service.
carol# [ 3.256873] systemd[1]: Listening on D-Bus System Message Bus Socket.
alice# [ 3.333788] systemd[1]: Started Flush Journal to Persistent Storage.
alice# [ 3.336197] systemd[1]: Starting Create Volatile Files and Directories...
carol# [ 3.261799] systemd[1]: Listening on Nix Daemon Socket.
alice# [ 3.338359] systemd[1]: Started Create Volatile Files and Directories.
carol# [ 3.264413] systemd[1]: Reached target Sockets.
alice# [ 3.511394] Floppy drive(s): fd0 is 2.88M AMI BIOS
carol# [ 3.266581] systemd[1]: Reached target Basic System.
carol# [ 3.269257] systemd[1]: Starting Name Service Cache Daemon...
carol# [ 3.273306] systemd[1]: Starting Kernel Auditing...
alice# [ 3.521730] nf_conntrack version 0.5.0 (3072 buckets, 12288 max)
alice# [ 3.524269] FDC 0 is a S82078B
carol# [ 3.277941] systemd[1]: Starting Store Sound Card State...
carol# [ 3.281366] systemd[1]: Starting Flush Journal to Persistent Storage...
carol# [ 3.283440] systemd[1]: Started Store Sound Card State.
carol# [ 3.285304] 18f7jhsyjkq7d0aaygnm7jra31776wlw-audit-disable[539]: No rules
carol# [ 3.287675] systemd[1]: Started Setup Virtual Console.
alice# [ 3.535919] Linux agpgart interface v0.103
carol# [ 3.291409] systemd[1]: Started Kernel Auditing.
carol# [ 3.465250] parport_pc 00:04: reported by Plug and Play ACPI
carol# [ 3.296771] systemd[1]: Started Name Service Cache Daemon.
carol# [ 3.304077] systemd[1]: Reached target User and Group Name Lookups.
carol# [ 3.311401] systemd[1]: Starting Login Service...
carol# [ 3.486571] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]
alice# [ 3.566551] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0
carol# [ 3.317794] systemd[1]: Reached target Host and Network Name Lookups.
carol# [ 3.325126] systemd[1]: Started D-Bus System Message Bus.
carol# [ 3.330433] systemd-logind[574]: New seat seat0.
carol# [ 3.332549] systemd[1]: Started Login Service.
carol# [ 3.334206] systemd[1]: Started Flush Journal to Persistent Storage.
carol# [ 3.335442] systemd[1]: Starting Create Volatile Files and Directories...
carol# [ 3.339272] systemd[1]: Started Create Volatile Files and Directories.
alice# [ 3.588158] mousedev: PS/2 mouse device common for all mice
carol# [ 3.516174] Floppy drive(s): fd0 is 2.88M AMI BIOS
carol# [ 3.529250] FDC 0 is a S82078B
moon# [ 3.253909] systemd-modules-load[479]: Inserted module 'cpufreq_ondemand'
moon# [ 3.254707] nscd[555]: 555 monitoring file `/etc/passwd` (1)
moon# [ 3.258093] systemd-modules-load[479]: Inserted module 'loop'
moon# [ 3.260585] nscd[555]: 555 monitoring directory `/etc` (2)
carol# [ 3.546511] Linux agpgart interface v0.103
moon# [ 3.266069] systemd-modules-load[479]: Inserted module 'nf_nat_ftp'
moon# [ 3.270082] nscd[555]: 555 monitoring file `/etc/group` (3)
moon# [ 3.270919] systemd-udevd[501]: Specified group 'kvm' unknown
moon# [ 3.272219] nscd[555]: 555 monitoring directory `/etc` (2)
moon# [ 3.274680] systemd-modules-load[479]: Inserted module 'snd_pcm_oss'
moon# [ 3.276724] nscd[555]: 555 monitoring file `/etc/hosts` (4)
alice# [ 3.463883] systemd[1]: Found device Virtio network device.
moon# [ 3.280373] systemd-modules-load[ 3.468974] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3
moon# [479]: Failed to find module 'gcov-proc'
moon# [ 3.470418] ACPI: Power Button [PWRF]
moon# [ 3.283286] nscd[555]: 555 monitoring directory `/etc` (2)
moon# [ 3.287565] systemd[1]: Starting Flush Journal to Persistent Storage...
moon# [ 3.290606] nscd[555]: 555 monitoring file `/etc/resolv.conf` (5)
carol# [ 3.576726] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0
moon# [ 3.295216] systemd[1]: Reached target System Initialization.
moon# [ 3.299630] nscd[555]: 555 monitoring directory `/etc` (2)
moon# [ 3.307084] systemd[1]: Started Daily Cleanup of Temporary Directories.
carol# [ 3.590461] nf_conntrack version 0.5.0 (3072 buckets, 12288 max)
moon# [ 3.312230] systemd[1]: Reached target Timers.
carol# [ 3.597110] mousedev: PS/2 mouse device common for all mice
moon# [ 3.316929] systemd[1]: Listening on Nix Daemon Socket.
alice# [ 3.505705] systemd[1]: Found device /dev/ttyS0.
moon# [ 3.321068] systemd[1]: Listening on D-Bus System Message Bus Socket.
moon# [ 3.323239] systemd[1]: Reached target Sockets.
moon# [ 3.325148] systemd[1]: Reached target Basic System.
alice# [ 3.511054] systemd[1]: Started Firewall.
alice# [ 3.511789] systemd[1]: Reached target Network (Pre).
moon# [ 3.328175] systemd[1]: Starting Name Service Cache Daemon...
alice# [ 3.514190] systemd[1]: Starting Address configuration of eth1...
moon# [ 3.333110] systemd[1]: Starting Store Sound Card State...
moon# [ 3.523711] parport_pc 00:04: reported by Plug and Play ACPI
moon# [ 3.336963] systemd[1]: Starting Kernel Auditing...
alice# [ 3.524396] systemd[1]: Starting Link configuration of eth1...
moon# [ 3.341279] systemd[1]: Started Store Sound Card State.
moon# [ 3.343354] 18f7jhsyjkq7d0aaygnm7jra31776wlw-audit-disable[545]: No rules
alice# [ 3.527268] network-addresses-eth1-start[655]: bringing up interface...
moon# [ 3.344078] systemd[1]: Started Kernel Auditing.
alice# [ 3.530099] systemd[1]: Started Link configuration of eth1.
moon# [ 3.346155] systemd[1]: Started Name Service Cache Daemon.
alice# [ 3.531897] network-link-eth1-start[656]: Configuring link...
alice# [ 3.534161] [ 3.706252] [drm] Initialized
alice# systemd[1]: Reached target All Network Interfaces (deprecated).
moon# [ 3.349594] systemd[1]: Reached target Host and Network Name Lookups.
moon# [ 3.540011] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]
moon# [ 3.354576] systemd[1]: Reached target User and Group Name Lookups.
carol# [ 3.468917] systemd[1]: Found device Virtio network device.
moon# [ 3.359075] systemd[1]: Starting Login Service...
moon# [ 3.362797] systemd[1]: Started D-Bus System Message Bus.
moon# [ 3.365762] systemd-logind[574]: New seat seat0.
alice# [ 3.552950] network-addresses-eth1-start[655]: added ip 192.168.0.1/24
alice# [ 3.556591] systemd[1]: Started Address configuration of eth1.
alice# [ 3.558592] systemd[1]: Starting Networking Setup...
moon# [ 3.372343] systemd[1]: Started Login Service.
moon# [ 3.376186] systemd[1]: Started Flush Journal to Persistent Storage.
moon# [ 3.380959] systemd[1]: Starting Create Volatile Files and Directories...
moon# [ 3.385365] systemd[1]: Started Create Volatile Files and Directories.
moon# [ 3.582632] Floppy drive(s): fd0 is 2.88M AMI BIOS
carol# [ 3.508955] systemd[1]: Found device /dev/ttyS0.
moon# [ 3.593422] Linux agpgart interface v0.103
moon# [ 3.595629] FDC 0 is a S82078B
carol# [ 3.695966] [drm] Initialized
moon# [ 3.628468] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0
alice# [ 3.813894] [drm] Found bochs VGA, ID 0xb0c0.
alice# [ 3.814332] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.
moon# [ 3.651564] mousedev: PS/2 mouse device common for all mice
alice# [ 3.821868] [TTM] Zone kernel: Available graphics memory: 188482 kiB
alice# [ 3.822971] [TTM] Initializing pool allocator
alice# [ 3.824097] [TTM] Initializing DMA pool allocator
carol# [ 3.591069] systemd[1]: Started Firewall.
carol# [ 3.592442] systemd[1]: Reached target Network (Pre).
carol# [ 3.593427] systemd[1]: Starting Address configuration of eth1...
carol# [ 3.602425] systemd[1]: Starting Link configuration of eth1...
carol# [ 3.608611] systemd[1]: Started Link configuration of eth1.
carol# [ 3.614432] network-addresses-eth1-start[654]: bringing up interface...
moon# [ 3.511430] systemd[1]: Found device Virtio network device.
carol# [ 3.792610] [drm] Found bochs VGA, ID 0xb0c0.
carol# [ 3.793098] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.
alice# [ 3.829571] fbcon: bochsdrmfb (fb0) is primary device
carol# [ 3.625777] systemd[1]: Reached target All Network Interfaces (deprecated).
alice# [ 3.872345] Console: switching to colour frame buffer device 128x48
carol# [ 3.630634] network-link-eth1-start[655]: Configuring link...
alice# [ 3.880569] bochs-drm 0000:00:02.0: fb0: bochsdrmfb frame buffer device
alice# [ 3.667494] systemd[1]: Found device /dev/hvc0.
alice# [ 3.712171] systemd[1]: Started backdoor.service.
alice# [ 3.885637] [drm] Initialized bochs-drm 1.0.0 20130925 for 0000:00:02.0 on minor 0
carol# [ 3.636650] network-addresses-eth1-start[654]: added ip 192.168.1.2/24
moon# [ 3.530671] systemd[1]: Found device Virtio network device.
carol# [ 3.643822] systemd[ 3.813867] [TTM] Zone kernel: Available graphics memory: 188482 kiB
carol# [ 3.814503] [TTM] Initializing pool allocator
carol# [1]: Started Address configuration of eth1.
alice# [ 3.720258] systemd[1]: Started Networking Setup.
carol# [ 3.647251] systemd[1]: Starting Networking Setup...
carol# [ 3.817888] [TTM] Initializing DMA pool allocator
alice# [ 3.728212] systemd[1]: Starting Extra networking commands....
alice# [ 3.733267] systemd[1]: Started Extra networking commands..
alice# [ 3.737519] systemd[1]: Reached target Network.
alice# [ 3.740716] systemd[1]: Reached target Network is Online.
alice# [ 3.743780] systemd[1]: Starting Permit User Sessions...
moon# [ 3.564465] systemd[1]: Found device /dev/ttyS0.
alice# [ 3.748177] systemd[1]: Started Permit User Sessions.
alice# [ 3.751329] systemd[1]: Started Getty on tty1.
alice# connecting to host...
alice# [ 3.755245] systemd[1]: Reached target Login Prompts.
alice# [ 3.758514] systemd[1]: Reached target Multi-User System.
moon# [ 3.767060] [drm] Initialized
alice# [ 3.763219] systemd[1]: Startup finished in 2.359s (kernel) + 1.355s (userspace) = 3.715s.
alice# sh: cannot set terminal process group (-1): Inappropriate ioctl for device
alice# sh: no job control in this shell
alice# [ 3.966921] ppdev: user-space parallel port driver
carol# [ 3.831271] fbcon: bochsdrmfb (fb0) is primary device
carol# [ 3.897575] Console: switching to colour frame buffer device 128x48
carol# [ 3.910282] bochs-drm 0000:00:02.0: fb0: bochsdrmfb frame buffer device
carol# [ 3.673574] systemd[1]: Found device /dev/hvc0.
carol# [ 3.742726] systemd[1]: Started backdoor.service.
carol# [ 3.914629] [drm] Initialized bochs-drm 1.0.0 20130925 for 0000:00:02.0 on minor 0
alice# [ 3.825583] systemd-logind[583]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)
moon# [ 3.830816] [drm] Found bochs VGA, ID 0xb0c0.
moon# [ 3.831242] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.
alice# [ 3.828174] systemd-logind[583]: Watching system buttons on /dev/input/event2 (Power Button)
carol# connecting to host...
moon# [ 3.836862] [TTM] Zone kernel: Available graphics memory: 188482 kiB
moon# [ 3.837541] [TTM] Initializing pool allocator
moon# [ 3.837943] [TTM] Initializing DMA pool allocator
carol# [ 3.764056] systemd[1]: Started Networking Setup.
carol# [ 3.764694] systemd[1]: Starting Extra networking commands....
carol: connected to guest root shell
carol# [ 3.775071] systemd[1]: Started Extra networking commands..
carol# [ 3.777886] systemd[1]: Reached target Network.
carol# [ 3.788478] sh: cannot set terminal process group (-1): Inappropriate ioctl for device
carol# systemd[1]: Starting Permit User Sessions...sh: no job control in this shell
carol#
carol# [ 3.796699] systemd[1]: Reached target Network is Online.
carol# [ 3.803225] systemd[1]: Starting strongSwan IPsec IKEv1/IKEv2 daemon using swanctl...
carol# [ 3.806433] systemd[1]: Started Permit User Sessions.
carol# [ 3.810949] systemd[1]: Started Getty on tty1.
carol# [ 3.814720] systemd[1]: Reached target Login Prompts.
carol# connect: Network is unreachable
carol: exit status 2
moon# [ 3.847388] fbcon: bochsdrmfb (fb0) is primary device
moon# [ 3.931538] Console: switching to colour frame buffer device 128x48
moon# [ 3.940995] bochs-drm 0000:00:02.0: fb0: bochsdrmfb frame buffer device
moon# [ 3.681066] systemd[1]: Found device /dev/hvc0.
moon# [ 3.945895] [drm] Initialized bochs-drm 1.0.0 20130925 for 0000:00:02.0 on minor 0
moon# [ 3.763031] systemd[1]: Started Firewall.
carol# [ 4.044838] ppdev: user-space parallel port driver
moon# [ 3.768763] systemd[1]: Reached target Network (Pre).
moon# [ 3.775458] network-addresses-eth1-start[661]: bringing up interface...
moon# [ 3.781158] network-addresses-eth1-start[661]: added ip 192.168.0.3/24
moon# [ 3.785892] systemd[1]: Starting Address configuration of eth1...
moon# [ 3.791109] network-addresses-eth2-start[662]: bringing up interface...
moon# [ 3.794586] network-addresses-eth2-start[662]: added ip 192.168.1.3/24connecting to host...
moon#
moon# [ 3.800107] systemd[1]: Starting Address configuration of eth2...
carol# [ 4.089389] NET: Registered protocol family 38
carol# [ 3.923393] systemd-logind[574]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)
moon# [ 3.807668] network-link-eth2-start[663]: Configuring link...
carol# [ 3.926156] systemd-logind[574]: Watching system buttons on /dev/input/event2 (Power Button)
moon# [ 3.815709] systemd[1]: Starting Link configuration of eth2...sh: cannot set terminal process group (-1): Inappropriate ioctl for device
moon# sh: no job control in this shell
moon#
moon# [ 3.821391] network-link-eth1-start[664]: Configuring link...
moon# [ 3.825344] systemd[1]: Starting Link configuration of eth1...
moon# [ 3.829794] systemd[1]: Started backdoor.service.
moon# [ 3.832271] systemd[1]: Started Link configuration of eth2.
moon# [ 3.832933] systemd[1]: Started Link configuration of eth1.
moon# [ 3.836508] systemd[1]: Started Address configuration of eth1.
moon# [ 3.838175] systemd[1]: Started Address configuration of eth2.
moon# [ 3.838839] systemd[1]: Starting Networking Setup...
moon# [ 3.841375] systemd[1]: Reached target All Network Interfaces (deprecated).
moon# [ 3.865685] systemd[1]: Started Networking Setup.
moon# [ 3.866302] systemd[1]: Starting Extra networking commands....
moon# [ 3.873051] systemd[1]: Started Extra networking commands..
moon# [ 3.873660] systemd[1]: Reached target Network.
moon# [ 3.875198] systemd[1]: Reached target Network is Online.
moon# [ 3.875789] systemd[1]: Starting strongSwan IPsec IKEv1/IKEv2 daemon using swanctl...
moon# [ 3.879922] systemd[1]: Starting Permit User Sessions...
moon# [ 3.889994] systemd[1]: Started Permit User Sessions.
moon# [ 3.891671] systemd[1]: Started Getty on tty1.
moon# [ 3.893564] systemd[1]: Reached target Login Prompts.
moon# [ 4.094798] ppdev: user-space parallel port driver
alice# [ 4.292424] input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input4
moon# [ 3.946197] systemd-logind[574]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)
moon# [ 3.950149] systemd-logind[574]: Watching system buttons on /dev/input/event2 (Power Button)
carol# [ 4.266702] camellia-x86_64: performance on this CPU would be suboptimal: disabling camellia-x86_64.
carol# [ 4.275952] camellia-x86_64: performance on this CPU would be suboptimal: disabling camellia-x86_64.
moon# [ 4.186109] NET: Registered protocol family 38
carol# [ 4.279908] camellia-x86_64: performance on this CPU would be suboptimal: disabling camellia-x86_64.
carol# [ 4.290232] input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input4
moon# [ 4.340309] camellia-x86_64: performance on this CPU would be suboptimal: disabling camellia-x86_64.
carol# [ 4.440743] CPU feature 'AVX registers' is not supported.
moon# [ 4.348499] camellia-x86_64: performance on this CPU would be suboptimal: disabling camellia-x86_64.
moon# [ 4.352354] camellia-x86_64: performance on this CPU would be suboptimal: disabling camellia-x86_64.
moon# [ 4.364736] input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input4
carol# [ 4.464293] blowfish-x86_64: performance on this CPU would be suboptimal: disabling blowfish-x86_64.
carol# [ 4.499296] CPU feature 'AVX registers' is not supported.
carol# [ 4.503679] CPU feature 'AVX registers' is not supported.
carol# [ 4.543471] twofish-x86_64-3way: performance on this CPU would be suboptimal: disabling twofish-x86_64-3way.
carol# [ 4.547513] twofish-x86_64-3way: performance on this CPU would be suboptimal: disabling twofish-x86_64-3way.
carol# [ 4.580944] NET: Registered protocol family 17
carol# [ 4.612976] Initializing XFRM netlink socket
carol# [ 4.449036] charon-systemd[714]: dnscert plugin is disabled
moon# [ 4.526511] CPU feature 'AVX registers' is not supported.
carol# [ 4.449950] charon-systemd[714]: using forecast interface eth1
carol# [ 4.450978] charon-systemd[714]: joining forecast multicast groups: 224.0.0.1,224.0.0.22,224.0.0.251,224.0.0.252,239.255.255.250
carol# [ 4.451988] charon-systemd[714]: loading ca certificates from '/nix/store/jdcviy5z25xamq35g8k9qbdpskkx3w9g-strongswan-5.6.0/etc/ipsec.d/cacerts'
carol# [ 4.454176] charon-systemd[714]: loading aa certificates from '/nix/store/jdcviy5z25xamq35g8k9qbdpskkx3w9g-strongswan-5.6.0/etc/ipsec.d/aacerts'
carol# [ 4.455727] charon-systemd[714]: loading ocsp signer certificates from '/nix/store/jdcviy5z25xamq35g8k9qbdpskkx3w9g-strongswan-5.6.0/etc/ipsec.d/ocspcerts'
carol# [ 4.457554] charon-systemd[714]: loading attribute certificates from '/nix/store/jdcviy5z25xamq35g8k9qbdpskkx3w9g-strongswan-5.6.0/etc/ipsec.d/acerts'
carol# [ 4.459179] charon-systemd[714]: loading crls from '/nix/store/jdcviy5z25xamq35g8k9qbdpskkx3w9g-strongswan-5.6.0/etc/ipsec.d/crls'
carol# [ 4.460593] charon-systemd[714]: loading secrets from '/nix/store/jdcviy5z25xamq35g8k9qbdpskkx3w9g-strongswan-5.6.0/etc/ipsec.secrets'
carol# [ 4.464260] charon-systemd[714]: opening triplet file /nix/store/jdcviy5z25xamq35g8k9qbdpskkx3w9g-strongswan-5.6.0/etc/ipsec.d/triplets.dat failed: No such file or directory
carol# [ 4.465932] charon-systemd[714]: no script for ext-auth script defined, disabled
carol# [ 4.467389] charon-systemd[714]: loaded plugins: charon-systemd charon-systemd unbound pkcs11 aes des rc2 sha2 sha1 md5 random nonce x509 revocation constraints acert pubkey pkcs1 pkcs7 pkcs8 pkcs12 pgp dnskey sshkey dnscert pem af-alg fips-prf gmp curve25519 chapoly xcbc cmac hmac attr kernel-netlink resolve socket-default connmark forecast farp stroke vici updown eap-identity eap-sim eap-sim-pcsc eap-aka eap-aka-3gpp2 eap-simaka-pseudonym eap-simaka-reauth eap-md5 eap-gtc eap-mschapv2 xauth-generic xauth-eap xauth-pam dhcp
carol# [ 4.470457] charon-systemd[714]: spawning 16 worker threads
moon# [ 4.551068] blowfish-x86_64: performance on this CPU would be suboptimal: disabling blowfish-x86_64.
carol# [ 4.486897] charon-systemd[714]: loaded IKE shared key with id 'ike-moon' for: '192.168.1.3'
carol# [ 4.488278] swanctl[922]: no authorities found, 0 unloaded
carol# [ 4.489081] swanctl[922]: no pools found, 0 unloaded
carol# [ 4.490065] charon-systemd[714]: added vici connection: home
carol# [ 4.491207] charon-systemd[714]: initiating 'home'
carol# [ 4.493971] charon-systemd[714]: initiating IKE_SA home[1] to 192.168.1.3
carol# [ 4.495593] charon-systemd[714]: generating IKE_SA_INIT request 0 [ SA KE No N(NATD_S_IP) N(NATD_D_IP) N(FRAG_SUP) N(HASH_ALG) N(REDIR_SUP) ]
carol# [ 4.497692] charon-systemd[714]: sending packet: from 192.168.1.2[500] to 192.168.1.3[500] (242 bytes)
carol# [ 4.500245] swanctl[922]: loaded ike secret 'ike-moon'
carol# [ 4.501128] swanctl[922]: loaded connection 'home'
carol# [ 4.502083] swanctl[922]: successfully loaded 1 connections, 0 unloaded
moon# [ 4.584278] CPU feature 'AVX registers' is not supported.
carol# [ 4.507558] systemd[1]: Started strongSwan IPsec IKEv1/IKEv2 daemon using swanctl.
carol# [ 4.508911] systemd[1]: Reached target Multi-User System.
carol# [ 4.510464] systemd[1]: Startup finished in 2.389s (kernel) + 2.117s (userspace) = 4.506s.
moon# [ 4.588572] CPU feature 'AVX registers' is not supported.
moon# [ 4.620855] twofish-x86_64-3way: performance on this CPU would be suboptimal: disabling twofish-x86_64-3way.
moon# [ 4.624346] twofish-x86_64-3way: performance on this CPU would be suboptimal: disabling twofish-x86_64-3way.
moon# [ 4.651553] NET: Registered protocol family 17
moon# [ 4.676873] Initializing XFRM netlink socket
moon# [ 4.493570] charon-systemd[727]: dnscert plugin is disabled
moon# [ 4.494450] charon-systemd[727]: using forecast interface eth1
moon# [ 4.495328] charon-systemd[727]: joining forecast multicast groups: 224.0.0.1,224.0.0.22,224.0.0.251,224.0.0.252,239.255.255.250
moon# [ 4.496281] charon-systemd[727]: loading ca certificates from '/nix/store/jdcviy5z25xamq35g8k9qbdpskkx3w9g-strongswan-5.6.0/etc/ipsec.d/cacerts'
moon# [ 4.497849] charon-systemd[727]: loading aa certificates from '/nix/store/jdcviy5z25xamq35g8k9qbdpskkx3w9g-strongswan-5.6.0/etc/ipsec.d/aacerts'
moon# [ 4.499208] charon-systemd[727]: loading ocsp signer certificates from '/nix/store/jdcviy5z25xamq35g8k9qbdpskkx3w9g-strongswan-5.6.0/etc/ipsec.d/ocspcerts'
moon# [ 4.500624] charon-systemd[727]: loading attribute certificates from '/nix/store/jdcviy5z25xamq35g8k9qbdpskkx3w9g-strongswan-5.6.0/etc/ipsec.d/acerts'
moon# [ 4.501878] charon-systemd[727]: loading crls from '/nix/store/jdcviy5z25xamq35g8k9qbdpskkx3w9g-strongswan-5.6.0/etc/ipsec.d/crls'
moon# [ 4.503048] charon-systemd[727]: loading secrets from '/nix/store/jdcviy5z25xamq35g8k9qbdpskkx3w9g-strongswan-5.6.0/etc/ipsec.secrets'
moon# [ 4.505953] charon-systemd[727]: opening triplet file /nix/store/jdcviy5z25xamq35g8k9qbdpskkx3w9g-strongswan-5.6.0/etc/ipsec.d/triplets.dat failed: No such file or directory
moon# [ 4.507783] charon-systemd[727]: no script for ext-auth script defined, disabled
moon# [ 4.508982] charon-systemd[727]: loaded plugins: charon-systemd charon-systemd unbound pkcs11 aes des rc2 sha2 sha1 md5 random nonce x509 revocation constraints acert pubkey pkcs1 pkcs7 pkcs8 pkcs12 pgp dnskey sshkey dnscert pem af-alg fips-prf gmp curve25519 chapoly xcbc cmac hmac attr kernel-netlink resolve socket-default connmark forecast farp stroke vici updown eap-identity eap-sim eap-sim-pcsc eap-aka eap-aka-3gpp2 eap-simaka-pseudonym eap-simaka-reauth eap-md5 eap-gtc eap-mschapv2 xauth-generic xauth-eap xauth-pam dhcp
moon# [ 4.511803] charon-systemd[727]: spawning 16 worker threads
moon# [ 4.528689] charon-systemd[727]: loaded IKE shared key with id 'ike-carol' for: '192.168.1.2'
moon# [ 4.529614] swanctl[934]: no authorities found, 0 unloaded
moon# [ 4.530320] swanctl[934]: no pools found, 0 unloaded
moon# [ 4.531145] charon-systemd[727]: added vici connection: rw
moon# [ 4.534425] swanctl[934]: loaded ike secret 'ike-carol'
moon# [ 4.534942] swanctl[934]: loaded connection 'rw'
moon# [ 4.535431] swanctl[934]: successfully loaded 1 connections, 0 unloaded
moon# [ 4.541689] systemd[1]: Started strongSwan IPsec IKEv1/IKEv2 daemon using swanctl.
moon# [ 4.542776] systemd[1]: Reached target Multi-User System.
moon# [ 4.544051] systemd[1]: Startup finished in 2.385s (kernel) + 2.155s (userspace) = 4.540s.
carol: running command: ping -c 1 alice
carol# connect: Network is unreachable
carol: exit status 2
carol: running command: ping -c 1 alice
carol# connect: Network is unreachable
carol: exit status 2
carol: running command: ping -c 1 alice
carol# connect: Network is unreachable
carol: exit status 2
carol: running command: ping -c 1 alice
carol# connect: Network is unreachable
carol: exit status 2
carol# [ 8.493553] charon-systemd[714]: retransmit 1 of request with message ID 0
carol# [ 8.494967] charon-systemd[714]: sending packet: from 192.168.1.2[500] to 192.168.1.3[500] (242 bytes)
moon# [ 8.384365] charon-systemd[727]: received packet: from 192.168.1.2[500] to 192.168.1.3[500] (242 bytes)
carol# [ 8.497917] charon-systemd[714]: received packet: from 192.168.1.3[500] to 192.168.1.2[500] (242 bytes)
moon# [ 8.386303] charon-systemd[727]: parsed IKE_SA_INIT request 0 [ SA KE No N(NATD_S_IP) N(NATD_D_IP) N(FRAG_SUP) N(HASH_ALG) N(REDIR_SUP) ]
moon# [ 8.388472] charon-systemd[727]: 192.168.1.2 is initiating an IKE_SA
carol# [ 8.499146] charon-systemd[714]: parsed IKE_SA_INIT response 0 [ SA KE No N(NATD_S_IP) N(NATD_D_IP) N(FRAG_SUP) N(HASH_ALG) N(MULT_AUTH) ]
carol# [ 8.500733] charon-systemd[714]: authentication of '192.168.1.2' (myself) with pre-shared key
moon# [ 8.389509] charon-systemd[727]: generating IKE_SA_INIT response 0 [ SA KE No N(NATD_S_IP) N(NATD_D_IP) N(FRAG_SUP) N(HASH_ALG) N(MULT_AUTH) ]
carol# [ 8.502141] charon-systemd[714]: establishing CHILD_SA home{1}
moon# [ 8.391747] charon-systemd[727]: sending packet: from 192.168.1.3[500] to 192.168.1.2[500] (242 bytes)
carol# [ 8.502950] charon-systemd[714]: generating IKE_AUTH request 1 [ IDi IDr AUTH SA TSi TSr N(MOBIKE_SUP) N(NO_ADD_ADDR) N(MULT_AUTH) N(EAP_ONLY) N(MSG_ID_SYN_SUP) ]
carol# [ 8.504479] charon-systemd[714]: sending packet: from 192.168.1.2[4500] to 192.168.1.3[4500] (256 bytes)
moon# [ 8.394044] charon-systemd[727]: received packet: from 192.168.1.2[4500] to 192.168.1.3[4500] (256 bytes)
moon# [ 8.395490] charon-systemd[727]: parsed IKE_AUTH request 1 [ IDi IDr AUTH SA TSi TSr N(MOBIKE_SUP) N(NO_ADD_ADDR) N(MULT_AUTH) N(EAP_ONLY) N(MSG_ID_SYN_SUP) ]
moon# [ 8.396892] charon-systemd[727]: looking for peer configs matching 192.168.1.3[192.168.1.3]...192.168.1.2[192.168.1.2]
moon# [ 8.398059] charon-systemd[727]: selected peer config 'rw'
moon# [ 8.399025] charon-systemd[727]: authentication of '192.168.1.2' with pre-shared key successful
moon# [ 8.399989] charon-systemd[727]: peer supports MOBIKE
moon# [ 8.400516] charon-systemd[727]: authentication of '192.168.1.3' (myself) with pre-shared key
moon# [ 8.401195] charon-systemd[727]: IKE_SA rw[1] established between 192.168.1.3[192.168.1.3]...192.168.1.2[192.168.1.2]
moon# [ 8.401978] charon-systemd[727]: scheduling rekeying in 12962s
moon# [ 8.402593] charon-systemd[727]: maximum IKE_SA lifetime 14402s
moon# [ 8.476320] charon-systemd[727]: CHILD_SA net{1} established with SPIs cfb2f186_i cee201b1_o and TS 192.168.0.0/24 === 192.168.1.2/32
moon# [ 8.505471] vpn[988]: + 192.168.1.2 192.168.1.2 -- 192.168.1.3 == 192.168.0.0/24
moon# [ 8.507445] charon-systemd[727]: generating IKE_AUTH response 1 [ IDr AUTH SA TSi TSr N(MOBIKE_SUP) N(ADD_4_ADDR) ]
moon# [ 8.508316] charon-systemd[727]: sending packet: from 192.168.1.3[4500] to 192.168.1.2[4500] (224 bytes)
carol# [ 8.620540] charon-systemd[714]: received packet: from 192.168.1.3[4500] to 192.168.1.2[4500] (224 bytes)
carol# [ 8.621423] charon-systemd[714]: parsed IKE_AUTH response 1 [ IDr AUTH SA TSi TSr N(MOBIKE_SUP) N(ADD_4_ADDR) ]
carol# [ 8.622206] charon-systemd[714]: authentication of '192.168.1.3' with pre-shared key successful
carol# [ 8.622899] charon-systemd[714]: IKE_SA home[1] established between 192.168.1.2[192.168.1.2]...192.168.1.3[192.168.1.3]
carol# [ 8.623815] charon-systemd[714]: scheduling rekeying in 13598s
carol# [ 8.624840] charon-systemd[714]: maximum IKE_SA lifetime 15038s
carol# [ 8.703775] charon-systemd[714]: CHILD_SA home{1} established with SPIs cee201b1_i cfb2f186_o and TS 192.168.1.2/32 === 192.168.0.0/24
carol# [ 8.733116] vpn[980]: + 192.168.1.3 192.168.0.0/24 == 192.168.1.3 -- 192.168.1.2
carol# [ 8.735041] charon-systemd[714]: peer supports MOBIKE
carol: running command: ping -c 1 alice
carol: exit status 0
collecting coverage data
carol: running command: test -e /sys/kernel/debug/gcov
carol: exit status 1
syncing
carol: running command: sync
carol: exit status 0
test script finished in 9.68s
cleaning up
killing alice (pid 19229)
killing carol (pid 19240)
killing moon (pid 19252)
vde_switch: vde_switch: EOF on stdin, cleaning up and exitingEOF on stdin, cleaning up and exiting
vde_switch: Could not remove ctl dir '/tmp/nix-build-vm-test-run-strongswan-swanctl.drv-0/vde1.ctl': Directory not emptyvde_switch:
Could not remove ctl dir '/tmp/nix-build-vm-test-run-strongswan-swanctl.drv-0/vde0.ctl': Directory not empty
/nix/store/i9ds8vrc95hk1y6ywd0hqbwr9vcvjc31-vm-test-run-strongswan-swanctl
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment