these 13 derivations will be built: /nix/store/zssvzfis6j4z18hm0rrj0y2zrqp27d93-flakelet-config.json.drv /nix/store/d9hhp8dpj2hkks48qp97055i195gmgm3-X-Restart-Triggers-flakelet-reconcile.drv /nix/store/abpirngd6n0g5v8rd33n98zhk10spdg1-unit-flakelet-reconcile.service.drv /nix/store/ivn8kzjb9bfqsfg3fv1xzgvv5kyqhnb0-system-units.drv /nix/store/lpj4bxxi3v8n8hhfvj72l43ckf6qxsli-etc.drv /nix/store/cfh51pn9alhjvzxm7gl6p2sx2v5hgj40-activate.drv /nix/store/8dmfk32fjz0wc5svzlwghw99bz4ma750-nixos-system-machine-test.drv /nix/store/qd7pz1plxbhznnfzm0ydhfmhgrlkzdig-closure-info.drv /nix/store/vw143grhbgkwgj77fv49n108nv7kf4xm-run-nixos-vm.drv /nix/store/sm152va0x9rkhxpn79wrgmhpqjjv0i28-nixos-vm.drv /nix/store/mmc046aacp2r0skb1nay6k0m4639wckv-driverConfiguration.json.drv /nix/store/6qhzay2wxl5rgp5mb1fdqnj2nqaq0ffk-nixos-test-driver-flakelet.drv /nix/store/6g9khx8r3wz9rmfsy28pnyzviz07vg66-vm-test-run-flakelet.drv building '/nix/store/zssvzfis6j4z18hm0rrj0y2zrqp27d93-flakelet-config.json.drv' flakelet-config.json> tribuchet: building on eliza flakelet-config.json> structuredAttrs is enabled building '/nix/store/d9hhp8dpj2hkks48qp97055i195gmgm3-X-Restart-Triggers-flakelet-reconcile.drv' X-Restart-Triggers-flakelet-reconcile> tribuchet: building on eliza building '/nix/store/abpirngd6n0g5v8rd33n98zhk10spdg1-unit-flakelet-reconcile.service.drv' unit-flakelet-reconcile.service> tribuchet: building on eliza unit-flakelet-reconcile.service> structuredAttrs is enabled building '/nix/store/ivn8kzjb9bfqsfg3fv1xzgvv5kyqhnb0-system-units.drv' system-units> tribuchet: building on eliza building '/nix/store/lpj4bxxi3v8n8hhfvj72l43ckf6qxsli-etc.drv' etc> tribuchet: building on eliza building '/nix/store/cfh51pn9alhjvzxm7gl6p2sx2v5hgj40-activate.drv' activate> tribuchet: building on eliza building '/nix/store/8dmfk32fjz0wc5svzlwghw99bz4ma750-nixos-system-machine-test.drv' nixos-system-machine-test> tribuchet: building on eliza nixos-system-machine-test> structuredAttrs is enabled building '/nix/store/qd7pz1plxbhznnfzm0ydhfmhgrlkzdig-closure-info.drv' closure-info> tribuchet: building on eliza closure-info> structuredAttrs is enabled building '/nix/store/vw143grhbgkwgj77fv49n108nv7kf4xm-run-nixos-vm.drv' run-nixos-vm> tribuchet: building on eliza building '/nix/store/sm152va0x9rkhxpn79wrgmhpqjjv0i28-nixos-vm.drv' nixos-vm> tribuchet: building on eliza building '/nix/store/mmc046aacp2r0skb1nay6k0m4639wckv-driverConfiguration.json.drv' driverConfiguration.json> tribuchet: building on eliza driverConfiguration.json> structuredAttrs is enabled building '/nix/store/6qhzay2wxl5rgp5mb1fdqnj2nqaq0ffk-nixos-test-driver-flakelet.drv' nixos-test-driver-flakelet> tribuchet: building on eliza nixos-test-driver-flakelet> Running type check (enable/disable: config.skipTypeCheck) nixos-test-driver-flakelet> See https://nixos.org/manual/nixos/stable/#test-opt-skipTypeCheck nixos-test-driver-flakelet> All checks passed! nixos-test-driver-flakelet> Linting test script (enable/disable: config.skipLint) nixos-test-driver-flakelet> See https://nixos.org/manual/nixos/stable/#test-opt-skipLint nixos-test-driver-flakelet> All checks passed! Failed to find a machine for remote build! derivation: 6g9khx8r3wz9rmfsy28pnyzviz07vg66-vm-test-run-flakelet.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/6g9khx8r3wz9rmfsy28pnyzviz07vg66-vm-test-run-flakelet.drv' vm-test-run-flakelet> tribuchet: building on eliza vm-test-run-flakelet> Machine state will be reset. To keep it, pass --keep-machine-state vm-test-run-flakelet> start all VLans vm-test-run-flakelet> (finished: start all VLans, in 0.00 seconds) vm-test-run-flakelet> Test will time out and terminate in 3600 seconds vm-test-run-flakelet> run the VM test script vm-test-run-flakelet> machine: waiting for unit multi-user.target vm-test-run-flakelet> machine: waiting for the VM to finish booting vm-test-run-flakelet> machine: starting vm vm-test-run-flakelet> machine # Disk image does not exist, creating the virtualisation disk image... vm-test-run-flakelet> machine: QEMU running (pid 45) vm-test-run-flakelet> machine # Formatting '/build/vm-state-machine/tmp.csiTTdbPZ5', fmt=raw size=1073741824 vm-test-run-flakelet> machine # mke2fs 1.47.4 (6-Mar-2025) vm-test-run-flakelet> machine # Discarding device blocks: 0/262144 done vm-test-run-flakelet> machine # Creating filesystem with 262144 4k blocks and 65536 inodes vm-test-run-flakelet> machine # Filesystem UUID: 73b53e32-2e1f-4de8-ae93-386325cdf32f vm-test-run-flakelet> machine # Superblock backups stored on blocks: vm-test-run-flakelet> machine # 32768, 98304, 163840, 229376 vm-test-run-flakelet> machine # vm-test-run-flakelet> machine # Allocating group tables: 0/8 done vm-test-run-flakelet> machine # Writing inode tables: 0/8 done vm-test-run-flakelet> machine # Creating journal (8192 blocks): done vm-test-run-flakelet> machine # Writing superblocks and filesystem accounting information: 0/8 done vm-test-run-flakelet> machine # vm-test-run-flakelet> machine # Virtualisation disk image created. vm-test-run-flakelet> machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40] vm-test-run-flakelet> machine # [ 0.000000] Linux version 6.18.40 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri Jul 24 14:17:26 UTC 2026 vm-test-run-flakelet> machine # [ 0.000000] KASLR enabled vm-test-run-flakelet> machine # [ 0.000000] random: crng init done vm-test-run-flakelet> machine # [ 0.000000] Machine model: linux,dummy-virt vm-test-run-flakelet> machine # [ 0.000000] efi: UEFI not found. vm-test-run-flakelet> machine # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT vm-test-run-flakelet> machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000013fffffff] vm-test-run-flakelet> machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x13fdeb740-0x13fdeeebf] vm-test-run-flakelet> machine # [ 0.000000] Zone ranges: vm-test-run-flakelet> machine # [ 0.000000] DMA [mem 0x0000000040000000-0x00000000ffffffff] vm-test-run-flakelet> machine # [ 0.000000] DMA32 empty vm-test-run-flakelet> machine # [ 0.000000] Normal [mem 0x0000000100000000-0x000000013fffffff] vm-test-run-flakelet> machine # [ 0.000000] Device empty vm-test-run-flakelet> machine # [ 0.000000] Movable zone start for each node vm-test-run-flakelet> machine # [ 0.000000] Early memory node ranges vm-test-run-flakelet> machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000013fffffff] vm-test-run-flakelet> machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000013fffffff] vm-test-run-flakelet> machine # [ 0.000000] cma: Reserved 32 MiB at 0x00000000fe000000 vm-test-run-flakelet> machine # [ 0.000000] psci: probing for conduit method from DT. vm-test-run-flakelet> machine # [ 0.000000] psci: PSCIv1.3 detected in firmware. vm-test-run-flakelet> machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs vm-test-run-flakelet> machine # [ 0.000000] psci: Trusted OS migration not required vm-test-run-flakelet> machine # [ 0.000000] psci: SMC Calling Convention v1.1 vm-test-run-flakelet> machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) vm-test-run-flakelet> machine # [ 0.000000] percpu: Embedded 76 pages/cpu s186392 r8192 d116712 u311296 vm-test-run-flakelet> machine # [ 0.000000] Detected PIPT I-cache on CPU0 vm-test-run-flakelet> machine # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm) vm-test-run-flakelet> machine # [ 0.000000] CPU features: detected: GICv3 CPU interface vm-test-run-flakelet> machine # [ 0.000000] CPU features: detected: Spectre-v4 vm-test-run-flakelet> machine # [ 0.000000] CPU features: detected: Spectre-BHB vm-test-run-flakelet> machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38 vm-test-run-flakelet> machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23 vm-test-run-flakelet> machine # [ 0.000000] alternatives: applying boot alternatives vm-test-run-flakelet> machine # [ 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/3z6a3hbfvlkx90987w1sw3qzzyh28d1z-nixos-system-machine-test/init regInfo=/nix/store/l223xgms25q3mj5mx1sbf6531qm0xwxz-closure-info/registration console=ttyAMA0,115200n8 console=tty0 vm-test-run-flakelet> machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/l223xgms25q3mj5mx1sbf6531qm0xwxz-closure-info/registration", will be passed to user space. vm-test-run-flakelet> machine # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes vm-test-run-flakelet> machine # [ 0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) vm-test-run-flakelet> machine # [ 0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) vm-test-run-flakelet> machine # [ 0.000000] software IO TLB: area num 4. vm-test-run-flakelet> machine # [ 0.000000] software IO TLB: mapped [mem 0x00000000fa000000-0x00000000fe000000] (64MB) vm-test-run-flakelet> machine # [ 0.000000] Fallback order for Node 0: 0 vm-test-run-flakelet> machine # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1048576 vm-test-run-flakelet> machine # [ 0.000000] Policy zone: Normal vm-test-run-flakelet> machine # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off vm-test-run-flakelet> machine # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 vm-test-run-flakelet> machine # [ 0.000000] allocated 8388608 bytes of page_ext vm-test-run-flakelet> machine # [ 0.000000] ftrace: allocating 74754 entries in 294 pages vm-test-run-flakelet> machine # [ 0.000000] ftrace: allocated 294 pages with 4 groups vm-test-run-flakelet> machine # [ 0.000000] rcu: Hierarchical RCU implementation. vm-test-run-flakelet> machine # [ 0.000000] rcu: RCU event tracing is enabled. vm-test-run-flakelet> machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=4. vm-test-run-flakelet> machine # [ 0.000000] Trampoline variant of Tasks RCU enabled. vm-test-run-flakelet> machine # [ 0.000000] Rude variant of Tasks RCU enabled. vm-test-run-flakelet> machine # [ 0.000000] Tracing variant of Tasks RCU enabled. vm-test-run-flakelet> machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. vm-test-run-flakelet> machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 vm-test-run-flakelet> machine # [ 0.000000] RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. vm-test-run-flakelet> machine # [ 0.000000] RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. vm-test-run-flakelet> machine # [ 0.000000] RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. vm-test-run-flakelet> machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 vm-test-run-flakelet> machine # [ 0.000000] GICv3: 256 SPIs implemented vm-test-run-flakelet> machine # [ 0.000000] GICv3: 0 Extended SPIs implemented vm-test-run-flakelet> machine # [ 0.000000] Root IRQ handler: gic_handle_irq vm-test-run-flakelet> machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI vm-test-run-flakelet> machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0 vm-test-run-flakelet> machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 vm-test-run-flakelet> machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] vm-test-run-flakelet> machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @100b10000 (indirect, esz 8, psz 64K, shr 1) vm-test-run-flakelet> machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @100b20000 (flat, esz 8, psz 64K, shr 1) vm-test-run-flakelet> machine # [ 0.000000] GICv3: using LPI property table @0x0000000100b30000 vm-test-run-flakelet> machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000100b40000 vm-test-run-flakelet> machine # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. vm-test-run-flakelet> machine # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns vm-test-run-flakelet> machine # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt). vm-test-run-flakelet> machine # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns vm-test-run-flakelet> machine # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns vm-test-run-flakelet> machine # [ 0.000030] arm-pv: using stolen time PV vm-test-run-flakelet> machine # [ 0.000415] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) vm-test-run-flakelet> machine # [ 0.000607] Console: colour dummy device 80x25 vm-test-run-flakelet> machine # [ 0.000614] printk: legacy console [tty0] enabled vm-test-run-flakelet> machine # [ 0.000804] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) vm-test-run-flakelet> machine # [ 0.000810] pid_max: default: 32768 minimum: 301 vm-test-run-flakelet> machine # [ 0.000886] LSM: initializing lsm=capability,landlock,yama,bpf,ima vm-test-run-flakelet> machine # [ 0.001033] landlock: Up and running. vm-test-run-flakelet> machine # [ 0.001036] Yama: becoming mindful. vm-test-run-flakelet> machine # [ 0.001470] LSM support for eBPF active vm-test-run-flakelet> machine # [ 0.001602] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-flakelet> machine # [ 0.001659] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-flakelet> machine # [ 0.002938] cacheinfo: Unable to detect cache hierarchy for CPU 0 vm-test-run-flakelet> machine # [ 0.003615] rcu: Hierarchical SRCU implementation. vm-test-run-flakelet> machine # [ 0.003619] rcu: Max phase no-delay instances is 1000. vm-test-run-flakelet> machine # [ 0.003795] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level vm-test-run-flakelet> machine # [ 0.004855] fsl-mc MSI: its@8080000 domain created vm-test-run-flakelet> machine # [ 0.004946] EFI services will not be available. vm-test-run-flakelet> machine # [ 0.005117] smp: Bringing up secondary CPUs ... vm-test-run-flakelet> machine # [ 0.005764] Detected PIPT I-cache on CPU1 vm-test-run-flakelet> machine # [ 0.005862] GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 vm-test-run-flakelet> machine # [ 0.005983] GICv3: CPU1: using allocated LPI pending table @0x0000000100b50000 vm-test-run-flakelet> machine # [ 0.006108] CPU1: Booted secondary processor 0x0000000001 [0xc00fac40] vm-test-run-flakelet> machine # [ 0.007177] Detected PIPT I-cache on CPU2 vm-test-run-flakelet> machine # [ 0.007285] GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 vm-test-run-flakelet> machine # [ 0.007406] GICv3: CPU2: using allocated LPI pending table @0x0000000100b60000 vm-test-run-flakelet> machine # [ 0.007531] CPU2: Booted secondary processor 0x0000000002 [0xc00fac40] vm-test-run-flakelet> machine # [ 0.008606] Detected PIPT I-cache on CPU3 vm-test-run-flakelet> machine # [ 0.008721] GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 vm-test-run-flakelet> machine # [ 0.008842] GICv3: CPU3: using allocated LPI pending table @0x0000000100b70000 vm-test-run-flakelet> machine # [ 0.008967] CPU3: Booted secondary processor 0x0000000003 [0xc00fac40] vm-test-run-flakelet> machine # [ 0.009464] smp: Brought up 1 node, 4 CPUs vm-test-run-flakelet> machine # [ 0.009491] SMP: Total of 4 processors activated. vm-test-run-flakelet> machine # [ 0.009493] CPU: All CPU(s) started at EL1 vm-test-run-flakelet> machine # [ 0.009501] CPU features: detected: Branch Target Identification vm-test-run-flakelet> machine # [ 0.009505] CPU features: detected: ARMv8.4 Translation Table Level vm-test-run-flakelet> machine # [ 0.009508] CPU features: detected: Instruction cache invalidation not required for I/D coherence vm-test-run-flakelet> machine # [ 0.009511] CPU features: detected: Data cache clean to the PoU not required for I/D coherence vm-test-run-flakelet> machine # [ 0.009515] CPU features: detected: Common not Private translations vm-test-run-flakelet> machine # [ 0.009518] CPU features: detected: CRC32 instructions vm-test-run-flakelet> machine # [ 0.009520] CPU features: detected: Data cache clean to Point of Deep Persistence vm-test-run-flakelet> machine # [ 0.009523] CPU features: detected: Data cache clean to Point of Persistence vm-test-run-flakelet> machine # [ 0.009526] CPU features: detected: Data independent timing control (DIT) vm-test-run-flakelet> machine # [ 0.009528] CPU features: detected: E0PD vm-test-run-flakelet> machine # [ 0.009531] CPU features: detected: Enhanced Counter Virtualization vm-test-run-flakelet> machine # [ 0.009534] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) vm-test-run-flakelet> machine # [ 0.009536] CPU features: detected: Enhanced Virtualization Traps vm-test-run-flakelet> machine # [ 0.009539] CPU features: detected: Fine Grained Traps vm-test-run-flakelet> machine # [ 0.009542] CPU features: detected: Generic authentication (architected QARMA5 algorithm) vm-test-run-flakelet> machine # [ 0.009546] CPU features: detected: RCpc load-acquire (LDAPR) vm-test-run-flakelet> machine # [ 0.009548] CPU features: detected: LSE atomic instructions vm-test-run-flakelet> machine # [ 0.009551] CPU features: detected: Privileged Access Never vm-test-run-flakelet> machine # [ 0.009553] CPU features: detected: PMUv3 vm-test-run-flakelet> machine # [ 0.009555] CPU features: detected: RAS Extension Support vm-test-run-flakelet> machine # [ 0.009558] CPU features: detected: RASv1p1 Extension Support vm-test-run-flakelet> machine # [ 0.009560] CPU features: detected: Random Number Generator vm-test-run-flakelet> machine # [ 0.009563] CPU features: detected: Speculation barrier (SB) vm-test-run-flakelet> machine # [ 0.009565] CPU features: detected: Stage-2 Force Write-Back vm-test-run-flakelet> machine # [ 0.009568] CPU features: detected: TLB range maintenance instructions vm-test-run-flakelet> machine # [ 0.009571] CPU features: detected: Speculative Store Bypassing Safe (SSBS) vm-test-run-flakelet> machine # [ 0.009704] alternatives: applying system-wide alternatives vm-test-run-flakelet> machine # [ 0.012681] CPU features: detected: BBM Level 2 without TLB conflict abort vm-test-run-flakelet> machine # [ 0.012979] Memory: 3910044K/4194304K available (24384K kernel code, 7086K rwdata, 26316K rodata, 4736K init, 1102K bss, 233732K reserved, 32768K cma-reserved) vm-test-run-flakelet> machine # [ 0.014256] devtmpfs: initialized vm-test-run-flakelet> machine # [ 0.017871] posixtimers hash table entries: 2048 (order: 3, 32768 bytes, linear) vm-test-run-flakelet> machine # [ 0.017935] futex hash table entries: 1024 (65536 bytes on 1 NUMA nodes, total 64 KiB, linear). vm-test-run-flakelet> machine # [ 0.018129] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL vm-test-run-flakelet> machine # [ 0.018134] 0 pages in range for non-PLT usage vm-test-run-flakelet> machine # [ 0.018135] 508320 pages in range for PLT usage vm-test-run-flakelet> machine # [ 0.018259] pinctrl core: initialized pinctrl subsystem vm-test-run-flakelet> machine # [ 0.019052] DMI not present or invalid. vm-test-run-flakelet> machine # [ 0.022247] NET: Registered PF_NETLINK/PF_ROUTE protocol family vm-test-run-flakelet> machine # [ 0.024542] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations vm-test-run-flakelet> machine # [ 0.024747] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations vm-test-run-flakelet> machine # [ 0.025086] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations vm-test-run-flakelet> machine # [ 0.025112] audit: initializing netlink subsys (disabled) vm-test-run-flakelet> machine # [ 0.025425] audit: type=2000 audit(0.024:1): state=initialized audit_enabled=0 res=1 vm-test-run-flakelet> machine # [ 0.025911] thermal_sys: Registered thermal governor 'fair_share' vm-test-run-flakelet> machine # [ 0.025915] thermal_sys: Registered thermal governor 'bang_bang' vm-test-run-flakelet> machine # [ 0.025919] thermal_sys: Registered thermal governor 'step_wise' vm-test-run-flakelet> machine # [ 0.025922] thermal_sys: Registered thermal governor 'user_space' vm-test-run-flakelet> machine # [ 0.025924] thermal_sys: Registered thermal governor 'power_allocator' vm-test-run-flakelet> machine # [ 0.026016] cpuidle: using governor ladder vm-test-run-flakelet> machine # [ 0.026040] cpuidle: using governor menu vm-test-run-flakelet> machine # [ 0.026234] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers. vm-test-run-flakelet> machine # [ 0.026456] ASID allocator initialised with 65536 entries vm-test-run-flakelet> machine # [ 0.027642] Serial: AMBA PL011 UART driver vm-test-run-flakelet> machine # [ 0.032857] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 vm-test-run-flakelet> machine # [ 0.033148] printk: console [ttyAMA0] enabled vm-test-run-flakelet> machine # [ 0.043312] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages vm-test-run-flakelet> machine # [ 0.043334] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page vm-test-run-flakelet> machine # [ 0.043344] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages vm-test-run-flakelet> machine # [ 0.043352] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page vm-test-run-flakelet> machine # [ 0.043360] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages vm-test-run-flakelet> machine # [ 0.043368] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page vm-test-run-flakelet> machine # [ 0.043376] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages vm-test-run-flakelet> machine # [ 0.043384] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page vm-test-run-flakelet> machine # [ 0.057266] fbcon: Taking over console vm-test-run-flakelet> machine # [ 0.057280] ACPI: Interpreter disabled. vm-test-run-flakelet> machine # [ 0.058249] iommu: Default domain type: Translated vm-test-run-flakelet> machine # [ 0.058258] iommu: DMA domain TLB invalidation policy: strict mode vm-test-run-flakelet> machine # [ 0.071937] SCSI subsystem initialized vm-test-run-flakelet> machine # [ 0.072325] usbcore: registered new interface driver usbfs vm-test-run-flakelet> machine # [ 0.072350] usbcore: registered new interface driver hub vm-test-run-flakelet> machine # [ 0.072366] usbcore: registered new device driver usb vm-test-run-flakelet> machine # [ 0.072658] pps_core: LinuxPPS API ver. 1 registered vm-test-run-flakelet> machine # [ 0.072661] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti vm-test-run-flakelet> machine # [ 0.072670] PTP clock support registered vm-test-run-flakelet> machine # [ 0.072709] EDAC MC: Ver: 3.0.0 vm-test-run-flakelet> machine # [ 0.073062] scmi_core: SCMI protocol bus registered vm-test-run-flakelet> machine # [ 0.073715] FPGA manager framework vm-test-run-flakelet> machine # [ 0.074371] vgaarb: loaded vm-test-run-flakelet> machine # [ 0.074901] clocksource: Switched to clocksource arch_sys_counter vm-test-run-flakelet> machine # [ 0.088459] VFS: Disk quotas dquot_6.6.0 vm-test-run-flakelet> machine # [ 0.088501] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) vm-test-run-flakelet> machine # [ 0.089018] netfs: FS-Cache loaded vm-test-run-flakelet> machine # [ 0.089197] pnp: PnP ACPI: disabled vm-test-run-flakelet> machine # [ 0.097421] NET: Registered PF_INET protocol family vm-test-run-flakelet> machine # [ 0.098195] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) vm-test-run-flakelet> machine # [ 0.134265] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) vm-test-run-flakelet> machine # [ 0.134315] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) vm-test-run-flakelet> machine # [ 0.134349] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) vm-test-run-flakelet> machine # [ 0.134510] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) vm-test-run-flakelet> machine # [ 0.134836] TCP: Hash tables configured (established 32768 bind 32768) vm-test-run-flakelet> machine # [ 0.135146] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear) vm-test-run-flakelet> machine # [ 0.135303] UDP hash table entries: 2048 (order: 5, 131072 bytes, linear) vm-test-run-flakelet> machine # [ 0.135481] UDP-Lite hash table entries: 2048 (order: 5, 131072 bytes, linear) vm-test-run-flakelet> machine # [ 0.135637] NET: Registered PF_UNIX/PF_LOCAL protocol family vm-test-run-flakelet> machine # [ 0.135659] NET: Registered PF_XDP protocol family vm-test-run-flakelet> machine # [ 0.135679] PCI: CLS 0 bytes, default 64 vm-test-run-flakelet> machine # [ 0.135920] Trying to unpack rootfs image as initramfs... vm-test-run-flakelet> machine # [ 0.148141] kvm [1]: HYP mode not available vm-test-run-flakelet> machine # [ 0.205950] Initialise system trusted keyrings vm-test-run-flakelet> machine # [ 0.206359] workingset: timestamp_bits=42 max_order=20 bucket_order=0 vm-test-run-flakelet> machine # [ 0.207072] squashfs: version 4.0 (2009/01/31) Phillip Lougher vm-test-run-flakelet> machine # [ 0.207248] 9p: Installing v9fs 9p2000 file system support vm-test-run-flakelet> machine # [ 0.220001] Key type asymmetric registered vm-test-run-flakelet> machine # [ 0.220006] Asymmetric key parser 'x509' registered vm-test-run-flakelet> machine # [ 0.220052] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) vm-test-run-flakelet> machine # [ 0.220299] io scheduler mq-deadline registered vm-test-run-flakelet> machine # [ 0.220305] io scheduler kyber registered vm-test-run-flakelet> machine # [ 0.227360] pl061_gpio 9030000.pl061: PL061 GPIO chip registered vm-test-run-flakelet> machine # [ 0.231255] ledtrig-cpu: registered to indicate activity on CPUs vm-test-run-flakelet> machine # [ 0.231664] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: vm-test-run-flakelet> machine # [ 0.231679] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 vm-test-run-flakelet> machine # [ 0.231689] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 vm-test-run-flakelet> machine # [ 0.231695] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 vm-test-run-flakelet> machine # [ 0.231714] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits vm-test-run-flakelet> machine # [ 0.231743] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] vm-test-run-flakelet> machine # [ 0.231833] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 vm-test-run-flakelet> machine # [ 0.231841] pci_bus 0000:00: root bus resource [bus 00-ff] vm-test-run-flakelet> machine # [ 0.231854] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] vm-test-run-flakelet> machine # [ 0.231858] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] vm-test-run-flakelet> machine # [ 0.231861] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] vm-test-run-flakelet> machine # [ 0.232179] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.232713] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.232935] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] vm-test-run-flakelet> machine # [ 0.232949] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-flakelet> machine # [ 0.232978] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-flakelet> machine # [ 0.232995] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-flakelet> machine # [ 0.233547] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.233762] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] vm-test-run-flakelet> machine # [ 0.233775] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-flakelet> machine # [ 0.233808] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-flakelet> machine # [ 0.234359] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.234574] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] vm-test-run-flakelet> machine # [ 0.234587] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-flakelet> machine # [ 0.234621] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-flakelet> machine # [ 0.235205] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.235417] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] vm-test-run-flakelet> machine # [ 0.235429] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-flakelet> machine # [ 0.235458] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-flakelet> machine # [ 0.235995] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.236236] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] vm-test-run-flakelet> machine # [ 0.236248] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-flakelet> machine # [ 0.236281] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-flakelet> machine # [ 0.236854] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.237074] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] vm-test-run-flakelet> machine # [ 0.237086] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-flakelet> machine # [ 0.237119] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-flakelet> machine # [ 0.237667] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.237889] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] vm-test-run-flakelet> machine # [ 0.237902] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-flakelet> machine # [ 0.237930] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-flakelet> machine # [ 0.237943] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-flakelet> machine # [ 0.238516] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.238733] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-flakelet> machine # [ 0.238762] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-flakelet> machine # [ 0.239370] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.239606] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-flakelet> machine # [ 0.239638] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-flakelet> machine # [ 0.240102] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.240311] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] vm-test-run-flakelet> machine # [ 0.240598] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.240882] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] vm-test-run-flakelet> machine # [ 0.240896] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-flakelet> machine # [ 0.240929] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-flakelet> machine # [ 0.241472] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.241679] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] vm-test-run-flakelet> machine # [ 0.241693] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-flakelet> machine # [ 0.241722] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-flakelet> machine # [ 0.242364] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned vm-test-run-flakelet> machine # [ 0.242370] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned vm-test-run-flakelet> machine # [ 0.242374] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned vm-test-run-flakelet> machine # [ 0.242425] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned vm-test-run-flakelet> machine # [ 0.242476] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned vm-test-run-flakelet> machine # [ 0.242524] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned vm-test-run-flakelet> machine # [ 0.242570] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned vm-test-run-flakelet> machine # [ 0.242619] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned vm-test-run-flakelet> machine # [ 0.242665] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned vm-test-run-flakelet> machine # [ 0.242712] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned vm-test-run-flakelet> machine # [ 0.242759] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned vm-test-run-flakelet> machine # [ 0.242816] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned vm-test-run-flakelet> machine # [ 0.242879] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned vm-test-run-flakelet> machine # [ 0.242942] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned vm-test-run-flakelet> machine # [ 0.242965] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned vm-test-run-flakelet> machine # [ 0.242988] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned vm-test-run-flakelet> machine # [ 0.243011] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned vm-test-run-flakelet> machine # [ 0.243035] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned vm-test-run-flakelet> machine # [ 0.243058] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned vm-test-run-flakelet> machine # [ 0.243078] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned vm-test-run-flakelet> machine # [ 0.243098] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned vm-test-run-flakelet> machine # [ 0.243117] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned vm-test-run-flakelet> machine # [ 0.243137] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned vm-test-run-flakelet> machine # [ 0.243156] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned vm-test-run-flakelet> machine # [ 0.243181] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned vm-test-run-flakelet> machine # [ 0.243201] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned vm-test-run-flakelet> machine # [ 0.243219] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned vm-test-run-flakelet> machine # [ 0.243239] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned vm-test-run-flakelet> machine # [ 0.243258] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned vm-test-run-flakelet> machine # [ 0.243282] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned vm-test-run-flakelet> machine # [ 0.243304] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned vm-test-run-flakelet> machine # [ 0.243327] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned vm-test-run-flakelet> machine # [ 0.243347] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned vm-test-run-flakelet> machine # [ 0.243367] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned vm-test-run-flakelet> machine # [ 0.243390] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] vm-test-run-flakelet> machine # [ 0.243396] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] vm-test-run-flakelet> machine # [ 0.243399] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] vm-test-run-flakelet> machine # [ 0.244744] pci 0000:00:0a.0: enabling device (0000 -> 0002) vm-test-run-flakelet> machine # [ 0.257531] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) vm-test-run-flakelet> machine # [ 0.260309] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) vm-test-run-flakelet> machine # [ 0.262535] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) vm-test-run-flakelet> machine # [ 0.264841] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) vm-test-run-flakelet> machine # [ 0.267090] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) vm-test-run-flakelet> machine # [ 0.273003] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) vm-test-run-flakelet> machine # [ 0.275534] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) vm-test-run-flakelet> machine # [ 0.277770] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) vm-test-run-flakelet> machine # [ 0.280143] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) vm-test-run-flakelet> machine # [ 0.282214] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) vm-test-run-flakelet> machine # [ 0.288582] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) vm-test-run-flakelet> machine # [ 0.295186] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled vm-test-run-flakelet> machine # [ 0.297293] msm_serial: driver initialized vm-test-run-flakelet> machine # [ 0.297457] SuperH (H)SCI(F) driver initialized vm-test-run-flakelet> machine # [ 0.297520] STM32 USART driver initialized vm-test-run-flakelet> machine # [ 0.323340] loop: module loaded vm-test-run-flakelet> machine # [ 0.323557] virtio_blk virtio5: 4/0/0 default/read/poll queues vm-test-run-flakelet> machine # [ 0.325372] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) vm-test-run-flakelet> machine # [ 0.327736] megasas: 07.734.00.00-rc1 vm-test-run-flakelet> machine # [ 0.328587] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] vm-test-run-flakelet> machine # [ 0.338112] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-flakelet> machine # [ 0.338129] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-flakelet> machine # [ 0.339977] Using buffer write method vm-test-run-flakelet> machine # [ 0.340011] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] vm-test-run-flakelet> machine # [ 0.342008] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-flakelet> machine # [ 0.342024] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-flakelet> machine # [ 0.343886] Using buffer write method vm-test-run-flakelet> machine # [ 0.343902] Concatenating MTD devices: vm-test-run-flakelet> machine # [ 0.343905] (0): "0.flash" vm-test-run-flakelet> machine # [ 0.343908] (1): "0.flash" vm-test-run-flakelet> machine # [ 0.343910] into device "0.flash" vm-test-run-flakelet> machine # [ 0.555324] Freeing initrd memory: 27052K vm-test-run-flakelet> machine # [ 0.579626] tun: Universal TUN/TAP device driver, 1.6 vm-test-run-flakelet> machine # [ 0.590124] thunder_xcv, ver 1.0 vm-test-run-flakelet> machine # [ 0.590268] thunder_bgx, ver 1.0 vm-test-run-flakelet> machine # [ 0.590371] nicpf, ver 1.0 vm-test-run-flakelet> machine # [ 0.592852] e1000: Intel(R) PRO/1000 Network Driver vm-test-run-flakelet> machine # [ 0.592871] e1000: Copyright (c) 1999-2006 Intel Corporation. vm-test-run-flakelet> machine # [ 0.592967] e1000e: Intel(R) PRO/1000 Network Driver vm-test-run-flakelet> machine # [ 0.592983] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. vm-test-run-flakelet> machine # [ 0.593070] igb: Intel(R) Gigabit Ethernet Network Driver vm-test-run-flakelet> machine # [ 0.593080] igb: Copyright (c) 2007-2014 Intel Corporation. vm-test-run-flakelet> machine # [ 0.593188] igbvf: Intel(R) Gigabit Virtual Function Network Driver vm-test-run-flakelet> machine # [ 0.593199] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. vm-test-run-flakelet> machine # [ 0.593720] sky2: driver version 1.30 vm-test-run-flakelet> machine # [ 0.599185] ehci-pci 0000:00:0a.0: EHCI Host Controller vm-test-run-flakelet> machine # [ 0.599217] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 vm-test-run-flakelet> machine # [ 0.599641] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 vm-test-run-flakelet> machine # [ 0.599897] usbcore: registered new interface driver usb-storage vm-test-run-flakelet> machine # [ 0.600536] usbcore: registered new interface driver usbserial_generic vm-test-run-flakelet> machine # [ 0.600604] usbserial: USB Serial support registered for generic vm-test-run-flakelet> machine # [ 0.602969] hv_vmbus: registering driver hyperv_keyboard vm-test-run-flakelet> machine # [ 0.606307] rtc-pl031 9010000.pl031: registered as rtc0 vm-test-run-flakelet> machine # [ 0.606380] rtc-pl031 9010000.pl031: setting system clock to 2026-08-27T21:36:12 UTC (1787866572) vm-test-run-flakelet> machine # [ 0.607619] i2c_dev: i2c /dev entries driver vm-test-run-flakelet> machine # [ 0.611062] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 vm-test-run-flakelet> machine # [ 0.612238] hub 1-0:1.0: USB hub found vm-test-run-flakelet> machine # [ 0.612291] hub 1-0:1.0: 6 ports detected vm-test-run-flakelet> machine # [ 0.616768] sdhci: Secure Digital Host Controller Interface driver vm-test-run-flakelet> machine # [ 0.616780] sdhci: Copyright(c) Pierre Ossman vm-test-run-flakelet> machine # [ 0.617538] Synopsys Designware Multimedia Card Interface Driver vm-test-run-flakelet> machine # [ 0.618582] sdhci-pltfm: SDHCI platform and OF driver helper vm-test-run-flakelet> machine # [ 0.622813] hid: raw HID events driver (C) Jiri Kosina vm-test-run-flakelet> machine # [ 0.623668] usbcore: registered new interface driver usbhid vm-test-run-flakelet> machine # [ 0.623678] usbhid: USB HID core driver vm-test-run-flakelet> machine # [ 0.632036] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available vm-test-run-flakelet> machine # [ 0.636394] drop_monitor: Initializing network drop monitor service vm-test-run-flakelet> machine # [ 0.636685] NET: Registered PF_INET6 protocol family vm-test-run-flakelet> machine # [ 0.638507] Segment Routing with IPv6 vm-test-run-flakelet> machine # [ 0.638538] In-situ OAM (IOAM) with IPv6 vm-test-run-flakelet> machine # [ 0.638653] NET: Registered PF_PACKET protocol family vm-test-run-flakelet> machine # [ 0.638979] 9pnet: Installing 9P2000 support vm-test-run-flakelet> machine # [ 0.644398] Key type dns_resolver registered vm-test-run-flakelet> machine # [ 0.661045] registered taskstats version 1 vm-test-run-flakelet> machine # [ 0.661569] Loading compiled-in X.509 certificates vm-test-run-flakelet> machine # [ 0.681148] Demotion targets for Node 0: null vm-test-run-flakelet> machine # [ 0.681326] Key type .fscrypt registered vm-test-run-flakelet> machine # [ 0.681333] Key type fscrypt-provisioning registered vm-test-run-flakelet> machine # [ 0.681540] ima: No TPM chip found, activating TPM-bypass! vm-test-run-flakelet> machine # [ 0.681562] ima: Allocated hash algorithm: sha1 vm-test-run-flakelet> machine # [ 0.681589] ima: No architecture policies found vm-test-run-flakelet> machine # [ 0.682646] input: gpio-keys as /devices/platform/gpio-keys/input/input0 vm-test-run-flakelet> machine # [ 0.706854] clk: Disabling unused clocks vm-test-run-flakelet> machine # [ 0.706892] PM: genpd: Disabling unused power domains vm-test-run-flakelet> machine # [ 0.711714] Freeing unused kernel memory: 4736K vm-test-run-flakelet> machine # [ 0.711923] Run /init as init process vm-test-run-flakelet> machine # [ 0.740404] systemd[1]: Successfully made /usr/ read-only. vm-test-run-flakelet> machine # [ 0.859028] usb 1-1: new high-speed USB device number 2 using ehci-pci vm-test-run-flakelet> machine # [ 1.011765] 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-flakelet> machine # [ 1.074810] systemd[1]: systemd 261 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -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-flakelet> machine # [ 1.074877] systemd[1]: Detected virtualization qemu. vm-test-run-flakelet> machine # [ 1.074994] systemd[1]: Detected architecture arm64. vm-test-run-flakelet> machine # [ 1.075009] systemd[1]: Running in initrd. vm-test-run-flakelet> machine # [ 1.075830] systemd[1]: Initializing machine ID from random generator. vm-test-run-flakelet> machine # [ 1.076089] systemd[1]: Hostname set to . vm-test-run-flakelet> machine # [ 1.151656] 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-flakelet> machine # [ 1.270994] usb 1-2: new high-speed USB device number 3 using ehci-pci vm-test-run-flakelet> machine # [ 1.286844] systemd[1]: bpf-restrict-fs: LSM BPF program attached vm-test-run-flakelet> machine # [ 1.356041] systemd[1]: Queued start job for default target Initrd Default Target. vm-test-run-flakelet> machine # [ 1.373747] systemd[1]: Created slice Slice /system/modprobe. vm-test-run-flakelet> machine # [ 1.373997] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. vm-test-run-flakelet> machine # [ 1.374030] systemd[1]: Expecting device /dev/disk/by-label/nixos... vm-test-run-flakelet> machine # [ 1.374053] systemd[1]: Reached target Path Units. vm-test-run-flakelet> machine # [ 1.374069] systemd[1]: Reached target Slice Units. vm-test-run-flakelet> machine # [ 1.374086] systemd[1]: Reached target Swaps. vm-test-run-flakelet> machine # [ 1.374102] systemd[1]: Reached target Timer Units. vm-test-run-flakelet> machine # [ 1.374263] systemd[1]: Listening on D-Bus System Message Bus Socket. vm-test-run-flakelet> machine # [ 1.374420] systemd[1]: Listening on Journal Socket (/dev/log). vm-test-run-flakelet> machine # [ 1.374569] systemd[1]: Listening on Journal Sockets. vm-test-run-flakelet> machine # [ 1.374707] systemd[1]: Listening on udev Control Socket. vm-test-run-flakelet> machine # [ 1.374793] systemd[1]: Listening on udev Kernel Socket. vm-test-run-flakelet> machine # [ 1.374812] systemd[1]: Reached target Socket Units. vm-test-run-flakelet> machine # [ 1.376703] systemd[1]: Starting Create List of Static Device Nodes... vm-test-run-flakelet> machine # [ 1.378487] systemd[1]: Starting Load Kernel Module 9pnet_virtio... vm-test-run-flakelet> machine # [ 1.378558] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs vm-test-run-flakelet> machine # [ 1.380231] systemd[1]: Mounting Kernel Configuration File System... vm-test-run-flakelet> machine # [ 1.408202] systemd[1]: Starting Journal Service... vm-test-run-flakelet> machine # [ 1.410218] systemd[1]: Starting Load Kernel Modules... vm-test-run-flakelet> machine # [ 1.410316] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os vm-test-run-flakelet> machine # [ 1.411694] systemd[1]: Starting Coldplug All udev Devices... vm-test-run-flakelet> machine # [ 1.413446] systemd[1]: Finished Create List of Static Device Nodes. vm-test-run-flakelet> machine # [ 1.414391] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 1.414712] systemd[1]: Finished Load Kernel Module 9pnet_virtio. vm-test-run-flakelet> machine # [ 1.419167] systemd[1]: Mounted Kernel Configuration File System. vm-test-run-flakelet> machine # [ 1.424411] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... vm-test-run-flakelet> machine # [ 1.430508] 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-flakelet> machine # [ 1.431023] 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-flakelet> machine # [ 1.455268] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0 vm-test-run-flakelet> machine # [ 1.455434] [drm] features: -virgl +edid -resource_blob -host_visible vm-test-run-flakelet> machine # [ 1.455443] [drm] features: -context_init vm-test-run-flakelet> machine # [ 1.456185] [drm] number of scanouts: 1 vm-test-run-flakelet> machine # [ 1.456203] [drm] number of cap sets: 0 vm-test-run-flakelet> machine # [ 1.459440] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic vm-test-run-flakelet> machine # [ 1.459449] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0 vm-test-run-flakelet> machine # [ 1.462294] Console: switching to colour frame buffer device 160x50 vm-test-run-flakelet> machine # [ 1.468666] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device vm-test-run-flakelet> machine # [ 1.473554] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. vm-test-run-flakelet> machine # [ 1.478539] systemd-journald[96]: Collecting audit messages is disabled. vm-test-run-flakelet> machine # [ 1.479096] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev vm-test-run-flakelet> machine # [ 1.485673] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. vm-test-run-flakelet> machine # [ 1.488365] systemd[1]: Starting Create Static Device Nodes in /dev... vm-test-run-flakelet> machine # [ 1.491834] systemd[1]: Finished Load Kernel Modules. vm-test-run-flakelet> machine # [ 1.511191] systemd[1]: Starting Apply Kernel Variables... vm-test-run-flakelet> machine # [ 1.514342] systemd[1]: Finished Create Static Device Nodes in /dev. vm-test-run-flakelet> machine # [ 1.514687] systemd[1]: Reached target Preparation for Local File Systems. vm-test-run-flakelet> machine # [ 1.515463] systemd[1]: Reached target Local File Systems. vm-test-run-flakelet> machine # [ 1.521917] systemd[1]: Starting Rule-based Manager for Device Events and Files... vm-test-run-flakelet> machine # [ 1.555905] systemd[1]: Started Journal Service. vm-test-run-flakelet> machine # [ 1.554616] systemd-modules-load[97]: Using 4 probe threads vm-test-run-flakelet> machine # [ 1.556930] systemd-modules-load[97]: Module 'virtio_balloon' is built in vm-test-run-flakelet> machine # [ 1.558145] systemd-modules-load[97]: Module 'virtio_console' is built in vm-test-run-flakelet> machine # [ 1.559288] systemd-modules-load[97]: Module 'virtio_rng' is built in vm-test-run-flakelet> machine # [ 1.560423] systemd-modules-load[97]: Inserted module 'dm_mod' vm-test-run-flakelet> machine # [ 1.561415] systemd-modules-load[97]: Inserted module 'virtio_gpu' vm-test-run-flakelet> machine # [ 1.562432] systemd[1]: Starting Create System Files and Directories... vm-test-run-flakelet> machine # [ 1.580456] systemd[1]: Finished Apply Kernel Variables. vm-test-run-flakelet> machine # [ 1.588743] systemd[1]: Finished Create System Files and Directories. vm-test-run-flakelet> machine # [ 1.593887] systemd-udevd[107]: Using default interface naming scheme 'v261'. vm-test-run-flakelet> machine # [ 1.617705] systemd[1]: Started Rule-based Manager for Device Events and Files. vm-test-run-flakelet> machine # [ 1.640878] systemd[1]: Starting Virtual Console Setup... vm-test-run-flakelet> machine # [ 1.697099] systemd-vconsole-setup[131]: Configuration of first virtual console was skipped, ignoring remaining ones. vm-test-run-flakelet> machine # [ 1.700710] systemd[1]: Finished Virtual Console Setup. vm-test-run-flakelet> machine # [ 2.069403] systemd[1]: Finished Coldplug All udev Devices. vm-test-run-flakelet> machine # [ 2.071979] systemd[1]: Reached target System Initialization. vm-test-run-flakelet> machine # [ 2.075753] systemd[1]: Reached target Basic System. vm-test-run-flakelet> machine # [ 2.282870] (udev-worker)[128]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. vm-test-run-flakelet> machine # [ 2.286070] (udev-worker)[128]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-flakelet> machine # [ 2.287637] (udev-worker)[123]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-flakelet> machine # [ 2.314253] systemd[1]: Found device /dev/disk/by-label/nixos. vm-test-run-flakelet> machine # [ 2.319382] systemd[1]: Reached target Initrd Root Device. vm-test-run-flakelet> machine # [ 2.322870] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... vm-test-run-flakelet> machine # [ 2.369199] systemd-fsck[153]: nixos: clean, 12/65536 files, 13019/262144 blocks vm-test-run-flakelet> machine # [ 2.374216] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. vm-test-run-flakelet> machine # [ 2.411633] systemd[1]: Mounting /sysroot... vm-test-run-flakelet> machine # [ 2.456442] EXT4-fs (vda): mounted filesystem 73b53e32-2e1f-4de8-ae93-386325cdf32f r/w with ordered data mode. Quota mode: none. vm-test-run-flakelet> machine # [ 2.458803] systemd[1]: Mounted /sysroot. vm-test-run-flakelet> machine # [ 2.462742] systemd[1]: Reached target Initrd Root File System. vm-test-run-flakelet> machine # [ 2.469156] systemd[1]: Mounting /sysroot/nix/.ro-store... vm-test-run-flakelet> machine # [ 2.484695] systemd[1]: Mounting /sysroot/run... vm-test-run-flakelet> machine # [ 2.485720] systemd[1]: Mounting /sysroot/tmp/shared... vm-test-run-flakelet> machine # [ 2.492368] systemd[1]: Mounting /sysroot/tmp/xchg... vm-test-run-flakelet> machine # [ 2.501247] systemd[1]: Starting Mountpoints Configured in the Real Root... vm-test-run-flakelet> machine # [ 2.507686] systemd-sysroot-fstab-check[165]: /sysroot should be mounted in the initrd, will request daemon-reload. vm-test-run-flakelet> machine # [ 2.520869] systemd[1]: Starting rw-sysroot-nix-store.service... vm-test-run-flakelet> machine # [ 2.527875] systemd[1]: Mounted /sysroot/nix/.ro-store. vm-test-run-flakelet> machine # [ 2.529376] systemd[1]: Mounted /sysroot/run. vm-test-run-flakelet> machine # [ 2.530390] systemd[1]: Reload requested from client PID 165 ('systemd-sysroot') (unit initrd-parse-etc.service)... vm-test-run-flakelet> machine # [ 2.533312] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 2.632065] systemd[1]: Reloading finished in 115 ms. vm-test-run-flakelet> machine # [ 2.688815] systemd-sysroot-fstab-check[165]: Requesting initrd-fs.target/start/replace... vm-test-run-flakelet> machine # [ 2.693446] systemd[1]: Mounted /sysroot/tmp/shared. vm-test-run-flakelet> machine # [ 2.696389] systemd[1]: Mounted /sysroot/tmp/xchg. vm-test-run-flakelet> machine # [ 2.697267] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 2.700118] systemd[1]: Finished rw-sysroot-nix-store.service. vm-test-run-flakelet> machine # [ 2.701043] systemd-sysroot-fstab-check[165]: Requesting swap.target/start/replace... vm-test-run-flakelet> machine # [ 2.708711] systemd[1]: Starting rw-sysroot-nix-store.service... vm-test-run-flakelet> machine # [ 2.711187] systemd[1]: initrd-parse-etc.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 2.715152] systemd[1]: Finished Mountpoints Configured in the Real Root. vm-test-run-flakelet> machine # [ 2.717644] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. vm-test-run-flakelet> machine # [ 2.729617] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 2.731794] systemd[1]: Finished rw-sysroot-nix-store.service. vm-test-run-flakelet> machine # [ 2.962316] (udev-worker)[129]: mtd0ro: Failed to find and pin callout binary "/nix/store/z2nxjmk4666nbka3hgyxlg13prrnvx38-systemd-261/lib/udev/mtd_probe": No such file or directory vm-test-run-flakelet> machine # [ 2.965256] (udev-worker)[129]: mtd0ro: /nix/store/z2nxjmk4666nbka3hgyxlg13prrnvx38-systemd-261/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-flakelet> machine # [ 2.979627] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 2.981658] systemd[1]: Stopped Virtual Console Setup. vm-test-run-flakelet> machine # [ 2.982589] systemd[1]: Stopping Virtual Console Setup... vm-test-run-flakelet> machine # [ 2.984860] systemd[1]: Starting Virtual Console Setup... vm-test-run-flakelet> machine # [ 3.031293] systemd-vconsole-setup[193]: Configuration of first virtual console was skipped, ignoring remaining ones. vm-test-run-flakelet> machine # [ 3.033857] systemd[1]: Finished Virtual Console Setup. vm-test-run-flakelet> machine # [ 3.419745] systemd[1]: Mounting /sysroot/nix/store... vm-test-run-flakelet> machine # [ 3.521047] systemd[1]: Mounted /sysroot/nix/store. vm-test-run-flakelet> machine # [ 3.523691] systemd[1]: Reached target Initrd File Systems. vm-test-run-flakelet> machine # [ 3.527732] systemd[1]: Starting Find NixOS closure... vm-test-run-flakelet> machine # [ 3.532659] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... vm-test-run-flakelet> machine # [ 3.596483] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. vm-test-run-flakelet> machine # [ 3.600267] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.622648] systemd[1]: Finished Find NixOS closure. vm-test-run-flakelet> machine # [ 3.625262] systemd[1]: Reached target Initrd Default Target. vm-test-run-flakelet> machine # [ 3.628483] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... vm-test-run-flakelet> machine # [ 3.693580] systemd[1]: Stopped target Initrd Default Target. vm-test-run-flakelet> machine # [ 3.696432] systemd[1]: Stopped target Basic System. vm-test-run-flakelet> machine # [ 3.698692] systemd[1]: Stopped target Initrd Root Device. vm-test-run-flakelet> machine # [ 3.701370] systemd[1]: Stopped target Path Units. vm-test-run-flakelet> machine # [ 3.703705] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.707320] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. vm-test-run-flakelet> machine # [ 3.710913] systemd[1]: Stopped target Slice Units. vm-test-run-flakelet> machine # [ 3.714370] systemd[1]: Stopped target Socket Units. vm-test-run-flakelet> machine # [ 3.716782] systemd[1]: Stopped target System Initialization. vm-test-run-flakelet> machine # [ 3.719431] systemd[1]: Stopped target Swaps. vm-test-run-flakelet> machine # [ 3.721861] systemd[1]: Stopped target Timer Units. vm-test-run-flakelet> machine # [ 3.724082] systemd[1]: dbus.socket: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.730466] systemd[1]: Closed D-Bus System Message Bus Socket. vm-test-run-flakelet> machine # [ 3.733354] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.736677] systemd[1]: Stopped Find NixOS closure. vm-test-run-flakelet> machine # [ 3.739224] systemd[1]: Starting Load Kernel Module 9pnet_virtio... vm-test-run-flakelet> machine # [ 3.742626] systemd[1]: Starting rw-sysroot-nix-store.service... vm-test-run-flakelet> machine # [ 3.746515] systemd[1]: systemd-sysctl.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.749976] systemd[1]: Stopped Apply Kernel Variables. vm-test-run-flakelet> machine # [ 3.752432] systemd[1]: systemd-modules-load.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.755668] systemd[1]: Stopped Load Kernel Modules. vm-test-run-flakelet> machine # [ 3.758231] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.761660] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. vm-test-run-flakelet> machine # [ 3.764806] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.767414] systemd[1]: Stopped Create System Files and Directories. vm-test-run-flakelet> machine # [ 3.769901] systemd[1]: Stopped target Local File Systems. vm-test-run-flakelet> machine # [ 3.771671] systemd[1]: Stopped target Preparation for Local File Systems. vm-test-run-flakelet> machine # [ 3.773868] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.775936] systemd[1]: Stopped Coldplug All udev Devices. vm-test-run-flakelet> machine # [ 3.777633] systemd[1]: Stopping Rule-based Manager for Device Events and Files... vm-test-run-flakelet> machine # [ 3.779750] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.781932] systemd[1]: Stopped Virtual Console Setup. vm-test-run-flakelet> machine # [ 3.783414] systemd[1]: initrd-cleanup.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.785389] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. vm-test-run-flakelet> machine # [ 3.787013] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.788871] systemd[1]: Finished rw-sysroot-nix-store.service. vm-test-run-flakelet> machine # [ 3.790334] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.791985] systemd[1]: Finished Load Kernel Module 9pnet_virtio. vm-test-run-flakelet> machine # [ 3.793412] systemd[1]: systemd-udevd.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.794879] systemd[1]: Stopped Rule-based Manager for Device Events and Files. vm-test-run-flakelet> machine # [ 3.796542] systemd[1]: systemd-udevd.service: Consumed 2.694s CPU time over 2.267s wall clock time, 32M memory peak. vm-test-run-flakelet> machine # [ 3.798753] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.800302] systemd[1]: Closed udev Control Socket. vm-test-run-flakelet> machine # [ 3.801465] systemd[1]: Starting Cleanup udev Database... vm-test-run-flakelet> machine # [ 3.802565] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.804319] systemd[1]: Stopped Create Static Device Nodes in /dev. vm-test-run-flakelet> machine # [ 3.805626] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.807288] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. vm-test-run-flakelet> machine # [ 3.808923] systemd[1]: kmod-static-nodes.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.810339] systemd[1]: Stopped Create List of Static Device Nodes. vm-test-run-flakelet> machine # [ 3.909256] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.912924] systemd[1]: Finished Cleanup udev Database. vm-test-run-flakelet> machine # [ 3.915478] systemd[1]: Reached target Switch Root. vm-test-run-flakelet> machine # [ 3.919383] systemd[1]: Starting NixOS Activation... vm-test-run-flakelet> machine # [ 4.266637] initrd-nixos-activation-start[218]: booting system configuration /nix/store/3z6a3hbfvlkx90987w1sw3qzzyh28d1z-nixos-system-machine-test vm-test-run-flakelet> machine # [ 4.440258] initrd-nixos-activation-start[218]: running activation script... vm-test-run-flakelet> machine # [ 5.146364] initrd-nixos-activation-start[241]: setting up /etc... vm-test-run-flakelet> machine # [ 5.673568] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 5.677424] systemd[1]: Finished NixOS Activation. vm-test-run-flakelet> machine # [ 5.681872] systemd[1]: Starting Switch Root... vm-test-run-flakelet> machine # [ 5.757662] systemd[1]: Switching root. vm-test-run-flakelet> machine # [ 5.913921] systemd-journald[96]: Received SIGTERM from PID 1 (systemd). vm-test-run-flakelet> machine # [ 6.617632] systemd[1]: systemd 261 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -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-flakelet> machine # [ 6.617774] systemd[1]: Detected virtualization qemu. vm-test-run-flakelet> machine # [ 6.617863] systemd[1]: Detected architecture arm64. vm-test-run-flakelet> machine # [ 6.618047] systemd[1]: Detected first boot. vm-test-run-flakelet> machine # [ 6.625137] systemd[1]: Initializing machine ID from random generator. vm-test-run-flakelet> machine # [ 6.842784] systemd[1]: bpf-restrict-fs: LSM BPF program attached vm-test-run-flakelet> machine # [ 6.994045] systemd[1]: Applying preset policy. vm-test-run-flakelet> machine # [ 7.516697] systemd[1]: Populated /etc with preset unit settings. vm-test-run-flakelet> machine # [ 8.046815] systemd[1]: initrd-switch-root.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 8.051572] systemd[1]: Stopped initrd-switch-root.service. vm-test-run-flakelet> machine # [ 8.056221] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. vm-test-run-flakelet> machine # [ 8.061519] systemd[1]: Created slice Slice /system/getty. vm-test-run-flakelet> machine # [ 8.065126] systemd[1]: Created slice User and Session Slice. vm-test-run-flakelet> machine # [ 8.066633] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. vm-test-run-flakelet> machine # [ 8.068256] systemd[1]: Started Forward Password Requests to Wall Directory Watch. vm-test-run-flakelet> machine # [ 8.069423] systemd[1]: Expecting device /dev/hvc0... vm-test-run-flakelet> machine # [ 8.070520] systemd[1]: Expecting device /dev/ttyAMA0... vm-test-run-flakelet> machine # [ 8.071965] systemd[1]: Reached target Local Encrypted Volumes. vm-test-run-flakelet> machine # [ 8.073103] systemd[1]: Reached target flakelet contract providers ready. vm-test-run-flakelet> machine # [ 8.074219] systemd[1]: Stopped target initrd-fs.target. vm-test-run-flakelet> machine # [ 8.075326] systemd[1]: Stopped target initrd-root-fs.target. vm-test-run-flakelet> machine # [ 8.076412] systemd[1]: Stopped target initrd-switch-root.target. vm-test-run-flakelet> machine # [ 8.077483] systemd[1]: Reached target Virtual Machines and Containers. vm-test-run-flakelet> machine # [ 8.078567] systemd[1]: Reached target Path Units. vm-test-run-flakelet> machine # [ 8.079648] systemd[1]: Reached target Remote File Systems. vm-test-run-flakelet> machine # [ 8.080730] systemd[1]: Reached target Slice Units. vm-test-run-flakelet> machine # [ 8.081774] systemd[1]: Reached target Swaps. vm-test-run-flakelet> machine # [ 8.092506] systemd[1]: Listening on Query the User Interactively for a Password. vm-test-run-flakelet> machine # [ 8.099846] systemd[1]: Listening on Process Core Dump Socket. vm-test-run-flakelet> machine # [ 8.105286] systemd[1]: Listening on Credential Encryption/Decryption. vm-test-run-flakelet> machine # [ 8.110879] systemd[1]: Listening on Factory Reset Management. vm-test-run-flakelet> machine # [ 8.112420] systemd[1]: Listening on Hostname Service Socket. vm-test-run-flakelet> machine # [ 8.121724] systemd[1]: Starting Journal Log Access Socket... vm-test-run-flakelet> machine # [ 8.123970] systemd[1]: Listening on Journal Audit Socket. vm-test-run-flakelet> machine # [ 8.129730] systemd[1]: Listening on Console Output Muting Service Socket. vm-test-run-flakelet> machine # [ 8.131371] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. vm-test-run-flakelet> machine # [ 8.132506] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os vm-test-run-flakelet> machine # [ 8.133439] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki vm-test-run-flakelet> machine # [ 8.150345] systemd[1]: Listening on Disk Repartitioning Service Socket. vm-test-run-flakelet> machine # [ 8.151374] systemd[1]: Listening on udev Control Socket. vm-test-run-flakelet> machine # [ 8.152224] systemd[1]: Listening on udev Varlink Socket. vm-test-run-flakelet> machine # [ 8.158065] systemd[1]: Mounting Huge Pages File System... vm-test-run-flakelet> machine # [ 8.163868] systemd[1]: Mounting POSIX Message Queue File System... vm-test-run-flakelet> machine # [ 8.171109] systemd[1]: Mounting Kernel Debug File System... vm-test-run-flakelet> machine # [ 8.186909] systemd[1]: Mounting Kernel Trace File System... vm-test-run-flakelet> machine # [ 8.197380] systemd[1]: Starting Create List of Static Device Nodes... vm-test-run-flakelet> machine # [ 8.206214] systemd[1]: Starting Load Kernel Module 9pnet_virtio... vm-test-run-flakelet> machine # [ 8.207427] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs vm-test-run-flakelet> machine # [ 8.257987] systemd[1]: Mounting Kernel Configuration File System... vm-test-run-flakelet> machine # [ 8.259306] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm vm-test-run-flakelet> machine # [ 8.260515] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore vm-test-run-flakelet> machine # [ 8.301728] systemd[1]: Starting Load Kernel Module fuse... vm-test-run-flakelet> machine # [ 8.302999] 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-flakelet> machine # [ 8.325335] systemd[1]: Starting Journal Service... vm-test-run-flakelet> machine # [ 8.331909] systemd[1]: Starting Load Kernel Modules... vm-test-run-flakelet> machine # [ 8.340690] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... vm-test-run-flakelet> machine # [ 8.354619] systemd[1]: Starting Remount Root and Kernel File Systems... vm-test-run-flakelet> machine # [ 8.355311] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os vm-test-run-flakelet> machine # [ 8.369842] systemd[1]: Starting Coldplug All udev Devices... vm-test-run-flakelet> machine # [ 8.376599] systemd[1]: Listening on Journal Log Access Socket. vm-test-run-flakelet> machine # [ 8.377785] systemd[1]: Mounted Huge Pages File System. vm-test-run-flakelet> machine # [ 8.378967] systemd[1]: Mounted POSIX Message Queue File System. vm-test-run-flakelet> machine # [ 8.380073] systemd[1]: Mounted Kernel Debug File System. vm-test-run-flakelet> machine # [ 8.381143] systemd[1]: Mounted Kernel Trace File System. vm-test-run-flakelet> machine # [ 8.383239] systemd[1]: Finished Create List of Static Device Nodes. vm-test-run-flakelet> machine # [ 8.384799] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 8.386741] systemd[1]: Finished Load Kernel Module 9pnet_virtio. vm-test-run-flakelet> machine # [ 8.387999] systemd[1]: Mounted Kernel Configuration File System. vm-test-run-flakelet> machine # [ 8.394329] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... vm-test-run-flakelet> machine # [ 8.396403] fuse: init (API version 7.45) vm-test-run-flakelet> machine # [ 8.402421] systemd[1]: modprobe@fuse.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 8.404578] systemd[1]: Finished Load Kernel Module fuse. vm-test-run-flakelet> machine # [ 8.412237] systemd[1]: Mounting FUSE Control File System... vm-test-run-flakelet> machine # [ 8.421779] systemd-journald[312]: Collecting audit messages is enabled. vm-test-run-flakelet> machine # [ 8.439190] systemd[1]: Queued start job for default target Multi-User System. vm-test-run-flakelet> machine # [ 8.442133] systemd[1]: Started Journal Service. vm-test-run-flakelet> machine # [ 8.443210] systemd[1]: systemd-journald.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 8.448880] systemd-modules-load[313]: Using 2 probe threads vm-test-run-flakelet> machine # [ 8.451398] systemd-modules-load[313]: Module 'atkbd' is built in vm-test-run-flakelet> machine # [ 8.455649] systemd-modules-load[313]: Module 'loop' is built in vm-test-run-flakelet> machine # [ 8.459041] systemd[1]: Finished Load Kernel Modules.[ 8.463112] EXT4-fs (vda): re-mounted 73b53e32-2e1f-4de8-ae93-386325cdf32f. vm-test-run-flakelet> machine # vm-test-run-flakelet> machine # [ 8.468789] systemd[1]: Starting Firewall... vm-test-run-flakelet> machine # [ 8.471936] systemd-oomd[315]: No swap; memory pressure usage will be degraded vm-test-run-flakelet> machine # [ 8.479555] systemd[1]: Starting Apply Kernel Variables... vm-test-run-flakelet> machine # [ 8.483724] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. vm-test-run-flakelet> machine # [ 8.488856] systemd[1]: Finished Remount Root and Kernel File Systems. vm-test-run-flakelet> machine # [ 8.495182] systemd[1]: Mounted FUSE Control File System. vm-test-run-flakelet> machine # [ 8.498975] systemd[1]: Listening on Disk Image Download Service Socket. vm-test-run-flakelet> machine # [ 8.512179] systemd[1]: Starting Flush Journal to Persistent Storage... vm-test-run-flakelet> machine # [ 8.513896] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore vm-test-run-flakelet> machine # [ 8.521880] systemd[1]: Starting Load/Save OS Random Seed... vm-test-run-flakelet> machine # [ 8.524183] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os vm-test-run-flakelet> machine # [ 8.537486] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. vm-test-run-flakelet> machine # [ 8.548710] systemd[1]: Starting Create Static Device Nodes in /dev... vm-test-run-flakelet> machine # [ 8.577603] systemd-journald[312]: Received client request to flush runtime journal. vm-test-run-flakelet> machine # [ 8.609592] systemd[1]: Finished Load/Save OS Random Seed. vm-test-run-flakelet> machine # [ 8.612996] systemd[1]: Reached target First Boot Complete. vm-test-run-flakelet> machine # [ 8.615438] systemd[1]: Finished Apply Kernel Variables. vm-test-run-flakelet> machine # [ 8.617681] systemd[1]: Finished Flush Journal to Persistent Storage. vm-test-run-flakelet> machine # [ 8.631099] systemd[1]: Finished Create Static Device Nodes in /dev. vm-test-run-flakelet> machine # [ 8.632511] systemd[1]: Reached target Preparation for Local File Systems. vm-test-run-flakelet> machine # [ 8.635870] systemd[1]: Starting Rule-based Manager for Device Events and Files... vm-test-run-flakelet> machine # [ 8.743359] systemd-udevd[355]: Using default interface naming scheme 'v261'. vm-test-run-flakelet> machine # [ 8.850238] systemd[1]: Started Rule-based Manager for Device Events and Files. vm-test-run-flakelet> machine # [ 9.051936] systemd[1]: Mounting /run/wrappers... vm-test-run-flakelet> machine # [ 9.108044] systemd[1]: Finished Coldplug All udev Devices. vm-test-run-flakelet> machine # [ 9.113718] systemd[1]: Mounted /run/wrappers. vm-test-run-flakelet> machine # [ 9.115213] systemd[1]: Reached target Local File Systems. vm-test-run-flakelet> machine # [ 9.117823] systemd[1]: Listening on Boot Loader Control Service Socket. vm-test-run-flakelet> machine # [ 9.121167] systemd[1]: Starting register-nix-paths.service... vm-test-run-flakelet> machine # [ 9.125930] systemd[1]: Starting Create SUID/SGID Wrappers... vm-test-run-flakelet> machine # [ 9.127927] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. vm-test-run-flakelet> machine # [ 9.142619] systemd[1]: Starting Save Transient machine-id to Disk... vm-test-run-flakelet> machine # [ 9.154597] systemd[1]: Starting Create System Files and Directories... vm-test-run-flakelet> machine # [ 9.163308] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs vm-test-run-flakelet> machine # [ 9.221137] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. vm-test-run-flakelet> machine # [ 9.225517] systemd[1]: Finished Save Transient machine-id to Disk. vm-test-run-flakelet> machine # [ 9.245350] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. vm-test-run-flakelet> machine # [ 9.270868] systemd[1]: Finished Create System Files and Directories. vm-test-run-flakelet> machine # [ 9.291991] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. vm-test-run-flakelet> machine # [ 9.297228] systemd[1]: Starting Rebuild Journal Catalog... vm-test-run-flakelet> machine # [ 9.303658] systemd[1]: Starting Record System Boot/Shutdown in UTMP... vm-test-run-flakelet> machine # [ 9.365472] systemd[1]: Finished Record System Boot/Shutdown in UTMP. vm-test-run-flakelet> machine # [ 9.370009] (udev-worker)[431]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-flakelet> machine # [ 9.384043] (udev-worker)[437]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. vm-test-run-flakelet> machine # [ 9.391682] (udev-worker)[437]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-flakelet> machine # [ 9.411848] systemd[1]: Finished Rebuild Journal Catalog. vm-test-run-flakelet> machine # [ 9.426056] systemd[1]: Starting Update is Completed... vm-test-run-flakelet> machine # [ 9.450032] systemd[1]: Condition check resulted in Virtio network device being skipped.[ 9.456344] mousedev: PS/2 mouse device common for all mice vm-test-run-flakelet> machine # vm-test-run-flakelet> machine # [ 9.458631] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore vm-test-run-flakelet> machine # [ 9.461795] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. vm-test-run-flakelet> machine # [ 9.465885] 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-flakelet> machine # [ 9.472728] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore vm-test-run-flakelet> machine # [ 9.475688] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os vm-test-run-flakelet> machine # [ 9.478910] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os vm-test-run-flakelet> machine # [ 9.483865] systemd[1]: Finished Update is Completed. vm-test-run-flakelet> machine # [ 9.686888] systemd[1]: Finished Firewall. vm-test-run-flakelet> machine # [ 9.759555] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 9.761097] systemd[1]: Finished Create SUID/SGID Wrappers. vm-test-run-flakelet> machine # [ 9.967222] systemd[1]: Finished register-nix-paths.service. vm-test-run-flakelet> machine # [ 9.968383] systemd[1]: Reached target System Initialization. vm-test-run-flakelet> machine # [ 9.969346] systemd[1]: Started Discard unused filesystem blocks once a week. vm-test-run-flakelet> machine # [ 9.970630] systemd[1]: Started Daily Cleanup of Temporary Directories. vm-test-run-flakelet> machine # [ 9.971655] systemd[1]: Reached target Timer Units. vm-test-run-flakelet> machine # [ 9.974074] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input3 vm-test-run-flakelet> machine # [ 9.975552] systemd[1]: Listening on D-Bus System Message Bus Socket. vm-test-run-flakelet> machine # [ 9.977231] systemd[1]: Listening on Nix Daemon Socket. vm-test-run-flakelet> machine # [ 9.978121] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. vm-test-run-flakelet> machine # [ 9.979359] systemd[1]: Reached target Socket Units. vm-test-run-flakelet> machine # [ 9.980814] systemd[1]: Reached target Basic System. vm-test-run-flakelet> machine # [ 9.981610] systemd[1]: Started backdoor.service. vm-test-run-flakelet> machine # [ 9.984304] systemd[1]: Starting Re-link flakelet services at boot... vm-test-run-flakelet> machine # [ 9.990452] systemd[1]: Starting Import lastlog data into lastlog2 database... vm-test-run-flakelet> machine # [ 10.010657] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-flakelet> machine # [ 10.015941] systemd[1]: Starting Post-Boot Actions... vm-test-run-flakelet> machine # [ 10.024492] systemd[1]: Started Reset console on configuration changes. vm-test-run-flakelet> machine # [ 10.029674] systemd[1]: Starting resolvconf update... vm-test-run-flakelet> machine # [ 10.038776] systemd[1]: Starting D-Bus System Message Bus... vm-test-run-flakelet> machine # [ 10.086045] systemd[1]: Finished Re-link flakelet services at boot. vm-test-run-flakelet> machine # [ 10.094659] systemd[1]: Starting Reconcile flakelet services with the host configuration... vm-test-run-flakelet> machine # connecting to host... vm-test-run-flakelet> machine # [ 10.108193] systemd[1]: Finished Post-Boot Actions. vm-test-run-flakelet> machine # [ 10.115824] nsncd[561]: Aug 27 21:36:22.008 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-flakelet> machine # [ 10.123032] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-flakelet> machine # [ 10.125886] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-flakelet> machine # [ 10.128552] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-flakelet> machine # [ 10.131411] systemd[1]: Starting User Login Management... vm-test-run-flakelet> machine # [ 10.135463] systemd[1]: Finished Import lastlog data into lastlog2 database. vm-test-run-flakelet> machine: Guest shell says: b'Spawning backdoor root shell...\n' vm-test-run-flakelet> machine: connected to guest root shell vm-test-run-flakelet> machine # [ 10.167655] systemd[1]: Starting Virtual Console Setup... vm-test-run-flakelet> machine: (connecting took 10.57 seconds) vm-test-run-flakelet> machine: (finished: waiting for the VM to finish booting, in 11.01 seconds) vm-test-run-flakelet> machine # [ 10.169219] systemd[1]: Finished Reconcile flakelet services with the host configuration. vm-test-run-flakelet> machine # [ 10.178911] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 10.181825] systemd[1]: Stopped Virtual Console Setup. vm-test-run-flakelet> machine # [ 10.185611] dbus-broker-launch[566]: Looking up NSS user entry for 'systemd-timesync'... vm-test-run-flakelet> machine # [ 10.189792] systemd[1]: Starting Virtual Console Setup... vm-test-run-flakelet> machine # [ 10.206629] dbus-broker-launch[566]: NSS returned no entry for 'systemd-timesync' vm-test-run-flakelet> machine # [ 10.208336] dbus-broker-launch[566]: Invalid user-name in /nix/store/sbvrn27fh8lph538cmhifxdccdxf3njq-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" vm-test-run-flakelet> machine # [ 10.241273] systemd-logind[591]: New seat seat0. vm-test-run-flakelet> machine # [ 10.247793] systemd-logind[591]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) vm-test-run-flakelet> machine # [ 10.253396] systemd-logind[591]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) vm-test-run-flakelet> machine # [ 10.258663] systemd-logind[591]: Watching system buttons on /dev/input/event0 (gpio-keys) vm-test-run-flakelet> machine # [ 10.264323] dbus-broker-launch[566]: Ready vm-test-run-flakelet> machine # [ 10.302447] systemd[1]: Started D-Bus System Message Bus. vm-test-run-flakelet> machine # [ 10.305896] systemd[1]: Started User Login Management. vm-test-run-flakelet> machine # [ 10.308194] systemd[1]: Stopped target Host and Network Name Lookups. vm-test-run-flakelet> machine # [ 10.312749] systemd[1]: Stopping Host and Network Name Lookups... vm-test-run-flakelet> machine # [ 10.317941] systemd[1]: Stopped target User and Group Name Lookups. vm-test-run-flakelet> machine # [ 10.321506] systemd[1]: Stopping User and Group Name Lookups... vm-test-run-flakelet> machine # [ 10.324642] systemd[1]: Starting linger-users.service... vm-test-run-flakelet> machine # [ 10.328313] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... vm-test-run-flakelet> machine # [ 10.331927] systemd[1]: nscd.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 10.337001] systemd[1]: Stopped Name Service Cache Daemon (nsncd). vm-test-run-flakelet> machine # [ 10.346722] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-flakelet> machine # [ 10.350568] systemd[1]: Finished resolvconf update. vm-test-run-flakelet> machine # [ 10.356726] systemd[1]: Reached target Preparation for Network. vm-test-run-flakelet> machine # [ 10.363584] systemd[1]: Starting DHCP Client... vm-test-run-flakelet> machine # [ 10.373242] systemd[1]: Starting Address configuration of eth1... vm-test-run-flakelet> machine # [ 10.381495] systemd[1]: Starting Extra networking commands.... vm-test-run-flakelet> machine # [ 10.384470] systemd[1]: linger-users.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 10.388514] systemd[1]: Finished linger-users.service. vm-test-run-flakelet> machine # [ 10.408169] nsncd[667]: Aug 27 21:36:22.303 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-flakelet> machine # [ 10.415639] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-flakelet> machine # [ 10.418715] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-flakelet> machine # [ 10.421740] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-flakelet> machine # [ 10.467380] network-addresses-eth1-start[671]: adding address 192.168.1.1/24... done vm-test-run-flakelet> machine # [ 10.484200] network-addresses-eth1-start[671]: adding address 2001:db8:1::1/64... done vm-test-run-flakelet> machine # [ 10.501342] systemd[1]: Finished Address configuration of eth1. vm-test-run-flakelet> machine # [ 10.525617] dhcpcd[689]: dhcpcd-10.3.2 starting vm-test-run-flakelet> machine # [ 10.535925] dhcpcd[735]: dev: loaded udev vm-test-run-flakelet> machine # [ 10.570610] 8021q: 802.1Q VLAN Support v1.8 vm-test-run-flakelet> machine # [ 10.571285] 8021q: adding VLAN 0 to HW filter on device eth1 vm-test-run-flakelet> machine # [ 10.572217] systemd[1]: Finished Extra networking commands.. vm-test-run-flakelet> machine # [ 10.574129] systemd[1]: Reached target Network. vm-test-run-flakelet> machine # [ 10.577181] systemd[1]: Starting Permit User Sessions... vm-test-run-flakelet> machine # [ 10.582351] systemd[1]: Starting Update flakelet service static... vm-test-run-flakelet> machine # [ 10.587576] systemd[1]: Starting Update flakelet service web... vm-test-run-flakelet> machine # [ 10.606183] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. vm-test-run-flakelet> machine # [ 10.630714] systemd[1]: Finished Permit User Sessions. vm-test-run-flakelet> machine # [ 10.636497] systemd[1]: Started Getty on tty1. vm-test-run-flakelet> machine # [ 10.638145] flakelet[752]: web: resolving path:/nix/store/9343bpka3d3qdvzj7xibb5rkb3z5phs6-flake.nix vm-test-run-flakelet> machine # [ 10.640263] flakelet[751]: static: using prebuilt artifact /nix/store/0xzyvfvb219zadpvnmd7vh97axdmxxc2-flakelet-static[ 10.644197] cfg80211: Loading compiled-in X.509 certificates for regulatory database vm-test-run-flakelet> machine # vm-test-run-flakelet> machine # [ 10.651950] systemd[1]: Reached target Login Prompts. vm-test-run-flakelet> machine # [ 10.656122] flakelet[751]: static: activating generation 1 vm-test-run-flakelet> machine # [ 10.659871] systemd[1]: Reload requested from client PID 757 ('systemctl') (unit flakelet-static.service)... vm-test-run-flakelet> machine # [ 10.666510] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 10.680848] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' vm-test-run-flakelet> machine # [ 10.685441] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' vm-test-run-flakelet> machine # [ 10.693033] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 vm-test-run-flakelet> machine # [ 10.693373] cfg80211: failed to load regulatory.db vm-test-run-flakelet> machine # [ 10.741503] systemd-vconsole-setup[624]: Configuration of first virtual console was skipped, ignoring remaining ones. vm-test-run-flakelet> machine # [ 10.788040] 8021q: adding VLAN 0 to HW filter on device eth0 vm-test-run-flakelet> machine # [ 10.786604] dhcpcd[735]: eth0: waiting for carrier vm-test-run-flakelet> machine # [ 10.790183] dhcpcd[735]: eth0: carrier acquired vm-test-run-flakelet> machine # [ 10.801786] dhcpcd[735]: DUID 00:01:00:01:32:23:6a:56:52:54:00:12:34:56 vm-test-run-flakelet> machine # [ 10.803304] dhcpcd[735]: eth0: IAID 00:12:34:56 vm-test-run-flakelet> machine # [ 10.804348] dhcpcd[735]: eth0: adding address fe80::5054:ff:fe12:3456 vm-test-run-flakelet> machine # [ 11.024731] dhcpcd[735]: eth0: soliciting a DHCP lease vm-test-run-flakelet> machine # [ 11.045187] dhcpcd[735]: eth0: offered 10.0.2.15 from 10.0.2.2 vm-test-run-flakelet> machine # [ 11.060479] dhcpcd[735]: eth0: probing address 10.0.2.15/24 vm-test-run-flakelet> machine # [ 11.271541] systemd[1]: Reloading finished in 608 ms. vm-test-run-flakelet> machine # [ 11.332005] systemd[1]: Finished Virtual Console Setup. vm-test-run-flakelet> machine # [ 11.352260] systemd[1]: Started Nix Daemon. vm-test-run-flakelet> machine # [ 11.367123] systemd[1]: Reload requested from client PID 809 ('systemctl') (unit flakelet-static.service)... vm-test-run-flakelet> machine # [ 11.377395] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 11.741846] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/static.service target /nix/store/8kxd89lpnhxjfiqmhsryf1l6vfb75fgn-static.service has different name vm-test-run-flakelet> machine # [ 12.012742] systemd[1]: Reloading finished in 643 ms. vm-test-run-flakelet> machine # [ 12.236375] nix-daemon[810]: accepted connection from pid 755, user flakelet vm-test-run-flakelet> machine # [ 12.242625] systemd[1]: Starting prebuilt flakelet service static... vm-test-run-flakelet> machine # [ 12.296294] systemd[1]: Started prebuilt flakelet service static. vm-test-run-flakelet> machine # [ 12.331082] flakelet[751]: static: updated to generation 1 vm-test-run-flakelet> machine # [ 12.334457] systemd[1]: Finished Update flakelet service static. vm-test-run-flakelet> machine # [ 12.446734] flakelet[752]: web: evaluating /nix/store/qy9sv455frvjvnd42j5lv67z58nry8w8-flakelet-driver.nix vm-test-run-flakelet> machine # [ 12.562022] nix-daemon[810]: accepted connection from pid 875, user flakelet vm-test-run-flakelet> machine # [ 12.669952] dhcpcd[735]: eth0: soliciting an IPv6 router vm-test-run-flakelet> machine # [ 12.672733] dhcpcd[735]: eth0: Router Advertisement from fe80::2 vm-test-run-flakelet> machine # [ 12.675418] dhcpcd[735]: eth0: adding address fec0::5054:ff:fe12:3456/64 vm-test-run-flakelet> machine # [ 12.678505] dhcpcd[735]: eth0: adding route to fec0::/64 vm-test-run-flakelet> machine # [ 12.681135] dhcpcd[735]: eth0: adding default route via fe80::2 vm-test-run-flakelet> machine # [ 16.161284] dhcpcd[735]: eth0: leased 10.0.2.15 for 86400 seconds vm-test-run-flakelet> machine # [ 16.161601] dhcpcd[735]: eth0: adding route to 10.0.2.0/24 vm-test-run-flakelet> machine # [ 16.161735] dhcpcd[735]: eth0: adding default route via 10.0.2.2 vm-test-run-flakelet> machine # [ 16.399232] systemd[1]: Started DHCP Client. vm-test-run-flakelet> machine # [ 20.684936] flakelet[752]: web: building /nix/store/wvrlslpbdc5y623n07sf3y5xlb1lyh3j-flakelet-web.drv vm-test-run-flakelet> machine # [ 22.103303] nix-daemon[810]: accepted connection from pid 1123, user flakelet vm-test-run-flakelet> machine # [ 22.141621] flakelet[752]: web: activating generation 1 vm-test-run-flakelet> machine # [ 22.159114] systemd[1]: Reload requested from client PID 1131 ('systemctl') (unit flakelet-web.service)... vm-test-run-flakelet> machine # [ 22.164469] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 22.563016] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/static.service target /nix/store/8kxd89lpnhxjfiqmhsryf1l6vfb75fgn-static.service has different name vm-test-run-flakelet> machine # [ 22.815785] systemd[1]: Reloading finished in 654 ms. vm-test-run-flakelet> machine # [ 22.989278] systemd[1]: Reload requested from client PID 1170 ('systemctl') (unit flakelet-web.service)... vm-test-run-flakelet> machine # [ 22.994716] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 23.336434] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/static.service target /nix/store/8kxd89lpnhxjfiqmhsryf1l6vfb75fgn-static.service has different name vm-test-run-flakelet> machine # [ 23.353480] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/web.service target /nix/store/c4cqrlnh27rmc82w9p3vlxql7qvvha6s-web.service has different name vm-test-run-flakelet> machine # [ 23.547635] systemd[1]: Reloading finished in 556 ms. vm-test-run-flakelet> machine # [ 23.663819] systemd[1]: Starting flakelet test service... vm-test-run-flakelet> machine # [ 23.738565] systemd[1]: Started flakelet test service. vm-test-run-flakelet> machine # [ 23.794086] flakelet[752]: web: updated to generation 1 vm-test-run-flakelet> machine # [ 23.798516] systemd[1]: Finished Update flakelet service web. vm-test-run-flakelet> machine # [ 23.801091] systemd[1]: Reached target flakelet managed services. vm-test-run-flakelet> machine # [ 23.803630] systemd[1]: Reached target Multi-User System. vm-test-run-flakelet> machine # [ 23.806112] systemd[1]: Startup finished in 715ms (kernel) + 5.345s (initrd) + 17.738s (userspace) = 23.800s. vm-test-run-flakelet> machine: (finished: waiting for unit multi-user.target, in 25.65 seconds) vm-test-run-flakelet> machine: must succeed: systemctl start flakelet-web.service vm-test-run-flakelet> machine: (finished: must succeed: systemctl start flakelet-web.service, in 0.07 seconds) vm-test-run-flakelet> machine: must succeed: systemctl is-active web.service vm-test-run-flakelet> machine: (finished: must succeed: systemctl is-active web.service, in 0.04 seconds) vm-test-run-flakelet> machine: must succeed: systemctl show web.service -p Environment | grep -q GREETING=hello vm-test-run-flakelet> machine: (finished: must succeed: systemctl show web.service -p Environment | grep -q GREETING=hello, in 0.05 seconds) vm-test-run-flakelet> machine: must succeed: test -f /nix/var/nix/gcroots/flakelet/web/gen-1/manifest.json vm-test-run-flakelet> machine: (finished: must succeed: test -f /nix/var/nix/gcroots/flakelet/web/gen-1/manifest.json, in 0.03 seconds) vm-test-run-flakelet> machine: must succeed: flakelet status | grep -q '^web' vm-test-run-flakelet> machine: (finished: must succeed: flakelet status | grep -q '^web', in 0.11 seconds) vm-test-run-flakelet> machine: must succeed: grep -q '"port": 8080' /run/flakelet/exports/web.json vm-test-run-flakelet> machine: (finished: must succeed: grep -q '"port": 8080' /run/flakelet/exports/web.json, in 0.03 seconds) vm-test-run-flakelet> machine: must succeed: systemctl start flakelet-static.service vm-test-run-flakelet> machine: (finished: must succeed: systemctl start flakelet-static.service, in 0.06 seconds) vm-test-run-flakelet> machine: must succeed: systemctl is-active static.service vm-test-run-flakelet> machine: (finished: must succeed: systemctl is-active static.service, in 0.04 seconds) vm-test-run-flakelet> machine: must succeed: flakelet activate cli /nix/store/7l9ww53jz520qkmapq239lf5hfc41vn0-flakelet-cli vm-test-run-flakelet> machine # cli: using prebuilt artifact /nix/store/7l9ww53jz520qkmapq239lf5hfc41vn0-flakelet-cli vm-test-run-flakelet> machine # cli: activating generation 1 vm-test-run-flakelet> machine # [ 25.371358] systemd[1]: Reload requested from client PID 1259 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 25.374255] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 25.800651] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/static.service target /nix/store/8kxd89lpnhxjfiqmhsryf1l6vfb75fgn-static.service has different name vm-test-run-flakelet> machine # [ 25.805352] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/web.service target /nix/store/c4cqrlnh27rmc82w9p3vlxql7qvvha6s-web.service has different name vm-test-run-flakelet> machine # [ 26.024486] systemd[1]: Reloading finished in 647 ms. vm-test-run-flakelet> machine # [ 26.128672] systemd[1]: Reload requested from client PID 1294 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 26.133511] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 26.572152] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/cli.service target /nix/store/sfaqsn8n4dr7ig35jj9nqhzfvlym87j3-cli.service has different name vm-test-run-flakelet> machine # [ 26.579771] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/static.service target /nix/store/8kxd89lpnhxjfiqmhsryf1l6vfb75fgn-static.service has different name vm-test-run-flakelet> machine # [ 26.584943] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/web.service target /nix/store/c4cqrlnh27rmc82w9p3vlxql7qvvha6s-web.service has different name vm-test-run-flakelet> machine # [ 26.802224] systemd[1]: Reloading finished in 666 ms. vm-test-run-flakelet> machine # [ 26.887748] systemd[1]: Starting prebuilt flakelet service cli... vm-test-run-flakelet> machine # [ 26.934113] systemd[1]: Started prebuilt flakelet service cli. vm-test-run-flakelet> machine: (finished: must succeed: flakelet activate cli /nix/store/7l9ww53jz520qkmapq239lf5hfc41vn0-flakelet-cli, in 1.67 seconds) vm-test-run-flakelet> machine: must succeed: systemctl is-active cli.service vm-test-run-flakelet> machine: (finished: must succeed: systemctl is-active cli.service, in 0.04 seconds) vm-test-run-flakelet> machine: must succeed: flakelet status --json | grep -q 'prebuilt:cli' vm-test-run-flakelet> machine: (finished: must succeed: flakelet status --json | grep -q 'prebuilt:cli', in 0.14 seconds) vm-test-run-flakelet> machine: must fail: flakelet activate cli /nix/store/5rlafdbdfvmf0jiv0mp6xdaxf9cpyhs2-flakelet-cli-broken vm-test-run-flakelet> machine # cli: using prebuilt artifact /nix/store/5rlafdbdfvmf0jiv0mp6xdaxf9cpyhs2-flakelet-cli-broken vm-test-run-flakelet> machine # cli: activating generation 2 vm-test-run-flakelet> machine # [ 27.246849] systemd[1]: Stopping prebuilt flakelet service cli... vm-test-run-flakelet> machine # [ 27.250347] systemd[1]: cli.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 27.252857] systemd[1]: Stopped prebuilt flakelet service cli. vm-test-run-flakelet> machine # [ 27.305356] systemd[1]: Reload requested from client PID 1351 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 27.310519] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 27.748681] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/static.service target /nix/store/8kxd89lpnhxjfiqmhsryf1l6vfb75fgn-static.service has different name vm-test-run-flakelet> machine # [ 27.763290] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/web.service target /nix/store/c4cqrlnh27rmc82w9p3vlxql7qvvha6s-web.service has different name vm-test-run-flakelet> machine # [ 27.991908] systemd[1]: Reloading finished in 683 ms. vm-test-run-flakelet> machine # [ 28.114415] systemd[1]: Reload requested from client PID 1386 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 28.120229] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 28.604200] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/static.service target /nix/store/8kxd89lpnhxjfiqmhsryf1l6vfb75fgn-static.service has different name vm-test-run-flakelet> machine # [ 28.620621] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/web.service target /nix/store/c4cqrlnh27rmc82w9p3vlxql7qvvha6s-web.service has different name vm-test-run-flakelet> machine # [ 28.829337] systemd[1]: Reloading finished in 710 ms. vm-test-run-flakelet> machine # [ 28.912792] systemd[1]: Reload requested from client PID 1421 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 28.917957] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 29.315041] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/static.service target /nix/store/8kxd89lpnhxjfiqmhsryf1l6vfb75fgn-static.service has different name vm-test-run-flakelet> machine # [ 29.327593] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/web.service target /nix/store/c4cqrlnh27rmc82w9p3vlxql7qvvha6s-web.service has different name vm-test-run-flakelet> machine # [ 29.565854] systemd[1]: Reloading finished in 650 ms. vm-test-run-flakelet> machine # [ 29.655271] systemd[1]: Reload requested from client PID 1456 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 29.660688] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 30.046992] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/cli.service target /nix/store/z84ijpkkv9wps6zd00rg19z89z9yvb85-cli.service has different name vm-test-run-flakelet> machine # [ 30.064421] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/static.service target /nix/store/8kxd89lpnhxjfiqmhsryf1l6vfb75fgn-static.service has different name vm-test-run-flakelet> machine # [ 30.080553] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/web.service target /nix/store/c4cqrlnh27rmc82w9p3vlxql7qvvha6s-web.service has different name vm-test-run-flakelet> machine # [ 30.270901] systemd[1]: Reloading finished in 613 ms. vm-test-run-flakelet> machine # [ 30.355674] systemd[1]: Starting cli.service... vm-test-run-flakelet> machine # [ 30.395141] (nonexistent)[1492]: cli.service: Unable to locate executable '/nonexistent': No such file or directory vm-test-run-flakelet> machine # [ 30.402211] (nonexistent)[1492]: cli.service: Failed at step EXEC spawning /nonexistent: No such file or directory vm-test-run-flakelet> machine # [ 30.407110] systemd[1]: cli.service: Main process exited, code=exited, status=203/EXEC vm-test-run-flakelet> machine # [ 30.411615] systemd[1]: cli.service: Failed with result 'exit-code'. vm-test-run-flakelet> machine # [ 30.416177] systemd[1]: Failed to start cli.service. vm-test-run-flakelet> machine # [ 30.507598] systemd[1]: Reload requested from client PID 1498 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 30.512995] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 30.961253] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/static.service target /nix/store/8kxd89lpnhxjfiqmhsryf1l6vfb75fgn-static.service has different name vm-test-run-flakelet> machine # [ 30.978995] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/web.service target /nix/store/c4cqrlnh27rmc82w9p3vlxql7qvvha6s-web.service has different name vm-test-run-flakelet> machine # [ 31.235112] systemd[1]: Reloading finished in 723 ms. vm-test-run-flakelet> machine # [ 31.381670] systemd[1]: Reload requested from client PID 1533 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 31.386870] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 31.827378] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/static.service target /nix/store/8kxd89lpnhxjfiqmhsryf1l6vfb75fgn-static.service has different name vm-test-run-flakelet> machine # [ 31.844641] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/web.service target /nix/store/c4cqrlnh27rmc82w9p3vlxql7qvvha6s-web.service has different name vm-test-run-flakelet> machine # [ 32.088908] systemd[1]: Reloading finished in 703 ms. vm-test-run-flakelet> machine # [ 32.205545] systemd[1]: Reload requested from client PID 1567 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 32.212718] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 32.634800] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/static.service target /nix/store/8kxd89lpnhxjfiqmhsryf1l6vfb75fgn-static.service has different name vm-test-run-flakelet> machine # [ 32.651553] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/web.service target /nix/store/c4cqrlnh27rmc82w9p3vlxql7qvvha6s-web.service has different name vm-test-run-flakelet> machine # [ 32.854128] systemd[1]: Reloading finished in 645 ms. vm-test-run-flakelet> machine # [ 32.945757] systemd[1]: Reload requested from client PID 1603 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 32.950964] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 33.312236] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/cli.service target /nix/store/sfaqsn8n4dr7ig35jj9nqhzfvlym87j3-cli.service has different name vm-test-run-flakelet> machine # [ 33.331146] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/static.service target /nix/store/8kxd89lpnhxjfiqmhsryf1l6vfb75fgn-static.service has different name vm-test-run-flakelet> machine # [ 33.348618] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/web.service target /nix/store/c4cqrlnh27rmc82w9p3vlxql7qvvha6s-web.service has different name vm-test-run-flakelet> machine # [ 33.530474] systemd[1]: Reloading finished in 582 ms. vm-test-run-flakelet> machine # [ 33.603508] systemd[1]: Starting prebuilt flakelet service cli... vm-test-run-flakelet> machine # [ 33.636773] systemd[1]: Started prebuilt flakelet service cli. vm-test-run-flakelet> machine: (finished: must fail: flakelet activate cli /nix/store/5rlafdbdfvmf0jiv0mp6xdaxf9cpyhs2-flakelet-cli-broken, in 6.50 seconds) vm-test-run-flakelet> machine: must succeed: systemctl is-active cli.service vm-test-run-flakelet> machine: (finished: must succeed: systemctl is-active cli.service, in 0.03 seconds) vm-test-run-flakelet> machine: must succeed: test "$(ls /nix/var/nix/gcroots/flakelet/cli)" = gen-1 vm-test-run-flakelet> machine: (finished: must succeed: test "$(ls /nix/var/nix/gcroots/flakelet/cli)" = gen-1, in 0.03 seconds) vm-test-run-flakelet> machine: must fail: flakelet activate cli /nix/store/5rlafdbdfvmf0jiv0mp6xdaxf9cpyhs2-flakelet-cli-broken vm-test-run-flakelet> machine # cli: using prebuilt artifact /nix/store/5rlafdbdfvmf0jiv0mp6xdaxf9cpyhs2-flakelet-cli-broken vm-test-run-flakelet> machine: (finished: must fail: flakelet activate cli /nix/store/5rlafdbdfvmf0jiv0mp6xdaxf9cpyhs2-flakelet-cli-broken, in 0.03 seconds) vm-test-run-flakelet> machine: must succeed: flakelet activate cli /nix/store/pcclca8ir92f2qcq1i8y3bz3a7cv44n4-flakelet-cli2 | grep -q 'generation 2' vm-test-run-flakelet> machine # cli: using prebuilt artifact /nix/store/pcclca8ir92f2qcq1i8y3bz3a7cv44n4-flakelet-cli2 vm-test-run-flakelet> machine # cli: activating generation 2 vm-test-run-flakelet> machine # [ 33.816730] systemd[1]: Stopping prebuilt flakelet service cli... vm-test-run-flakelet> machine # [ 33.821078] systemd[1]: cli.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 33.824253] systemd[1]: Stopped prebuilt flakelet service cli. vm-test-run-flakelet> machine # [ 33.855669] systemd[1]: Reload requested from client PID 1660 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 33.860846] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 34.243334] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/static.service target /nix/store/8kxd89lpnhxjfiqmhsryf1l6vfb75fgn-static.service has different name vm-test-run-flakelet> machine # [ 34.259996] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/web.service target /nix/store/c4cqrlnh27rmc82w9p3vlxql7qvvha6s-web.service has different name vm-test-run-flakelet> machine # [ 34.463862] systemd[1]: Reloading finished in 606 ms. vm-test-run-flakelet> machine # [ 34.560684] systemd[1]: Reload requested from client PID 1695 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 34.564789] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 35.000667] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/static.service target /nix/store/8kxd89lpnhxjfiqmhsryf1l6vfb75fgn-static.service has different name vm-test-run-flakelet> machine # [ 35.005267] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/web.service target /nix/store/c4cqrlnh27rmc82w9p3vlxql7qvvha6s-web.service has different name vm-test-run-flakelet> machine # [ 35.225956] systemd[1]: Reloading finished in 658 ms. vm-test-run-flakelet> machine # [ 35.318825] systemd[1]: Reload requested from client PID 1729 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 35.323994] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 35.747859] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/static.service target /nix/store/8kxd89lpnhxjfiqmhsryf1l6vfb75fgn-static.service has different name vm-test-run-flakelet> machine # [ 35.752864] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/web.service target /nix/store/c4cqrlnh27rmc82w9p3vlxql7qvvha6s-web.service has different name vm-test-run-flakelet> machine # [ 35.971509] systemd[1]: Reloading finished in 644 ms. vm-test-run-flakelet> machine # [ 36.079977] systemd[1]: Reload requested from client PID 1764 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 36.083746] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 36.459192] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/cli.service target /nix/store/sfaqsn8n4dr7ig35jj9nqhzfvlym87j3-cli.service has different name vm-test-run-flakelet> machine # [ 36.467094] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/static.service target /nix/store/8kxd89lpnhxjfiqmhsryf1l6vfb75fgn-static.service has different name vm-test-run-flakelet> machine # [ 36.472094] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/web.service target /nix/store/c4cqrlnh27rmc82w9p3vlxql7qvvha6s-web.service has different name vm-test-run-flakelet> machine # [ 36.693167] systemd[1]: Reloading finished in 607 ms. vm-test-run-flakelet> machine # [ 36.782095] systemd[1]: Starting prebuilt flakelet service cli... vm-test-run-flakelet> machine # [ 36.838009] systemd[1]: Started prebuilt flakelet service cli. vm-test-run-flakelet> machine: (finished: must succeed: flakelet activate cli /nix/store/pcclca8ir92f2qcq1i8y3bz3a7cv44n4-flakelet-cli2 | grep -q 'generation 2', in 3.14 seconds) vm-test-run-flakelet> machine: must succeed: flakelet rollback cli | grep -q 'generation 1' vm-test-run-flakelet> machine # [ 36.981397] systemd[1]: Stopping prebuilt flakelet service cli... vm-test-run-flakelet> machine # [ 36.988119] systemd[1]: cli.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 36.990581] systemd[1]: Stopped prebuilt flakelet service cli. vm-test-run-flakelet> machine # [ 37.040483] systemd[1]: Reload requested from client PID 1813 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 37.045209] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 37.481479] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/static.service target /nix/store/8kxd89lpnhxjfiqmhsryf1l6vfb75fgn-static.service has different name vm-test-run-flakelet> machine # [ 37.486047] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/web.service target /nix/store/c4cqrlnh27rmc82w9p3vlxql7qvvha6s-web.service has different name vm-test-run-flakelet> machine # [ 37.707009] systemd[1]: Reloading finished in 658 ms. vm-test-run-flakelet> machine # [ 37.803821] systemd[1]: Reload requested from client PID 1848 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 37.809162] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 38.203295] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/static.service target /nix/store/8kxd89lpnhxjfiqmhsryf1l6vfb75fgn-static.service has different name vm-test-run-flakelet> machine # [ 38.219654] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/web.service target /nix/store/c4cqrlnh27rmc82w9p3vlxql7qvvha6s-web.service has different name vm-test-run-flakelet> machine # [ 38.422330] systemd[1]: Reloading finished in 616 ms. vm-test-run-flakelet> machine # [ 38.502721] systemd[1]: Reload requested from client PID 1882 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 38.507592] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 38.863223] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/static.service target /nix/store/8kxd89lpnhxjfiqmhsryf1l6vfb75fgn-static.service has different name vm-test-run-flakelet> machine # [ 38.878967] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/web.service target /nix/store/c4cqrlnh27rmc82w9p3vlxql7qvvha6s-web.service has different name vm-test-run-flakelet> machine # [ 39.084115] systemd[1]: Reloading finished in 580 ms. vm-test-run-flakelet> machine # [ 39.191353] systemd[1]: Reload requested from client PID 1917 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 39.198634] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 39.586776] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/cli.service target /nix/store/sfaqsn8n4dr7ig35jj9nqhzfvlym87j3-cli.service has different name vm-test-run-flakelet> machine # [ 39.602477] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/static.service target /nix/store/8kxd89lpnhxjfiqmhsryf1l6vfb75fgn-static.service has different name vm-test-run-flakelet> machine # [ 39.618701] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/web.service target /nix/store/c4cqrlnh27rmc82w9p3vlxql7qvvha6s-web.service has different name vm-test-run-flakelet> machine # [ 39.900385] systemd[1]: Reloading finished in 706 ms. vm-test-run-flakelet> machine # [ 40.084624] systemd[1]: Starting prebuilt flakelet service cli... vm-test-run-flakelet> machine # [ 40.152446] systemd[1]: Started prebuilt flakelet service cli. vm-test-run-flakelet> machine: (finished: must succeed: flakelet rollback cli | grep -q 'generation 1', in 3.29 seconds) vm-test-run-flakelet> machine: must succeed: systemctl is-active cli.service vm-test-run-flakelet> machine: (finished: must succeed: systemctl is-active cli.service, in 0.08 seconds) vm-test-run-flakelet> machine: must succeed: flakelet lock cli | grep -q 'prebuilt:cli' vm-test-run-flakelet> machine: (finished: must succeed: flakelet lock cli | grep -q 'prebuilt:cli', in 0.09 seconds) vm-test-run-flakelet> machine: must succeed: flakelet unlock cli vm-test-run-flakelet> machine: (finished: must succeed: flakelet unlock cli, in 0.08 seconds) vm-test-run-flakelet> machine: must succeed: touch /tmp/failjob vm-test-run-flakelet> machine: (finished: must succeed: touch /tmp/failjob, in 0.07 seconds) vm-test-run-flakelet> machine: must fail: systemctl start web-job.service vm-test-run-flakelet> machine # [ 40.583922] systemd[1]: Starting web-job.service... vm-test-run-flakelet> machine # [ 40.669898] systemd[1]: web-job.service: Main process exited, code=exited, status=1/FAILURE vm-test-run-flakelet> machine # Job for web-job.service failed because the control process exited with error code. vm-test-run-flakelet> machine # [ 40.674469] systemd[1]: web-job.service: Failed with result 'exit-code'. vm-test-run-flakelet> machine # See "systemctl status web-job.service" and "journalctl -xeu web-job.service" for details. vm-test-run-flakelet> machine # [ 40.681597] systemd[1]: Failed to start web-job.service. vm-test-run-flakelet> machine: (finished: must fail: systemctl start web-job.service, in 0.21 seconds) vm-test-run-flakelet> machine: must succeed: systemctl is-failed web-job.service && rm /tmp/failjob vm-test-run-flakelet> machine: (finished: must succeed: systemctl is-failed web-job.service && rm /tmp/failjob, in 0.10 seconds) vm-test-run-flakelet> machine: must succeed: flakelet update web --force --no-refresh | grep -q 'updated to generation' vm-test-run-flakelet> machine # web: resolving path:/nix/store/9343bpka3d3qdvzj7xibb5rkb3z5phs6-flake.nix vm-test-run-flakelet> machine # [ 40.970300] nix-daemon[810]: accepted connection from pid 1987, user flakelet vm-test-run-flakelet> machine # web: evaluating /nix/store/qy9sv455frvjvnd42j5lv67z58nry8w8-flakelet-driver.nix vm-test-run-flakelet> machine # [ 41.271878] nix-daemon[810]: accepted connection from pid 2007, user flakelet vm-test-run-flakelet> machine # web: building /nix/store/wvrlslpbdc5y623n07sf3y5xlb1lyh3j-flakelet-web.drv vm-test-run-flakelet> machine # [ 46.629927] nix-daemon[810]: accepted connection from pid 2017, user flakelet vm-test-run-flakelet> machine # web: activating generation 2 vm-test-run-flakelet> machine # [ 46.734751] systemd[1]: Stopping flakelet test service... vm-test-run-flakelet> machine # [ 46.737927] systemd[1]: web.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 46.740860] systemd[1]: Stopped flakelet test service. vm-test-run-flakelet> machine # [ 46.800686] systemd[1]: Reload requested from client PID 2030 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 46.805977] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 47.194427] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/cli.service target /nix/store/sfaqsn8n4dr7ig35jj9nqhzfvlym87j3-cli.service has different name vm-test-run-flakelet> machine # [ 47.214349] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/static.service target /nix/store/8kxd89lpnhxjfiqmhsryf1l6vfb75fgn-static.service has different name vm-test-run-flakelet> machine # [ 47.412360] systemd[1]: Reloading finished in 608 ms. vm-test-run-flakelet> machine # [ 47.516486] systemd[1]: Reload requested from client PID 2065 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 47.521754] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 47.864484] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/cli.service target /nix/store/sfaqsn8n4dr7ig35jj9nqhzfvlym87j3-cli.service has different name vm-test-run-flakelet> machine # [ 47.883583] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/static.service target /nix/store/8kxd89lpnhxjfiqmhsryf1l6vfb75fgn-static.service has different name vm-test-run-flakelet> machine # [ 48.082353] systemd[1]: Reloading finished in 564 ms. vm-test-run-flakelet> machine # [ 48.208851] systemd[1]: Reload requested from client PID 2099 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 48.214265] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 48.626334] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/cli.service target /nix/store/sfaqsn8n4dr7ig35jj9nqhzfvlym87j3-cli.service has different name vm-test-run-flakelet> machine # [ 48.644510] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/static.service target /nix/store/8kxd89lpnhxjfiqmhsryf1l6vfb75fgn-static.service has different name vm-test-run-flakelet> machine # [ 48.853200] systemd[1]: Reloading finished in 641 ms. vm-test-run-flakelet> machine # [ 48.952255] systemd[1]: Reload requested from client PID 2134 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 48.957130] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 49.369853] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/cli.service target /nix/store/sfaqsn8n4dr7ig35jj9nqhzfvlym87j3-cli.service has different name vm-test-run-flakelet> machine # [ 49.387943] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/static.service target /nix/store/8kxd89lpnhxjfiqmhsryf1l6vfb75fgn-static.service has different name vm-test-run-flakelet> machine # [ 49.403850] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/web.service target /nix/store/c4cqrlnh27rmc82w9p3vlxql7qvvha6s-web.service has different name vm-test-run-flakelet> machine # [ 49.599022] systemd[1]: Reloading finished in 645 ms. vm-test-run-flakelet> machine # [ 49.701063] systemd[1]: Starting flakelet test service... vm-test-run-flakelet> machine # [ 49.766267] systemd[1]: Started flakelet test service. vm-test-run-flakelet> machine: (finished: must succeed: flakelet update web --force --no-refresh | grep -q 'updated to generation', in 9.03 seconds) vm-test-run-flakelet> machine: must succeed: flakelet reconcile vm-test-run-flakelet> machine: (finished: must succeed: flakelet reconcile, in 0.05 seconds) vm-test-run-flakelet> machine: must succeed: systemctl is-active web.service static.service cli.service vm-test-run-flakelet> machine: (finished: must succeed: systemctl is-active web.service static.service cli.service, in 0.04 seconds) vm-test-run-flakelet> machine: must succeed: flakelet check --build --no-refresh --gc-roots-dir /tmp/roots | grep -q '^web: built /nix/store/' vm-test-run-flakelet> machine # [ 50.074399] nix-daemon[810]: accepted connection from pid 2183, user flakelet vm-test-run-flakelet> machine # [ 50.337799] nix-daemon[810]: accepted connection from pid 2203, user flakelet vm-test-run-flakelet> machine: (finished: must succeed: flakelet check --build --no-refresh --gc-roots-dir /tmp/roots | grep -q '^web: built /nix/store/', in 5.28 seconds) vm-test-run-flakelet> machine: must succeed: test -L /tmp/roots/web vm-test-run-flakelet> machine: (finished: must succeed: test -L /tmp/roots/web, in 0.03 seconds) vm-test-run-flakelet> machine: must succeed: flakelet build web --no-refresh --out-link /tmp/out && test -L /tmp/out/web vm-test-run-flakelet> machine # [ 55.358605] nix-daemon[810]: accepted connection from pid 2219, user flakelet vm-test-run-flakelet> machine # [ 55.609497] nix-daemon[810]: accepted connection from pid 2239, user flakelet vm-test-run-flakelet> machine: (finished: must succeed: flakelet build web --no-refresh --out-link /tmp/out && test -L /tmp/out/web, in 5.10 seconds) vm-test-run-flakelet> machine: must fail: flakelet check nosuchservice --no-refresh vm-test-run-flakelet> machine # error: service 'nosuchservice' is not configured vm-test-run-flakelet> machine: (finished: must fail: flakelet check nosuchservice --no-refresh, in 0.05 seconds) vm-test-run-flakelet> machine: must succeed: rm /run/systemd/system/web.service vm-test-run-flakelet> machine: (finished: must succeed: rm /run/systemd/system/web.service, in 0.04 seconds) vm-test-run-flakelet> machine: must succeed: flakelet boot vm-test-run-flakelet> machine # [ 60.489340] systemd[1]: Reload requested from client PID 2257 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 60.494462] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 60.878142] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/cli.service target /nix/store/sfaqsn8n4dr7ig35jj9nqhzfvlym87j3-cli.service has different name vm-test-run-flakelet> machine # [ 60.896704] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/static.service target /nix/store/8kxd89lpnhxjfiqmhsryf1l6vfb75fgn-static.service has different name vm-test-run-flakelet> machine # [ 60.913013] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/web.service target /nix/store/c4cqrlnh27rmc82w9p3vlxql7qvvha6s-web.service has different name vm-test-run-flakelet> machine # [ 61.096768] systemd[1]: Reloading finished in 605 ms. vm-test-run-flakelet> machine # [ 61.201921] systemd[1]: Reload requested from client PID 2293 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 61.207246] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 61.559451] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/cli.service target /nix/store/sfaqsn8n4dr7ig35jj9nqhzfvlym87j3-cli.service has different name vm-test-run-flakelet> machine # [ 61.578066] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/static.service target /nix/store/8kxd89lpnhxjfiqmhsryf1l6vfb75fgn-static.service has different name vm-test-run-flakelet> machine # [ 61.594389] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/web.service target /nix/store/c4cqrlnh27rmc82w9p3vlxql7qvvha6s-web.service has different name vm-test-run-flakelet> machine # [ 61.778053] systemd[1]: Reloading finished in 574 ms. vm-test-run-flakelet> machine # [ 61.883809] systemd[1]: Reload requested from client PID 2330 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 61.889104] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 62.314660] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/cli.service target /nix/store/sfaqsn8n4dr7ig35jj9nqhzfvlym87j3-cli.service has different name vm-test-run-flakelet> machine # [ 62.331892] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/static.service target /nix/store/8kxd89lpnhxjfiqmhsryf1l6vfb75fgn-static.service has different name vm-test-run-flakelet> machine # [ 62.348566] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/web.service target /nix/store/c4cqrlnh27rmc82w9p3vlxql7qvvha6s-web.service has different name vm-test-run-flakelet> machine # [ 62.538425] systemd[1]: Reloading finished in 651 ms. vm-test-run-flakelet> machine # [ 62.650372] systemd[1]: Reload requested from client PID 2366 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 62.655621] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 63.089178] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/cli.service target /nix/store/sfaqsn8n4dr7ig35jj9nqhzfvlym87j3-cli.service has different name vm-test-run-flakelet> machine # [ 63.107008] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/static.service target /nix/store/8kxd89lpnhxjfiqmhsryf1l6vfb75fgn-static.service has different name vm-test-run-flakelet> machine # [ 63.123462] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/web.service target /nix/store/c4cqrlnh27rmc82w9p3vlxql7qvvha6s-web.service has different name vm-test-run-flakelet> machine # [ 63.315819] systemd[1]: Reloading finished in 663 ms. vm-test-run-flakelet> machine # [ 63.418036] systemd[1]: Reload requested from client PID 2403 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 63.423273] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 63.795618] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/cli.service target /nix/store/sfaqsn8n4dr7ig35jj9nqhzfvlym87j3-cli.service has different name vm-test-run-flakelet> machine # [ 63.813317] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/static.service target /nix/store/8kxd89lpnhxjfiqmhsryf1l6vfb75fgn-static.service has different name vm-test-run-flakelet> machine # [ 63.830077] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/web.service target /nix/store/c4cqrlnh27rmc82w9p3vlxql7qvvha6s-web.service has different name vm-test-run-flakelet> machine # [ 64.021193] systemd[1]: Reloading finished in 600 ms. vm-test-run-flakelet> machine # [ 64.136869] systemd[1]: Reload requested from client PID 2439 ('systemctl') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 64.142075] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 64.563294] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/cli.service target /nix/store/sfaqsn8n4dr7ig35jj9nqhzfvlym87j3-cli.service has different name vm-test-run-flakelet> machine # [ 64.578671] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/static.service target /nix/store/8kxd89lpnhxjfiqmhsryf1l6vfb75fgn-static.service has different name vm-test-run-flakelet> machine # [ 64.592760] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/web.service target /nix/store/c4cqrlnh27rmc82w9p3vlxql7qvvha6s-web.service has different name vm-test-run-flakelet> machine # [ 64.795876] systemd[1]: Reloading finished in 656 ms. vm-test-run-flakelet> machine: (finished: must succeed: flakelet boot, in 4.48 seconds) vm-test-run-flakelet> machine: must succeed: test -L /run/systemd/system/web.service vm-test-run-flakelet> machine: (finished: must succeed: test -L /run/systemd/system/web.service, in 0.03 seconds) vm-test-run-flakelet> machine: waiting for the VM to power off vm-test-run-flakelet> additionally exposed symbols: vm-test-run-flakelet> machine, vm-test-run-flakelet> vlan1, vm-test-run-flakelet> 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 vm-test-run-flakelet> Aug 27 21:36:22 machine systemd[1]: Starting Update flakelet service web... vm-test-run-flakelet> Aug 27 21:36:22 machine flakelet[752]: web: resolving path:/nix/store/9343bpka3d3qdvzj7xibb5rkb3z5phs6-flake.nix vm-test-run-flakelet> Aug 27 21:36:24 machine flakelet[752]: web: evaluating /nix/store/qy9sv455frvjvnd42j5lv67z58nry8w8-flakelet-driver.nix vm-test-run-flakelet> Aug 27 21:36:32 machine flakelet[752]: web: building /nix/store/wvrlslpbdc5y623n07sf3y5xlb1lyh3j-flakelet-web.drv vm-test-run-flakelet> Aug 27 21:36:34 machine flakelet[752]: web: activating generation 1 vm-test-run-flakelet> Aug 27 21:36:35 machine flakelet[752]: web: updated to generation 1 vm-test-run-flakelet> Aug 27 21:36:35 machine systemd[1]: Finished Update flakelet service web. vm-test-run-flakelet> vm-test-run-flakelet> machine # [ 64.956567] systemd-logind[591]: poweroff requested from client PID 2479 ('poweroff') (unit backdoor.service)... vm-test-run-flakelet> machine # [ 64.962920] systemd-logind[591]: The system will power off now! vm-test-run-flakelet> machine # [ 64.967154] systemd-logind[591]: System is powering down. vm-test-run-flakelet> machine # [ 64.985152] systemd[1]: Removed slice Slice /system/modprobe. vm-test-run-flakelet> machine # [ 64.988121] systemd[1]: Stopped target Multi-User System. vm-test-run-flakelet> machine # [ 64.990611] systemd[1]: Stopped target flakelet managed services. vm-test-run-flakelet> machine # [ 64.993932] systemd[1]: Stopped target Login Prompts. vm-test-run-flakelet> machine # [ 64.997040] systemd[1]: Stopped target Virtual Machines and Containers. vm-test-run-flakelet> machine # [ 65.002069] dhcpcd[735]: received SIGTERM, stopping vm-test-run-flakelet> machine # [ 65.006009] systemd[1]: Stopped target Host and Network Name Lookups. vm-test-run-flakelet> machine # [ 65.009879] dhcpcd[735]: eth0: removing interface vm-test-run-flakelet> machine # [ 65.013244] systemd[1]: Stopped target Timer Units. vm-test-run-flakelet> machine # [ 65.016953] dhcpcd[735]: eth0: deleting address fec0::5054:ff:fe12:3456/64 vm-test-run-flakelet> machine # [ 65.020804] systemd[1]: fstrim.timer: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.030287] dhcpcd[735]: eth0: deleting route to fec0::/64 vm-test-run-flakelet> machine # [ 65.035005] systemd[1]: Stopped Discard unused filesystem blocks once a week. vm-test-run-flakelet> machine # [ 65.043916] dhcpcd[735]: eth0: deleting default route via fe80::2 vm-test-run-flakelet> machine # [ 65.050435] systemd[1]: systemd-tmpfiles-clean.timer: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.058761] systemd[1]: Stopped Daily Cleanup of Temporary Directories. vm-test-run-flakelet> machine # [ 65.065514] systemd[1]: systemd-rfkill.socket: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.071391] systemd[1]: Closed Load/Save RF Kill Switch Status /dev/rfkill Watch. vm-test-run-flakelet> machine # [ 65.081691] systemd[1]: Mounting /run/initramfs... vm-test-run-flakelet> machine # [ 65.088401] dhcpcd[735]: eth0: deleting address fe80::5054:ff:fe12:3456 vm-test-run-flakelet> machine # [ 65.093748] systemd[1]: Stopping backdoor.service... vm-test-run-flakelet> machine # [ 65.107572] network-addresses-eth1-pre-stop[2483]: deleting address 192.168.1.1/24... done vm-test-run-flakelet> machine # [ 65.114660] systemd[1]: Stopping prebuilt flakelet service cli... vm-test-run-flakelet> machine # [ 65.119416] dhcpcd[735]: eth0: deleting route to 10.0.2.0/24 vm-test-run-flakelet> machine # [ 65.124671] network-addresses-eth1-pre-stop[2483]: deleting address 2001:db8:1::1/64... done vm-test-run-flakelet> machine # [ 65.129023] systemd[1]: Stopping DHCP Client... vm-test-run-flakelet> machine # [ 65.132321] dhcpcd[735]: eth0: deleting default route via 10.0.2.2 vm-test-run-flakelet> machine # [ 65.137418] systemd[1]: Stopping Getty on tty1... vm-test-run-flakelet> machine # [ 65.141471] systemd[1]: lastlog2-import.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.144525] systemd[1]: Stopped Import lastlog data into lastlog2 database. vm-test-run-flakelet> machine # [ 65.147726] dhcpcd[735]: dhcpcd exited vm-test-run-flakelet> machine # [ 65.149852] systemd[1]: Stopping Address configuration of eth1... vm-test-run-flakelet> machine # [ 65.152495] systemd[1]: Stopping Nix Daemon... vm-test-run-flakelet> machine # [ 65.156437] systemd[1]: Stopping Post-Boot Actions... vm-test-run-flakelet> machine # [ 65.164615] systemd[1]: reload-systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.170457] systemd[1]: Stopped Reset console on configuration changes. vm-test-run-flakelet> machine # [ 65.174627] systemd[1]: Stopping prebuilt flakelet service static... vm-test-run-flakelet> machine # [ 65.178029] systemd[1]: Stopping User Login Management... vm-test-run-flakelet> machine # [ 65.180865] systemd[1]: systemd-machine-id-commit.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.184356] systemd[1]: Stopped Save Transient machine-id to Disk. vm-test-run-flakelet> machine # [ 65.188430] systemd[1]: Stopped target First Boot Complete. vm-test-run-flakelet> machine # [ 65.190727] systemd[1]: Stopping Userspace Out-Of-Memory (OOM) Killer... vm-test-run-flakelet> machine # [ 65.193613] systemd[1]: Stopping Load/Save OS Random Seed... vm-test-run-flakelet> machine # [ 65.196277] systemd[1]: Stopping flakelet test service... vm-test-run-flakelet> machine # [ 65.198598] systemd[1]: flakelet-static.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.201415] systemd[1]: Stopped Update flakelet service static. vm-test-run-flakelet> machine # [ 65.203561] systemd[1]: flakelet-web.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.206204] systemd[1]: Stopped Update flakelet service web. vm-test-run-flakelet> machine # [ 65.209199] systemd[1]: flakelet-web.service: Consumed 3.992s CPU time over 54.474s wall clock time, 125M memory peak, 4K written to disk. vm-test-run-flakelet> machine # [ 65.215386] systemd[1]: Stopped target flakelet contract providers ready. vm-test-run-flakelet> machine # [ 65.219883] systemd[1]: flakelet-reconcile.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.223836] systemd[1]: Stopped Reconcile flakelet services with the host configuration. vm-test-run-flakelet> machine # [ 65.231481] systemd[1]: flakelet-boot.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.235409] systemd[1]: Stopped Re-link flakelet services at boot. vm-test-run-flakelet> machine # [ 65.240051] systemd[1]: systemd-oomd.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.245470] systemd[1]: Stopped Userspace Out-Of-Memory (OOM) Killer. vm-test-run-flakelet> machine # [ 65.251470] systemd[1]: backdoor.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.255664] make-initrd-ng[2511]: /etc/initrd-release -> /nix/store/94m2cr9q6r1gdr1df0sz9ayq29mj68kz-etc-os-release vm-test-run-flakelet> machine # [ 65.264992] make-initrd-ng[2511]: /etc/os-release -> /nix/store/94m2cr9q6r1gdr1df0sz9ayq29mj68kz-etc-os-release vm-test-run-flakelet> machine # [ 65.273404] make-initrd-ng[2511]: /shutdown -> /nix/store/z2nxjmk4666nbka3hgyxlg13prrnvx38-systemd-261/lib/systemd/systemd-shutdown vm-test-run-flakelet> machine # [ 65.282427] systemd[1]: Stopped backdoor.service. vm-test-run-flakelet> machine # [ 65.289720] systemd[1]: backdoor.service: Consumed 9.309s CPU time over 55.106s wall clock time, 119M memory peak, 104K written to disk. vm-test-run-flakelet> machine # [ 65.302014] systemd[1]: systemd-logind.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.309841] systemd[1]: Stopped User Login Management. vm-test-run-flakelet> machine # [ 65.314241] systemd[1]: getty@tty1.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.321945] systemd[1]: Stopped Getty on tty1. vm-test-run-flakelet> machine # [ 65.325283] systemd[1]: nix-daemon.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.332004] systemd[1]: Stopped Nix Daemon. vm-test-run-flakelet> machine # [ 65.343571] systemd[1]: nix-daemon.service: Consumed 2.990s CPU time over 53.750s wall clock time, 53.5M memory peak, 4.9M written to disk. vm-test-run-flakelet> machine # [ 65.357917] systemd[1]: static.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.362685] systemd[1]: Stopped prebuilt flakelet service static. vm-test-run-flakelet> machine # [ 65.368690] systemd[1]: cli.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.376691] systemd[1]: Stopped prebuilt flakelet service cli. vm-test-run-flakelet> machine # [ 65.379229] systemd[1]: web.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.381991] systemd[1]: Stopped flakelet test service. vm-test-run-flakelet> machine # [ 65.386127] systemd[1]: Mounted /run/initramfs. vm-test-run-flakelet> machine # [ 65.389809] systemd[1]: post-boot.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.395150] systemd[1]: Stopped Post-Boot Actions. vm-test-run-flakelet> machine # [ 65.399159] make-initrd-ng[2511]: Warning: Couldn't satisfy dependency libcrypt.so.1 for "/nix/store/z2nxjmk4666nbka3hgyxlg13prrnvx38-systemd-261/lib/systemd/libsystemd-shared-261.so" vm-test-run-flakelet> machine # [ 65.409139] make-initrd-ng[2511]: Warning: Couldn't satisfy dependency libcrypt.so.1.1 for "/nix/store/z2nxjmk4666nbka3hgyxlg13prrnvx38-systemd-261/lib/systemd/libsystemd-shared-261.so" vm-test-run-flakelet> machine # [ 65.421126] systemd[1]: Removed slice Slice /system/getty. vm-test-run-flakelet> machine # [ 65.425641] systemd[1]: Starting Generate shutdown ramfs... vm-test-run-flakelet> machine # [ 65.430003] systemd[1]: Stopping Permit User Sessions... vm-test-run-flakelet> machine # [ 65.434152] systemd[1]: network-addresses-eth1.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.439687] systemd[1]: Stopped Address configuration of eth1. vm-test-run-flakelet> machine # [ 65.444653] systemd[1]: systemd-random-seed.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.451534] systemd[1]: Stopped Load/Save OS Random Seed. vm-test-run-flakelet> machine # [ 65.456042] systemd[1]: dhcpcd.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.461000] systemd[1]: Stopped DHCP Client. vm-test-run-flakelet> machine # [ 65.463179] systemd[1]: dhcpcd.service: Consumed 434ms CPU time over 54.785s wall clock time, 6.6M memory peak, 8K written to disk, 96B incoming IP traffic, 56B outgoing IP traffic. vm-test-run-flakelet> machine # [ 65.470111] systemd[1]: systemd-user-sessions.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.473067] systemd[1]: Stopped Permit User Sessions. vm-test-run-flakelet> machine # [ 65.475080] systemd[1]: Stopped target Network. vm-test-run-flakelet> machine # [ 65.477028] systemd[1]: Stopped target User and Group Name Lookups. vm-test-run-flakelet> machine # [ 65.479445] systemd[1]: Stopped target Remote File Systems. vm-test-run-flakelet> machine # [ 65.481742] systemd[1]: network-local-commands.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.484405] systemd[1]: Stopped Extra networking commands.. vm-test-run-flakelet> machine # [ 65.486320] systemd[1]: Stopped target Preparation for Network. vm-test-run-flakelet> machine # [ 65.488363] systemd[1]: Stopping Firewall... vm-test-run-flakelet> machine # [ 65.489902] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... vm-test-run-flakelet> machine # [ 65.491878] systemd[1]: resolvconf.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.494014] systemd[1]: Stopped resolvconf update. vm-test-run-flakelet> machine # [ 65.495611] systemd[1]: nscd.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.497469] systemd[1]: Stopped Name Service Cache Daemon (nsncd). vm-test-run-flakelet> machine # [ 65.499158] systemd[1]: Stopped target Basic System. vm-test-run-flakelet> machine # [ 65.500688] systemd[1]: Stopped target Path Units. vm-test-run-flakelet> machine # [ 65.502159] systemd[1]: Stopped target Slice Units. vm-test-run-flakelet> machine # [ 65.503632] systemd[1]: Removed slice User and Session Slice. vm-test-run-flakelet> machine # [ 65.505341] systemd[1]: Stopped target Socket Units. vm-test-run-flakelet> machine # [ 65.506736] systemd[1]: nix-daemon.socket: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.508472] systemd[1]: Closed Nix Daemon Socket. vm-test-run-flakelet> machine # [ 65.509786] systemd[1]: systemd-hostnamed.socket: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.511520] systemd[1]: Closed Hostname Service Socket. vm-test-run-flakelet> machine # [ 65.512927] systemd[1]: systemd-importd.socket: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.514469] systemd[1]: Closed Disk Image Download Service Socket. vm-test-run-flakelet> machine # [ 65.515875] systemd[1]: systemd-machined.socket: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.517561] systemd[1]: Closed Virtual Machine and Container Registration Service Socket. vm-test-run-flakelet> machine # [ 65.519348] systemd[1]: systemd-mute-console.socket: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.520999] systemd[1]: Closed Console Output Muting Service Socket. vm-test-run-flakelet> machine # [ 65.522302] systemd[1]: systemd-oomd.socket: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.523628] systemd[1]: Closed Userspace Out-Of-Memory (OOM) Killer Socket. vm-test-run-flakelet> machine # [ 65.525107] systemd[1]: systemd-repart.socket: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.526388] systemd[1]: Closed Disk Repartitioning Service Socket. vm-test-run-flakelet> machine # [ 65.527842] dbus-broker[646]: Dispatched 22543 messages @ 3(±5)μs / message. vm-test-run-flakelet> machine # [ 65.529373] systemd[1]: Stopping D-Bus System Message Bus... vm-test-run-flakelet> machine # [ 65.530466] systemd[1]: dbus-broker.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.531697] systemd[1]: Stopped D-Bus System Message Bus. vm-test-run-flakelet> machine # [ 65.532850] systemd[1]: dbus.socket: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.533949] systemd[1]: Closed D-Bus System Message Bus Socket. vm-test-run-flakelet> machine # [ 65.535035] systemd[1]: Stopped target System Initialization. vm-test-run-flakelet> machine # [ 65.536126] systemd[1]: Stopped target Local Encrypted Volumes. vm-test-run-flakelet> machine # [ 65.537218] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.538538] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. vm-test-run-flakelet> machine # [ 65.539876] systemd[1]: systemd-ask-password-wall.path: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.541243] systemd[1]: Stopped Forward Password Requests to Wall Directory Watch. vm-test-run-flakelet> machine # [ 65.542457] systemd[1]: register-nix-paths.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.543629] systemd[1]: Stopped register-nix-paths.service. vm-test-run-flakelet> machine # [ 65.545608] systemd[1]: systemd-sysctl.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.546706] systemd[1]: Stopped Apply Kernel Variables. vm-test-run-flakelet> machine # [ 65.547563] systemd[1]: systemd-coredump.socket: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.548920] systemd[1]: Closed Process Core Dump Socket. vm-test-run-flakelet> machine # [ 65.549980] systemd[1]: systemd-update-done.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.551331] systemd[1]: Stopped Update is Completed. vm-test-run-flakelet> machine # [ 65.552349] systemd[1]: systemd-journal-catalog-update.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.553848] systemd[1]: Stopped Rebuild Journal Catalog. vm-test-run-flakelet> machine # [ 65.554895] systemd[1]: Stopping Record System Boot/Shutdown in UTMP... vm-test-run-flakelet> machine # [ 65.556183] systemd[1]: systemd-update-utmp.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.557539] systemd[1]: Stopped Record System Boot/Shutdown in UTMP. vm-test-run-flakelet> machine # [ 65.558739] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.560143] systemd[1]: Stopped Create System Files and Directories. vm-test-run-flakelet> machine # [ 65.561350] systemd[1]: Stopped target Local File Systems. vm-test-run-flakelet> machine # [ 65.562409] systemd[1]: Unmounting /run/keys... vm-test-run-flakelet> machine # [ 65.563319] systemd[1]: Unmounting /run/wrappers... vm-test-run-flakelet> machine # [ 65.564348] systemd[1]: run-keys.mount: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.565528] systemd[1]: Unmounted /run/keys. vm-test-run-flakelet> machine # [ 65.566408] systemd[1]: run-wrappers.mount: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.567618] systemd[1]: Unmounted /run/wrappers. vm-test-run-flakelet> machine # [ 65.568592] systemd[1]: Stopped target Preparation for Local File Systems. vm-test-run-flakelet> machine # [ 65.569873] systemd[1]: Stopped target Swaps. vm-test-run-flakelet> machine # [ 65.570737] systemd[1]: Reached target Unmount All Filesystems. vm-test-run-flakelet> machine # [ 65.571845] systemd[1]: systemd-remount-fs.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.573283] systemd[1]: Stopped Remount Root and Kernel File Systems. vm-test-run-flakelet> machine # [ 65.574472] systemd[1]: systemd-fsck-root.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.575768] systemd[1]: Stopped File System Check on Root Device. vm-test-run-flakelet> machine # [ 65.576990] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.578356] systemd[1]: Stopped Create Static Device Nodes in /dev. vm-test-run-flakelet> machine # [ 65.579480] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.581030] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. vm-test-run-flakelet> machine # [ 65.582296] systemd[1]: firewall.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.583396] systemd[1]: Stopped Firewall. vm-test-run-flakelet> machine # [ 65.584174] systemd[1]: systemd-modules-load.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.585413] systemd[1]: Stopped Load Kernel Modules. vm-test-run-flakelet> machine # [ 65.586281] systemd[1]: generate-shutdown-ramfs.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.587520] systemd[1]: Finished Generate shutdown ramfs. vm-test-run-flakelet> machine # [ 65.588498] systemd[1]: Reached target System Shutdown. vm-test-run-flakelet> machine # [ 65.589423] systemd[1]: Reached target Late Shutdown Services. vm-test-run-flakelet> machine # [ 65.590382] systemd[1]: systemd-poweroff.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 65.591471] systemd[1]: Finished System Power Off. vm-test-run-flakelet> machine # [ 65.592359] systemd[1]: Reached target System Power Off. vm-test-run-flakelet> machine # [ 65.593245] systemd[1]: Shutting down. vm-test-run-flakelet> machine # [ 65.658106] systemd-shutdown[1]: Syncing filesystems and block devices. vm-test-run-flakelet> machine # [ 65.666338] systemd-shutdown[1]: Sending SIGTERM to remaining processes... vm-test-run-flakelet> machine # [ 65.678674] systemd-journald[312]: Received SIGTERM from PID 1 (systemd-shutdow). vm-test-run-flakelet> machine # [ 65.711311] systemd-shutdown[1]: Sending SIGKILL to remaining processes... vm-test-run-flakelet> machine # [ 65.722306] systemd-shutdown[1]: Unmounting file systems. vm-test-run-flakelet> machine # [ 65.728089] (sd-umount)[2546]: Unmounting '/run/credentials/systemd-journald.service'. vm-test-run-flakelet> machine # [ 65.734373] (sd-remount)[2547]: Remounting '/nix/store' read-only with options 'lowerdir=/sysroot/nix/.ro-store,upperdir=/sysroot/nix/.rw-store/upper,workdir=/sysroot/nix/.rw-store/work,uuid=on'. vm-test-run-flakelet> machine # [ 65.758690] (sd-remount)[2548]: Remounting '/nix/store' read-only with options 'lowerdir=/sysroot/nix/.ro-store,upperdir=/sysroot/nix/.rw-store/upper,workdir=/sysroot/nix/.rw-store/work,uuid=on'. vm-test-run-flakelet> machine # [ 65.768730] (sd-remount)[2549]: Remounting '/tmp/shared' read-only with options 'access=client,msize=16384,trans=virtio'. vm-test-run-flakelet> machine # [ 65.777938] (sd-umount)[2550]: Unmounting '/tmp/shared'. vm-test-run-flakelet> machine # [ 65.805661] (sd-remount)[2551]: Remounting '/tmp/xchg' read-only with options 'access=client,msize=16384,trans=virtio'. vm-test-run-flakelet> machine # [ 65.808037] (sd-umount)[2552]: Unmounting '/tmp/xchg'. vm-test-run-flakelet> machine # [ 65.816260] (sd-remount)[2553]: Remounting '/nix/.ro-store' read-only with options 'cache=0xf,access=client,msize=16384,trans=virtio'. vm-test-run-flakelet> machine # [ 66.013180] (sd-umount)[2554]: Unmounting '/nix/.ro-store'. vm-test-run-flakelet> machine # [ 66.018590] (sd-remount)[2555]: Remounting '/' read-only with options ''. vm-test-run-flakelet> machine # [ 66.038089] EXT4-fs (vda): re-mounted 73b53e32-2e1f-4de8-ae93-386325cdf32f ro. vm-test-run-flakelet> machine # [ 66.044674] systemd-shutdown[1]: All filesystems unmounted. vm-test-run-flakelet> machine # [ 66.044724] systemd-shutdown[1]: Deactivating swaps. vm-test-run-flakelet> machine # [ 66.044785] systemd-shutdown[1]: All swaps deactivated. vm-test-run-flakelet> machine # [ 66.044803] systemd-shutdown[1]: Detaching loop devices. vm-test-run-flakelet> machine # [ 66.056095] systemd-shutdown[1]: All loop devices detached. vm-test-run-flakelet> machine # [ 66.056240] systemd-shutdown[1]: Stopping MD devices. vm-test-run-flakelet> machine # [ 66.057421] systemd-shutdown[1]: All MD devices stopped. vm-test-run-flakelet> machine # [ 66.058184] systemd-shutdown[1]: Detaching DM devices. vm-test-run-flakelet> machine # [ 66.058605] systemd-shutdown[1]: All DM devices detached. vm-test-run-flakelet> machine # [ 66.058636] systemd-shutdown[1]: All filesystems, swaps, loop devices, MD devices and DM devices detached. vm-test-run-flakelet> machine # [ 66.060685] systemd-shutdown[1]: Failed to chase and open directory '/etc/systemd/system-shutdown', ignoring: Input/output error vm-test-run-flakelet> machine # [ 66.397376] systemd-shutdown[1]: Successfully changed into root pivot. vm-test-run-flakelet> machine # [ 66.397433] systemd-shutdown[1]: Entering exitrd... vm-test-run-flakelet> machine # [ 66.413092] shutdown[1]: Syncing filesystems and block devices. vm-test-run-flakelet> machine # [ 66.414722] shutdown[1]: Sending SIGTERM to remaining processes... vm-test-run-flakelet> machine # [ 66.424759] shutdown[1]: Sending SIGKILL to remaining processes... vm-test-run-flakelet> machine # [ 66.434165] shutdown[1]: Unmounting file systems. vm-test-run-flakelet> machine # [ 66.437906] (sd-umoun[2557]: Unmounting '/run/credentials'. vm-test-run-flakelet> machine # [ 66.443233] (sd-umoun[2558]: Unmounting '/oldroot/sys/fs/fuse/connections'. vm-test-run-flakelet> machine # [ 66.448971] (sd-umoun[2559]: Unmounting '/oldroot/sys/kernel/config'. vm-test-run-flakelet> machine # [ 66.454481] (sd-umoun[2560]: Unmounting '/oldroot/dev/mqueue'. vm-test-run-flakelet> machine # [ 66.459895] (sd-umoun[2561]: Unmounting '/oldroot/sys/kernel/tracing'. vm-test-run-flakelet> machine # [ 66.465454] (sd-umoun[2562]: Unmounting '/oldroot/dev/hugepages'. vm-test-run-flakelet> machine # [ 66.470996] (sd-umoun[2563]: Unmounting '/oldroot/sys/kernel/debug'. vm-test-run-flakelet> machine # [ 66.476473] (sd-umoun[2564]: Unmounting '/oldroot/sys/fs/bpf'. vm-test-run-flakelet> machine # [ 66.481847] (sd-umoun[2565]: Unmounting '/oldroot/sys/fs/pstore'. vm-test-run-flakelet> machine # [ 66.487404] (sd-umoun[2566]: Unmounting '/oldroot/sys/fs/cgroup'. vm-test-run-flakelet> machine # [ 66.492765] (sd-umoun[2567]: Unmounting '/oldroot/sys/kernel/security'. vm-test-run-flakelet> machine # [ 66.498293] (sd-umoun[2568]: Unmounting '/oldroot/nix/store'. vm-test-run-flakelet> machine # [ 66.503751] (sd-umoun[2569]: Unmounting '/oldroot/sys'. vm-test-run-flakelet> machine # [ 66.508798] (sd-umoun[2570]: Unmounting '/oldroot/proc'. vm-test-run-flakelet> machine # [ 66.513867] (sd-umoun[2571]: Unmounting '/oldroot/dev/shm'. vm-test-run-flakelet> machine # [ 66.519058] (sd-umoun[2572]: Unmounting '/oldroot/dev/pts'. vm-test-run-flakelet> machine # [ 66.524282] (sd-umoun[2573]: Unmounting '/oldroot/dev'. vm-test-run-flakelet> machine # [ 66.529279] (sd-umoun[2574]: Unmounting '/oldroot/nix/store'. vm-test-run-flakelet> machine # [ 66.618744] (sd-umoun[2575]: Unmounting '/oldroot/run'. vm-test-run-flakelet> machine # [ 66.624003] (sd-umoun[2576]: Unmounting '/oldroot'. vm-test-run-flakelet> machine # [ 66.650413] EXT4-fs (vda): unmounting filesystem 73b53e32-2e1f-4de8-ae93-386325cdf32f. vm-test-run-flakelet> machine # [ 66.656313] shutdown[1]: All filesystems unmounted. vm-test-run-flakelet> machine # [ 66.657275] shutdown[1]: Deactivating swaps. vm-test-run-flakelet> machine # [ 66.658231] shutdown[1]: All swaps deactivated. vm-test-run-flakelet> machine # [ 66.659122] shutdown[1]: Detaching loop devices. vm-test-run-flakelet> machine # [ 66.667892] shutdown[1]: All loop devices detached. vm-test-run-flakelet> machine # [ 66.668767] shutdown[1]: Stopping MD devices. vm-test-run-flakelet> machine # [ 66.669969] shutdown[1]: All MD devices stopped. vm-test-run-flakelet> machine # [ 66.670753] shutdown[1]: Detaching DM devices. vm-test-run-flakelet> machine # [ 66.672484] shutdown[1]: All DM devices detached. vm-test-run-flakelet> machine # [ 66.673275] shutdown[1]: All filesystems, swaps, loop devices, MD devices and DM devices detached. vm-test-run-flakelet> machine # [ 66.674774] shutdown[1]: Syncing filesystems and block devices. vm-test-run-flakelet> machine # [ 66.676245] shutdown[1]: Powering off. vm-test-run-flakelet> machine # [ 66.727548] Console: switching to colour dummy device 80x25 vm-test-run-flakelet> machine # [ 66.746524] Flash device refused suspend due to active operation (state 20) vm-test-run-flakelet> machine # [ 66.746593] Flash device refused suspend due to active operation (state 20) vm-test-run-flakelet> machine # [ 66.752149] reboot: Power down vm-test-run-flakelet> machine: (finished: waiting for the VM to power off, in 2.08 seconds) vm-test-run-flakelet> machine: starting vm vm-test-run-flakelet> machine: QEMU running (pid 82) vm-test-run-flakelet> machine: waiting for unit web.service vm-test-run-flakelet> machine: waiting for the VM to finish booting vm-test-run-flakelet> machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40] vm-test-run-flakelet> machine # [ 0.000000] Linux version 6.18.40 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri Jul 24 14:17:26 UTC 2026 vm-test-run-flakelet> machine # [ 0.000000] KASLR enabled vm-test-run-flakelet> machine # [ 0.000000] random: crng init done vm-test-run-flakelet> machine # [ 0.000000] Machine model: linux,dummy-virt vm-test-run-flakelet> machine # [ 0.000000] efi: UEFI not found. vm-test-run-flakelet> machine # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT vm-test-run-flakelet> machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000013fffffff] vm-test-run-flakelet> machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x13fdeb740-0x13fdeeebf] vm-test-run-flakelet> machine # [ 0.000000] Zone ranges: vm-test-run-flakelet> machine # [ 0.000000] DMA [mem 0x0000000040000000-0x00000000ffffffff] vm-test-run-flakelet> machine # [ 0.000000] DMA32 empty vm-test-run-flakelet> machine # [ 0.000000] Normal [mem 0x0000000100000000-0x000000013fffffff] vm-test-run-flakelet> machine # [ 0.000000] Device empty vm-test-run-flakelet> machine # [ 0.000000] Movable zone start for each node vm-test-run-flakelet> machine # [ 0.000000] Early memory node ranges vm-test-run-flakelet> machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000013fffffff] vm-test-run-flakelet> machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000013fffffff] vm-test-run-flakelet> machine # [ 0.000000] cma: Reserved 32 MiB at 0x00000000fe000000 vm-test-run-flakelet> machine # [ 0.000000] psci: probing for conduit method from DT. vm-test-run-flakelet> machine # [ 0.000000] psci: PSCIv1.3 detected in firmware. vm-test-run-flakelet> machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs vm-test-run-flakelet> machine # [ 0.000000] psci: Trusted OS migration not required vm-test-run-flakelet> machine # [ 0.000000] psci: SMC Calling Convention v1.1 vm-test-run-flakelet> machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) vm-test-run-flakelet> machine # [ 0.000000] percpu: Embedded 76 pages/cpu s186392 r8192 d116712 u311296 vm-test-run-flakelet> machine # [ 0.000000] Detected PIPT I-cache on CPU0 vm-test-run-flakelet> machine # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm) vm-test-run-flakelet> machine # [ 0.000000] CPU features: detected: GICv3 CPU interface vm-test-run-flakelet> machine # [ 0.000000] CPU features: detected: Spectre-v4 vm-test-run-flakelet> machine # [ 0.000000] CPU features: detected: Spectre-BHB vm-test-run-flakelet> machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38 vm-test-run-flakelet> machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23 vm-test-run-flakelet> machine # [ 0.000000] alternatives: applying boot alternatives vm-test-run-flakelet> machine # [ 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/3z6a3hbfvlkx90987w1sw3qzzyh28d1z-nixos-system-machine-test/init regInfo=/nix/store/l223xgms25q3mj5mx1sbf6531qm0xwxz-closure-info/registration console=ttyAMA0,115200n8 console=tty0 vm-test-run-flakelet> machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/l223xgms25q3mj5mx1sbf6531qm0xwxz-closure-info/registration", will be passed to user space. vm-test-run-flakelet> machine # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes vm-test-run-flakelet> machine # [ 0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) vm-test-run-flakelet> machine # [ 0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) vm-test-run-flakelet> machine # [ 0.000000] software IO TLB: area num 4. vm-test-run-flakelet> machine # [ 0.000000] software IO TLB: mapped [mem 0x00000000fa000000-0x00000000fe000000] (64MB) vm-test-run-flakelet> machine # [ 0.000000] Fallback order for Node 0: 0 vm-test-run-flakelet> machine # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1048576 vm-test-run-flakelet> machine # [ 0.000000] Policy zone: Normal vm-test-run-flakelet> machine # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off vm-test-run-flakelet> machine # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 vm-test-run-flakelet> machine # [ 0.000000] allocated 8388608 bytes of page_ext vm-test-run-flakelet> machine # [ 0.000000] ftrace: allocating 74754 entries in 294 pages vm-test-run-flakelet> machine # [ 0.000000] ftrace: allocated 294 pages with 4 groups vm-test-run-flakelet> machine # [ 0.000000] rcu: Hierarchical RCU implementation. vm-test-run-flakelet> machine # [ 0.000000] rcu: RCU event tracing is enabled. vm-test-run-flakelet> machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=4. vm-test-run-flakelet> machine # [ 0.000000] Trampoline variant of Tasks RCU enabled. vm-test-run-flakelet> machine # [ 0.000000] Rude variant of Tasks RCU enabled. vm-test-run-flakelet> machine # [ 0.000000] Tracing variant of Tasks RCU enabled. vm-test-run-flakelet> machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. vm-test-run-flakelet> machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 vm-test-run-flakelet> machine # [ 0.000000] RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. vm-test-run-flakelet> machine # [ 0.000000] RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. vm-test-run-flakelet> machine # [ 0.000000] RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. vm-test-run-flakelet> machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 vm-test-run-flakelet> machine # [ 0.000000] GICv3: 256 SPIs implemented vm-test-run-flakelet> machine # [ 0.000000] GICv3: 0 Extended SPIs implemented vm-test-run-flakelet> machine # [ 0.000000] Root IRQ handler: gic_handle_irq vm-test-run-flakelet> machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI vm-test-run-flakelet> machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0 vm-test-run-flakelet> machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 vm-test-run-flakelet> machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] vm-test-run-flakelet> machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @100b10000 (indirect, esz 8, psz 64K, shr 1) vm-test-run-flakelet> machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @100b20000 (flat, esz 8, psz 64K, shr 1) vm-test-run-flakelet> machine # [ 0.000000] GICv3: using LPI property table @0x0000000100b30000 vm-test-run-flakelet> machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000100b40000 vm-test-run-flakelet> machine # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. vm-test-run-flakelet> machine # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns vm-test-run-flakelet> machine # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt). vm-test-run-flakelet> machine # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns vm-test-run-flakelet> machine # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns vm-test-run-flakelet> machine # [ 0.000029] arm-pv: using stolen time PV vm-test-run-flakelet> machine # [ 0.000370] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) vm-test-run-flakelet> machine # [ 0.000576] Console: colour dummy device 80x25 vm-test-run-flakelet> machine # [ 0.000583] printk: legacy console [tty0] enabled vm-test-run-flakelet> machine # [ 0.000761] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) vm-test-run-flakelet> machine # [ 0.000767] pid_max: default: 32768 minimum: 301 vm-test-run-flakelet> machine # [ 0.000863] LSM: initializing lsm=capability,landlock,yama,bpf,ima vm-test-run-flakelet> machine # [ 0.000987] landlock: Up and running. vm-test-run-flakelet> machine # [ 0.000990] Yama: becoming mindful. vm-test-run-flakelet> machine # [ 0.001400] LSM support for eBPF active vm-test-run-flakelet> machine # [ 0.001556] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-flakelet> machine # [ 0.001608] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-flakelet> machine # [ 0.002675] cacheinfo: Unable to detect cache hierarchy for CPU 0 vm-test-run-flakelet> machine # [ 0.003317] rcu: Hierarchical SRCU implementation. vm-test-run-flakelet> machine # [ 0.003321] rcu: Max phase no-delay instances is 1000. vm-test-run-flakelet> machine # [ 0.003462] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level vm-test-run-flakelet> machine # [ 0.004454] fsl-mc MSI: its@8080000 domain created vm-test-run-flakelet> machine # [ 0.004560] EFI services will not be available. vm-test-run-flakelet> machine # [ 0.004720] smp: Bringing up secondary CPUs ... vm-test-run-flakelet> machine # [ 0.005334] Detected PIPT I-cache on CPU1 vm-test-run-flakelet> machine # [ 0.005432] GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 vm-test-run-flakelet> machine # [ 0.005553] GICv3: CPU1: using allocated LPI pending table @0x0000000100b50000 vm-test-run-flakelet> machine # [ 0.005677] CPU1: Booted secondary processor 0x0000000001 [0xc00fac40] vm-test-run-flakelet> machine # [ 0.006694] Detected PIPT I-cache on CPU2 vm-test-run-flakelet> machine # [ 0.006799] GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 vm-test-run-flakelet> machine # [ 0.006920] GICv3: CPU2: using allocated LPI pending table @0x0000000100b60000 vm-test-run-flakelet> machine # [ 0.007042] CPU2: Booted secondary processor 0x0000000002 [0xc00fac40] vm-test-run-flakelet> machine # [ 0.008077] Detected PIPT I-cache on CPU3 vm-test-run-flakelet> machine # [ 0.008191] GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 vm-test-run-flakelet> machine # [ 0.008313] GICv3: CPU3: using allocated LPI pending table @0x0000000100b70000 vm-test-run-flakelet> machine # [ 0.008437] CPU3: Booted secondary processor 0x0000000003 [0xc00fac40] vm-test-run-flakelet> machine # [ 0.008951] smp: Brought up 1 node, 4 CPUs vm-test-run-flakelet> machine # [ 0.008978] SMP: Total of 4 processors activated. vm-test-run-flakelet> machine # [ 0.008980] CPU: All CPU(s) started at EL1 vm-test-run-flakelet> machine # [ 0.008989] CPU features: detected: Branch Target Identification vm-test-run-flakelet> machine # [ 0.008992] CPU features: detected: ARMv8.4 Translation Table Level vm-test-run-flakelet> machine # [ 0.008995] CPU features: detected: Instruction cache invalidation not required for I/D coherence vm-test-run-flakelet> machine # [ 0.008999] CPU features: detected: Data cache clean to the PoU not required for I/D coherence vm-test-run-flakelet> machine # [ 0.009002] CPU features: detected: Common not Private translations vm-test-run-flakelet> machine # [ 0.009005] CPU features: detected: CRC32 instructions vm-test-run-flakelet> machine # [ 0.009007] CPU features: detected: Data cache clean to Point of Deep Persistence vm-test-run-flakelet> machine # [ 0.009010] CPU features: detected: Data cache clean to Point of Persistence vm-test-run-flakelet> machine # [ 0.009013] CPU features: detected: Data independent timing control (DIT) vm-test-run-flakelet> machine # [ 0.009016] CPU features: detected: E0PD vm-test-run-flakelet> machine # [ 0.009018] CPU features: detected: Enhanced Counter Virtualization vm-test-run-flakelet> machine # [ 0.009021] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) vm-test-run-flakelet> machine # [ 0.009024] CPU features: detected: Enhanced Virtualization Traps vm-test-run-flakelet> machine # [ 0.009027] CPU features: detected: Fine Grained Traps vm-test-run-flakelet> machine # [ 0.009029] CPU features: detected: Generic authentication (architected QARMA5 algorithm) vm-test-run-flakelet> machine # [ 0.009033] CPU features: detected: RCpc load-acquire (LDAPR) vm-test-run-flakelet> machine # [ 0.009035] CPU features: detected: LSE atomic instructions vm-test-run-flakelet> machine # [ 0.009038] CPU features: detected: Privileged Access Never vm-test-run-flakelet> machine # [ 0.009040] CPU features: detected: PMUv3 vm-test-run-flakelet> machine # [ 0.009043] CPU features: detected: RAS Extension Support vm-test-run-flakelet> machine # [ 0.009045] CPU features: detected: RASv1p1 Extension Support vm-test-run-flakelet> machine # [ 0.009047] CPU features: detected: Random Number Generator vm-test-run-flakelet> machine # [ 0.009050] CPU features: detected: Speculation barrier (SB) vm-test-run-flakelet> machine # [ 0.009052] CPU features: detected: Stage-2 Force Write-Back vm-test-run-flakelet> machine # [ 0.009055] CPU features: detected: TLB range maintenance instructions vm-test-run-flakelet> machine # [ 0.009058] CPU features: detected: Speculative Store Bypassing Safe (SSBS) vm-test-run-flakelet> machine # [ 0.009182] alternatives: applying system-wide alternatives vm-test-run-flakelet> machine # [ 0.011941] CPU features: detected: BBM Level 2 without TLB conflict abort vm-test-run-flakelet> machine # [ 0.012576] Memory: 3909996K/4194304K available (24384K kernel code, 7086K rwdata, 26316K rodata, 4736K init, 1102K bss, 233732K reserved, 32768K cma-reserved) vm-test-run-flakelet> machine # [ 0.013809] devtmpfs: initialized vm-test-run-flakelet> machine # [ 0.017059] posixtimers hash table entries: 2048 (order: 3, 32768 bytes, linear) vm-test-run-flakelet> machine # [ 0.017127] futex hash table entries: 1024 (65536 bytes on 1 NUMA nodes, total 64 KiB, linear). vm-test-run-flakelet> machine # [ 0.017298] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL vm-test-run-flakelet> machine # [ 0.017302] 0 pages in range for non-PLT usage vm-test-run-flakelet> machine # [ 0.017303] 508320 pages in range for PLT usage vm-test-run-flakelet> machine # [ 0.017431] pinctrl core: initialized pinctrl subsystem vm-test-run-flakelet> machine # [ 0.018127] DMI not present or invalid. vm-test-run-flakelet> machine # [ 0.021215] NET: Registered PF_NETLINK/PF_ROUTE protocol family vm-test-run-flakelet> machine # [ 0.023448] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations vm-test-run-flakelet> machine # [ 0.023625] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations vm-test-run-flakelet> machine # [ 0.023838] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations vm-test-run-flakelet> machine # [ 0.023859] audit: initializing netlink subsys (disabled) vm-test-run-flakelet> machine # [ 0.024285] audit: type=2000 audit(0.020:1): state=initialized audit_enabled=0 res=1 vm-test-run-flakelet> machine # [ 0.026371] thermal_sys: Registered thermal governor 'fair_share' vm-test-run-flakelet> machine # [ 0.026379] thermal_sys: Registered thermal governor 'bang_bang' vm-test-run-flakelet> machine # [ 0.026393] thermal_sys: Registered thermal governor 'step_wise' vm-test-run-flakelet> machine # [ 0.026401] thermal_sys: Registered thermal governor 'user_space' vm-test-run-flakelet> machine # [ 0.026408] thermal_sys: Registered thermal governor 'power_allocator' vm-test-run-flakelet> machine # [ 0.026518] cpuidle: using governor ladder vm-test-run-flakelet> machine # [ 0.026572] cpuidle: using governor menu vm-test-run-flakelet> machine # [ 0.027455] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers. vm-test-run-flakelet> machine # [ 0.027720] ASID allocator initialised with 65536 entries vm-test-run-flakelet> machine # [ 0.031439] Serial: AMBA PL011 UART driver vm-test-run-flakelet> machine # [ 0.047654] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 vm-test-run-flakelet> machine # [ 0.048266] printk: console [ttyAMA0] enabled vm-test-run-flakelet> machine # [ 0.058821] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages vm-test-run-flakelet> machine # [ 0.058842] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page vm-test-run-flakelet> machine # [ 0.058852] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages vm-test-run-flakelet> machine # [ 0.058860] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page vm-test-run-flakelet> machine # [ 0.058869] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages vm-test-run-flakelet> machine # [ 0.058877] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page vm-test-run-flakelet> machine # [ 0.058885] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages vm-test-run-flakelet> machine # [ 0.058893] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page vm-test-run-flakelet> machine # [ 0.072825] fbcon: Taking over console vm-test-run-flakelet> machine # [ 0.072854] ACPI: Interpreter disabled. vm-test-run-flakelet> machine # [ 0.075615] iommu: Default domain type: Translated vm-test-run-flakelet> machine # [ 0.075626] iommu: DMA domain TLB invalidation policy: strict mode vm-test-run-flakelet> machine # [ 0.082742] SCSI subsystem initialized vm-test-run-flakelet> machine # [ 0.083491] usbcore: registered new interface driver usbfs vm-test-run-flakelet> machine # [ 0.083574] usbcore: registered new interface driver hub vm-test-run-flakelet> machine # [ 0.083642] usbcore: registered new device driver usb vm-test-run-flakelet> machine # [ 0.084361] pps_core: LinuxPPS API ver. 1 registered vm-test-run-flakelet> machine # [ 0.084371] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti vm-test-run-flakelet> machine # [ 0.084436] PTP clock support registered vm-test-run-flakelet> machine # [ 0.084589] EDAC MC: Ver: 3.0.0 vm-test-run-flakelet> machine # [ 0.085186] scmi_core: SCMI protocol bus registered vm-test-run-flakelet> machine # [ 0.086282] FPGA manager framework vm-test-run-flakelet> machine # [ 0.087662] vgaarb: loaded vm-test-run-flakelet> machine # [ 0.090065] clocksource: Switched to clocksource arch_sys_counter vm-test-run-flakelet> machine # [ 0.093792] VFS: Disk quotas dquot_6.6.0 vm-test-run-flakelet> machine # [ 0.093851] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) vm-test-run-flakelet> machine # [ 0.094664] netfs: FS-Cache loaded vm-test-run-flakelet> machine # [ 0.094979] pnp: PnP ACPI: disabled vm-test-run-flakelet> machine # [ 0.104120] NET: Registered PF_INET protocol family vm-test-run-flakelet> machine # [ 0.105458] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) vm-test-run-flakelet> machine # [ 0.151811] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) vm-test-run-flakelet> machine # [ 0.151860] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) vm-test-run-flakelet> machine # [ 0.151900] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) vm-test-run-flakelet> machine # [ 0.152087] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) vm-test-run-flakelet> machine # [ 0.152487] TCP: Hash tables configured (established 32768 bind 32768) vm-test-run-flakelet> machine # [ 0.152604] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear) vm-test-run-flakelet> machine # [ 0.152650] UDP hash table entries: 2048 (order: 5, 131072 bytes, linear) vm-test-run-flakelet> machine # [ 0.152732] UDP-Lite hash table entries: 2048 (order: 5, 131072 bytes, linear) vm-test-run-flakelet> machine # [ 0.152877] NET: Registered PF_UNIX/PF_LOCAL protocol family vm-test-run-flakelet> machine # [ 0.152903] NET: Registered PF_XDP protocol family vm-test-run-flakelet> machine # [ 0.152919] PCI: CLS 0 bytes, default 64 vm-test-run-flakelet> machine # [ 0.153177] Trying to unpack rootfs image as initramfs... vm-test-run-flakelet> machine # [ 0.166958] kvm [1]: HYP mode not available vm-test-run-flakelet> machine # [ 0.234732] Initialise system trusted keyrings vm-test-run-flakelet> machine # [ 0.235238] workingset: timestamp_bits=42 max_order=20 bucket_order=0 vm-test-run-flakelet> machine # [ 0.238399] squashfs: version 4.0 (2009/01/31) Phillip Lougher vm-test-run-flakelet> machine # [ 0.242140] 9p: Installing v9fs 9p2000 file system support vm-test-run-flakelet> machine # [ 0.262243] Key type asymmetric registered vm-test-run-flakelet> machine # [ 0.262251] Asymmetric key parser 'x509' registered vm-test-run-flakelet> machine # [ 0.262321] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) vm-test-run-flakelet> machine # [ 0.262667] io scheduler mq-deadline registered vm-test-run-flakelet> machine # [ 0.262684] io scheduler kyber registered vm-test-run-flakelet> machine # [ 0.278917] pl061_gpio 9030000.pl061: PL061 GPIO chip registered vm-test-run-flakelet> machine # [ 0.282253] ledtrig-cpu: registered to indicate activity on CPUs vm-test-run-flakelet> machine # [ 0.283591] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: vm-test-run-flakelet> machine # [ 0.283644] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 vm-test-run-flakelet> machine # [ 0.283693] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 vm-test-run-flakelet> machine # [ 0.283713] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 vm-test-run-flakelet> machine # [ 0.283757] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits vm-test-run-flakelet> machine # [ 0.283825] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] vm-test-run-flakelet> machine # [ 0.284109] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 vm-test-run-flakelet> machine # [ 0.284129] pci_bus 0000:00: root bus resource [bus 00-ff] vm-test-run-flakelet> machine # [ 0.284140] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] vm-test-run-flakelet> machine # [ 0.284150] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] vm-test-run-flakelet> machine # [ 0.284159] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] vm-test-run-flakelet> machine # [ 0.284397] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.285924] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.286622] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] vm-test-run-flakelet> machine # [ 0.286671] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-flakelet> machine # [ 0.286754] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-flakelet> machine # [ 0.286805] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-flakelet> machine # [ 0.288350] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.289023] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] vm-test-run-flakelet> machine # [ 0.289059] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-flakelet> machine # [ 0.289154] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-flakelet> machine # [ 0.290739] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.291405] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] vm-test-run-flakelet> machine # [ 0.291441] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-flakelet> machine # [ 0.291533] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-flakelet> machine # [ 0.293110] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.293780] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] vm-test-run-flakelet> machine # [ 0.293816] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-flakelet> machine # [ 0.293895] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-flakelet> machine # [ 0.295454] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.296130] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] vm-test-run-flakelet> machine # [ 0.296166] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-flakelet> machine # [ 0.296248] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-flakelet> machine # [ 0.297808] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.298497] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] vm-test-run-flakelet> machine # [ 0.298533] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-flakelet> machine # [ 0.298613] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-flakelet> machine # [ 0.300146] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.300812] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] vm-test-run-flakelet> machine # [ 0.300849] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-flakelet> machine # [ 0.300942] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-flakelet> machine # [ 0.300978] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-flakelet> machine # [ 0.302641] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.303317] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-flakelet> machine # [ 0.303411] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-flakelet> machine # [ 0.305016] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.305674] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-flakelet> machine # [ 0.305765] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-flakelet> machine # [ 0.307140] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.307762] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] vm-test-run-flakelet> machine # [ 0.308606] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.309327] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] vm-test-run-flakelet> machine # [ 0.309363] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-flakelet> machine # [ 0.309457] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-flakelet> machine # [ 0.311074] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-flakelet> machine # [ 0.311717] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] vm-test-run-flakelet> machine # [ 0.311753] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-flakelet> machine # [ 0.311835] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-flakelet> machine # [ 0.313743] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned vm-test-run-flakelet> machine # [ 0.313761] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned vm-test-run-flakelet> machine # [ 0.313772] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned vm-test-run-flakelet> machine # [ 0.313914] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned vm-test-run-flakelet> machine # [ 0.314095] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned vm-test-run-flakelet> machine # [ 0.314258] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned vm-test-run-flakelet> machine # [ 0.314405] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned vm-test-run-flakelet> machine # [ 0.314542] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned vm-test-run-flakelet> machine # [ 0.314700] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned vm-test-run-flakelet> machine # [ 0.314839] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned vm-test-run-flakelet> machine # [ 0.314987] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned vm-test-run-flakelet> machine # [ 0.315133] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned vm-test-run-flakelet> machine # [ 0.315304] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned vm-test-run-flakelet> machine # [ 0.315448] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned vm-test-run-flakelet> machine # [ 0.315513] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned vm-test-run-flakelet> machine # [ 0.315570] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned vm-test-run-flakelet> machine # [ 0.315623] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned vm-test-run-flakelet> machine # [ 0.315690] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned vm-test-run-flakelet> machine # [ 0.315747] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned vm-test-run-flakelet> machine # [ 0.315804] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned vm-test-run-flakelet> machine # [ 0.315862] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned vm-test-run-flakelet> machine # [ 0.315929] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned vm-test-run-flakelet> machine # [ 0.315984] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned vm-test-run-flakelet> machine # [ 0.316039] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned vm-test-run-flakelet> machine # [ 0.316095] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned vm-test-run-flakelet> machine # [ 0.316149] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned vm-test-run-flakelet> machine # [ 0.316202] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned vm-test-run-flakelet> machine # [ 0.316255] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned vm-test-run-flakelet> machine # [ 0.316311] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned vm-test-run-flakelet> machine # [ 0.316363] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned vm-test-run-flakelet> machine # [ 0.316416] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned vm-test-run-flakelet> machine # [ 0.316469] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned vm-test-run-flakelet> machine # [ 0.316531] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned vm-test-run-flakelet> machine # [ 0.316585] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned vm-test-run-flakelet> machine # [ 0.316651] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] vm-test-run-flakelet> machine # [ 0.316666] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] vm-test-run-flakelet> machine # [ 0.316675] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] vm-test-run-flakelet> machine # [ 0.320924] pci 0000:00:0a.0: enabling device (0000 -> 0002) vm-test-run-flakelet> machine # [ 0.356426] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) vm-test-run-flakelet> machine # [ 0.361798] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) vm-test-run-flakelet> machine # [ 0.368238] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) vm-test-run-flakelet> machine # [ 0.374506] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) vm-test-run-flakelet> machine # [ 0.380704] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) vm-test-run-flakelet> machine # [ 0.387549] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) vm-test-run-flakelet> machine # [ 0.393388] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) vm-test-run-flakelet> machine # [ 0.400192] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) vm-test-run-flakelet> machine # [ 0.405991] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) vm-test-run-flakelet> machine # [ 0.411367] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) vm-test-run-flakelet> machine # [ 0.416936] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) vm-test-run-flakelet> machine # [ 0.432430] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled vm-test-run-flakelet> machine # [ 0.436460] msm_serial: driver initialized vm-test-run-flakelet> machine # [ 0.436884] SuperH (H)SCI(F) driver initialized vm-test-run-flakelet> machine # [ 0.437004] STM32 USART driver initialized vm-test-run-flakelet> machine # [ 0.468183] loop: module loaded vm-test-run-flakelet> machine # [ 0.468558] virtio_blk virtio5: 4/0/0 default/read/poll queues vm-test-run-flakelet> machine # [ 0.471678] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) vm-test-run-flakelet> machine # [ 0.475489] megasas: 07.734.00.00-rc1 vm-test-run-flakelet> machine # [ 0.476818] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] vm-test-run-flakelet> machine # [ 0.487358] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-flakelet> machine # [ 0.487454] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-flakelet> machine # [ 0.490845] Using buffer write method vm-test-run-flakelet> machine # [ 0.490893] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] vm-test-run-flakelet> machine # [ 0.493723] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-flakelet> machine # [ 0.493747] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-flakelet> machine # [ 0.496977] Using buffer write method vm-test-run-flakelet> machine # [ 0.497003] Concatenating MTD devices: vm-test-run-flakelet> machine # [ 0.497007] (0): "0.flash" vm-test-run-flakelet> machine # [ 0.497012] (1): "0.flash" vm-test-run-flakelet> machine # [ 0.497016] into device "0.flash" vm-test-run-flakelet> machine # [ 0.611497] Freeing initrd memory: 27052K vm-test-run-flakelet> machine # [ 0.629848] tun: Universal TUN/TAP device driver, 1.6 vm-test-run-flakelet> machine # [ 0.639159] thunder_xcv, ver 1.0 vm-test-run-flakelet> machine # [ 0.639264] thunder_bgx, ver 1.0 vm-test-run-flakelet> machine # [ 0.639345] nicpf, ver 1.0 vm-test-run-flakelet> machine # [ 0.641307] e1000: Intel(R) PRO/1000 Network Driver vm-test-run-flakelet> machine # [ 0.641321] e1000: Copyright (c) 1999-2006 Intel Corporation. vm-test-run-flakelet> machine # [ 0.641396] e1000e: Intel(R) PRO/1000 Network Driver vm-test-run-flakelet> machine # [ 0.641409] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. vm-test-run-flakelet> machine # [ 0.641474] igb: Intel(R) Gigabit Ethernet Network Driver vm-test-run-flakelet> machine # [ 0.641483] igb: Copyright (c) 2007-2014 Intel Corporation. vm-test-run-flakelet> machine # [ 0.641763] igbvf: Intel(R) Gigabit Virtual Function Network Driver vm-test-run-flakelet> machine # [ 0.641774] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. vm-test-run-flakelet> machine # [ 0.642224] sky2: driver version 1.30 vm-test-run-flakelet> machine # [ 0.646906] ehci-pci 0000:00:0a.0: EHCI Host Controller vm-test-run-flakelet> machine # [ 0.646938] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 vm-test-run-flakelet> machine # [ 0.647247] usbcore: registered new interface driver usb-storage vm-test-run-flakelet> machine # [ 0.647387] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 vm-test-run-flakelet> machine # [ 0.647654] usbcore: registered new interface driver usbserial_generic vm-test-run-flakelet> machine # [ 0.647695] usbserial: USB Serial support registered for generic vm-test-run-flakelet> machine # [ 0.649610] hv_vmbus: registering driver hyperv_keyboard vm-test-run-flakelet> machine # [ 0.652181] rtc-pl031 9010000.pl031: registered as rtc0 vm-test-run-flakelet> machine # [ 0.652238] rtc-pl031 9010000.pl031: setting system clock to 2026-08-27T21:37:20 UTC (1787866640) vm-test-run-flakelet> machine # [ 0.653197] i2c_dev: i2c /dev entries driver vm-test-run-flakelet> machine # [ 0.658170] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 vm-test-run-flakelet> machine # [ 0.658940] hub 1-0:1.0: USB hub found vm-test-run-flakelet> machine # [ 0.658974] hub 1-0:1.0: 6 ports detected vm-test-run-flakelet> machine # [ 0.661889] sdhci: Secure Digital Host Controller Interface driver vm-test-run-flakelet> machine # [ 0.661902] sdhci: Copyright(c) Pierre Ossman vm-test-run-flakelet> machine # [ 0.662762] Synopsys Designware Multimedia Card Interface Driver vm-test-run-flakelet> machine # [ 0.663957] sdhci-pltfm: SDHCI platform and OF driver helper vm-test-run-flakelet> machine # [ 0.668964] hid: raw HID events driver (C) Jiri Kosina vm-test-run-flakelet> machine # [ 0.669791] usbcore: registered new interface driver usbhid vm-test-run-flakelet> machine # [ 0.669802] usbhid: USB HID core driver vm-test-run-flakelet> machine # [ 0.680582] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available vm-test-run-flakelet> machine # [ 0.685468] drop_monitor: Initializing network drop monitor service vm-test-run-flakelet> machine # [ 0.685832] NET: Registered PF_INET6 protocol family vm-test-run-flakelet> machine # [ 0.687872] Segment Routing with IPv6 vm-test-run-flakelet> machine # [ 0.687907] In-situ OAM (IOAM) with IPv6 vm-test-run-flakelet> machine # [ 0.687975] NET: Registered PF_PACKET protocol family vm-test-run-flakelet> machine # [ 0.688297] 9pnet: Installing 9P2000 support vm-test-run-flakelet> machine # [ 0.694586] Key type dns_resolver registered vm-test-run-flakelet> machine # [ 0.712077] registered taskstats version 1 vm-test-run-flakelet> machine # [ 0.712642] Loading compiled-in X.509 certificates vm-test-run-flakelet> machine # [ 0.732263] Demotion targets for Node 0: null vm-test-run-flakelet> machine # [ 0.732542] Key type .fscrypt registered vm-test-run-flakelet> machine # [ 0.732551] Key type fscrypt-provisioning registered vm-test-run-flakelet> machine # [ 0.732734] ima: No TPM chip found, activating TPM-bypass! vm-test-run-flakelet> machine # [ 0.732758] ima: Allocated hash algorithm: sha1 vm-test-run-flakelet> machine # [ 0.732791] ima: No architecture policies found vm-test-run-flakelet> machine # [ 0.733904] input: gpio-keys as /devices/platform/gpio-keys/input/input0 vm-test-run-flakelet> machine # [ 0.760500] clk: Disabling unused clocks vm-test-run-flakelet> machine # [ 0.760527] PM: genpd: Disabling unused power domains vm-test-run-flakelet> machine # [ 0.765269] Freeing unused kernel memory: 4736K vm-test-run-flakelet> machine # [ 0.765508] Run /init as init process vm-test-run-flakelet> machine # [ 0.797025] systemd[1]: Successfully made /usr/ read-only. vm-test-run-flakelet> machine # [ 0.906134] usb 1-1: new high-speed USB device number 2 using ehci-pci vm-test-run-flakelet> machine # [ 1.060821] 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-flakelet> machine # [ 1.131827] systemd[1]: systemd 261 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -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-flakelet> machine # [ 1.131892] systemd[1]: Detected virtualization qemu. vm-test-run-flakelet> machine # [ 1.131955] systemd[1]: Detected architecture arm64. vm-test-run-flakelet> machine # [ 1.131969] systemd[1]: Running in initrd. vm-test-run-flakelet> machine # [ 1.132816] systemd[1]: Initializing machine ID from random generator. vm-test-run-flakelet> machine # [ 1.133169] systemd[1]: Hostname set to . vm-test-run-flakelet> machine # [ 1.170811] 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-flakelet> machine # [ 1.290133] usb 1-2: new high-speed USB device number 3 using ehci-pci vm-test-run-flakelet> machine # [ 1.352089] systemd[1]: bpf-restrict-fs: LSM BPF program attached vm-test-run-flakelet> machine # [ 1.430934] systemd[1]: Queued start job for default target Initrd Default Target. vm-test-run-flakelet> machine # [ 1.453536] systemd[1]: Created slice Slice /system/modprobe. vm-test-run-flakelet> machine # [ 1.453839] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. vm-test-run-flakelet> machine # [ 1.453878] systemd[1]: Expecting device /dev/disk/by-label/nixos... vm-test-run-flakelet> machine # [ 1.453908] systemd[1]: Reached target Path Units. vm-test-run-flakelet> machine # [ 1.453929] systemd[1]: Reached target Slice Units. vm-test-run-flakelet> machine # [ 1.453951] systemd[1]: Reached target Swaps. vm-test-run-flakelet> machine # [ 1.453969] systemd[1]: Reached target Timer Units. vm-test-run-flakelet> machine # [ 1.454275] systemd[1]: Listening on D-Bus System Message Bus Socket. vm-test-run-flakelet> machine # [ 1.454474] systemd[1]: Listening on Journal Socket (/dev/log). vm-test-run-flakelet> machine # [ 1.454665] systemd[1]: Listening on Journal Sockets. vm-test-run-flakelet> machine # [ 1.454841] systemd[1]: Listening on udev Control Socket. vm-test-run-flakelet> machine # [ 1.454947] systemd[1]: Listening on udev Kernel Socket. vm-test-run-flakelet> machine # [ 1.454970] systemd[1]: Reached target Socket Units. vm-test-run-flakelet> machine # [ 1.457073] systemd[1]: Starting Create List of Static Device Nodes... vm-test-run-flakelet> machine # [ 1.459166] systemd[1]: Starting Load Kernel Module 9pnet_virtio... vm-test-run-flakelet> machine # [ 1.459248] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs vm-test-run-flakelet> machine # [ 1.461219] systemd[1]: Mounting Kernel Configuration File System... vm-test-run-flakelet> machine # [ 1.464866] 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-flakelet> machine # [ 1.465220] 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-flakelet> machine # [ 1.488024] systemd[1]: Starting Journal Service... vm-test-run-flakelet> machine # [ 1.490193] systemd[1]: Starting Load Kernel Modules... vm-test-run-flakelet> machine # [ 1.490307] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os vm-test-run-flakelet> machine # [ 1.496794] systemd[1]: Starting Coldplug All udev Devices... vm-test-run-flakelet> machine # [ 1.498632] systemd[1]: Finished Create List of Static Device Nodes. vm-test-run-flakelet> machine # [ 1.499651] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 1.500016] systemd[1]: Finished Load Kernel Module 9pnet_virtio. vm-test-run-flakelet> machine # [ 1.500297] systemd[1]: Mounted Kernel Configuration File System. vm-test-run-flakelet> machine # [ 1.522951] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... vm-test-run-flakelet> machine # [ 1.530575] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. vm-test-run-flakelet> machine # [ 1.530769] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev vm-test-run-flakelet> machine # [ 1.538459] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0 vm-test-run-flakelet> machine # [ 1.538612] [drm] features: -virgl +edid -resource_blob -host_visible vm-test-run-flakelet> machine # [ 1.538615] [drm] features: -context_init vm-test-run-flakelet> machine # [ 1.539385] [drm] number of scanouts: 1 vm-test-run-flakelet> machine # [ 1.539403] [drm] number of cap sets: 0 vm-test-run-flakelet> machine # [ 1.546121] systemd-journald[94]: Collecting audit messages is disabled. vm-test-run-flakelet> machine # [ 1.548819] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. vm-test-run-flakelet> machine # [ 1.551198] systemd[1]: Starting Create Static Device Nodes in /dev... vm-test-run-flakelet> machine # [ 1.554498] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic vm-test-run-flakelet> machine # [ 1.554532] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0 vm-test-run-flakelet> machine # [ 1.566752] systemd[1]: Finished Create Static Device Nodes in /dev. vm-test-run-flakelet> machine # [ 1.566949] systemd[1]: Reached target Preparation for Local File Systems. vm-test-run-flakelet> machine # [ 1.566981] systemd[1]: Reached target Local File Systems. vm-test-run-flakelet> machine # [ 1.567246] Console: switching to colour frame buffer device 160x50 vm-test-run-flakelet> machine # [ 1.577519] systemd[1]: Starting Rule-based Manager for Device Events and Files... vm-test-run-flakelet> machine # [ 1.583408] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device vm-test-run-flakelet> machine # [ 1.611054] systemd[1]: Started Journal Service. vm-test-run-flakelet> machine # [ 1.609205] systemd-modules-load[95]: Using 4 probe threads vm-test-run-flakelet> machine # [ 1.612922] systemd-modules-load[95]: Module 'virtio_balloon' is built in vm-test-run-flakelet> machine # [ 1.614679] systemd-modules-load[95]: Module 'virtio_console' is built in vm-test-run-flakelet> machine # [ 1.615846] systemd-modules-load[95]: Module 'virtio_rng' is built in vm-test-run-flakelet> machine # [ 1.617588] systemd-modules-load[95]: Inserted module 'dm_mod' vm-test-run-flakelet> machine # [ 1.618591] systemd[1]: Starting Create System Files and Directories... vm-test-run-flakelet> machine # [ 1.619856] systemd-udevd[105]: Using default interface naming scheme 'v261'. vm-test-run-flakelet> machine # [ 1.621145] systemd-modules-load[95]: Inserted module 'virtio_gpu' vm-test-run-flakelet> machine # [ 1.622104] systemd[1]: Finished Load Kernel Modules. vm-test-run-flakelet> machine # [ 1.642457] systemd[1]: Starting Apply Kernel Variables... vm-test-run-flakelet> machine # [ 1.660610] systemd[1]: Started Rule-based Manager for Device Events and Files. vm-test-run-flakelet> machine # [ 1.665428] systemd[1]: Finished Create System Files and Directories. vm-test-run-flakelet> machine # [ 1.672180] systemd[1]: Finished Apply Kernel Variables. vm-test-run-flakelet> machine # [ 1.707762] systemd[1]: Starting Virtual Console Setup... vm-test-run-flakelet> machine # [ 1.754774] systemd-vconsole-setup[133]: Configuration of first virtual console was skipped, ignoring remaining ones. vm-test-run-flakelet> machine # [ 1.759901] systemd[1]: Finished Virtual Console Setup. vm-test-run-flakelet> machine # [ 2.138544] systemd[1]: Finished Coldplug All udev Devices. vm-test-run-flakelet> machine # [ 2.141130] systemd[1]: Reached target System Initialization. vm-test-run-flakelet> machine # [ 2.143601] systemd[1]: Reached target Basic System. vm-test-run-flakelet> machine # [ 2.313256] (udev-worker)[142]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-flakelet> machine # [ 2.334831] (udev-worker)[120]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. vm-test-run-flakelet> machine # [ 2.339974] (udev-worker)[120]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-flakelet> machine # [ 2.378355] systemd[1]: Found device /dev/disk/by-label/nixos. vm-test-run-flakelet> machine # [ 2.380482] systemd[1]: Reached target Initrd Root Device. vm-test-run-flakelet> machine # [ 2.381580] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... vm-test-run-flakelet> machine # [ 2.431993] systemd-fsck[155]: nixos: clean, 1200/65536 files, 18895/262144 blocks vm-test-run-flakelet> machine # [ 2.439502] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. vm-test-run-flakelet> machine # [ 2.497363] systemd[1]: Mounting /sysroot... vm-test-run-flakelet> machine # [ 2.536093] EXT4-fs (vda): mounted filesystem 73b53e32-2e1f-4de8-ae93-386325cdf32f r/w with ordered data mode. Quota mode: none. vm-test-run-flakelet> machine # [ 2.537864] systemd[1]: Mounted /sysroot. vm-test-run-flakelet> machine # [ 2.540106] systemd[1]: Reached target Initrd Root File System. vm-test-run-flakelet> machine # [ 2.543645] systemd[1]: Mounting /sysroot/nix/.ro-store... vm-test-run-flakelet> machine # [ 2.547550] systemd[1]: Mounting /sysroot/run... vm-test-run-flakelet> machine # [ 2.570284] systemd[1]: Mounting /sysroot/tmp/shared... vm-test-run-flakelet> machine # [ 2.579697] systemd[1]: Mounting /sysroot/tmp/xchg... vm-test-run-flakelet> machine # [ 2.583561] systemd[1]: Starting Mountpoints Configured in the Real Root... vm-test-run-flakelet> machine # [ 2.592264] systemd[1]: Starting rw-sysroot-nix-store.service... vm-test-run-flakelet> machine # [ 2.599695] systemd[1]: Mounted /sysroot/nix/.ro-store. vm-test-run-flakelet> machine # [ 2.602239] systemd[1]: Mounted /sysroot/run. vm-test-run-flakelet> machine # [ 2.603268] systemd[1]: Mounted /sysroot/tmp/shared. vm-test-run-flakelet> machine # [ 2.604816] systemd[1]: Mounted /sysroot/tmp/xchg. vm-test-run-flakelet> machine # [ 2.607009] systemd-sysroot-fstab-check[167]: /sysroot should be mounted in the initrd, will request daemon-reload. vm-test-run-flakelet> machine # [ 2.613445] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 2.614953] systemd[1]: Finished rw-sysroot-nix-store.service. vm-test-run-flakelet> machine # [ 2.616167] systemd[1]: Reload requested from client PID 167 ('systemd-sysroot') (unit initrd-parse-etc.service)... vm-test-run-flakelet> machine # [ 2.618461] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 2.722328] systemd[1]: Reloading finished in 106 ms. vm-test-run-flakelet> machine # [ 2.778137] systemd-sysroot-fstab-check[167]: Requesting initrd-fs.target/start/replace... vm-test-run-flakelet> machine # [ 2.780114] systemd-sysroot-fstab-check[167]: Requesting swap.target/start/replace... vm-test-run-flakelet> machine # [ 2.782391] systemd[1]: Starting rw-sysroot-nix-store.service... vm-test-run-flakelet> machine # [ 2.785245] systemd[1]: initrd-parse-etc.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 2.797461] systemd[1]: Finished Mountpoints Configured in the Real Root. vm-test-run-flakelet> machine # [ 2.800183] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. vm-test-run-flakelet> machine # [ 2.803731] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 2.805061] systemd[1]: Finished rw-sysroot-nix-store.service. vm-test-run-flakelet> machine # [ 2.936727] (udev-worker)[145]: mtd0ro: Failed to find and pin callout binary "/nix/store/z2nxjmk4666nbka3hgyxlg13prrnvx38-systemd-261/lib/udev/mtd_probe": No such file or directory vm-test-run-flakelet> machine # [ 2.940179] (udev-worker)[145]: mtd0ro: /nix/store/z2nxjmk4666nbka3hgyxlg13prrnvx38-systemd-261/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-flakelet> machine # [ 2.949554] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 2.950662] systemd[1]: Stopped Virtual Console Setup. vm-test-run-flakelet> machine # [ 2.951411] systemd[1]: Stopping Virtual Console Setup... vm-test-run-flakelet> machine # [ 2.952291] systemd[1]: Starting Virtual Console Setup... vm-test-run-flakelet> machine # [ 2.994213] systemd-vconsole-setup[195]: Configuration of first virtual console was skipped, ignoring remaining ones. vm-test-run-flakelet> machine # [ 2.996341] systemd[1]: Finished Virtual Console Setup. vm-test-run-flakelet> machine # [ 3.501808] systemd[1]: Mounting /sysroot/nix/store... vm-test-run-flakelet> machine # [ 3.577258] systemd[1]: Mounted /sysroot/nix/store. vm-test-run-flakelet> machine # [ 3.579501] systemd[1]: Reached target Initrd File Systems. vm-test-run-flakelet> machine # [ 3.582108] systemd[1]: Starting Find NixOS closure... vm-test-run-flakelet> machine # [ 3.584949] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... vm-test-run-flakelet> machine # [ 3.627458] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. vm-test-run-flakelet> machine # [ 3.631105] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.649028] systemd[1]: Finished Find NixOS closure. vm-test-run-flakelet> machine # [ 3.651335] systemd[1]: Reached target Initrd Default Target. vm-test-run-flakelet> machine # [ 3.653945] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... vm-test-run-flakelet> machine # [ 3.702260] systemd[1]: Stopped target Initrd Default Target. vm-test-run-flakelet> machine # [ 3.704864] systemd[1]: Stopped target Basic System. vm-test-run-flakelet> machine # [ 3.707063] systemd[1]: Stopped target Initrd Root Device. vm-test-run-flakelet> machine # [ 3.709533] systemd[1]: Stopped target Path Units. vm-test-run-flakelet> machine # [ 3.711642] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.714983] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. vm-test-run-flakelet> machine # [ 3.718355] systemd[1]: Stopped target Slice Units. vm-test-run-flakelet> machine # [ 3.720581] systemd[1]: Stopped target Socket Units. vm-test-run-flakelet> machine # [ 3.722771] systemd[1]: Stopped target System Initialization. vm-test-run-flakelet> machine # [ 3.728109] systemd[1]: Stopped target Swaps. vm-test-run-flakelet> machine # [ 3.731667] systemd[1]: Stopped target Timer Units. vm-test-run-flakelet> machine # [ 3.734132] systemd[1]: dbus.socket: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.738171] systemd[1]: Closed D-Bus System Message Bus Socket. vm-test-run-flakelet> machine # [ 3.744734] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.747460] systemd[1]: Stopped Find NixOS closure. vm-test-run-flakelet> machine # [ 3.749387] systemd[1]: Starting Load Kernel Module 9pnet_virtio... vm-test-run-flakelet> machine # [ 3.751618] systemd[1]: Starting rw-sysroot-nix-store.service... vm-test-run-flakelet> machine # [ 3.753781] systemd[1]: systemd-sysctl.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.755862] systemd[1]: Stopped Apply Kernel Variables. vm-test-run-flakelet> machine # [ 3.757758] systemd[1]: systemd-modules-load.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.759842] systemd[1]: Stopped Load Kernel Modules. vm-test-run-flakelet> machine # [ 3.761397] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.763557] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. vm-test-run-flakelet> machine # [ 3.765867] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.767766] systemd[1]: Stopped Create System Files and Directories. vm-test-run-flakelet> machine # [ 3.769510] systemd[1]: Stopped target Local File Systems. vm-test-run-flakelet> machine # [ 3.770991] systemd[1]: Stopped target Preparation for Local File Systems. vm-test-run-flakelet> machine # [ 3.772756] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.774542] systemd[1]: Stopped Coldplug All udev Devices. vm-test-run-flakelet> machine # [ 3.775938] systemd[1]: Stopping Rule-based Manager for Device Events and Files... vm-test-run-flakelet> machine # [ 3.777915] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.779757] systemd[1]: Stopped Virtual Console Setup. vm-test-run-flakelet> machine # [ 3.781161] systemd[1]: initrd-cleanup.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.782836] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. vm-test-run-flakelet> machine # [ 3.784511] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.786298] systemd[1]: Finished rw-sysroot-nix-store.service. vm-test-run-flakelet> machine # [ 3.787768] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.789702] systemd[1]: Finished Load Kernel Module 9pnet_virtio. vm-test-run-flakelet> machine # [ 3.791226] systemd[1]: systemd-udevd.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.792937] systemd[1]: Stopped Rule-based Manager for Device Events and Files. vm-test-run-flakelet> machine # [ 3.794725] systemd[1]: systemd-udevd.service: Consumed 2.271s CPU time over 2.194s wall clock time, 31.6M memory peak. vm-test-run-flakelet> machine # [ 3.797336] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.799111] systemd[1]: Closed udev Control Socket. vm-test-run-flakelet> machine # [ 3.800519] systemd[1]: Starting Cleanup udev Database... vm-test-run-flakelet> machine # [ 3.801820] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.803558] systemd[1]: Stopped Create Static Device Nodes in /dev. vm-test-run-flakelet> machine # [ 3.805038] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.806822] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. vm-test-run-flakelet> machine # [ 3.808363] systemd[1]: kmod-static-nodes.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.809837] systemd[1]: Stopped Create List of Static Device Nodes. vm-test-run-flakelet> machine # [ 3.869959] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 3.873401] systemd[1]: Finished Cleanup udev Database. vm-test-run-flakelet> machine # [ 3.875700] systemd[1]: Reached target Switch Root. vm-test-run-flakelet> machine # [ 3.878044] systemd[1]: Starting NixOS Activation... vm-test-run-flakelet> machine # [ 4.131008] initrd-nixos-activation-start[220]: booting system configuration /nix/store/3z6a3hbfvlkx90987w1sw3qzzyh28d1z-nixos-system-machine-test vm-test-run-flakelet> machine # [ 4.228865] initrd-nixos-activation-start[220]: running activation script... vm-test-run-flakelet> machine # [ 4.733569] initrd-nixos-activation-start[243]: setting up /etc... vm-test-run-flakelet> machine # [ 5.129207] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 5.132715] systemd[1]: Finished NixOS Activation. vm-test-run-flakelet> machine # [ 5.134865] systemd[1]: Starting Switch Root... vm-test-run-flakelet> machine # [ 5.176433] systemd[1]: Switching root. vm-test-run-flakelet> machine # [ 5.303464] systemd-journald[94]: Received SIGTERM from PID 1 (systemd). vm-test-run-flakelet> machine # [ 5.979244] systemd[1]: systemd 261 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -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-flakelet> machine # [ 5.979376] systemd[1]: Detected virtualization qemu. vm-test-run-flakelet> machine # [ 5.979458] systemd[1]: Detected architecture arm64. vm-test-run-flakelet> machine # [ 6.227377] systemd[1]: bpf-restrict-fs: LSM BPF program attached vm-test-run-flakelet> machine # [ 7.270909] systemd[1]: initrd-switch-root.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 7.271513] systemd[1]: Stopped initrd-switch-root.service. vm-test-run-flakelet> machine # [ 7.280340] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. vm-test-run-flakelet> machine # [ 7.288209] systemd[1]: Created slice Slice /system/getty. vm-test-run-flakelet> machine # [ 7.293367] systemd[1]: Created slice User and Session Slice. vm-test-run-flakelet> machine # [ 7.294656] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. vm-test-run-flakelet> machine # [ 7.295575] systemd[1]: Started Forward Password Requests to Wall Directory Watch. vm-test-run-flakelet> machine # [ 7.296017] systemd[1]: Expecting device /dev/hvc0... vm-test-run-flakelet> machine # [ 7.296940] systemd[1]: Expecting device /dev/ttyAMA0... vm-test-run-flakelet> machine # [ 7.297835] systemd[1]: Reached target Local Encrypted Volumes. vm-test-run-flakelet> machine # [ 7.298850] systemd[1]: Reached target flakelet contract providers ready. vm-test-run-flakelet> machine # [ 7.299720] systemd[1]: Stopped target initrd-fs.target. vm-test-run-flakelet> machine # [ 7.300624] systemd[1]: Stopped target initrd-root-fs.target. vm-test-run-flakelet> machine # [ 7.301618] systemd[1]: Stopped target initrd-switch-root.target. vm-test-run-flakelet> machine # [ 7.303540] systemd[1]: Reached target Virtual Machines and Containers. vm-test-run-flakelet> machine # [ 7.305169] systemd[1]: Reached target Path Units. vm-test-run-flakelet> machine # [ 7.306866] systemd[1]: Reached target Remote File Systems. vm-test-run-flakelet> machine # [ 7.308527] systemd[1]: Reached target Slice Units. vm-test-run-flakelet> machine # [ 7.309959] systemd[1]: Reached target Swaps. vm-test-run-flakelet> machine # [ 7.319604] systemd[1]: Listening on Query the User Interactively for a Password. vm-test-run-flakelet> machine # [ 7.329954] systemd[1]: Listening on Process Core Dump Socket. vm-test-run-flakelet> machine # [ 7.338532] systemd[1]: Listening on Credential Encryption/Decryption. vm-test-run-flakelet> machine # [ 7.347100] systemd[1]: Listening on Factory Reset Management. vm-test-run-flakelet> machine # [ 7.349468] systemd[1]: Listening on Hostname Service Socket. vm-test-run-flakelet> machine # [ 7.363837] systemd[1]: Starting Journal Log Access Socket... vm-test-run-flakelet> machine # [ 7.367361] systemd[1]: Listening on Journal Audit Socket. vm-test-run-flakelet> machine # [ 7.375272] systemd[1]: Listening on Console Output Muting Service Socket. vm-test-run-flakelet> machine # [ 7.377325] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. vm-test-run-flakelet> machine # [ 7.378720] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os vm-test-run-flakelet> machine # [ 7.379738] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki vm-test-run-flakelet> machine # [ 7.396409] systemd[1]: Listening on Disk Repartitioning Service Socket. vm-test-run-flakelet> machine # [ 7.397851] systemd[1]: Listening on udev Control Socket. vm-test-run-flakelet> machine # [ 7.399363] systemd[1]: Listening on udev Varlink Socket. vm-test-run-flakelet> machine # [ 7.409267] systemd[1]: Mounting Huge Pages File System... vm-test-run-flakelet> machine # [ 7.416315] systemd[1]: Mounting POSIX Message Queue File System... vm-test-run-flakelet> machine # [ 7.423998] systemd[1]: Mounting Kernel Debug File System... vm-test-run-flakelet> machine # [ 7.436773] systemd[1]: Mounting Kernel Trace File System... vm-test-run-flakelet> machine # [ 7.453708] systemd[1]: Starting Create List of Static Device Nodes... vm-test-run-flakelet> machine # [ 7.468308] systemd[1]: Starting Load Kernel Module 9pnet_virtio... vm-test-run-flakelet> machine # [ 7.470317] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs vm-test-run-flakelet> machine # [ 7.482943] systemd[1]: Mounting Kernel Configuration File System... vm-test-run-flakelet> machine # [ 7.484473] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm vm-test-run-flakelet> machine # [ 7.485779] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore vm-test-run-flakelet> machine # [ 7.495347] systemd[1]: Starting Load Kernel Module fuse... vm-test-run-flakelet> machine # [ 7.498357] 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-flakelet> machine # [ 7.538457] systemd[1]: Starting Journal Service... vm-test-run-flakelet> machine # [ 7.563382] systemd[1]: Starting Load Kernel Modules... vm-test-run-flakelet> machine # [ 7.607600] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... vm-test-run-flakelet> machine # [ 7.622293] systemd[1]: Starting Remount Root and Kernel File Systems... vm-test-run-flakelet> machine # [ 7.623353] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os vm-test-run-flakelet> machine # [ 7.637552] fuse: init (API version 7.45) vm-test-run-flakelet> machine # [ 7.644022] systemd[1]: Starting Coldplug All udev Devices... vm-test-run-flakelet> machine # [ 7.657441] systemd[1]: Listening on Journal Log Access Socket. vm-test-run-flakelet> machine # [ 7.660220] systemd[1]: Mounted Huge Pages File System. vm-test-run-flakelet> machine # [ 7.662916] systemd[1]: Mounted POSIX Message Queue File System. vm-test-run-flakelet> machine # [ 7.665128] systemd[1]: Mounted Kernel Debug File System. vm-test-run-flakelet> machine # [ 7.667103] systemd[1]: Mounted Kernel Trace File System. vm-test-run-flakelet> machine # [ 7.670507] systemd[1]: Finished Create List of Static Device Nodes. vm-test-run-flakelet> machine # [ 7.673709] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 7.676252] systemd[1]: Finished Load Kernel Module 9pnet_virtio. vm-test-run-flakelet> machine # [ 7.679249] systemd[1]: Mounted Kernel Configuration File System. vm-test-run-flakelet> machine # [ 7.680480] systemd-journald[314]: Collecting audit messages is enabled. vm-test-run-flakelet> machine # [ 7.681657] systemd[1]: modprobe@fuse.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 7.684305] systemd[1]: Finished Load Kernel Module fuse. vm-test-run-flakelet> machine # [ 7.697297] systemd[1]: Queued start job for default target Multi-User System. vm-test-run-flakelet> machine # [ 7.698874] systemd[1]: Mounting FUSE Control File System... vm-test-run-flakelet> machine # [ 7.710931] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... vm-test-run-flakelet> machine # [ 7.711872] systemd[1]: Started Journal Service. vm-test-run-flakelet> machine # [ 7.716214] systemd[1]: systemd-journald.service: Deactivated successfully.[ 7.719004] EXT4-fs (vda): re-mounted 73b53e32-2e1f-4de8-ae93-386325cdf32f. vm-test-run-flakelet> machine # vm-test-run-flakelet> machine # [ 7.722993] systemd-modules-load[315]: Using 2 probe threads vm-test-run-flakelet> machine # [ 7.724445] systemd-modules-load[315]: Module 'atkbd' is built in vm-test-run-flakelet> machine # [ 7.725696] systemd-modules-load[315]: Module 'loop' is built in vm-test-run-flakelet> machine # [ 7.732756] systemd[1]: Finished Load Kernel Modules. vm-test-run-flakelet> machine # [ 7.734821] systemd[1]: Finished Remount Root and Kernel File Systems. vm-test-run-flakelet> machine # [ 7.748151] systemd[1]: Listening on Disk Image Download Service Socket. vm-test-run-flakelet> machine # [ 7.757055] systemd[1]: Starting Firewall... vm-test-run-flakelet> machine # [ 7.761203] systemd[1]: Starting Flush Journal to Persistent Storage... vm-test-run-flakelet> machine # [ 7.764818] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore vm-test-run-flakelet> machine # [ 7.768506] systemd[1]: Starting Load/Save OS Random Seed... vm-test-run-flakelet> machine # [ 7.778623] systemd-oomd[317]: No swap; memory pressure usage will be degraded vm-test-run-flakelet> machine # [ 7.784295] systemd[1]: Starting Apply Kernel Variables... vm-test-run-flakelet> machine # [ 7.787275] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os vm-test-run-flakelet> machine # [ 7.790092] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. vm-test-run-flakelet> machine # [ 7.791539] systemd[1]: Mounted FUSE Control File System. vm-test-run-flakelet> machine # [ 7.823348] systemd-journald[314]: Received client request to flush runtime journal. vm-test-run-flakelet> machine # [ 7.863499] systemd[1]: Finished Load/Save OS Random Seed. vm-test-run-flakelet> machine # [ 7.868847] systemd[1]: First Boot Complete skipped, unmet condition check ConditionFirstBoot=yes vm-test-run-flakelet> machine # [ 7.874788] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. vm-test-run-flakelet> machine # [ 7.880743] systemd[1]: Starting Create Static Device Nodes in /dev... vm-test-run-flakelet> machine # [ 7.887457] systemd[1]: Finished Flush Journal to Persistent Storage. vm-test-run-flakelet> machine # [ 7.892145] systemd[1]: Finished Apply Kernel Variables. vm-test-run-flakelet> machine # [ 7.923874] systemd[1]: Finished Create Static Device Nodes in /dev. vm-test-run-flakelet> machine # [ 7.926055] systemd[1]: Reached target Preparation for Local File Systems. vm-test-run-flakelet> machine # [ 7.934488] systemd[1]: Starting Rule-based Manager for Device Events and Files... vm-test-run-flakelet> machine # [ 8.045620] systemd-udevd[354]: Using default interface naming scheme 'v261'. vm-test-run-flakelet> machine # [ 8.231266] systemd[1]: Started Rule-based Manager for Device Events and Files. vm-test-run-flakelet> machine # [ 8.274686] systemd[1]: Mounting /run/wrappers... vm-test-run-flakelet> machine # [ 8.329472] systemd[1]: Mounted /run/wrappers. vm-test-run-flakelet> machine # [ 8.333062] systemd[1]: Reached target Local File Systems. vm-test-run-flakelet> machine # [ 8.335598] systemd[1]: Listening on Boot Loader Control Service Socket. vm-test-run-flakelet> machine # [ 8.338796] systemd[1]: Starting register-nix-paths.service... vm-test-run-flakelet> machine # [ 8.344465] systemd[1]: Starting Create SUID/SGID Wrappers... vm-test-run-flakelet> machine # [ 8.346928] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. vm-test-run-flakelet> machine # [ 8.351896] systemd[1]: Save Transient machine-id to Disk skipped, unmet condition check ConditionPathIsMountPoint=/etc/machine-id vm-test-run-flakelet> machine # [ 8.369713] systemd[1]: Starting Create System Files and Directories... vm-test-run-flakelet> machine # [ 8.473467] systemd[1]: Finished Create System Files and Directories. vm-test-run-flakelet> machine # [ 8.476198] systemd[1]: Rebuild Journal Catalog skipped, unmet condition check ConditionNeedsUpdate=/var vm-test-run-flakelet> machine # [ 8.478008] systemd[1]: Update is Completed skipped, no trigger condition checks were met. vm-test-run-flakelet> machine # [ 8.481377] systemd[1]: Starting Record System Boot/Shutdown in UTMP... vm-test-run-flakelet> machine # [ 8.532804] systemd[1]: Finished Record System Boot/Shutdown in UTMP. vm-test-run-flakelet> machine # [ 8.549495] systemd[1]: Finished Coldplug All udev Devices. vm-test-run-flakelet> machine # [ 8.591582] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs vm-test-run-flakelet> machine # [ 8.648604] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. vm-test-run-flakelet> machine # [ 8.716733] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. vm-test-run-flakelet> machine # [ 8.820824] (udev-worker)[388]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. vm-test-run-flakelet> machine # [ 8.825146] (udev-worker)[388]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-flakelet> machine # [ 8.828396] (udev-worker)[462]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-flakelet> machine # [ 8.833051] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 8.841131] systemd[1]: Finished Create SUID/SGID Wrappers. vm-test-run-flakelet> machine # [ 8.852933] systemd[1]: Condition check resulted in Virtio network device being skipped. vm-test-run-flakelet> machine # [ 8.854749] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore vm-test-run-flakelet> machine # [ 8.858454] systemd[1]: Starting Create SUID/SGID Wrappers... vm-test-run-flakelet> machine # [ 8.859811] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. vm-test-run-flakelet> machine # [ 8.861514] 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-flakelet> machine # [ 8.864109] systemd[1]: Rebuild Journal Catalog skipped, unmet condition check ConditionNeedsUpdate=/var vm-test-run-flakelet> machine # [ 8.865762] systemd[1]: Save Transient machine-id to Disk skipped, unmet condition check ConditionPathIsMountPoint=/etc/machine-id vm-test-run-flakelet> machine # [ 8.867499] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore vm-test-run-flakelet> machine # [ 8.869594] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os vm-test-run-flakelet> machine # [ 8.871138] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os vm-test-run-flakelet> machine # [ 8.872626] systemd[1]: Update is Completed skipped, no trigger condition checks were met. vm-test-run-flakelet> machine # [ 8.880437] mousedev: PS/2 mouse device common for all mice vm-test-run-flakelet> machine # [ 9.118227] systemd[1]: Finished register-nix-paths.service. vm-test-run-flakelet> machine # [ 9.164227] systemd[1]: Finished Firewall. vm-test-run-flakelet> machine # [ 9.268643] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input3 vm-test-run-flakelet> machine # [ 9.325805] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 9.327003] systemd[1]: Finished Create SUID/SGID Wrappers. vm-test-run-flakelet> machine # [ 9.331224] systemd[1]: Reached target System Initialization. vm-test-run-flakelet> machine # [ 9.332984] systemd[1]: Started Discard unused filesystem blocks once a week. vm-test-run-flakelet> machine # [ 9.334083] systemd[1]: Started Daily Cleanup of Temporary Directories. vm-test-run-flakelet> machine # [ 9.335263] systemd[1]: Reached target Timer Units. vm-test-run-flakelet> machine # [ 9.336605] systemd[1]: Listening on D-Bus System Message Bus Socket. vm-test-run-flakelet> machine # [ 9.338617] systemd[1]: Listening on Nix Daemon Socket. vm-test-run-flakelet> machine # [ 9.339931] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. vm-test-run-flakelet> machine # [ 9.341287] systemd[1]: Reached target Socket Units. vm-test-run-flakelet> machine # [ 9.342052] systemd[1]: Reached target Basic System. vm-test-run-flakelet> machine # [ 9.342817] systemd[1]: Started backdoor.service. vm-test-run-flakelet> machine # [ 9.364069] systemd[1]: Starting Re-link flakelet services at boot... vm-test-run-flakelet> machine # [ 9.366378] systemd[1]: Import lastlog data into lastlog2 database skipped, unmet condition check ConditionPathExists=!/var/lib/lastlog/lastlog2.db vm-test-run-flakelet> machine # [ 9.372392] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-flakelet> machine # [ 9.376581] systemd[1]: Starting Post-Boot Actions... vm-test-run-flakelet> machine # [ 9.380892] systemd[1]: Started Reset console on configuration changes. vm-test-run-flakelet> machine # [ 9.394475] systemd[1]: Starting resolvconf update... vm-test-run-flakelet> machine # [ 9.410632] systemd[1]: Starting D-Bus System Message Bus... vm-test-run-flakelet> machine # [ 9.416425] systemd[1]: Starting Virtual Console Setup... vm-test-run-flakelet> machine # connecting to host... vm-test-run-flakelet> machine # [ 9.439868] systemd[1]: Finished Post-Boot Actions. vm-test-run-flakelet> machine # [ 9.455758] systemd[1]: Reload requested from client PID 628 ('systemctl') (unit flakelet-boot.service)... vm-test-run-flakelet> machine: Guest shell says: b'Spawning backdoor root shell...\n' vm-test-run-flakelet> machine # [ 9.464312] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 9.467454] nsncd[614]: Aug 27 21:37:29.310 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-flakelet> machine: connected to guest root shell vm-test-run-flakelet> machine: (connecting took 9.87 seconds) vm-test-run-flakelet> machine: (finished: waiting for the VM to finish booting, in 9.87 seconds) vm-test-run-flakelet> machine # [ 9.531331] dbus-broker-launch[621]: Looking up NSS user entry for 'systemd-timesync'... vm-test-run-flakelet> machine # [ 9.815507] systemd-vconsole-setup[622]: Configuration of first virtual console was skipped, ignoring remaining ones. vm-test-run-flakelet> machine # [ 9.982234] systemd[1]: Reloading finished in 522 ms. vm-test-run-flakelet> machine # [ 10.062807] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-flakelet> machine # [ 10.066840] systemd[1]: Finished Virtual Console Setup. vm-test-run-flakelet> machine # [ 10.104969] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... vm-test-run-flakelet> machine # [ 10.113439] systemd[1]: nscd.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 10.120646] systemd[1]: Stopped Name Service Cache Daemon (nsncd). vm-test-run-flakelet> machine # [ 10.124653] dbus-broker-launch[621]: NSS returned no entry for 'systemd-timesync' vm-test-run-flakelet> machine # [ 10.129627] dbus-broker-launch[621]: Invalid user-name in /nix/store/sbvrn27fh8lph538cmhifxdccdxf3njq-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" vm-test-run-flakelet> machine # [ 10.143118] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-flakelet> machine # [ 10.155654] systemd[1]: Reload requested from client PID 711 ('systemctl') (unit flakelet-boot.service)... vm-test-run-flakelet> machine # [ 10.166079] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 10.215771] nsncd[721]: Aug 27 21:37:30.064 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-flakelet> machine # [ 10.222593] dbus-broker-launch[621]: Ready vm-test-run-flakelet> machine # [ 10.514411] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/cli.service target /nix/store/sfaqsn8n4dr7ig35jj9nqhzfvlym87j3-cli.service has different name vm-test-run-flakelet> machine # [ 10.727832] systemd[1]: Reloading finished in 568 ms. vm-test-run-flakelet> machine # [ 10.788120] systemd[1]: Started D-Bus System Message Bus. vm-test-run-flakelet> machine # [ 10.793242] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-flakelet> machine # [ 10.814504] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-flakelet> machine # [ 10.817059] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-flakelet> machine # [ 10.821375] systemd[1]: Starting prebuilt flakelet service cli... vm-test-run-flakelet> machine # [ 10.842261] systemd[1]: Starting User Login Management... vm-test-run-flakelet> machine # [ 10.845816] systemd[1]: Finished resolvconf update. vm-test-run-flakelet> machine # [ 10.851242] systemd[1]: Reached target Preparation for Network. vm-test-run-flakelet> machine # [ 10.874537] systemd[1]: Starting DHCP Client... vm-test-run-flakelet> machine # [ 10.879814] systemd[1]: Starting Address configuration of eth1... vm-test-run-flakelet> machine # [ 10.886590] systemd[1]: Starting Extra networking commands.... vm-test-run-flakelet> machine # [ 10.889183] systemd[1]: Started prebuilt flakelet service cli. vm-test-run-flakelet> machine # [ 10.891099] systemd[1]: Reload requested from client PID 777 ('systemctl') (unit flakelet-boot.service)... vm-test-run-flakelet> machine # [ 10.894432] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 10.956375] systemd-logind[779]: New seat seat0. vm-test-run-flakelet> machine # [ 10.962764] systemd-logind[779]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) vm-test-run-flakelet> machine # [ 10.969463] systemd-logind[779]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) vm-test-run-flakelet> machine # [ 10.971037] systemd-logind[779]: Watching system buttons on /dev/input/event0 (gpio-keys) vm-test-run-flakelet> machine # [ 11.010163] network-addresses-eth1-start[785]: adding address 192.168.1.1/24... done vm-test-run-flakelet> machine # [ 11.024555] network-addresses-eth1-start[785]: adding address 2001:db8:1::1/64... done vm-test-run-flakelet> machine # [ 11.274043] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/cli.service target /nix/store/sfaqsn8n4dr7ig35jj9nqhzfvlym87j3-cli.service has different name vm-test-run-flakelet> machine # [ 11.485203] systemd[1]: Reloading finished in 587 ms. vm-test-run-flakelet> machine # [ 11.553446] systemd[1]: Started User Login Management. vm-test-run-flakelet> machine # [ 11.556635] systemd[1]: Finished Address configuration of eth1. vm-test-run-flakelet> machine # [ 11.559323] systemd[1]: Finished Extra networking commands.. vm-test-run-flakelet> machine # [ 11.569756] systemd[1]: Reached target Network. vm-test-run-flakelet> machine # [ 11.575389] systemd[1]: Starting linger-users.service... vm-test-run-flakelet> machine # [ 11.580506] systemd[1]: Starting Permit User Sessions... vm-test-run-flakelet> machine # [ 11.594410] systemd[1]: Reload requested from client PID 879 ('systemctl') (unit flakelet-boot.service)... vm-test-run-flakelet> machine # [ 11.599711] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 12.009572] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/cli.service target /nix/store/sfaqsn8n4dr7ig35jj9nqhzfvlym87j3-cli.service has different name vm-test-run-flakelet> machine # [ 12.018400] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/static.service target /nix/store/8kxd89lpnhxjfiqmhsryf1l6vfb75fgn-static.service has different name vm-test-run-flakelet> machine # [ 12.234758] systemd[1]: Reloading finished in 637 ms. vm-test-run-flakelet> machine # [ 12.291044] systemd[1]: linger-users.service: Deactivated successfully. vm-test-run-flakelet> machine # [ 12.293255] systemd[1]: Finished linger-users.service. vm-test-run-flakelet> machine # [ 12.294866] systemd[1]: Finished Permit User Sessions. vm-test-run-flakelet> machine # [ 12.344988] systemd[1]: Started Getty on tty1. vm-test-run-flakelet> machine # [ 12.348483] systemd[1]: Reached target Login Prompts. vm-test-run-flakelet> machine # [ 12.352405] systemd[1]: Starting prebuilt flakelet service static... vm-test-run-flakelet> machine # [ 12.360258] systemd[1]: Reload requested from client PID 924 ('systemctl') (unit flakelet-boot.service)... vm-test-run-flakelet> machine # [ 12.368510] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 12.780195] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/cli.service target /nix/store/sfaqsn8n4dr7ig35jj9nqhzfvlym87j3-cli.service has different name vm-test-run-flakelet> machine # [ 12.796625] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/static.service target /nix/store/8kxd89lpnhxjfiqmhsryf1l6vfb75fgn-static.service has different name vm-test-run-flakelet> machine # [ 13.002033] systemd[1]: Reloading finished in 645 ms. vm-test-run-flakelet> machine # [ 13.109653] systemd[1]: Started prebuilt flakelet service static. vm-test-run-flakelet> machine # [ 13.155524] systemd[1]: Reload requested from client PID 968 ('systemctl') (unit flakelet-boot.service)... vm-test-run-flakelet> machine # [ 13.161130] systemd[1]: Reloading... vm-test-run-flakelet> machine # [ 13.555134] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/cli.service target /nix/store/sfaqsn8n4dr7ig35jj9nqhzfvlym87j3-cli.service has different name vm-test-run-flakelet> machine # [ 13.572117] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/static.service target /nix/store/8kxd89lpnhxjfiqmhsryf1l6vfb75fgn-static.service has different name vm-test-run-flakelet> machine # [ 13.588870] systemd[1]: multi-user.target: Wants dependency dropin /run/systemd/system/multi-user.target.wants/web.service target /nix/store/c4cqrlnh27rmc82w9p3vlxql7qvvha6s-web.service has different name vm-test-run-flakelet> machine # [ 13.775953] systemd[1]: Reloading finished in 617 ms. vm-test-run-flakelet> machine # [ 13.909691] systemd[1]: Starting flakelet test service... vm-test-run-flakelet> machine # [ 13.915891] flakelet[613]: cli: units re-linked vm-test-run-flakelet> machine # [ 13.918562] flakelet[613]: static: units re-linked vm-test-run-flakelet> machine # [ 13.921917] flakelet[613]: web: units re-linked vm-test-run-flakelet> machine # [ 13.925240] systemd[1]: Finished Re-link flakelet services at boot. vm-test-run-flakelet> machine # [ 13.939196] systemd[1]: Starting Reconcile flakelet services with the host configuration... vm-test-run-flakelet> machine # [ 13.962902] systemd[1]: Started flakelet test service. vm-test-run-flakelet> machine # [ 14.001487] systemd[1]: Finished Reconcile flakelet services with the host configuration. vm-test-run-flakelet> machine # [ 14.008166] systemd[1]: Starting Update flakelet service static... vm-test-run-flakelet> machine # [ 14.014815] systemd[1]: Starting Update flakelet service web... vm-test-run-flakelet> machine # [ 14.020301] dhcpcd[966]: dhcpcd-10.3.2 starting vm-test-run-flakelet> machine # [ 14.034844] dhcpcd[1012]: dev: loaded udev vm-test-run-flakelet> machine # [ 14.039672] dhcpcd[1012]: DUID 00:01:00:01:32:23:6a:56:52:54:00:12:34:56 vm-test-run-flakelet> machine # [ 14.060979] flakelet[1010]: web: resolving path:/nix/store/9343bpka3d3qdvzj7xibb5rkb3z5phs6-flake.nix vm-test-run-flakelet> machine # [ 14.073883] flakelet[1009]: static: using prebuilt artifact /nix/store/0xzyvfvb219zadpvnmd7vh97axdmxxc2-flakelet-static vm-test-run-flakelet> machine # [ 14.086048] flakelet[1009]: static: up to date vm-test-run-flakelet> machine # [ 14.087150] systemd[1]: Finished Update flakelet service static. vm-test-run-flakelet> machine # [ 14.097569] 8021q: 802.1Q VLAN Support v1.8 vm-test-run-flakelet> machine # [ 14.098317] 8021q: adding VLAN 0 to HW filter on device eth1 vm-test-run-flakelet> machine # [ 14.172600] cfg80211: Loading compiled-in X.509 certificates for regulatory database vm-test-run-flakelet> machine # [ 14.181613] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. vm-test-run-flakelet> machine # [ 14.185812] systemd[1]: Started Nix Daemon. vm-test-run-flakelet> machine: (finished: waiting for unit web.service, in 14.60 seconds) vm-test-run-flakelet> machine # [ 14.205268] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' vm-test-run-flakelet> machine: waiting for unit cli.service vm-test-run-flakelet> machine # [ 14.205830] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' vm-test-run-flakelet> machine # [ 14.209365] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 vm-test-run-flakelet> machine # [ 14.209729] cfg80211: failed to load regulatory.db vm-test-run-flakelet> machine: (finished: waiting for unit cli.service, in 0.06 seconds) vm-test-run-flakelet> (finished: run the VM test script, in 82.81 seconds) vm-test-run-flakelet> machine # [ 14.278706] 8021q: adding VLAN 0 to HW filter on device eth0 vm-test-run-flakelet> machine # [ 14.277576] dhcpcd[1012]: eth0: waiting for carrier vm-test-run-flakelet> machine # [ 14.280447] dhcpcd[1012]: eth0: carrier acquired vm-test-run-flakelet> machine # [ 14.292189] dhcpcd[1012]: eth0: IAID 00:12:34:56 vm-test-run-flakelet> machine # [ 14.293026] dhcpcd[1012]: eth0: adding address fe80::5054:ff:fe12:3456 vm-test-run-flakelet> test script finished in 82.87s vm-test-run-flakelet> cleanup vm-test-run-flakelet> kill QemuMachine (pid 82) vm-test-run-flakelet> machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/ymm5c1kb7p2r6331bgcdxijayqhcbvqy-python3-3.14.6/bin/python3.14) vm-test-run-flakelet> (finished: cleanup, in 0.20 seconds) post-build step Upload coverage to codecov: ok Skipping codecov: project=Mic92/flakelet attr=checks.aarch64-linux.vm