these 19 derivations will be built: /nix/store/4g1cqb97lh79px82ncvbi4yzn88mad7p-unit-nginx.service.drv /nix/store/zg5cibx6crxjgf2fi0i3w8zlz3636ij4-unit-firewall.service.drv /nix/store/0smahqma0vjp7js3pnp3f5qk460bvn2p-system-units.drv /nix/store/pk54hqrbh8ymjf0r71m7r7qqk5jkbjfs-user-units.drv /nix/store/21ynv8sac00v1mixd9yrwpkrkz3a3v7y-etc.drv /nix/store/1jla8prbzydgp3115zirwb81rxs21wsv-activate.drv /nix/store/8sygrk244jzhlipylh5fi8k9vahhgw7j-etc.drv /nix/store/p5sdnfvma1lhvninwk45vh0p2xn33mvn-activate.drv /nix/store/csnbx5y6ppyszslkiij3w3gcihw0qh3g-nixos-system-client-test.drv /nix/store/l6hb1iq5blgfpqvj9jnry814alsdxswp-closure-info.drv /nix/store/s80avbs0zl026d203s2gfp4rb192kqy9-run-nixos-vm.drv /nix/store/24kqjkbl404xj32hyqvqcdp6pdy6fvv4-nixos-vm.drv /nix/store/97d37y9ry9nwbjpvngjip2n8rhddq5wv-nixos-system-server-test.drv /nix/store/jx9z1vylpljryvf165fb0gxx2fvz9dh1-closure-info.drv /nix/store/m139f6g99599qwq2n2q56i8x1z0hd2zm-run-nixos-vm.drv /nix/store/hjy5b64fiyx9z7jmg2byvix1dfnxq815-nixos-vm.drv /nix/store/lcjp4kdykkj683ag543377zzd2mj97k5-driverConfiguration.json.drv /nix/store/qkizhwijb3qzh2d7s9rmx63fsndbrknj-nixos-test-driver-systemd-nspawn.drv /nix/store/qjwq1s1h57vqcgv9z6n8v64zpjhf2zyx-vm-test-run-systemd-nspawn.drv building '/nix/store/8sygrk244jzhlipylh5fi8k9vahhgw7j-etc.drv' building '/nix/store/pk54hqrbh8ymjf0r71m7r7qqk5jkbjfs-user-units.drv' building '/nix/store/zg5cibx6crxjgf2fi0i3w8zlz3636ij4-unit-firewall.service.drv' building '/nix/store/4g1cqb97lh79px82ncvbi4yzn88mad7p-unit-nginx.service.drv' etc> tribuchet: building on eliza unit-firewall.service> tribuchet: building on eliza user-units> tribuchet: building on eliza unit-nginx.service> tribuchet: building on eliza unit-nginx.service> structuredAttrs is enabled unit-firewall.service> structuredAttrs is enabled building '/nix/store/p5sdnfvma1lhvninwk45vh0p2xn33mvn-activate.drv' activate> tribuchet: building on eliza building '/nix/store/0smahqma0vjp7js3pnp3f5qk460bvn2p-system-units.drv' system-units> tribuchet: building on eliza building '/nix/store/csnbx5y6ppyszslkiij3w3gcihw0qh3g-nixos-system-client-test.drv' nixos-system-client-test> tribuchet: building on eliza building '/nix/store/21ynv8sac00v1mixd9yrwpkrkz3a3v7y-etc.drv' etc> tribuchet: building on eliza nixos-system-client-test> structuredAttrs is enabled building '/nix/store/1jla8prbzydgp3115zirwb81rxs21wsv-activate.drv' building '/nix/store/l6hb1iq5blgfpqvj9jnry814alsdxswp-closure-info.drv' activate> tribuchet: building on eliza closure-info> tribuchet: building on eliza closure-info> structuredAttrs is enabled building '/nix/store/97d37y9ry9nwbjpvngjip2n8rhddq5wv-nixos-system-server-test.drv' nixos-system-server-test> tribuchet: building on eliza building '/nix/store/s80avbs0zl026d203s2gfp4rb192kqy9-run-nixos-vm.drv' run-nixos-vm> tribuchet: building on eliza nixos-system-server-test> structuredAttrs is enabled building '/nix/store/jx9z1vylpljryvf165fb0gxx2fvz9dh1-closure-info.drv' closure-info> tribuchet: building on eliza building '/nix/store/24kqjkbl404xj32hyqvqcdp6pdy6fvv4-nixos-vm.drv' nixos-vm> tribuchet: building on eliza closure-info> structuredAttrs is enabled building '/nix/store/m139f6g99599qwq2n2q56i8x1z0hd2zm-run-nixos-vm.drv' run-nixos-vm> tribuchet: building on eliza building '/nix/store/hjy5b64fiyx9z7jmg2byvix1dfnxq815-nixos-vm.drv' nixos-vm> tribuchet: building on eliza building '/nix/store/lcjp4kdykkj683ag543377zzd2mj97k5-driverConfiguration.json.drv' driverConfiguration.json> tribuchet: building on eliza driverConfiguration.json> structuredAttrs is enabled building '/nix/store/qkizhwijb3qzh2d7s9rmx63fsndbrknj-nixos-test-driver-systemd-nspawn.drv' nixos-test-driver-systemd-nspawn> tribuchet: building on eliza nixos-test-driver-systemd-nspawn> Running type check (enable/disable: config.skipTypeCheck) nixos-test-driver-systemd-nspawn> See https://nixos.org/manual/nixos/stable/#test-opt-skipTypeCheck nixos-test-driver-systemd-nspawn> All checks passed! nixos-test-driver-systemd-nspawn> Linting test script (enable/disable: config.skipLint) nixos-test-driver-systemd-nspawn> See https://nixos.org/manual/nixos/stable/#test-opt-skipLint nixos-test-driver-systemd-nspawn> All checks passed! Failed to find a machine for remote build! derivation: qjwq1s1h57vqcgv9z6n8v64zpjhf2zyx-vm-test-run-systemd-nspawn.drv required (system, features): (aarch64-linux, [kvm, nixos-test]) 1 available machines: (systems, maxjobs, supportedFeatures, mandatoryFeatures) ([aarch64-darwin, x86_64-darwin], 8, [big-parallel, recursive-nix], []) building '/nix/store/qjwq1s1h57vqcgv9z6n8v64zpjhf2zyx-vm-test-run-systemd-nspawn.drv' vm-test-run-systemd-nspawn> tribuchet: building on eliza vm-test-run-systemd-nspawn> Machine state will be reset. To keep it, pass --keep-machine-state vm-test-run-systemd-nspawn> start all VLans vm-test-run-systemd-nspawn> (finished: start all VLans, in 0.00 seconds) vm-test-run-systemd-nspawn> Test will time out and terminate in 3600.0 seconds vm-test-run-systemd-nspawn> run the VM test script vm-test-run-systemd-nspawn> start all VMs vm-test-run-systemd-nspawn> client: starting vm vm-test-run-systemd-nspawn> server: starting vm vm-test-run-systemd-nspawn> client # Disk image does not exist, creating the virtualisation disk image... vm-test-run-systemd-nspawn> client # Formatting '/build/vm-state-client/tmp.0jpnslVm9A', fmt=raw size=1073741824 vm-test-run-systemd-nspawn> client: QEMU running (pid 47) vm-test-run-systemd-nspawn> client # mke2fs 1.47.4 (6-Mar-2025) vm-test-run-systemd-nspawn> client # Discarding device blocks: 0/262144 done vm-test-run-systemd-nspawn> client # Creating filesystem with 262144 4k blocks and 65536 inodes vm-test-run-systemd-nspawn> client # Filesystem UUID: 89046247-85e5-40ea-9dd6-36f6f230222f vm-test-run-systemd-nspawn> client # Superblock backups stored on blocks: vm-test-run-systemd-nspawn> client # 32768, 98304, 163840, 229376 vm-test-run-systemd-nspawn> client # vm-test-run-systemd-nspawn> client # Allocating group tables: 0/8 done vm-test-run-systemd-nspawn> client # Writing inode tables: 0/8 done vm-test-run-systemd-nspawn> client # Creating journal (8192 blocks): done vm-test-run-systemd-nspawn> client # Writing superblocks and filesystem accounting information: 0/8 done vm-test-run-systemd-nspawn> client # vm-test-run-systemd-nspawn> client # Virtualisation disk image created. vm-test-run-systemd-nspawn> server # Disk image does not exist, creating the virtualisation disk image... vm-test-run-systemd-nspawn> server: QEMU running (pid 48) vm-test-run-systemd-nspawn> server # Formatting '/build/vm-state-server/tmp.ydiZvmn5u7', fmt=raw size=1073741824 vm-test-run-systemd-nspawn> server # mke2fs 1.47.4 (6-Mar-2025) vm-test-run-systemd-nspawn> server # Discarding device blocks: 0/262144 done vm-test-run-systemd-nspawn> server # Creating filesystem with 262144 4k blocks and 65536 inodes vm-test-run-systemd-nspawn> (finished: start all VMs, in 0.51 seconds) vm-test-run-systemd-nspawn> server # Filesystem UUID: 147e7863-c943-4acb-9f2c-c6186383c9df vm-test-run-systemd-nspawn> server: waiting for unit nginx.service vm-test-run-systemd-nspawn> server # Superblock backups stored on blocks: vm-test-run-systemd-nspawn> server: waiting for the VM to finish booting vm-test-run-systemd-nspawn> server # 32768, 98304, 163840, 229376 vm-test-run-systemd-nspawn> server # vm-test-run-systemd-nspawn> server # Allocating group tables: 0/8 done vm-test-run-systemd-nspawn> server # Writing inode tables: 0/8 done vm-test-run-systemd-nspawn> server # Creating journal (8192 blocks): done vm-test-run-systemd-nspawn> server # Writing superblocks and filesystem accounting information: 0/8 done vm-test-run-systemd-nspawn> server # vm-test-run-systemd-nspawn> server # Virtualisation disk image created. vm-test-run-systemd-nspawn> client # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40] vm-test-run-systemd-nspawn> client # [ 0.000000] Linux version 6.18.49 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Wed Sep 2 12:31:51 UTC 2026 vm-test-run-systemd-nspawn> client # [ 0.000000] KASLR enabled vm-test-run-systemd-nspawn> client # [ 0.000000] random: crng init done vm-test-run-systemd-nspawn> client # [ 0.000000] Machine model: linux,dummy-virt vm-test-run-systemd-nspawn> client # [ 0.000000] efi: UEFI not found. vm-test-run-systemd-nspawn> client # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT vm-test-run-systemd-nspawn> client # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff] vm-test-run-systemd-nspawn> client # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fded700-0x7fdf0e7f] vm-test-run-systemd-nspawn> client # [ 0.000000] Zone ranges: vm-test-run-systemd-nspawn> client # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff] vm-test-run-systemd-nspawn> client # [ 0.000000] DMA32 empty vm-test-run-systemd-nspawn> client # [ 0.000000] Normal empty vm-test-run-systemd-nspawn> client # [ 0.000000] Device empty vm-test-run-systemd-nspawn> client # [ 0.000000] Movable zone start for each node vm-test-run-systemd-nspawn> client # [ 0.000000] Early memory node ranges vm-test-run-systemd-nspawn> client # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff] vm-test-run-systemd-nspawn> client # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff] vm-test-run-systemd-nspawn> client # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc00000 vm-test-run-systemd-nspawn> client # [ 0.000000] psci: probing for conduit method from DT. vm-test-run-systemd-nspawn> client # [ 0.000000] psci: PSCIv1.3 detected in firmware. vm-test-run-systemd-nspawn> client # [ 0.000000] psci: Using standard PSCI v0.2 function IDs vm-test-run-systemd-nspawn> client # [ 0.000000] psci: Trusted OS migration not required vm-test-run-systemd-nspawn> client # [ 0.000000] psci: SMC Calling Convention v1.1 vm-test-run-systemd-nspawn> client # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) vm-test-run-systemd-nspawn> client # [ 0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u311296 vm-test-run-systemd-nspawn> client # [ 0.000000] Detected PIPT I-cache on CPU0 vm-test-run-systemd-nspawn> client # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm) vm-test-run-systemd-nspawn> client # [ 0.000000] CPU features: detected: GICv3 CPU interface vm-test-run-systemd-nspawn> client # [ 0.000000] CPU features: detected: Spectre-v4 vm-test-run-systemd-nspawn> client # [ 0.000000] CPU features: detected: Spectre-BHB vm-test-run-systemd-nspawn> client # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38 vm-test-run-systemd-nspawn> client # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23 vm-test-run-systemd-nspawn> client # [ 0.000000] alternatives: applying boot alternatives vm-test-run-systemd-nspawn> client # [ 0.000000] Kernel command line: console=ttyAMA0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/49zhjw9p29p5vq6bzvb6cmz0aw2ls87a-nixos-system-client-test/init regInfo=/nix/store/vhpidpanjywgb0acpisd1y4lgdcwsz83-closure-info/registration console=ttyAMA0,115200n8 console=tty0 vm-test-run-systemd-nspawn> client # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/vhpidpanjywgb0acpisd1y4lgdcwsz83-closure-info/registration", will be passed to user space. vm-test-run-systemd-nspawn> client # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes vm-test-run-systemd-nspawn> client # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) vm-test-run-systemd-nspawn> client # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) vm-test-run-systemd-nspawn> client # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB vm-test-run-systemd-nspawn> client # [ 0.000000] software IO TLB: area num 1. vm-test-run-systemd-nspawn> client # [ 0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB) vm-test-run-systemd-nspawn> client # [ 0.000000] Fallback order for Node 0: 0 vm-test-run-systemd-nspawn> client # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144 vm-test-run-systemd-nspawn> client # [ 0.000000] Policy zone: DMA vm-test-run-systemd-nspawn> client # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off vm-test-run-systemd-nspawn> client # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 vm-test-run-systemd-nspawn> client # [ 0.000000] allocated 2097152 bytes of page_ext vm-test-run-systemd-nspawn> client # [ 0.000000] ftrace: allocating 74886 entries in 294 pages vm-test-run-systemd-nspawn> client # [ 0.000000] ftrace: allocated 294 pages with 4 groups vm-test-run-systemd-nspawn> client # [ 0.000000] rcu: Hierarchical RCU implementation. vm-test-run-systemd-nspawn> client # [ 0.000000] rcu: RCU event tracing is enabled. vm-test-run-systemd-nspawn> client # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. vm-test-run-systemd-nspawn> client # [ 0.000000] Trampoline variant of Tasks RCU enabled. vm-test-run-systemd-nspawn> client # [ 0.000000] Rude variant of Tasks RCU enabled. vm-test-run-systemd-nspawn> client # [ 0.000000] Tracing variant of Tasks RCU enabled. vm-test-run-systemd-nspawn> client # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. vm-test-run-systemd-nspawn> client # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 vm-test-run-systemd-nspawn> client # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. vm-test-run-systemd-nspawn> client # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. vm-test-run-systemd-nspawn> client # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. vm-test-run-systemd-nspawn> client # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 vm-test-run-systemd-nspawn> client # [ 0.000000] GICv3: 256 SPIs implemented vm-test-run-systemd-nspawn> client # [ 0.000000] GICv3: 0 Extended SPIs implemented vm-test-run-systemd-nspawn> client # [ 0.000000] Root IRQ handler: gic_handle_irq vm-test-run-systemd-nspawn> client # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI vm-test-run-systemd-nspawn> client # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0 vm-test-run-systemd-nspawn> client # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 vm-test-run-systemd-nspawn> client # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] vm-test-run-systemd-nspawn> client # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1) vm-test-run-systemd-nspawn> client # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1) vm-test-run-systemd-nspawn> client # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000 vm-test-run-systemd-nspawn> client # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000 vm-test-run-systemd-nspawn> client # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. vm-test-run-systemd-nspawn> client # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns vm-test-run-systemd-nspawn> client # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt). vm-test-run-systemd-nspawn> client # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns vm-test-run-systemd-nspawn> client # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns vm-test-run-systemd-nspawn> client # [ 0.000033] arm-pv: using stolen time PV vm-test-run-systemd-nspawn> client # [ 0.000460] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) vm-test-run-systemd-nspawn> server # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40] vm-test-run-systemd-nspawn> client # [ 0.000647] Console: colour dummy device 80x25 vm-test-run-systemd-nspawn> client # [ 0.000655] printk: legacy console [tty0] enabled vm-test-run-systemd-nspawn> server # [ 0.000000] Linux version 6.18.49 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Wed Sep 2 12:31:51 UTC 2026 vm-test-run-systemd-nspawn> server # [ 0.000000] KASLR enabled vm-test-run-systemd-nspawn> client # [ 0.000841] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) vm-test-run-systemd-nspawn> server # [ 0.000000] random: crng init done vm-test-run-systemd-nspawn> client # [ 0.000848] pid_max: default: 32768 minimum: 301 vm-test-run-systemd-nspawn> server # [ 0.000000] Machine model: linux,dummy-virt vm-test-run-systemd-nspawn> server # [ 0.000000] efi: UEFI not found. vm-test-run-systemd-nspawn> client # [ 0.000919] LSM: initializing lsm=capability,landlock,yama,bpf,ima vm-test-run-systemd-nspawn> client # [ 0.001089] landlock: Up and running. vm-test-run-systemd-nspawn> server # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT vm-test-run-systemd-nspawn> client # [ 0.001092] Yama: becoming mindful. vm-test-run-systemd-nspawn> client # [ 0.001585] LSM support for eBPF active vm-test-run-systemd-nspawn> server # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff] vm-test-run-systemd-nspawn> client # [ 0.001702] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) vm-test-run-systemd-nspawn> server # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fded700-0x7fdf0e7f] vm-test-run-systemd-nspawn> server # [ 0.000000] Zone ranges: vm-test-run-systemd-nspawn> client # [ 0.001722] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) vm-test-run-systemd-nspawn> server # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff] vm-test-run-systemd-nspawn> client # [ 0.002895] cacheinfo: Unable to detect cache hierarchy for CPU 0 vm-test-run-systemd-nspawn> server # [ 0.000000] DMA32 empty vm-test-run-systemd-nspawn> server # [ 0.000000] Normal empty vm-test-run-systemd-nspawn> client # [ 0.003640] rcu: Hierarchical SRCU implementation. vm-test-run-systemd-nspawn> server # [ 0.000000] Device empty vm-test-run-systemd-nspawn> client # [ 0.003645] rcu: Max phase no-delay instances is 1000. vm-test-run-systemd-nspawn> server # [ 0.000000] Movable zone start for each node vm-test-run-systemd-nspawn> server # [ 0.000000] Early memory node ranges vm-test-run-systemd-nspawn> client # [ 0.004842] fsl-mc MSI: its@8080000 domain created vm-test-run-systemd-nspawn> client # [ 0.004934] EFI services will not be available. vm-test-run-systemd-nspawn> server # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff] vm-test-run-systemd-nspawn> client # [ 0.005049] smp: Bringing up secondary CPUs ... vm-test-run-systemd-nspawn> server # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff] vm-test-run-systemd-nspawn> client # [ 0.005058] smp: Brought up 1 node, 1 CPU vm-test-run-systemd-nspawn> server # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc00000 vm-test-run-systemd-nspawn> client # [ 0.005061] SMP: Total of 1 processors activated. vm-test-run-systemd-nspawn> client # [ 0.005064] CPU: All CPU(s) started at EL1 vm-test-run-systemd-nspawn> server # [ 0.000000] psci: probing for conduit method from DT. vm-test-run-systemd-nspawn> server # [ 0.000000] psci: PSCIv1.3 detected in firmware. vm-test-run-systemd-nspawn> client # [ 0.005080] CPU features: detected: Branch Target Identification vm-test-run-systemd-nspawn> server # [ 0.000000] psci: Using standard PSCI v0.2 function IDs vm-test-run-systemd-nspawn> client # [ 0.005085] CPU features: detected: ARMv8.4 Translation Table Level vm-test-run-systemd-nspawn> server # [ 0.000000] psci: Trusted OS migration not required vm-test-run-systemd-nspawn> server # [ 0.000000] psci: SMC Calling Convention v1.1 vm-test-run-systemd-nspawn> client # [ 0.005088] CPU features: detected: Instruction cache invalidation not required for I/D coherence vm-test-run-systemd-nspawn> server # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) vm-test-run-systemd-nspawn> client # [ 0.005091] CPU features: detected: Data cache clean to the PoU not required for I/D coherence vm-test-run-systemd-nspawn> server # [ 0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u311296 vm-test-run-systemd-nspawn> client # [ 0.005095] CPU features: detected: Common not Private translations vm-test-run-systemd-nspawn> client # [ 0.005099] CPU features: detected: CRC32 instructions vm-test-run-systemd-nspawn> server # [ 0.000000] Detected PIPT I-cache on CPU0 vm-test-run-systemd-nspawn> client # [ 0.005101] CPU features: detected: Data cache clean to Point of Deep Persistence vm-test-run-systemd-nspawn> server # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm) vm-test-run-systemd-nspawn> client # [ 0.005105] CPU features: detected: Data cache clean to Point of Persistence vm-test-run-systemd-nspawn> server # [ 0.000000] CPU features: detected: GICv3 CPU interface vm-test-run-systemd-nspawn> client # [ 0.005108] CPU features: detected: Data independent timing control (DIT) vm-test-run-systemd-nspawn> server # [ 0.000000] CPU features: detected: Spectre-v4 vm-test-run-systemd-nspawn> client # [ 0.005111] CPU features: detected: E0PD vm-test-run-systemd-nspawn> server # [ 0.000000] CPU features: detected: Spectre-BHB vm-test-run-systemd-nspawn> client # [ 0.005114] CPU features: detected: Enhanced Counter Virtualization vm-test-run-systemd-nspawn> server # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38 vm-test-run-systemd-nspawn> client # [ 0.005117] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) vm-test-run-systemd-nspawn> server # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23 vm-test-run-systemd-nspawn> client # [ 0.005120] CPU features: detected: Enhanced Virtualization Traps vm-test-run-systemd-nspawn> server # [ 0.000000] alternatives: applying boot alternatives vm-test-run-systemd-nspawn> client # [ 0.005123] CPU features: detected: Fine Grained Traps vm-test-run-systemd-nspawn> client # [ 0.005127] CPU features: detected: Generic authentication (architected QARMA5 algorithm) vm-test-run-systemd-nspawn> client # [ 0.005132] CPU features: detected: RCpc load-acquire (LDAPR) vm-test-run-systemd-nspawn> client # [ 0.005136] CPU features: detected: LSE atomic instructions vm-test-run-systemd-nspawn> client # [ 0.005139] CPU features: detected: Privileged Access Never vm-test-run-systemd-nspawn> server # [ 0.000000] Kernel command line: console=ttyAMA0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/9jkg1k6dq4h2r3qcfi70ixnwx6mxy1fm-nixos-system-server-test/init regInfo=/nix/store/krhng9bs0ilma20qgs2s990g5w9zxd8q-closure-info/registration console=ttyAMA0,115200n8 console=tty0 vm-test-run-systemd-nspawn> client # [ 0.005141] CPU features: detected: PMUv3 vm-test-run-systemd-nspawn> client # [ 0.005144] CPU features: detected: RAS Extension Support vm-test-run-systemd-nspawn> client # [ 0.005147] CPU features: detected: RASv1p1 Extension Support vm-test-run-systemd-nspawn> server # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/krhng9bs0ilma20qgs2s990g5w9zxd8q-closure-info/registration", will be passed to user space. vm-test-run-systemd-nspawn> client # [ 0.005149] CPU features: detected: Random Number Generator vm-test-run-systemd-nspawn> server # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes vm-test-run-systemd-nspawn> client # [ 0.005152] CPU features: detected: Speculation barrier (SB) vm-test-run-systemd-nspawn> server # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) vm-test-run-systemd-nspawn> client # [ 0.005155] CPU features: detected: Stage-2 Force Write-Back vm-test-run-systemd-nspawn> client # [ 0.005158] CPU features: detected: TLB range maintenance instructions vm-test-run-systemd-nspawn> server # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) vm-test-run-systemd-nspawn> client # [ 0.005163] CPU features: detected: Speculative Store Bypassing Safe (SSBS) vm-test-run-systemd-nspawn> server # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB vm-test-run-systemd-nspawn> server # [ 0.000000] software IO TLB: area num 1. vm-test-run-systemd-nspawn> client # [ 0.005203] alternatives: applying system-wide alternatives vm-test-run-systemd-nspawn> server # [ 0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB) vm-test-run-systemd-nspawn> client # [ 0.008178] CPU features: detected: BBM Level 2 without TLB conflict abort vm-test-run-systemd-nspawn> server # [ 0.000000] Fallback order for Node 0: 0 vm-test-run-systemd-nspawn> server # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144 vm-test-run-systemd-nspawn> server # [ 0.000000] Policy zone: DMA vm-test-run-systemd-nspawn> client # [ 0.008410] Memory: 894300K/1048576K available (24448K kernel code, 7090K rwdata, 26344K rodata, 4736K init, 1107K bss, 112964K reserved, 32768K cma-reserved) vm-test-run-systemd-nspawn> client # [ 0.008788] devtmpfs: initialized vm-test-run-systemd-nspawn> server # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off vm-test-run-systemd-nspawn> client # [ 0.010572] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) vm-test-run-systemd-nspawn> server # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 vm-test-run-systemd-nspawn> server # [ 0.000000] allocated 2097152 bytes of page_ext vm-test-run-systemd-nspawn> client # [ 0.010595] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). vm-test-run-systemd-nspawn> server # [ 0.000000] ftrace: allocating 74886 entries in 294 pages vm-test-run-systemd-nspawn> client # [ 0.010788] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL vm-test-run-systemd-nspawn> server # [ 0.000000] ftrace: allocated 294 pages with 4 groups vm-test-run-systemd-nspawn> client # [ 0.010792] 0 pages in range for non-PLT usage vm-test-run-systemd-nspawn> server # [ 0.000000] rcu: Hierarchical RCU implementation. vm-test-run-systemd-nspawn> client # [ 0.010793] 508288 pages in range for PLT usage vm-test-run-systemd-nspawn> server # [ 0.000000] rcu: RCU event tracing is enabled. vm-test-run-systemd-nspawn> client # [ 0.010915] pinctrl core: initialized pinctrl subsystem vm-test-run-systemd-nspawn> server # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. vm-test-run-systemd-nspawn> client # [ 0.011754] DMI not present or invalid. vm-test-run-systemd-nspawn> server # [ 0.000000] Trampoline variant of Tasks RCU enabled. vm-test-run-systemd-nspawn> client # [ 0.014977] NET: Registered PF_NETLINK/PF_ROUTE protocol family vm-test-run-systemd-nspawn> server # [ 0.000000] Rude variant of Tasks RCU enabled. vm-test-run-systemd-nspawn> client # [ 0.017363] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations vm-test-run-systemd-nspawn> server # [ 0.000000] Tracing variant of Tasks RCU enabled. vm-test-run-systemd-nspawn> client # [ 0.017512] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations vm-test-run-systemd-nspawn> server # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. vm-test-run-systemd-nspawn> server # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 vm-test-run-systemd-nspawn> client # [ 0.017673] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations vm-test-run-systemd-nspawn> client # [ 0.017696] audit: initializing netlink subsys (disabled) vm-test-run-systemd-nspawn> server # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. vm-test-run-systemd-nspawn> client # [ 0.018251] thermal_sys: Registered thermal governor 'fair_share' vm-test-run-systemd-nspawn> server # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. vm-test-run-systemd-nspawn> client # [ 0.018254] thermal_sys: Registered thermal governor 'bang_bang' vm-test-run-systemd-nspawn> client # [ 0.018257] thermal_sys: Registered thermal governor 'step_wise' vm-test-run-systemd-nspawn> server # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. vm-test-run-systemd-nspawn> client # [ 0.018260] thermal_sys: Registered thermal governor 'user_space' vm-test-run-systemd-nspawn> server # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 vm-test-run-systemd-nspawn> server # [ 0.000000] GICv3: 256 SPIs implemented vm-test-run-systemd-nspawn> client # [ 0.018265] thermal_sys: Registered thermal governor 'power_allocator' vm-test-run-systemd-nspawn> server # [ 0.000000] GICv3: 0 Extended SPIs implemented vm-test-run-systemd-nspawn> server # [ 0.000000] Root IRQ handler: gic_handle_irq vm-test-run-systemd-nspawn> client # [ 0.018305] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1 vm-test-run-systemd-nspawn> server # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI vm-test-run-systemd-nspawn> client # [ 0.018314] cpuidle: using governor ladder vm-test-run-systemd-nspawn> client # [ 0.018320] cpuidle: using governor menu vm-test-run-systemd-nspawn> server # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0 vm-test-run-systemd-nspawn> client # [ 0.018511] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers. vm-test-run-systemd-nspawn> server # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 vm-test-run-systemd-nspawn> server # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] vm-test-run-systemd-nspawn> client # [ 0.018526] ASID allocator initialised with 65536 entries vm-test-run-systemd-nspawn> client # [ 0.019698] Serial: AMBA PL011 UART driver vm-test-run-systemd-nspawn> server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1) vm-test-run-systemd-nspawn> client # [ 0.025008] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 vm-test-run-systemd-nspawn> client # [ 0.025170] printk: console [ttyAMA0] enabled vm-test-run-systemd-nspawn> server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1) vm-test-run-systemd-nspawn> server # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000 vm-test-run-systemd-nspawn> server # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000 vm-test-run-systemd-nspawn> server # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. vm-test-run-systemd-nspawn> server # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns vm-test-run-systemd-nspawn> server # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt). vm-test-run-systemd-nspawn> server # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns vm-test-run-systemd-nspawn> server # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns vm-test-run-systemd-nspawn> server # [ 0.000029] arm-pv: using stolen time PV vm-test-run-systemd-nspawn> server # [ 0.000396] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) vm-test-run-systemd-nspawn> server # [ 0.000593] Console: colour dummy device 80x25 vm-test-run-systemd-nspawn> client # [ 0.149542] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages vm-test-run-systemd-nspawn> server # [ 0.000600] printk: legacy console [tty0] enabled vm-test-run-systemd-nspawn> client # [ 0.149563] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page vm-test-run-systemd-nspawn> server # [ 0.000783] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) vm-test-run-systemd-nspawn> client # [ 0.149568] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages vm-test-run-systemd-nspawn> server # [ 0.000790] pid_max: default: 32768 minimum: 301 vm-test-run-systemd-nspawn> client # [ 0.149573] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page vm-test-run-systemd-nspawn> server # [ 0.000859] LSM: initializing lsm=capability,landlock,yama,bpf,ima vm-test-run-systemd-nspawn> server # [ 0.001015] landlock: Up and running. vm-test-run-systemd-nspawn> client # [ 0.149577] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages vm-test-run-systemd-nspawn> server # [ 0.001018] Yama: becoming mindful. vm-test-run-systemd-nspawn> client # [ 0.149582] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page vm-test-run-systemd-nspawn> server # [ 0.001452] LSM support for eBPF active vm-test-run-systemd-nspawn> client # [ 0.149586] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages vm-test-run-systemd-nspawn> server # [ 0.001599] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) vm-test-run-systemd-nspawn> client # [ 0.149590] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page vm-test-run-systemd-nspawn> server # [ 0.001618] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) vm-test-run-systemd-nspawn> server # [ 0.002690] cacheinfo: Unable to detect cache hierarchy for CPU 0 vm-test-run-systemd-nspawn> server # [ 0.003398] rcu: Hierarchical SRCU implementation. vm-test-run-systemd-nspawn> client # [ 0.157245] fbcon: Taking over console vm-test-run-systemd-nspawn> server # [ 0.003402] rcu: Max phase no-delay instances is 1000. vm-test-run-systemd-nspawn> client # [ 0.157263] ACPI: Interpreter disabled. vm-test-run-systemd-nspawn> server # [ 0.004597] fsl-mc MSI: its@8080000 domain created vm-test-run-systemd-nspawn> server # [ 0.004688] EFI services will not be available. vm-test-run-systemd-nspawn> client # [ 0.159163] iommu: Default domain type: Translated vm-test-run-systemd-nspawn> server # [ 0.004753] smp: Bringing up secondary CPUs ... vm-test-run-systemd-nspawn> server # [ 0.004761] smp: Brought up 1 node, 1 CPU vm-test-run-systemd-nspawn> client # [ 0.159173] iommu: DMA domain TLB invalidation policy: strict mode vm-test-run-systemd-nspawn> server # [ 0.004765] SMP: Total of 1 processors activated. vm-test-run-systemd-nspawn> client # [ 0.160824] SCSI subsystem initialized vm-test-run-systemd-nspawn> server # [ 0.004767] CPU: All CPU(s) started at EL1 vm-test-run-systemd-nspawn> server # [ 0.004782] CPU features: detected: Branch Target Identification vm-test-run-systemd-nspawn> server # [ 0.004786] CPU features: detected: ARMv8.4 Translation Table Level vm-test-run-systemd-nspawn> server # [ 0.004789] CPU features: detected: Instruction cache invalidation not required for I/D coherence vm-test-run-systemd-nspawn> server # [ 0.004793] CPU features: detected: Data cache clean to the PoU not required for I/D coherence vm-test-run-systemd-nspawn> server # [ 0.004797] CPU features: detected: Common not Private translations vm-test-run-systemd-nspawn> server # [ 0.004800] CPU features: detected: CRC32 instructions vm-test-run-systemd-nspawn> client # [ 0.165988] usbcore: registered new interface driver usbfs vm-test-run-systemd-nspawn> server # [ 0.004803] CPU features: detected: Data cache clean to Point of Deep Persistence vm-test-run-systemd-nspawn> client # [ 0.166019] usbcore: registered new interface driver hub vm-test-run-systemd-nspawn> server # [ 0.004806] CPU features: detected: Data cache clean to Point of Persistence vm-test-run-systemd-nspawn> client # [ 0.166034] usbcore: registered new device driver usb vm-test-run-systemd-nspawn> client # [ 0.166294] pps_core: LinuxPPS API ver. 1 registered vm-test-run-systemd-nspawn> server # [ 0.004809] CPU features: detected: Data independent timing control (DIT) vm-test-run-systemd-nspawn> server # [ 0.004813] CPU features: detected: E0PD vm-test-run-systemd-nspawn> client # [ 0.166299] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti vm-test-run-systemd-nspawn> server # [ 0.004815] CPU features: detected: Enhanced Counter Virtualization vm-test-run-systemd-nspawn> client # [ 0.166309] PTP clock support registered vm-test-run-systemd-nspawn> server # [ 0.004818] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) vm-test-run-systemd-nspawn> client # [ 0.166356] EDAC MC: Ver: 3.0.0 vm-test-run-systemd-nspawn> client # [ 0.170958] scmi_core: SCMI protocol bus registered vm-test-run-systemd-nspawn> server # [ 0.004822] CPU features: detected: Enhanced Virtualization Traps vm-test-run-systemd-nspawn> server # [ 0.004825] CPU features: detected: Fine Grained Traps vm-test-run-systemd-nspawn> client # [ 0.171902] FPGA manager framework vm-test-run-systemd-nspawn> client # [ 0.172846] vgaarb: loaded vm-test-run-systemd-nspawn> server # [ 0.004828] CPU features: detected: Generic authentication (architected QARMA5 algorithm) vm-test-run-systemd-nspawn> server # [ 0.004834] CPU features: detected: RCpc load-acquire (LDAPR) vm-test-run-systemd-nspawn> client # [ 0.173482] clocksource: Switched to clocksource arch_sys_counter vm-test-run-systemd-nspawn> server # [ 0.004837] CPU features: detected: LSE atomic instructions vm-test-run-systemd-nspawn> server # [ 0.004840] CPU features: detected: Privileged Access Never vm-test-run-systemd-nspawn> server # [ 0.004843] CPU features: detected: PMUv3 vm-test-run-systemd-nspawn> server # [ 0.004845] CPU features: detected: RAS Extension Support vm-test-run-systemd-nspawn> server # [ 0.004848] CPU features: detected: RASv1p1 Extension Support vm-test-run-systemd-nspawn> client # [ 0.177390] VFS: Disk quotas dquot_6.6.0 vm-test-run-systemd-nspawn> server # [ 0.004851] CPU features: detected: Random Number Generator vm-test-run-systemd-nspawn> server # [ 0.004853] CPU features: detected: Speculation barrier (SB) vm-test-run-systemd-nspawn> client # [ 0.177432] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) vm-test-run-systemd-nspawn> server # [ 0.004856] CPU features: detected: Stage-2 Force Write-Back vm-test-run-systemd-nspawn> server # [ 0.004859] CPU features: detected: TLB range maintenance instructions vm-test-run-systemd-nspawn> server # [ 0.004864] CPU features: detected: Speculative Store Bypassing Safe (SSBS) vm-test-run-systemd-nspawn> server # [ 0.004903] alternatives: applying system-wide alternatives vm-test-run-systemd-nspawn> client # [ 0.181134] netfs: FS-Cache loaded vm-test-run-systemd-nspawn> client # [ 0.181243] pnp: PnP ACPI: disabled vm-test-run-systemd-nspawn> server # [ 0.007874] CPU features: detected: BBM Level 2 without TLB conflict abort vm-test-run-systemd-nspawn> server # [ 0.008011] Memory: 894288K/1048576K available (24448K kernel code, 7090K rwdata, 26344K rodata, 4736K init, 1107K bss, 112960K reserved, 32768K cma-reserved) vm-test-run-systemd-nspawn> server # [ 0.008428] devtmpfs: initialized vm-test-run-systemd-nspawn> client # [ 0.185218] NET: Registered PF_INET protocol family vm-test-run-systemd-nspawn> client # [ 0.185387] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) vm-test-run-systemd-nspawn> server # [ 0.010094] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) vm-test-run-systemd-nspawn> server # [ 0.010117] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). vm-test-run-systemd-nspawn> server # [ 0.010306] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL vm-test-run-systemd-nspawn> server # [ 0.010311] 0 pages in range for non-PLT usage vm-test-run-systemd-nspawn> server # [ 0.010312] 508288 pages in range for PLT usage vm-test-run-systemd-nspawn> server # [ 0.010421] pinctrl core: initialized pinctrl subsystem vm-test-run-systemd-nspawn> server # [ 0.011193] DMI not present or invalid. vm-test-run-systemd-nspawn> server # [ 0.014292] NET: Registered PF_NETLINK/PF_ROUTE protocol family vm-test-run-systemd-nspawn> server # [ 0.016620] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations vm-test-run-systemd-nspawn> server # [ 0.016765] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations vm-test-run-systemd-nspawn> server # [ 0.016929] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations vm-test-run-systemd-nspawn> server # [ 0.016951] audit: initializing netlink subsys (disabled) vm-test-run-systemd-nspawn> server # [ 0.017551] thermal_sys: Registered thermal governor 'fair_share' vm-test-run-systemd-nspawn> server # [ 0.017553] thermal_sys: Registered thermal governor 'bang_bang' vm-test-run-systemd-nspawn> server # [ 0.017557] thermal_sys: Registered thermal governor 'step_wise' vm-test-run-systemd-nspawn> server # [ 0.017559] thermal_sys: Registered thermal governor 'user_space' vm-test-run-systemd-nspawn> server # [ 0.017565] thermal_sys: Registered thermal governor 'power_allocator' vm-test-run-systemd-nspawn> server # [ 0.017595] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1 vm-test-run-systemd-nspawn> server # [ 0.017605] cpuidle: using governor ladder vm-test-run-systemd-nspawn> server # [ 0.017611] cpuidle: using governor menu vm-test-run-systemd-nspawn> server # [ 0.017804] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers. vm-test-run-systemd-nspawn> server # [ 0.017819] ASID allocator initialised with 65536 entries vm-test-run-systemd-nspawn> server # [ 0.019333] Serial: AMBA PL011 UART driver vm-test-run-systemd-nspawn> server # [ 0.024531] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 vm-test-run-systemd-nspawn> server # [ 0.024694] printk: console [ttyAMA0] enabled vm-test-run-systemd-nspawn> server # [ 0.148501] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages vm-test-run-systemd-nspawn> server # [ 0.148525] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page vm-test-run-systemd-nspawn> server # [ 0.148531] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages vm-test-run-systemd-nspawn> server # [ 0.148535] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page vm-test-run-systemd-nspawn> server # [ 0.148540] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages vm-test-run-systemd-nspawn> server # [ 0.148544] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page vm-test-run-systemd-nspawn> server # [ 0.148549] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages vm-test-run-systemd-nspawn> server # [ 0.148553] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page vm-test-run-systemd-nspawn> server # [ 0.156068] fbcon: Taking over console vm-test-run-systemd-nspawn> server # [ 0.156086] ACPI: Interpreter disabled. vm-test-run-systemd-nspawn> server # [ 0.158025] iommu: Default domain type: Translated vm-test-run-systemd-nspawn> server # [ 0.158036] iommu: DMA domain TLB invalidation policy: strict mode vm-test-run-systemd-nspawn> client # [ 0.215568] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) vm-test-run-systemd-nspawn> server # [ 0.159775] SCSI subsystem initialized vm-test-run-systemd-nspawn> client # [ 0.215621] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) vm-test-run-systemd-nspawn> client # [ 0.215646] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-systemd-nspawn> client # [ 0.215699] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) vm-test-run-systemd-nspawn> client # [ 0.215774] TCP: Hash tables configured (established 8192 bind 8192) vm-test-run-systemd-nspawn> client # [ 0.215889] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) vm-test-run-systemd-nspawn> client # [ 0.215922] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) vm-test-run-systemd-nspawn> server # [ 0.164857] usbcore: registered new interface driver usbfs vm-test-run-systemd-nspawn> client # [ 0.215948] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) vm-test-run-systemd-nspawn> server # [ 0.164890] usbcore: registered new interface driver hub vm-test-run-systemd-nspawn> client # [ 0.216025] NET: Registered PF_UNIX/PF_LOCAL protocol family vm-test-run-systemd-nspawn> server # [ 0.164907] usbcore: registered new device driver usb vm-test-run-systemd-nspawn> client # [ 0.216069] NET: Registered PF_XDP protocol family vm-test-run-systemd-nspawn> server # [ 0.165182] pps_core: LinuxPPS API ver. 1 registered vm-test-run-systemd-nspawn> client # [ 0.216091] PCI: CLS 0 bytes, default 64 vm-test-run-systemd-nspawn> client # [ 0.216334] Trying to unpack rootfs image as initramfs... vm-test-run-systemd-nspawn> server # [ 0.165188] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti vm-test-run-systemd-nspawn> server # [ 0.165198] PTP clock support registered vm-test-run-systemd-nspawn> server # [ 0.165248] EDAC MC: Ver: 3.0.0 vm-test-run-systemd-nspawn> server # [ 0.169946] scmi_core: SCMI protocol bus registered vm-test-run-systemd-nspawn> client # [ 0.231210] kvm [1]: HYP mode not available vm-test-run-systemd-nspawn> server # [ 0.170921] FPGA manager framework vm-test-run-systemd-nspawn> server # [ 0.171854] vgaarb: loaded vm-test-run-systemd-nspawn> server # [ 0.172519] clocksource: Switched to clocksource arch_sys_counter vm-test-run-systemd-nspawn> server # [ 0.176612] VFS: Disk quotas dquot_6.6.0 vm-test-run-systemd-nspawn> server # [ 0.176641] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) vm-test-run-systemd-nspawn> server # [ 0.180224] netfs: FS-Cache loaded vm-test-run-systemd-nspawn> server # [ 0.180348] pnp: PnP ACPI: disabled vm-test-run-systemd-nspawn> server # [ 0.184313] NET: Registered PF_INET protocol family vm-test-run-systemd-nspawn> server # [ 0.184472] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) vm-test-run-systemd-nspawn> server # [ 0.214238] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) vm-test-run-systemd-nspawn> server # [ 0.214291] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) vm-test-run-systemd-nspawn> server # [ 0.214319] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-systemd-nspawn> server # [ 0.214370] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) vm-test-run-systemd-nspawn> server # [ 0.214445] TCP: Hash tables configured (established 8192 bind 8192) vm-test-run-systemd-nspawn> server # [ 0.214545] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) vm-test-run-systemd-nspawn> server # [ 0.214601] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) vm-test-run-systemd-nspawn> server # [ 0.214661] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) vm-test-run-systemd-nspawn> server # [ 0.214771] NET: Registered PF_UNIX/PF_LOCAL protocol family vm-test-run-systemd-nspawn> server # [ 0.214793] NET: Registered PF_XDP protocol family vm-test-run-systemd-nspawn> server # [ 0.214816] PCI: CLS 0 bytes, default 64 vm-test-run-systemd-nspawn> server # [ 0.215073] Trying to unpack rootfs image as initramfs... vm-test-run-systemd-nspawn> server # [ 0.230209] kvm [1]: HYP mode not available vm-test-run-systemd-nspawn> client # [ 0.342079] Initialise system trusted keyrings vm-test-run-systemd-nspawn> client # [ 0.342860] workingset: timestamp_bits=42 max_order=18 bucket_order=0 vm-test-run-systemd-nspawn> client # [ 0.344168] squashfs: version 4.0 (2009/01/31) Phillip Lougher vm-test-run-systemd-nspawn> client # [ 0.344926] 9p: Installing v9fs 9p2000 file system support vm-test-run-systemd-nspawn> client # [ 0.373618] Key type asymmetric registered vm-test-run-systemd-nspawn> client # [ 0.373647] Asymmetric key parser 'x509' registered vm-test-run-systemd-nspawn> client # [ 0.373739] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) vm-test-run-systemd-nspawn> client # [ 0.375901] io scheduler mq-deadline registered vm-test-run-systemd-nspawn> client # [ 0.375912] io scheduler kyber registered vm-test-run-systemd-nspawn> client # [ 0.385637] pl061_gpio 9030000.pl061: PL061 GPIO chip registered vm-test-run-systemd-nspawn> client # [ 0.387158] ledtrig-cpu: registered to indicate activity on CPUs vm-test-run-systemd-nspawn> client # [ 0.387562] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: vm-test-run-systemd-nspawn> client # [ 0.387580] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 vm-test-run-systemd-nspawn> client # [ 0.387597] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 vm-test-run-systemd-nspawn> client # [ 0.387606] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 vm-test-run-systemd-nspawn> client # [ 0.387646] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits vm-test-run-systemd-nspawn> client # [ 0.387674] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] vm-test-run-systemd-nspawn> client # [ 0.387751] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 vm-test-run-systemd-nspawn> client # [ 0.387761] pci_bus 0000:00: root bus resource [bus 00-ff] vm-test-run-systemd-nspawn> client # [ 0.387767] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] vm-test-run-systemd-nspawn> client # [ 0.387772] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] vm-test-run-systemd-nspawn> client # [ 0.387778] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] vm-test-run-systemd-nspawn> client # [ 0.387842] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint vm-test-run-systemd-nspawn> client # [ 0.388264] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-systemd-nspawn> client # [ 0.388445] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] vm-test-run-systemd-nspawn> client # [ 0.388462] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-systemd-nspawn> client # [ 0.388492] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-systemd-nspawn> client # [ 0.388509] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-systemd-nspawn> client # [ 0.388963] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-systemd-nspawn> client # [ 0.389141] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] vm-test-run-systemd-nspawn> client # [ 0.389158] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-systemd-nspawn> client # [ 0.389187] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-systemd-nspawn> client # [ 0.408700] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-systemd-nspawn> client # [ 0.408889] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] vm-test-run-systemd-nspawn> client # [ 0.408906] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-systemd-nspawn> server # [ 0.349122] Initialise system trusted keyrings vm-test-run-systemd-nspawn> client # [ 0.408936] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-systemd-nspawn> server # [ 0.349895] workingset: timestamp_bits=42 max_order=18 bucket_order=0 vm-test-run-systemd-nspawn> client # [ 0.409384] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-systemd-nspawn> server # [ 0.351196] squashfs: version 4.0 (2009/01/31) Phillip Lougher vm-test-run-systemd-nspawn> server # [ 0.351927] 9p: Installing v9fs 9p2000 file system support vm-test-run-systemd-nspawn> client # [ 0.421647] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] vm-test-run-systemd-nspawn> client # [ 0.421684] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-systemd-nspawn> client # [ 0.421715] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-systemd-nspawn> client # [ 0.422243] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-systemd-nspawn> client # [ 0.422428] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] vm-test-run-systemd-nspawn> client # [ 0.422445] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-systemd-nspawn> client # [ 0.422475] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-systemd-nspawn> client # [ 0.422919] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint vm-test-run-systemd-nspawn> client # [ 0.423126] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] vm-test-run-systemd-nspawn> client # [ 0.423143] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-systemd-nspawn> client # [ 0.423173] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-systemd-nspawn> client # [ 0.423635] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-systemd-nspawn> client # [ 0.423819] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] vm-test-run-systemd-nspawn> client # [ 0.423835] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-systemd-nspawn> client # [ 0.423865] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-systemd-nspawn> client # [ 0.423882] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-systemd-nspawn> client # [ 0.424343] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint vm-test-run-systemd-nspawn> client # [ 0.424526] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-systemd-nspawn> server # [ 0.380604] Key type asymmetric registered vm-test-run-systemd-nspawn> client # [ 0.424555] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-systemd-nspawn> server # [ 0.380635] Asymmetric key parser 'x509' registered vm-test-run-systemd-nspawn> client # [ 0.424995] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint vm-test-run-systemd-nspawn> server # [ 0.380711] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) vm-test-run-systemd-nspawn> server # [ 0.382874] io scheduler mq-deadline registered vm-test-run-systemd-nspawn> client # [ 0.425176] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-systemd-nspawn> server # [ 0.382886] io scheduler kyber registered vm-test-run-systemd-nspawn> client # [ 0.425206] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-systemd-nspawn> client # [ 0.425600] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint vm-test-run-systemd-nspawn> client # [ 0.425777] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] vm-test-run-systemd-nspawn> client # [ 0.426019] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint vm-test-run-systemd-nspawn> client # [ 0.426307] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] vm-test-run-systemd-nspawn> client # [ 0.426325] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-systemd-nspawn> client # [ 0.426355] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-systemd-nspawn> client # [ 0.426819] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-systemd-nspawn> client # [ 0.426996] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] vm-test-run-systemd-nspawn> client # [ 0.427029] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-systemd-nspawn> client # [ 0.427059] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-systemd-nspawn> client # [ 0.427654] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned vm-test-run-systemd-nspawn> client # [ 0.427666] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned vm-test-run-systemd-nspawn> server # [ 0.392686] pl061_gpio 9030000.pl061: PL061 GPIO chip registered vm-test-run-systemd-nspawn> client # [ 0.427672] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned vm-test-run-systemd-nspawn> client # [ 0.427717] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned vm-test-run-systemd-nspawn> client # [ 0.427765] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned vm-test-run-systemd-nspawn> server # [ 0.394155] ledtrig-cpu: registered to indicate activity on CPUs vm-test-run-systemd-nspawn> client # [ 0.427813] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned vm-test-run-systemd-nspawn> server # [ 0.394552] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: vm-test-run-systemd-nspawn> client # [ 0.427859] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned vm-test-run-systemd-nspawn> server # [ 0.394570] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 vm-test-run-systemd-nspawn> client # [ 0.427906] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned vm-test-run-systemd-nspawn> server # [ 0.394587] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 vm-test-run-systemd-nspawn> client # [ 0.427952] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned vm-test-run-systemd-nspawn> server # [ 0.394596] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 vm-test-run-systemd-nspawn> client # [ 0.427999] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned vm-test-run-systemd-nspawn> server # [ 0.394618] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits vm-test-run-systemd-nspawn> client # [ 0.428044] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned vm-test-run-systemd-nspawn> server # [ 0.394651] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] vm-test-run-systemd-nspawn> client # [ 0.428091] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned vm-test-run-systemd-nspawn> server # [ 0.394726] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 vm-test-run-systemd-nspawn> client # [ 0.428192] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned vm-test-run-systemd-nspawn> server # [ 0.394735] pci_bus 0000:00: root bus resource [bus 00-ff] vm-test-run-systemd-nspawn> client # [ 0.428239] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned vm-test-run-systemd-nspawn> server # [ 0.394742] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] vm-test-run-systemd-nspawn> client # [ 0.428261] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned vm-test-run-systemd-nspawn> server # [ 0.394748] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] vm-test-run-systemd-nspawn> client # [ 0.428282] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned vm-test-run-systemd-nspawn> server # [ 0.394753] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] vm-test-run-systemd-nspawn> client # [ 0.428304] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned vm-test-run-systemd-nspawn> server # [ 0.394854] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint vm-test-run-systemd-nspawn> client # [ 0.428326] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned vm-test-run-systemd-nspawn> server # [ 0.395307] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-systemd-nspawn> client # [ 0.428351] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned vm-test-run-systemd-nspawn> server # [ 0.395494] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] vm-test-run-systemd-nspawn> client # [ 0.428374] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned vm-test-run-systemd-nspawn> server # [ 0.395511] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-systemd-nspawn> client # [ 0.428396] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned vm-test-run-systemd-nspawn> server # [ 0.395541] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-systemd-nspawn> client # [ 0.428418] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned vm-test-run-systemd-nspawn> server # [ 0.395557] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-systemd-nspawn> client # [ 0.428441] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned vm-test-run-systemd-nspawn> server # [ 0.396011] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-systemd-nspawn> client # [ 0.428463] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned vm-test-run-systemd-nspawn> server # [ 0.396197] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] vm-test-run-systemd-nspawn> client # [ 0.428486] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned vm-test-run-systemd-nspawn> server # [ 0.396213] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-systemd-nspawn> client # [ 0.428508] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned vm-test-run-systemd-nspawn> server # [ 0.396242] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-systemd-nspawn> client # [ 0.428529] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned vm-test-run-systemd-nspawn> client # [ 0.428551] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned vm-test-run-systemd-nspawn> server # [ 0.416426] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-systemd-nspawn> client # [ 0.428573] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned vm-test-run-systemd-nspawn> client # [ 0.428594] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned vm-test-run-systemd-nspawn> client # [ 0.428616] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned vm-test-run-systemd-nspawn> client # [ 0.428638] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned vm-test-run-systemd-nspawn> server # [ 0.417637] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] vm-test-run-systemd-nspawn> client # [ 0.428661] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned vm-test-run-systemd-nspawn> server # [ 0.417657] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-systemd-nspawn> client # [ 0.428683] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned vm-test-run-systemd-nspawn> client # [ 0.428710] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] vm-test-run-systemd-nspawn> server # [ 0.417687] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-systemd-nspawn> client # [ 0.428720] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] vm-test-run-systemd-nspawn> server # [ 0.418167] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-systemd-nspawn> client # [ 0.428725] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] vm-test-run-systemd-nspawn> server # [ 0.418369] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] vm-test-run-systemd-nspawn> server # [ 0.418386] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-systemd-nspawn> server # [ 0.418416] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-systemd-nspawn> server # [ 0.418910] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-systemd-nspawn> server # [ 0.419107] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] vm-test-run-systemd-nspawn> server # [ 0.419125] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-systemd-nspawn> server # [ 0.419156] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-systemd-nspawn> server # [ 0.419630] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint vm-test-run-systemd-nspawn> server # [ 0.419825] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] vm-test-run-systemd-nspawn> server # [ 0.419842] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-systemd-nspawn> server # [ 0.419875] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-systemd-nspawn> server # [ 0.420354] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-systemd-nspawn> client # [ 0.493955] pci 0000:00:0a.0: enabling device (0000 -> 0002) vm-test-run-systemd-nspawn> server # [ 0.440611] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] vm-test-run-systemd-nspawn> server # [ 0.440645] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-systemd-nspawn> server # [ 0.440675] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-systemd-nspawn> server # [ 0.440692] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-systemd-nspawn> server # [ 0.441249] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint vm-test-run-systemd-nspawn> server # [ 0.441442] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-systemd-nspawn> server # [ 0.441472] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-systemd-nspawn> server # [ 0.441918] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint vm-test-run-systemd-nspawn> server # [ 0.442103] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-systemd-nspawn> client # [ 0.514812] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) vm-test-run-systemd-nspawn> server # [ 0.442133] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-systemd-nspawn> client # [ 0.516944] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) vm-test-run-systemd-nspawn> server # [ 0.442521] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint vm-test-run-systemd-nspawn> server # [ 0.442700] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] vm-test-run-systemd-nspawn> server # [ 0.442942] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint vm-test-run-systemd-nspawn> server # [ 0.443222] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] vm-test-run-systemd-nspawn> server # [ 0.443239] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-systemd-nspawn> server # [ 0.443268] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-systemd-nspawn> server # [ 0.443730] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-systemd-nspawn> server # [ 0.443916] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] vm-test-run-systemd-nspawn> server # [ 0.443931] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-systemd-nspawn> server # [ 0.443961] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-systemd-nspawn> server # [ 0.444573] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned vm-test-run-systemd-nspawn> server # [ 0.444585] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned vm-test-run-systemd-nspawn> server # [ 0.444591] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned vm-test-run-systemd-nspawn> server # [ 0.444637] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned vm-test-run-systemd-nspawn> client # [ 0.527947] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) vm-test-run-systemd-nspawn> server # [ 0.444684] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned vm-test-run-systemd-nspawn> server # [ 0.444732] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned vm-test-run-systemd-nspawn> server # [ 0.444779] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned vm-test-run-systemd-nspawn> server # [ 0.444825] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned vm-test-run-systemd-nspawn> server # [ 0.444874] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned vm-test-run-systemd-nspawn> server # [ 0.444922] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned vm-test-run-systemd-nspawn> server # [ 0.444969] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned vm-test-run-systemd-nspawn> server # [ 0.445015] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned vm-test-run-systemd-nspawn> server # [ 0.445089] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned vm-test-run-systemd-nspawn> server # [ 0.445136] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned vm-test-run-systemd-nspawn> server # [ 0.445157] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned vm-test-run-systemd-nspawn> server # [ 0.445178] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned vm-test-run-systemd-nspawn> server # [ 0.445200] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned vm-test-run-systemd-nspawn> client # [ 0.538416] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) vm-test-run-systemd-nspawn> server # [ 0.445221] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned vm-test-run-systemd-nspawn> client # [ 0.541028] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) vm-test-run-systemd-nspawn> server # [ 0.445246] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned vm-test-run-systemd-nspawn> server # [ 0.445268] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned vm-test-run-systemd-nspawn> server # [ 0.445290] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned vm-test-run-systemd-nspawn> client # [ 0.544602] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) vm-test-run-systemd-nspawn> server # [ 0.445312] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned vm-test-run-systemd-nspawn> server # [ 0.445334] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned vm-test-run-systemd-nspawn> server # [ 0.445357] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned vm-test-run-systemd-nspawn> server # [ 0.445379] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned vm-test-run-systemd-nspawn> server # [ 0.445401] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned vm-test-run-systemd-nspawn> server # [ 0.445422] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned vm-test-run-systemd-nspawn> server # [ 0.445444] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned vm-test-run-systemd-nspawn> server # [ 0.445465] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned vm-test-run-systemd-nspawn> server # [ 0.445487] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned vm-test-run-systemd-nspawn> server # [ 0.445508] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned vm-test-run-systemd-nspawn> server # [ 0.445530] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned vm-test-run-systemd-nspawn> server # [ 0.445560] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned vm-test-run-systemd-nspawn> client # [ 0.553250] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) vm-test-run-systemd-nspawn> server # [ 0.445582] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned vm-test-run-systemd-nspawn> server # [ 0.445610] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] vm-test-run-systemd-nspawn> server # [ 0.445620] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] vm-test-run-systemd-nspawn> server # [ 0.445625] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] vm-test-run-systemd-nspawn> server # [ 0.446791] pci 0000:00:0a.0: enabling device (0000 -> 0002) vm-test-run-systemd-nspawn> client # [ 0.562830] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) vm-test-run-systemd-nspawn> client # [ 0.566546] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) vm-test-run-systemd-nspawn> client # [ 0.568559] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) vm-test-run-systemd-nspawn> client # [ 0.580323] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) vm-test-run-systemd-nspawn> server # [ 0.522952] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) vm-test-run-systemd-nspawn> server # [ 0.525939] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) vm-test-run-systemd-nspawn> server # [ 0.527901] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) vm-test-run-systemd-nspawn> client # [ 0.594257] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled vm-test-run-systemd-nspawn> client # [ 0.596864] msm_serial: driver initialized vm-test-run-systemd-nspawn> client # [ 0.597021] SuperH (H)SCI(F) driver initialized vm-test-run-systemd-nspawn> client # [ 0.597073] STM32 USART driver initialized vm-test-run-systemd-nspawn> server # [ 0.538231] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) vm-test-run-systemd-nspawn> server # [ 0.540103] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) vm-test-run-systemd-nspawn> server # [ 0.543644] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) vm-test-run-systemd-nspawn> server # [ 0.552361] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) vm-test-run-systemd-nspawn> server # [ 0.561780] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) vm-test-run-systemd-nspawn> client # [ 0.628348] loop: module loaded vm-test-run-systemd-nspawn> client # [ 0.628530] virtio_blk virtio5: 1/0/0 default/read/poll queues vm-test-run-systemd-nspawn> client # [ 0.629238] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) vm-test-run-systemd-nspawn> server # [ 0.568617] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) vm-test-run-systemd-nspawn> server # [ 0.570425] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) vm-test-run-systemd-nspawn> client # [ 0.634080] megasas: 07.734.00.00-rc1 vm-test-run-systemd-nspawn> client # [ 0.634788] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] vm-test-run-systemd-nspawn> client # [ 0.636989] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-systemd-nspawn> client # [ 0.637014] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-systemd-nspawn> server # [ 0.580670] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) vm-test-run-systemd-nspawn> client # [ 0.646497] Using buffer write method vm-test-run-systemd-nspawn> client # [ 0.646579] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] vm-test-run-systemd-nspawn> client # [ 0.649443] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-systemd-nspawn> client # [ 0.649467] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-systemd-nspawn> server # [ 0.593801] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled vm-test-run-systemd-nspawn> server # [ 0.596435] msm_serial: driver initialized vm-test-run-systemd-nspawn> client # [ 0.662672] Using buffer write method vm-test-run-systemd-nspawn> server # [ 0.597168] SuperH (H)SCI(F) driver initialized vm-test-run-systemd-nspawn> client # [ 0.662709] Concatenating MTD devices: vm-test-run-systemd-nspawn> client # [ 0.662713] (0): "0.flash" vm-test-run-systemd-nspawn> server # [ 0.597227] STM32 USART driver initialized vm-test-run-systemd-nspawn> client # [ 0.662717] (1): "0.flash" vm-test-run-systemd-nspawn> client # [ 0.662721] into device "0.flash" vm-test-run-systemd-nspawn> server # [ 0.624443] loop: module loaded vm-test-run-systemd-nspawn> server # [ 0.628853] virtio_blk virtio5: 1/0/0 default/read/poll queues vm-test-run-systemd-nspawn> server # [ 0.629666] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) vm-test-run-systemd-nspawn> server # [ 0.637185] megasas: 07.734.00.00-rc1 vm-test-run-systemd-nspawn> server # [ 0.637943] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] vm-test-run-systemd-nspawn> server # [ 0.640141] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-systemd-nspawn> server # [ 0.640169] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-systemd-nspawn> server # [ 0.649548] Using buffer write method vm-test-run-systemd-nspawn> server # [ 0.649628] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] vm-test-run-systemd-nspawn> server # [ 0.660544] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-systemd-nspawn> server # [ 0.660570] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-systemd-nspawn> server # [ 0.662128] Using buffer write method vm-test-run-systemd-nspawn> server # [ 0.662159] Concatenating MTD devices: vm-test-run-systemd-nspawn> server # [ 0.662163] (0): "0.flash" vm-test-run-systemd-nspawn> server # [ 0.662167] (1): "0.flash" vm-test-run-systemd-nspawn> server # [ 0.662170] into device "0.flash" vm-test-run-systemd-nspawn> client # [ 0.903421] Freeing initrd memory: 26104K vm-test-run-systemd-nspawn> client # [ 0.909341] tun: Universal TUN/TAP device driver, 1.6 vm-test-run-systemd-nspawn> client # [ 0.913067] thunder_xcv, ver 1.0 vm-test-run-systemd-nspawn> client # [ 0.913108] thunder_bgx, ver 1.0 vm-test-run-systemd-nspawn> client # [ 0.913129] nicpf, ver 1.0 vm-test-run-systemd-nspawn> client # [ 0.914890] e1000: Intel(R) PRO/1000 Network Driver vm-test-run-systemd-nspawn> client # [ 0.914900] e1000: Copyright (c) 1999-2006 Intel Corporation. vm-test-run-systemd-nspawn> client # [ 0.914928] e1000e: Intel(R) PRO/1000 Network Driver vm-test-run-systemd-nspawn> client # [ 0.914937] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. vm-test-run-systemd-nspawn> client # [ 0.914962] igb: Intel(R) Gigabit Ethernet Network Driver vm-test-run-systemd-nspawn> client # [ 0.914968] igb: Copyright (c) 2007-2014 Intel Corporation. vm-test-run-systemd-nspawn> client # [ 0.914990] igbvf: Intel(R) Gigabit Virtual Function Network Driver vm-test-run-systemd-nspawn> client # [ 0.914995] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. vm-test-run-systemd-nspawn> client # [ 0.915149] sky2: driver version 1.30 vm-test-run-systemd-nspawn> client # [ 0.916706] usbcore: registered new interface driver usb-storage vm-test-run-systemd-nspawn> client # [ 0.916787] usbcore: registered new interface driver usbserial_generic vm-test-run-systemd-nspawn> client # [ 0.916799] usbserial: USB Serial support registered for generic vm-test-run-systemd-nspawn> client # [ 0.917393] hv_vmbus: registering driver hyperv_keyboard vm-test-run-systemd-nspawn> client # [ 0.918190] ehci-pci 0000:00:0a.0: EHCI Host Controller vm-test-run-systemd-nspawn> client # [ 0.918216] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 vm-test-run-systemd-nspawn> client # [ 0.918497] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 vm-test-run-systemd-nspawn> client # [ 0.929878] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 vm-test-run-systemd-nspawn> client # [ 0.930251] hub 1-0:1.0: USB hub found vm-test-run-systemd-nspawn> client # [ 0.930266] hub 1-0:1.0: 6 ports detected vm-test-run-systemd-nspawn> client # [ 0.933130] rtc-pl031 9010000.pl031: registered as rtc0 vm-test-run-systemd-nspawn> client # [ 0.933160] rtc-pl031 9010000.pl031: setting system clock to 2026-09-06T02:35:16 UTC (1788662116) vm-test-run-systemd-nspawn> client # [ 0.933459] i2c_dev: i2c /dev entries driver vm-test-run-systemd-nspawn> client # [ 0.938377] sdhci: Secure Digital Host Controller Interface driver vm-test-run-systemd-nspawn> client # [ 0.938389] sdhci: Copyright(c) Pierre Ossman vm-test-run-systemd-nspawn> client # [ 0.938654] Synopsys Designware Multimedia Card Interface Driver vm-test-run-systemd-nspawn> client # [ 0.939034] sdhci-pltfm: SDHCI platform and OF driver helper vm-test-run-systemd-nspawn> client # [ 0.940728] hid: raw HID events driver (C) Jiri Kosina vm-test-run-systemd-nspawn> client # [ 0.940949] usbcore: registered new interface driver usbhid vm-test-run-systemd-nspawn> client # [ 0.940956] usbhid: USB HID core driver vm-test-run-systemd-nspawn> client # [ 0.946622] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available vm-test-run-systemd-nspawn> client # [ 0.948144] drop_monitor: Initializing network drop monitor service vm-test-run-systemd-nspawn> client # [ 0.948290] NET: Registered PF_INET6 protocol family vm-test-run-systemd-nspawn> client # [ 0.951281] Segment Routing with IPv6 vm-test-run-systemd-nspawn> client # [ 0.951311] In-situ OAM (IOAM) with IPv6 vm-test-run-systemd-nspawn> client # [ 0.951338] NET: Registered PF_PACKET protocol family vm-test-run-systemd-nspawn> client # [ 0.952963] 9pnet: Installing 9P2000 support vm-test-run-systemd-nspawn> client # [ 0.955745] Key type dns_resolver registered vm-test-run-systemd-nspawn> client # [ 0.962130] registered taskstats version 1 vm-test-run-systemd-nspawn> client # [ 0.962285] Loading compiled-in X.509 certificates vm-test-run-systemd-nspawn> server # [ 0.904982] Freeing initrd memory: 26100K vm-test-run-systemd-nspawn> client # [ 0.970982] Demotion targets for Node 0: null vm-test-run-systemd-nspawn> client # [ 0.971107] Key type .fscrypt registered vm-test-run-systemd-nspawn> client # [ 0.971113] Key type fscrypt-provisioning registered vm-test-run-systemd-nspawn> client # [ 0.971210] ima: No TPM chip found, activating TPM-bypass! vm-test-run-systemd-nspawn> server # [ 0.910857] tun: Universal TUN/TAP device driver, 1.6 vm-test-run-systemd-nspawn> client # [ 0.971230] ima: Allocated hash algorithm: sha1 vm-test-run-systemd-nspawn> client # [ 0.971252] ima: No architecture policies found vm-test-run-systemd-nspawn> client # [ 0.975318] input: gpio-keys as /devices/platform/gpio-keys/input/input0 vm-test-run-systemd-nspawn> server # [ 0.914497] thunder_xcv, ver 1.0 vm-test-run-systemd-nspawn> server # [ 0.914539] thunder_bgx, ver 1.0 vm-test-run-systemd-nspawn> server # [ 0.914562] nicpf, ver 1.0 vm-test-run-systemd-nspawn> server # [ 0.915153] e1000: Intel(R) PRO/1000 Network Driver vm-test-run-systemd-nspawn> server # [ 0.915160] e1000: Copyright (c) 1999-2006 Intel Corporation. vm-test-run-systemd-nspawn> server # [ 0.915187] e1000e: Intel(R) PRO/1000 Network Driver vm-test-run-systemd-nspawn> server # [ 0.915195] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. vm-test-run-systemd-nspawn> server # [ 0.915219] igb: Intel(R) Gigabit Ethernet Network Driver vm-test-run-systemd-nspawn> server # [ 0.915225] igb: Copyright (c) 2007-2014 Intel Corporation. vm-test-run-systemd-nspawn> server # [ 0.915246] igbvf: Intel(R) Gigabit Virtual Function Network Driver vm-test-run-systemd-nspawn> server # [ 0.915253] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. vm-test-run-systemd-nspawn> server # [ 0.915383] sky2: driver version 1.30 vm-test-run-systemd-nspawn> server # [ 0.924124] usbcore: registered new interface driver usb-storage vm-test-run-systemd-nspawn> server # [ 0.924221] usbcore: registered new interface driver usbserial_generic vm-test-run-systemd-nspawn> server # [ 0.924234] usbserial: USB Serial support registered for generic vm-test-run-systemd-nspawn> server # [ 0.925133] ehci-pci 0000:00:0a.0: EHCI Host Controller vm-test-run-systemd-nspawn> server # [ 0.925158] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 vm-test-run-systemd-nspawn> server # [ 0.925324] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 vm-test-run-systemd-nspawn> client # [ 0.992599] clk: Disabling unused clocks vm-test-run-systemd-nspawn> server # [ 0.930322] hv_vmbus: registering driver hyperv_keyboard vm-test-run-systemd-nspawn> client # [ 0.992628] PM: genpd: Disabling unused power domains vm-test-run-systemd-nspawn> server # [ 0.931819] rtc-pl031 9010000.pl031: registered as rtc0 vm-test-run-systemd-nspawn> server # [ 0.931847] rtc-pl031 9010000.pl031: setting system clock to 2026-09-06T02:35:16 UTC (1788662116) vm-test-run-systemd-nspawn> server # [ 0.932147] i2c_dev: i2c /dev entries driver vm-test-run-systemd-nspawn> client # [ 0.996845] Freeing unused kernel memory: 4736K vm-test-run-systemd-nspawn> client # [ 0.997074] Run /init as init process vm-test-run-systemd-nspawn> server # [ 0.937093] sdhci: Secure Digital Host Controller Interface driver vm-test-run-systemd-nspawn> server # [ 0.937103] sdhci: Copyright(c) Pierre Ossman vm-test-run-systemd-nspawn> server # [ 0.937361] Synopsys Designware Multimedia Card Interface Driver vm-test-run-systemd-nspawn> server # [ 0.937724] sdhci-pltfm: SDHCI platform and OF driver helper vm-test-run-systemd-nspawn> server # [ 0.939376] hid: raw HID events driver (C) Jiri Kosina vm-test-run-systemd-nspawn> server # [ 0.939601] usbcore: registered new interface driver usbhid vm-test-run-systemd-nspawn> server # [ 0.939608] usbhid: USB HID core driver vm-test-run-systemd-nspawn> server # [ 0.940561] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 vm-test-run-systemd-nspawn> server # [ 0.940862] hub 1-0:1.0: USB hub found vm-test-run-systemd-nspawn> server # [ 0.940882] hub 1-0:1.0: 6 ports detected vm-test-run-systemd-nspawn> server # [ 0.947549] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available vm-test-run-systemd-nspawn> client # [ 1.011725] systemd[1]: Successfully made /usr/ read-only. vm-test-run-systemd-nspawn> server # [ 0.950218] drop_monitor: Initializing network drop monitor service vm-test-run-systemd-nspawn> server # [ 0.950389] NET: Registered PF_INET6 protocol family vm-test-run-systemd-nspawn> server # [ 0.952271] Segment Routing with IPv6 vm-test-run-systemd-nspawn> server # [ 0.952291] In-situ OAM (IOAM) with IPv6 vm-test-run-systemd-nspawn> server # [ 0.952318] NET: Registered PF_PACKET protocol family vm-test-run-systemd-nspawn> server # [ 0.954009] 9pnet: Installing 9P2000 support vm-test-run-systemd-nspawn> server # [ 0.956151] Key type dns_resolver registered vm-test-run-systemd-nspawn> server # [ 0.962868] registered taskstats version 1 vm-test-run-systemd-nspawn> server # [ 0.963017] Loading compiled-in X.509 certificates vm-test-run-systemd-nspawn> server # [ 0.971472] Demotion targets for Node 0: null vm-test-run-systemd-nspawn> server # [ 0.971583] Key type .fscrypt registered vm-test-run-systemd-nspawn> server # [ 0.971590] Key type fscrypt-provisioning registered vm-test-run-systemd-nspawn> server # [ 0.971682] ima: No TPM chip found, activating TPM-bypass! vm-test-run-systemd-nspawn> server # [ 0.971702] ima: Allocated hash algorithm: sha1 vm-test-run-systemd-nspawn> server # [ 0.971724] ima: No architecture policies found vm-test-run-systemd-nspawn> server # [ 0.976284] input: gpio-keys as /devices/platform/gpio-keys/input/input0 vm-test-run-systemd-nspawn> server # [ 0.994389] clk: Disabling unused clocks vm-test-run-systemd-nspawn> server # [ 0.994423] PM: genpd: Disabling unused power domains vm-test-run-systemd-nspawn> server # [ 0.998665] Freeing unused kernel memory: 4736K vm-test-run-systemd-nspawn> server # [ 0.998890] Run /init as init process vm-test-run-systemd-nspawn> server # [ 1.014700] systemd[1]: Successfully made /usr/ read-only. vm-test-run-systemd-nspawn> client # [ 1.177560] usb 1-1: new high-speed USB device number 2 using ehci-pci vm-test-run-systemd-nspawn> server # [ 1.192597] usb 1-1: new high-speed USB device number 2 using ehci-pci vm-test-run-systemd-nspawn> client # [ 1.329777] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1 vm-test-run-systemd-nspawn> client # [ 1.346536] systemd[1]: systemd 262-9457f81 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) vm-test-run-systemd-nspawn> client # [ 1.358467] systemd[1]: Detected virtualization qemu. vm-test-run-systemd-nspawn> client # [ 1.360552] systemd[1]: Detected architecture arm64. vm-test-run-systemd-nspawn> client # [ 1.362486] systemd[1]: Running in initrd. vm-test-run-systemd-nspawn> client # [ 1.365005] systemd[1]: Initializing machine ID from random generator. vm-test-run-systemd-nspawn> client # [ 1.368007] systemd[1]: Hostname set to . vm-test-run-systemd-nspawn> server # [ 1.344803] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1 vm-test-run-systemd-nspawn> client # [ 1.417761] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0 vm-test-run-systemd-nspawn> server # [ 1.350749] systemd[1]: systemd 262-9457f81 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) vm-test-run-systemd-nspawn> server # [ 1.350811] systemd[1]: Detected virtualization qemu. vm-test-run-systemd-nspawn> server # [ 1.350884] systemd[1]: Detected architecture arm64. vm-test-run-systemd-nspawn> server # [ 1.350907] systemd[1]: Running in initrd. vm-test-run-systemd-nspawn> server # [ 1.351816] systemd[1]: Initializing machine ID from random generator. vm-test-run-systemd-nspawn> server # [ 1.352094] systemd[1]: Hostname set to . vm-test-run-systemd-nspawn> server # [ 1.432765] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0 vm-test-run-systemd-nspawn> client # [ 1.519315] systemd[1]: bpf-restrict-fs: LSM BPF program attached vm-test-run-systemd-nspawn> client # [ 1.541580] usb 1-2: new high-speed USB device number 3 using ehci-pci vm-test-run-systemd-nspawn> client # [ 1.573646] systemd[1]: Queued start job for default target Initrd Default Target. vm-test-run-systemd-nspawn> client # [ 1.583415] systemd[1]: Created slice Slice /system/modprobe. vm-test-run-systemd-nspawn> client # [ 1.584339] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. vm-test-run-systemd-nspawn> client # [ 1.585337] systemd[1]: Expecting device /dev/disk/by-label/nixos... vm-test-run-systemd-nspawn> client # [ 1.586240] systemd[1]: Reached target Path Units. vm-test-run-systemd-nspawn> client # [ 1.586852] systemd[1]: Reached target Slice Units. vm-test-run-systemd-nspawn> client # [ 1.587478] systemd[1]: Reached target Swaps. vm-test-run-systemd-nspawn> client # [ 1.588039] systemd[1]: Reached target Timer Units. vm-test-run-systemd-nspawn> client # [ 1.588788] systemd[1]: Listening on D-Bus System Message Bus Socket. vm-test-run-systemd-nspawn> client # [ 1.589799] systemd[1]: Listening on Journal Socket (/dev/log). vm-test-run-systemd-nspawn> client # [ 1.590667] systemd[1]: Listening on Journal Sockets. vm-test-run-systemd-nspawn> client # [ 1.591400] systemd[1]: Listening on udev Kernel Socket. vm-test-run-systemd-nspawn> client # [ 1.592083] systemd[1]: Reached target Socket Units. vm-test-run-systemd-nspawn> server # [ 1.531317] systemd[1]: bpf-restrict-fs: LSM BPF program attached vm-test-run-systemd-nspawn> client # [ 1.594074] systemd[1]: Starting Create List of Static Device Nodes... vm-test-run-systemd-nspawn> client # [ 1.601211] systemd[1]: Starting Load Kernel Module 9pnet_virtio... vm-test-run-systemd-nspawn> client # [ 1.602337] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs vm-test-run-systemd-nspawn> client # [ 1.614756] systemd[1]: Mounting Kernel Configuration File System... vm-test-run-systemd-nspawn> server # [ 1.556611] usb 1-2: new high-speed USB device number 3 using ehci-pci vm-test-run-systemd-nspawn> client # [ 1.633287] systemd[1]: Starting Journal Service... vm-test-run-systemd-nspawn> client # [ 1.637881] systemd[1]: Starting Load Kernel Modules... vm-test-run-systemd-nspawn> client # [ 1.637987] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os vm-test-run-systemd-nspawn> server # [ 1.584022] systemd[1]: Queued start job for default target Initrd Default Target. vm-test-run-systemd-nspawn> server # [ 1.590488] systemd[1]: Created slice Slice /system/modprobe. vm-test-run-systemd-nspawn> server # [ 1.591515] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. vm-test-run-systemd-nspawn> server # [ 1.592722] systemd[1]: Expecting device /dev/disk/by-label/nixos... vm-test-run-systemd-nspawn> server # [ 1.592756] systemd[1]: Reached target Path Units. vm-test-run-systemd-nspawn> server # [ 1.592773] systemd[1]: Reached target Slice Units. vm-test-run-systemd-nspawn> server # [ 1.592789] systemd[1]: Reached target Swaps. vm-test-run-systemd-nspawn> server # [ 1.592804] systemd[1]: Reached target Timer Units. vm-test-run-systemd-nspawn> server # [ 1.592958] systemd[1]: Listening on D-Bus System Message Bus Socket. vm-test-run-systemd-nspawn> server # [ 1.593109] systemd[1]: Listening on Journal Socket (/dev/log). vm-test-run-systemd-nspawn> server # [ 1.593233] systemd[1]: Listening on Journal Sockets. vm-test-run-systemd-nspawn> server # [ 1.593321] systemd[1]: Listening on udev Kernel Socket. vm-test-run-systemd-nspawn> server # [ 1.593338] systemd[1]: Reached target Socket Units. vm-test-run-systemd-nspawn> server # [ 1.601663] systemd[1]: Starting Create List of Static Device Nodes... vm-test-run-systemd-nspawn> server # [ 1.608503] systemd[1]: Starting Load Kernel Module 9pnet_virtio... vm-test-run-systemd-nspawn> client # [ 1.671269] systemd-journald[73]: Collecting audit messages is disabled. vm-test-run-systemd-nspawn> client # [ 1.672346] systemd[1]: Starting Coldplug All udev Devices... vm-test-run-systemd-nspawn> client # [ 1.678354] systemd[1]: Finished Create List of Static Device Nodes. vm-test-run-systemd-nspawn> server # [ 1.616664] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs vm-test-run-systemd-nspawn> client # [ 1.680180] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. vm-test-run-systemd-nspawn> server # [ 1.624894] systemd[1]: Mounting Kernel Configuration File System... vm-test-run-systemd-nspawn> client # [ 1.694058] systemd[1]: Finished Load Kernel Module 9pnet_virtio. vm-test-run-systemd-nspawn> client # [ 1.696931] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... vm-test-run-systemd-nspawn> client # [ 1.698362] systemd[1]: Mounted Kernel Configuration File System. vm-test-run-systemd-nspawn> server # [ 1.636713] systemd[1]: Starting Journal Service... vm-test-run-systemd-nspawn> server # [ 1.645196] systemd[1]: Starting Load Kernel Modules... vm-test-run-systemd-nspawn> client # [ 1.706665] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2 vm-test-run-systemd-nspawn> server # [ 1.645999] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os vm-test-run-systemd-nspawn> client # [ 1.706791] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0 vm-test-run-systemd-nspawn> server # [ 1.652815] systemd[1]: Starting Coldplug All udev Devices... vm-test-run-systemd-nspawn> client # [ 1.715207] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. vm-test-run-systemd-nspawn> client # [ 1.721583] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev vm-test-run-systemd-nspawn> client # [ 1.726098] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0 vm-test-run-systemd-nspawn> client # [ 1.726333] [drm] features: -virgl +edid -resource_blob -host_visible vm-test-run-systemd-nspawn> client # [ 1.726343] [drm] features: -context_init vm-test-run-systemd-nspawn> client # [ 1.727083] [drm] number of scanouts: 1 vm-test-run-systemd-nspawn> client # [ 1.727101] [drm] number of cap sets: 0 vm-test-run-systemd-nspawn> server # [ 1.668659] systemd[1]: Finished Create List of Static Device Nodes. vm-test-run-systemd-nspawn> server # [ 1.670484] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. vm-test-run-systemd-nspawn> server # [ 1.677415] systemd[1]: Finished Load Kernel Module 9pnet_virtio. vm-test-run-systemd-nspawn> server # [ 1.677761] systemd[1]: Mounted Kernel Configuration File System. vm-test-run-systemd-nspawn> client # [ 1.741870] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic vm-test-run-systemd-nspawn> client # [ 1.741888] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0 vm-test-run-systemd-nspawn> server # [ 1.688944] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... vm-test-run-systemd-nspawn> server # [ 1.711337] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2 vm-test-run-systemd-nspawn> server # [ 1.711472] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0 vm-test-run-systemd-nspawn> server # [ 1.719125] systemd-journald[73]: Collecting audit messages is disabled. vm-test-run-systemd-nspawn> client # [ 1.778700] Console: switching to colour frame buffer device 160x50 vm-test-run-systemd-nspawn> client # [ 1.785317] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device vm-test-run-systemd-nspawn> client # [ 1.788727] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. vm-test-run-systemd-nspawn> server # [ 1.732482] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. vm-test-run-systemd-nspawn> server # [ 1.734403] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. vm-test-run-systemd-nspawn> client # [ 1.797795] systemd[1]: Starting Create Static Device Nodes in /dev... vm-test-run-systemd-nspawn> server # [ 1.740910] systemd[1]: Starting Create Static Device Nodes in /dev... vm-test-run-systemd-nspawn> server # [ 1.748739] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev vm-test-run-systemd-nspawn> client # [ 1.814350] systemd[1]: Finished Load Kernel Modules. vm-test-run-systemd-nspawn> client # [ 1.817467] systemd[1]: Starting Apply Kernel Variables... vm-test-run-systemd-nspawn> server # [ 1.760402] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0 vm-test-run-systemd-nspawn> server # [ 1.772955] [drm] features: -virgl +edid -resource_blob -host_visible vm-test-run-systemd-nspawn> server # [ 1.772976] [drm] features: -context_init vm-test-run-systemd-nspawn> server # [ 1.773738] [drm] number of scanouts: 1 vm-test-run-systemd-nspawn> server # [ 1.773757] [drm] number of cap sets: 0 vm-test-run-systemd-nspawn> server # [ 1.776929] systemd[1]: Finished Create Static Device Nodes in /dev. vm-test-run-systemd-nspawn> server # [ 1.777272] systemd[1]: Reached target Preparation for Local File Systems. vm-test-run-systemd-nspawn> server # [ 1.777303] systemd[1]: Reached target Local File Systems. vm-test-run-systemd-nspawn> client # [ 1.854221] systemd[1]: Finished Create Static Device Nodes in /dev. vm-test-run-systemd-nspawn> client # [ 1.854422] systemd[1]: Reached target Preparation for Local File Systems. vm-test-run-systemd-nspawn> client # [ 1.854458] systemd[1]: Reached target Local File Systems. vm-test-run-systemd-nspawn> server # [ 1.784946] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic vm-test-run-systemd-nspawn> server # [ 1.784963] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0 vm-test-run-systemd-nspawn> server # [ 1.798643] systemd[1]: Starting Rule-based Manager for Device Events and Files... vm-test-run-systemd-nspawn> client # [ 1.865970] systemd[1]: Starting Rule-based Manager for Device Events and Files... vm-test-run-systemd-nspawn> client # [ 1.857293] systemd-modules-load[75]: Inserted module 'dm_mod' vm-test-run-systemd-nspawn> client # [ 1.858390] systemd-modules-load[75]: Module 'virtio_balloon' is built in vm-test-run-systemd-nspawn> client # [ 1.881850] systemd[1]: Started Journal Service. vm-test-run-systemd-nspawn> client # [ 1.867008] systemd-modules-load[75]: Module 'virtio_console' is built in vm-test-run-systemd-nspawn> client # [ 1.869138] systemd-modules-load[75]: Inserted module 'virtio_gpu' vm-test-run-systemd-nspawn> server # [ 1.816978] Console: switching to colour frame buffer device 160x50 vm-test-run-systemd-nspawn> client # [ 1.870972] systemd-modules-load[75]: Module 'virtio_rng' is built in vm-test-run-systemd-nspawn> server # [ 1.823439] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device vm-test-run-systemd-nspawn> client # [ 1.880419] systemd[1]: Finished Apply Kernel Variables. vm-test-run-systemd-nspawn> client # [ 1.884100] systemd[1]: Starting Create System Files and Directories... vm-test-run-systemd-nspawn> server # [ 1.853319] systemd[1]: Finished Load Kernel Modules. vm-test-run-systemd-nspawn> server # [ 1.868926] systemd[1]: Starting Apply Kernel Variables... vm-test-run-systemd-nspawn> client # [ 1.940336] systemd-udevd[81]: Using default interface naming scheme 'v261'. vm-test-run-systemd-nspawn> client # [ 1.942438] systemd[1]: Finished Create System Files and Directories. vm-test-run-systemd-nspawn> server # [ 1.916173] systemd[1]: Started Journal Service. vm-test-run-systemd-nspawn> client # [ 1.967485] systemd[1]: Started Rule-based Manager for Device Events and Files. vm-test-run-systemd-nspawn> server # [ 1.909858] systemd-modules-load[74]: Inserted module 'dm_mod' vm-test-run-systemd-nspawn> server # [ 1.911116] systemd-modules-load[74]: Module 'virtio_balloon' is built in vm-test-run-systemd-nspawn> server # [ 1.916351] systemd-modules-load[74]: Module 'virtio_console' is built in vm-test-run-systemd-nspawn> server # [ 1.917445] systemd-modules-load[74]: Inserted module 'virtio_gpu' vm-test-run-systemd-nspawn> server # [ 1.918421] systemd-modules-load[74]: Module 'virtio_rng' is built in vm-test-run-systemd-nspawn> server # [ 1.919798] systemd-udevd[80]: Using default interface naming scheme 'v261'. vm-test-run-systemd-nspawn> server # [ 1.935156] systemd[1]: Starting Create System Files and Directories... vm-test-run-systemd-nspawn> server # [ 1.941322] systemd[1]: Finished Apply Kernel Variables. vm-test-run-systemd-nspawn> server # [ 1.949172] systemd[1]: Finished Create System Files and Directories. vm-test-run-systemd-nspawn> server # [ 1.965688] systemd[1]: Started Rule-based Manager for Device Events and Files. vm-test-run-systemd-nspawn> client # [ 2.069344] systemd[1]: Starting Virtual Console Setup... vm-test-run-systemd-nspawn> server # [ 2.056130] systemd[1]: Starting Virtual Console Setup... vm-test-run-systemd-nspawn> client # [ 2.136558] systemd-vconsole-setup[105]: Configuration of first virtual console was skipped, ignoring remaining ones. vm-test-run-systemd-nspawn> client # [ 2.140049] systemd[1]: Finished Virtual Console Setup. vm-test-run-systemd-nspawn> server # [ 2.120522] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones. vm-test-run-systemd-nspawn> server # [ 2.123944] systemd[1]: Finished Virtual Console Setup. vm-test-run-systemd-nspawn> client # [ 2.757106] systemd[1]: Finished Coldplug All udev Devices. vm-test-run-systemd-nspawn> client # [ 2.758750] systemd[1]: Reached target System Initialization. vm-test-run-systemd-nspawn> client # [ 2.759604] systemd[1]: Reached target Basic System. vm-test-run-systemd-nspawn> server # [ 2.749047] systemd[1]: Finished Coldplug All udev Devices. vm-test-run-systemd-nspawn> server # [ 2.750521] systemd[1]: Reached target System Initialization. vm-test-run-systemd-nspawn> server # [ 2.751372] systemd[1]: Reached target Basic System. vm-test-run-systemd-nspawn> client # [ 2.892375] (udev-worker)[96]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. vm-test-run-systemd-nspawn> client # [ 2.930262] (udev-worker)[97]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-systemd-nspawn> client # [ 2.933639] (udev-worker)[96]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-systemd-nspawn> server # [ 2.883872] (udev-worker)[100]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. vm-test-run-systemd-nspawn> server # [ 2.906143] (udev-worker)[94]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-systemd-nspawn> server # [ 2.921680] (udev-worker)[100]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-systemd-nspawn> client # [ 2.992112] systemd[1]: Found device /dev/disk/by-label/nixos. vm-test-run-systemd-nspawn> client # [ 2.995014] systemd[1]: Reached target Initrd Root Device. vm-test-run-systemd-nspawn> client # [ 2.998906] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... vm-test-run-systemd-nspawn> client # [ 3.049578] systemd-fsck[113]: nixos: clean, 12/65536 files, 13019/262144 blocks vm-test-run-systemd-nspawn> server # [ 2.991835] systemd[1]: Found device /dev/disk/by-label/nixos. vm-test-run-systemd-nspawn> client # [ 3.057730] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. vm-test-run-systemd-nspawn> server # [ 2.996756] systemd[1]: Reached target Initrd Root Device. vm-test-run-systemd-nspawn> client # [ 3.060182] systemd[1]: Mounting /sysroot... vm-test-run-systemd-nspawn> server # [ 3.000215] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... vm-test-run-systemd-nspawn> client # [ 3.113061] EXT4-fs (vda): mounted filesystem 89046247-85e5-40ea-9dd6-36f6f230222f r/w with ordered data mode. Quota mode: none. vm-test-run-systemd-nspawn> client # [ 3.100688] systemd[1]: Mounted /sysroot. vm-test-run-systemd-nspawn> client # [ 3.101979] systemd[1]: Reached target Initrd Root File System. vm-test-run-systemd-nspawn> server # [ 3.047762] systemd-fsck[112]: nixos: clean, 12/65536 files, 13019/262144 blocks vm-test-run-systemd-nspawn> client # [ 3.111912] systemd[1]: Starting Mountpoints Configured in the Real Root... vm-test-run-systemd-nspawn> server # [ 3.056183] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. vm-test-run-systemd-nspawn> server # [ 3.061271] systemd[1]: Mounting /sysroot... vm-test-run-systemd-nspawn> client # [ 3.131900] systemd-sysroot-fstab-check[121]: /sysroot should be mounted in the initrd, will request daemon-reload. vm-test-run-systemd-nspawn> client # [ 3.138563] systemd[1]: Reload requested from client PID 121 ('systemd-sysroot') (unit initrd-parse-etc.service)... vm-test-run-systemd-nspawn> client # [ 3.143761] systemd[1]: Reloading... vm-test-run-systemd-nspawn> server # [ 3.112509] EXT4-fs (vda): mounted filesystem 147e7863-c943-4acb-9f2c-c6186383c9df r/w with ordered data mode. Quota mode: none. vm-test-run-systemd-nspawn> server # [ 3.100486] systemd[1]: Mounted /sysroot. vm-test-run-systemd-nspawn> server # [ 3.102126] systemd[1]: Reached target Initrd Root File System. vm-test-run-systemd-nspawn> server # [ 3.108102] systemd[1]: Starting Mountpoints Configured in the Real Root... vm-test-run-systemd-nspawn> server # [ 3.135512] systemd-sysroot-fstab-check[120]: /sysroot should be mounted in the initrd, will request daemon-reload. vm-test-run-systemd-nspawn> server # [ 3.144081] systemd[1]: Reload requested from client PID 120 ('systemd-sysroot') (unit initrd-parse-etc.service)... vm-test-run-systemd-nspawn> server # [ 3.148071] systemd[1]: Reloading... vm-test-run-systemd-nspawn> client # [ 3.333242] systemd[1]: Reloading finished in 191 ms. vm-test-run-systemd-nspawn> client # [ 3.358609] systemd-sysroot-fstab-check[121]: Requesting initrd-fs.target/start/replace... vm-test-run-systemd-nspawn> client # [ 3.362518] systemd-sysroot-fstab-check[121]: Requesting swap.target/start/replace... vm-test-run-systemd-nspawn> client # [ 3.368102] systemd[1]: Starting Load Kernel Module 9pnet_virtio... vm-test-run-systemd-nspawn> client # [ 3.373887] systemd[1]: initrd-parse-etc.service: Deactivated successfully. vm-test-run-systemd-nspawn> client # [ 3.376153] systemd[1]: Finished Mountpoints Configured in the Real Root. vm-test-run-systemd-nspawn> client # [ 3.379845] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. vm-test-run-systemd-nspawn> server # [ 3.332119] systemd[1]: Reloading finished in 187 ms. vm-test-run-systemd-nspawn> client # [ 3.400271] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. vm-test-run-systemd-nspawn> client # [ 3.402844] systemd[1]: Finished Load Kernel Module 9pnet_virtio. vm-test-run-systemd-nspawn> server # [ 3.367420] systemd-sysroot-fstab-check[120]: Requesting initrd-fs.target/start/replace... vm-test-run-systemd-nspawn> server # [ 3.370400] systemd-sysroot-fstab-check[120]: Requesting swap.target/start/replace... vm-test-run-systemd-nspawn> server # [ 3.376782] systemd[1]: Starting Load Kernel Module 9pnet_virtio... vm-test-run-systemd-nspawn> server # [ 3.384583] systemd[1]: initrd-parse-etc.service: Deactivated successfully. vm-test-run-systemd-nspawn> server # [ 3.388136] systemd[1]: Finished Mountpoints Configured in the Real Root. vm-test-run-systemd-nspawn> server # [ 3.391552] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. vm-test-run-systemd-nspawn> server # [ 3.408379] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. vm-test-run-systemd-nspawn> server # [ 3.410607] systemd[1]: Finished Load Kernel Module 9pnet_virtio. vm-test-run-systemd-nspawn> client # [ 3.659572] systemd[1]: Mounting /sysroot/nix/.ro-store... vm-test-run-systemd-nspawn> client # [ 3.671464] systemd[1]: Mounting /sysroot/nix/.rw-store... vm-test-run-systemd-nspawn> client # [ 3.687624] systemd[1]: Mounting /sysroot/run... vm-test-run-systemd-nspawn> client # [ 3.706083] systemd[1]: Mounting /sysroot/tmp/shared... vm-test-run-systemd-nspawn> server # [ 3.656295] systemd[1]: Mounting /sysroot/nix/.ro-store... vm-test-run-systemd-nspawn> client # [ 3.721756] systemd[1]: Mounting /sysroot/tmp/xchg... vm-test-run-systemd-nspawn> server # [ 3.668866] systemd[1]: Mounting /sysroot/nix/.rw-store... vm-test-run-systemd-nspawn> client # [ 3.739596] systemd[1]: Mounted /sysroot/nix/.rw-store. vm-test-run-systemd-nspawn> server # [ 3.683184] systemd[1]: Mounting /sysroot/run... vm-test-run-systemd-nspawn> server # [ 3.702405] systemd[1]: Mounting /sysroot/tmp/shared... vm-test-run-systemd-nspawn> client # [ 3.778761] systemd[1]: Starting rw-sysroot-nix-store.service... vm-test-run-systemd-nspawn> client # [ 3.785219] systemd[1]: Mounted /sysroot/nix/.ro-store. vm-test-run-systemd-nspawn> client # [ 3.789858] systemd[1]: Mounted /sysroot/run. vm-test-run-systemd-nspawn> client # [ 3.792002] systemd[1]: Mounted /sysroot/tmp/shared. vm-test-run-systemd-nspawn> server # [ 3.733227] systemd[1]: Mounting /sysroot/tmp/xchg... vm-test-run-systemd-nspawn> client # [ 3.814756] systemd[1]: Mounted /sysroot/tmp/xchg. vm-test-run-systemd-nspawn> server # [ 3.753526] systemd[1]: Mounted /sysroot/nix/.ro-store. vm-test-run-systemd-nspawn> client # [ 3.821578] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. vm-test-run-systemd-nspawn> client # [ 3.824239] systemd[1]: Finished rw-sysroot-nix-store.service. vm-test-run-systemd-nspawn> server # [ 3.763755] systemd[1]: Mounted /sysroot/run. vm-test-run-systemd-nspawn> client # [ 3.829001] systemd[1]: Mounting /sysroot/nix/store... vm-test-run-systemd-nspawn> server # [ 3.775782] systemd[1]: Mounted /sysroot/nix/.rw-store. vm-test-run-systemd-nspawn> server # [ 3.792421] systemd[1]: Starting rw-sysroot-nix-store.service... vm-test-run-systemd-nspawn> server # [ 3.795425] systemd[1]: Mounted /sysroot/tmp/shared. vm-test-run-systemd-nspawn> client # [ 3.869312] systemd[1]: Mounted /sysroot/nix/store. vm-test-run-systemd-nspawn> server # [ 3.808621] systemd[1]: Mounted /sysroot/tmp/xchg. vm-test-run-systemd-nspawn> client # [ 3.871538] systemd[1]: Reached target Initrd File Systems. vm-test-run-systemd-nspawn> client # [ 3.876136] systemd[1]: Starting Find NixOS closure... vm-test-run-systemd-nspawn> client # [ 3.884214] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... vm-test-run-systemd-nspawn> server # [ 3.832778] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. vm-test-run-systemd-nspawn> server # [ 3.834328] systemd[1]: Finished rw-sysroot-nix-store.service. vm-test-run-systemd-nspawn> client # [ 3.922616] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. vm-test-run-systemd-nspawn> client # [ 3.941142] systemd[1]: Finished Find NixOS closure. vm-test-run-systemd-nspawn> client # [ 3.942620] systemd[1]: Reached target Initrd Default Target. vm-test-run-systemd-nspawn> client # [ 3.947325] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... vm-test-run-systemd-nspawn> client # [ 3.978975] systemd[1]: Stopped target Initrd Default Target. vm-test-run-systemd-nspawn> client # [ 3.982427] systemd[1]: Stopped target Basic System. vm-test-run-systemd-nspawn> client # [ 3.983889] systemd[1]: Stopped target Initrd Root Device. vm-test-run-systemd-nspawn> client # [ 3.988008] systemd[1]: Stopped target Path Units. vm-test-run-systemd-nspawn> client # [ 3.989554] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. vm-test-run-systemd-nspawn> client # [ 3.991724] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. vm-test-run-systemd-nspawn> client # [ 3.993963] systemd[1]: Stopped target Slice Units. vm-test-run-systemd-nspawn> client # [ 3.996067] systemd[1]: Stopped target Socket Units. vm-test-run-systemd-nspawn> client # [ 3.999095] systemd[1]: Stopped target System Initialization. vm-test-run-systemd-nspawn> client # [ 4.004909] systemd[1]: Stopped target Swaps. vm-test-run-systemd-nspawn> client # [ 4.007074] systemd[1]: Stopped target Timer Units. vm-test-run-systemd-nspawn> client # [ 4.007815] systemd[1]: dbus.socket: Deactivated successfully. vm-test-run-systemd-nspawn> client # [ 4.010139] systemd[1]: Closed D-Bus System Message Bus Socket. vm-test-run-systemd-nspawn> client # [ 4.012909] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. vm-test-run-systemd-nspawn> client # [ 4.020515] systemd[1]: Stopped Find NixOS closure. vm-test-run-systemd-nspawn> client # [ 4.021321] systemd[1]: Starting Load Kernel Module 9pnet_virtio... vm-test-run-systemd-nspawn> client # [ 4.023226] systemd[1]: Starting rw-sysroot-nix-store.service... vm-test-run-systemd-nspawn> client # [ 4.025291] systemd[1]: systemd-sysctl.service: Deactivated successfully. vm-test-run-systemd-nspawn> client # [ 4.034136] systemd[1]: Stopped Apply Kernel Variables. vm-test-run-systemd-nspawn> client # [ 4.035967] systemd[1]: systemd-modules-load.service: Deactivated successfully. vm-test-run-systemd-nspawn> client # [ 4.039264] systemd[1]: Stopped Load Kernel Modules. vm-test-run-systemd-nspawn> client # [ 4.044236] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. vm-test-run-systemd-nspawn> client # [ 4.053553] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. vm-test-run-systemd-nspawn> client # [ 4.056583] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. vm-test-run-systemd-nspawn> client # [ 4.060215] systemd[1]: Stopped Create System Files and Directories. vm-test-run-systemd-nspawn> client # [ 4.065130] systemd[1]: Stopped target Local File Systems. vm-test-run-systemd-nspawn> client # [ 4.068292] systemd[1]: Stopped target Preparation for Local File Systems. vm-test-run-systemd-nspawn> client # [ 4.070139] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. vm-test-run-systemd-nspawn> client # [ 4.072822] systemd[1]: Stopped Coldplug All udev Devices. vm-test-run-systemd-nspawn> client # [ 4.076537] systemd[1]: Stopping Rule-based Manager for Device Events and Files... vm-test-run-systemd-nspawn> client # [ 4.077635] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-systemd-nspawn> client # [ 4.079590] systemd[1]: Stopped Virtual Console Setup. vm-test-run-systemd-nspawn> client # [ 4.080536] systemd[1]: initrd-cleanup.service: Deactivated successfully. vm-test-run-systemd-nspawn> client # [ 4.081454] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. vm-test-run-systemd-nspawn> client # [ 4.082365] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. vm-test-run-systemd-nspawn> client # [ 4.083346] systemd[1]: Finished Load Kernel Module 9pnet_virtio. vm-test-run-systemd-nspawn> client # [ 4.092260] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. vm-test-run-systemd-nspawn> client # [ 4.093334] systemd[1]: Finished rw-sysroot-nix-store.service. vm-test-run-systemd-nspawn> client # [ 4.094156] systemd[1]: systemd-udevd.service: Deactivated successfully. vm-test-run-systemd-nspawn> client # [ 4.095057] systemd[1]: Stopped Rule-based Manager for Device Events and Files. vm-test-run-systemd-nspawn> client # [ 4.097046] systemd[1]: systemd-udevd.service: Consumed 1.084s CPU time over 2.238s wall clock time, 17.1M memory peak. vm-test-run-systemd-nspawn> client # [ 4.098601] systemd[1]: Starting Cleanup udev Database... vm-test-run-systemd-nspawn> client # [ 4.099378] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. vm-test-run-systemd-nspawn> client # [ 4.100550] systemd[1]: Stopped Create Static Device Nodes in /dev. vm-test-run-systemd-nspawn> client # [ 4.101405] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. vm-test-run-systemd-nspawn> client # [ 4.102523] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. vm-test-run-systemd-nspawn> client # [ 4.103489] systemd[1]: kmod-static-nodes.service: Deactivated successfully. vm-test-run-systemd-nspawn> client # [ 4.108303] systemd[1]: Stopped Create List of Static Device Nodes. vm-test-run-systemd-nspawn> client # [ 4.134978] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. vm-test-run-systemd-nspawn> client # [ 4.137892] systemd[1]: Finished Cleanup udev Database. vm-test-run-systemd-nspawn> client # [ 4.138707] systemd[1]: Reached target Switch Root. vm-test-run-systemd-nspawn> client # [ 4.139956] systemd[1]: Starting NixOS Activation... vm-test-run-systemd-nspawn> client # [ 4.304523] initrd-nixos-activation-start[173]: booting system configuration /nix/store/49zhjw9p29p5vq6bzvb6cmz0aw2ls87a-nixos-system-client-test vm-test-run-systemd-nspawn> server # [ 4.256645] (udev-worker)[95]: mtd0ro: Failed to find and pin callout binary "/nix/store/x4i8f5p0japrw9j9zrdx7z9lf5387qn3-systemd-262-9457f81/lib/udev/mtd_probe": No such file or directory vm-test-run-systemd-nspawn> server # [ 4.263278] (udev-worker)[95]: mtd0ro: /nix/store/x4i8f5p0japrw9j9zrdx7z9lf5387qn3-systemd-262-9457f81/lib/udev/rules.d/75-probe_mtd.rules:5 IMPORT{program}="mtd_probe $devnode": Failed to execute "mtd_probe /dev/mtd0ro", ignoring: No such file or directory vm-test-run-systemd-nspawn> server # [ 4.288351] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-systemd-nspawn> server # [ 4.290790] systemd[1]: Stopped Virtual Console Setup. vm-test-run-systemd-nspawn> server # [ 4.292265] systemd[1]: Stopping Virtual Console Setup... vm-test-run-systemd-nspawn> server # [ 4.293689] systemd[1]: Starting Virtual Console Setup... vm-test-run-systemd-nspawn> client # [ 4.369187] initrd-nixos-activation-start[173]: running activation script... vm-test-run-systemd-nspawn> server # [ 4.312831] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-systemd-nspawn> server # [ 4.314313] systemd[1]: Stopped Virtual Console Setup. vm-test-run-systemd-nspawn> server # [ 4.316602] systemd[1]: Starting Virtual Console Setup... vm-test-run-systemd-nspawn> server # [ 4.338040] systemd-vconsole-setup[155]: Configuration of first virtual console was skipped, ignoring remaining ones. vm-test-run-systemd-nspawn> server # [ 4.341302] systemd[1]: Finished Virtual Console Setup. vm-test-run-systemd-nspawn> server # [ 4.656342] systemd[1]: Mounting /sysroot/nix/store... vm-test-run-systemd-nspawn> server # [ 4.721684] systemd[1]: Mounted /sysroot/nix/store. vm-test-run-systemd-nspawn> client # [ 4.785328] initrd-nixos-activation-start[196]: setting up /etc... vm-test-run-systemd-nspawn> server # [ 4.725202] systemd[1]: Reached target Initrd File Systems. vm-test-run-systemd-nspawn> server # [ 4.730240] systemd[1]: Starting Find NixOS closure... vm-test-run-systemd-nspawn> server # [ 4.740453] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... vm-test-run-systemd-nspawn> server # [ 4.797686] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. vm-test-run-systemd-nspawn> server # [ 4.804557] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. vm-test-run-systemd-nspawn> server # [ 4.815184] systemd[1]: Finished Find NixOS closure. vm-test-run-systemd-nspawn> server # [ 4.818842] systemd[1]: Reached target Initrd Default Target. vm-test-run-systemd-nspawn> server # [ 4.824465] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... vm-test-run-systemd-nspawn> server # [ 4.851419] systemd[1]: Stopped target Initrd Default Target. vm-test-run-systemd-nspawn> server # [ 4.853502] systemd[1]: Stopped target Basic System. vm-test-run-systemd-nspawn> server # [ 4.856323] systemd[1]: Stopped target Initrd Root Device. vm-test-run-systemd-nspawn> server # [ 4.858152] systemd[1]: Stopped target Path Units. vm-test-run-systemd-nspawn> server # [ 4.860695] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. vm-test-run-systemd-nspawn> server # [ 4.865201] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. vm-test-run-systemd-nspawn> server # [ 4.872190] systemd[1]: Stopped target Slice Units. vm-test-run-systemd-nspawn> server # [ 4.873331] systemd[1]: Stopped target Socket Units. vm-test-run-systemd-nspawn> server # [ 4.874388] systemd[1]: Stopped target System Initialization. vm-test-run-systemd-nspawn> server # [ 4.875579] systemd[1]: Stopped target Swaps. vm-test-run-systemd-nspawn> server # [ 4.877654] systemd[1]: Stopped target Timer Units. vm-test-run-systemd-nspawn> server # [ 4.879863] systemd[1]: dbus.socket: Deactivated successfully. vm-test-run-systemd-nspawn> server # [ 4.885516] systemd[1]: Closed D-Bus System Message Bus Socket. vm-test-run-systemd-nspawn> server # [ 4.889755] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. vm-test-run-systemd-nspawn> server # [ 4.898767] systemd[1]: Stopped Find NixOS closure. vm-test-run-systemd-nspawn> server # [ 4.899773] systemd[1]: Starting Load Kernel Module 9pnet_virtio... vm-test-run-systemd-nspawn> server # [ 4.901067] systemd[1]: Starting rw-sysroot-nix-store.service... vm-test-run-systemd-nspawn> server # [ 4.903011] systemd[1]: systemd-sysctl.service: Deactivated successfully. vm-test-run-systemd-nspawn> server # [ 4.917605] systemd[1]: Stopped Apply Kernel Variables. vm-test-run-systemd-nspawn> server # [ 4.918558] systemd[1]: systemd-modules-load.service: Deactivated successfully. vm-test-run-systemd-nspawn> server # [ 4.919627] systemd[1]: Stopped Load Kernel Modules. vm-test-run-systemd-nspawn> server # [ 4.926571] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. vm-test-run-systemd-nspawn> server # [ 4.930193] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. vm-test-run-systemd-nspawn> server # [ 4.931288] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. vm-test-run-systemd-nspawn> server # [ 4.933047] systemd[1]: Stopped Create System Files and Directories. vm-test-run-systemd-nspawn> server # [ 4.935547] systemd[1]: Stopped target Local File Systems. vm-test-run-systemd-nspawn> server # [ 4.937004] systemd[1]: Stopped target Preparation for Local File Systems. vm-test-run-systemd-nspawn> server # [ 4.939374] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. vm-test-run-systemd-nspawn> server # [ 4.941549] systemd[1]: Stopped Coldplug All udev Devices. vm-test-run-systemd-nspawn> server # [ 4.942327] systemd[1]: Stopping Rule-based Manager for Device Events and Files... vm-test-run-systemd-nspawn> server # [ 4.943328] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-systemd-nspawn> server # [ 4.948112] systemd[1]: Stopped Virtual Console Setup. vm-test-run-systemd-nspawn> server # [ 4.948949] systemd[1]: systemd-udevd.service: Deactivated successfully. vm-test-run-systemd-nspawn> server # [ 4.949865] systemd[1]: Stopped Rule-based Manager for Device Events and Files. vm-test-run-systemd-nspawn> server # [ 4.950833] systemd[1]: systemd-udevd.service: Consumed 1.450s CPU time over 3.141s wall clock time, 22.1M memory peak. vm-test-run-systemd-nspawn> server # [ 4.952315] systemd[1]: initrd-cleanup.service: Deactivated successfully. vm-test-run-systemd-nspawn> server # [ 4.953235] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. vm-test-run-systemd-nspawn> server # [ 4.954149] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. vm-test-run-systemd-nspawn> server # [ 4.955135] systemd[1]: Finished Load Kernel Module 9pnet_virtio. vm-test-run-systemd-nspawn> server # [ 4.955983] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. vm-test-run-systemd-nspawn> server # [ 4.961196] systemd[1]: Finished rw-sysroot-nix-store.service. vm-test-run-systemd-nspawn> server # [ 4.964172] systemd[1]: Starting Cleanup udev Database... vm-test-run-systemd-nspawn> server # [ 4.965144] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. vm-test-run-systemd-nspawn> server # [ 4.968275] systemd[1]: Stopped Create Static Device Nodes in /dev. vm-test-run-systemd-nspawn> server # [ 4.969188] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. vm-test-run-systemd-nspawn> server # [ 4.972113] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. vm-test-run-systemd-nspawn> server # [ 4.973103] systemd[1]: kmod-static-nodes.service: Deactivated successfully. vm-test-run-systemd-nspawn> server # [ 4.976138] systemd[1]: Stopped Create List of Static Device Nodes. vm-test-run-systemd-nspawn> client # [ 5.053591] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. vm-test-run-systemd-nspawn> client # [ 5.056216] systemd[1]: Finished NixOS Activation. vm-test-run-systemd-nspawn> client # [ 5.057920] systemd[1]: Starting Switch Root... vm-test-run-systemd-nspawn> server # [ 5.003225] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. vm-test-run-systemd-nspawn> server # [ 5.004866] systemd[1]: Finished Cleanup udev Database. vm-test-run-systemd-nspawn> server # [ 5.008619] systemd[1]: Reached target Switch Root. vm-test-run-systemd-nspawn> server # [ 5.009459] systemd[1]: Starting NixOS Activation... vm-test-run-systemd-nspawn> client # [ 5.081146] systemd[1]: Switching root. vm-test-run-systemd-nspawn> server # [ 5.177645] initrd-nixos-activation-start[180]: booting system configuration /nix/store/9jkg1k6dq4h2r3qcfi70ixnwx6mxy1fm-nixos-system-server-test vm-test-run-systemd-nspawn> client # [ 5.282036] systemd-journald[73]: Received SIGTERM from PID 1 (systemd). vm-test-run-systemd-nspawn> server # [ 5.246174] initrd-nixos-activation-start[180]: running activation script... vm-test-run-systemd-nspawn> server # [ 5.713053] initrd-nixos-activation-start[203]: setting up /etc... vm-test-run-systemd-nspawn> client # [ 5.902901] systemd[1]: systemd 262-9457f81 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) vm-test-run-systemd-nspawn> client # [ 5.915813] systemd[1]: Detected virtualization qemu. vm-test-run-systemd-nspawn> client # [ 5.915953] systemd[1]: Detected architecture arm64. vm-test-run-systemd-nspawn> client # [ 5.916184] systemd[1]: Detected first boot. vm-test-run-systemd-nspawn> client # [ 5.927396] systemd[1]: Initializing machine ID from random generator. vm-test-run-systemd-nspawn> server # [ 5.995832] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. vm-test-run-systemd-nspawn> server # [ 5.999089] systemd[1]: Finished NixOS Activation. vm-test-run-systemd-nspawn> server # [ 6.004333] systemd[1]: Starting Switch Root... vm-test-run-systemd-nspawn> client # [ 6.102116] systemd[1]: bpf-restrict-fs: LSM BPF program attached vm-test-run-systemd-nspawn> server # [ 6.025678] systemd[1]: Switching root. vm-test-run-systemd-nspawn> client # [ 6.267412] systemd[1]: Applying preset policy. vm-test-run-systemd-nspawn> server # [ 6.212374] systemd-journald[73]: Received SIGTERM from PID 1 (systemd). vm-test-run-systemd-nspawn> client # [ 6.768249] systemd[1]: Populated /etc with preset unit settings. vm-test-run-systemd-nspawn> server # [ 6.817121] systemd[1]: systemd 262-9457f81 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) vm-test-run-systemd-nspawn> server # [ 6.829273] systemd[1]: Detected virtualization qemu. vm-test-run-systemd-nspawn> server # [ 6.832370] systemd[1]: Detected architecture arm64. vm-test-run-systemd-nspawn> server # [ 6.836154] systemd[1]: Detected first boot. vm-test-run-systemd-nspawn> server # [ 6.843559] systemd[1]: Initializing machine ID from random generator. vm-test-run-systemd-nspawn> server # [ 7.016216] systemd[1]: bpf-restrict-fs: LSM BPF program attached vm-test-run-systemd-nspawn> server # [ 7.174394] systemd[1]: Applying preset policy. vm-test-run-systemd-nspawn> client # [ 7.273022] systemd[1]: initrd-switch-root.service: Deactivated successfully. vm-test-run-systemd-nspawn> client # [ 7.274604] systemd[1]: Stopped initrd-switch-root.service. vm-test-run-systemd-nspawn> client # [ 7.276187] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. vm-test-run-systemd-nspawn> client # [ 7.280081] systemd[1]: Created slice Slice /system/getty. vm-test-run-systemd-nspawn> client # [ 7.282153] systemd[1]: Created slice User and Session Slice. vm-test-run-systemd-nspawn> client # [ 7.284305] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. vm-test-run-systemd-nspawn> client # [ 7.286855] systemd[1]: Started Forward Password Requests to Wall Directory Watch. vm-test-run-systemd-nspawn> client # [ 7.289049] systemd[1]: Expecting device /dev/hvc0... vm-test-run-systemd-nspawn> client # [ 7.291044] systemd[1]: Expecting device /dev/ttyAMA0... vm-test-run-systemd-nspawn> client # [ 7.293352] systemd[1]: Reached target Local Encrypted Volumes. vm-test-run-systemd-nspawn> client # [ 7.295332] systemd[1]: Stopped target initrd-fs.target. vm-test-run-systemd-nspawn> client # [ 7.297199] systemd[1]: Stopped target initrd-root-fs.target. vm-test-run-systemd-nspawn> client # [ 7.299163] systemd[1]: Stopped target initrd-switch-root.target. vm-test-run-systemd-nspawn> client # [ 7.301112] systemd[1]: Reached target Virtual Machines and Containers. vm-test-run-systemd-nspawn> client # [ 7.303236] systemd[1]: Reached target Path Units. vm-test-run-systemd-nspawn> client # [ 7.305023] systemd[1]: Reached target Remote File Systems. vm-test-run-systemd-nspawn> client # [ 7.306969] systemd[1]: Reached target Slice Units. vm-test-run-systemd-nspawn> client # [ 7.308763] systemd[1]: Reached target Swaps. vm-test-run-systemd-nspawn> client # [ 7.312861] systemd[1]: Listening on Query the User Interactively for a Password. vm-test-run-systemd-nspawn> client # [ 7.318073] systemd[1]: Listening on Process Core Dump Socket. vm-test-run-systemd-nspawn> client # [ 7.321990] systemd[1]: Listening on Credential Encryption/Decryption. vm-test-run-systemd-nspawn> client # [ 7.325845] systemd[1]: Listening on Factory Reset Management. vm-test-run-systemd-nspawn> client # [ 7.327945] systemd[1]: Listening on Hostname Service Socket. vm-test-run-systemd-nspawn> client # [ 7.333405] systemd[1]: Starting Journal Log Access Socket... vm-test-run-systemd-nspawn> client # [ 7.336378] systemd[1]: Listening on Journal Audit Socket. vm-test-run-systemd-nspawn> client # [ 7.340579] systemd[1]: Listening on Console Output Muting Service Socket. vm-test-run-systemd-nspawn> client # [ 7.343124] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. vm-test-run-systemd-nspawn> client # [ 7.345747] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os vm-test-run-systemd-nspawn> client # [ 7.348259] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki vm-test-run-systemd-nspawn> client # [ 7.359796] systemd[1]: Listening on Disk Repartitioning Service Socket. vm-test-run-systemd-nspawn> client # [ 7.361238] systemd[1]: Listening on udev Varlink Socket. vm-test-run-systemd-nspawn> client # [ 7.365725] systemd[1]: Mounting Huge Pages File System... vm-test-run-systemd-nspawn> client # [ 7.371040] systemd[1]: Mounting POSIX Message Queue File System... vm-test-run-systemd-nspawn> client # [ 7.381672] systemd[1]: Mounting Kernel Debug File System... vm-test-run-systemd-nspawn> client # [ 7.387767] systemd[1]: Mounting Kernel Trace File System... vm-test-run-systemd-nspawn> client # [ 7.401167] systemd[1]: Starting Create List of Static Device Nodes... vm-test-run-systemd-nspawn> client # [ 7.412713] systemd[1]: Starting Load Kernel Module 9pnet_virtio... vm-test-run-systemd-nspawn> client # [ 7.414205] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs vm-test-run-systemd-nspawn> client # [ 7.432208] systemd[1]: Mounting Kernel Configuration File System... vm-test-run-systemd-nspawn> client # [ 7.433944] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm vm-test-run-systemd-nspawn> client # [ 7.439557] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore vm-test-run-systemd-nspawn> client # [ 7.502844] systemd[1]: Starting Load Kernel Module fuse... vm-test-run-systemd-nspawn> client # [ 7.503404] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 vm-test-run-systemd-nspawn> client # [ 7.555164] systemd[1]: Starting Journal Service... vm-test-run-systemd-nspawn> client # [ 7.574522] systemd[1]: Starting Load Kernel Modules... vm-test-run-systemd-nspawn> client # [ 7.603970] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... vm-test-run-systemd-nspawn> client # [ 7.611685] fuse: init (API version 7.45) vm-test-run-systemd-nspawn> client # [ 7.617654] systemd[1]: Starting Remount Root and Kernel File Systems... vm-test-run-systemd-nspawn> client # [ 7.622849] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os vm-test-run-systemd-nspawn> client # [ 7.656639] systemd[1]: Starting Coldplug All udev Devices... vm-test-run-systemd-nspawn> client # [ 7.681299] systemd-journald[269]: Collecting audit messages is enabled. vm-test-run-systemd-nspawn> client # [ 7.690720] systemd[1]: Listening on Journal Log Access Socket. vm-test-run-systemd-nspawn> client # [ 7.694215] systemd[1]: Mounted Huge Pages File System. vm-test-run-systemd-nspawn> client # [ 7.698348] systemd[1]: Mounted POSIX Message Queue File System. vm-test-run-systemd-nspawn> client # [ 7.703357] systemd[1]: Mounted Kernel Debug File System. vm-test-run-systemd-nspawn> client # [ 7.703994] systemd[1]: Mounted Kernel Trace File System. vm-test-run-systemd-nspawn> client # [ 7.690051] systemd[1]: Queued start job for default target Multi-User System. vm-test-run-systemd-nspawn> client # [ 7.692556] systemd[1]: systemd-journald.service: Deactivated successfully. vm-test-run-systemd-nspawn> client # [ 7.713727] systemd[1]: Started Journal Service. vm-test-run-systemd-nspawn> client # [ 7.704194] systemd-modules-load[270]: Module 'atkbd' is built in vm-test-run-systemd-nspawn> client # [ 7.709330] systemd-modules-load[270]: Module 'loop' is built in vm-test-run-systemd-nspawn> server # [ 7.666848] systemd[1]: Populated /etc with preset unit settings. vm-test-run-systemd-nspawn> client # [ 7.717383] systemd[1]: Finished Create List of Static Device Nodes. vm-test-run-systemd-nspawn> client # [ 7.718482] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. vm-test-run-systemd-nspawn> client # [ 7.719601] systemd[1]: Finished Load Kernel Module 9pnet_virtio. vm-test-run-systemd-nspawn> client # [ 7.733165] systemd[1]: Mounted Kernel Configuration File System. vm-test-run-systemd-nspawn> client # [ 7.739352] systemd[1]: modprobe@fuse.service: Deactivated successfully. vm-test-run-systemd-nspawn> client # [ 7.743334] systemd[1]: Finished Load Kernel Module fuse. vm-test-run-systemd-nspawn> client # [ 7.749737] systemd[1]: Finished Load Kernel Modules. vm-test-run-systemd-nspawn> client # [ 7.768184] EXT4-fs (vda): re-mounted 89046247-85e5-40ea-9dd6-36f6f230222f. vm-test-run-systemd-nspawn> client # [ 7.767356] systemd[1]: Mounting FUSE Control File System... vm-test-run-systemd-nspawn> client # [ 7.772266] systemd[1]: Starting Firewall... vm-test-run-systemd-nspawn> client # [ 7.788361] systemd-oomd[271]: No swap; memory pressure usage will be degraded vm-test-run-systemd-nspawn> client # [ 7.792766] systemd[1]: Starting Apply Kernel Variables... vm-test-run-systemd-nspawn> client # [ 7.813344] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... vm-test-run-systemd-nspawn> client # [ 7.816222] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. vm-test-run-systemd-nspawn> client # [ 7.822518] systemd[1]: Finished Remount Root and Kernel File Systems. vm-test-run-systemd-nspawn> client # [ 7.857165] systemd[1]: Listening on Disk Image Download Service Socket. vm-test-run-systemd-nspawn> client # [ 7.877806] systemd[1]: Starting Flush Journal to Persistent Storage... vm-test-run-systemd-nspawn> client # [ 7.880731] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore vm-test-run-systemd-nspawn> client # [ 7.907883] systemd[1]: Starting Load/Save OS Random Seed... vm-test-run-systemd-nspawn> client # [ 7.915996] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os vm-test-run-systemd-nspawn> client # [ 7.958719] systemd[1]: Finished Apply Kernel Variables. vm-test-run-systemd-nspawn> client # [ 7.972218] systemd[1]: Mounted FUSE Control File System. vm-test-run-systemd-nspawn> client # [ 8.007643] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. vm-test-run-systemd-nspawn> client # [ 8.041736] systemd-journald[269]: Received client request to flush runtime journal. vm-test-run-systemd-nspawn> client # [ 8.104470] systemd[1]: Starting Create Static Device Nodes in /dev... vm-test-run-systemd-nspawn> client # [ 8.108834] systemd[1]: Finished Load/Save OS Random Seed. vm-test-run-systemd-nspawn> client # [ 8.112521] systemd[1]: Reached target First Boot Complete. vm-test-run-systemd-nspawn> client # [ 8.116666] systemd[1]: Finished Flush Journal to Persistent Storage. vm-test-run-systemd-nspawn> client # [ 8.150206] systemd[1]: Finished Create Static Device Nodes in /dev. vm-test-run-systemd-nspawn> client # [ 8.151662] systemd[1]: Reached target Preparation for Local File Systems. vm-test-run-systemd-nspawn> client # [ 8.160606] systemd[1]: Starting Rule-based Manager for Device Events and Files... vm-test-run-systemd-nspawn> server # [ 8.155789] systemd[1]: initrd-switch-root.service: Deactivated successfully. vm-test-run-systemd-nspawn> server # [ 8.157352] systemd[1]: Stopped initrd-switch-root.service. vm-test-run-systemd-nspawn> server # [ 8.158765] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. vm-test-run-systemd-nspawn> server # [ 8.159822] systemd[1]: Created slice Slice /system/getty. vm-test-run-systemd-nspawn> server # [ 8.163648] systemd[1]: Created slice User and Session Slice. vm-test-run-systemd-nspawn> server # [ 8.165970] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. vm-test-run-systemd-nspawn> server # [ 8.168035] systemd[1]: Started Forward Password Requests to Wall Directory Watch. vm-test-run-systemd-nspawn> server # [ 8.170218] systemd[1]: Expecting device /dev/hvc0... vm-test-run-systemd-nspawn> server # [ 8.171797] systemd[1]: Expecting device /dev/ttyAMA0... vm-test-run-systemd-nspawn> server # [ 8.173772] systemd[1]: Reached target Local Encrypted Volumes. vm-test-run-systemd-nspawn> server # [ 8.175708] systemd[1]: Stopped target initrd-fs.target. vm-test-run-systemd-nspawn> server # [ 8.177691] systemd[1]: Stopped target initrd-root-fs.target. vm-test-run-systemd-nspawn> server # [ 8.179577] systemd[1]: Stopped target initrd-switch-root.target. vm-test-run-systemd-nspawn> server # [ 8.181613] systemd[1]: Reached target Virtual Machines and Containers. vm-test-run-systemd-nspawn> server # [ 8.183625] systemd[1]: Reached target Path Units. vm-test-run-systemd-nspawn> server # [ 8.185457] systemd[1]: Reached target Remote File Systems. vm-test-run-systemd-nspawn> server # [ 8.187300] systemd[1]: Reached target Slice Units. vm-test-run-systemd-nspawn> server # [ 8.189167] systemd[1]: Reached target Swaps. vm-test-run-systemd-nspawn> server # [ 8.193110] systemd[1]: Listening on Query the User Interactively for a Password. vm-test-run-systemd-nspawn> server # [ 8.197979] systemd[1]: Listening on Process Core Dump Socket. vm-test-run-systemd-nspawn> server # [ 8.201825] systemd[1]: Listening on Credential Encryption/Decryption. vm-test-run-systemd-nspawn> server # [ 8.205533] systemd[1]: Listening on Factory Reset Management. vm-test-run-systemd-nspawn> server # [ 8.207556] systemd[1]: Listening on Hostname Service Socket. vm-test-run-systemd-nspawn> server # [ 8.213413] systemd[1]: Starting Journal Log Access Socket... vm-test-run-systemd-nspawn> server # [ 8.215813] systemd[1]: Listening on Journal Audit Socket. vm-test-run-systemd-nspawn> client # [ 8.262689] systemd[1]: Mounting /run/wrappers... vm-test-run-systemd-nspawn> server # [ 8.219833] systemd[1]: Listening on Console Output Muting Service Socket. vm-test-run-systemd-nspawn> server # [ 8.222354] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. vm-test-run-systemd-nspawn> server # [ 8.224821] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os vm-test-run-systemd-nspawn> server # [ 8.227273] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki vm-test-run-systemd-nspawn> server # [ 8.238216] systemd[1]: Listening on Disk Repartitioning Service Socket. vm-test-run-systemd-nspawn> server # [ 8.239613] systemd[1]: Listening on udev Varlink Socket. vm-test-run-systemd-nspawn> server # [ 8.243992] systemd[1]: Mounting Huge Pages File System... vm-test-run-systemd-nspawn> server # [ 8.248290] systemd[1]: Mounting POSIX Message Queue File System... vm-test-run-systemd-nspawn> server # [ 8.255217] systemd[1]: Mounting Kernel Debug File System... vm-test-run-systemd-nspawn> server # [ 8.262591] systemd[1]: Mounting Kernel Trace File System... vm-test-run-systemd-nspawn> server # [ 8.276981] systemd[1]: Starting Create List of Static Device Nodes... vm-test-run-systemd-nspawn> server # [ 8.285778] systemd[1]: Starting Load Kernel Module 9pnet_virtio... vm-test-run-systemd-nspawn> server # [ 8.287049] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs vm-test-run-systemd-nspawn> client # [ 8.340632] systemd[1]: Mounted /run/wrappers. vm-test-run-systemd-nspawn> client # [ 8.341622] systemd[1]: Reached target Local File Systems. vm-test-run-systemd-nspawn> client # [ 8.347066] systemd[1]: Listening on Boot Loader Control Service Socket. vm-test-run-systemd-nspawn> server # [ 8.302529] systemd[1]: Mounting Kernel Configuration File System... vm-test-run-systemd-nspawn> server # [ 8.304114] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm vm-test-run-systemd-nspawn> client # [ 8.351792] systemd[1]: Starting register-nix-paths.service... vm-test-run-systemd-nspawn> server # [ 8.306513] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore vm-test-run-systemd-nspawn> client # [ 8.364095] systemd[1]: Starting Create SUID/SGID Wrappers... vm-test-run-systemd-nspawn> client # [ 8.365344] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. vm-test-run-systemd-nspawn> server # [ 8.325043] systemd[1]: Starting Load Kernel Module fuse... vm-test-run-systemd-nspawn> server # [ 8.326524] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 vm-test-run-systemd-nspawn> client # [ 8.382587] systemd[1]: Starting Save Transient machine-id to Disk... vm-test-run-systemd-nspawn> client # [ 8.436093] systemd[1]: Starting Create System Files and Directories... vm-test-run-systemd-nspawn> server # [ 8.399840] systemd[1]: Starting Journal Service... vm-test-run-systemd-nspawn> server # [ 8.449860] systemd[1]: Starting Load Kernel Modules... vm-test-run-systemd-nspawn> server # [ 8.465480] fuse: init (API version 7.45) vm-test-run-systemd-nspawn> server # [ 8.480513] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... vm-test-run-systemd-nspawn> client # [ 8.545167] systemd-udevd[312]: Using default interface naming scheme 'v261'. vm-test-run-systemd-nspawn> server # [ 8.506890] systemd[1]: Starting Remount Root and Kernel File Systems... vm-test-run-systemd-nspawn> client # [ 8.554449] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. vm-test-run-systemd-nspawn> server # [ 8.514551] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os vm-test-run-systemd-nspawn> client # [ 8.565142] systemd[1]: Finished Save Transient machine-id to Disk. vm-test-run-systemd-nspawn> server # [ 8.554079] systemd[1]: Starting Coldplug All udev Devices... vm-test-run-systemd-nspawn> server # [ 8.563478] systemd[1]: Listening on Journal Log Access Socket. vm-test-run-systemd-nspawn> server # [ 8.580188] systemd[1]: Mounted Huge Pages File System. vm-test-run-systemd-nspawn> server # [ 8.587740] systemd[1]: Mounted POSIX Message Queue File System. vm-test-run-systemd-nspawn> server # [ 8.593269] systemd[1]: Mounted Kernel Debug File System. vm-test-run-systemd-nspawn> server # [ 8.597112] systemd-journald[275]: Collecting audit messages is enabled. vm-test-run-systemd-nspawn> server # [ 8.602886] systemd[1]: Mounted Kernel Trace File System. vm-test-run-systemd-nspawn> server # [ 8.607209] systemd[1]: Finished Create List of Static Device Nodes. vm-test-run-systemd-nspawn> server # [ 8.612454] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. vm-test-run-systemd-nspawn> server # [ 8.621175] systemd[1]: Finished Load Kernel Module 9pnet_virtio. vm-test-run-systemd-nspawn> server # [ 8.607562] systemd[1]: Queued start job for default target Multi-User System. vm-test-run-systemd-nspawn> server # [ 8.609102] systemd[1]: systemd-journald.service: Deactivated successfully. vm-test-run-systemd-nspawn> server # [ 8.610435] systemd-modules-load[276]: Module 'atkbd' is built in vm-test-run-systemd-nspawn> server # [ 8.611415] systemd-modules-load[276]: Module 'loop' is built in vm-test-run-systemd-nspawn> server # [ 8.629294] systemd[1]: Started Journal Service. vm-test-run-systemd-nspawn> server # [ 8.622630] systemd-modules-load[276]: Inserted module 'tls' vm-test-run-systemd-nspawn> server # [ 8.630602] systemd[1]: Mounted Kernel Configuration File System. vm-test-run-systemd-nspawn> server # [ 8.631624] systemd[1]: modprobe@fuse.service: Deactivated successfully. vm-test-run-systemd-nspawn> client # [ 8.697789] systemd[1]: Finished Create System Files and Directories. vm-test-run-systemd-nspawn> server # [ 8.638010] systemd[1]: Finished Load Kernel Module fuse. vm-test-run-systemd-nspawn> server # [ 8.646787] systemd[1]: Finished Load Kernel Modules. vm-test-run-systemd-nspawn> server # [ 8.652978] systemd-oomd[277]: No swap; memory pressure usage will be degraded vm-test-run-systemd-nspawn> client # [ 8.716694] systemd[1]: Starting Rebuild Journal Catalog... vm-test-run-systemd-nspawn> client # [ 8.725713] systemd[1]: Starting Record System Boot/Shutdown in UTMP... vm-test-run-systemd-nspawn> server # [ 8.666140] systemd[1]: Mounting FUSE Control File System... vm-test-run-systemd-nspawn> server # [ 8.669002] systemd[1]: Starting Firewall... vm-test-run-systemd-nspawn> server # [ 8.692610] EXT4-fs (vda): re-mounted 147e7863-c943-4acb-9f2c-c6186383c9df. vm-test-run-systemd-nspawn> server # [ 8.689529] systemd[1]: Starting Apply Kernel Variables... vm-test-run-systemd-nspawn> server # [ 8.705715] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... vm-test-run-systemd-nspawn> server # [ 8.712063] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. vm-test-run-systemd-nspawn> server # [ 8.728976] systemd[1]: Finished Remount Root and Kernel File Systems. vm-test-run-systemd-nspawn> server # [ 8.732295] systemd[1]: Listening on Disk Image Download Service Socket. vm-test-run-systemd-nspawn> server # [ 8.746027] systemd[1]: Starting Flush Journal to Persistent Storage... vm-test-run-systemd-nspawn> server # [ 8.749941] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore vm-test-run-systemd-nspawn> server # [ 8.781862] systemd[1]: Starting Load/Save OS Random Seed... vm-test-run-systemd-nspawn> server # [ 8.786167] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os vm-test-run-systemd-nspawn> client # [ 8.881198] systemd[1]: Started Rule-based Manager for Device Events and Files. vm-test-run-systemd-nspawn> client # [ 8.905827] systemd[1]: Finished Record System Boot/Shutdown in UTMP. vm-test-run-systemd-nspawn> server # [ 8.846009] systemd[1]: Mounted FUSE Control File System. vm-test-run-systemd-nspawn> server # [ 8.865813] systemd[1]: Finished Apply Kernel Variables. vm-test-run-systemd-nspawn> server # [ 8.910572] systemd-journald[275]: Received client request to flush runtime journal. vm-test-run-systemd-nspawn> client # [ 8.999415] systemd[1]: Finished Rebuild Journal Catalog. vm-test-run-systemd-nspawn> client # [ 9.015743] systemd[1]: Starting Update is Completed... vm-test-run-systemd-nspawn> server # [ 8.955870] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. vm-test-run-systemd-nspawn> server # [ 8.962867] systemd[1]: Starting Create Static Device Nodes in /dev... vm-test-run-systemd-nspawn> server # [ 8.968949] systemd[1]: Finished Load/Save OS Random Seed. vm-test-run-systemd-nspawn> server # [ 8.970899] systemd[1]: Reached target First Boot Complete. vm-test-run-systemd-nspawn> server # [ 8.973416] systemd[1]: Finished Flush Journal to Persistent Storage. vm-test-run-systemd-nspawn> server # [ 9.047331] systemd[1]: Finished Create Static Device Nodes in /dev. vm-test-run-systemd-nspawn> server # [ 9.052317] systemd[1]: Reached target Preparation for Local File Systems. vm-test-run-systemd-nspawn> server # [ 9.055069] systemd[1]: Starting Rule-based Manager for Device Events and Files... vm-test-run-systemd-nspawn> client # [ 9.134721] systemd[1]: Finished Update is Completed. vm-test-run-systemd-nspawn> server # [ 9.146760] systemd[1]: Mounting /run/wrappers... vm-test-run-systemd-nspawn> server # [ 9.188304] systemd-udevd[316]: Using default interface naming scheme 'v261'. vm-test-run-systemd-nspawn> server # [ 9.213443] systemd[1]: Mounted /run/wrappers. vm-test-run-systemd-nspawn> server # [ 9.214599] systemd[1]: Reached target Local File Systems. vm-test-run-systemd-nspawn> server # [ 9.218383] systemd[1]: Listening on Boot Loader Control Service Socket. vm-test-run-systemd-nspawn> server # [ 9.225786] systemd[1]: Starting register-nix-paths.service... vm-test-run-systemd-nspawn> server # [ 9.231858] systemd[1]: Starting Create SUID/SGID Wrappers... vm-test-run-systemd-nspawn> server # [ 9.233282] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. vm-test-run-systemd-nspawn> server # [ 9.239265] systemd[1]: Starting Save Transient machine-id to Disk... vm-test-run-systemd-nspawn> server # [ 9.256875] systemd[1]: Starting Create System Files and Directories... vm-test-run-systemd-nspawn> server # [ 9.443082] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. vm-test-run-systemd-nspawn> server # [ 9.455353] systemd[1]: Finished Save Transient machine-id to Disk. vm-test-run-systemd-nspawn> server # [ 9.476480] systemd[1]: Started Rule-based Manager for Device Events and Files. vm-test-run-systemd-nspawn> server # [ 9.553706] systemd[1]: Finished Create System Files and Directories. vm-test-run-systemd-nspawn> server # [ 9.580173] systemd[1]: Starting Rebuild Journal Catalog... vm-test-run-systemd-nspawn> server # [ 9.596688] systemd[1]: Starting Record System Boot/Shutdown in UTMP... vm-test-run-systemd-nspawn> client # [ 9.667224] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. vm-test-run-systemd-nspawn> client # [ 9.672696] systemd[1]: Finished Create SUID/SGID Wrappers. vm-test-run-systemd-nspawn> server # [ 9.737180] systemd[1]: Finished Record System Boot/Shutdown in UTMP. vm-test-run-systemd-nspawn> server # [ 9.799310] systemd[1]: Finished Rebuild Journal Catalog. vm-test-run-systemd-nspawn> server # [ 9.813276] systemd[1]: Starting Update is Completed... vm-test-run-systemd-nspawn> client # [ 9.917323] systemd[1]: Finished register-nix-paths.service. vm-test-run-systemd-nspawn> server # [ 9.891232] systemd[1]: Finished Update is Completed. vm-test-run-systemd-nspawn> client # [ 10.149410] systemd[1]: Finished Coldplug All udev Devices. vm-test-run-systemd-nspawn> client # [ 10.150974] systemd[1]: Reached target System Initialization. vm-test-run-systemd-nspawn> client # [ 10.153251] systemd[1]: Started Discard unused filesystem blocks once a week. vm-test-run-systemd-nspawn> client # [ 10.160684] systemd[1]: Started Daily Cleanup of Temporary Directories. vm-test-run-systemd-nspawn> client # [ 10.161810] systemd[1]: Reached target Timer Units. vm-test-run-systemd-nspawn> client # [ 10.166968] systemd[1]: Listening on D-Bus System Message Bus Socket. vm-test-run-systemd-nspawn> client # [ 10.170609] systemd[1]: Listening on Nix Daemon Socket. vm-test-run-systemd-nspawn> client # [ 10.180324] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. vm-test-run-systemd-nspawn> client # [ 10.181890] systemd[1]: Reached target Socket Units. vm-test-run-systemd-nspawn> client # [ 10.182685] systemd[1]: Reached target Basic System. vm-test-run-systemd-nspawn> client # [ 10.188174] systemd[1]: Starting Import lastlog data into lastlog2 database... vm-test-run-systemd-nspawn> client # [ 10.191699] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-systemd-nspawn> client # [ 10.195263] systemd[1]: Starting Post-Boot Actions... vm-test-run-systemd-nspawn> client # [ 10.217108] systemd[1]: Started Reset console on configuration changes. vm-test-run-systemd-nspawn> client # [ 10.263480] systemd[1]: Starting resolvconf update... vm-test-run-systemd-nspawn> client # [ 10.290587] systemd[1]: Finished Firewall. vm-test-run-systemd-nspawn> client # [ 10.299094] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-systemd-nspawn> client # [ 10.308390] nsncd[483]: Sep 06 02:35:25.881 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-systemd-nspawn> client # [ 10.321316] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-systemd-nspawn> client # [ 10.325811] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-systemd-nspawn> client # [ 10.348348] systemd[1]: Starting D-Bus System Message Bus... vm-test-run-systemd-nspawn> client # [ 10.371485] systemd[1]: Starting User Login Management... vm-test-run-systemd-nspawn> server # [ 10.313098] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. vm-test-run-systemd-nspawn> client # [ 10.381938] systemd[1]: Finished Post-Boot Actions. vm-test-run-systemd-nspawn> server # [ 10.320794] systemd[1]: Finished Create SUID/SGID Wrappers. vm-test-run-systemd-nspawn> client # [ 10.419299] systemd[1]: Finished Import lastlog data into lastlog2 database. vm-test-run-systemd-nspawn> client # [ 10.538686] dbus-broker-launch[504]: Looking up NSS user entry for 'systemd-timesync'... vm-test-run-systemd-nspawn> client # [ 10.546984] dbus-broker-launch[504]: NSS returned no entry for 'systemd-timesync' vm-test-run-systemd-nspawn> client # [ 10.551835] dbus-broker-launch[504]: Invalid user-name in /nix/store/v3mlfznwlfywigxsg9va44lq8gsrcg44-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" vm-test-run-systemd-nspawn> client # [ 10.576403] systemd-logind[506]: New seat seat0. vm-test-run-systemd-nspawn> client # [ 10.583554] systemd[1]: Started User Login Management. vm-test-run-systemd-nspawn> client # [ 10.592105] systemd[1]: Starting linger-users.service... vm-test-run-systemd-nspawn> client # [ 10.596095] systemd[1]: Started D-Bus System Message Bus. vm-test-run-systemd-nspawn> client # [ 10.601511] systemd[1]: Stopped target Host and Network Name Lookups. vm-test-run-systemd-nspawn> client # [ 10.604488] systemd[1]: Stopping Host and Network Name Lookups... vm-test-run-systemd-nspawn> client # [ 10.607276] systemd[1]: Stopped target User and Group Name Lookups. vm-test-run-systemd-nspawn> client # [ 10.613105] systemd[1]: Stopping User and Group Name Lookups... vm-test-run-systemd-nspawn> client # [ 10.615047] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... vm-test-run-systemd-nspawn> server # [ 10.556530] systemd[1]: Finished register-nix-paths.service. vm-test-run-systemd-nspawn> client # [ 10.622272] systemd[1]: nscd.service: Deactivated successfully. vm-test-run-systemd-nspawn> client # [ 10.624776] systemd[1]: Stopped Name Service Cache Daemon (nsncd). vm-test-run-systemd-nspawn> client # [ 10.639680] dbus-broker-launch[504]: Ready vm-test-run-systemd-nspawn> client # [ 10.666767] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-systemd-nspawn> client # [ 10.701029] systemd[1]: linger-users.service: Deactivated successfully. vm-test-run-systemd-nspawn> client # [ 10.704410] systemd[1]: Finished linger-users.service. vm-test-run-systemd-nspawn> client # [ 10.749340] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-systemd-nspawn> client # [ 10.754506] nsncd[557]: Sep 06 02:35:26.333 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-systemd-nspawn> client # [ 10.759885] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-systemd-nspawn> client # [ 10.762734] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-systemd-nspawn> client # [ 10.791946] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input3 vm-test-run-systemd-nspawn> client # [ 10.785813] systemd[1]: Finished resolvconf update. vm-test-run-systemd-nspawn> client # [ 10.788955] systemd[1]: Reached target Preparation for Network. vm-test-run-systemd-nspawn> client # [ 10.797041] systemd[1]: Starting DHCP Client... vm-test-run-systemd-nspawn> client # [ 10.803642] systemd[1]: Starting Extra networking commands.... vm-test-run-systemd-nspawn> server # [ 10.826200] systemd[1]: Finished Coldplug All udev Devices. vm-test-run-systemd-nspawn> server # [ 10.827331] systemd[1]: Reached target System Initialization. vm-test-run-systemd-nspawn> server # [ 10.829656] systemd[1]: Started Discard unused filesystem blocks once a week. vm-test-run-systemd-nspawn> server # [ 10.836916] systemd[1]: Started Daily Cleanup of Temporary Directories. vm-test-run-systemd-nspawn> server # [ 10.837878] systemd[1]: Reached target Timer Units. vm-test-run-systemd-nspawn> server # [ 10.838584] systemd[1]: Listening on D-Bus System Message Bus Socket. vm-test-run-systemd-nspawn> server # [ 10.839466] systemd[1]: Listening on Nix Daemon Socket. vm-test-run-systemd-nspawn> server # [ 10.849115] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. vm-test-run-systemd-nspawn> server # [ 10.857590] systemd[1]: Reached target Socket Units. vm-test-run-systemd-nspawn> server # [ 10.858369] systemd[1]: Reached target Basic System. vm-test-run-systemd-nspawn> server # [ 10.859100] systemd[1]: Starting Import lastlog data into lastlog2 database... vm-test-run-systemd-nspawn> server # [ 10.864308] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-systemd-nspawn> server # [ 10.869700] systemd[1]: Starting Post-Boot Actions... vm-test-run-systemd-nspawn> server # [ 10.888414] systemd[1]: Started Reset console on configuration changes. vm-test-run-systemd-nspawn> server # [ 10.920577] systemd[1]: Starting resolvconf update... vm-test-run-systemd-nspawn> client # [ 11.043181] dhcpcd[590]: dhcpcd-10.3.2 starting vm-test-run-systemd-nspawn> client # [ 11.059995] dhcpcd[621]: dev: loaded udev vm-test-run-systemd-nspawn> server # [ 10.999821] systemd[1]: Starting D-Bus System Message Bus... vm-test-run-systemd-nspawn> server # [ 11.002881] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs vm-test-run-systemd-nspawn> client # [ 11.067883] dhcpcd[621]: no valid interfaces found vm-test-run-systemd-nspawn> client # [ 11.069869] dhcpcd[621]: no valid interfaces found vm-test-run-systemd-nspawn> client # [ 11.071158] dhcpcd[621]: libudev: received NULL device vm-test-run-systemd-nspawn> client # [ 11.072388] dhcpcd[621]: libudev: received NULL device vm-test-run-systemd-nspawn> server # [ 11.009946] systemd[1]: Finished Firewall. vm-test-run-systemd-nspawn> server # [ 11.016903] systemd[1]: Finished Post-Boot Actions. vm-test-run-systemd-nspawn> server # [ 11.039279] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-systemd-nspawn> server # [ 11.047220] nsncd[487]: Sep 06 02:35:26.626 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-systemd-nspawn> server # [ 11.058948] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-systemd-nspawn> server # [ 11.065778] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-systemd-nspawn> server # [ 11.070307] systemd[1]: Starting User Login Management... vm-test-run-systemd-nspawn> server # [ 11.076646] systemd[1]: Finished Import lastlog data into lastlog2 database. vm-test-run-systemd-nspawn> client # [ 11.138688] systemd[1]: Finished Extra networking commands.. vm-test-run-systemd-nspawn> client # [ 11.139782] systemd[1]: Reached target Network. vm-test-run-systemd-nspawn> client # [ 11.143962] systemd[1]: Starting Permit User Sessions... vm-test-run-systemd-nspawn> client # [ 11.197256] systemd[1]: Finished Permit User Sessions. vm-test-run-systemd-nspawn> client # [ 11.204298] systemd[1]: Started Getty on tty1. vm-test-run-systemd-nspawn> client # [ 11.206037] systemd[1]: Reached target Login Prompts. vm-test-run-systemd-nspawn> server # [ 11.205800] dbus-broker-launch[500]: Looking up NSS user entry for 'systemd-timesync'... vm-test-run-systemd-nspawn> server # [ 11.214082] dbus-broker-launch[500]: NSS returned no entry for 'systemd-timesync' vm-test-run-systemd-nspawn> server # [ 11.218443] dbus-broker-launch[500]: Invalid user-name in /nix/store/4q1m9dk5hza80953xzlgcdnm0cab53vf-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" vm-test-run-systemd-nspawn> server # [ 11.248503] systemd-logind[515]: New seat seat0. vm-test-run-systemd-nspawn> server # [ 11.253330] systemd[1]: Started User Login Management. vm-test-run-systemd-nspawn> server # [ 11.265069] systemd[1]: Starting linger-users.service... vm-test-run-systemd-nspawn> server # [ 11.269331] systemd[1]: Started D-Bus System Message Bus. vm-test-run-systemd-nspawn> client # [ 11.343351] systemd[1]: Starting Virtual Console Setup... vm-test-run-systemd-nspawn> server # [ 11.295543] systemd[1]: Stopped target Host and Network Name Lookups. vm-test-run-systemd-nspawn> server # [ 11.304139] systemd[1]: Stopping Host and Network Name Lookups... vm-test-run-systemd-nspawn> server # [ 11.305171] systemd[1]: Stopped target User and Group Name Lookups. vm-test-run-systemd-nspawn> server # [ 11.306035] systemd[1]: Stopping User and Group Name Lookups... vm-test-run-systemd-nspawn> server # [ 11.306844] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... vm-test-run-systemd-nspawn> client # [ 11.369226] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-systemd-nspawn> client # [ 11.372375] systemd[1]: Stopped Virtual Console Setup. vm-test-run-systemd-nspawn> client # [ 11.375645] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs vm-test-run-systemd-nspawn> client # [ 11.382814] systemd[1]: Starting Virtual Console Setup... vm-test-run-systemd-nspawn> server # [ 11.319688] systemd[1]: nscd.service: Deactivated successfully. vm-test-run-systemd-nspawn> server # [ 11.325658] systemd[1]: Stopped Name Service Cache Daemon (nsncd). vm-test-run-systemd-nspawn> server # [ 11.332674] dbus-broker-launch[500]: Ready vm-test-run-systemd-nspawn> server # [ 11.356477] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-systemd-nspawn> server # [ 11.378354] systemd[1]: linger-users.service: Deactivated successfully. vm-test-run-systemd-nspawn> server # [ 11.383331] systemd[1]: Finished linger-users.service. vm-test-run-systemd-nspawn> server # [ 11.437851] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-systemd-nspawn> server # [ 11.441000] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. vm-test-run-systemd-nspawn> server # [ 11.445594] nsncd[567]: Sep 06 02:35:27.023 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-systemd-nspawn> server # [ 11.453208] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-systemd-nspawn> server # [ 11.456958] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-systemd-nspawn> server # [ 11.464933] systemd[1]: Finished resolvconf update. vm-test-run-systemd-nspawn> server # [ 11.468163] systemd[1]: Reached target Preparation for Network. vm-test-run-systemd-nspawn> server # [ 11.474269] systemd[1]: Starting DHCP Client... vm-test-run-systemd-nspawn> server # [ 11.488534] systemd[1]: Starting Extra networking commands.... vm-test-run-systemd-nspawn> server # [ 11.506512] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. vm-test-run-systemd-nspawn> server # [ 11.514675] systemd[1]: Started backdoor.service. vm-test-run-systemd-nspawn> client # [ 11.638868] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. vm-test-run-systemd-nspawn> server # connecting to host... vm-test-run-systemd-nspawn> client # [ 11.701494] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. vm-test-run-systemd-nspawn> client # [ 11.710063] systemd[1]: Started backdoor.service. vm-test-run-systemd-nspawn> server: Guest shell says: b'Spawning backdoor root shell...\n' vm-test-run-systemd-nspawn> client # [ 11.770983] 8021q: 802.1Q VLAN Support v1.8 vm-test-run-systemd-nspawn> server: connected to guest root shell vm-test-run-systemd-nspawn> server: (connecting took 12.05 seconds) vm-test-run-systemd-nspawn> server: (finished: waiting for the VM to finish booting, in 12.05 seconds) vm-test-run-systemd-nspawn> client # [ 11.817218] (udev-worker)[650]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-systemd-nspawn> client # connecting to host... vm-test-run-systemd-nspawn> server # [ 11.775287] dhcpcd[599]: dhcpcd-10.3.2 starting vm-test-run-systemd-nspawn> client # [ 11.841958] (udev-worker)[657]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. vm-test-run-systemd-nspawn> client # [ 11.850004] (udev-worker)[657]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-systemd-nspawn> server # [ 11.795277] dhcpcd[643]: dev: loaded udev vm-test-run-systemd-nspawn> client # [ 11.914137] cfg80211: Loading compiled-in X.509 certificates for regulatory database vm-test-run-systemd-nspawn> server # [ 11.862531] 8021q: 802.1Q VLAN Support v1.8 vm-test-run-systemd-nspawn> server # [ 11.864326] systemd[1]: Finished Extra networking commands.. vm-test-run-systemd-nspawn> client # [ 11.947737] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' vm-test-run-systemd-nspawn> client # [ 11.948235] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' vm-test-run-systemd-nspawn> client # [ 11.953547] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 vm-test-run-systemd-nspawn> client # [ 11.953871] cfg80211: failed to load regulatory.db vm-test-run-systemd-nspawn> server # [ 11.888917] systemd[1]: Reached target Network. vm-test-run-systemd-nspawn> client # [ 11.953956] systemd-vconsole-setup[647]: Configuration of first virtual console was skipped, ignoring remaining ones. vm-test-run-systemd-nspawn> client # [ 11.960651] systemd[1]: Finished Virtual Console Setup. vm-test-run-systemd-nspawn> server # [ 11.902919] systemd[1]: Starting Nginx Web Server... vm-test-run-systemd-nspawn> server # [ 11.928083] systemd[1]: Starting Permit User Sessions... vm-test-run-systemd-nspawn> client # [ 12.036679] systemd[1]: Condition check resulted in Virtio network device being skipped. vm-test-run-systemd-nspawn> client # [ 12.045286] systemd[1]: Starting Address configuration of eth1... vm-test-run-systemd-nspawn> server # [ 12.008439] (udev-worker)[357]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. vm-test-run-systemd-nspawn> server # [ 12.031415] cfg80211: Loading compiled-in X.509 certificates for regulatory database vm-test-run-systemd-nspawn> server # [ 12.020913] (udev-worker)[357]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-systemd-nspawn> server # [ 12.031035] (udev-worker)[356]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-systemd-nspawn> server # [ 12.037677] systemd[1]: Finished Permit User Sessions. vm-test-run-systemd-nspawn> server # [ 12.049361] systemd[1]: Started Getty on tty1. vm-test-run-systemd-nspawn> server # [ 12.051772] systemd[1]: Reached target Login Prompts. vm-test-run-systemd-nspawn> client # [ 12.141629] 8021q: adding VLAN 0 to HW filter on device eth0 vm-test-run-systemd-nspawn> client # [ 12.128706] dhcpcd[621]: eth0: waiting for carrier vm-test-run-systemd-nspawn> client # [ 12.131776] dhcpcd[621]: eth0: carrier acquired vm-test-run-systemd-nspawn> server # [ 12.091017] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' vm-test-run-systemd-nspawn> server # [ 12.091526] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' vm-test-run-systemd-nspawn> server # [ 12.096372] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 vm-test-run-systemd-nspawn> server # [ 12.096791] cfg80211: failed to load regulatory.db vm-test-run-systemd-nspawn> client # [ 12.146602] dhcpcd[621]: DUID 00:01:00:01:32:2f:8d:ef:52:54:00:12:34:56 vm-test-run-systemd-nspawn> client # [ 12.148870] dhcpcd[621]: eth0: IAID 00:12:34:56 vm-test-run-systemd-nspawn> client # [ 12.150402] dhcpcd[621]: eth0: adding address fe80::5054:ff:fe12:3456 vm-test-run-systemd-nspawn> client # [ 12.172926] 8021q: adding VLAN 0 to HW filter on device eth1 vm-test-run-systemd-nspawn> client # [ 12.176340] network-addresses-eth1-start[677]: adding address 192.168.1.1/24... done vm-test-run-systemd-nspawn> client # [ 12.191787] network-addresses-eth1-start[677]: adding address 2001:db8:1::1/64... done vm-test-run-systemd-nspawn> client # [ 12.213889] systemd[1]: Finished Address configuration of eth1. vm-test-run-systemd-nspawn> client # [ 12.220153] systemd-logind[506]: Watching system buttons on /dev/input/event0 (gpio-keys) vm-test-run-systemd-nspawn> server # [ 12.187896] 8021q: adding VLAN 0 to HW filter on device eth0 vm-test-run-systemd-nspawn> server # [ 12.174068] dhcpcd[643]: eth0: waiting for carrier vm-test-run-systemd-nspawn> server # [ 12.177910] dhcpcd[643]: libudev: received NULL device vm-test-run-systemd-nspawn> server # [ 12.178833] dhcpcd[643]: libudev: received NULL device vm-test-run-systemd-nspawn> server # [ 12.181934] dhcpcd[643]: eth0: carrier acquired vm-test-run-systemd-nspawn> server # [ 12.197494] dhcpcd[643]: DUID 00:01:00:01:32:2f:8d:ef:52:54:00:12:34:56 vm-test-run-systemd-nspawn> server # [ 12.199785] dhcpcd[643]: eth0: IAID 00:12:34:56 vm-test-run-systemd-nspawn> server # [ 12.202123] dhcpcd[643]: eth0: adding address fe80::5054:ff:fe12:3456 vm-test-run-systemd-nspawn> server # [ 12.224304] systemd-logind[515]: Watching system buttons on /dev/input/event0 (gpio-keys) vm-test-run-systemd-nspawn> server # [ 12.233536] dhcpcd[643]: eth0: IAID 00:12:34:56 vm-test-run-systemd-nspawn> server # [ 12.239529] systemd[1]: Condition check resulted in Virtio network device being skipped. vm-test-run-systemd-nspawn> server # [ 12.244728] systemd[1]: Starting Address configuration of eth1... vm-test-run-systemd-nspawn> client # [ 12.331659] mousedev: PS/2 mouse device common for all mice vm-test-run-systemd-nspawn> client # [ 12.385704] systemd-logind[506]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) vm-test-run-systemd-nspawn> server # [ 12.329446] nginx-pre-start[676]: nginx: the configuration file /nix/store/hf88bln2hx6ms1y08l3aq1p4g39ajhp3-nginx.conf syntax is ok vm-test-run-systemd-nspawn> server # [ 12.331456] nginx-pre-start[676]: nginx: configuration file /nix/store/hf88bln2hx6ms1y08l3aq1p4g39ajhp3-nginx.conf test is successful vm-test-run-systemd-nspawn> server # [ 12.346836] systemd[1]: Started Nginx Web Server. vm-test-run-systemd-nspawn> server # [ 12.381639] 8021q: adding VLAN 0 to HW filter on device eth1 vm-test-run-systemd-nspawn> server # [ 12.395091] network-addresses-eth1-start[685]: adding address 192.168.1.2/24... done vm-test-run-systemd-nspawn> server # [ 12.411782] dhcpcd[643]: eth0: soliciting a DHCP lease vm-test-run-systemd-nspawn> server # [ 12.416548] dhcpcd[643]: eth0: offered 10.0.2.15 from 10.0.2.2 vm-test-run-systemd-nspawn> server # [ 12.424268] dhcpcd[643]: eth0: probing address 10.0.2.15/24 vm-test-run-systemd-nspawn> server # [ 12.425725] network-addresses-eth1-start[685]: adding address 2001:db8:1::2/64... done vm-test-run-systemd-nspawn> client # [ 12.506617] dhcpcd[621]: eth0: soliciting a DHCP lease vm-test-run-systemd-nspawn> client # [ 12.512487] dhcpcd[621]: eth0: offered 10.0.2.15 from 10.0.2.2 vm-test-run-systemd-nspawn> server # [ 12.456726] systemd[1]: Finished Address configuration of eth1. vm-test-run-systemd-nspawn> client # [ 12.520231] dhcpcd[621]: eth0: probing address 10.0.2.15/24 vm-test-run-systemd-nspawn> server # [ 12.602362] mousedev: PS/2 mouse device common for all mice vm-test-run-systemd-nspawn> server # [ 12.617400] systemd-logind[515]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) vm-test-run-systemd-nspawn> server: (finished: waiting for unit nginx.service, in 13.38 seconds) vm-test-run-systemd-nspawn> client: waiting for the VM to finish booting vm-test-run-systemd-nspawn> client: Guest shell says: b'Spawning backdoor root shell...\n' vm-test-run-systemd-nspawn> client: connected to guest root shell vm-test-run-systemd-nspawn> client: (connecting took 0.00 seconds) vm-test-run-systemd-nspawn> client: (finished: waiting for the VM to finish booting, in 0.00 seconds) vm-test-run-systemd-nspawn> client # [ 13.393412] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-systemd-nspawn> client # [ 13.396219] systemd[1]: Stopped Virtual Console Setup. vm-test-run-systemd-nspawn> client # [ 13.397019] systemd[1]: Stopping Virtual Console Setup... vm-test-run-systemd-nspawn> client # [ 13.404453] systemd[1]: Starting Virtual Console Setup... vm-test-run-systemd-nspawn> server # [ 13.357627] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input3 vm-test-run-systemd-nspawn> client # [ 13.446778] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. vm-test-run-systemd-nspawn> client # [ 13.453635] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-systemd-nspawn> client # [ 13.459177] systemd[1]: Stopped Virtual Console Setup. vm-test-run-systemd-nspawn> client # [ 13.466066] systemd[1]: Starting Virtual Console Setup... vm-test-run-systemd-nspawn> client # [ 13.500263] systemd-logind[506]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) vm-test-run-systemd-nspawn> server # [ 13.648981] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. vm-test-run-systemd-nspawn> server # [ 13.669845] systemd[1]: Starting Virtual Console Setup... vm-test-run-systemd-nspawn> client # [ 13.745686] systemd-vconsole-setup[706]: Configuration of first virtual console was skipped, ignoring remaining ones. vm-test-run-systemd-nspawn> client # [ 13.749740] systemd[1]: Finished Virtual Console Setup. vm-test-run-systemd-nspawn> server # [ 13.698865] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-systemd-nspawn> server # [ 13.700749] systemd[1]: Stopped Virtual Console Setup. vm-test-run-systemd-nspawn> server # [ 13.705163] systemd[1]: Starting Virtual Console Setup... vm-test-run-systemd-nspawn> server # [ 13.751454] systemd-logind[515]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) vm-test-run-systemd-nspawn> server # [ 14.131170] systemd-vconsole-setup[722]: Configuration of first virtual console was skipped, ignoring remaining ones. vm-test-run-systemd-nspawn> server # [ 14.136513] systemd[1]: Finished Virtual Console Setup. vm-test-run-systemd-nspawn> client # [ 14.307968] dhcpcd[621]: eth0: soliciting an IPv6 router vm-test-run-systemd-nspawn> client # [ 14.311741] dhcpcd[621]: eth0: Router Advertisement from fe80::2 vm-test-run-systemd-nspawn> client # [ 14.314516] dhcpcd[621]: eth0: adding address fec0::5054:ff:fe12:3456/64 vm-test-run-systemd-nspawn> client # [ 14.317567] dhcpcd[621]: eth0: adding route to fec0::/64 vm-test-run-systemd-nspawn> client # [ 14.319880] dhcpcd[621]: eth0: adding default route via fe80::2 vm-test-run-systemd-nspawn> server # [ 14.366632] dhcpcd[643]: eth0: soliciting an IPv6 router vm-test-run-systemd-nspawn> server # [ 14.370553] dhcpcd[643]: eth0: Router Advertisement from fe80::2 vm-test-run-systemd-nspawn> server # [ 14.373275] dhcpcd[643]: eth0: adding address fec0::5054:ff:fe12:3456/64 vm-test-run-systemd-nspawn> server # [ 14.376318] dhcpcd[643]: eth0: adding route to fec0::/64 vm-test-run-systemd-nspawn> server # [ 14.378554] dhcpcd[643]: eth0: adding default route via fe80::2 vm-test-run-systemd-nspawn> server # [ 17.027145] dhcpcd[643]: eth0: leased 10.0.2.15 for 86400 seconds vm-test-run-systemd-nspawn> server # [ 17.030378] dhcpcd[643]: eth0: adding route to 10.0.2.0/24 vm-test-run-systemd-nspawn> server # [ 17.033003] dhcpcd[643]: eth0: adding default route via 10.0.2.2 vm-test-run-systemd-nspawn> server # [ 17.248739] systemd[1]: Started DHCP Client. vm-test-run-systemd-nspawn> server # [ 17.250651] systemd[1]: Reached target Multi-User System. vm-test-run-systemd-nspawn> server # [ 17.251941] systemd[1]: Startup finished in 986ms (kernel) + 5.335s (initrd) + 10.929s (userspace) = 17.251s. vm-test-run-systemd-nspawn> client # [ 17.417060] dhcpcd[621]: eth0: leased 10.0.2.15 for 86400 seconds vm-test-run-systemd-nspawn> client # [ 17.420417] dhcpcd[621]: eth0: adding route to 10.0.2.0/24 vm-test-run-systemd-nspawn> client # [ 17.422805] dhcpcd[621]: eth0: adding default route via 10.0.2.2 vm-test-run-systemd-nspawn> client # [ 17.602598] systemd[1]: Started DHCP Client. vm-test-run-systemd-nspawn> client # [ 17.605413] systemd[1]: Reached target Multi-User System. vm-test-run-systemd-nspawn> client # [ 17.608479] systemd[1]: Reached target Network is Online. vm-test-run-systemd-nspawn> client # [ 17.609459] systemd[1]: Startup finished in 984ms (kernel) + 4.408s (initrd) + 12.214s (userspace) = 17.607s. vm-test-run-systemd-nspawn> client: waiting for unit network-online.target vm-test-run-systemd-nspawn> client: (finished: waiting for unit network-online.target, in 0.11 seconds) vm-test-run-systemd-nspawn> client: must succeed: machinectl pull-raw --verify=signature http://server/testimage.raw vm-test-run-systemd-nspawn> client # The 'machinectl pull-raw' command has been replaced by 'importctl -m pull-raw'. Redirecting invocation. vm-test-run-systemd-nspawn> client # [ 17.764800] systemd[1]: Starting Disk Image Download Service... vm-test-run-systemd-nspawn> client # [ 17.807078] systemd[1]: Started Disk Image Download Service. vm-test-run-systemd-nspawn> client # Enqueued transfer job 1. Press C-c to continue download in background. vm-test-run-systemd-nspawn> client # [ 17.819943] systemd-importd[777]: (transfer1) Pulling 'http://server/testimage.raw', saving as 'testimage'. vm-test-run-systemd-nspawn> client # Pulling 'http://server/testimage.raw', saving as 'testimage'. vm-test-run-systemd-nspawn> client # Operating on image directory '/var/lib/machines'. vm-test-run-systemd-nspawn> client # [ 17.823434] systemd-importd[777]: (transfer1) Operating on image directory '/var/lib/machines'. vm-test-run-systemd-nspawn> client # HTTP request to http://server/testimage.nspawn failed with code 404. vm-test-run-systemd-nspawn> client # [ 18.024734] systemd-importd[777]: (transfer1) HTTP request to http://server/testimage.nspawn failed with code 404. vm-test-run-systemd-nspawn> client # Settings file could not be retrieved, proceeding without. vm-test-run-systemd-nspawn> client # [ 18.028990] systemd-importd[777]: (transfer1) Settings file could not be retrieved, proceeding without. vm-test-run-systemd-nspawn> server # [ 17.960614] nginx[711]: 2026/09/06 02:35:33 [error] 711#711: *1 open() "/nix/store/n58c814m7hc2lbdibgyj37rc2a1s1wjz-localhost/testimage.nspawn" failed (2: No such file or directory), client: 2001:db8:1::1, server: server, request: "GET /testimage.nspawn HTTP/1.1", host: "server" vm-test-run-systemd-nspawn> client # Downloading 5M for http://server/testimage.raw. vm-test-run-systemd-nspawn> client # [ 18.040134] systemd-importd[777]: (transfer1) Downloading 5M for http://server/testimage.raw. vm-test-run-systemd-nspawn> client # Got 2% of http://server/testimage.raw. vm-test-run-systemd-nspawn> client # [ 18.044493] systemd-importd[777]: (transfer1) Got 2% of http://server/testimage.raw. vm-test-run-systemd-nspawn> server # [ 17.977788] nginx[711]: 2026/09/06 02:35:33 [error] 711#711: *3 open() "/nix/store/n58c814m7hc2lbdibgyj37rc2a1s1wjz-localhost/testimage.raw.sha256" failed (2: No such file or directory), client: 2001:db8:1::1, server: server, request: "GET /testimage.raw.sha256 HTTP/1.1", host: "server" vm-test-run-systemd-nspawn> server # [ 18.039381] nginx[711]: 2026/09/06 02:35:33 [error] 711#711: *4 open() "/nix/store/n58c814m7hc2lbdibgyj37rc2a1s1wjz-localhost/testimage.raw.sha256.asc" failed (2: No such file or directory), client: 2001:db8:1::1, server: server, request: "GET /testimage.raw.sha256.asc HTTP/1.1", host: "server" vm-test-run-systemd-nspawn> client # Downloading 164B for http://server/SHA256SUMS. vm-test-run-systemd-nspawn> client # [ 18.115146] systemd-importd[777]: (transfer1) Downloading 164B for http://server/SHA256SUMS. vm-test-run-systemd-nspawn> server # [ 18.049914] nginx[711]: 2026/09/06 02:35:33 [error] 711#711: *5 open() "/nix/store/n58c814m7hc2lbdibgyj37rc2a1s1wjz-localhost/testimage.roothash" failed (2: No such file or directory), client: 2001:db8:1::1, server: server, request: "GET /testimage.roothash HTTP/1.1", host: "server" vm-test-run-systemd-nspawn> client # Acquired 164B for http://server/SHA256SUMS. vm-test-run-systemd-nspawn> client # Download of http://server/SHA256SUMS complete. vm-test-run-systemd-nspawn> client # [ 18.124994] systemd-importd[777]: (transfer1) Acquired 164B for http://server/SHA256SUMS. vm-test-run-systemd-nspawn> client # [ 18.127786] systemd-importd[777]: (transfer1) Download of http://server/SHA256SUMS complete. vm-test-run-systemd-nspawn> client # HTTP request to http://server/testimage.roothash failed with code 404. vm-test-run-systemd-nspawn> client # Root hash file could not be retrieved, proceeding without. vm-test-run-systemd-nspawn> client # [ 18.140462] systemd-importd[777]: (transfer1) HTTP request to http://server/testimage.roothash failed with code 404. vm-test-run-systemd-nspawn> client # [ 18.142661] systemd-importd[777]: (transfer1) Root hash file could not be retrieved, proceeding without. vm-test-run-systemd-nspawn> server # [ 18.076816] nginx[711]: 2026/09/06 02:35:33 [error] 711#711: *6 open() "/nix/store/n58c814m7hc2lbdibgyj37rc2a1s1wjz-localhost/testimage.roothash.p7s" failed (2: No such file or directory), client: 2001:db8:1::1, server: server, request: "GET /testimage.roothash.p7s HTTP/1.1", host: "server" vm-test-run-systemd-nspawn> client # HTTP request to http://server/testimage.roothash.p7s failed with code 404. vm-test-run-systemd-nspawn> server # [ 18.085849] nginx[711]: 2026/09/06 02:35:33 [error] 711#711: *4 open() "/nix/store/n58c814m7hc2lbdibgyj37rc2a1s1wjz-localhost/testimage.raw.sha256.gpg" failed (2: No such file or directory), client: 2001:db8:1::1, server: server, request: "GET /testimage.raw.sha256.gpg HTTP/1.1", host: "server" vm-test-run-systemd-nspawn> client # [ 18.153017] systemd-importd[777]: (transfer1) HTTP request to http://server/testimage.roothash.p7s failed with code 404. vm-test-run-systemd-nspawn> client # Root hash signature file could not be retrieved, proceeding without. vm-test-run-systemd-nspawn> client # HTTP request to http://server/testimage.verity failed with code 404. vm-test-run-systemd-nspawn> client # Verity integrity file could not be retrieved, proceeding without. vm-test-run-systemd-nspawn> server # [ 18.094586] nginx[711]: 2026/09/06 02:35:33 [error] 711#711: *7 open() "/nix/store/n58c814m7hc2lbdibgyj37rc2a1s1wjz-localhost/testimage.verity" failed (2: No such file or directory), client: 2001:db8:1::1, server: server, request: "GET /testimage.verity HTTP/1.1", host: "server" vm-test-run-systemd-nspawn> client # [ 18.161237] systemd-importd[777]: (transfer1) Root hash signature file could not be retrieved, proceeding without. vm-test-run-systemd-nspawn> client # [ 18.168445] systemd-importd[777]: (transfer1) HTTP request to http://server/testimage.verity failed with code 404. vm-test-run-systemd-nspawn> client # [ 18.180622] systemd-importd[777]: (transfer1) Verity integrity file could not be retrieved, proceeding without. vm-test-run-systemd-nspawn> client # [ 18.194597] systemd-importd[777]: (transfer1) Downloading 119B for http://server/SHA256SUMS.gpg. vm-test-run-systemd-nspawn> client # Downloading 119B for http://server/SHA256SUMS.gpg. vm-test-run-systemd-nspawn> client # Acquired 119B for http://server/SHA256SUMS.gpg. vm-test-run-systemd-nspawn> client # [ 18.202332] systemd-importd[777]: (transfer1) Acquired 119B for http://server/SHA256SUMS.gpg. vm-test-run-systemd-nspawn> client # Download of http://server/SHA256SUMS.gpg complete. vm-test-run-systemd-nspawn> client # [ 18.206290] systemd-importd[777]: (transfer1) Download of http://server/SHA256SUMS.gpg complete. vm-test-run-systemd-nspawn> client # [ 18.214690] systemd-importd[777]: (transfer1) Acquired 5M for http://server/testimage.raw. vm-test-run-systemd-nspawn> client # Acquired 5M for http://server/testimage.raw. vm-test-run-systemd-nspawn> client # Download of http://server/testimage.raw complete. vm-test-run-systemd-nspawn> client # SHA256 checksum of http://server/testimage.raw is valid. vm-test-run-systemd-nspawn> client # [ 18.218817] systemd-importd[777]: (transfer1) Download of http://server/testimage.raw complete. vm-test-run-systemd-nspawn> client # [ 18.220153] systemd-importd[777]: (transfer1) SHA256 checksum of http://server/testimage.raw is valid. vm-test-run-systemd-nspawn> client # gpg: Signature made Tue 25 Aug 2026 07:55:48 PM UTC vm-test-run-systemd-nspawn> client # [ 18.271270] systemd-importd[777]: (transfer1) gpg: Signature made Tue 25 Aug 2026 07:55:48 PM UTC vm-test-run-systemd-nspawn> client # gpg: using EDDSA key B602513E30B9C7C18A2EE305BD46D0F30A37875D vm-test-run-systemd-nspawn> client # [ 18.274091] systemd-importd[777]: (transfer1) gpg: using EDDSA key B602513E30B9C7C18A2EE305BD46D0F30A37875D vm-test-run-systemd-nspawn> client # gpg: Good signature from "Bob Foobar " [unknown] vm-test-run-systemd-nspawn> client # [ 18.281582] systemd-importd[777]: (transfer1) gpg: Good signature from "Bob Foobar " [unknown] vm-test-run-systemd-nspawn> client # gpg: WARNING: Using untrusted key! vm-test-run-systemd-nspawn> client # [ 18.284424] systemd-importd[777]: (transfer1) gpg: WARNING: Using untrusted key! vm-test-run-systemd-nspawn> client # Signature verification succeeded. vm-test-run-systemd-nspawn> client # [ 18.286731] systemd-importd[777]: (transfer1) Signature verification succeeded. vm-test-run-systemd-nspawn> client # Created new local image 'testimage'. vm-test-run-systemd-nspawn> client # [ 18.312868] systemd-importd[777]: (transfer1) Created new local image 'testimage'. vm-test-run-systemd-nspawn> client # Operation completed successfully. vm-test-run-systemd-nspawn> client # Exiting. vm-test-run-systemd-nspawn> client # [ 18.316864] systemd-importd[777]: (transfer1) Operation completed successfully. vm-test-run-systemd-nspawn> client # [ 18.318462] systemd-importd[777]: (transfer1) Exiting. vm-test-run-systemd-nspawn> client: (finished: must succeed: machinectl pull-raw --verify=signature http://server/testimage.raw, in 0.61 seconds) vm-test-run-systemd-nspawn> client: must succeed: cmp /var/lib/machines/testimage.raw /nix/store/n58c814m7hc2lbdibgyj37rc2a1s1wjz-localhost/testimage.raw vm-test-run-systemd-nspawn> client: (finished: must succeed: cmp /var/lib/machines/testimage.raw /nix/store/n58c814m7hc2lbdibgyj37rc2a1s1wjz-localhost/testimage.raw, in 0.09 seconds) vm-test-run-systemd-nspawn> client: must succeed: machinectl pull-tar --verify=signature http://server/testimage2.tar.xz vm-test-run-systemd-nspawn> client # The 'machinectl pull-tar' command has been replaced by 'importctl -m pull-tar'. Redirecting invocation. vm-test-run-systemd-nspawn> client # Enqueued transfer job 2. Press C-c to continue download in background. vm-test-run-systemd-nspawn> client # Pulling 'http://server/testimage2.tar.xz', saving as 'testimage2'. vm-test-run-systemd-nspawn> client # [ 18.462410] systemd-importd[777]: (transfer2) Pulling 'http://server/testimage2.tar.xz', saving as 'testimage2'. vm-test-run-systemd-nspawn> client # Operating on image directory '/var/lib/machines'. vm-test-run-systemd-nspawn> client # [ 18.465283] systemd-importd[777]: (transfer2) Operating on image directory '/var/lib/machines'. vm-test-run-systemd-nspawn> client # HTTP request to http://server/testimage2.nspawn failed with code 404. vm-test-run-systemd-nspawn> client # [ 18.511290] systemd-importd[777]: (transfer2) HTTP request to http://server/testimage2.nspawn failed with code 404. vm-test-run-systemd-nspawn> client # Settings file could not be retrieved, proceeding without. vm-test-run-systemd-nspawn> client # [ 18.514016] systemd-importd[777]: (transfer2) Settings file could not be retrieved, proceeding without. vm-test-run-systemd-nspawn> server # [ 18.447233] nginx[711]: 2026/09/06 02:35:34 [error] 711#711: *8 open() "/nix/store/n58c814m7hc2lbdibgyj37rc2a1s1wjz-localhost/testimage2.nspawn" failed (2: No such file or directory), client: 2001:db8:1::1, server: server, request: "GET /testimage2.nspawn HTTP/1.1", host: "server" vm-test-run-systemd-nspawn> server # [ 18.461002] nginx[711]: 2026/09/06 02:35:34 [error] 711#711: *9 open() "/nix/store/n58c814m7hc2lbdibgyj37rc2a1s1wjz-localhost/testimage2.tar.xz.sha256" failed (2: No such file or directory), client: 2001:db8:1::1, server: server, request: "GET /testimage2.tar.xz.sha256 HTTP/1.1", host: "server" vm-test-run-systemd-nspawn> client # Downloading 57.6K for http://server/testimage2.tar.xz. vm-test-run-systemd-nspawn> client # [ 18.537703] systemd-importd[777]: (transfer2) Downloading 57.6K for http://server/testimage2.tar.xz. vm-test-run-systemd-nspawn> server # [ 18.475429] nginx[711]: 2026/09/06 02:35:34 [error] 711#711: *10 open() "/nix/store/n58c814m7hc2lbdibgyj37rc2a1s1wjz-localhost/testimage2.tar.xz.sha256.asc" failed (2: No such file or directory), client: 2001:db8:1::1, server: server, request: "GET /testimage2.tar.xz.sha256.asc HTTP/1.1", host: "server" vm-test-run-systemd-nspawn> client # Acquired 350K for http://server/testimage2.tar.xz. vm-test-run-systemd-nspawn> client # [ 18.574103] systemd-importd[777]: (transfer2) Acquired 350K for http://server/testimage2.tar.xz. vm-test-run-systemd-nspawn> client # Download of http://server/testimage2.tar.xz complete. vm-test-run-systemd-nspawn> client # Downloading 164B for http://server/SHA256SUMS. vm-test-run-systemd-nspawn> client # Acquired 164B for http://server/SHA256SUMS. vm-test-run-systemd-nspawn> client # Download of http://server/SHA256SUMS complete. vm-test-run-systemd-nspawn> client # [ 18.582046] systemd-importd[777]: (transfer2) Download of http://server/testimage2.tar.xz complete. vm-test-run-systemd-nspawn> client # [ 18.583333] systemd-importd[777]: (transfer2) Downloading 164B for http://server/SHA256SUMS. vm-test-run-systemd-nspawn> server # [ 18.512352] nginx[711]: 2026/09/06 02:35:34 [error] 711#711: *11 open() "/nix/store/n58c814m7hc2lbdibgyj37rc2a1s1wjz-localhost/testimage2.tar.xz.sha256.gpg" failed (2: No such file or directory), client: 2001:db8:1::1, server: server, request: "GET /testimage2.tar.xz.sha256.gpg HTTP/1.1", host: "server" vm-test-run-systemd-nspawn> client # [ 18.587837] systemd-importd[777]: (transfer2) Acquired 164B for http://server/SHA256SUMS. vm-test-run-systemd-nspawn> client # [ 18.589198] systemd-importd[777]: (transfer2) Download of http://server/SHA256SUMS complete. vm-test-run-systemd-nspawn> client # Downloading 119B for http://server/SHA256SUMS.gpg. vm-test-run-systemd-nspawn> client # [ 18.756145] systemd-importd[777]: (transfer2) Downloading 119B for http://server/SHA256SUMS.gpg. vm-test-run-systemd-nspawn> client # Acquired 119B for http://server/SHA256SUMS.gpg. vm-test-run-systemd-nspawn> client # Download of http://server/SHA256SUMS.gpg complete. vm-test-run-systemd-nspawn> client # SHA256 checksum of http://server/testimage2.tar.xz is valid. vm-test-run-systemd-nspawn> client # [ 18.762600] systemd-importd[777]: (transfer2) Acquired 119B for http://server/SHA256SUMS.gpg. vm-test-run-systemd-nspawn> client # [ 18.764367] systemd-importd[777]: (transfer2) Download of http://server/SHA256SUMS.gpg complete. vm-test-run-systemd-nspawn> client # [ 18.766271] systemd-importd[777]: (transfer2) SHA256 checksum of http://server/testimage2.tar.xz is valid. vm-test-run-systemd-nspawn> client # gpg: Signature made Tue 25 Aug 2026 07:55:48 PM UTC vm-test-run-systemd-nspawn> client # [ 18.782386] systemd-importd[777]: (transfer2) gpg: Signature made Tue 25 Aug 2026 07:55:48 PM UTC vm-test-run-systemd-nspawn> client # gpg: using EDDSA key B602513E30B9C7C18A2EE305BD46D0F30A37875D vm-test-run-systemd-nspawn> client # [ 18.788463] systemd-importd[777]: (transfer2) gpg: using EDDSA key B602513E30B9C7C18A2EE305BD46D0F30A37875D vm-test-run-systemd-nspawn> client # gpg: Good signature from "Bob Foobar " [unknown] vm-test-run-systemd-nspawn> client # gpg: WARNING: Using untrusted key! vm-test-run-systemd-nspawn> client # [ 18.792917] systemd-importd[777]: (transfer2) gpg: Good signature from "Bob Foobar " [unknown] vm-test-run-systemd-nspawn> client # [ 18.794498] systemd-importd[777]: (transfer2) gpg: WARNING: Using untrusted key! vm-test-run-systemd-nspawn> client # Signature verification succeeded. vm-test-run-systemd-nspawn> client # [ 18.797262] systemd-importd[777]: (transfer2) Signature verification succeeded. vm-test-run-systemd-nspawn> client # Created new local image 'testimage2'. vm-test-run-systemd-nspawn> client # [ 18.841708] systemd-importd[777]: (transfer2) Created new local image 'testimage2'. vm-test-run-systemd-nspawn> client # Operation completed successfully. vm-test-run-systemd-nspawn> client # Exiting. vm-test-run-systemd-nspawn> client # [ 18.848969] systemd-importd[777]: (transfer2) Operation completed successfully. vm-test-run-systemd-nspawn> client # [ 18.850248] systemd-importd[777]: (transfer2) Exiting. vm-test-run-systemd-nspawn> client: (finished: must succeed: machinectl pull-tar --verify=signature http://server/testimage2.tar.xz, in 0.44 seconds) vm-test-run-systemd-nspawn> client: must succeed: cmp /var/lib/machines/testimage2//nix/store/r6kacndzxprd8xcz5kdf037ganb3yhxq-hello-2.12.3/bin/hello /nix/store/r6kacndzxprd8xcz5kdf037ganb3yhxq-hello-2.12.3/bin/hello vm-test-run-systemd-nspawn> client: (finished: must succeed: cmp /var/lib/machines/testimage2//nix/store/r6kacndzxprd8xcz5kdf037ganb3yhxq-hello-2.12.3/bin/hello /nix/store/r6kacndzxprd8xcz5kdf037ganb3yhxq-hello-2.12.3/bin/hello, in 0.03 seconds) vm-test-run-systemd-nspawn> (finished: run the VM test script, in 19.65 seconds) vm-test-run-systemd-nspawn> test script finished in 19.78s vm-test-run-systemd-nspawn> cleanup vm-test-run-systemd-nspawn> kill QemuMachine (pid 47) vm-test-run-systemd-nspawn> client # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lfh101cfjj8p8npcari9hk0lbqi33yvh-python3-3.14.7/bin/python3.14) vm-test-run-systemd-nspawn> kill QemuMachine (pid 48) vm-test-run-systemd-nspawn> server # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lfh101cfjj8p8npcari9hk0lbqi33yvh-python3-3.14.7/bin/python3.14) vm-test-run-systemd-nspawn> (finished: cleanup, in 0.36 seconds) vm-test-run-systemd-nspawn> additionally exposed symbols: vm-test-run-systemd-nspawn> client, server, vm-test-run-systemd-nspawn> vlan1, vm-test-run-systemd-nspawn> start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh post-build step Upload coverage to codecov: ok Skipping codecov: project=Kranzes/systemd-nix-nightly attr=checks.aarch64-linux.systemd-nspawn