Skip to content

Instantly share code, notes, and snippets.

@thefloweringash

thefloweringash/log

Created July 22, 2019 04:48
Show Gist options
  • Save thefloweringash/56c12b8b2a670d962401c7a8fd2ad2e6 to your computer and use it in GitHub Desktop.
Save thefloweringash/56c12b8b2a670d962401c7a8fd2ad2e6 to your computer and use it in GitHub Desktop.
Download ZIP
nix-build nixos/release.nix -A tests.bittorrent.x86_64-linux
Raw
log
starting VDE switch for network 2
starting VDE switch for network 1
running the VM test script
starting all VMs
tracker: starting vm
tracker# Formatting '/build/vm-state-tracker/tracker.qcow2', fmt=qcow2 size=536870912 cluster_size=65536 lazy_refcounts=off refcount_bits=16
tracker: QEMU running (pid 598)
router: starting vm
router# Formatting '/build/vm-state-router/router.qcow2', fmt=qcow2 size=536870912 cluster_size=65536 lazy_refcounts=off refcount_bits=16
router: QEMU running (pid 610)
client1: starting vm
client1# Formatting '/build/vm-state-client1/client1.qcow2', fmt=qcow2 size=536870912 cluster_size=65536 lazy_refcounts=off refcount_bits=16
tracker# c[?7lSeaBIOS (version rel-1.12.1-0-ga5cab58e9a3f-prebuilt.qemu.org)
client1: QEMU running (pid 622)
client2: starting vm
client2# Formatting '/build/vm-state-client2/client2.qcow2', fmt=qcow2 size=536870912 cluster_size=65536 lazy_refcounts=off refcount_bits=16
tracker#
tracker#
tracker# iPXE (http://ipxe.org) 00:03.0 C980 PCI2.10 PnP PMM+17F90FD0+17EF0FD0 C980
tracker# Press Ctrl-B to configure iPXE (PCI 00:03.0)...
tracker#
tracker#
tracker#
tracker#
tracker# iPXE (http://ipxe.org) 00:08.0 CA80 PCI2.10 PnP PMM 17F90FD0 17EF0FD0 CA80
router# c[?7lSeaBIOS (version rel-1.12.1-0-ga5cab58e9a3f-prebuilt.qemu.org)
tracker# Press Ctrl-B to configure iPXE (PCI 00:08.0)...
tracker#
tracker#
tracker# Booting from ROM...
client2: QEMU running (pid 634)
(0.36 seconds)
router: waiting for unit ‘network-online.target’
router: running command: systemctl --no-pager show "network-online.target"
router: waiting for the VM to finish booting
client1# c[?7lSeaBIOS (version rel-1.12.1-0-ga5cab58e9a3f-prebuilt.qemu.org)
router#
router#
router# iPXE (http://ipxe.org) 00:03.0 C980 PCI2.10 PnP PMM+17F90F80+17EF0F80 C980
router# Press Ctrl-B to configure iPXE (PCI 00:03.0)...
router#
router#
router#
router#
router# iPXE (http://ipxe.org) 00:08.0 CA80 PCI2.10 PnP PMM 17F90F80 17EF0F80 CA80
router# Press Ctrl-B to configure iPXE (PCI 00:08.0)...
router#
router#
router#
router#
router# iPXE (http://ipxe.org) 00:09.0 CB80 PCI2.10 PnP PMM 17F90F80 17EF0F80 CB80
router# Press Ctrl-B to configure iPXE (PCI 00:09.0)...
router#
router#
router# Booting from ROM...
router# Probing EDD (edd=off to disable)... ok
client2# c[?7lSeaBIOS (version rel-1.12.1-0-ga5cab58e9a3f-prebuilt.qemu.org)
client1#
client1#
client1# iPXE (http://ipxe.org) 00:03.0 C980 PCI2.10 PnP PMM+17F90FD0+17EF0FD0 C980
client1# Press Ctrl-B to configure iPXE (PCI 00:03.0)...
client1#
client1#
client1#
client1#
client1# iPXE (http://ipxe.org) 00:08.0 CA80 PCI2.10 PnP PMM 17F90FD0 17EF0FD0 CA80
client1# Press Ctrl-B to configure iPXE (PCI 00:08.0)...
client1#
client1#
client2#
client2#
client2# iPXE (http://ipxe.org) 00:03.0 C980 PCI2.10 PnP PMM+17F90FD0+17EF0FD0 C980
client2# Press Ctrl-B to configure iPXE (PCI 00:03.0)...
client2#
client2#
client2#
client2#
client2# iPXE (http://ipxe.org) 00:08.0 CA80 PCI2.10 PnP PMM 17F90FD0 17EF0FD0 CA80
client1# Booting from ROM...
client2# Press Ctrl-B to configure iPXE (PCI 00:08.0)...
client2#
client2#
client2# Booting from ROM...
tracker# Probing EDD (edd=off to disable)... oc[?7lk
[ 0.000000] Linux version 4.19.59 (nixbld@localhost) (gcc version 7.4.0 (GCC)) #1-NixOS SMP Sun Jul 14 06:11:23 UTC 2019
tracker# [ 0.000000] Command line: console=ttyS0 panic=1 boot.panic_on_fail loglevel=7 net.ifnames=0 init=/nix/store/25fbd9dqrlifnxbifaqlh2ir6kkr0lsq-nixos-system-tracker-19.09.git.771985d/init regInfo=/nix/store/m7rzmz88yjz7c8fkjg9zmb1k2lgxplxb-closure-info/registration console=ttyS0
tracker# [ 0.000000] x86/fpu: x87 FPU will use FXSAVE
tracker# [ 0.000000] BIOS-provided physical RAM map:
tracker# [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
tracker# [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
tracker# [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
tracker# [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x0000000017fdbfff] usable
tracker# [ 0.000000] BIOS-e820: [mem 0x0000000017fdc000-0x0000000017ffffff] reserved
tracker# [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
tracker# [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
tracker# [ 0.000000] NX (Execute Disable) protection: active
tracker# [ 0.000000] SMBIOS 2.8 present.
tracker# [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.12.1-0-ga5cab58e9a3f-prebuilt.qemu.org 04/01/2014
tracker# [ 0.000000] Hypervisor detected: KVM
tracker# [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
tracker# [ 0.000000] kvm-clock: cpu 0, msr 11d52001, primary cpu clock
tracker# [ 0.000000] kvm-clock: using sched offset of 645712924 cycles
tracker# [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
tracker# [ 0.000003] tsc: Detected 3399.996 MHz processor
tracker# [ 0.001262] last_pfn = 0x17fdc max_arch_pfn = 0x400000000
tracker# [ 0.001295] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WC UC- UC
tracker# [ 0.007594] found SMP MP-table at [mem 0x000f5ab0-0x000f5abf]
tracker# [ 0.007613] Scanning 1 areas for low memory corruption
tracker# [ 0.007756] RAMDISK: [mem 0x17656000-0x17fcffff]
tracker# [ 0.007771] ACPI: Early table checksum verification disabled
tracker# [ 0.007816] ACPI: RSDP 0x00000000000F58D0 000014 (v00 BOCHS )
tracker# [ 0.007820] ACPI: RSDT 0x0000000017FE156F 000030 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001)
tracker# [ 0.007824] ACPI: FACP 0x0000000017FE144B 000074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001)
tracker# [ 0.007828] ACPI: DSDT 0x0000000017FE0040 00140B (v01 BOCHS BXPCDSDT 00000001 BXPC 00000001)
tracker# [ 0.007831] ACPI: FACS 0x0000000017FE0000 000040
tracker# [ 0.007833] ACPI: APIC 0x0000000017FE14BF 000078 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001)
tracker# [ 0.007836] ACPI: HPET 0x0000000017FE1537 000038 (v01 BOCHS BXPCHPET 00000001 BXPC 00000001)
tracker# [ 0.008181] No NUMA configuration found
tracker# [ 0.008182] Faking a node at [mem 0x0000000000000000-0x0000000017fdbfff]
tracker# [ 0.008185] NODE_DATA(0) allocated [mem 0x17fd8000-0x17fdbfff]
tracker# [ 0.008199] Zone ranges:
tracker# [ 0.008199] DMA [mem 0x0000000000001000-0x0000000000ffffff]
tracker# [ 0.008201] DMA32 [mem 0x0000000001000000-0x0000000017fdbfff]
tracker# [ 0.008201] Normal empty
tracker# [ 0.008202] Movable zone start for each node
tracker# [ 0.008203] Early memory node ranges
tracker# [ 0.008204] node 0: [mem 0x0000000000001000-0x000000000009efff]
tracker# [ 0.008205] node 0: [mem 0x0000000000100000-0x0000000017fdbfff]
tracker# [ 0.017701] Reserved but unavailable: 98 pages
tracker# [ 0.017704] Initmem setup node 0 [mem 0x0000000000001000-0x0000000017fdbfff]
tracker# [ 0.036638] ACPI: PM-Timer IO Port: 0x608
tracker# [ 0.036651] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
tracker# [ 0.036688] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
tracker# [ 0.036690] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
tracker# [ 0.036692] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
tracker# [ 0.036692] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
tracker# [ 0.036693] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
tracker# [ 0.036694] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
tracker# [ 0.036698] Using ACPI (MADT) for SMP configuration information
tracker# [ 0.036699] ACPI: HPET id: 0x8086a201 base: 0xfed00000
tracker# [ 0.036704] smpboot: Allowing 1 CPUs, 0 hotplug CPUs
tracker# [ 0.036722] PM: Registered nosave memory: [mem 0x00000000-0x00000fff]
tracker# [ 0.036724] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff]
tracker# [ 0.036725] PM: Registered nosave memory: [mem 0x000a0000-0x000effff]
tracker# [ 0.036727] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff]
tracker# [ 0.036729] [mem 0x18000000-0xfeffbfff] available for PCI devices
tracker# [ 0.036730] Booting paravirtualized kernel on KVM
tracker# [ 0.036733] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
tracker# [ 0.097529] random: get_random_bytes called from start_kernel+0x94/0x4ce with crng_init=0
tracker# [ 0.097537] setup_percpu: NR_CPUS:384 nr_cpumask_bits:384 nr_cpu_ids:1 nr_node_ids:1
tracker# [ 0.100099] percpu: Embedded 44 pages/cpu s142424 r8192 d29608 u2097152
tracker# [ 0.100121] KVM setup async PF for cpu 0
tracker# [ 0.100125] kvm-stealtime: cpu 0, msr 16c16180
tracker# [ 0.100129] Built 1 zonelists, mobility grouping on. Total pages: 96613
tracker# [ 0.100130] Policy zone: DMA32
tracker# [ 0.100131] Kernel command line: console=ttyS0 panic=1 boot.panic_on_fail loglevel=7 net.ifnames=0 init=/nix/store/25fbd9dqrlifnxbifaqlh2ir6kkr0lsq-nixos-system-tracker-19.09.git.771985d/init regInfo=/nix/store/m7rzmz88yjz7c8fkjg9zmb1k2lgxplxb-closure-info/registration console=ttyS0
tracker# [ 0.101094] Memory: 354272K/392680K available (10252K kernel code, 1137K rwdata, 1860K rodata, 1436K init, 812K bss, 38408K reserved, 0K cma-reserved)
tracker# [ 0.104191] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
tracker# [ 0.104200] Kernel/User page tables isolation: enabled
tracker# [ 0.104233] ftrace: allocating 28486 entries in 112 pages
tracker# [ 0.120715] rcu: Hierarchical RCU implementation.
tracker# [ 0.120718] rcu: RCU event tracing is enabled.
tracker# [ 0.120719] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.
tracker# [ 0.120720] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
tracker# [ 0.122555] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16
tracker# [ 0.128723] Console: colour VGA+ 80x25
tracker# [ 0.200942] console [ttyS0] enabled
tracker# [ 0.201420] ACPI: Core revision 20180810
tracker# [ 0.202152] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
tracker# [ 0.203404] APIC: Switch to symmetric I/O mode setup
tracker# [ 0.204309] x2apic enabled
tracker# [ 0.204957] Switched APIC routing to physical x2apic.
tracker# [ 0.206708] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
tracker# [ 0.207511] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x31024b3bec5, max_idle_ns: 440795366697 ns
tracker# [ 0.208868] Calibrating delay loop (skipped) preset value.. 6799.99 BogoMIPS (lpj=3399996)
tracker# [ 0.209859] pid_max: default: 32768 minimum: 301
tracker# [ 0.210876] Security Framework initialized
tracker# [ 0.211418] Yama: becoming mindful.
tracker# [ 0.211887] AppArmor: AppArmor initialized
tracker# [ 0.212894] Dentry cache hash table entries: 65536 (order: 7, 524288 bytes)
tracker# [ 0.213949] Inode-cache hash table entries: 32768 (order: 6, 262144 bytes)
tracker# [ 0.214876] Mount-cache hash table entries: 1024 (order: 1, 8192 bytes)
tracker# [ 0.215781] Mountpoint-cache hash table entries: 1024 (order: 1, 8192 bytes)
tracker# [ 0.217890] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
tracker# [ 0.218594] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
tracker# [ 0.218860] Spectre V2 : Mitigation: Full generic retpoline
tracker# [ 0.219858] Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch
tracker# [ 0.220858] Speculative Store Bypass: Vulnerable
tracker# [ 0.221903] MDS: Vulnerable: Clear CPU buffers attempted, no microcode
tracker# [ 0.229496] Freeing SMP alternatives memory: 28K
router# c[?7l[ 0.000000] Linux version 4.19.59 (nixbld@localhost) (gcc version 7.4.0 (GCC)) #1-NixOS SMP Sun Jul 14 06:11:23 UTC 2019
router# [ 0.000000] Command line: console=ttyS0 panic=1 boot.panic_on_fail loglevel=7 net.ifnames=0 init=/nix/store/wrjiykljl2kkrpi4bfck2fr1cbb0fhns-nixos-system-router-19.09.git.771985d/init regInfo=/nix/store/4v2d5bm6p93p0jjffpgml2vch14v8ayi-closure-info/registration console=ttyS0
router# [ 0.000000] x86/fpu: x87 FPU will use FXSAVE
router# [ 0.000000] BIOS-provided physical RAM map:
router# [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
router# [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
router# [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
router# [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x0000000017fdbfff] usable
router# [ 0.000000] BIOS-e820: [mem 0x0000000017fdc000-0x0000000017ffffff] reserved
router# [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
router# [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
router# [ 0.000000] NX (Execute Disable) protection: active
router# [ 0.000000] SMBIOS 2.8 present.
router# [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.12.1-0-ga5cab58e9a3f-prebuilt.qemu.org 04/01/2014
router# [ 0.000000] Hypervisor detected: KVM
router# [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
router# [ 0.000000] kvm-clock: cpu 0, msr a352001, primary cpu clock
router# [ 0.000000] kvm-clock: using sched offset of 716453201 cycles
router# [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
router# [ 0.000003] tsc: Detected 3399.996 MHz processor
router# [ 0.001324] last_pfn = 0x17fdc max_arch_pfn = 0x400000000
router# [ 0.001356] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WC UC- UC
router# [ 0.007775] found SMP MP-table at [mem 0x000f5ab0-0x000f5abf]
router# [ 0.007794] Scanning 1 areas for low memory corruption
router# [ 0.007937] RAMDISK: [mem 0x17656000-0x17fcffff]
router# [ 0.007953] ACPI: Early table checksum verification disabled
router# [ 0.007993] ACPI: RSDP 0x00000000000F58D0 000014 (v00 BOCHS )
router# [ 0.007996] ACPI: RSDT 0x0000000017FE156F 000030 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001)
router# [ 0.008001] ACPI: FACP 0x0000000017FE144B 000074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001)
router# [ 0.008005] ACPI: DSDT 0x0000000017FE0040 00140B (v01 BOCHS BXPCDSDT 00000001 BXPC 00000001)
router# [ 0.008007] ACPI: FACS 0x0000000017FE0000 000040
router# [ 0.008010] ACPI: APIC 0x0000000017FE14BF 000078 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001)
router# [ 0.008026] ACPI: HPET 0x0000000017FE1537 000038 (v01 BOCHS BXPCHPET 00000001 BXPC 00000001)
router# [ 0.008382] No NUMA configuration found
router# [ 0.008384] Faking a node at [mem 0x0000000000000000-0x0000000017fdbfff]
router# [ 0.008386] NODE_DATA(0) allocated [mem 0x17fd8000-0x17fdbfff]
router# [ 0.008400] Zone ranges:
router# [ 0.008401] DMA [mem 0x0000000000001000-0x0000000000ffffff]
router# [ 0.008402] DMA32 [mem 0x0000000001000000-0x0000000017fdbfff]
router# [ 0.008403] Normal empty
router# [ 0.008404] Movable zone start for each node
router# [ 0.008404] Early memory node ranges
router# [ 0.008405] node 0: [mem 0x0000000000001000-0x000000000009efff]
router# [ 0.008406] node 0: [mem 0x0000000000100000-0x0000000017fdbfff]
router# [ 0.017483] Reserved but unavailable: 98 pages
router# [ 0.017486] Initmem setup node 0 [mem 0x0000000000001000-0x0000000017fdbfff]
router# [ 0.032880] ACPI: PM-Timer IO Port: 0x608
router# [ 0.032893] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
router# [ 0.032930] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
router# [ 0.032932] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
router# [ 0.032934] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
router# [ 0.032934] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
router# [ 0.032935] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
router# [ 0.032936] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
router# [ 0.032940] Using ACPI (MADT) for SMP configuration information
router# [ 0.032942] ACPI: HPET id: 0x8086a201 base: 0xfed00000
router# [ 0.032946] smpboot: Allowing 1 CPUs, 0 hotplug CPUs
router# [ 0.032964] PM: Registered nosave memory: [mem 0x00000000-0x00000fff]
router# [ 0.032967] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff]
router# [ 0.032968] PM: Registered nosave memory: [mem 0x000a0000-0x000effff]
router# [ 0.032969] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff]
router# [ 0.032972] [mem 0x18000000-0xfeffbfff] available for PCI devices
router# [ 0.032973] Booting paravirtualized kernel on KVM
router# [ 0.032976] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
router# [ 0.095995] random: get_random_bytes called from start_kernel+0x94/0x4ce with crng_init=0
router# [ 0.096004] setup_percpu: NR_CPUS:384 nr_cpumask_bits:384 nr_cpu_ids:1 nr_node_ids:1
router# [ 0.096285] percpu: Embedded 44 pages/cpu s142424 r8192 d29608 u2097152
router# [ 0.096305] KVM setup async PF for cpu 0
router# [ 0.096309] kvm-stealtime: cpu 0, msr 16c16180
router# [ 0.096312] Built 1 zonelists, mobility grouping on. Total pages: 96613
router# [ 0.096313] Policy zone: DMA32
router# [ 0.096315] Kernel command line: console=ttyS0 panic=1 boot.panic_on_fail loglevel=7 net.ifnames=0 init=/nix/store/wrjiykljl2kkrpi4bfck2fr1cbb0fhns-nixos-system-router-19.09.git.771985d/init regInfo=/nix/store/4v2d5bm6p93p0jjffpgml2vch14v8ayi-closure-info/registration console=ttyS0
router# [ 0.097275] Memory: 354272K/392680K available (10252K kernel code, 1137K rwdata, 1860K rodata, 1436K init, 812K bss, 38408K reserved, 0K cma-reserved)
router# [ 0.103452] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
router# [ 0.103458] Kernel/User page tables isolation: enabled
router# [ 0.103484] ftrace: allocating 28486 entries in 112 pages
router# [ 0.116740] rcu: Hierarchical RCU implementation.
router# [ 0.116743] rcu: RCU event tracing is enabled.
tracker# [ 0.231857] smpboot: CPU0: Intel Common KVM processor (family: 0xf, model: 0x6, stepping: 0x1)
router# [ 0.116744] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.
router# [ 0.116745] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
tracker# [ 0.232023] Performance Events: unsupported Netburst CPU model 6 no PMU driver, software events only.
router# [ 0.118597] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16
tracker# [ 0.232909] rcu: Hierarchical SRCU implementation.
router# [ 0.124797] Console: colour VGA+ 80x25
router# [ 0.194262] console [ttyS0] enabled
tracker# [ 0.234210] smp: Bringing up secondary CPUs ...
router# [ 0.194725] ACPI: Core revision 20180810
tracker# [ 0.234859] smp: Brought up 1 node, 1 CPU
tracker# [ 0.235401] smpboot: Max logical packages: 1
router# [ 0.195433] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
tracker# [ 0.235859] smpboot: Total of 1 processors activated (6799.99 BogoMIPS)
router# [ 0.196693] APIC: Switch to symmetric I/O mode setup
tracker# [ 0.237010] devtmpfs: initialized
router# [ 0.197638] x2apic enabled
tracker# [ 0.237518] x86/mm: Memory block size: 128MB
router# [ 0.198307] Switched APIC routing to physical x2apic.
tracker# [ 0.238041] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
tracker# [ 0.238863] futex hash table entries: 256 (order: 2, 16384 bytes)
router# [ 0.200082] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
tracker# [ 0.239909] pinctrl core: initialized pinctrl subsystem
tracker# [ 0.241025] NET: Registered protocol family 16
router# [ 0.200898] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x31024b3bec5, max_idle_ns: 440795366697 ns
tracker# [ 0.241948] audit: initializing netlink subsys (disabled)
router# [ 0.202285] Calibrating delay loop (skipped) preset value.. 6799.99 BogoMIPS (lpj=3399996)
tracker# [ 0.242993] cpuidle: using governor menu
router# [ 0.203276] pid_max: default: 32768 minimum: 301
tracker# [ 0.243567] ACPI: bus type PCI registered
router# [ 0.204289] Security Framework initialized
tracker# [ 0.243860] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
router# [ 0.204855] Yama: becoming mindful.
router# [ 0.205303] AppArmor: AppArmor initialized
tracker# [ 0.245040] PCI: Using configuration type 1 for base access
router# [ 0.206304] Dentry cache hash table entries: 65536 (order: 7, 524288 bytes)
tracker# [ 0.245901] audit: type=2000 audit(1563769886.053:1): state=initialized audit_enabled=0 res=1
router# [ 0.207245] Inode-cache hash table entries: 32768 (order: 6, 262144 bytes)
router# [ 0.207281] Mount-cache hash table entries: 1024 (order: 1, 8192 bytes)
tracker# [ 0.248013] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
router# [ 0.208278] Mountpoint-cache hash table entries: 1024 (order: 1, 8192 bytes)
tracker# [ 0.249095] ACPI: Added _OSI(Module Device)
tracker# [ 0.249864] ACPI: Added _OSI(Processor Device)
tracker# [ 0.250549] ACPI: Added _OSI(3.0 _SCP Extensions)
tracker# [ 0.250860] ACPI: Added _OSI(Processor Aggregator Device)
tracker# [ 0.251866] ACPI: Added _OSI(Linux-Dell-Video)
tracker# [ 0.252571] ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio)
tracker# [ 0.254068] ACPI: 1 ACPI AML tables successfully acquired and loaded
tracker# [ 0.255991] ACPI: Interpreter enabled
router# [ 0.210315] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
tracker# [ 0.256874] ACPI: (supports S0 S3 S4 S5)
router# [ 0.211277] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
tracker# [ 0.257533] ACPI: Using IOAPIC for interrupt routing
router# [ 0.212277] Spectre V2 : Mitigation: Full generic retpoline
tracker# [ 0.257902] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
router# [ 0.213051] Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch
router# [ 0.213276] Speculative Store Bypass: Vulnerable
tracker# [ 0.258986] ACPI: Enabled 2 GPEs in block 00 to 0F
router# [ 0.214305] MDS: Vulnerable: Clear CPU buffers attempted, no microcode
tracker# [ 0.262195] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
tracker# [ 0.262862] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI]
tracker# [ 0.263863] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM
tracker# [ 0.264864] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge.
tracker# [ 0.266005] acpiphp: Slot [3] registered
tracker# [ 0.266910] acpiphp: Slot [4] registered
tracker# [ 0.267511] acpiphp: Slot [5] registered
router# [ 0.222280] Freeing SMP alternatives memory: 28K
tracker# [ 0.267914] acpiphp: Slot [6] registered
tracker# [ 0.268908] acpiphp: Slot [7] registered
tracker# [ 0.269515] acpiphp: Slot [8] registered
tracker# [ 0.269909] acpiphp: Slot [9] registered
tracker# [ 0.270520] acpiphp: Slot [10] registered
tracker# [ 0.270932] acpiphp: Slot [11] registered
tracker# [ 0.271914] acpiphp: Slot [12] registered
tracker# [ 0.272499] acpiphp: Slot [13] registered
tracker# [ 0.272908] acpiphp: Slot [14] registered
tracker# [ 0.273498] acpiphp: Slot [15] registered
tracker# [ 0.273920] acpiphp: Slot [16] registered
tracker# [ 0.274909] acpiphp: Slot [17] registered
tracker# [ 0.275515] acpiphp: Slot [18] registered
tracker# [ 0.275926] acpiphp: Slot [19] registered
tracker# [ 0.276898] acpiphp: Slot [20] registered
tracker# [ 0.277587] acpiphp: Slot [21] registered
tracker# [ 0.277931] acpiphp: Slot [22] registered
tracker# [ 0.278918] acpiphp: Slot [23] registered
tracker# [ 0.279562] acpiphp: Slot [24] registered
tracker# [ 0.279905] acpiphp: Slot [25] registered
tracker# [ 0.280489] acpiphp: Slot [26] registered
tracker# [ 0.280908] acpiphp: Slot [27] registered
tracker# [ 0.281901] acpiphp: Slot [28] registered
tracker# [ 0.282499] acpiphp: Slot [29] registered
tracker# [ 0.282927] acpiphp: Slot [30] registered
tracker# [ 0.283585] acpiphp: Slot [31] registered
tracker# [ 0.283872] PCI host bridge to bus 0000:00
tracker# [ 0.284861] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]
tracker# [ 0.285746] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]
tracker# [ 0.285860] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
tracker# [ 0.286860] pci_bus 0000:00: root bus resource [mem 0x18000000-0xfebfffff window]
tracker# [ 0.287860] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window]
tracker# [ 0.288862] pci_bus 0000:00: root bus resource [bus 00-ff]
tracker# [ 0.295767] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7]
tracker# [ 0.295860] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6]
tracker# [ 0.296860] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177]
tracker# [ 0.297860] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376]
tracker# [ 0.303097] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI
tracker# [ 0.303866] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB
client1# Probing EDD (edd=off to disable)... oc[?7lk
[ 0.000000] Linux version 4.19.59 (nixbld@localhost) (gcc version 7.4.0 (GCC)) #1-NixOS SMP Sun Jul 14 06:11:23 UTC 2019
client1# [ 0.000000] Command line: console=ttyS0 panic=1 boot.panic_on_fail loglevel=7 net.ifnames=0 init=/nix/store/39js8rhgjw2z0b9rilizimvlhrshii03-nixos-system-client1-19.09.git.771985d/init regInfo=/nix/store/s0h6bhgk30z1if7n2almvx3468z8bbdp-closure-info/registration console=ttyS0
client1# [ 0.000000] x86/fpu: x87 FPU will use FXSAVE
client1# [ 0.000000] BIOS-provided physical RAM map:
client1# [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
client1# [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
client1# [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
client1# [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x0000000017fdbfff] usable
client1# [ 0.000000] BIOS-e820: [mem 0x0000000017fdc000-0x0000000017ffffff] reserved
client1# [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
client1# [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
client1# [ 0.000000] NX (Execute Disable) protection: active
client1# [ 0.000000] SMBIOS 2.8 present.
client1# [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.12.1-0-ga5cab58e9a3f-prebuilt.qemu.org 04/01/2014
client1# [ 0.000000] Hypervisor detected: KVM
client1# [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
client1# [ 0.000000] kvm-clock: cpu 0, msr 6352001, primary cpu clock
client1# [ 0.000000] kvm-clock: using sched offset of 787829105 cycles
client1# [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
client1# [ 0.000003] tsc: Detected 3399.996 MHz processor
client1# [ 0.001277] last_pfn = 0x17fdc max_arch_pfn = 0x400000000
client1# [ 0.001309] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WC UC- UC
client1# [ 0.007634] found SMP MP-table at [mem 0x000f5ab0-0x000f5abf]
client1# [ 0.007653] Scanning 1 areas for low memory corruption
client1# [ 0.007793] RAMDISK: [mem 0x17656000-0x17fcffff]
client1# [ 0.007807] ACPI: Early table checksum verification disabled
client1# [ 0.007846] ACPI: RSDP 0x00000000000F58D0 000014 (v00 BOCHS )
client1# [ 0.007849] ACPI: RSDT 0x0000000017FE156F 000030 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001)
client1# [ 0.007853] ACPI: FACP 0x0000000017FE144B 000074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001)
client1# [ 0.007858] ACPI: DSDT 0x0000000017FE0040 00140B (v01 BOCHS BXPCDSDT 00000001 BXPC 00000001)
client1# [ 0.007861] ACPI: FACS 0x0000000017FE0000 000040
client1# [ 0.007863] ACPI: APIC 0x0000000017FE14BF 000078 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001)
client1# [ 0.007866] ACPI: HPET 0x0000000017FE1537 000038 (v01 BOCHS BXPCHPET 00000001 BXPC 00000001)
client1# [ 0.008218] No NUMA configuration found
client1# [ 0.008219] Faking a node at [mem 0x0000000000000000-0x0000000017fdbfff]
client1# [ 0.008222] NODE_DATA(0) allocated [mem 0x17fd8000-0x17fdbfff]
client1# [ 0.008235] Zone ranges:
client1# [ 0.008236] DMA [mem 0x0000000000001000-0x0000000000ffffff]
client1# [ 0.008237] DMA32 [mem 0x0000000001000000-0x0000000017fdbfff]
client1# [ 0.008238] Normal empty
client1# [ 0.008238] Movable zone start for each node
client1# [ 0.008239] Early memory node ranges
client1# [ 0.008240] node 0: [mem 0x0000000000001000-0x000000000009efff]
client1# [ 0.008241] node 0: [mem 0x0000000000100000-0x0000000017fdbfff]
client1# [ 0.014030] Reserved but unavailable: 98 pages
client1# [ 0.014032] Initmem setup node 0 [mem 0x0000000000001000-0x0000000017fdbfff]
client1# [ 0.026544] ACPI: PM-Timer IO Port: 0x608
client1# [ 0.026556] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
client1# [ 0.026593] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
client1# [ 0.026595] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
client1# [ 0.026597] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
client1# [ 0.026597] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
client1# [ 0.026598] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
client1# [ 0.026599] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
client1# [ 0.026603] Using ACPI (MADT) for SMP configuration information
client1# [ 0.026605] ACPI: HPET id: 0x8086a201 base: 0xfed00000
client1# [ 0.026609] smpboot: Allowing 1 CPUs, 0 hotplug CPUs
client1# [ 0.026628] PM: Registered nosave memory: [mem 0x00000000-0x00000fff]
client1# [ 0.026630] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff]
client1# [ 0.026632] PM: Registered nosave memory: [mem 0x000a0000-0x000effff]
client1# [ 0.026633] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff]
client1# [ 0.026635] [mem 0x18000000-0xfeffbfff] available for PCI devices
client1# [ 0.026637] Booting paravirtualized kernel on KVM
client1# [ 0.026640] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
client1# [ 0.088079] random: get_random_bytes called from start_kernel+0x94/0x4ce with crng_init=0
client1# [ 0.088088] setup_percpu: NR_CPUS:384 nr_cpumask_bits:384 nr_cpu_ids:1 nr_node_ids:1
client1# [ 0.098626] percpu: Embedded 44 pages/cpu s142424 r8192 d29608 u2097152
client1# [ 0.098651] KVM setup async PF for cpu 0
client1# [ 0.098655] kvm-stealtime: cpu 0, msr 16c16180
client1# [ 0.098659] Built 1 zonelists, mobility grouping on. Total pages: 96613
client1# [ 0.098660] Policy zone: DMA32
router# [ 0.225274] smpboot: CPU0: Intel Common KVM processor (family: 0xf, model: 0x6, stepping: 0x1)
router# [ 0.225443] Performance Events: unsupported Netburst CPU model 6 no PMU driver, software events only.
client1# [ 0.098662] Kernel command line: console=ttyS0 panic=1 boot.panic_on_fail loglevel=7 net.ifnames=0 init=/nix/store/39js8rhgjw2z0b9rilizimvlhrshii03-nixos-system-client1-19.09.git.771985d/init regInfo=/nix/store/s0h6bhgk30z1if7n2almvx3468z8bbdp-closure-info/registration console=ttyS0
router# [ 0.226312] rcu: Hierarchical SRCU implementation.
router# [ 0.227616] smp: Bringing up secondary CPUs ...
client1# [ 0.099690] Memory: 354272K/392680K available (10252K kernel code, 1137K rwdata, 1860K rodata, 1436K init, 812K bss, 38408K reserved, 0K cma-reserved)
router# [ 0.228277] smp: Brought up 1 node, 1 CPU
router# [ 0.228824] smpboot: Max logical packages: 1
client1# [ 0.099927] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
client1# [ 0.099932] Kernel/User page tables isolation: enabled
router# [ 0.229277] smpboot: Total of 1 processors activated (6799.99 BogoMIPS)
client1# [ 0.099965] ftrace: allocating 28486 entries in 112 pages
router# [ 0.230459] devtmpfs: initialized
client1# [ 0.108558] rcu: Hierarchical RCU implementation.
router# [ 0.231314] x86/mm: Memory block size: 128MB
client1# [ 0.108561] rcu: RCU event tracing is enabled.
client1# [ 0.108562] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.
router# [ 0.232143] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
client1# [ 0.108563] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
router# [ 0.232281] futex hash table entries: 256 (order: 2, 16384 bytes)
client1# [ 0.110331] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16
router# [ 0.233316] pinctrl core: initialized pinctrl subsystem
client1# [ 0.116534] Console: colour VGA+ 80x25
client1# [ 0.184932] console [ttyS0] enabled
router# [ 0.234321] NET: Registered protocol family 16
client1# [ 0.185401] ACPI: Core revision 20180810
router# [ 0.235038] audit: initializing netlink subsys (disabled)
client2# Probing EDD (edd=off to disable)... oc[?7l[ 0.000000] Linux version 4.19.59 (nixbld@localhost) (gcc version 7.4.0 (GCC)) #1-NixOS SMP Sun Jul 14 06:11:23 UTC 2019
router# [ 0.235417] cpuidle: using governor menu
client1# [ 0.186090] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
router# [ 0.236317] ACPI: bus type PCI registered
client1# [ 0.187356] APIC: Switch to symmetric I/O mode setup
router# [ 0.236878] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
client1# [ 0.188252] x2apic enabled
router# [ 0.237419] PCI: Using configuration type 1 for base access
client1# [ 0.188890] Switched APIC routing to physical x2apic.
client2# [ 0.000000] Command line: console=ttyS0 panic=1 boot.panic_on_fail loglevel=7 net.ifnames=0 init=/nix/store/xwyb06m80vl103cg5z9n5v1sl18c4sw3-nixos-system-client2-19.09.git.771985d/init regInfo=/nix/store/q5b6v75gl73dvxs0y3sn9ma842v7r42i-closure-info/registration console=ttyS0
client2# [ 0.000000] x86/fpu: x87 FPU will use FXSAVE
router# [ 0.238303] audit: type=2000 audit(1563769886.195:1): state=initialized audit_enabled=0 res=1
client2# [ 0.000000] BIOS-provided physical RAM map:
client1# [ 0.190674] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
router# [ 0.240689] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
client2# [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
client1# [ 0.191491] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x31024b3bec5, max_idle_ns: 440795366697 ns
router# [ 0.241502] ACPI: Added _OSI(Module Device)
client2# [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
router# [ 0.242279] ACPI: Added _OSI(Processor Device)
client1# [ 0.192840] Calibrating delay loop (skipped) preset value.. 6799.99 BogoMIPS (lpj=3399996)
client1# [ 0.193828] pid_max: default: 32768 minimum: 301
router# [ 0.243277] ACPI: Added _OSI(3.0 _SCP Extensions)
client2# [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
client1# [ 0.194849] Security Framework initialized
router# [ 0.244005] ACPI: Added _OSI(Processor Aggregator Device)
client1# [ 0.195373] Yama: becoming mindful.
client2# [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x0000000017fdbfff] usable
client1# [ 0.195848] AppArmor: AppArmor initialized
router# [ 0.244283] ACPI: Added _OSI(Linux-Dell-Video)
client2# [ 0.000000] BIOS-e820: [mem 0x0000000017fdc000-0x0000000017ffffff] reserved
router# [ 0.245289] ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio)
client1# [ 0.196449] Dentry cache hash table entries: 65536 (order: 7, 524288 bytes)
client2# [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
client1# [ 0.196863] Inode-cache hash table entries: 32768 (order: 6, 262144 bytes)
tracker# [ 0.382371] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
router# [ 0.246710] ACPI: 1 ACPI AML tables successfully acquired and loaded
client1# [ 0.197835] Mount-cache hash table entries: 1024 (order: 1, 8192 bytes)
tracker# [ 0.382984] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
client2# [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
client1# [ 0.198831] Mountpoint-cache hash table entries: 1024 (order: 1, 8192 bytes)
client2# [ 0.000000] NX (Execute Disable) protection: active
router# [ 0.248377] ACPI: Interpreter enabled
client2# [ 0.000000] SMBIOS 2.8 present.
router# [ 0.249290] ACPI: (supports S0 S3 S4 S5)
client1# [ 0.200855] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
router# [ 0.250277] ACPI: Using IOAPIC for interrupt routing
client1# [ 0.201539] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
tracker# [ 0.384914] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
client2# [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.12.1-0-ga5cab58e9a3f-prebuilt.qemu.org 04/01/2014
client2# [ 0.000000] Hypervisor detected: KVM
client1# [ 0.201829] Spectre V2 : Mitigation: Full generic retpoline
router# [ 0.251080] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
client2# [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
client1# [ 0.202827] Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch
tracker# [ 0.386090] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
router# [ 0.251357] ACPI: Enabled 2 GPEs in block 00 to 0F
client1# [ 0.203828] Speculative Store Bypass: Vulnerable
client2# [ 0.000000] kvm-clock: cpu 0, msr 17152001, primary cpu clock
client1# [ 0.204861] MDS: Vulnerable: Clear CPU buffers attempted, no microcode
client2# [ 0.000000] kvm-clock: using sched offset of 783589082 cycles
tracker# [ 0.386958] ACPI: PCI Interrupt Link [LNKS] (IRQs *9)
client2# [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
client2# [ 0.000003] tsc: Detected 3399.996 MHz processor
router# [ 0.254679] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
tracker# [ 0.389117] pci 0000:00:02.0: vgaarb: setting as boot VGA device
client2# [ 0.001327] last_pfn = 0x17fdc max_arch_pfn = 0x400000000
router# [ 0.255281] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI]
client2# [ 0.001359] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WC UC- UC
router# [ 0.256281] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM
client2# [ 0.007777] found SMP MP-table at [mem 0x000f5ab0-0x000f5abf]
tracker# [ 0.389857] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none
client2# [ 0.007796] Scanning 1 areas for low memory corruption
client2# [ 0.007928] RAMDISK: [mem 0x17656000-0x17fcffff]
router# [ 0.257283] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge.
client2# [ 0.007943] ACPI: Early table checksum verification disabled
tracker# [ 0.389863] pci 0000:00:02.0: vgaarb: bridge control possible
router# [ 0.258415] acpiphp: Slot [3] registered
client2# [ 0.007983] ACPI: RSDP 0x00000000000F58D0 000014 (v00 BOCHS )
tracker# [ 0.390859] vgaarb: loaded
router# [ 0.259331] acpiphp: Slot [4] registered
client1# [ 0.213306] Freeing SMP alternatives memory: 28K
tracker# [ 0.392246] PCI: Using ACPI for IRQ routing
router# [ 0.260335] acpiphp: Slot [5] registered
client2# [ 0.007986] ACPI: RSDT 0x0000000017FE156F 000030 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001)
router# [ 0.261314] acpiphp: Slot [6] registered
tracker# [ 0.393156] NetLabel: Initializing
client2# [ 0.007990] ACPI: FACP 0x0000000017FE144B 000074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001)
tracker# [ 0.393595] NetLabel: domain hash size = 128
router# [ 0.261977] acpiphp: Slot [7] registered
tracker# [ 0.393858] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO
router# [ 0.262333] acpiphp: Slot [8] registered
client2# [ 0.007995] ACPI: DSDT 0x0000000017FE0040 00140B (v01 BOCHS BXPCDSDT 00000001 BXPC 00000001)
tracker# [ 0.394869] NetLabel: unlabeled traffic allowed by default
router# [ 0.263318] acpiphp: Slot [9] registered
client2# [ 0.007998] ACPI: FACS 0x0000000017FE0000 000040
router# [ 0.263991] acpiphp: Slot [10] registered
tracker# [ 0.395672] HPET: 3 timers in total, 0 timers will be used for per-cpu timer
router# [ 0.264326] acpiphp: Slot [11] registered
tracker# [ 0.395878] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
client2# [ 0.008000] ACPI: APIC 0x0000000017FE14BF 000078 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001)
router# [ 0.265315] acpiphp: Slot [12] registered
tracker# [ 0.396859] hpet0: 3 comparators, 64-bit 100.000000 MHz counter
router# [ 0.266064] acpiphp: Slot [13] registered
client2# [ 0.008003] ACPI: HPET 0x0000000017FE1537 000038 (v01 BOCHS BXPCHPET 00000001 BXPC 00000001)
client2# [ 0.008341] No NUMA configuration found
client2# [ 0.008343] Faking a node at [mem 0x0000000000000000-0x0000000017fdbfff]
router# [ 0.266315] acpiphp: Slot [14] registered
router# [ 0.267328] acpiphp: Slot [15] registered
router# [ 0.267971] acpiphp: Slot [16] registered
client2# [ 0.008345] NODE_DATA(0) allocated [mem 0x17fd8000-0x17fdbfff]
client2# [ 0.008358] Zone ranges:
router# [ 0.268337] acpiphp: Slot [17] registered
tracker# [ 0.400916] clocksource: Switched to clocksource kvm-clock
client2# [ 0.008358] DMA [mem 0x0000000000001000-0x0000000000ffffff]
router# [ 0.269315] acpiphp: Slot [18] registered
client2# [ 0.008360] DMA32 [mem 0x0000000001000000-0x0000000017fdbfff]
router# [ 0.270316] acpiphp: Slot [19] registered
client2# [ 0.008361] Normal empty
router# [ 0.271075] acpiphp: Slot [20] registered
client2# [ 0.008361] Movable zone start for each node
client2# [ 0.008362] Early memory node ranges
router# [ 0.271321] acpiphp: Slot [21] registered
client2# [ 0.008363] node 0: [mem 0x0000000000001000-0x000000000009efff]
router# [ 0.272322] acpiphp: Slot [22] registered
client2# [ 0.008364] node 0: [mem 0x0000000000100000-0x0000000017fdbfff]
router# [ 0.273328] acpiphp: Slot [23] registered
client2# [ 0.013960] Reserved but unavailable: 98 pages
router# [ 0.274079] acpiphp: Slot [24] registered
client2# [ 0.013962] Initmem setup node 0 [mem 0x0000000000001000-0x0000000017fdbfff]
router# [ 0.274317] acpiphp: Slot [25] registered
client2# [ 0.028962] ACPI: PM-Timer IO Port: 0x608
router# [ 0.275323] acpiphp: Slot [26] registered
client2# [ 0.028978] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
router# [ 0.276317] acpiphp: Slot [27] registered
client2# [ 0.029026] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
tracker# [ 0.408720] VFS: Disk quotas dquot_6.6.0
router# [ 0.277060] acpiphp: Slot [28] registered
client2# [ 0.029029] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
router# [ 0.277315] acpiphp: Slot [29] registered
tracker# [ 0.409255] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
router# [ 0.278322] acpiphp: Slot [30] registered
tracker# [ 0.410195] AppArmor: AppArmor Filesystem Enabled
client2# [ 0.029031] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
tracker# [ 0.410798] pnp: PnP ACPI init
router# [ 0.279320] acpiphp: Slot [31] registered
client2# [ 0.029033] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
tracker# [ 0.411499] pnp: PnP ACPI: found 6 devices
router# [ 0.280036] PCI host bridge to bus 0000:00
client2# [ 0.029034] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
router# [ 0.280279] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]
client2# [ 0.029036] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
client2# [ 0.029042] Using ACPI (MADT) for SMP configuration information
router# [ 0.281278] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]
client2# [ 0.029044] ACPI: HPET id: 0x8086a201 base: 0xfed00000
client2# [ 0.029050] smpboot: Allowing 1 CPUs, 0 hotplug CPUs
router# [ 0.282277] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
client2# [ 0.029078] PM: Registered nosave memory: [mem 0x00000000-0x00000fff]
router# [ 0.283278] pci_bus 0000:00: root bus resource [mem 0x18000000-0xfebfffff window]
client2# [ 0.029080] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff]
client2# [ 0.029081] PM: Registered nosave memory: [mem 0x000a0000-0x000effff]
router# [ 0.284278] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window]
client2# [ 0.029082] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff]
router# [ 0.285277] pci_bus 0000:00: root bus resource [bus 00-ff]
client2# [ 0.029084] [mem 0x18000000-0xfeffbfff] available for PCI devices
client2# [ 0.029085] Booting paravirtualized kernel on KVM
client2# [ 0.029087] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
client2# [ 0.100240] random: get_random_bytes called from start_kernel+0x94/0x4ce with crng_init=0
client2# [ 0.100251] setup_percpu: NR_CPUS:384 nr_cpumask_bits:384 nr_cpu_ids:1 nr_node_ids:1
tracker# [ 0.423056] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
client2# [ 0.100446] percpu: Embedded 44 pages/cpu s142424 r8192 d29608 u2097152
tracker# [ 0.424235] NET: Registered protocol family 2
client2# [ 0.100475] KVM setup async PF for cpu 0
client2# [ 0.100479] kvm-stealtime: cpu 0, msr 17416180
tracker# [ 0.424929] tcp_listen_portaddr_hash hash table entries: 256 (order: 0, 4096 bytes)
router# [ 0.293566] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7]
client2# [ 0.100484] Built 1 zonelists, mobility grouping on. Total pages: 96613
tracker# [ 0.426046] TCP established hash table entries: 4096 (order: 3, 32768 bytes)
client2# [ 0.100485] Policy zone: DMA32
router# [ 0.294277] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6]
tracker# [ 0.426968] TCP bind hash table entries: 4096 (order: 4, 65536 bytes)
tracker# [ 0.427820] TCP: Hash tables configured (established 4096 bind 4096)
router# [ 0.295276] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177]
tracker# [ 0.428692] UDP hash table entries: 256 (order: 1, 8192 bytes)
tracker# [ 0.429456] UDP-Lite hash table entries: 256 (order: 1, 8192 bytes)
router# [ 0.296277] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376]
tracker# [ 0.430283] NET: Registered protocol family 1
client2# [ 0.100487] Kernel command line: console=ttyS0 panic=1 boot.panic_on_fail loglevel=7 net.ifnames=0 init=/nix/store/xwyb06m80vl103cg5z9n5v1sl18c4sw3-nixos-system-client2-19.09.git.771985d/init regInfo=/nix/store/q5b6v75gl73dvxs0y3sn9ma842v7r42i-closure-info/registration console=ttyS0
tracker# [ 0.430856] pci 0000:00:01.0: PIIX3: Enabling Passive Release
tracker# [ 0.431607] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
tracker# [ 0.432373] pci 0000:00:01.0: Activating ISA DMA hang workarounds
client2# [ 0.101610] Memory: 355976K/392680K available (10252K kernel code, 1137K rwdata, 1860K rodata, 1436K init, 812K bss, 36704K reserved, 0K cma-reserved)
client2# [ 0.102114] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
client2# [ 0.102119] Kernel/User page tables isolation: enabled
router# [ 0.302334] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI
client2# [ 0.102151] ftrace: allocating 28486 entries in 112 pages
client2# [ 0.111059] rcu: Hierarchical RCU implementation.
router# [ 0.303290] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB
client2# [ 0.111062] rcu: RCU event tracing is enabled.
client2# [ 0.111063] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.
client2# [ 0.111064] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
client2# [ 0.113177] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16
client2# [ 0.120869] Console: colour VGA+ 80x25
client2# [ 0.197391] console [ttyS0] enabled
client2# [ 0.197853] ACPI: Core revision 20180810
client2# [ 0.198543] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
client2# [ 0.200090] APIC: Switch to symmetric I/O mode setup
client2# [ 0.200987] x2apic enabled
client2# [ 0.201623] Switched APIC routing to physical x2apic.
tracker# [ 0.444320] PCI Interrupt Link [LNKD] enabled at IRQ 11
client2# [ 0.203522] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
client2# [ 0.204328] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x31024b3bec5, max_idle_ns: 440795366697 ns
client2# [ 0.205693] Calibrating delay loop (skipped) preset value.. 6799.99 BogoMIPS (lpj=3399996)
client2# [ 0.206682] pid_max: default: 32768 minimum: 301
client2# [ 0.207699] Security Framework initialized
client2# [ 0.208232] Yama: becoming mindful.
client2# [ 0.208697] AppArmor: AppArmor initialized
client2# [ 0.209299] Dentry cache hash table entries: 65536 (order: 7, 524288 bytes)
client2# [ 0.209715] Inode-cache hash table entries: 32768 (order: 6, 262144 bytes)
client2# [ 0.210686] Mount-cache hash table entries: 1024 (order: 1, 8192 bytes)
client2# [ 0.211684] Mountpoint-cache hash table entries: 1024 (order: 1, 8192 bytes)
tracker# [ 0.456330] pci 0000:00:01.2: quirk_usb_early_handoff+0x0/0x6b0 took 22594 usecs
tracker# [ 0.457337] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
tracker# [ 0.458508] Trying to unpack rootfs image as initramfs...
client2# [ 0.213720] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
client2# [ 0.214682] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
client2# [ 0.215439] Spectre V2 : Mitigation: Full generic retpoline
client2# [ 0.215681] Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch
client2# [ 0.216682] Speculative Store Bypass: Vulnerable
client2# [ 0.217715] MDS: Vulnerable: Clear CPU buffers attempted, no microcode
client2# [ 0.226731] Freeing SMP alternatives memory: 28K
client1# [ 0.215825] smpboot: CPU0: Intel Common KVM processor (family: 0xf, model: 0x6, stepping: 0x1)
client1# [ 0.215936] Performance Events: unsupported Netburst CPU model 6 no PMU driver, software events only.
client1# [ 0.216863] rcu: Hierarchical SRCU implementation.
client1# [ 0.218088] smp: Bringing up secondary CPUs ...
client1# [ 0.218681] smp: Brought up 1 node, 1 CPU
client1# [ 0.218828] smpboot: Max logical packages: 1
client1# [ 0.219382] smpboot: Total of 1 processors activated (6799.99 BogoMIPS)
client1# [ 0.219948] devtmpfs: initialized
client1# [ 0.220867] x86/mm: Memory block size: 128MB
client1# [ 0.221920] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
client1# [ 0.222833] futex hash table entries: 256 (order: 2, 16384 bytes)
client1# [ 0.223863] pinctrl core: initialized pinctrl subsystem
client1# [ 0.224644] NET: Registered protocol family 16
client1# [ 0.224881] audit: initializing netlink subsys (disabled)
client1# [ 0.225906] cpuidle: using governor menu
client1# [ 0.226460] ACPI: bus type PCI registered
client1# [ 0.226828] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
client1# [ 0.227922] PCI: Using configuration type 1 for base access
client1# [ 0.228649] audit: type=2000 audit(1563769886.345:1): state=initialized audit_enabled=0 res=1
client1# [ 0.229213] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
client1# [ 0.229958] ACPI: Added _OSI(Module Device)
client1# [ 0.230830] ACPI: Added _OSI(Processor Device)
client1# [ 0.231392] ACPI: Added _OSI(3.0 _SCP Extensions)
client1# [ 0.231828] ACPI: Added _OSI(Processor Aggregator Device)
client1# [ 0.232516] ACPI: Added _OSI(Linux-Dell-Video)
client1# [ 0.232838] ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio)
client1# [ 0.234170] ACPI: 1 ACPI AML tables successfully acquired and loaded
client1# [ 0.235924] ACPI: Interpreter enabled
client1# [ 0.236411] ACPI: (supports S0 S3 S4 S5)
client1# [ 0.236835] ACPI: Using IOAPIC for interrupt routing
client1# [ 0.237476] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
client1# [ 0.237901] ACPI: Enabled 2 GPEs in block 00 to 0F
client1# [ 0.240016] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
client1# [ 0.240807] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI]
client1# [ 0.240834] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM
client1# [ 0.241836] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge.
client1# [ 0.242961] acpiphp: Slot [3] registered
client1# [ 0.243510] acpiphp: Slot [4] registered
client1# [ 0.243867] acpiphp: Slot [5] registered
client1# [ 0.244417] acpiphp: Slot [6] registered
client1# [ 0.244865] acpiphp: Slot [7] registered
client1# [ 0.245864] acpiphp: Slot [8] registered
client1# [ 0.246406] acpiphp: Slot [9] registered
client1# [ 0.246867] acpiphp: Slot [10] registered
client1# [ 0.247430] acpiphp: Slot [11] registered
client1# [ 0.247863] acpiphp: Slot [12] registered
client1# [ 0.248425] acpiphp: Slot [13] registered
client1# [ 0.248868] acpiphp: Slot [14] registered
client1# [ 0.249832] acpiphp: Slot [15] registered
client1# [ 0.250384] acpiphp: Slot [16] registered
client1# [ 0.250865] acpiphp: Slot [17] registered
client1# [ 0.251415] acpiphp: Slot [18] registered
client1# [ 0.251866] acpiphp: Slot [19] registered
client1# [ 0.252428] acpiphp: Slot [20] registered
client1# [ 0.252865] acpiphp: Slot [21] registered
client1# [ 0.253431] acpiphp: Slot [22] registered
client1# [ 0.253867] acpiphp: Slot [23] registered
client1# [ 0.254865] acpiphp: Slot [24] registered
client1# [ 0.255422] acpiphp: Slot [25] registered
client1# [ 0.255867] acpiphp: Slot [26] registered
client1# [ 0.256431] acpiphp: Slot [27] registered
client1# [ 0.256867] acpiphp: Slot [28] registered
router# [ 0.398903] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
client1# [ 0.257438] acpiphp: Slot [29] registered
client1# [ 0.257868] acpiphp: Slot [30] registered
client1# [ 0.258867] acpiphp: Slot [31] registered
client1# [ 0.259428] PCI host bridge to bus 0000:00
client1# [ 0.259830] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]
router# [ 0.399403] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
client1# [ 0.260828] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]
router# [ 0.400357] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
client1# [ 0.261828] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
router# [ 0.401348] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
router# [ 0.402160] ACPI: PCI Interrupt Link [LNKS] (IRQs *9)
client1# [ 0.262828] pci_bus 0000:00: root bus resource [mem 0x18000000-0xfebfffff window]
router# [ 0.402534] pci 0000:00:02.0: vgaarb: setting as boot VGA device
client1# [ 0.263829] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window]
client1# [ 0.264830] pci_bus 0000:00: root bus resource [bus 00-ff]
router# [ 0.403274] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none
router# [ 0.403277] pci 0000:00:02.0: vgaarb: bridge control possible
router# [ 0.404276] vgaarb: loaded
router# [ 0.405303] PCI: Using ACPI for IRQ routing
router# [ 0.406220] NetLabel: Initializing
router# [ 0.406276] NetLabel: domain hash size = 128
router# [ 0.406847] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO
router# [ 0.407289] NetLabel: unlabeled traffic allowed by default
client1# [ 0.270383] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7]
router# [ 0.408394] HPET: 3 timers in total, 0 timers will be used for per-cpu timer
client1# [ 0.270829] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6]
router# [ 0.409309] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
client1# [ 0.271829] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177]
router# [ 0.410276] hpet0: 3 comparators, 64-bit 100.000000 MHz counter
client1# [ 0.272829] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376]
router# [ 0.414365] clocksource: Switched to clocksource kvm-clock
client1# [ 0.278335] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI
client1# [ 0.278841] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB
router# [ 0.435022] VFS: Disk quotas dquot_6.6.0
router# [ 0.435592] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
client2# [ 0.228680] smpboot: CPU0: Intel Common KVM processor (family: 0xf, model: 0x6, stepping: 0x1)
router# [ 0.436667] AppArmor: AppArmor Filesystem Enabled
router# [ 0.437386] pnp: PnP ACPI init
router# [ 0.438102] pnp: PnP ACPI: found 6 devices
client2# [ 0.228826] Performance Events: unsupported Netburst CPU model 6 no PMU driver, software events only.
client2# [ 0.229720] rcu: Hierarchical SRCU implementation.
client2# [ 0.230999] smp: Bringing up secondary CPUs ...
client2# [ 0.231682] smp: Brought up 1 node, 1 CPU
client2# [ 0.232681] smpboot: Max logical packages: 1
client2# [ 0.233225] smpboot: Total of 1 processors activated (6799.99 BogoMIPS)
client2# [ 0.233816] devtmpfs: initialized
client2# [ 0.234704] x86/mm: Memory block size: 128MB
client2# [ 0.235421] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
router# [ 0.444293] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
client2# [ 0.235686] futex hash table entries: 256 (order: 2, 16384 bytes)
router# [ 0.445591] NET: Registered protocol family 2
client2# [ 0.236734] pinctrl core: initialized pinctrl subsystem
client2# [ 0.237839] NET: Registered protocol family 16
router# [ 0.446410] tcp_listen_portaddr_hash hash table entries: 256 (order: 0, 4096 bytes)
client2# [ 0.238757] audit: initializing netlink subsys (disabled)
router# [ 0.447562] TCP established hash table entries: 4096 (order: 3, 32768 bytes)
client2# [ 0.239816] cpuidle: using governor menu
router# [ 0.448632] TCP bind hash table entries: 4096 (order: 4, 65536 bytes)
client2# [ 0.240729] ACPI: bus type PCI registered
router# [ 0.449618] TCP: Hash tables configured (established 4096 bind 4096)
client2# [ 0.241380] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
router# [ 0.450587] UDP hash table entries: 256 (order: 1, 8192 bytes)
client2# [ 0.241827] PCI: Using configuration type 1 for base access
router# [ 0.451340] UDP-Lite hash table entries: 256 (order: 1, 8192 bytes)
router# [ 0.452165] NET: Registered protocol family 1
client2# [ 0.242707] audit: type=2000 audit(1563769886.412:1): state=initialized audit_enabled=0 res=1
router# [ 0.452759] pci 0000:00:01.0: PIIX3: Enabling Passive Release
router# [ 0.453593] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
client2# [ 0.244157] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
router# [ 0.454369] pci 0000:00:01.0: Activating ISA DMA hang workarounds
client2# [ 0.244897] ACPI: Added _OSI(Module Device)
client2# [ 0.245685] ACPI: Added _OSI(Processor Device)
client2# [ 0.246337] ACPI: Added _OSI(3.0 _SCP Extensions)
client2# [ 0.246683] ACPI: Added _OSI(Processor Aggregator Device)
client2# [ 0.247690] ACPI: Added _OSI(Linux-Dell-Video)
client2# [ 0.248694] ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio)
client2# [ 0.249984] ACPI: 1 ACPI AML tables successfully acquired and loaded
client2# [ 0.251791] ACPI: Interpreter enabled
client2# [ 0.252350] ACPI: (supports S0 S3 S4 S5)
client2# [ 0.252683] ACPI: Using IOAPIC for interrupt routing
client2# [ 0.253698] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
client2# [ 0.254765] ACPI: Enabled 2 GPEs in block 00 to 0F
router# [ 0.466138] PCI Interrupt Link [LNKD] enabled at IRQ 11
client2# [ 0.257515] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
client2# [ 0.257688] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI]
client2# [ 0.258689] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM
client2# [ 0.259690] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge.
client2# [ 0.260810] acpiphp: Slot [3] registered
client2# [ 0.261725] acpiphp: Slot [4] registered
client2# [ 0.262340] acpiphp: Slot [5] registered
client2# [ 0.262720] acpiphp: Slot [6] registered
client2# [ 0.263244] acpiphp: Slot [7] registered
client2# [ 0.263711] acpiphp: Slot [8] registered
client2# [ 0.264232] acpiphp: Slot [9] registered
client2# [ 0.264716] acpiphp: Slot [10] registered
client2# [ 0.265249] acpiphp: Slot [11] registered
client2# [ 0.265710] acpiphp: Slot [12] registered
client2# [ 0.266713] acpiphp: Slot [13] registered
client2# [ 0.267258] acpiphp: Slot [14] registered
client2# [ 0.267709] acpiphp: Slot [15] registered
client2# [ 0.268251] acpiphp: Slot [16] registered
router# [ 0.478201] pci 0000:00:01.2: quirk_usb_early_handoff+0x0/0x6b0 took 22482 usecs
client2# [ 0.268709] acpiphp: Slot [17] registered
client2# [ 0.269245] acpiphp: Slot [18] registered
router# [ 0.479254] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
client2# [ 0.269710] acpiphp: Slot [19] registered
client2# [ 0.270248] acpiphp: Slot [20] registered
router# [ 0.480561] Trying to unpack rootfs image as initramfs...
client2# [ 0.270710] acpiphp: Slot [21] registered
client2# [ 0.271243] acpiphp: Slot [22] registered
client2# [ 0.271725] acpiphp: Slot [23] registered
client2# [ 0.272710] acpiphp: Slot [24] registered
client2# [ 0.273257] acpiphp: Slot [25] registered
client2# [ 0.273714] acpiphp: Slot [26] registered
client2# [ 0.274260] acpiphp: Slot [27] registered
client2# [ 0.274715] acpiphp: Slot [28] registered
client2# [ 0.275248] acpiphp: Slot [29] registered
client2# [ 0.275716] acpiphp: Slot [30] registered
client2# [ 0.276282] acpiphp: Slot [31] registered
client2# [ 0.276694] PCI host bridge to bus 0000:00
client2# [ 0.277212] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]
client2# [ 0.277682] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]
client2# [ 0.278682] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
client2# [ 0.279682] pci_bus 0000:00: root bus resource [mem 0x18000000-0xfebfffff window]
client2# [ 0.280682] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window]
client2# [ 0.281682] pci_bus 0000:00: root bus resource [bus 00-ff]
client1# [ 0.358145] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
client2# [ 0.287712] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7]
client1# [ 0.358907] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
client1# [ 0.359685] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
client2# [ 0.288684] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6]
client1# [ 0.359895] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
client1# [ 0.360869] ACPI: PCI Interrupt Link [LNKS] (IRQs *9)
client2# [ 0.289683] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177]
client1# [ 0.362117] pci 0000:00:02.0: vgaarb: setting as boot VGA device
client2# [ 0.290684] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376]
client1# [ 0.362825] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none
client1# [ 0.362834] pci 0000:00:02.0: vgaarb: bridge control possible
client1# [ 0.363828] vgaarb: loaded
client1# [ 0.364877] PCI: Using ACPI for IRQ routing
client1# [ 0.365784] NetLabel: Initializing
client1# [ 0.365828] NetLabel: domain hash size = 128
client1# [ 0.366382] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO
client1# [ 0.366844] NetLabel: unlabeled traffic allowed by default
client2# [ 0.296896] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI
client1# [ 0.367937] HPET: 3 timers in total, 0 timers will be used for per-cpu timer
client2# [ 0.297695] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB
client1# [ 0.368848] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
client1# [ 0.369827] hpet0: 3 comparators, 64-bit 100.000000 MHz counter
tracker# [ 0.657133] Freeing initrd memory: 9704K
tracker# [ 0.657706] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x31024b3bec5, max_idle_ns: 440795366697 ns
tracker# [ 0.659030] Scanning for low memory corruption every 60 seconds
tracker# [ 0.660208] Initialise system trusted keyrings
tracker# [ 0.660831] workingset: timestamp_bits=40 max_order=17 bucket_order=0
tracker# [ 0.662635] zbud: loaded
tracker# [ 0.663459] Key type asymmetric registered
client1# [ 0.375915] clocksource: Switched to clocksource kvm-clock
tracker# [ 0.664046] Asymmetric key parser 'x509' registered
tracker# [ 0.664711] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250)
tracker# [ 0.665737] io scheduler noop registered
tracker# [ 0.666297] io scheduler deadline registered
tracker# [ 0.666922] io scheduler cfq registered (default)
tracker# [ 0.667611] io scheduler mq-deadline registered
tracker# [ 0.668284] io scheduler kyber registered
tracker# [ 0.669069] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
client1# [ 0.390795] VFS: Disk quotas dquot_6.6.0
client1# [ 0.391338] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
client1# [ 0.392341] AppArmor: AppArmor Filesystem Enabled
client1# [ 0.393100] pnp: PnP ACPI init
client1# [ 0.393804] pnp: PnP ACPI: found 6 devices
tracker# [ 0.694333] 00:05: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
client1# [ 0.406869] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
client1# [ 0.408070] NET: Registered protocol family 2
client1# [ 0.408851] tcp_listen_portaddr_hash hash table entries: 256 (order: 0, 4096 bytes)
client1# [ 0.409869] TCP established hash table entries: 4096 (order: 3, 32768 bytes)
client1# [ 0.410783] TCP bind hash table entries: 4096 (order: 4, 65536 bytes)
client1# [ 0.411643] TCP: Hash tables configured (established 4096 bind 4096)
client1# [ 0.412845] UDP hash table entries: 256 (order: 1, 8192 bytes)
client1# [ 0.413595] UDP-Lite hash table entries: 256 (order: 1, 8192 bytes)
client1# [ 0.414576] NET: Registered protocol family 1
client1# [ 0.415164] pci 0000:00:01.0: PIIX3: Enabling Passive Release
client1# [ 0.415918] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
tracker# [ 0.704434] brd: module loaded
client1# [ 0.416689] pci 0000:00:01.0: Activating ISA DMA hang workarounds
tracker# [ 0.705000] mce: Using 10 MCE banks
tracker# [ 0.705483] sched_clock: Marking stable (623726835, 81137999)->(830710323, -125845489)
tracker# [ 0.706614] registered taskstats version 1
tracker# [ 0.707187] Loading compiled-in X.509 certificates
tracker# [ 0.707824] zswap: loaded using pool lzo/zbud
tracker# [ 0.708449] AppArmor: AppArmor sha1 policy hashing enabled
tracker# [ 0.711281] Freeing unused kernel image memory: 1436K
tracker# [ 0.713876] Write protecting the kernel read-only data: 14336k
tracker# [ 0.715024] Freeing unused kernel image memory: 2012K
tracker# [ 0.715879] Freeing unused kernel image memory: 188K
tracker# [ 0.716565] Run /init as init process
client1# [ 0.429816] PCI Interrupt Link [LNKD] enabled at IRQ 11
tracker#
tracker# <<< NixOS Stage 1 >>>
tracker#
client1# [ 0.441748] pci 0000:00:01.2: quirk_usb_early_handoff+0x0/0x6b0 took 23663 usecs
client1# [ 0.442762] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
client1# [ 0.444008] Trying to unpack rootfs image as initramfs...
tracker# loading module virtio_balloon...
tracker# loading module virtio_console...
tracker# loading module virtio_rng...
tracker# loading module dm_mod...
client2# [ 0.385063] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
client2# [ 0.385768] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
client2# [ 0.386753] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
tracker# [ 0.753208] device-mapper: ioctl: 4.39.0-ioctl (2018-04-03) initialised: [email protected]
client2# [ 0.387748] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
tracker# running udev...
client2# [ 0.388510] ACPI: PCI Interrupt Link [LNKS] (IRQs *9)
client2# [ 0.388982] pci 0000:00:02.0: vgaarb: setting as boot VGA device
client2# [ 0.389680] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none
client2# [ 0.389683] pci 0000:00:02.0: vgaarb: bridge control possible
client2# [ 0.390681] vgaarb: loaded
client2# [ 0.391832] PCI: Using ACPI for IRQ routing
tracker# [ 0.758928] systemd-udevd[90]: Starting version 242
client2# [ 0.392778] NetLabel: Initializing
client2# [ 0.393262] NetLabel: domain hash size = 128
tracker# [ 0.760417] systemd-udevd[91]: Network interface NamePolicy= disabled on kernel command line, ignoring.
client2# [ 0.393682] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO
client2# [ 0.394701] NetLabel: unlabeled traffic allowed by default
client2# [ 0.395912] HPET: 3 timers in total, 0 timers will be used for per-cpu timer
client2# [ 0.396715] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
client2# [ 0.397683] hpet0: 3 comparators, 64-bit 100.000000 MHz counter
client2# [ 0.401769] clocksource: Switched to clocksource kvm-clock
client2# [ 0.420348] VFS: Disk quotas dquot_6.6.0
client2# [ 0.421001] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
client2# [ 0.422146] AppArmor: AppArmor Filesystem Enabled
client2# [ 0.422898] pnp: PnP ACPI init
client2# [ 0.423721] pnp: PnP ACPI: found 6 devices
router# [ 0.645633] Freeing initrd memory: 9704K
router# [ 0.646324] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x31024b3bec5, max_idle_ns: 440795366697 ns
router# [ 0.647663] Scanning for low memory corruption every 60 seconds
router# [ 0.648831] Initialise system trusted keyrings
router# [ 0.649459] workingset: timestamp_bits=40 max_order=17 bucket_order=0
router# [ 0.651169] zbud: loaded
router# [ 0.651989] Key type asymmetric registered
router# [ 0.652612] Asymmetric key parser 'x509' registered
router# [ 0.653161] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250)
router# [ 0.654045] io scheduler noop registered
router# [ 0.654624] io scheduler deadline registered
router# [ 0.655322] io scheduler cfq registered (default)
router# [ 0.656014] io scheduler mq-deadline registered
router# [ 0.656694] io scheduler kyber registered
tracker# [ 0.802885] rtc_cmos 00:00: RTC can wake from S4
router# [ 0.657492] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
client2# [ 0.438790] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
client2# [ 0.440197] NET: Registered protocol family 2
client2# [ 0.441035] tcp_listen_portaddr_hash hash table entries: 256 (order: 0, 4096 bytes)
tracker# [ 0.809272] rtc_cmos 00:00: registered as rtc0
client2# [ 0.442184] TCP established hash table entries: 4096 (order: 3, 32768 bytes)
client2# [ 0.443218] TCP bind hash table entries: 4096 (order: 4, 65536 bytes)
client2# [ 0.443982] TCP: Hash tables configured (established 4096 bind 4096)
client2# [ 0.444789] UDP hash table entries: 256 (order: 1, 8192 bytes)
client2# [ 0.445470] UDP-Lite hash table entries: 256 (order: 1, 8192 bytes)
client2# [ 0.446723] NET: Registered protocol family 1
client2# [ 0.448276] pci 0000:00:01.0: PIIX3: Enabling Passive Release
client2# [ 0.450395] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
client2# [ 0.452607] pci 0000:00:01.0: Activating ISA DMA hang workarounds
tracker# [ 0.826736] rtc_cmos 00:00: alarms up to one day, y3k, 114 bytes nvram, hpet irqs
tracker# [ 0.827814] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
router# [ 0.682836] 00:05: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
client2# [ 0.466077] PCI Interrupt Link [LNKD] enabled at IRQ 11
tracker# [ 0.834540] serio: i8042 KBD port at 0x60,0x64 irq 1
router# [ 0.694877] brd: module loaded
router# [ 0.695508] mce: Using 10 MCE banks
tracker# [ 0.841871] serio: i8042 AUX port at 0x60,0x64 irq 12
router# [ 0.696054] sched_clock: Marking stable (616843800, 78526765)->(820215654, -124845089)
router# [ 0.697343] registered taskstats version 1
router# [ 0.697953] Loading compiled-in X.509 certificates
router# [ 0.698703] zswap: loaded using pool lzo/zbud
router# [ 0.699413] AppArmor: AppArmor sha1 policy hashing enabled
client2# [ 0.478242] pci 0000:00:01.2: quirk_usb_early_handoff+0x0/0x6b0 took 23488 usecs
client2# [ 0.479294] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
client2# [ 0.480512] Trying to unpack rootfs image as initramfs...
router# [ 0.702287] Freeing unused kernel image memory: 1436K
router# [ 0.704307] Write protecting the kernel read-only data: 14336k
router# [ 0.706010] Freeing unused kernel image memory: 2012K
router# [ 0.706789] Freeing unused kernel image memory: 188K
router# [ 0.707957] Run /init as init process
router#
router# <<< NixOS Stage 1 >>>
router#
tracker# [ 0.864391] SCSI subsystem initialized
router# loading module virtio_balloon...
tracker# [ 0.874434] PCI Interrupt Link [LNKC] enabled at IRQ 10
router# loading module virtio_console...
tracker# [ 0.877536] ACPI: bus type USB registered
router# loading module virtio_rng...
tracker# [ 0.878907] usbcore: registered new interface driver usbfs
tracker# [ 0.879856] usbcore: registered new interface driver hub
router# loading module dm_mod...
tracker# [ 0.887887] usbcore: registered new device driver usb
router# [ 0.744712] device-mapper: ioctl: 4.39.0-ioctl (2018-04-03) initialised: [email protected]
router# running udev...
router# [ 0.750502] systemd-udevd[90]: Starting version 242
router# [ 0.751845] systemd-udevd[91]: Network interface NamePolicy= disabled on kernel command line, ignoring.
tracker# [ 0.904073] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
tracker# [ 0.915625] uhci_hcd: USB Universal Host Controller Interface driver
client1# [ 0.629497] Freeing initrd memory: 9704K
client1# [ 0.630115] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x31024b3bec5, max_idle_ns: 440795366697 ns
client1# [ 0.631522] Scanning for low memory corruption every 60 seconds
client1# [ 0.632733] Initialise system trusted keyrings
client1# [ 0.633418] workingset: timestamp_bits=40 max_order=17 bucket_order=0
client1# [ 0.635217] zbud: loaded
client1# [ 0.636123] Key type asymmetric registered
client1# [ 0.636655] Asymmetric key parser 'x509' registered
client1# [ 0.637317] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250)
client1# [ 0.638310] io scheduler noop registered
client1# [ 0.638816] io scheduler deadline registered
client1# [ 0.639443] io scheduler cfq registered (default)
client1# [ 0.640049] io scheduler mq-deadline registered
client1# [ 0.640642] io scheduler kyber registered
client1# [ 0.641385] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
tracker# [ 0.929872] scsi host0: ata_piix
tracker# [ 0.935875] scsi host1: ata_piix
tracker# [ 0.936460] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc1c0 irq 14
tracker# [ 0.937388] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc1c8 irq 15
router# [ 0.793527] rtc_cmos 00:00: RTC can wake from S4
tracker# [ 0.952136] uhci_hcd 0000:00:01.2: UHCI Host Controller
tracker# [ 0.952832] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1
client1# [ 0.665443] 00:05: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
tracker# [ 0.954866] random: fast init done
tracker# [ 0.956876] random: crng init done
router# [ 0.812461] rtc_cmos 00:00: registered as rtc0
router# [ 0.813077] rtc_cmos 00:00: alarms up to one day, y3k, 114 bytes nvram, hpet irqs
router# [ 0.814116] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
client1# [ 0.675652] brd: module loaded
client1# [ 0.676214] mce: Using 10 MCE banks
tracker# [ 0.963893] uhci_hcd 0000:00:01.2: detected 2 ports
client1# [ 0.676719] sched_clock: Marking stable (598720984, 77343776)->(784747830, -108683070)
tracker# [ 0.964606] uhci_hcd 0000:00:01.2: irq 11, io base 0x0000c0c0
client1# [ 0.677917] registered taskstats version 1
client1# [ 0.678450] Loading compiled-in X.509 certificates
client1# [ 0.679112] zswap: loaded using pool lzo/zbud
client1# [ 0.679745] AppArmor: AppArmor sha1 policy hashing enabled
tracker# [ 0.967884] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 4.19
router# [ 0.822924] serio: i8042 KBD port at 0x60,0x64 irq 1
tracker# [ 0.969002] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
tracker# [ 0.969966] usb usb1: Product: UHCI Host Controller
client1# [ 0.682510] Freeing unused kernel image memory: 1436K
tracker# [ 0.970618] usb usb1: Manufacturer: Linux 4.19.59 uhci_hcd
tracker# [ 0.971327] usb usb1: SerialNumber: 0000:00:01.2
client1# [ 0.684864] Write protecting the kernel read-only data: 14336k
router# [ 0.827462] serio: i8042 AUX port at 0x60,0x64 irq 12
client1# [ 0.686498] Freeing unused kernel image memory: 2012K
client1# [ 0.687259] Freeing unused kernel image memory: 188K
client1# [ 0.688032] Run /init as init process
client1#
client1# <<< NixOS Stage 1 >>>
client1#
tracker# [ 0.980635] PCI Interrupt Link [LNKA] enabled at IRQ 10
tracker# [ 0.981711] hub 1-0:1.0: USB hub found
tracker# [ 0.982431] hub 1-0:1.0: 2 ports detected
client1# loading module virtio_balloon...
router# [ 0.848819] SCSI subsystem initialized
client1# loading module virtio_console...
client1# loading module virtio_rng...
client1# loading module dm_mod...
router# [ 0.862380] PCI Interrupt Link [LNKC] enabled at IRQ 10
router# [ 0.864127] ACPI: bus type USB registered
tracker# [ 1.011263] PCI Interrupt Link [LNKB] enabled at IRQ 11
router# [ 0.866310] usbcore: registered new interface driver usbfs
router# [ 0.867052] usbcore: registered new interface driver hub
client1# [ 0.725041] device-mapper: ioctl: 4.39.0-ioctl (2018-04-03) initialised: [email protected]
client1# running udev...
client1# [ 0.731068] systemd-udevd[90]: Starting version 242
client1# [ 0.732524] systemd-udevd[91]: Network interface NamePolicy= disabled on kernel command line, ignoring.
router# [ 0.875305] usbcore: registered new device driver usb
client2# [ 0.658921] Freeing initrd memory: 9704K
client2# [ 0.659522] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x31024b3bec5, max_idle_ns: 440795366697 ns
client2# [ 0.660865] Scanning for low memory corruption every 60 seconds
client2# [ 0.662337] Initialise system trusted keyrings
client2# [ 0.662981] workingset: timestamp_bits=40 max_order=17 bucket_order=0
client2# [ 0.664671] zbud: loaded
client2# [ 0.665532] Key type asymmetric registered
client2# [ 0.666096] Asymmetric key parser 'x509' registered
client2# [ 0.666748] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250)
client2# [ 0.667743] io scheduler noop registered
client2# [ 0.668260] io scheduler deadline registered
client2# [ 0.668843] io scheduler cfq registered (default)
client2# [ 0.669463] io scheduler mq-deadline registered
client2# [ 0.670090] io scheduler kyber registered
router# [ 0.892122] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
client2# [ 0.670802] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
router# [ 0.898483] uhci_hcd: USB Universal Host Controller Interface driver
router# [ 0.909291] scsi host0: ata_piix
client1# [ 0.770810] rtc_cmos 00:00: RTC can wake from S4
router# [ 0.916289] scsi host1: ata_piix
client2# [ 0.694847] 00:05: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
router# [ 0.916767] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc1e0 irq 14
client1# [ 0.775996] rtc_cmos 00:00: registered as rtc0
router# [ 0.917694] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc1e8 irq 15
client1# [ 0.776607] rtc_cmos 00:00: alarms up to one day, y3k, 114 bytes nvram, hpet irqs
client2# [ 0.706762] brd: module loaded
client2# [ 0.707318] mce: Using 10 MCE banks
client2# [ 0.707810] sched_clock: Marking stable (620454341, 87327949)->(832568734, -124786444)
client2# [ 0.708961] registered taskstats version 1
client2# [ 0.709500] Loading compiled-in X.509 certificates
client2# [ 0.710148] zswap: loaded using pool lzo/zbud
client2# [ 0.710773] AppArmor: AppArmor sha1 policy hashing enabled
client2# [ 0.713538] Freeing unused kernel image memory: 1436K
router# [ 0.936639] uhci_hcd 0000:00:01.2: UHCI Host Controller
client1# [ 0.794868] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
client2# [ 0.715699] Write protecting the kernel read-only data: 14336k
router# [ 0.937369] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1
client2# [ 0.717389] Freeing unused kernel image memory: 2012K
client2# [ 0.718160] Freeing unused kernel image memory: 188K
router# [ 0.940286] random: fast init done
client2# [ 0.718869] Run /init as init process
router# [ 0.940847] random: crng init done
client2#
client2# <<< NixOS Stage 1 >>>
client2#
router# [ 0.943317] uhci_hcd 0000:00:01.2: detected 2 ports
router# [ 0.944030] uhci_hcd 0000:00:01.2: irq 11, io base 0x0000c0c0
client1# [ 0.803501] serio: i8042 KBD port at 0x60,0x64 irq 1
client1# [ 0.808840] serio: i8042 AUX port at 0x60,0x64 irq 12
router# [ 0.950300] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 4.19
router# [ 0.951459] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
router# [ 0.952453] usb usb1: Product: UHCI Host Controller
router# [ 0.953129] usb usb1: Manufacturer: Linux 4.19.59 uhci_hcd
router# [ 0.953865] usb usb1: SerialNumber: 0000:00:01.2
tracker# [ 1.100466] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100
tracker# [ 1.102113] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5
client2# loading module virtio_balloon...
client2# loading module virtio_console...
router# [ 0.963385] hub 1-0:1.0: USB hub found
router# [ 0.963949] hub 1-0:1.0: 2 ports detected
client2# loading module virtio_rng...
router# [ 0.966466] PCI Interrupt Link [LNKA] enabled at IRQ 10
client1# [ 0.826678] SCSI subsystem initialized
client2# loading module dm_mod...
client2# [ 0.755403] device-mapper: ioctl: 4.39.0-ioctl (2018-04-03) initialised: [email protected]
client2# running udev...
client1# [ 0.841607] ACPI: bus type USB registered
client2# [ 0.761172] systemd-udevd[90]: Starting version 242
client2# [ 0.764150] systemd-udevd[91]: Network interface NamePolicy= disabled on kernel command line, ignoring.
client1# [ 0.844757] PCI Interrupt Link [LNKC] enabled at IRQ 10
client1# [ 0.847874] usbcore: registered new interface driver usbfs
client1# [ 0.848661] usbcore: registered new interface driver hub
client1# [ 0.852911] usbcore: registered new device driver usb
router# [ 0.999002] PCI Interrupt Link [LNKB] enabled at IRQ 11
client1# [ 0.870581] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
client2# [ 0.805107] rtc_cmos 00:00: RTC can wake from S4
client1# [ 0.885299] uhci_hcd: USB Universal Host Controller Interface driver
client1# [ 0.896844] scsi host0: ata_piix
client2# [ 0.823599] rtc_cmos 00:00: registered as rtc0
client1# [ 0.903842] scsi host1: ata_piix
client1# [ 0.904328] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc1c0 irq 14
client1# [ 0.905211] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc1c8 irq 15
client2# [ 0.825760] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
client2# [ 0.828706] rtc_cmos 00:00: alarms up to one day, y3k, 114 bytes nvram, hpet irqs
client2# [ 0.835381] serio: i8042 KBD port at 0x60,0x64 irq 1
client2# [ 0.839700] serio: i8042 AUX port at 0x60,0x64 irq 12
client1# [ 0.922835] random: fast init done
client1# [ 0.923443] random: crng init done
tracker# [ 1.217281] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
router# [ 1.077986] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100
router# [ 1.079806] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5
client1# [ 0.941352] uhci_hcd 0000:00:01.2: UHCI Host Controller
client1# [ 0.942269] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1
tracker# [ 1.230849] 9pnet: Installing 9P2000 support
client1# [ 0.943573] uhci_hcd 0000:00:01.2: detected 2 ports
client2# [ 0.865191] SCSI subsystem initialized
client1# [ 0.944656] PCI Interrupt Link [LNKA] enabled at IRQ 10
client1# [ 0.946950] uhci_hcd 0000:00:01.2: irq 11, io base 0x0000c0c0
client1# [ 0.950862] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 4.19
client1# [ 0.952364] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
client2# [ 0.874266] ACPI: bus type USB registered
client1# [ 0.953798] usb usb1: Product: UHCI Host Controller
client1# [ 0.954670] usb usb1: Manufacturer: Linux 4.19.59 uhci_hcd
client2# [ 0.875347] PCI Interrupt Link [LNKC] enabled at IRQ 10
client1# [ 0.955637] usb usb1: SerialNumber: 0000:00:01.2
client2# [ 0.876716] usbcore: registered new interface driver usbfs
client2# [ 0.877430] usbcore: registered new interface driver hub
tracker# [ 1.245305] virtio_blk virtio8: [vda] 1048576 512-byte logical blocks (537 MB/512 MiB)
client2# [ 0.882744] usbcore: registered new device driver usb
client1# [ 0.967961] hub 1-0:1.0: USB hub found
client1# [ 0.969844] hub 1-0:1.0: 2 ports detected
client2# [ 0.899573] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
tracker# [ 1.269549] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray
tracker# [ 1.270920] cdrom: Uniform CD-ROM driver Revision: 3.20
client2# [ 0.911751] uhci_hcd: USB Universal Host Controller Interface driver
client1# [ 0.998124] PCI Interrupt Link [LNKB] enabled at IRQ 11
client2# [ 0.922695] scsi host0: ata_piix
client2# [ 0.929695] scsi host1: ata_piix
client2# [ 0.930159] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc1c0 irq 14
client2# [ 0.931054] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc1c8 irq 15
client2# [ 0.948071] uhci_hcd 0000:00:01.2: UHCI Host Controller
client2# [ 0.948770] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1
client2# [ 0.949751] uhci_hcd 0000:00:01.2: detected 2 ports
client2# [ 0.950436] uhci_hcd 0000:00:01.2: irq 11, io base 0x0000c0c0
tracker# [ 1.317909] usb 1-1: new full-speed USB device number 2 using uhci_hcd
client2# [ 0.954763] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 4.19
client2# [ 0.955941] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
client2# [ 0.956922] usb usb1: Product: UHCI Host Controller
client2# [ 0.957558] usb usb1: Manufacturer: Linux 4.19.59 uhci_hcd
client2# [ 0.958325] usb usb1: SerialNumber: 0000:00:01.2
client2# [ 0.962765] hub 1-0:1.0: USB hub found
client2# [ 0.963317] hub 1-0:1.0: 2 ports detected
client1# [ 1.068592] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100
client1# [ 1.070231] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5
client2# [ 1.036811] random: fast init done
client2# [ 1.037380] random: crng init done
client2# [ 1.057153] PCI Interrupt Link [LNKA] enabled at IRQ 10
router# [ 1.287290] usb 1-1: new full-speed USB device number 2 using uhci_hcd
client2# [ 1.084759] PCI Interrupt Link [LNKB] enabled at IRQ 11
client2# [ 1.089409] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100
client2# [ 1.091069] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5
router# [ 1.328165] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
tracker# kbd_mode: KDSKBMODE: Inappropriate ioctl for device
tracker# %Gstarting device mapper and LVM...
tracker# [ 1.494149] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00
tracker# [ 1.495337] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10
tracker# [ 1.496536] usb 1-1: Product: QEMU USB Tablet
tracker# [ 1.497126] usb 1-1: Manufacturer: QEMU
tracker# [ 1.497670] usb 1-1: SerialNumber: 28754-0000:00:01.2-1
client1# [ 1.217570] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
tracker# [ 1.519391] hidraw: raw HID events driver (C) Jiri Kosina
router# [ 1.381428] 9pnet: Installing 9P2000 support
tracker# [ 1.527065] usbcore: registered new interface driver usbhid
tracker# [ 1.527917] usbhid: USB HID core driver
tracker# [ 1.529490] 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
router# [ 1.385256] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray
router# [ 1.386219] cdrom: Uniform CD-ROM driver Revision: 3.20
tracker# [ 1.531249] 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
tracker# [ 1.535161] clocksource: Switched to clocksource acpi_pm
tracker# mke2fs 1.45.2 (27-May-2019)
router# [ 1.395533] virtio_blk virtio9: [vda] 1048576 512-byte logical blocks (537 MB/512 MiB)
tracker# Creating filesystem with 131072 4k blocks and 32768 inodes
tracker# Filesystem UUID: 294a75ea-fafa-48e9-acfe-df8a1c38e91a
client1# [ 1.256591] 9pnet: Installing 9P2000 support
tracker# Superblock backups stored on blocks:
tracker# 32768, 98304
tracker#
tracker# Allocating group tables: 0/4 done
client1# [ 1.261158] virtio_blk virtio8: [vda] 1048576 512-byte logical blocks (537 MB/512 MiB)
tracker# Writing inode tables: 0/4 done
tracker# Creating journal (4096 blocks): done
client1# [ 1.287387] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray
client1# [ 1.288535] cdrom: Uniform CD-ROM driver Revision: 3.20
client1# [ 1.301890] usb 1-1: new full-speed USB device number 2 using uhci_hcd
router# [ 1.468597] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00
router# [ 1.471276] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10
router# [ 1.473055] usb 1-1: Product: QEMU USB Tablet
router# [ 1.473705] usb 1-1: Manufacturer: QEMU
router# [ 1.474273] usb 1-1: SerialNumber: 28754-0000:00:01.2-1
router# [ 1.488451] hidraw: raw HID events driver (C) Jiri Kosina
tracker# Writing superblocks and filesystem accounting information: 0/4 done
tracker#
router# [ 1.497443] usbcore: registered new interface driver usbhid
router# [ 1.498341] usbhid: USB HID core driver
router# [ 1.499975] 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
router# [ 1.501686] 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
client2# [ 1.282701] usb 1-1: new full-speed USB device number 2 using uhci_hcd
client2# [ 1.284168] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
tracker# checking /dev/vda...
tracker# fsck (busybox 1.30.1)
tracker# [fsck.ext4 (1) -- /mnt-root/] fsck.ext4 -a /dev/vda
tracker# /dev/vda: clean, 11/32768 files, 6353/131072 blocks
tracker# mounting /dev/vda on /...
client2# [ 1.298637] 9pnet: Installing 9P2000 support
client2# [ 1.326636] virtio_blk virtio8: [vda] 1048576 512-byte logical blocks (537 MB/512 MiB)
client2# [ 1.347877] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray
client2# [ 1.349365] cdrom: Uniform CD-ROM driver Revision: 3.20
tracker# [ 1.719722] EXT4-fs (vda): mounted filesystem with ordered data mode. Opts: (null)
tracker# mounting store on /nix/.ro-store...
tracker# [ 1.737385] FS-Cache: Loaded
tracker# [ 1.741389] 9p: Installing v9fs 9p2000 file system support
tracker# [ 1.742470] FS-Cache: Netfs '9p' registered for caching
tracker# mounting tmpfs on /nix/.rw-store...
router# kbd_mode: KDSKBMODE: Inappropriate ioctl for device
tracker# mounting shared on /tmp/shared...
client1# [ 1.472541] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00
client1# [ 1.473786] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10
router# %Gstarting device mapper and LVM...
client1# [ 1.474796] usb 1-1: Product: QEMU USB Tablet
client1# [ 1.475464] usb 1-1: Manufacturer: QEMU
client1# [ 1.476032] usb 1-1: SerialNumber: 28754-0000:00:01.2-1
tracker# mounting xchg on /tmp/xchg...
client1# [ 1.487415] hidraw: raw HID events driver (C) Jiri Kosina
tracker# mounting overlay filesystem on /nix/store...
router# [ 1.641779] clocksource: Switched to clocksource acpi_pm
client1# [ 1.500232] usbcore: registered new interface driver usbhid
client1# [ 1.501297] usbhid: USB HID core driver
client1# [ 1.503363] 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
client1# [ 1.505550] 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
router# mke2fs 1.45.2 (27-May-2019)
router# Creating filesystem with 131072 4k blocks and 32768 inodes
router# Filesystem UUID: ad53c44d-e98c-4cf6-aa02-45a852923783
router# Superblock backups stored on blocks:
client1# kbd_mode: KDSKBMODE: Inappropriate ioctl for device
router# 32768, 98304
router#
router# Allocating group tables: 0/4 done
client1# %Gstarting device mapper and LVM...
client1# [ 1.529088] clocksource: Switched to clocksource acpi_pm
client2# [ 1.451590] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00
client2# [ 1.453022] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10
client2# [ 1.454255] usb 1-1: Product: QEMU USB Tablet
client2# [ 1.455012] usb 1-1: Manufacturer: QEMU
client2# [ 1.455705] usb 1-1: SerialNumber: 28754-0000:00:01.2-1
client1# mke2fs 1.45.2 (27-May-2019)
client1# Creating filesystem with 131072 4k blocks and 32768 inodes
client1# Filesystem UUID: fb5396b3-b49e-4a40-9813-c625e4835030
client1# Superblock backups stored on blocks:
router# Writing inode tables: 0/4 done
client1# 32768, 98304
client1#
client1# Allocating group tables: 0/4 done
client2# [ 1.466709] hidraw: raw HID events driver (C) Jiri Kosina
router# Creating journal (4096 blocks): done
client1# Writing inode tables: 0/4 done
client1# Creating journal (4096 blocks): done
client2# [ 1.474716] usbcore: registered new interface driver usbhid
client2# [ 1.475565] usbhid: USB HID core driver
client2# [ 1.477426] 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
client2# [ 1.480773] 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
client2# kbd_mode: KDSKBMODE: Inappropriate ioctl for device
client2# %Gstarting device mapper and LVM...
client2# [ 1.579073] clocksource: Switched to clocksource acpi_pm
client2# mke2fs 1.45.2 (27-May-2019)
client2# Creating filesystem with 131072 4k blocks and 32768 inodes
client2# Filesystem UUID: f05c59cb-d9f9-4ab7-b414-89156b59d3a9
client2# Superblock backups stored on blocks:
client2# 32768, 98304
client2#
client2# Allocating group tables: 0/4 done
router# Writing superblocks and filesystem accounting information: 0/4 done
router#
client1# Writing superblocks and filesystem accounting information: 0/4 done
client1#
client2# Writing inode tables: 0/4 done
client2# Creating journal (4096 blocks): done
router# checking /dev/vda...
client1# checking /dev/vda...
router# fsck (busybox 1.30.1)
client1# fsck (busybox 1.30.1)
router# [fsck.ext4 (1) -- /mnt-root/] fsck.ext4 -a /dev/vda
client1# [fsck.ext4 (1) -- /mnt-root/] fsck.ext4 -a /dev/vda
router# /dev/vda: clean, 11/32768 files, 6353/131072 blocks
client1# /dev/vda: clean, 11/32768 files, 6353/131072 blocks
tracker#
tracker# <<< NixOS Stage 2 >>>
tracker#
client1# mounting /dev/vda on /...
router# mounting /dev/vda on /...
client2# Writing superblocks and filesystem accounting information: 0/4 done
client2#
client2# checking /dev/vda...
client2# fsck (busybox 1.30.1)
client2# [fsck.ext4 (1) -- /mnt-root/] fsck.ext4 -a /dev/vda
client2# /dev/vda: clean, 11/32768 files, 6353/131072 blocks
client2# mounting /dev/vda on /...
tracker# [ 2.206108] EXT4-fs (vda): re-mounted. Opts: (null)
tracker# [ 2.207976] booting system configuration /nix/store/25fbd9dqrlifnxbifaqlh2ir6kkr0lsq-nixos-system-tracker-19.09.git.771985d
client1# [ 1.943740] EXT4-fs (vda): mounted filesystem with ordered data mode. Opts: (null)
router# [ 2.089745] EXT4-fs (vda): mounted filesystem with ordered data mode. Opts: (null)
client1# mounting store on /nix/.ro-store...
router# mounting store on /nix/.ro-store...
client1# [ 1.961074] FS-Cache: Loaded
router# [ 2.106373] FS-Cache: Loaded
client1# [ 1.965147] 9p: Installing v9fs 9p2000 file system support
client1# [ 1.966303] FS-Cache: Netfs '9p' registered for caching
router# [ 2.110528] 9p: Installing v9fs 9p2000 file system support
router# [ 2.111683] FS-Cache: Netfs '9p' registered for caching
client2# [ 1.891412] EXT4-fs (vda): mounted filesystem with ordered data mode. Opts: (null)
client1# mounting tmpfs on /nix/.rw-store...
router# mounting tmpfs on /nix/.rw-store...
client2# mounting store on /nix/.ro-store...
client1# mounting shared on /tmp/shared...
router# mounting shared on /tmp/shared...
client2# [ 1.908379] FS-Cache: Loaded
client2# [ 1.912044] 9p: Installing v9fs 9p2000 file system support
client2# [ 1.913135] FS-Cache: Netfs '9p' registered for caching
client1# mounting xchg on /tmp/xchg...
router# mounting xchg on /tmp/xchg...
client1# mounting overlay filesystem on /nix/store...
client2# mounting tmpfs on /nix/.rw-store...
router# mounting overlay filesystem on /nix/store...
client2# mounting shared on /tmp/shared...
client2# mounting xchg on /tmp/xchg...
client2# mounting overlay filesystem on /nix/store...
tracker# running activation script...
router#
router# <<< NixOS Stage 2 >>>
router#
client1#
client1# <<< NixOS Stage 2 >>>
client1#
client2#
client2# <<< NixOS Stage 2 >>>
client2#
router# [ 2.303940] EXT4-fs (vda): re-mounted. Opts: (null)
router# [ 2.305890] booting system configuration /nix/store/wrjiykljl2kkrpi4bfck2fr1cbb0fhns-nixos-system-router-19.09.git.771985d
client1# [ 2.168991] EXT4-fs (vda): re-mounted. Opts: (null)
client1# [ 2.170950] booting system configuration /nix/store/39js8rhgjw2z0b9rilizimvlhrshii03-nixos-system-client1-19.09.git.771985d
client2# [ 2.116899] EXT4-fs (vda): re-mounted. Opts: (null)
client2# [ 2.118772] booting system configuration /nix/store/xwyb06m80vl103cg5z9n5v1sl18c4sw3-nixos-system-client2-19.09.git.771985d
router# running activation script...
client1# running activation script...
client2# running activation script...
tracker# setting up /etc...
router# setting up /etc...
client2# setting up /etc...
client1# setting up /etc...
client2# starting systemd...
tracker# starting systemd...
client1# starting systemd...
router# starting systemd...
client1# [ 4.267604] systemd[1]: Inserted module 'autofs4'
tracker# [ 4.555952] systemd[1]: Inserted module 'autofs4'
router# [ 4.410189] systemd[1]: Inserted module 'autofs4'
client2# [ 4.198451] systemd[1]: Inserted module 'autofs4'
router# [ 4.454326] NET: Registered protocol family 10
router# [ 4.455248] Segment Routing with IPv6
tracker# [ 4.602517] NET: Registered protocol family 10
tracker# [ 4.603416] Segment Routing with IPv6
client1# [ 4.329210] NET: Registered protocol family 10
client2# [ 4.249954] NET: Registered protocol family 10
client1# [ 4.330055] Segment Routing with IPv6
client2# [ 4.250891] Segment Routing with IPv6
router# [ 4.485032] systemd[1]: systemd 242 running in system mode. (+PAM +AUDIT -SELINUX +IMA +APPARMOR +SMACK -SYSVINIT +UTMP -LIBCRYPTSETUP +GCRYPT -GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID -ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=hybrid)
tracker# [ 4.631046] systemd[1]: systemd 242 running in system mode. (+PAM +AUDIT -SELINUX +IMA +APPARMOR +SMACK -SYSVINIT +UTMP -LIBCRYPTSETUP +GCRYPT -GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID -ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=hybrid)
router# [ 4.488174] systemd[1]: Detected virtualization kvm.
router# [ 4.488915] systemd[1]: Detected architecture x86-64.
tracker# [ 4.634668] systemd[1]: Detected virtualization kvm.
tracker# [ 4.635554] systemd[1]: Detected architecture x86-64.
client1# [ 4.345969] systemd[1]: systemd 242 running in system mode. (+PAM +AUDIT -SELINUX +IMA +APPARMOR +SMACK -SYSVINIT +UTMP -LIBCRYPTSETUP +GCRYPT -GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID -ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=hybrid)
client2# [ 4.266345] systemd[1]: systemd 242 running in system mode. (+PAM +AUDIT -SELINUX +IMA +APPARMOR +SMACK -SYSVINIT +UTMP -LIBCRYPTSETUP +GCRYPT -GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID -ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=hybrid)
client2# [ 4.269359] systemd[1]: Detected virtualization kvm.
client1# [ 4.349127] systemd[1]: Detected virtualization kvm.
client2# [ 4.270130] systemd[1]: Detected architecture x86-64.
client1# [ 4.350039] systemd[1]: Detected architecture x86-64.
router# [ 4.493224] systemd[1]: Set hostname to <router>.
tracker# [ 4.639640] systemd[1]: Set hostname to <tracker>.
client2# [ 4.273528] systemd[1]: Set hostname to <client2>.
client1# [ 4.353467] systemd[1]: Set hostname to <client1>.
client1# [ 4.356804] systemd[1]: Initializing machine ID from random generator.
client2# [ 4.277909] systemd[1]: Initializing machine ID from random generator.
tracker# [ 4.645155] systemd[1]: Initializing machine ID from random generator.
router# [ 4.499129] systemd[1]: Initializing machine ID from random generator.
client1# [ 4.359790] systemd[1]: Failed to bump fs.file-max, ignoring: Invalid argument
client2# [ 4.281545] systemd[1]: Failed to bump fs.file-max, ignoring: Invalid argument
router# [ 4.503264] systemd[1]: Failed to bump fs.file-max, ignoring: Invalid argument
tracker# [ 4.649164] systemd[1]: Failed to bump fs.file-max, ignoring: Invalid argument
tracker# [ 4.723823] systemd-fstab-generator[365]: Checking was requested for "store", but it is not a device.
tracker# [ 4.732027] systemd-fstab-generator[365]: Checking was requested for "shared", but it is not a device.
tracker# [ 4.734554] systemd-fstab-generator[365]: Checking was requested for "xchg", but it is not a device.
client1# [ 4.453111] systemd-fstab-generator[365]: Checking was requested for "store", but it is not a device.
client1# [ 4.457451] systemd-fstab-generator[365]: Checking was requested for "shared", but it is not a device.
router# [ 4.601107] systemd-fstab-generator[365]: Checking was requested for "store", but it is not a device.
client2# [ 4.380133] systemd-fstab-generator[365]: Checking was requested for "store", but it is not a device.
client1# [ 4.461057] systemd-fstab-generator[365]: Checking was requested for "xchg", but it is not a device.
router# [ 4.603252] systemd-fstab-generator[365]: Checking was requested for "shared", but it is not a device.
client2# [ 4.382673] systemd-fstab-generator[365]: Checking was requested for "shared", but it is not a device.
router# [ 4.605124] systemd-fstab-generator[365]: Checking was requested for "xchg", but it is not a device.
client2# [ 4.384540] systemd-fstab-generator[365]: Checking was requested for "xchg", but it is not a device.
client1# [ 4.867187] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
client1# [ 4.868458] systemd[1]: Reached target Containers.
client2# [ 4.789066] systemd[1]: Listening on Journal Audit Socket.
client1# [ 4.869826] systemd[1]: Listening on Journal Audit Socket.
client1# [ 4.870749] systemd[1]: Listening on initctl Compatibility Named Pipe.
client2# [ 4.790903] systemd[1]: Created slice User and Session Slice.
client2# [ 4.792044] systemd[1]: Reached target Slices.
client2# [ 4.793015] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
router# [ 5.015667] systemd[1]: Reached target Swap.
tracker# [ 5.161601] systemd[1]: Listening on Journal Socket.
router# [ 5.016627] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
router# [ 5.018475] systemd[1]: Listening on Journal Socket.
tracker# [ 5.164100] systemd[1]: Starting Load Kernel Modules...
tracker# [ 5.166316] systemd[1]: Listening on udev Control Socket.
router# [ 5.020499] systemd[1]: Starting Create list of required static device nodes for the current kernel...
tracker# [ 5.167413] systemd[1]: Reached target Swap.
client2# [ 4.876679] EXT4-fs (vda): re-mounted. Opts: (null)
client1# [ 4.962982] loop: module loaded
tracker# [ 5.259690] EXT4-fs (vda): re-mounted. Opts: (null)
client1# [ 4.991039] EXT4-fs (vda): re-mounted. Opts: (null)
tracker# [ 5.287681] loop: module loaded
client2# [ 4.924803] loop: module loaded
router# [ 5.150085] EXT4-fs (vda): re-mounted. Opts: (null)
router# [ 5.157615] loop: module loaded
tracker# [ 6.066671] audit: type=1130 audit(1563769891.530:2): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-udevd comm="systemd" exe="/nix/store/wzrglgf7i2zajmm5k53hypgnv3n0z3v6-systemd-242/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
tracker# [ 6.078399] audit: type=1130 audit(1563769891.540:3): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-journald comm="systemd" exe="/nix/store/wzrglgf7i2zajmm5k53hypgnv3n0z3v6-systemd-242/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
client2# [ 5.717734] audit: type=1130 audit(1563769891.137:2): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-journald comm="systemd" exe="/nix/store/wzrglgf7i2zajmm5k53hypgnv3n0z3v6-systemd-242/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
client1# [ 5.801712] audit: type=1130 audit(1563769891.271:2): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-udevd comm="systemd" exe="/nix/store/wzrglgf7i2zajmm5k53hypgnv3n0z3v6-systemd-242/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
client2# [ 5.640995] systemd-modules-load[380]: Failed to find module 'gcov-proc'
tracker# [ 6.004409] systemd-modules-load[371]: Failed to find module 'gcov-proc'
tracker# [ 6.023150] systemd-modules-load[371]: Inserted module 'loop'
client2# [ 5.654095] systemd-modules-load[380]: Inserted module 'loop'
tracker# [ 6.027762] systemd-udevd[385]: Network interface NamePolicy= disabled on kernel command line, ignoring.
client2# [ 5.746207] audit: type=1130 audit(1563769891.166:3): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-udevd comm="systemd" exe="/nix/store/wzrglgf7i2zajmm5k53hypgnv3n0z3v6-systemd-242/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
tracker# [ 6.031467] systemd[1]: Starting Flush Journal to Persistent Storage...
client1# [ 5.838495] audit: type=1130 audit(1563769891.307:3): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-journald comm="systemd" exe="/nix/store/wzrglgf7i2zajmm5k53hypgnv3n0z3v6-systemd-242/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
client1# [ 5.769125] systemd-modules-load[375]: Failed to find module 'gcov-proc'
client2# [ 5.667964] systemd-udevd[385]: Network interface NamePolicy= disabled on kernel command line, ignoring.
client2# [ 5.685204] systemd[1]: Starting Flush Journal to Persistent Storage...
client2# [ 5.689079] systemd[1]: Started udev Kernel Device Manager.
tracker# [ 6.146049] systemd-journald[373]: Received request to flush runtime journal from PID 1
client1# [ 5.785517] systemd-modules-load[375]: Inserted module 'loop'
client1# [ 5.790582] systemd-udevd[385]: Network interface NamePolicy= disabled on kernel command line, ignoring.
client1# [ 5.795719] systemd[1]: Starting Flush Journal to Persistent Storage...
router# [ 6.043680] audit: type=1325 audit(1563769891.400:2): table=nat family=2 entries=5
router# [ 6.044888] audit: type=1300 audit(1563769891.400:2): arch=c000003e syscall=54 success=yes exit=0 a0=4 a1=0 a2=40 a3=13e3a20 items=0 ppid=385 pid=471 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="iptables" exe="/nix/store/kr4iias7wcrvac5j9h1lwdycvr5v1gmm-iptables-1.8.3/bin/xtables-legacy-multi" subj==unconfined key=(null)
client2# [ 5.837386] systemd-journald[376]: Received request to flush runtime journal from PID 1
client1# [ 5.917817] systemd-journald[374]: Received request to flush runtime journal from PID 1
router# [ 6.062994] audit: type=1327 audit(1563769891.400:2): proctitle=69707461626C6573002D77002D74006E6174002D4E006E69786F732D6E61742D707265
tracker# [ 6.134204] systemd[1]: Started Flush Journal to Persistent Storage.
router# [ 6.072334] audit: type=1325 audit(1563769891.413:3): table=nat family=2 entries=7
tracker# [ 6.216780] audit: type=1130 audit(1563769891.678:4): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-journal-flush comm="systemd" exe="/nix/store/wzrglgf7i2zajmm5k53hypgnv3n0z3v6-systemd-242/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
router# [ 6.073788] audit: type=1300 audit(1563769891.413:3): arch=c000003e syscall=54 success=yes exit=0 a0=4 a1=0 a2=40 a3=206ac00 items=0 ppid=385 pid=472 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="iptables" exe="/nix/store/kr4iias7wcrvac5j9h1lwdycvr5v1gmm-iptables-1.8.3/bin/xtables-legacy-multi" subj==unconfined key=(null)
tracker# [ 6.141652] systemd[1]: Starting Create Volatile Files and Directories...
router# [ 6.098603] audit: type=1327 audit(1563769891.413:3): proctitle=69707461626C6573002D77002D74006E6174002D4E006E69786F732D6E61742D706F7374
tracker# [ 6.165854] systemd[1]: Started Create Volatile Files and Directories.[ 6.247986] audit: type=1130 audit(1563769891.710:5): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/nix/store/wzrglgf7i2zajmm5k53hypgnv3n0z3v6-systemd-242/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
tracker#
router# [ 6.105961] audit: type=1325 audit(1563769891.452:4): table=nat family=2 entries=9
tracker# [ 6.171568] systemd[1]: Starting Update UTMP about System Boot/Shutdown...
router# [ 6.108981] audit: type=1300 audit(1563769891.452:4): arch=c000003e syscall=54 success=yes exit=0 a0=4 a1=0 a2=40 a3=591b00 items=0 ppid=385 pid=473 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="iptables" exe="/nix/store/kr4iias7wcrvac5j9h1lwdycvr5v1gmm-iptables-1.8.3/bin/xtables-legacy-multi" subj==unconfined key=(null)
tracker# [ 6.177105] systemd[1]: Starting Rebuild Journal Catalog...
router# [ 6.124529] audit: type=1327 audit(1563769891.452:4): proctitle=69707461626C6573002D77002D74006E6174002D41006E69786F732D6E61742D707265002D690065746832002D6A004D41524B002D2D7365742D6D61726B0031
tracker# [ 6.275010] audit: type=1127 audit(1563769891.739:6): pid=395 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg=' comm="systemd-update-utmp" exe="/nix/store/wzrglgf7i2zajmm5k53hypgnv3n0z3v6-systemd-242/lib/systemd/systemd-update-utmp" hostname=? addr=? terminal=? res=success'
client1# [ 5.913643] systemd[1]: Started Flush Journal to Persistent Storage.[ 5.992276] audit: type=1130 audit(1563769891.460:4): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-journal-flush comm="systemd" exe="/nix/store/wzrglgf7i2zajmm5k53hypgnv3n0z3v6-systemd-242/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
client1#
router# [ 6.139675] audit: type=1325 audit(1563769891.497:5): table=nat family=2 entries=10
client2# [ 5.828153] systemd[1]: Started Flush Journal to Persistent Storage.[ 5.916734] audit: type=1130 audit(1563769891.334:4): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-journal-flush comm="systemd" exe="/nix/store/wzrglgf7i2zajmm5k53hypgnv3n0z3v6-systemd-242/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
client2#
tracker# [ 6.205774] systemd[1]: Started Update UTMP about System Boot/Shutdown.[ 6.287935] audit: type=1130 audit(1563769891.750:7): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-update-utmp comm="systemd" exe="/nix/store/wzrglgf7i2zajmm5k53hypgnv3n0z3v6-systemd-242/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
client1# [ 5.923153] systemd[1]: Starting Create Volatile Files and Directories...
client2# [ 5.835450] systemd[1]: Starting Create Volatile Files and Directories...
tracker#
tracker# [ 6.234599] systemd[1]: Started Rebuild Journal Catalog.
client2# [ 5.859481] systemd[1]: Started Create Volatile Files and Directories.[ 5.947771] audit: type=1130 audit(1563769891.366:5): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/nix/store/wzrglgf7i2zajmm5k53hypgnv3n0z3v6-systemd-242/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
client2#
tracker# [ 6.316868] audit: type=1130 audit(1563769891.779:8): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-journal-catalog-update comm="systemd" exe="/nix/store/wzrglgf7i2zajmm5k53hypgnv3n0z3v6-systemd-242/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
client1# [ 5.951607] systemd[1]: Started Create Volatile Files and Directories.[ 6.030000] audit: type=1130 audit(1563769891.498:5): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/nix/store/wzrglgf7i2zajmm5k53hypgnv3n0z3v6-systemd-242/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
client1#
client2# [ 5.865752] systemd[1]: Starting Update UTMP about System Boot/Shutdown...
tracker# [ 6.242013] systemd[1]: Starting Update is Completed...
client1# [ 5.958585] systemd[1]: Starting Update UTMP about System Boot/Shutdown...
client2# [ 5.873238] systemd[1]: Starting Rebuild Journal Catalog...
client1# [ 5.967046] systemd[1]: Starting Rebuild Journal Catalog...
tracker# [ 6.263545] systemd[1]: Started Update is Completed.
tracker# [ 6.345921] audit: type=1130 audit(1563769891.808:9): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-update-done comm="systemd" exe="/nix/store/wzrglgf7i2zajmm5k53hypgnv3n0z3v6-systemd-242/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
client1# [ 6.059001] audit: type=1127 audit(1563769891.529:6): pid=397 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg=' comm="systemd-update-utmp" exe="/nix/store/wzrglgf7i2zajmm5k53hypgnv3n0z3v6-systemd-242/lib/systemd/systemd-update-utmp" hostname=? addr=? terminal=? res=success'
client1# [ 6.069672] audit: type=1130 audit(1563769891.539:7): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-update-utmp comm="systemd" exe="/nix/store/wzrglgf7i2zajmm5k53hypgnv3n0z3v6-systemd-242/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
client2# [ 5.990317] audit: type=1127 audit(1563769891.410:6): pid=398 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg=' comm="systemd-update-utmp" exe="/nix/store/wzrglgf7i2zajmm5k53hypgnv3n0z3v6-systemd-242/lib/systemd/systemd-update-utmp" hostname=? addr=? terminal=? res=success'
client1# [ 5.997249] systemd[1]: Started Update UTMP about System Boot/Shutdown.
client2# [ 5.917707] systemd[1]: Started Update UTMP about System Boot/Shutdown.[ 6.006330] audit: type=1130 audit(1563769891.425:7): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-update-utmp comm="systemd" exe="/nix/store/wzrglgf7i2zajmm5k53hypgnv3n0z3v6-systemd-242/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
client2#
client1# [ 6.030614] systemd[1]: Started Rebuild Journal Catalog.[ 6.108895] audit: type=1130 audit(1563769891.577:8): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-journal-catalog-update comm="systemd" exe="/nix/store/wzrglgf7i2zajmm5k53hypgnv3n0z3v6-systemd-242/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
client1#
client1# [ 6.038344] systemd[1]: Starting Update is Completed...
client2# [ 5.962509] systemd[1]: Started Rebuild Journal Catalog.[ 6.050957] audit: type=1130 audit(1563769891.469:8): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-journal-catalog-update comm="systemd" exe="/nix/store/wzrglgf7i2zajmm5k53hypgnv3n0z3v6-systemd-242/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
client2#
client2# [ 5.970491] systemd[1]: Starting Update is Completed...
client1# [ 6.058837] systemd[1]: Started Update is Completed.[ 6.137239] audit: type=1130 audit(1563769891.605:9): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-update-done comm="systemd" exe="/nix/store/wzrglgf7i2zajmm5k53hypgnv3n0z3v6-systemd-242/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
client1#
tracker# [ 6.428296] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3
tracker# [ 6.430580] ACPI: Power Button [PWRF]
client2# [ 5.992766] systemd[1]: Started Update is Completed.
client2# [ 6.081645] audit: type=1130 audit(1563769891.500:9): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-update-done comm="systemd" exe="/nix/store/wzrglgf7i2zajmm5k53hypgnv3n0z3v6-systemd-242/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
client1# [ 6.194755] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3
client1# [ 6.195983] ACPI: Power Button [PWRF]
client2# [ 6.135919] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3
client2# [ 6.137114] ACPI: Power Button [PWRF]
tracker# [ 6.505776] parport_pc 00:04: reported by Plug and Play ACPI
tracker# [ 6.508990] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]
tracker# [ 6.522858] Floppy drive(s): fd0 is 2.88M AMI BIOS
tracker# [ 6.541395] FDC 0 is a S82078B
tracker# [ 6.552697] Linux agpgart interface v0.103
client1# [ 6.269446] parport_pc 00:04: reported by Plug and Play ACPI
client1# [ 6.271686] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]
router# [ 6.414817] systemd-journald[375]: Received request to flush runtime journal from PID 1
client1# [ 6.287161] Floppy drive(s): fd0 is 2.88M AMI BIOS
client2# [ 6.209235] parport_pc 00:04: reported by Plug and Play ACPI
client1# [ 6.299447] Linux agpgart interface v0.103
client1# [ 6.304502] FDC 0 is a S82078B
tracker# [ 6.510993] systemd-udevd[391]: Using default interface naming scheme 'v240'.
client2# [ 6.226821] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]
client2# [ 6.230362] Floppy drive(s): fd0 is 2.88M AMI BIOS
tracker# [ 6.527840] systemd-udevd[400]: Using default interface naming scheme 'v240'.
tracker# [ 6.617175] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0
client2# [ 6.250376] FDC 0 is a S82078B
tracker# [ 6.545596] systemd-udevd[391]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
tracker# [ 6.552024] systemd-udevd[400]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
client2# [ 6.272469] Linux agpgart interface v0.103
client1# [ 6.274763] systemd-udevd[401]: Using default interface naming scheme 'v240'.
client1# [ 6.311613] systemd-udevd[401]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
client2# [ 6.225527] systemd-udevd[402]: Using default interface naming scheme 'v240'.
client2# [ 6.323470] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0
client1# [ 6.326575] systemd-udevd[389]: Using default interface naming scheme 'v240'.
client2# [ 6.252006] systemd-udevd[402]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
router# [ 6.481635] systemd-modules-load[373]: Failed to find module 'gcov-proc'
client2# [ 6.263237] systemd-udevd[396]: Using default interface naming scheme 'v240'.
router# [ 6.492375] systemd-modules-load[373]: Inserted module 'loop'
client1# [ 6.355436] systemd-udevd[389]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
client1# [ 6.440989] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0
router# [ 6.499145] systemd-modules-load[373]: Inserted module 'nf_nat_ftp'
router# [ 6.513843] systemd-udevd[384]: Network interface NamePolicy= disabled on kernel command line, ignoring.
client2# [ 6.294488] systemd-udevd[396]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
router# [ 6.527541] systemd[1]: Starting Flush Journal to Persistent Storage...
router# [ 6.534384] systemd[1]: Started Firewall.
router# [ 6.538094] systemd[1]: Started Flush Journal to Persistent Storage.
router# [ 6.541650] systemd[1]: Starting Create Volatile Files and Directories...
tracker# [ 6.767640] mousedev: PS/2 mouse device common for all mice
router# [ 6.545887] systemd[1]: Started Create Volatile Files and Directories.
router# [ 6.548897] systemd[1]: Starting Rebuild Journal Catalog...
router# [ 6.553158] systemd[1]: Starting Update UTMP about System Boot/Shutdown...
tracker# [ 6.697711] systemd[1]: Found device /dev/ttyS0.
router# [ 6.556623] systemd[1]: Started Update UTMP about System Boot/Shutdown.
router# [ 6.560569] systemd[1]: Started Rebuild Journal Catalog.
client1# [ 6.497540] mousedev: PS/2 mouse device common for all mice
router# [ 6.563544] systemd[1]: Starting Update is Completed...
router# [ 6.567136] firewall-start[385]: + export 'PATH=/nix/store/4gmp5qxbvig77nxnq7af7430dd5vfdkb-which-2.21/bin:/nix/store/9gs2k6xcfddnpff0yraz0l8wz1ijammg-iproute2-5.1.0/bin:/nix/store/kr4iias7wcrvac5j9h1lwdycvr5v1gmm-iptables-1.8.3/bin:/nix/store/vnyd3wh5i5kj66n9c5b8shzxjjrw22cn-gnused-4.7/bin:/nix/store/k8lhqzpaaymshchz8ky3z4653h4kln9d-coreutils-8.31/bin:/nix/store/5x5a1bb8rk317z5l1824j84nwmmd5w52-gawk-4.2.1/bin:$PATH'
router# [ 6.576154] firewall-start[385]: + PATH='/nix/store/4gmp5qxbvig77nxnq7af7430dd5vfdkb-which-2.21/bin:/nix/store/9gs2k6xcfddnpff0yraz0l8wz1ijammg-iproute2-5.1.0/bin:/nix/store/kr4iias7wcrvac5j9h1lwdycvr5v1gmm-iptables-1.8.3/bin:/nix/store/vnyd3wh5i5kj66n9c5b8shzxjjrw22cn-gnused-4.7/bin:/nix/store/k8lhqzpaaymshchz8ky3z4653h4kln9d-coreutils-8.31/bin:/nix/store/5x5a1bb8rk317z5l1824j84nwmmd5w52-gawk-4.2.1/bin:$PATH'
router# [ 6.585116] firewall-start[385]: + exec -a /nix/store/7w0pyww6gmprfqa1chgaz8wi1xcmk00s-miniupnpd-2.1.20190502/etc/miniupnpd/iptables_init.sh /nix/store/7w0pyww6gmprfqa1chgaz8wi1xcmk00s-miniupnpd-2.1.20190502/etc/miniupnpd/.iptables_init.sh-wrapped -i eth1
router# [ 6.591937] firewall-start[385]: NAT table clean..initalizing..
router# [ 6.594033] firewall-start[385]: Mangle table clean..initializing...
router# [ 6.596037] firewall-start[385]: Filter table clean..initalizing..
router# [ 6.598082] firewall-start[385]: POSTROUTING NAT table clean..initalizing..
router# [ 6.601350] systemd[1]: Started Update is Completed.
client1# [ 6.484520] systemd[1]: Found device /dev/ttyS0.
client2# [ 6.486577] mousedev: PS/2 mouse device common for all mice
router# [ 6.727131] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3
router# [ 6.728405] ACPI: Power Button [PWRF]
client2# [ 6.443961] systemd[1]: Found device /dev/ttyS0.
client1# [ 6.571415] systemd[1]: Found device Virtio network device.
router# [ 6.798462] parport_pc 00:04: reported by Plug and Play ACPI
router# [ 6.808039] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]
router# [ 6.810592] Floppy drive(s): fd0 is 2.88M AMI BIOS
client1# [ 6.601322] systemd[1]: Found device Virtio network device.
router# [ 6.825822] FDC 0 is a S82078B
client2# [ 6.531583] systemd[1]: Found device Virtio network device.
router# [ 6.842017] Linux agpgart interface v0.103
client2# [ 6.542186] systemd[1]: Found device Virtio network device.
router# [ 6.780602] systemd-udevd[525]: Using default interface naming scheme 'v240'.
router# [ 6.792488] systemd-udevd[525]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
router# [ 6.890526] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0
tracker# [ 6.978399] systemd[1]: Found device Virtio network device.
router# [ 6.839975] systemd-udevd[489]: Using default interface naming scheme 'v240'.
router# [ 6.925346] mousedev: PS/2 mouse device common for all mice
tracker# [ 6.995883] systemd-udevd[389]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
router# [ 6.854143] systemd-udevd[491]: Using default interface naming scheme 'v240'.
router# [ 6.871890] systemd-udevd[489]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
tracker# [ 7.024145] systemd[1]: Found device /dev/hvc0.
router# [ 6.891716] systemd-udevd[491]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
client1# [ 6.764024] systemd-udevd[402]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
client1# [ 6.799797] systemd[1]: Found device /dev/hvc0.
client2# [ 6.715216] systemd-udevd[396]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
client2# [ 6.784521] systemd[1]: Found device /dev/hvc0.
client1# [ 6.966139] [drm] Found bochs VGA, ID 0xb0c0.
client1# [ 6.967039] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.
router# [ 7.039145] systemd[1]: Found device /dev/ttyS0.
tracker# [ 7.266053] [drm] Found bochs VGA, ID 0xb0c0.
tracker# [ 7.266995] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.
client1# [ 6.980888] [TTM] Zone kernel: Available graphics memory: 183820 kiB
client1# [ 6.982049] [TTM] Initializing pool allocator
client1# [ 6.988889] [TTM] Initializing DMA pool allocator
tracker# [ 7.281365] [TTM] Zone kernel: Available graphics memory: 183820 kiB
tracker# [ 7.282665] [TTM] Initializing pool allocator
tracker# [ 7.288982] [TTM] Initializing DMA pool allocator
tracker# [ 7.303398] ppdev: user-space parallel port driver
client2# [ 6.938890] [drm] Found bochs VGA, ID 0xb0c0.
client1# [ 6.998664] fbcon: bochsdrmfb (fb0) is primary device
client2# [ 6.939752] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.
client1# [ 7.015619] Console: switching to colour frame buffer device 128x48
client1# [ 7.026737] bochs-drm 0000:00:02.0: fb0: bochsdrmfb frame buffer device
client2# [ 6.953341] [TTM] Zone kernel: Available graphics memory: 184672 kiB
client2# [ 6.954499] [TTM] Initializing pool allocator
client1# [ 7.035054] [drm] Initialized bochs-drm 1.0.0 20130925 for 0000:00:02.0 on minor 0
client2# [ 6.960350] [TTM] Initializing DMA pool allocator
client1# [ 7.044327] ppdev: user-space parallel port driver
tracker# [ 7.305844] fbcon: bochsdrmfb (fb0) is primary device
router# [ 7.115307] systemd[1]: Found device Virtio network device.
tracker# [ 7.334841] Console: switching to colour frame buffer device 128x48
router# [ 7.130234] systemd[1]: Found device Virtio network device.
tracker# [ 7.357548] bochs-drm 0000:00:02.0: fb0: bochsdrmfb frame buffer device
tracker# [ 7.359243] [drm] Initialized bochs-drm 1.0.0 20130925 for 0000:00:02.0 on minor 0
client2# [ 6.969823] fbcon: bochsdrmfb (fb0) is primary device
client2# [ 6.989581] Console: switching to colour frame buffer device 128x48
router# [ 7.151404] systemd[1]: Found device Virtio network device.
client2# [ 7.010209] bochs-drm 0000:00:02.0: fb0: bochsdrmfb frame buffer device
client2# [ 7.019278] [drm] Initialized bochs-drm 1.0.0 20130925 for 0000:00:02.0 on minor 0
client2# [ 7.024856] ppdev: user-space parallel port driver
tracker# [ 7.484723] input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input4
router# [ 7.318909] systemd-udevd[489]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
router# [ 7.366315] systemd[1]: Found device /dev/hvc0.
client2# [ 7.225860] input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input4
client1# [ 7.317114] input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input4
tracker# [ 7.695028] audit: type=1130 audit(1563769893.157:10): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-udev-settle comm="systemd" exe="/nix/store/wzrglgf7i2zajmm5k53hypgnv3n0z3v6-systemd-242/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
client1# [ 7.406970] audit: type=1130 audit(1563769892.876:10): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-udev-settle comm="systemd" exe="/nix/store/wzrglgf7i2zajmm5k53hypgnv3n0z3v6-systemd-242/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
tracker# [ 7.619257] systemd[1]: Started udev Wait for Complete Device Initialization.
client1# [ 7.336107] systemd[1]: Started udev Wait for Complete Device Initialization.
tracker# [ 7.622335] systemd[1]: Reached target System Initialization.
client1# [ 7.342306] systemd[1]: Reached target System Initialization.
client1# [ 7.344745] systemd[1]: Listening on D-Bus System Message Bus Socket.
client2# [ 7.344921] audit: type=1130 audit(1563769892.763:10): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-udev-settle comm="systemd" exe="/nix/store/wzrglgf7i2zajmm5k53hypgnv3n0z3v6-systemd-242/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
tracker# [ 7.628638] systemd[ 7.711571] audit: type=1130 audit(1563769893.174:11): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=backdoor comm="systemd" exe="/nix/store/wzrglgf7i2zajmm5k53hypgnv3n0z3v6-systemd-242/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
client2# [ 7.261884] systemd[1]: Started udev Wait for Complete Device Initialization.
tracker# [1]: Listening on Nix Daemon Socket.
client1# [ 7.429615] audit: type=1130 audit(1563769892.899:11): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=backdoor comm="systemd" exe="/nix/store/wzrglgf7i2zajmm5k53hypgnv3n0z3v6-systemd-242/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
client2# [ 7.264919] systemd[1]: Reached target System Initialization.
client2# [ 7.357833] audit: type=1130 audit(1563769892.777:11): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=backdoor comm="systemd" exe="/nix/store/wzrglgf7i2zajmm5k53hypgnv3n0z3v6-systemd-242/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
client1# [ 7.356164] systemd[1]: Started Daily Cleanup of Temporary Directories.
client2# [ 7.279608] systemd[1]: Listening on Nix Daemon Socket.
tracker# [ 7.652544] systemd[1]: Started Daily Cleanup of Temporary Directories.
tracker# [ 7.676402] systemd[1]: Reached target Timers.
client1# [ 7.389299] systemd[1]: Reached target Timers.
client2# [ 7.298339] systemd[1]: Started Daily Cleanup of Temporary Directories.
client2# [ 7.321541] systemd[1]: Reached target Timers.
tracker# [ 7.694156] systemd[1]: Listening on D-Bus System Message Bus Socket.
router# [ 7.638767] [drm] Found bochs VGA, ID 0xb0c0.
router# [ 7.639674] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.
router# [ 7.648077] ppdev: user-space parallel port driver
router# [ 7.649144] [TTM] Zone kernel: Available graphics memory: 183820 kiB
client1# [ 7.406345] dhcpcd[423]: dev: loaded udev
tracker# [ 7.713594] gqa4kkyhzfmyrycx8kcy64356lwsfj42-audit-disable[424]: No rules
router# [ 7.650626] [TTM] Initializing pool allocator
tracker# [ 7.718146] dhcpcd[427]: dev: loaded udev
client1# [ 7.434672] systemd[1]: Listening on Nix Daemon Socket.
router# [ 7.659105] [TTM] Initializing DMA pool allocator
tracker# [ 7.723845] systemd[1]: Reached target Sockets.
client1# [ 7.442967] [ 7.524076] 8021q: 802.1Q VLAN Support v1.8
tracker# [ 7.812558] 8021q: 802.1Q VLAN Support v1.8
client1# systemd[1]: Reached target Sockets.
client2# [ 7.355816] systemd[1]: Listening on D-Bus System Message Bus Socket.
tracker# [ 7.736895] nscd[440]: 440 monitoring file `/etc/passwd` (1)
client1# [ 7.454432] systemd[1]: Reached target Basic System.
client2# [ 7.365875] dhcpcd[427]: dev: loaded udev
client1# [ 7.459216] systemd[1]: Starting DHCP Client...
client1# [ 7.461840] gqa4kkyhzfmyrycx8kcy64356lwsfj42-audit-disable[427]: No rules
client2# [ 7.460951] 8021q: 802.1Q VLAN Support v1.8
tracker# [ 7.742884] systemd[1]: Reached target Basic System.
client2# [ 7.375220] systemd[1]: Reached target Sockets.
tracker# [ 7.749790] nscd[440]: 440 monitoring directory `/etc` (2)
client2# [ 7.378632] nscd[435]: 435 monitoring file `/etc/passwd` (1)
tracker# [ 7.754864] systemd[1]: Starting Name Service Cache Daemon...
client1# [ 7.465820] systemd[1]: Starting Name Service Cache Daemon...
client2# [ 7.384929] systemd[1]: Reached target Basic System.
tracker# [ 7.758550] nscd[440]: 440 monitoring file `/etc/group` (3)
tracker# [ 7.764336] systemd[1]: Starting Kernel Auditing...
client2# [ 7.388670] nscd[435]: 435 monitoring directory `/etc` (2)
client1# [ 7.481384] systemd[1]: Starting resolvconf update...
tracker# [ 7.775633] nscd[440]: 440 monitoring directory `/etc` (2)
client1# [ 7.499967] nscd[450]: 450 monitoring file `/etc/passwd` (1)
client2# [ 7.411488] systemd[1]: Starting Name Service Cache Daemon...
client1# [ 7.504518] systemd[1]: Started backdoor.service.
client1# [ 7.507026] nscd[450]: 450 monitoring directory `/etc` (2)
client1# [ 7.510005] systemd[1]: Starting Kernel Auditing...
client1# [ 7.512977] nscd[450]: 450 monitoring file `/etc/group` (3)
client1# [ 7.516182] systemd[1]: Started Kernel Auditing.
client2# [ 7.418176] nscd[435]: 435 monitoring file `/etc/group` (3)
client1# [ 7.517704] nscd[450]: 450 monitoring directory `/etc` (2)
client1# [ 7.520106] nscd[450]: 450 monitoring file `/etc/hosts` (4)
client2# [ 7.431078] systemd[1]: Started backdoor.service.
tracker# [ 7.805796] systemd[1]: Started backdoor.service.
client1# [ 7.522387] nscd[450]: 450 monitoring directory `/etc` (2)
tracker# [ 7.808389] nscd[440]: 440 monitoring file `/etc/hosts` (4)
client2# [ 7.434150] nscd[435]: 435 monitoring directory `/etc` (2)
tracker# [ 7.810553] systemd[1]: Starting resolvconf update...
tracker# [ 7.812628] nscd[440]: 440 monitoring directory `/etc` (2)
router# [ 7.750485] input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input4
client1# [ 7.525899] nscd[450]: 450 disabled inotify-based monitoring for file `/etc/resolv.conf': No such file or directory
tracker# [ 7.816864] systemd[1]: Starting DHCP Client...
client1# [ 7.539900] nscd[450]: 450 stat failed for file `/etc/resolv.conf'; will try again later: No such file or directory
tracker# [ 7.827548] nscd[440]: 440 disabled inotify-based monitoring for file `/etc/resolv.conf': No such file or directory
client2# [ 7.451775] gqa4kkyhzfmyrycx8kcy64356lwsfj42-audit-disable[428]: No rules
tracker# [ 7.832687] systemd[1]: Started Kernel Auditing.
client1# [ 7.547900] nscd[450]: 450 monitoring file `/etc/services` (5)
client1# [ 7.551681] nscd[450]: 450 monitoring directory `/etc` (2)
tracker# [ 7.834880] nscd[440]: 440 stat failed for file `/etc/resolv.conf'; will try again later: No such file or directory
client1# [ 7.553102] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
tracker# [ 7.837179] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
client1# [ 7.554573] nscd[450]: 450 disabled inotify-based monitoring for file `/etc/netgroup': No such file or directory
tracker# [ 7.839154] nscd[440]: 440 monitoring file `/etc/services` (5)
client1# [ 7.556185] nscd[450]: 450 stat failed for file `/etc/netgroup'; will try again later: No such file or directory
client2# [ 7.461039] systemd[1]: Starting resolvconf update...
tracker# [ 7.840785] nscd[440]: 440 monitoring directory `/etc` (2)
tracker# [ 7.844229] nscd[440]: 440 disabled inotify-based monitoring for file `/etc/netgroup': No such file or directory
client2# [ 7.471322] nscd[435]: 435 monitoring file `/etc/hosts` (4)
tracker# [ 7.847018] nscd[440]: 440 stat failed for file `/etc/netgroup'; will try again later: No such file or directory
client2# [ 7.475691] systemd[1]: Starting DHCP Client...
client2# [ 7.478120] nscd[435]: 435 monitoring directory `/etc` (2)
client2# [ 7.480583] systemd[1]: Starting Kernel Auditing...
client2# [ 7.483858] nscd[435]: 435 disabled inotify-based monitoring for file `/etc/resolv.conf': No such file or directory
client2# [ 7.487731] systemd[1]: Started Kernel Auditing.
client2# [ 7.496512] nscd[435]: 435 stat failed for file `/etc/resolv.conf'; will try again later: No such file or directory
router# [ 7.789596] fbcon: bochsdrmfb (fb0) is primary device
client2# [ 7.504157] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
client2# [ 7.509125] nscd[435]: 435 monitoring file `/etc/services` (5)
client2# [ 7.516346] nscd[435]: 435 monitoring directory `/etc` (2)
router# [ 7.807064] Console: switching to colour frame buffer device 128x48
client2# [ 7.518322] nscd[435]: 435 disabled inotify-based monitoring for file `/etc/netgroup': No such file or directory
router# [ 7.830335] bochs-drm 0000:00:02.0: fb0: bochsdrmfb frame buffer device
router# [ 7.834212] [drm] Initialized bochs-drm 1.0.0 20130925 for 0000:00:02.0 on minor 0
client2# [ 7.527647] nscd[435]: 435 stat failed for file `/etc/netgroup'; will try again later: No such file or directory
client2# [ 7.534230] systemd[1]: Started D-Bus System Message Bus.
client1# [ 7.644226] systemd[1]: Started D-Bus System Message Bus.
client1# [ 7.729722] cfg80211: Loading compiled-in X.509 certificates for regulatory database
tracker# [ 7.943779] systemd[1]: Started D-Bus System Message Bus.
client2# [ 7.659173] cfg80211: Loading compiled-in X.509 certificates for regulatory database
tracker# [ 8.032793] cfg80211: Loading compiled-in X.509 certificates for regulatory database
client1# [ 7.765162] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
client2# [ 7.687250] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
client1# [ 7.767997] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2
client1# [ 7.769252] cfg80211: failed to load regulatory.db
client2# [ 7.690569] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2
client2# [ 7.691864] cfg80211: failed to load regulatory.db
tracker# [ 8.063032] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
tracker# [ 8.065824] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2
tracker# [ 8.067706] cfg80211: failed to load regulatory.db
client2# [ 7.669521] dbus-daemon[469]: dbus[469]: Unknown username "systemd-timesync" in message bus configuration file
tracker# [ 8.054006] dbus-daemon[469]: dbus[469]: Unknown username "systemd-timesync" in message bus configuration file
client1# [ 7.781407] dbus-daemon[469]: dbus[469]: Unknown username "systemd-timesync" in message bus configuration file
router# [ 7.936804] systemd[1]: Started udev Wait for Complete Device Initialization.
router# [ 7.938688] systemd[1]: Reached target System Initialization.
client1# connecting to host...
client2# connecting to host...
router# [ 7.944189] systemd[1]: Listening on Nix Daemon Socket.
tracker# connecting to host...
router# [ 7.952327] systemd[1]: Listening on D-Bus System Message Bus Socket.
client1# sh: cannot set terminal process group (-1): Inappropriate ioctl for device
client1# sh: no job control in this shell
client2# sh: cannot set terminal process group (-1): Inappropriate ioctl for device
client2# sh: no job control in this shell
router# [ 7.972985] systemd[1]: Reached target Sockets.
tracker# sh: cannot set terminal process group (-1): Inappropriate ioctl for device
tracker# sh: no job control in this shell
client1# [ 7.849385] systemd[1]: nscd.service: Control process exited, code=killed, status=15/TERM
tracker# [ 8.135940] systemd[1]: nscd.service: Control process exited, code=killed, status=15/TERM
client1# [ 7.853394] systemd[1]: nscd.service: Failed with result 'signal'.
client2# [ 7.765529] systemd[1]: nscd.service: Control process exited, code=killed, status=15/TERM
client1# [ 7.856987] systemd[1]: Stopped Name Service Cache Daemon.
tracker# [ 8.141084] systemd[1]: nscd.service: Failed with result 'signal'.
client1# [ 7.861103] systemd[1]: Starting Name Service Cache Daemon...
client2# [ 7.770889] systemd[1]: nscd.service: Failed with result 'signal'.
tracker# [ 8.148290] systemd[1]: Stopped Name Service Cache Daemon.
tracker# [ 8.151229] systemd[1]: Starting Name Service Cache Daemon...
client2# [ 7.777555] systemd[1]: Stopped Name Service Cache Daemon.
client2# [ 7.780948] systemd[1]: Starting Name Service Cache Daemon...
router# [ 8.008576] systemd[1]: Started Daily Cleanup of Temporary Directories.
router# [ 8.016433] dhcpcd[551]: dev: loaded udev
tracker# [ 8.153623] systemd[1]: Started resolvconf update.
client2# [ 7.784815] systemd[1]: Started resolvconf update.
tracker# [ 8.166627] systemd[1]: Reached target Network (Pre).
router# [ 8.105679] 8021q: 802.1Q VLAN Support v1.8
client1# [ 7.880818] systemd[1]: Started resolvconf update.
tracker# [ 8.172475] systemd[1]: Starting Link configuration of eth1...
router# [ 8.030596] systemd[1]: Reached target Timers.
client2# [ 7.794725] systemd[1]: Reached target Network (Pre).
router# [ 8.035491] nscd[564]: 564 monitoring file `/etc/passwd` (1)
tracker# [ 8.180967] systemd[1]: Starting Address configuration of eth1...
router# [ 8.042143] gqa4kkyhzfmyrycx8kcy64356lwsfj42-audit-disable[549]: No rules
tracker# [ 8.186495] iqyn75imy8mlkj3yrmxpawdscnlfkl2g-unit-script-network-link-eth1-start[510]: Configuring link...
client1# [ 7.898396] systemd[1]: Reached target Network (Pre).
client2# [ 7.820522] systemd[1]: Starting Address configuration of eth1...
client1# [ 7.923112] systemd[1]: Starting Address configuration of eth1...
tracker# [ 8.211987] nscd[521]: 521 monitoring file `/etc/passwd` (1)
client1# [ 8.010962] 8021q: adding VLAN 0 to HW filter on device eth1
tracker# [ 8.300070] 8021q: adding VLAN 0 to HW filter on device eth1
client1# [ 8.013124] 8021q: adding VLAN 0 to HW filter on device eth0
client2# [ 7.835930] systemd[1]: Starting Link configuration of eth0...
router# [ 8.070727] systemd[1]: Reached target Basic System.
client2# [ 7.940386] 8021q: adding VLAN 0 to HW filter on device eth1
router# [ 8.084109] nscd[564]: 564 monitoring directory `/etc` (2)
client2# [ 7.944344] 8021q: adding VLAN 0 to HW filter on device eth0
client1# [ 7.952139] wdq33pw91r2j5g4dz7pi49w3lsnw33m6-unit-script-network-addresses-eth1-start[511]: adding address 192.168.2.1/24... done
tracker# [ 8.237585] nscd[521]: 521 monitoring directory `/etc` (2)
client2# [ 7.868730] hr3qsi5kkx89y86knl4y7jnvjgaqp23j-unit-script-network-link-eth0-start[511]: Configuring link...
tracker# [ 8.244604] zxr8r90dsgb1qc1yccg5c4kgzxh40n3x-unit-script-network-addresses-eth1-start[511]: adding address 192.168.1.4/24... done
tracker# [ 8.248661] zxr8r90dsgb1qc1yccg5c4kgzxh40n3x-unit-script-network-addresses-eth1-start[511]: adding address 80.100.100.3/24... done
client1# [ 7.965206] hr3qsi5kkx89y86knl4y7jnvjgaqp23j-unit-script-network-link-eth0-start[512]: Configuring link...
tracker# [ 8.252010] iqyn75imy8mlkj3yrmxpawdscnlfkl2g-unit-script-network-link-eth1-start[510]: bringing up interface... done
client2# [ 7.879653] hr3qsi5kkx89y86knl4y7jnvjgaqp23j-unit-script-network-link-eth0-start[511]: bringing up interface... done
client1# [ 7.970141] hr3qsi5kkx89y86knl4y7jnvjgaqp23j-unit-script-network-link-eth0-start[512]: bringing up interface... done
client1# [ 7.975908] systemd[1]: Starting Link configuration of eth0...
tracker# [ 8.259293] nscd[521]: 521 monitoring file `/etc/group` (3)
tracker# [ 8.268969] systemd[1]: Started Link configuration of eth1.
client2# [ 7.894064] systemd[1]: Starting Address configuration of eth0...
tracker# [ 8.272496] nscd[521]: 521 monitoring directory `/etc` (2)
client1# [ 7.987217] nscd[525]: 525 monitoring file `/etc/passwd` (1)
router# [ 8.094128] systemd[1]: Starting Name Service Cache Daemon...
client2# [ 7.902853] zwgp4vvhxy9lpc0cbk0vp3ik1d7k7ry4-unit-script-network-addresses-eth1-start[510]: adding address 192.168.1.2/24... done
router# [ 8.133531] nscd[564]: 564 monitoring file `/etc/group` (3)
client1# [ 7.991947] wdq33pw91r2j5g4dz7pi49w3lsnw33m6-unit-script-network-addresses-eth1-start[511]: adding address 192.168.3.2/24... done
client2# [ 7.907656] zwgp4vvhxy9lpc0cbk0vp3ik1d7k7ry4-unit-script-network-addresses-eth1-start[510]: adding address 80.100.100.2/24... done
tracker# [ 8.285037] systemd[1]: Reached target All Network Interfaces (deprecated).
router# [ 8.139391] systemd[1]: Starting Kernel Auditing...
router# [ 8.145634] nscd[564]: 564 monitoring directory `/etc` (2)
client1# [ 8.005588] systemd[1]: Starting Address configuration of eth0...
client1# [ 8.009989] nscd[525]: 525 monitoring directory `/etc` (2)
router# [ 8.150231] systemd[1]: Starting resolvconf update...
tracker# [ 8.294215] nscd[521]: 521 monitoring file `/etc/hosts` (4)
tracker# [ 8.297693] systemd[1]: Started Address configuration of eth1.
router# [ 8.154242] nscd[564]: 564 monitoring file `/etc/hosts` (4)
client1# [ 8.013247] iqyn75imy8mlkj3yrmxpawdscnlfkl2g-unit-script-network-link-eth1-start[517]: Configuring link...
client2# [ 7.924339] nscd[531]: 531 monitoring file `/etc/passwd` (1)
client2# [ 7.932237] systemd[1]: Starting Link configuration of eth1...
tracker# [ 8.307257] nscd[521]: 521 monitoring directory `/etc` (2)
client1# [ 8.022540] iqyn75imy8mlkj3yrmxpawdscnlfkl2g-unit-script-network-link-eth1-start[517]: bringing up interface... done
client1# [ 8.028135] systemd[1]: Starting Link configuration of eth1...
tracker# [ 8.315019] systemd[1]: Starting Networking Setup...
client2# [ 7.939072] iqyn75imy8mlkj3yrmxpawdscnlfkl2g-unit-script-network-link-eth1-start[517]: Configuring link...
router# [ 8.176911] systemd[1]: Starting DHCP Client...
tracker# [ 8.318899] nscd[521]: 521 monitoring file `/etc/resolv.conf` (5)
client1# [ 8.034969] nscd[525]: 525 monitoring file `/etc/group` (3)
tracker# [ 8.322305] systemd[1]: Started Name Service Cache Daemon.
router# [ 8.179578] nscd[564]: 564 monitoring directory `/etc` (2)
client2# [ 7.946200] iqyn75imy8mlkj3yrmxpawdscnlfkl2g-unit-script-network-link-eth1-start[517]: bringing up interface... done
client1# [ 8.044913] systemd[1]: Started Link configuration of eth0.
tracker# [ 8.327786] nscd[521]: 521 monitoring directory `/etc` (2)
router# [ 8.186171] systemd[1]: Started backdoor.service.
client2# [ 7.957539] nscd[531]: 531 monitoring directory `/etc` (2)
tracker# [ 8.333250] systemd[1]: Reached target Host and Network Name Lookups.
client2# [ 7.961065] systemd[1]: Started Link configuration of eth1.
client1# [ 8.050189] nscd[525]: 525 monitoring directory `/etc` (2)
router# [ 8.192440] nscd[564]: 564 disabled inotify-based monitoring for file `/etc/resolv.conf': No such file or directory
tracker# [ 8.337893] nscd[521]: 521 monitoring file `/etc/services` (6)
router# [ 8.199033] systemd[1]: Started Kernel Auditing.
tracker# [ 8.343449] systemd[1]: Reached target User and Group Name Lookups.
client1# [ 8.058558] systemd[1]: Started Link configuration of eth1.
client2# [ 7.970313] nscd[531]: 531 monitoring file `/etc/group` (3)
tracker# [ 8.347514] nscd[521]: 521 monitoring directory `/etc` (2)
router# [ 8.205478] nscd[564]: 564 stat failed for file `/etc/resolv.conf'; will try again later: No such file or directory
client2# [ 7.978580] systemd[1]: Started Link configuration of eth0.
tracker# [ 8.353872] systemd[1]: Starting Login Service...
router# [ 8.216402] systemd[1]: Started D-Bus System Message Bus.
client1# [ 8.065133] nscd[525]: 525 monitoring file `/etc/hosts` (4)
client2# [ 7.987756] nscd[531]: 531 monitoring directory `/etc` (2)
client1# [ 8.083354] systemd[1]: Reached target All Network Interfaces (deprecated).
client2# [ 7.993667] systemd[1]: Reached target All Network Interfaces (deprecated).
client1# [ 8.088796] nscd[525]: 525 monitoring directory `/etc` (2)
client1# [ 8.090598] systemd[1]: Started Name Service Cache Daemon.
tracker# [ 8.358876] nscd[521]: 521 disabled inotify-based monitoring for file `/etc/netgroup': No such file or directory
router# [ 8.228976] nscd[564]: 564 monitoring file `/etc/services` (5)
client1# [ 8.092767] nscd[525]: 525 monitoring file `/etc/resolv.conf` (5)
client2# [ 8.004093] nscd[531]: 531 monitoring file `/etc/hosts` (4)
tracker# [ 8.376232] nscd[521]: 521 stat failed for file `/etc/netgroup'; will try again later: No such file or directory
client1# [ 8.094916] systemd[1]: Reached target User and Group Name Lookups.
client2# [ 8.007404] systemd[1]: Started Address configuration of eth0.
client1# [ 8.097894] nscd[525]: 525 monitoring directory `/etc` (2)
router# [ 8.237009] dbus-daemon[576]: dbus[576]: Unknown username "systemd-timesync" in message bus configuration file
client1# [ 8.099832] systemd[1]: Starting Login Service...
client1# [ 8.101885] nscd[525]: 525 monitoring file `/etc/services` (6)
router# [ 8.243049] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
client1# [ 8.104830] systemd[1]: Reached target Host and Network Name Lookups.
client1# [ 8.106866] nscd[525]: 525 monitoring directory `/etc` (2)
client1# [ 8.109834] systemd[1]: Started Address configuration of eth1.
client2# [ 8.012496] nscd[531]: 531 monitoring directory `/etc` (2)
client1# [ 8.113952] nscd[525]: 525 disabled inotify-based monitoring for file `/etc/netgroup': No such file or directory
client2# [ 8.028912] systemd[1]: Started Address configuration of eth1.
router# [ 8.249106] nscd[564]: 564 monitoring directory `/etc` (2)
client1# [ 8.119920] systemd[1]: Started Address configuration of eth0.
client2# [ 8.031225] nscd[531]: 531 monitoring file `/etc/resolv.conf` (5)
client2# [ 8.034274] systemd[1]: Starting Networking Setup...
client1# [ 8.122416] nscd[525]: 525 stat failed for file `/etc/netgroup'; will try again later: No such file or directory
client2# [ 8.036262] nscd[531]: 531 monitoring directory `/etc` (2)
client2# [ 8.038305] systemd[1]: Started Name Service Cache Daemon.
router# [ 8.269165] nscd[564]: 564 disabled inotify-based monitoring for file `/etc/netgroup': No such file or directory
client1# [ 8.127878] systemd[1]: Starting Networking Setup...
router# [ 8.271411] nscd[564]: 564 stat failed for file `/etc/netgroup'; will try again later: No such file or directory
client2# [ 8.040265] nscd[531]: 531 monitoring file `/etc/services` (6)
client2# [ 8.043294] systemd[1]: Reached target Host and Network Name Lookups.
client2# [ 8.046426] nscd[531]: 531 monitoring directory `/etc` (2)
client2# [ 8.049652] systemd[1]: Reached target User and Group Name Lookups.
router# [ 8.358425] cfg80211: Loading compiled-in X.509 certificates for regulatory database
client2# [ 8.050906] nscd[531]: 531 disabled inotify-based monitoring for file `/etc/netgroup': No such file or directory
client2# [ 8.053701] systemd[1]: Starting Login Service...
client2# [ 8.055717] nscd[531]: 531 stat failed for file `/etc/netgroup'; will try again later: No such file or directory
tracker# [ 8.437255] systemd[1]: Started Networking Setup.
tracker# [ 8.438905] systemd[1]: Starting Extra networking commands....
tracker# [ 8.448858] systemd[1]: Started Extra networking commands..
tracker# [ 8.450164] systemd[1]: Reached target Network.
tracker# [ 8.453060] systemd[1]: Starting Apache HTTPD...
client1# [ 8.178599] systemd[1]: Started Networking Setup.
client1# [ 8.180818] systemd[1]: Starting Extra networking commands....
tracker# [ 8.466537] systemd[1]: Starting Permit User Sessions...
router# [ 8.407579] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
client1# [ 8.190341] systemd[1]: Started Extra networking commands..
client1# [ 8.192522] systemd[1]: Reached target Network.
router# [ 8.411237] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2
router# [ 8.412599] cfg80211: failed to load regulatory.db
client2# [ 8.103503] systemd[1]: Started Networking Setup.
client2# [ 8.106713] systemd[1]: Starting Extra networking commands....
router# [ 8.338967] systemd[1]: nscd.service: Control process exited, code=killed, status=15/TERM
client1# [ 8.194923] systemd[1]: Starting Permit User Sessions...
tracker# [ 8.487643] systemd[1]: Starting Transmission BitTorrent Service...
client2# [ 8.119099] systemd[1]: Started Extra networking commands..
router# [ 8.345863] systemd[1]: nscd.service: Failed with result 'signal'.connecting to host...
router#
client2# [ 8.120345] systemd[1]: Reached target Network.
client1# [ 8.209355] systemd[1]: Starting Transmission BitTorrent Service...
router# [ 8.356181] systemd[1]: Stopped Name Service Cache Daemon.
tracker# [ 8.503062] systemd[1]: Started opentracker server.
client1# [ 8.220890] systemd[1]: Started Permit User Sessions.
client2# [ 8.128471] systemd[1]: Starting Permit User Sessions...
router: connected to guest root shell
tracker# [ 8.508884] systemd[1]: Started Permit User Sessions.
router# [ 8.368555] systemd[1]: Started resolvconf update.
client1# [ 8.227226] systemd[1]: Started Getty on tty1.
client2# [ 8.138059] systemd[1]: Starting Transmission BitTorrent Service...
tracker# [ 8.521951] systemd[1]: Started Getty on tty1.
client1# [ 8.236232] avahfzp0k5snzwqp7fl889nfxb7jic3k-transmission-pre-start[584]: + for DIR in '/var/lib/transmission' '/var/lib/transmission/.config/transmission-daemon' '/var/lib/transmission/Downloads' '/var/lib/transmission/.incomplete'
client2# [ 8.155954] systemd[1]: Started Permit User Sessions.
client1# [ 8.245816] avahfzp0k5snzwqp7fl889nfxb7jic3k-transmission-pre-start[584]: + mkdir -p /var/lib/transmission
router# [ 8.374936] systemd[1]: Reached target Network (Pre).
client1# [ 8.252375] avahfzp0k5snzwqp7fl889nfxb7jic3k-transmission-pre-start[584]: + chmod 770 /var/lib/transmission
router# sh: cannot set terminal process group (-1): Inappropriate ioctl for device
client2# [ 8.165022] systemd[1]: Started Getty on tty1.
router# sh: no job control in this shell
tracker# [ 8.533155] b5gj2wvnah5r1nwxpag6h89rk73xd38a-transmission-pre-start[577]: + for DIR in '/var/lib/transmission' '/var/lib/transmission/.config/transmission-daemon' '/var/lib/transmission/Downloads' '/var/lib/transmission/.incomplete'
router# [ 8.398690] systemd[1]: Starting Link configuration of eth2...
client1# [ 8.259177] avahfzp0k5snzwqp7fl889nfxb7jic3k-transmission-pre-start[584]: + for DIR in '/var/lib/transmission' '/var/lib/transmission/.config/transmission-daemon' '/var/lib/transmission/Downloads' '/var/lib/transmission/.incomplete'
client2# [ 8.171622] b5gj2wvnah5r1nwxpag6h89rk73xd38a-transmission-pre-start[583]: + for DIR in '/var/lib/transmission' '/var/lib/transmission/.config/transmission-daemon' '/var/lib/transmission/Downloads' '/var/lib/transmission/.incomplete'
tracker# [ 8.551241] b5gj2wvnah5r1nwxpag6h89rk73xd38a-transmission-pre-start[577]: + mkdir -p /var/lib/transmission
client1# [ 8.270249] avahfzp0k5snzwqp7fl889nfxb7jic3k-transmission-pre-start[584]: + mkdir -p /var/lib/transmission/.config/transmission-daemon
client2# [ 8.182623] b5gj2wvnah5r1nwxpag6h89rk73xd38a-transmission-pre-start[583]: + mkdir -p /var/lib/transmission
client1# [ 8.278845] systemd[1]: Reached target Login Prompts.
client2# [ 8.190614] b5gj2wvnah5r1nwxpag6h89rk73xd38a-transmission-pre-start[583]: + chmod 770 /var/lib/transmission
tracker# [ 8.562925] b5gj2wvnah5r1nwxpag6h89rk73xd38a-transmission-pre-start[577]: + chmod 770 /var/lib/transmission
router# [ 8.422363] systemd[1]: Starting Address configuration of eth0...[ 8.509929] 8021q: adding VLAN 0 to HW filter on device eth2
client1# [ 8.284354] avahfzp0k5snzwqp7fl889nfxb7jic3k-transmission-pre-start[584]: + chmod 770 /var/lib/transmission/.config/transmission-daemon
client2# [ 8.195617] b5gj2wvnah5r1nwxpag6h89rk73xd38a-transmission-pre-start[583]: + for DIR in '/var/lib/transmission' '/var/lib/transmission/.config/transmission-daemon' '/var/lib/transmission/Downloads' '/var/lib/transmission/.incomplete'
router#
tracker# [ 8.570475] b5gj2wvnah5r1nwxpag6h89rk73xd38a-transmission-pre-start[577]: + for DIR in '/var/lib/transmission' '/var/lib/transmission/.config/transmission-daemon' '/var/lib/transmission/Downloads' '/var/lib/transmission/.incomplete'
client1# [ 8.292316] avahfzp0k5snzwqp7fl889nfxb7jic3k-transmission-pre-start[584]: + for DIR in '/var/lib/transmission' '/var/lib/transmission/.config/transmission-daemon' '/var/lib/transmission/Downloads' '/var/lib/transmission/.incomplete'
router# [ 8.521491] 8021q: adding VLAN 0 to HW filter on device eth1
client2# [ 8.205474] b5gj2wvnah5r1nwxpag6h89rk73xd38a-transmission-pre-start[583]: + mkdir -p /var/lib/transmission/.config/transmission-daemon
tracker# [ 8.580718] b5gj2wvnah5r1nwxpag6h89rk73xd38a-transmission-pre-start[577]: + mkdir -p /var/lib/transmission/.config/transmission-daemon
client1# [ 8.301481] avahfzp0k5snzwqp7fl889nfxb7jic3k-transmission-pre-start[584]: + mkdir -p /var/lib/transmission/Downloads
client1# [ 8.305795] avahfzp0k5snzwqp7fl889nfxb7jic3k-transmission-pre-start[584]: + chmod 770 /var/lib/transmission/Downloads
client2# [ 8.215331] b5gj2wvnah5r1nwxpag6h89rk73xd38a-transmission-pre-start[583]: + chmod 770 /var/lib/transmission/.config/transmission-daemon
tracker# [ 8.590275] b5gj2wvnah5r1nwxpag6h89rk73xd38a-transmission-pre-start[577]: + chmod 770 /var/lib/transmission/.config/transmission-daemon
client1# [ 8.309818] avahfzp0k5snzwqp7fl889nfxb7jic3k-transmission-pre-start[584]: + for DIR in '/var/lib/transmission' '/var/lib/transmission/.config/transmission-daemon' '/var/lib/transmission/Downloads' '/var/lib/transmission/.incomplete'
router# [ 8.452277] 4mdcdx6fxqag5alvcfb38b2fcwcshpp8-unit-script-network-link-eth2-start[ 8.537905] 8021q: adding VLAN 0 to HW filter on device eth0
client2# [ 8.223839] b5gj2wvnah5r1nwxpag6h89rk73xd38a-transmission-pre-start[583]: + for DIR in '/var/lib/transmission' '/var/lib/transmission/.config/transmission-daemon' '/var/lib/transmission/Downloads' '/var/lib/transmission/.incomplete'
client1# [ 8.317784] avahfzp0k5snzwqp7fl889nfxb7jic3k-transmission-pre-start[584]: + mkdir -p /var/lib/transmission/.incomplete
tracker# [ 8.599406] b5gj2wvnah5r1nwxpag6h89rk73xd38a-transmission-pre-start[577]: + for DIR in '/var/lib/transmission' '/var/lib/transmission/.config/transmission-daemon' '/var/lib/transmission/Downloads' '/var/lib/transmission/.incomplete'
router: (connecting took 9.25 seconds)
(9.25 seconds)
client2# [ 8.232442] b5gj2wvnah5r1nwxpag6h89rk73xd38a-transmission-pre-start[583]: + mkdir -p /var/lib/transmission/Downloads
client1# [ 8.322291] avahfzp0k5snzwqp7fl889nfxb7jic3k-transmission-pre-start[584]: + chmod 770 /var/lib/transmission/.incomplete
tracker# [ 8.608284] b5gj2wvnah5r1nwxpag6h89rk73xd38a-transmission-pre-start[577]: + mkdir -p /var/lib/transmission/Downloads
client2# [ 8.238091] systemd[1]: Reached target Login Prompts.
router# [629]: Configuring link...
client1# [ 8.327447] avahfzp0k5snzwqp7fl889nfxb7jic3k-transmission-pre-start[584]: + cp -f /nix/store/x53sazxhdy3zw2fws04j6b666h1q0mw1-settings.json /var/lib/transmission/.config/transmission-daemon/settings.json
client2# [ 8.243689] b5gj2wvnah5r1nwxpag6h89rk73xd38a-transmission-pre-start[583]: + chmod 770 /var/lib/transmission/Downloads
tracker# [ 8.617246] systemd[1]: Reached target Login Prompts.
client1# [ 8.340861] systemd[1]: Started Transmission BitTorrent Service.
client2# [ 8.250157] b5gj2wvnah5r1nwxpag6h89rk73xd38a-transmission-pre-start[583]: + for DIR in '/var/lib/transmission' '/var/lib/transmission/.config/transmission-daemon' '/var/lib/transmission/Downloads' '/var/lib/transmission/.incomplete'
tracker# [ 8.626099] b5gj2wvnah5r1nwxpag6h89rk73xd38a-transmission-pre-start[577]: + chmod 770 /var/lib/transmission/Downloads
client2# [ 8.258955] b5gj2wvnah5r1nwxpag6h89rk73xd38a-transmission-pre-start[583]: + mkdir -p /var/lib/transmission/.incomplete
tracker# [ 8.632849] b5gj2wvnah5r1nwxpag6h89rk73xd38a-transmission-pre-start[577]: + for DIR in '/var/lib/transmission' '/var/lib/transmission/.config/transmission-daemon' '/var/lib/transmission/Downloads' '/var/lib/transmission/.incomplete'
client2# [ 8.263723] b5gj2wvnah5r1nwxpag6h89rk73xd38a-transmission-pre-start[583]: + chmod 770 /var/lib/transmission/.incomplete
router# [ 8.484812] 4mdcdx6fxqag5alvcfb38b2fcwcshpp8-unit-script-network-link-eth2-start[629]: bringing up interface... done
tracker# [ 8.641959] b5gj2wvnah5r1nwxpag6h89rk73xd38a-transmission-pre-start[577]: + mkdir -p /var/lib/transmission/.incomplete
client2# [ 8.268817] b5gj2wvnah5r1nwxpag6h89rk73xd38a-transmission-pre-start[583]: + cp -f /nix/store/hq13ckk7avk8fj5vjqf3g3xq6d4bi18d-settings.json /var/lib/transmission/.config/transmission-daemon/settings.json
tracker# [ 8.648917] b5gj2wvnah5r1nwxpag6h89rk73xd38a-transmission-pre-start[577]: + chmod 770 /var/lib/transmission/.incomplete
client2# [ 8.277541] systemd[1]: Started Transmission BitTorrent Service.
tracker# [ 8.653843] b5gj2wvnah5r1nwxpag6h89rk73xd38a-transmission-pre-start[577]: + cp -f /nix/store/hq13ckk7avk8fj5vjqf3g3xq6d4bi18d-settings.json /var/lib/transmission/.config/transmission-daemon/settings.json
tracker# [ 8.661059] systemd[1]: Started Transmission BitTorrent Service.
router# [ 8.520248] systemd[1]: Starting Address configuration of eth1...
router# [ 8.535529] dhcpcd[551]: eth0: waiting for carrier
router# [ 8.547571] systemd[1]: Starting Link configuration of eth1...
router# [ 8.558296] h0yjc8lk5aa91sw9j54fvny7wzxf9nqd-unit-script-network-addresses-eth1-start[632]: adding address 192.168.1.3/24... done
router# [ 8.562677] h0yjc8lk5aa91sw9j54fvny7wzxf9nqd-unit-script-network-addresses-eth1-start[632]: adding address 80.100.100.1/24... done
router# [ 8.566853] dhcpcd[551]: eth0: carrier acquired
router# [ 8.568854] systemd[1]: Starting Link configuration of eth0...
router# [ 8.571414] iqyn75imy8mlkj3yrmxpawdscnlfkl2g-unit-script-network-link-eth1-start[635]: Configuring link...
router# [ 8.573947] iqyn75imy8mlkj3yrmxpawdscnlfkl2g-unit-script-network-link-eth1-start[635]: bringing up interface... done
router# [ 8.578306] nscd[670]: 670 monitoring file `/etc/passwd` (1)
router# [ 8.580711] systemd[1]: Starting Address configuration of eth2...
router# [ 8.583034] hr3qsi5kkx89y86knl4y7jnvjgaqp23j-unit-script-network-link-eth0-start[637]: Configuring link...
router# [ 8.584967] hr3qsi5kkx89y86knl4y7jnvjgaqp23j-unit-script-network-link-eth0-start[637]: bringing up interface... done
router# [ 8.587275] nscd[670]: 670 monitoring directory `/etc` (2)
router# [ 8.590561] systemd[1]: Starting Name Service Cache Daemon...
router# [ 8.595394] 6lcgchk3qbiywcgry82s7l0rnlh09vzv-unit-script-network-addresses-eth2-start[641]: adding address 192.168.2.3/24... done
router# [ 8.599590] 6lcgchk3qbiywcgry82s7l0rnlh09vzv-unit-script-network-addresses-eth2-start[641]: adding address 192.168.3.1/24... done
router# [ 8.603021] nscd[670]: 670 monitoring file `/etc/group` (3)
router# [ 8.605165] systemd[1]: Started Link configuration of eth2.
router# [ 8.608496] nscd[670]: 670 monitoring directory `/etc` (2)
router# [ 8.610683] systemd[1]: Started Address configuration of eth0.
router# [ 8.613714] nscd[670]: 670 monitoring file `/etc/hosts` (4)
router# [ 8.615729] systemd[1]: Started Link configuration of eth1.
router# [ 8.617918] nscd[670]: 670 monitoring directory `/etc` (2)
router# [ 8.619941] systemd[1]: Started Link configuration of eth0.
router# [ 8.622094] nscd[670]: 670 monitoring file `/etc/resolv.conf` (5)
router# [ 8.624113] systemd[1]: Started Address configuration of eth1.
router# [ 8.626267] nscd[670]: 670 monitoring directory `/etc` (2)
router# [ 8.628338] nscd[670]: 670 monitoring file `/etc/services` (6)
router# [ 8.630359] nscd[670]: 670 monitoring directory `/etc` (2)
router# [ 8.632328] nscd[670]: 670 disabled inotify-based monitoring for file `/etc/netgroup': No such file or directory
router# [ 8.634490] nscd[670]: 670 stat failed for file `/etc/netgroup'; will try again later: No such file or directory
router# [ 8.636546] dhcpcd[551]: DUID 00:01:00:01:24:c7:f8:a5:52:54:00:12:34:56
router# [ 8.638710] dhcpcd[551]: eth0: IAID 00:12:34:56
router# [ 8.640810] dhcpcd[551]: eth0: adding address fe80::5054:ff:fe12:3456
client1# [ 8.590263] systemd-logind[545]: New seat seat0.
client1# [ 8.598237] systemd-logind[545]: Watching system buttons on /dev/input/event2 (Power Button)
client1# [ 8.600826] systemd-logind[545]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)
router: exit status 0
router# [ 8.744698] systemd[1]: Started Address configuration of eth2.
client2# [ 8.515333] systemd-logind[546]: New seat seat0.
(9.53 seconds)
router: running command: systemctl list-jobs --full 2>&1
client1# [ 8.607447] systemd[1]: Started Login Service.
router# [ 8.755135] systemd[1]: Starting Networking Setup...
client2# [ 8.525966] systemd-logind[546]: Watching system buttons on /dev/input/event2 (Power Button)
tracker# [ 8.901809] systemd[1]: Started Apache HTTPD.
client2# [ 8.527811] systemd-logind[546]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)
router# [ 8.757074] systemd[1]: Reached target All Network Interfaces (deprecated).
client2# [ 8.533130] systemd[1]: Started Login Service.
router: exit status 0
(0.04 seconds)
router# [ 8.788988] systemd[1]: Started Name Service Cache Daemon.
router# [ 8.790856] systemd[1]: Reached target User and Group Name Lookups.
router# [ 8.793363] systemd[1]: Starting Login Service...
router# [ 8.799397] systemd[1]: Reached target Host and Network Name Lookups.
tracker# [ 8.967156] systemd-logind[540]: New seat seat0.
tracker# [ 8.975268] systemd-logind[540]: Watching system buttons on /dev/input/event2 (Power Button)
tracker# [ 8.977100] systemd-logind[540]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)
tracker# [ 8.994527] systemd[1]: Started Login Service.
router# [ 8.890397] systemd[1]: Started Networking Setup.
router# [ 8.891913] systemd[1]: Starting Extra networking commands....
router# [ 8.901304] systemd[1]: Started Extra networking commands..
router# [ 8.902513] systemd[1]: Reached target Network.
router# [ 8.904573] systemd[1]: Starting Permit User Sessions...
router# [ 8.908889] systemd[1]: Starting MiniUPnP daemon...
router# [ 8.926295] systemd[1]: miniupnpd.service: Can't open PID file /run/miniupnpd.pid (yet?) after start: No such file or directory
router# [ 8.929357] systemd[1]: Started MiniUPnP daemon.
router# [ 8.934032] miniupnpd[723]: HTTP listening on port 35643
router# [ 8.936333] systemd[1]: Started Permit User Sessions.
router# [ 8.938507] systemd[1]: Started Getty on tty1.
tracker# [ 9.083284] transmission-daemon[603]: sendto: Network is unreachable
client2# [ 8.710481] transmission-daemon[594]: sendto: Network is unreachable
router# [ 8.941511] systemd[1]: Reached target Login Prompts.
router# [ 8.961876] dhcpcd[551]: eth0: soliciting a DHCP lease
client2# [ 8.742535] dhcpcd[427]: eth0: waiting for carrier
client2# [ 8.743947] dhcpcd[427]: eth0: carrier acquired
client1# [ 8.835473] dhcpcd[423]: eth0: waiting for carrier
tracker# [ 9.201258] 8021q: adding VLAN 0 to HW filter on device eth0
client1# [ 8.837179] dhcpcd[423]: eth0: carrier acquired
tracker# [ 9.121503] dhcpcd[427]: eth0: waiting for carrier
tracker# [ 9.123153] dhcpcd[427]: eth0: carrier acquired
router# [ 9.059589] NET: Registered protocol family 17
router# [ 8.985505] dhcpcd[551]: eth0: offered 10.0.2.15 from 10.0.2.2
client2# [ 8.757333] dhcpcd[427]: DUID 00:01:00:01:24:c7:f8:a6:52:54:00:12:34:56
client2# [ 8.758930] dhcpcd[427]: eth0: IAID 00:12:34:56
client1# [ 8.849790] dhcpcd[423]: DUID 00:01:00:01:24:c7:f8:a6:52:54:00:12:34:56
client2# [ 8.760479] dhcpcd[427]: eth0: adding address fe80::5054:ff:fe12:3456
client1# [ 8.851431] dhcpcd[423]: eth0: IAID 00:12:34:56
tracker# [ 9.135533] dhcpcd[427]: DUID 00:01:00:01:24:c7:f8:a6:52:54:00:12:34:56
router# [ 8.988060] dhcpcd[551]: eth0: leased 10.0.2.15 for 86400 seconds
tracker# [ 9.136919] dhcpcd[427]: eth0: IAID 00:12:34:56
client1# [ 8.852900] dhcpcd[423]: eth0: adding address fe80::5054:ff:fe12:3456
tracker# [ 9.138174] dhcpcd[427]: eth0: adding address fe80::5054:ff:fe12:3456
router# [ 8.994172] dhcpcd[551]: eth0: adding route to 10.0.2.0/24
router# [ 8.999861] dhcpcd[551]: eth0: adding default route via 10.0.2.2
router# [ 9.069355] nscd[670]: 670 monitored file `/etc/resolv.conf` was written to
router# [ 9.090472] systemd[1]: Stopping Name Service Cache Daemon...
router# [ 9.093500] systemd[1]: nscd.service: Succeeded.
router# [ 9.094941] systemd[1]: Stopped Name Service Cache Daemon.
router# [ 9.100121] systemd[1]: Starting Name Service Cache Daemon...
router# [ 9.138252] dhcpcd[551]: Failed to reload-or-try-restart ntpd.service: Unit ntpd.service not found.
router# [ 9.140737] dhcpcd[551]: Failed to reload-or-try-restart openntpd.service: Unit openntpd.service not found.
router# [ 9.145848] dhcpcd[551]: Failed to reload-or-try-restart chronyd.service: Unit chronyd.service not found.
client2# [ 8.924193] dhcpcd[427]: eth0: soliciting a DHCP lease
router# [ 9.157638] nscd[771]: 771 monitoring file `/etc/passwd` (1)
router# [ 9.163170] systemd[1]: Started DHCP Client.
router# [ 9.170112] nscd[771]: 771 monitoring directory `/etc` (2)
client2# [ 9.030105] NET: Registered protocol family 17
client1# [ 9.031780] dhcpcd[423]: eth0: soliciting an IPv6 router
router# [ 9.173903] systemd[1]: Reached target Network is Online.
client2# [ 8.946266] dhcpcd[427]: eth0: offered 10.0.2.15 from 10.0.2.2
router# [ 9.176042] nscd[771]: 771 monitoring file `/etc/group` (3)
client2# [ 8.947443] dhcpcd[427]: eth0: ignoring offer of 10.0.2.15 from 10.0.2.2
client2# [ 8.948783] dhcpcd[427]: eth0: leased 10.0.2.15 for 86400 seconds
router# [ 9.178225] systemd[1]: Started Name Service Cache Daemon.
client2# [ 8.950548] dhcpcd[427]: eth0: adding route to 10.0.2.0/24
router# [ 9.181150] nscd[771]: 771 monitoring directory `/etc` (2)
client2# [ 8.952099] dhcpcd[427]: eth0: adding default route via 10.0.2.2
router# [ 9.183091] nscd[771]: 771 monitoring file `/etc/hosts` (4)
router# [ 9.186109] nscd[771]: 771 monitoring directory `/etc` (2)
router# [ 9.188098] nscd[771]: 771 monitoring file `/etc/resolv.conf` (5)
router# [ 9.190098] nscd[771]: 771 monitoring directory `/etc` (2)
router# [ 9.192067] nscd[771]: 771 monitoring file `/etc/services` (6)
router# [ 9.195102] nscd[771]: 771 monitoring directory `/etc` (2)
router# [ 9.197111] nscd[771]: 771 disabled inotify-based monitoring for file `/etc/netgroup': No such file or directory
router# [ 9.200089] nscd[771]: 771 stat failed for file `/etc/netgroup'; will try again later: No such file or directory
router# [ 9.203091] dhcpcd[551]: forked to background, child pid 772
client2# [ 9.044736] nscd[531]: 531 monitored file `/etc/resolv.conf` was written to
client2# [ 9.068903] systemd[1]: Stopping Name Service Cache Daemon...
client2# [ 9.072489] systemd[1]: nscd.service: Succeeded.
client2# [ 9.074452] systemd[1]: Stopped Name Service Cache Daemon.
client2# [ 9.078625] systemd[1]: Starting Name Service Cache Daemon...
router# [ 9.334944] systemd-logind[686]: New seat seat0.
router# [ 9.341942] systemd-logind[686]: Watching system buttons on /dev/input/event2 (Power Button)
router# [ 9.343728] systemd-logind[686]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)
router# [ 9.350820] systemd[1]: Started Login Service.
router# [ 9.354871] systemd[1]: Reached target Multi-User System.
client2# [ 9.126975] nscd[647]: 647 monitoring file `/etc/passwd` (1)
client2# [ 9.129468] nscd[647]: 647 monitoring directory `/etc` (2)
router# [ 9.361037] systemd[1]: Startup finished in 4.269s (kernel) + 5.080s (userspace) = 9.350s.
client2# [ 9.132581] nscd[647]: 647 monitoring file `/etc/group` (3)
client2# [ 9.134933] nscd[647]: 647 monitoring directory `/etc` (2)
client2# [ 9.152330] nscd[647]: 647 monitoring file `/etc/hosts` (4)
client2# [ 9.159636] dhcpcd[427]: Failed to reload-or-try-restart ntpd.service: Unit ntpd.service not found.
client2# [ 9.161276] dhcpcd[427]: Failed to reload-or-try-restart openntpd.service: Unit openntpd.service not found.
client2# [ 9.166654] dhcpcd[427]: Failed to reload-or-try-restart chronyd.service: Unit chronyd.service not found.
client2# [ 9.168945] nscd[647]: 647 monitoring directory `/etc` (2)
client2# [ 9.170688] systemd[1]: Started DHCP Client.
client2# [ 9.173041] nscd[647]: 647 monitoring file `/etc/resolv.conf` (5)
client2# [ 9.175923] systemd[1]: Reached target Network is Online.
client2# [ 9.178205] nscd[647]: 647 monitoring directory `/etc` (2)
client2# [ 9.179729] systemd[1]: Reached target Multi-User System.
client2# [ 9.181505] nscd[647]: 647 monitoring file `/etc/services` (6)
client2# [ 9.183067] systemd[1]: Started Name Service Cache Daemon.
client2# [ 9.184665] nscd[647]: 647 monitoring directory `/etc` (2)
client2# [ 9.186164] systemd[1]: Startup finished in 4.038s (kernel) + 5.126s (userspace) = 9.165s.
client2# [ 9.188125] nscd[647]: 647 disabled inotify-based monitoring for file `/etc/netgroup': No such file or directory
client2# [ 9.190069] nscd[647]: 647 stat failed for file `/etc/netgroup'; will try again later: No such file or directory
client2# [ 9.192060] dhcpcd[427]: forked to background, child pid 660
router# [ 9.525161] dhcpcd[772]: eth0: soliciting an IPv6 router
tracker# [ 9.841425] dhcpcd[427]: eth0: soliciting an IPv6 router
client1# [ 9.610718] transmission-daemon[595]: [2019-07-22 04:31:35.157] Transmission 2.94 (d8e60ee44f) started (session.c:740)
client1# [ 9.615846] transmission-daemon[595]: [2019-07-22 04:31:35.157] Couldn't read "/var/lib/transmission/.config/transmission-daemon/stats.json": No such file or directory (utils.c:238)
tracker# [ 9.901093] transmission-daemon[603]: [2019-07-22 04:31:35.446] Transmission 2.94 (d8e60ee44f) started (session.c:740)
client1# [ 9.620389] transmission-daemon[595]: [2019-07-22 04:31:35.157] Couldn't read "/var/lib/transmission/.config/transmission-daemon/stats.benc": No such file or directory (utils.c:238)
client2# [ 9.529647] transmission-daemon[594]: [2019-07-22 04:31:35.036] Transmission 2.94 (d8e60ee44f) started (session.c:740)
client1# [ 9.622863] transmission-daemon[595]: [2019-07-22 04:31:35.157] Cache Maximum cache size set to 4.00 MiB (256 blocks) (cache.c:261)
client1# [ 9.624861] transmission-daemon[595]: [2019-07-22 04:31:35.157] RPC Server Adding address to whitelist: 127.0.0.1 (rpc-server.c:971)
tracker# [ 9.906385] transmission-daemon[603]: [2019-07-22 04:31:35.446] RPC Server Adding address to whitelist: 127.0.0.1 (rpc-server.c:971)
client1# [ 9.626859] transmission-daemon[595]: [2019-07-22 04:31:35.157] RPC Server Serving RPC and Web requests on port 127.0.0.1:9091/transmission/ (rpc-server.c:1213)
client2# [ 9.534719] transmission-daemon[594]: [2019-07-22 04:31:35.037] RPC Server Adding address to whitelist: 127.0.0.1 (rpc-server.c:971)
tracker# [ 9.911505] transmission-daemon[603]: [2019-07-22 04:31:35.446] RPC Server Serving RPC and Web requests on port 127.0.0.1:9091/transmission/ (rpc-server.c:1213)
client1# [ 9.629268] transmission-daemon[595]: [2019-07-22 04:31:35.157] RPC Server Started listening on 0.0.0.0:9091 (rpc-server.c:853)
client2# [ 9.539465] transmission-daemon[594]: [2019-07-22 04:31:35.037] RPC Server Serving RPC and Web requests on port 127.0.0.1:9091/transmission/ (rpc-server.c:1213)
client1# [ 9.631236] transmission-daemon[595]: [2019-07-22 04:31:35.157] RPC Server Whitelist enabled (rpc-server.c:1217)
client2# [ 9.541806] transmission-daemon[594]: [2019-07-22 04:31:35.037] RPC Server Whitelist enabled (rpc-server.c:1217)
tracker# [ 9.914888] transmission-daemon[603]: [2019-07-22 04:31:35.446] RPC Server Whitelist enabled (rpc-server.c:1217)
client1# [ 9.632995] transmission-daemon[595]: [2019-07-22 04:31:35.157] Bound socket 15 to port 51413 on 0.0.0.0 (net.c:388)
client2# [ 9.543670] transmission-daemon[594]: [2019-07-22 04:31:35.037] UDP Failed to set receive buffer: requested 4194304, got 425984 (tr-udp.c:84)
tracker# [ 9.917253] transmission-daemon[603]: [2019-07-22 04:31:35.446] UDP Failed to set receive buffer: requested 4194304, got 425984 (tr-udp.c:84)
client1# [ 9.634768] transmission-daemon[595]: [2019-07-22 04:31:35.157] Bound socket 16 to port 51413 on :: (net.c:388)
client2# [ 9.545784] transmission-daemon[594]: [2019-07-22 04:31:35.037] UDP Please add the line "net.core.rmem_max = 4194304" to /etc/sysctl.conf (tr-udp.c:89)
client1# [ 9.636453] transmission-daemon[595]: [2019-07-22 04:31:35.157] UDP Failed to set receive buffer: requested 4194304, got 425984 (tr-udp.c:84)
tracker# [ 9.920189] transmission-daemon[603]: [2019-07-22 04:31:35.446] UDP Please add the line "net.core.rmem_max = 4194304" to /etc/sysctl.conf (tr-udp.c:89)
client2# [ 9.547989] transmission-daemon[594]: [2019-07-22 04:31:35.037] UDP Failed to set send buffer: requested 1048576, got 425984 (tr-udp.c:95)
client1# [ 9.638567] transmission-daemon[595]: [2019-07-22 04:31:35.157] UDP Please add the line "net.core.rmem_max = 4194304" to /etc/sysctl.conf (tr-udp.c:89)
tracker# [ 9.923106] transmission-daemon[603]: [2019-07-22 04:31:35.446] UDP Failed to set send buffer: requested 1048576, got 425984 (tr-udp.c:95)
client2# [ 9.550093] transmission-daemon[594]: [2019-07-22 04:31:35.037] UDP Please add the line "net.core.wmem_max = 1048576" to /etc/sysctl.conf (tr-udp.c:100)
client1# [ 9.640819] transmission-daemon[595]: [2019-07-22 04:31:35.157] UDP Failed to set send buffer: requested 1048576, got 425984 (tr-udp.c:95)
client2# [ 9.552387] transmission-daemon[594]: [2019-07-22 04:31:35.037] Using settings from "/var/lib/transmission/.config/transmission-daemon" (daemon.c:528)
tracker# [ 9.925915] transmission-daemon[603]: [2019-07-22 04:31:35.446] UDP Please add the line "net.core.wmem_max = 1048576" to /etc/sysctl.conf (tr-udp.c:100)
client1# [ 9.642881] transmission-daemon[595]: [2019-07-22 04:31:35.157] UDP Please add the line "net.core.wmem_max = 1048576" to /etc/sysctl.conf (tr-udp.c:100)
client2# [ 9.554587] transmission-daemon[594]: [2019-07-22 04:31:35.037] Saved "/var/lib/transmission/.config/transmission-daemon/settings.json" (variant.c:1266)
client1# [ 9.645089] transmission-daemon[595]: [2019-07-22 04:31:35.157] Using settings from "/var/lib/transmission/.config/transmission-daemon" (daemon.c:528)
tracker# [ 9.928719] transmission-daemon[603]: [2019-07-22 04:31:35.446] Using settings from "/var/lib/transmission/.config/transmission-daemon" (daemon.c:528)
router: running command: systemctl --no-pager show "network-online.target"
client2# [ 9.556784] transmission-daemon[594]: [2019-07-22 04:31:35.037] Port Forwarding State changed from "Not forwarded" to "???" (port-forwarding.c:92)
client1# [ 9.647308] transmission-daemon[595]: [2019-07-22 04:31:35.157] Saved "/var/lib/transmission/.config/transmission-daemon/settings.json" (variant.c:1266)
tracker# [ 9.931469] transmission-daemon[603]: [2019-07-22 04:31:35.446] Saved "/var/lib/transmission/.config/transmission-daemon/settings.json" (variant.c:1266)
client1# [ 9.649475] transmission-daemon[595]: [2019-07-22 04:31:35.157] Port Forwarding (NAT-PMP) initnatpmp succeeded (0) (natpmp.c:70)
client1# [ 9.651342] transmission-daemon[595]: [2019-07-22 04:31:35.157] Port Forwarding (NAT-PMP) sendpublicaddressrequest succeeded (2) (natpmp.c:70)
tracker# [ 9.934302] transmission-daemon[603]: [2019-07-22 04:31:35.446] Port Forwarding State changed from "Not forwarded" to "???" (port-forwarding.c:92)
router: exit status 0
(0.04 seconds)
(10.62 seconds)
router: waiting for unit ‘miniupnpd’
router: running command: systemctl --no-pager show "miniupnpd"
client1# [ 9.702039] dhcpcd[423]: eth0: soliciting a DHCP lease
client1# [ 9.801498] NET: Registered protocol family 17
client1# [ 9.728206] dhcpcd[423]: eth0: offered 10.0.2.15 from 10.0.2.2
client1# [ 9.729577] dhcpcd[423]: eth0: ignoring offer of 10.0.2.15 from 10.0.2.2
client1# [ 9.731254] dhcpcd[423]: eth0: leased 10.0.2.15 for 86400 seconds
client1# [ 9.733295] dhcpcd[423]: eth0: adding route to 10.0.2.0/24
client1# [ 9.736872] dhcpcd[423]: eth0: adding default route via 10.0.2.2
tracker# [ 10.045899] dhcpcd[427]: eth0: soliciting a DHCP lease
tracker# [ 10.145196] NET: Registered protocol family 17
tracker# [ 10.066692] dhcpcd[427]: eth0: offered 10.0.2.15 from 10.0.2.2
tracker# [ 10.068095] dhcpcd[427]: eth0: ignoring offer of 10.0.2.15 from 10.0.2.2
tracker# [ 10.069667] dhcpcd[427]: eth0: leased 10.0.2.15 for 86400 seconds
tracker# [ 10.071837] dhcpcd[427]: eth0: adding route to 10.0.2.0/24
tracker# [ 10.075264] dhcpcd[427]: eth0: adding default route via 10.0.2.2
client1# [ 9.824673] nscd[525]: 525 monitored file `/etc/resolv.conf` was written to
client2# [ 9.749135] dhcpcd[660]: eth0: soliciting an IPv6 router
client1# [ 9.843216] systemd[1]: Stopping Name Service Cache Daemon...
client1# [ 9.846264] systemd[1]: nscd.service: Succeeded.
client1# [ 9.847726] systemd[1]: Stopped Name Service Cache Daemon.
client1# [ 9.851116] systemd[1]: Starting Name Service Cache Daemon...
router: exit status 0
(0.16 seconds)
(0.16 seconds)
tracker: must succeed: mkdir /tmp/data
tracker: waiting for the VM to finish booting
tracker: connected to guest root shell
tracker: (connecting took 0.00 seconds)
(0.00 seconds)
tracker: exit status 0
(0.01 seconds)
tracker: must succeed: cp /nix/store/3x7dwzq014bblazs7kq20p9hyzz0qh8g-hello-2.10.tar.gz /tmp/data/test.tar.bz2
tracker# [ 10.155883] nscd[521]: 521 monitored file `/etc/resolv.conf` was written to
client1# [ 9.890733] nscd[648]: 648 monitoring file `/etc/passwd` (1)
client1# [ 9.893177] nscd[648]: 648 monitoring directory `/etc` (2)
client1# [ 9.896619] nscd[648]: 648 monitoring file `/etc/group` (3)
client1# [ 9.906419] nscd[648]: 648 monitoring directory `/etc` (2)
tracker# [ 10.198061] systemd[1]: Stopping Name Service Cache Daemon...
client1# [ 9.911466] nscd[648]: 648 monitoring file `/etc/hosts` (4)
client1# [ 9.922191] dhcpcd[423]: Failed to reload-or-try-restart ntpd.service: Unit ntpd.service not found.
tracker: exit status 0
(0.06 seconds)
tracker: must succeed: transmission-create /tmp/data/test.tar.bz2 --private --tracker http://80.100.100.3:6969/announce --outfile /tmp/test.torrent
tracker# [ 10.210946] systemd[1]: nscd.service: Succeeded.
tracker# [ 10.213985] systemd[1]: Stopped Name Service Cache Daemon.
router# [ 10.071940] dhcpcd[772]: eth0: Router Advertisement from fe80::2
client1# [ 9.931644] dhcpcd[423]: Failed to reload-or-try-restart openntpd.service: Unit openntpd.service not found.
router# [ 10.074698] dhcpcd[772]: eth0: adding address fec0::5054:ff:fe12:3456/64
router# [ 10.077383] dhcpcd[772]: eth0: adding route to fec0::/64
tracker# [ 10.218794] systemd[1]: Starting Name Service Cache Daemon...
client1# [ 9.935460] dhcpcd[423]: Failed to reload-or-try-restart chronyd.service: Unit chronyd.service not found.
router# [ 10.079634] dhcpcd[772]: eth0: adding default route via fe80::2
client1# [ 9.939603] nscd[648]: 648 monitoring directory `/etc` (2)
client1# [ 9.941942] systemd[1]: Started Name Service Cache Daemon.
client1# [ 9.944766] nscd[648]: 648 monitoring file `/etc/resolv.conf` (5)
client1# [ 9.947321] systemd[1]: Started DHCP Client.
client1# [ 9.949269] nscd[648]: 648 monitoring directory `/etc` (2)
client1# [ 9.951639] systemd[1]: Reached target Network is Online.
client1# [ 9.953917] nscd[648]: 648 monitoring file `/etc/services` (6)
client1# [ 9.955836] systemd[1]: Reached target Multi-User System.
client1# [ 9.957855] nscd[648]: 648 monitoring directory `/etc` (2)
client1# [ 9.959771] systemd[1]: Startup finished in 4.128s (kernel) + 5.802s (userspace) = 9.930s.
client1# [ 9.962317] nscd[648]: 648 disabled inotify-based monitoring for file `/etc/netgroup': No such file or directory
client1# [ 9.965029] nscd[648]: 648 stat failed for file `/etc/netgroup'; will try again later: No such file or directory
client1# [ 9.967704] dhcpcd[423]: forked to background, child pid 661
tracker# [ 10.260468] dhcpcd[427]: Failed to reload-or-try-restart ntpd.service: Unit ntpd.service not found.
tracker# [ 10.265508] dhcpcd[427]: Failed to reload-or-try-restart openntpd.service: Unit openntpd.service not found.
tracker# [ 10.269772] dhcpcd[427]: Failed to reload-or-try-restart chronyd.service: Unit chronyd.service not found.
tracker# [ 10.283773] nscd[667]: 667 monitoring file `/etc/passwd` (1)
tracker# [ 10.289905] nscd[667]: 667 monitoring directory `/etc` (2)
tracker# [ 10.292587] systemd[1]: Started DHCP Client.
tracker# [ 10.296457] nscd[667]: 667 monitoring file `/etc/group` (3)
tracker# [ 10.298850] systemd[1]: Reached target Network is Online.
tracker# [ 10.300509] nscd[667]: 667 monitoring directory `/etc` (2)
tracker# [ 10.302465] systemd[1]: Reached target Multi-User System.
tracker# [ 10.304362] nscd[667]: 667 monitoring file `/etc/hosts` (4)
tracker# [ 10.309310] nscd[667]: 667 monitoring directory `/etc` (2)
tracker# [ 10.311158] systemd[1]: Started Name Service Cache Daemon.
tracker# [ 10.312711] nscd[667]: 667 monitoring file `/etc/resolv.conf` (5)
tracker# [ 10.314837] systemd[1]: Startup finished in 4.412s (kernel) + 5.895s (userspace) = 10.308s.
tracker# [ 10.316798] nscd[667]: 667 monitoring directory `/etc` (2)
tracker# [ 10.319332] nscd[667]: 667 monitoring file `/etc/services` (6)
tracker# [ 10.321012] nscd[667]: 667 monitoring directory `/etc` (2)
tracker# [ 10.322405] nscd[667]: 667 disabled inotify-based monitoring for file `/etc/netgroup': No such file or directory
tracker# [ 10.324324] nscd[667]: 667 stat failed for file `/etc/netgroup'; will try again later: No such file or directory
tracker# [ 10.326295] dhcpcd[427]: forked to background, child pid 668
tracker: exit status 0
(0.55 seconds)
tracker: must succeed: chmod 644 /tmp/test.torrent
tracker: exit status 0
(0.02 seconds)
tracker: waiting for unit ‘network-online.target’
tracker: running command: systemctl --no-pager show "network-online.target"
tracker: exit status 0
(0.18 seconds)
(0.18 seconds)
tracker: waiting for unit ‘opentracker.service’
tracker: running command: systemctl --no-pager show "opentracker.service"
client2# [ 10.706870] dhcpcd[660]: eth0: Router Advertisement from fe80::2
client2# [ 10.708595] dhcpcd[660]: eth0: adding address fec0::5054:ff:fe12:3456/64
client2# [ 10.710183] dhcpcd[660]: eth0: adding route to fec0::/64
client2# [ 10.711658] dhcpcd[660]: eth0: adding default route via fe80::2
tracker# [ 11.100031] dhcpcd[668]: eth0: Router Advertisement from fe80::2
tracker# [ 11.101750] dhcpcd[668]: eth0: adding address fec0::5054:ff:fe12:3456/64
tracker# [ 11.102983] dhcpcd[668]: eth0: adding route to fec0::/64
tracker: exit status 0
tracker# [ 11.104277] dhcpcd[668]: eth0: adding default route via fe80::2
(0.14 seconds)
(0.14 seconds)
tracker: waiting for TCP port 6969
tracker: running command: nc -z localhost 6969
client1# [ 10.832477] dhcpcd[661]: eth0: Router Advertisement from fe80::2
client1# [ 10.834057] dhcpcd[661]: eth0: adding address fec0::5054:ff:fe12:3456/64
client1# [ 10.835736] dhcpcd[661]: eth0: adding route to fec0::/64
client1# [ 10.837103] dhcpcd[661]: eth0: adding default route via fe80::2
tracker# Connection to localhost 6969 port [tcp/acmsoda] succeeded!
tracker: exit status 0
(0.13 seconds)
(0.13 seconds)
tracker: must succeed: transmission-remote --add /tmp/test.torrent --no-portmap --no-dht --download-dir /tmp/data
tracker: exit status 0
(0.10 seconds)
tracker: waiting for unit ‘httpd’
tracker: running command: systemctl --no-pager show "httpd"
tracker: exit status 0
(0.15 seconds)
(0.15 seconds)
client1: waiting for unit ‘network-online.target’
client1: running command: systemctl --no-pager show "network-online.target"
client1: waiting for the VM to finish booting
client1: connected to guest root shell
client1: (connecting took 0.00 seconds)
(0.00 seconds)
client1: exit status 0
(0.10 seconds)
(0.10 seconds)
client1: must succeed: transmission-remote --add http://80.100.100.3/test.torrent --download-dir /tmp >&2 &
client1: exit status 0
(0.00 seconds)
client1: waiting for file ‘/tmp/test.tar.bz2’
client1: running command: test -e /tmp/test.tar.bz2
client1: exit status 1
(0.00 seconds)
client1# localhost:9091/transmission/rpc/ responded: "success"
client1# [ 11.608628] transmission-daemon[595]: [2019-07-22 04:31:37.156] Port Forwarding (UPnP) UPNP_GetValidIGD failed (errno 0 - Success) (upnp.c:239)
client1# [ 11.612352] transmission-daemon[595]: [2019-07-22 04:31:37.159] Port Forwarding (UPnP) If your router supports UPnP, please make sure UPnP is enabled! (upnp.c:242)
client1# [ 11.616007] transmission-daemon[595]: [2019-07-22 04:31:37.159] Port Forwarding State changed from "Not forwarded" to "Starting" (port-forwarding.c:92)
client1# [ 11.619212] transmission-daemon[595]: [2019-07-22 04:31:37.159] Couldn't read "/var/lib/transmission/.config/transmission-daemon/resume/test.tar.bz2.78f1a0d6f6e93bf8.resume": No such file or directory (utils.c:238)
client1# [ 11.622262] transmission-daemon[595]: [2019-07-22 04:31:37.159] test.tar.bz2 Couldn't read "/var/lib/transmission/.config/transmission-daemon/resume/test.tar.bz2.78f1a0d6f6e93bf8.resume": No such file or directory (resume.c:718)
client1# [ 11.625475] transmission-daemon[595]: [2019-07-22 04:31:37.160] Saved "/var/lib/transmission/.config/transmission-daemon/torrents/test.tar.bz2.78f1a0d6f6e93bf8.torrent" (variant.c:1266)
tracker# [ 11.901354] transmission-daemon[603]: [2019-07-22 04:31:37.446] Saved "/var/lib/transmission/.config/transmission-daemon/torrents/test.tar.bz2.78f1a0d6f6e93bf8.torrent" (variant.c:1266)
client1# [ 11.628063] transmission-daemon[595]: [2019-07-22 04:31:37.160] test.tar.bz2 Queued for verification (verify.c:269)
tracker# [ 11.912339] transmission-daemon[603]: [2019-07-22 04:31:37.449] test.tar.bz2 Queued for verification (verify.c:269)
client1# [ 11.629944] transmission-daemon[595]: [2019-07-22 04:31:37.160] test.tar.bz2 Verifying torrent (verify.c:224)
tracker# [ 11.914202] transmission-daemon[603]: [2019-07-22 04:31:37.449] test.tar.bz2 Verifying torrent (verify.c:224)
client1# [ 11.631713] transmission-daemon[595]: [2019-07-22 04:31:37.160] test.tar.bz2 verifying torrent... (verify.c:62)
tracker# [ 11.915919] transmission-daemon[603]: [2019-07-22 04:31:37.449] Port Forwarding Stopped (port-forwarding.c:180)
client1: running command: test -e /tmp/test.tar.bz2
client1: exit status 1
(0.00 seconds)
client1# [ 12.613230] transmission-daemon[595]: [2019-07-22 04:31:38.160] test.tar.bz2 Verification is done. It took 0 seconds to verify 725946 bytes (725946 bytes per second) (verify.c:167)
client1# [ 12.619600] transmission-daemon[595]: [2019-07-22 04:31:38.163] test.tar.bz2 Announcing to tracker (announcer.c:1554)
client1# [ 12.622831] transmission-daemon[595]: [2019-07-22 04:31:38.163] test.tar.bz2 Got 2 peers from tracker (torrent.c:565)
client1# [ 12.624770] transmission-daemon[595]: [2019-07-22 04:31:38.163] test.tar.bz2 Announce response contained scrape info; rescheduling next scrape to 1800 seconds from now. (announcer.c:1152)
client1: running command: test -e /tmp/test.tar.bz2
client1: exit status 1
(0.00 seconds)
client1: running command: test -e /tmp/test.tar.bz2
client1: exit status 1
(0.00 seconds)
client1: running command: test -e /tmp/test.tar.bz2
client1: exit status 1
(0.00 seconds)
client1: running command: test -e /tmp/test.tar.bz2
client1: exit status 1
(0.00 seconds)
client1: running command: test -e /tmp/test.tar.bz2
client1: exit status 1
(0.00 seconds)
client1: running command: test -e /tmp/test.tar.bz2
client1: exit status 1
(0.00 seconds)
client1# [ 18.609069] transmission-daemon[595]: [2019-07-22 04:31:44.155] Port Forwarding (NAT-PMP) readnatpmpresponseorretry failed. Natpmp returned -7 (the gateway does not support nat-pmp); errno is 111 (Connection refused) (natpmp.c:75)
client1# [ 18.617001] transmission-daemon[595]: [2019-07-22 04:31:44.159] Port Forwarding State changed from "Starting" to "???" (port-forwarding.c:92)
client1: running command: test -e /tmp/test.tar.bz2
client1: exit status 1
(0.00 seconds)
client1: running command: test -e /tmp/test.tar.bz2
client1: exit status 1
(0.00 seconds)
client1: running command: test -e /tmp/test.tar.bz2
client1: exit status 1
(0.00 seconds)
client1# [ 21.608984] transmission-daemon[595]: [2019-07-22 04:31:47.155] SO_SNDBUF size is 16384 (fdlimit.c:541)
client1# [ 21.613848] transmission-daemon[595]: [2019-07-22 04:31:47.159] SO_RCVBUF size is 87380 (fdlimit.c:543)
client1: running command: test -e /tmp/test.tar.bz2
client1: exit status 1
(0.00 seconds)
client1: running command: test -e /tmp/test.tar.bz2
client1: exit status 1
(0.00 seconds)
client1# [ 23.609933] transmission-daemon[595]: [2019-07-22 04:31:49.156] test.tar.bz2 [LAZY] checking just-completed piece 22 (torrent.c:3318)
client1# [ 23.615827] transmission-daemon[595]: [2019-07-22 04:31:49.160] test.tar.bz2 [LAZY] checking just-completed piece 0 (torrent.c:3318)
client1: running command: test -e /tmp/test.tar.bz2
client1: exit status 1
(0.00 seconds)
client1# [ 24.613270] transmission-daemon[595]: [2019-07-22 04:31:50.160] test.tar.bz2 [LAZY] checking just-completed piece 3 (torrent.c:3318)
client1# [ 24.619243] transmission-daemon[595]: [2019-07-22 04:31:50.166] test.tar.bz2 [LAZY] checking just-completed piece 4 (torrent.c:3318)
client1# [ 24.623229] transmission-daemon[595]: [2019-07-22 04:31:50.166] test.tar.bz2 [LAZY] checking just-completed piece 8 (torrent.c:3318)
client1# [ 24.625450] transmission-daemon[595]: [2019-07-22 04:31:50.166] test.tar.bz2 [LAZY] checking just-completed piece 16 (torrent.c:3318)
client1# [ 24.627625] transmission-daemon[595]: [2019-07-22 04:31:50.166] test.tar.bz2 [LAZY] checking just-completed piece 12 (torrent.c:3318)
client1# [ 24.629739] transmission-daemon[595]: [2019-07-22 04:31:50.166] test.tar.bz2 [LAZY] checking just-completed piece 20 (torrent.c:3318)
client1# [ 24.631839] transmission-daemon[595]: [2019-07-22 04:31:50.166] test.tar.bz2 [LAZY] checking just-completed piece 10 (torrent.c:3318)
client1# [ 24.633902] transmission-daemon[595]: [2019-07-22 04:31:50.166] test.tar.bz2 [LAZY] checking just-completed piece 9 (torrent.c:3318)
client1: running command: test -e /tmp/test.tar.bz2
client1: exit status 1
(0.00 seconds)
client1# [ 25.614595] transmission-daemon[595]: [2019-07-22 04:31:51.161] test.tar.bz2 [LAZY] checking just-completed piece 21 (torrent.c:3318)
client1# [ 25.619387] transmission-daemon[595]: [2019-07-22 04:31:51.166] test.tar.bz2 [LAZY] checking just-completed piece 18 (torrent.c:3318)
client1# [ 25.622140] transmission-daemon[595]: [2019-07-22 04:31:51.166] test.tar.bz2 [LAZY] checking just-completed piece 11 (torrent.c:3318)
client1# [ 25.624900] transmission-daemon[595]: [2019-07-22 04:31:51.166] test.tar.bz2 [LAZY] checking just-completed piece 14 (torrent.c:3318)
client1# [ 25.627666] transmission-daemon[595]: [2019-07-22 04:31:51.167] test.tar.bz2 [LAZY] checking just-completed piece 7 (torrent.c:3318)
client1# [ 25.630025] transmission-daemon[595]: [2019-07-22 04:31:51.167] test.tar.bz2 [LAZY] checking just-completed piece 15 (torrent.c:3318)
client1# [ 25.632156] transmission-daemon[595]: [2019-07-22 04:31:51.167] test.tar.bz2 [LAZY] checking just-completed piece 1 (torrent.c:3318)
client1# [ 25.634254] transmission-daemon[595]: [2019-07-22 04:31:51.167] test.tar.bz2 [LAZY] checking just-completed piece 6 (torrent.c:3318)
client1# [ 25.636319] transmission-daemon[595]: [2019-07-22 04:31:51.167] test.tar.bz2 [LAZY] checking just-completed piece 17 (torrent.c:3318)
client1# [ 25.638387] transmission-daemon[595]: [2019-07-22 04:31:51.167] test.tar.bz2 [LAZY] checking just-completed piece 5 (torrent.c:3318)
client1# [ 25.640688] transmission-daemon[595]: [2019-07-22 04:31:51.167] test.tar.bz2 [LAZY] checking just-completed piece 13 (torrent.c:3318)
client1# [ 25.642685] transmission-daemon[595]: [2019-07-22 04:31:51.167] test.tar.bz2 [LAZY] checking just-completed piece 19 (torrent.c:3318)
client1# [ 25.644651] transmission-daemon[595]: [2019-07-22 04:31:51.167] test.tar.bz2 [LAZY] checking just-completed piece 2 (torrent.c:3318)
client1# [ 25.646612] transmission-daemon[595]: [2019-07-22 04:31:51.167] Preallocated file "/tmp/test.tar.bz2.part" (sparse, size: 725946) (fdlimit.c:220)
client1: running command: test -e /tmp/test.tar.bz2
client1: exit status 0
(0.00 seconds)
(15.05 seconds)
client1: must succeed: cmp /tmp/test.tar.bz2 /nix/store/3x7dwzq014bblazs7kq20p9hyzz0qh8g-hello-2.10.tar.gz
client1: exit status 0
(0.04 seconds)
client2: waiting for unit ‘network-online.target’
client2: running command: systemctl --no-pager show "network-online.target"
client2: waiting for the VM to finish booting
client2: connected to guest root shell
client2: (connecting took 0.00 seconds)
(0.00 seconds)
client2: exit status 0
(0.19 seconds)
(0.19 seconds)
client2: must succeed: transmission-remote --add http://80.100.100.3/test.torrent --no-portmap --no-dht --download-dir /tmp >&2 &
client2: exit status 0
(0.00 seconds)
client2: waiting for file ‘/tmp/test.tar.bz2’
client2: running command: test -e /tmp/test.tar.bz2
client2: exit status 1
(0.00 seconds)
client1# [ 26.613361] transmission-daemon[595]: [2019-07-22 04:31:52.161] test.tar.bz2 State changed from "Incomplete" to "Complete" (torrent.c:2218)
client2# localhost:9091/transmission/rpc/ responded: "success"
client2# localhost:9091/transmission/rpc/ responded: "success"
client2: running command: test -e /tmp/test.tar.bz2
client2: exit status 1
(0.00 seconds)
client1# [ 27.609946] transmission-daemon[595]: [2019-07-22 04:31:53.156] test.tar.bz2 Announcing to tracker (announcer.c:1554)
client1# [ 27.614575] transmission-daemon[595]: [2019-07-22 04:31:53.156] test.tar.bz2 Got 2 seeds from tracker (torrent.c:563)
client1# [ 27.618854] transmission-daemon[595]: [2019-07-22 04:31:53.156] test.tar.bz2 Announce response contained scrape info; rescheduling next scrape to 1800 seconds from now. (announcer.c:1152)
client2# [ 27.530856] transmission-daemon[594]: [2019-07-22 04:31:53.037] Saved "/var/lib/transmission/.config/transmission-daemon/torrents/test.tar.bz2.78f1a0d6f6e93bf8.torrent" (variant.c:1266)
client2# [ 27.537618] transmission-daemon[594]: [2019-07-22 04:31:53.037] test.tar.bz2 Queued for verification (verify.c:269)
client2# [ 27.540977] transmission-daemon[594]: [2019-07-22 04:31:53.037] test.tar.bz2 Verifying torrent (verify.c:224)
client2# [ 27.542907] transmission-daemon[594]: [2019-07-22 04:31:53.037] Port Forwarding Stopped (port-forwarding.c:180)
router# [ 28.152126] nscd[771]: 771 checking for monitored file `/etc/netgroup': No such file or directory
client2# [ 28.142807] nscd[647]: 647 checking for monitored file `/etc/netgroup': No such file or directory
client2: running command: test -e /tmp/test.tar.bz2
client2: exit status 1
(0.00 seconds)
client1# [ 28.906185] nscd[648]: 648 checking for monitored file `/etc/netgroup': No such file or directory
tracker# [ 29.288203] nscd[667]: 667 checking for monitored file `/etc/netgroup': No such file or directory
client2: running command: test -e /tmp/test.tar.bz2
client2: exit status 1
(0.00 seconds)
client2: running command: test -e /tmp/test.tar.bz2
client2: exit status 1
(0.00 seconds)
client2: running command: test -e /tmp/test.tar.bz2
client2: exit status 1
(0.00 seconds)
client2: running command: test -e /tmp/test.tar.bz2
client2: exit status 1
(0.00 seconds)
router# [ 33.706148] refused connection: IN=eth1 OUT= MAC=52:54:00:12:01:03:52:54:00:12:01:04:08:00 SRC=80.100.100.3 DST=80.100.100.1 LEN=60 TOS=0x00 PREC=0x00 TTL=64 ID=2455 DF PROTO=TCP SPT=33651 DPT=51413 WINDOW=7300 RES=0x00 SYN URGP=0
client2: running command: test -e /tmp/test.tar.bz2
client2: exit status 1
(0.00 seconds)
router# [ 34.714707] refused connection: IN=eth1 OUT= MAC=52:54:00:12:01:03:52:54:00:12:01:04:08:00 SRC=80.100.100.3 DST=80.100.100.1 LEN=60 TOS=0x00 PREC=0x00 TTL=64 ID=2456 DF PROTO=TCP SPT=33651 DPT=51413 WINDOW=7300 RES=0x00 SYN URGP=0
client2: running command: test -e /tmp/test.tar.bz2
client2: exit status 1
(0.00 seconds)
client2: running command: test -e /tmp/test.tar.bz2
client2: exit status 1
(0.00 seconds)
router# [ 36.762716] refused connection: IN=eth1 OUT= MAC=52:54:00:12:01:03:52:54:00:12:01:04:08:00 SRC=80.100.100.3 DST=80.100.100.1 LEN=60 TOS=0x00 PREC=0x00 TTL=64 ID=2457 DF PROTO=TCP SPT=33651 DPT=51413 WINDOW=7300 RES=0x00 SYN URGP=0
client2: running command: test -e /tmp/test.tar.bz2
client2: exit status 1
(0.00 seconds)
router# [ 37.248540] refused connection: IN=eth1 OUT= MAC=52:54:00:12:01:03:52:54:00:12:01:02:08:00 SRC=80.100.100.2 DST=80.100.100.1 LEN=60 TOS=0x00 PREC=0x00 TTL=64 ID=17553 DF PROTO=TCP SPT=34147 DPT=51413 WINDOW=29200 RES=0x00 SYN URGP=0
client2: running command: test -e /tmp/test.tar.bz2
client2: exit status 1
(0.00 seconds)
client2: running command: test -e /tmp/test.tar.bz2
client2: exit status 1
(0.00 seconds)
client2: running command: test -e /tmp/test.tar.bz2
client2: exit status 1
(0.00 seconds)
router# [ 40.794625] refused connection: IN=eth1 OUT= MAC=52:54:00:12:01:03:52:54:00:12:01:04:08:00 SRC=80.100.100.3 DST=80.100.100.1 LEN=60 TOS=0x00 PREC=0x00 TTL=64 ID=2458 DF PROTO=TCP SPT=33651 DPT=51413 WINDOW=7300 RES=0x00 SYN URGP=0
client2: running command: test -e /tmp/test.tar.bz2
client2: exit status 0
(0.00 seconds)
(14.04 seconds)
client2: must succeed: cmp /tmp/test.tar.bz2 /nix/store/3x7dwzq014bblazs7kq20p9hyzz0qh8g-hello-2.10.tar.gz
client2: exit status 0
(0.04 seconds)
(41.96 seconds)
collecting coverage data
tracker: running command: test -e /sys/kernel/debug/gcov
tracker: exit status 1
(0.00 seconds)
router: running command: test -e /sys/kernel/debug/gcov
router: exit status 1
(0.00 seconds)
client1: running command: test -e /sys/kernel/debug/gcov
client1: exit status 1
(0.00 seconds)
client2: running command: test -e /sys/kernel/debug/gcov
client2: exit status 1
(0.00 seconds)
(0.01 seconds)
syncing
tracker: running command: sync
tracker: exit status 0
(0.02 seconds)
router: running command: sync
router: exit status 0
(0.02 seconds)
client1: running command: sync
client1: exit status 0
(0.02 seconds)
client2: running command: sync
client2: exit status 0
(0.02 seconds)
(0.09 seconds)
test script finished in 42.06s
cleaning up
killing tracker (pid 598)
killing router (pid 610)
killing client1 (pid 622)
killing client2 (pid 634)
(0.00 seconds)
vde_switch: vde_switch: EOF on stdin, cleaning up and exitingEOF on stdin, cleaning up and exiting
vde_switch: Could not remove ctl dir '/build/vde2.ctl': Directory not empty
vde_switch: Could not remove ctl dir '/build/vde1.ctl': Directory not empty
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment