these 16 derivations will be built: /nix/store/n0ayk2ah2ksg9vnqwgahci7waaxnn5w3-unit-script-suid-sgid-wrappers-start.drv /nix/store/9y59q1i7a65c1xx2hdc9hx55174yq9is-unit-suid-sgid-wrappers.service.drv /nix/store/3hwv0idq0n0bchh29y941s24d4clry8k-X-Reload-Triggers-systemd-networkd.drv /nix/store/bk38w3ffmll5n7m6nnkf44w9s20z453h-unit-systemd-networkd.service.drv /nix/store/sckn46v2afwlwqds4rqbazm71v5gi0a3-X-Restart-Triggers-systemd-udevd.drv /nix/store/llxl5p8b1d4x9lp483bkbx4pibdyw0k0-unit-systemd-udevd.service.drv /nix/store/zc75n308abl4aapxiav15979x130asr6-system-units.drv /nix/store/66zqp6zfjdcv599vb6y1wq915kcxcryc-etc.drv /nix/store/nyj7203aimgf6pib5cjfn72xbw9yk918-activate.drv /nix/store/k1vvzxazqm2xx0q1l728zr7afif54rqc-nixos-system-machine-test.drv /nix/store/phlijnqqz22pc4fvc1bh1zyqir7lzxk6-closure-info.drv /nix/store/hh6m9aqhpx0mwbnfihxqai6r0f2ax57k-run-nixos-vm.drv /nix/store/2x4rbzr01fabxyd94aq90mhxc42qxxs1-nixos-vm.drv /nix/store/6av3w3x2m5j3dzrbkwjfp2wzqbnk92xn-driverConfiguration.json.drv /nix/store/6gkdvrdfaybs44dg1x2kp12ycrfw3dnc-nixos-test-driver-secrets.drv /nix/store/z3dr2ihqi0zh29y1bv1bwyzpsipgx1s0-vm-test-run-secrets.drv building '/nix/store/sckn46v2afwlwqds4rqbazm71v5gi0a3-X-Restart-Triggers-systemd-udevd.drv' on 'ssh-ng://builder@build01.clan.lol' building '/nix/store/sckn46v2afwlwqds4rqbazm71v5gi0a3-X-Restart-Triggers-systemd-udevd.drv' building '/nix/store/llxl5p8b1d4x9lp483bkbx4pibdyw0k0-unit-systemd-udevd.service.drv' on 'ssh-ng://builder@build01.clan.lol' building '/nix/store/llxl5p8b1d4x9lp483bkbx4pibdyw0k0-unit-systemd-udevd.service.drv' building '/nix/store/66zqp6zfjdcv599vb6y1wq915kcxcryc-etc.drv' on 'ssh-ng://builder@build01.clan.lol' building '/nix/store/66zqp6zfjdcv599vb6y1wq915kcxcryc-etc.drv' building '/nix/store/nyj7203aimgf6pib5cjfn72xbw9yk918-activate.drv' on 'ssh-ng://builder@build01.clan.lol' building '/nix/store/nyj7203aimgf6pib5cjfn72xbw9yk918-activate.drv' warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy building '/nix/store/k1vvzxazqm2xx0q1l728zr7afif54rqc-nixos-system-machine-test.drv' on 'ssh-ng://builder@build01.clan.lol' building '/nix/store/k1vvzxazqm2xx0q1l728zr7afif54rqc-nixos-system-machine-test.drv' nixos-system-machine-test> structuredAttrs is enabled building '/nix/store/phlijnqqz22pc4fvc1bh1zyqir7lzxk6-closure-info.drv' on 'ssh-ng://builder@build01.clan.lol' building '/nix/store/phlijnqqz22pc4fvc1bh1zyqir7lzxk6-closure-info.drv' closure-info> structuredAttrs is enabled building '/nix/store/hh6m9aqhpx0mwbnfihxqai6r0f2ax57k-run-nixos-vm.drv' on 'ssh-ng://builder@build01.clan.lol' building '/nix/store/hh6m9aqhpx0mwbnfihxqai6r0f2ax57k-run-nixos-vm.drv' building '/nix/store/2x4rbzr01fabxyd94aq90mhxc42qxxs1-nixos-vm.drv' on 'ssh-ng://builder@build01.clan.lol' building '/nix/store/2x4rbzr01fabxyd94aq90mhxc42qxxs1-nixos-vm.drv' building '/nix/store/6av3w3x2m5j3dzrbkwjfp2wzqbnk92xn-driverConfiguration.json.drv' on 'ssh-ng://builder@build01.clan.lol' building '/nix/store/6av3w3x2m5j3dzrbkwjfp2wzqbnk92xn-driverConfiguration.json.drv' driverConfiguration.json> structuredAttrs is enabled building '/nix/store/6gkdvrdfaybs44dg1x2kp12ycrfw3dnc-nixos-test-driver-secrets.drv' on 'ssh-ng://builder@build01.clan.lol' building '/nix/store/6gkdvrdfaybs44dg1x2kp12ycrfw3dnc-nixos-test-driver-secrets.drv' nixos-test-driver-secrets> Running type check (enable/disable: config.skipTypeCheck) nixos-test-driver-secrets> See https://nixos.org/manual/nixos/stable/#test-opt-skipTypeCheck nixos-test-driver-secrets> All checks passed! nixos-test-driver-secrets> Linting test script (enable/disable: config.skipLint) nixos-test-driver-secrets> See https://nixos.org/manual/nixos/stable/#test-opt-skipLint nixos-test-driver-secrets> All checks passed! building '/nix/store/z3dr2ihqi0zh29y1bv1bwyzpsipgx1s0-vm-test-run-secrets.drv' on 'ssh-ng://builder@build01.clan.lol' building '/nix/store/z3dr2ihqi0zh29y1bv1bwyzpsipgx1s0-vm-test-run-secrets.drv' vm-test-run-secrets> Machine state will be reset. To keep it, pass --keep-machine-state vm-test-run-secrets> start all VLans vm-test-run-secrets> (finished: start all VLans, in 0.00 seconds) vm-test-run-secrets> Test will time out and terminate in 3600 seconds vm-test-run-secrets> run the VM test script vm-test-run-secrets> additionally exposed symbols: vm-test-run-secrets> machine, vm-test-run-secrets> vlan1, vm-test-run-secrets> 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-secrets> machine: must succeed: cat /etc/secret >&2 vm-test-run-secrets> machine: waiting for the VM to finish booting vm-test-run-secrets> machine: starting vm vm-test-run-secrets> machine # Disk image does not exist, creating the virtualisation disk image... vm-test-run-secrets> machine # Formatting '/build/vm-state-machine/tmp.D3mOnpL3t3', fmt=raw size=1073741824 vm-test-run-secrets> machine # mke2fs 1.47.4 (6-Mar-2025) vm-test-run-secrets> machine # Discarding device blocks: 0/262144 done vm-test-run-secrets> machine # Creating filesystem with 262144 4k blocks and 65536 inodes vm-test-run-secrets> machine # Filesystem UUID: 868cfc6e-22d2-46de-96e7-26ccf2697120 vm-test-run-secrets> machine # Superblock backups stored on blocks: vm-test-run-secrets> machine # 32768, 98304, 163840, 229376 vm-test-run-secrets> machine # vm-test-run-secrets> machine # Allocating group tables: 0/8 done vm-test-run-secrets> machine # Writing inode tables: 0/8 done vm-test-run-secrets> machine # Creating journal (8192 blocks): done vm-test-run-secrets> machine: QEMU running (pid 12) vm-test-run-secrets> machine # Writing superblocks and filesystem accounting information: 0/8 done vm-test-run-secrets> machine # vm-test-run-secrets> machine # Virtualisation disk image created. vm-test-run-secrets> machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] vm-test-run-secrets> machine # [ 0.000000] Linux version 6.18.50 (nixbld@localhost) (gcc (GCC) 15.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Mon Sep 7 15:23:00 UTC 2026 vm-test-run-secrets> machine # [ 0.000000] KASLR enabled vm-test-run-secrets> machine # [ 0.000000] random: crng init done vm-test-run-secrets> machine # [ 0.000000] Machine model: linux,dummy-virt vm-test-run-secrets> machine # [ 0.000000] efi: UEFI not found. vm-test-run-secrets> machine # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT vm-test-run-secrets> machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff] vm-test-run-secrets> machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc07740-0x7fc0aebf] vm-test-run-secrets> machine # [ 0.000000] Zone ranges: vm-test-run-secrets> machine # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff] vm-test-run-secrets> machine # [ 0.000000] DMA32 empty vm-test-run-secrets> machine # [ 0.000000] Normal empty vm-test-run-secrets> machine # [ 0.000000] Device empty vm-test-run-secrets> machine # [ 0.000000] Movable zone start for each node vm-test-run-secrets> machine # [ 0.000000] Early memory node ranges vm-test-run-secrets> machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff] vm-test-run-secrets> machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff] vm-test-run-secrets> machine # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca00000 vm-test-run-secrets> machine # [ 0.000000] psci: probing for conduit method from DT. vm-test-run-secrets> machine # [ 0.000000] psci: PSCIv1.3 detected in firmware. vm-test-run-secrets> machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs vm-test-run-secrets> machine # [ 0.000000] psci: Trusted OS migration not required vm-test-run-secrets> machine # [ 0.000000] psci: SMC Calling Convention v1.1 vm-test-run-secrets> machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) vm-test-run-secrets> machine # [ 0.000000] percpu: Embedded 76 pages/cpu s186328 r8192 d116776 u311296 vm-test-run-secrets> machine # [ 0.000000] Detected PIPT I-cache on CPU0 vm-test-run-secrets> machine # [ 0.000000] CPU features: detected: GICv3 CPU interface vm-test-run-secrets> machine # [ 0.000000] CPU features: detected: Spectre-v4 vm-test-run-secrets> machine # [ 0.000000] CPU features: detected: Spectre-BHB vm-test-run-secrets> machine # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR vm-test-run-secrets> machine # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI) vm-test-run-secrets> machine # [ 0.000000] CPU features: detected: ARM erratum 1418040 vm-test-run-secrets> machine # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion vm-test-run-secrets> machine # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing vm-test-run-secrets> machine # [ 0.000000] alternatives: applying boot alternatives vm-test-run-secrets> 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/3fqikzln17f27r2b92vav49s7hskhlqf-nixos-system-machine-test/init regInfo=/nix/store/fhzqq3kg3mlf2akfdkmyw3fj9nng068v-closure-info/registration console=ttyAMA0,115200n8 console=tty0 vm-test-run-secrets> machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/fhzqq3kg3mlf2akfdkmyw3fj9nng068v-closure-info/registration", will be passed to user space. vm-test-run-secrets> machine # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes vm-test-run-secrets> machine # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) vm-test-run-secrets> machine # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) vm-test-run-secrets> machine # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB vm-test-run-secrets> machine # [ 0.000000] software IO TLB: area num 1. vm-test-run-secrets> machine # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB) vm-test-run-secrets> machine # [ 0.000000] Fallback order for Node 0: 0 vm-test-run-secrets> machine # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144 vm-test-run-secrets> machine # [ 0.000000] Policy zone: DMA vm-test-run-secrets> machine # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off vm-test-run-secrets> machine # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 vm-test-run-secrets> machine # [ 0.000000] allocated 2097152 bytes of page_ext vm-test-run-secrets> machine # [ 0.000000] ftrace: allocating 74755 entries in 294 pages vm-test-run-secrets> machine # [ 0.000000] ftrace: allocated 294 pages with 4 groups vm-test-run-secrets> machine # [ 0.000000] rcu: Hierarchical RCU implementation. vm-test-run-secrets> machine # [ 0.000000] rcu: RCU event tracing is enabled. vm-test-run-secrets> machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. vm-test-run-secrets> machine # [ 0.000000] Trampoline variant of Tasks RCU enabled. vm-test-run-secrets> machine # [ 0.000000] Rude variant of Tasks RCU enabled. vm-test-run-secrets> machine # [ 0.000000] Tracing variant of Tasks RCU enabled. vm-test-run-secrets> machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. vm-test-run-secrets> machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 vm-test-run-secrets> machine # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. vm-test-run-secrets> machine # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. vm-test-run-secrets> machine # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. vm-test-run-secrets> machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 vm-test-run-secrets> machine # [ 0.000000] GICv3: 256 SPIs implemented vm-test-run-secrets> machine # [ 0.000000] GICv3: 0 Extended SPIs implemented vm-test-run-secrets> machine # [ 0.000000] Root IRQ handler: gic_handle_irq vm-test-run-secrets> machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI vm-test-run-secrets> machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0 vm-test-run-secrets> machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 vm-test-run-secrets> machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] vm-test-run-secrets> machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1) vm-test-run-secrets> machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1) vm-test-run-secrets> machine # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000 vm-test-run-secrets> machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000 vm-test-run-secrets> machine # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. vm-test-run-secrets> machine # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns vm-test-run-secrets> machine # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040 vm-test-run-secrets> machine # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt). vm-test-run-secrets> machine # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns vm-test-run-secrets> machine # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns vm-test-run-secrets> machine # [ 0.000054] arm-pv: using stolen time PV vm-test-run-secrets> machine # [ 0.000350] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) vm-test-run-secrets> machine # [ 0.000616] Console: colour dummy device 80x25 vm-test-run-secrets> machine # [ 0.000632] printk: legacy console [tty0] enabled vm-test-run-secrets> machine # [ 0.000830] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000) vm-test-run-secrets> machine # [ 0.000835] pid_max: default: 32768 minimum: 301 vm-test-run-secrets> machine # [ 0.000903] LSM: initializing lsm=capability,landlock,yama,bpf,ima vm-test-run-secrets> machine # [ 0.001014] landlock: Up and running. vm-test-run-secrets> machine # [ 0.001016] Yama: becoming mindful. vm-test-run-secrets> machine # [ 0.001341] LSM support for eBPF active vm-test-run-secrets> machine # [ 0.001486] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) vm-test-run-secrets> machine # [ 0.001505] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) vm-test-run-secrets> machine # [ 0.003229] cacheinfo: Unable to detect cache hierarchy for CPU 0 vm-test-run-secrets> machine # [ 0.004095] rcu: Hierarchical SRCU implementation. vm-test-run-secrets> machine # [ 0.004099] rcu: Max phase no-delay instances is 1000. vm-test-run-secrets> machine # [ 0.005020] fsl-mc MSI: its@8080000 domain created vm-test-run-secrets> machine # [ 0.005168] EFI services will not be available. vm-test-run-secrets> machine # [ 0.005245] smp: Bringing up secondary CPUs ... vm-test-run-secrets> machine # [ 0.005271] smp: Brought up 1 node, 1 CPU vm-test-run-secrets> machine # [ 0.005273] SMP: Total of 1 processors activated. vm-test-run-secrets> machine # [ 0.005275] CPU: All CPU(s) started at EL1 vm-test-run-secrets> machine # [ 0.005287] CPU features: detected: 32-bit EL0 Support vm-test-run-secrets> machine # [ 0.005289] CPU features: detected: Data cache clean to the PoU not required for I/D coherence vm-test-run-secrets> machine # [ 0.005292] CPU features: detected: Common not Private translations vm-test-run-secrets> machine # [ 0.005294] CPU features: detected: CRC32 instructions vm-test-run-secrets> machine # [ 0.005296] CPU features: detected: Data cache clean to Point of Persistence vm-test-run-secrets> machine # [ 0.005299] CPU features: detected: Enhanced Virtualization Traps vm-test-run-secrets> machine # [ 0.005309] CPU features: detected: RCpc load-acquire (LDAPR) vm-test-run-secrets> machine # [ 0.005311] CPU features: detected: LSE atomic instructions vm-test-run-secrets> machine # [ 0.005313] CPU features: detected: Privileged Access Never vm-test-run-secrets> machine # [ 0.005314] CPU features: detected: PMUv3 vm-test-run-secrets> machine # [ 0.005316] CPU features: detected: RAS Extension Support vm-test-run-secrets> machine # [ 0.005320] CPU features: detected: Speculative Store Bypassing Safe (SSBS) vm-test-run-secrets> machine # [ 0.005339] alternatives: applying system-wide alternatives vm-test-run-secrets> machine # [ 0.006764] CPU features: detected: Hardware dirty bit management on CPU0 vm-test-run-secrets> machine # [ 0.006919] Memory: 893824K/1048576K available (24320K kernel code, 7086K rwdata, 26340K rodata, 4736K init, 1103K bss, 113416K reserved, 32768K cma-reserved) vm-test-run-secrets> machine # [ 0.007344] devtmpfs: initialized vm-test-run-secrets> machine # [ 0.008778] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) vm-test-run-secrets> machine # [ 0.008800] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). vm-test-run-secrets> machine # [ 0.008918] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL vm-test-run-secrets> machine # [ 0.008921] 0 pages in range for non-PLT usage vm-test-run-secrets> machine # [ 0.008922] 508336 pages in range for PLT usage vm-test-run-secrets> machine # [ 0.009040] pinctrl core: initialized pinctrl subsystem vm-test-run-secrets> machine # [ 0.009767] DMI not present or invalid. vm-test-run-secrets> machine # [ 0.012885] NET: Registered PF_NETLINK/PF_ROUTE protocol family vm-test-run-secrets> machine # [ 0.015363] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations vm-test-run-secrets> machine # [ 0.015515] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations vm-test-run-secrets> machine # [ 0.015686] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations vm-test-run-secrets> machine # [ 0.015703] audit: initializing netlink subsys (disabled) vm-test-run-secrets> machine # [ 0.016111] audit: type=2000 audit(0.012:1): state=initialized audit_enabled=0 res=1 vm-test-run-secrets> machine # [ 0.016310] thermal_sys: Registered thermal governor 'fair_share' vm-test-run-secrets> machine # [ 0.016312] thermal_sys: Registered thermal governor 'bang_bang' vm-test-run-secrets> machine # [ 0.016314] thermal_sys: Registered thermal governor 'step_wise' vm-test-run-secrets> machine # [ 0.016316] thermal_sys: Registered thermal governor 'user_space' vm-test-run-secrets> machine # [ 0.016318] thermal_sys: Registered thermal governor 'power_allocator' vm-test-run-secrets> machine # [ 0.016340] cpuidle: using governor ladder vm-test-run-secrets> machine # [ 0.016346] cpuidle: using governor menu vm-test-run-secrets> machine # [ 0.016448] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. vm-test-run-secrets> machine # [ 0.016468] ASID allocator initialised with 32768 entries vm-test-run-secrets> machine # [ 0.017122] Serial: AMBA PL011 UART driver vm-test-run-secrets> machine # [ 0.020171] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 vm-test-run-secrets> machine # [ 0.020330] printk: console [ttyAMA0] enabled vm-test-run-secrets> machine # [ 0.093402] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages vm-test-run-secrets> machine # [ 0.093427] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page vm-test-run-secrets> machine # [ 0.093434] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages vm-test-run-secrets> machine # [ 0.093438] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page vm-test-run-secrets> machine # [ 0.093441] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages vm-test-run-secrets> machine # [ 0.093445] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page vm-test-run-secrets> machine # [ 0.093448] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages vm-test-run-secrets> machine # [ 0.093451] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page vm-test-run-secrets> machine # [ 0.098632] fbcon: Taking over console vm-test-run-secrets> machine # [ 0.098654] ACPI: Interpreter disabled. vm-test-run-secrets> machine # [ 0.099883] iommu: Default domain type: Translated vm-test-run-secrets> machine # [ 0.099893] iommu: DMA domain TLB invalidation policy: strict mode vm-test-run-secrets> machine # [ 0.101098] SCSI subsystem initialized vm-test-run-secrets> machine # [ 0.101739] usbcore: registered new interface driver usbfs vm-test-run-secrets> machine # [ 0.101773] usbcore: registered new interface driver hub vm-test-run-secrets> machine # [ 0.101783] usbcore: registered new device driver usb vm-test-run-secrets> machine # [ 0.102016] pps_core: LinuxPPS API ver. 1 registered vm-test-run-secrets> machine # [ 0.102022] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti vm-test-run-secrets> machine # [ 0.102028] PTP clock support registered vm-test-run-secrets> machine # [ 0.102057] EDAC MC: Ver: 3.0.0 vm-test-run-secrets> machine # [ 0.109671] scmi_core: SCMI protocol bus registered vm-test-run-secrets> machine # [ 0.110470] FPGA manager framework vm-test-run-secrets> machine # [ 0.111504] vgaarb: loaded vm-test-run-secrets> machine # [ 0.111946] clocksource: Switched to clocksource arch_sys_counter vm-test-run-secrets> machine # [ 0.121564] VFS: Disk quotas dquot_6.6.0 vm-test-run-secrets> machine # [ 0.121602] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) vm-test-run-secrets> machine # [ 0.123910] netfs: FS-Cache loaded vm-test-run-secrets> machine # [ 0.124355] pnp: PnP ACPI: disabled vm-test-run-secrets> machine # [ 0.126446] NET: Registered PF_INET protocol family vm-test-run-secrets> machine # [ 0.126642] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) vm-test-run-secrets> machine # [ 0.151023] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) vm-test-run-secrets> machine # [ 0.151054] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) vm-test-run-secrets> machine # [ 0.151069] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-secrets> machine # [ 0.151106] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) vm-test-run-secrets> machine # [ 0.151174] TCP: Hash tables configured (established 8192 bind 8192) vm-test-run-secrets> machine # [ 0.151271] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) vm-test-run-secrets> machine # [ 0.151300] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) vm-test-run-secrets> machine # [ 0.151363] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) vm-test-run-secrets> machine # [ 0.151484] NET: Registered PF_UNIX/PF_LOCAL protocol family vm-test-run-secrets> machine # [ 0.151516] NET: Registered PF_XDP protocol family vm-test-run-secrets> machine # [ 0.151538] PCI: CLS 0 bytes, default 64 vm-test-run-secrets> machine # [ 0.151739] Trying to unpack rootfs image as initramfs... vm-test-run-secrets> machine # [ 0.166074] kvm [1]: HYP mode not available vm-test-run-secrets> machine # [ 0.230339] Initialise system trusted keyrings vm-test-run-secrets> machine # [ 0.230871] workingset: timestamp_bits=42 max_order=18 bucket_order=0 vm-test-run-secrets> machine # [ 0.231840] squashfs: version 4.0 (2009/01/31) Phillip Lougher vm-test-run-secrets> machine # [ 0.232442] 9p: Installing v9fs 9p2000 file system support vm-test-run-secrets> machine # [ 0.251251] Key type asymmetric registered vm-test-run-secrets> machine # [ 0.251276] Asymmetric key parser 'x509' registered vm-test-run-secrets> machine # [ 0.251331] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) vm-test-run-secrets> machine # [ 0.256102] io scheduler mq-deadline registered vm-test-run-secrets> machine # [ 0.256118] io scheduler kyber registered vm-test-run-secrets> machine # [ 0.264066] pl061_gpio 9030000.pl061: PL061 GPIO chip registered vm-test-run-secrets> machine # [ 0.264394] ledtrig-cpu: registered to indicate activity on CPUs vm-test-run-secrets> machine # [ 0.264676] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: vm-test-run-secrets> machine # [ 0.264697] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 vm-test-run-secrets> machine # [ 0.264713] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 vm-test-run-secrets> machine # [ 0.264719] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 vm-test-run-secrets> machine # [ 0.264747] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits vm-test-run-secrets> machine # [ 0.264770] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] vm-test-run-secrets> machine # [ 0.264845] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 vm-test-run-secrets> machine # [ 0.264864] pci_bus 0000:00: root bus resource [bus 00-ff] vm-test-run-secrets> machine # [ 0.264869] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] vm-test-run-secrets> machine # [ 0.264872] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] vm-test-run-secrets> machine # [ 0.264876] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] vm-test-run-secrets> machine # [ 0.264955] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint vm-test-run-secrets> machine # [ 0.265378] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-secrets> machine # [ 0.265495] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] vm-test-run-secrets> machine # [ 0.265506] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-secrets> machine # [ 0.265526] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-secrets> machine # [ 0.265538] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-secrets> machine # [ 0.265842] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-secrets> machine # [ 0.265955] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] vm-test-run-secrets> machine # [ 0.265966] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-secrets> machine # [ 0.265986] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-secrets> machine # [ 0.266261] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-secrets> machine # [ 0.266372] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] vm-test-run-secrets> machine # [ 0.266383] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-secrets> machine # [ 0.266403] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-secrets> machine # [ 0.266690] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-secrets> machine # [ 0.266805] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] vm-test-run-secrets> machine # [ 0.266815] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-secrets> machine # [ 0.266835] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-secrets> machine # [ 0.267115] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-secrets> machine # [ 0.267226] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] vm-test-run-secrets> machine # [ 0.267237] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-secrets> machine # [ 0.267258] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-secrets> machine # [ 0.267529] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint vm-test-run-secrets> machine # [ 0.267641] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] vm-test-run-secrets> machine # [ 0.267652] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-secrets> machine # [ 0.267672] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-secrets> machine # [ 0.268006] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-secrets> machine # [ 0.268119] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] vm-test-run-secrets> machine # [ 0.268129] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-secrets> machine # [ 0.268153] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-secrets> machine # [ 0.268164] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-secrets> machine # [ 0.268453] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint vm-test-run-secrets> machine # [ 0.268568] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-secrets> machine # [ 0.268587] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-secrets> machine # [ 0.268859] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint vm-test-run-secrets> machine # [ 0.268981] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-secrets> machine # [ 0.269000] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-secrets> machine # [ 0.269254] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint vm-test-run-secrets> machine # [ 0.269364] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] vm-test-run-secrets> machine # [ 0.269520] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint vm-test-run-secrets> machine # [ 0.269677] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] vm-test-run-secrets> machine # [ 0.269689] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-secrets> machine # [ 0.269780] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-secrets> machine # [ 0.270066] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-secrets> machine # [ 0.270179] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] vm-test-run-secrets> machine # [ 0.270189] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-secrets> machine # [ 0.270209] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-secrets> machine # [ 0.270629] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned vm-test-run-secrets> machine # [ 0.270642] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned vm-test-run-secrets> machine # [ 0.270647] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned vm-test-run-secrets> machine # [ 0.270682] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned vm-test-run-secrets> machine # [ 0.270713] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned vm-test-run-secrets> machine # [ 0.270743] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned vm-test-run-secrets> machine # [ 0.270774] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned vm-test-run-secrets> machine # [ 0.270805] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned vm-test-run-secrets> machine # [ 0.270836] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned vm-test-run-secrets> machine # [ 0.270867] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned vm-test-run-secrets> machine # [ 0.270897] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned vm-test-run-secrets> machine # [ 0.270927] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned vm-test-run-secrets> machine # [ 0.271013] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned vm-test-run-secrets> machine # [ 0.271044] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned vm-test-run-secrets> machine # [ 0.271058] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned vm-test-run-secrets> machine # [ 0.271073] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned vm-test-run-secrets> machine # [ 0.271089] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned vm-test-run-secrets> machine # [ 0.271103] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned vm-test-run-secrets> machine # [ 0.271119] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned vm-test-run-secrets> machine # [ 0.271134] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned vm-test-run-secrets> machine # [ 0.271149] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned vm-test-run-secrets> machine # [ 0.271165] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned vm-test-run-secrets> machine # [ 0.271180] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned vm-test-run-secrets> machine # [ 0.271195] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned vm-test-run-secrets> machine # [ 0.271210] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned vm-test-run-secrets> machine # [ 0.271226] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned vm-test-run-secrets> machine # [ 0.271242] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned vm-test-run-secrets> machine # [ 0.271257] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned vm-test-run-secrets> machine # [ 0.271272] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned vm-test-run-secrets> machine # [ 0.271292] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned vm-test-run-secrets> machine # [ 0.271307] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned vm-test-run-secrets> machine # [ 0.271322] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned vm-test-run-secrets> machine # [ 0.271338] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned vm-test-run-secrets> machine # [ 0.271354] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned vm-test-run-secrets> machine # [ 0.271374] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] vm-test-run-secrets> machine # [ 0.271380] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] vm-test-run-secrets> machine # [ 0.271384] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] vm-test-run-secrets> machine # [ 0.328161] pci 0000:00:0a.0: enabling device (0000 -> 0002) vm-test-run-secrets> machine # [ 0.334608] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) vm-test-run-secrets> machine # [ 0.344464] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) vm-test-run-secrets> machine # [ 0.347421] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) vm-test-run-secrets> machine # [ 0.357063] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) vm-test-run-secrets> machine # [ 0.364085] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) vm-test-run-secrets> machine # [ 0.365880] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) vm-test-run-secrets> machine # [ 0.367723] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) vm-test-run-secrets> machine # [ 0.377858] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) vm-test-run-secrets> machine # [ 0.379646] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) vm-test-run-secrets> machine # [ 0.390122] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) vm-test-run-secrets> machine # [ 0.393338] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) vm-test-run-secrets> machine # [ 0.405226] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled vm-test-run-secrets> machine # [ 0.406674] msm_serial: driver initialized vm-test-run-secrets> machine # [ 0.406771] SuperH (H)SCI(F) driver initialized vm-test-run-secrets> machine # [ 0.406810] STM32 USART driver initialized vm-test-run-secrets> machine # [ 0.426484] loop: module loaded vm-test-run-secrets> machine # [ 0.426619] virtio_blk virtio5: 1/0/0 default/read/poll queues vm-test-run-secrets> machine # [ 0.427152] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) vm-test-run-secrets> machine # [ 0.436357] megasas: 07.734.00.00-rc1 vm-test-run-secrets> machine # [ 0.436835] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] vm-test-run-secrets> machine # [ 0.439255] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-secrets> machine # [ 0.439274] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-secrets> machine # [ 0.443199] Using buffer write method vm-test-run-secrets> machine # [ 0.443257] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] vm-test-run-secrets> machine # [ 0.448980] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-secrets> machine # [ 0.449003] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-secrets> machine # [ 0.459991] Using buffer write method vm-test-run-secrets> machine # [ 0.460030] Concatenating MTD devices: vm-test-run-secrets> machine # [ 0.460034] (0): "0.flash" vm-test-run-secrets> machine # [ 0.460037] (1): "0.flash" vm-test-run-secrets> machine # [ 0.460040] into device "0.flash" vm-test-run-secrets> machine # [ 0.652984] Freeing initrd memory: 24808K vm-test-run-secrets> machine # [ 0.659984] tun: Universal TUN/TAP device driver, 1.6 vm-test-run-secrets> machine # [ 0.662717] thunder_xcv, ver 1.0 vm-test-run-secrets> machine # [ 0.662749] thunder_bgx, ver 1.0 vm-test-run-secrets> machine # [ 0.662761] nicpf, ver 1.0 vm-test-run-secrets> machine # [ 0.663047] e1000: Intel(R) PRO/1000 Network Driver vm-test-run-secrets> machine # [ 0.663055] e1000: Copyright (c) 1999-2006 Intel Corporation. vm-test-run-secrets> machine # [ 0.663070] e1000e: Intel(R) PRO/1000 Network Driver vm-test-run-secrets> machine # [ 0.663076] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. vm-test-run-secrets> machine # [ 0.663089] igb: Intel(R) Gigabit Ethernet Network Driver vm-test-run-secrets> machine # [ 0.663093] igb: Copyright (c) 2007-2014 Intel Corporation. vm-test-run-secrets> machine # [ 0.663104] igbvf: Intel(R) Gigabit Virtual Function Network Driver vm-test-run-secrets> machine # [ 0.663107] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. vm-test-run-secrets> machine # [ 0.663195] sky2: driver version 1.30 vm-test-run-secrets> machine # [ 0.669185] ehci-pci 0000:00:0a.0: EHCI Host Controller vm-test-run-secrets> machine # [ 0.669225] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 vm-test-run-secrets> machine # [ 0.669401] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 vm-test-run-secrets> machine # [ 0.670992] usbcore: registered new interface driver usb-storage vm-test-run-secrets> machine # [ 0.671049] usbcore: registered new interface driver usbserial_generic vm-test-run-secrets> machine # [ 0.671058] usbserial: USB Serial support registered for generic vm-test-run-secrets> machine # [ 0.671396] hv_vmbus: registering driver hyperv_keyboard vm-test-run-secrets> machine # [ 0.673902] rtc-pl031 9010000.pl031: registered as rtc0 vm-test-run-secrets> machine # [ 0.673942] rtc-pl031 9010000.pl031: setting system clock to 2026-09-10T00:19:52 UTC (1788999592) vm-test-run-secrets> machine # [ 0.674124] i2c_dev: i2c /dev entries driver vm-test-run-secrets> machine # [ 0.676938] sdhci: Secure Digital Host Controller Interface driver vm-test-run-secrets> machine # [ 0.676953] sdhci: Copyright(c) Pierre Ossman vm-test-run-secrets> machine # [ 0.677079] Synopsys Designware Multimedia Card Interface Driver vm-test-run-secrets> machine # [ 0.677237] sdhci-pltfm: SDHCI platform and OF driver helper vm-test-run-secrets> machine # [ 0.678081] hid: raw HID events driver (C) Jiri Kosina vm-test-run-secrets> machine # [ 0.678222] usbcore: registered new interface driver usbhid vm-test-run-secrets> machine # [ 0.678227] usbhid: USB HID core driver vm-test-run-secrets> machine # [ 0.681717] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 vm-test-run-secrets> machine # [ 0.682579] hub 1-0:1.0: USB hub found vm-test-run-secrets> machine # [ 0.683004] hub 1-0:1.0: 6 ports detected vm-test-run-secrets> machine # [ 0.683648] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available vm-test-run-secrets> machine # [ 0.685180] drop_monitor: Initializing network drop monitor service vm-test-run-secrets> machine # [ 0.685376] NET: Registered PF_INET6 protocol family vm-test-run-secrets> machine # [ 0.687009] Segment Routing with IPv6 vm-test-run-secrets> machine # [ 0.687035] In-situ OAM (IOAM) with IPv6 vm-test-run-secrets> machine # [ 0.687091] NET: Registered PF_PACKET protocol family vm-test-run-secrets> machine # [ 0.688238] 9pnet: Installing 9P2000 support vm-test-run-secrets> machine # [ 0.690114] Key type dns_resolver registered vm-test-run-secrets> machine # [ 0.693707] registered taskstats version 1 vm-test-run-secrets> machine # [ 0.693873] Loading compiled-in X.509 certificates vm-test-run-secrets> machine # [ 0.699278] Demotion targets for Node 0: null vm-test-run-secrets> machine # [ 0.699355] Key type .fscrypt registered vm-test-run-secrets> machine # [ 0.699361] Key type fscrypt-provisioning registered vm-test-run-secrets> machine # [ 0.699472] ima: No TPM chip found, activating TPM-bypass! vm-test-run-secrets> machine # [ 0.699485] ima: Allocated hash algorithm: sha1 vm-test-run-secrets> machine # [ 0.699543] ima: No architecture policies found vm-test-run-secrets> machine # [ 0.702653] input: gpio-keys as /devices/platform/gpio-keys/input/input0 vm-test-run-secrets> machine # [ 0.712796] clk: Disabling unused clocks vm-test-run-secrets> machine # [ 0.712820] PM: genpd: Disabling unused power domains vm-test-run-secrets> machine # [ 0.716133] Freeing unused kernel memory: 4736K vm-test-run-secrets> machine # [ 0.716220] Run /init as init process vm-test-run-secrets> machine # [ 0.738434] systemd[1]: Successfully made /usr/ read-only. vm-test-run-secrets> machine # [ 0.927997] usb 1-1: new high-speed USB device number 2 using ehci-pci vm-test-run-secrets> machine # [ 1.073180] systemd[1]: systemd 260.2 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-secrets> machine # [ 1.080583] systemd[1]: Detected virtualization qemu. vm-test-run-secrets> machine # [ 1.081760] systemd[1]: Detected architecture arm64. vm-test-run-secrets> machine # [ 1.083156] systemd[1]: Running in initrd. vm-test-run-secrets> machine # [ 1.085461] systemd[1]: Initializing machine ID from random generator. vm-test-run-secrets> machine # [ 1.087472] systemd[1]: Hostname set to . vm-test-run-secrets> machine # [ 1.093334] 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-secrets> machine # [ 1.180130] 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-secrets> machine # [ 1.195644] systemd[1]: Queued start job for default target Initrd Default Target. vm-test-run-secrets> machine # [ 1.201865] systemd[1]: Created slice Slice /system/modprobe. vm-test-run-secrets> machine # [ 1.202928] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. vm-test-run-secrets> machine # [ 1.204148] systemd[1]: Expecting device /dev/disk/by-label/nixos... vm-test-run-secrets> machine # [ 1.204934] systemd[1]: Reached target Path Units. vm-test-run-secrets> machine # [ 1.205549] systemd[1]: Reached target Slice Units. vm-test-run-secrets> machine # [ 1.206463] systemd[1]: Reached target Swaps. vm-test-run-secrets> machine # [ 1.207268] systemd[1]: Reached target Timer Units. vm-test-run-secrets> machine # [ 1.208053] systemd[1]: Listening on D-Bus System Message Bus Socket. vm-test-run-secrets> machine # [ 1.208966] systemd[1]: Listening on Journal Socket (/dev/log). vm-test-run-secrets> machine # [ 1.209800] systemd[1]: Listening on Journal Sockets. vm-test-run-secrets> machine # [ 1.210625] systemd[1]: Listening on udev Control Socket. vm-test-run-secrets> machine # [ 1.211647] systemd[1]: Listening on udev Kernel Socket. vm-test-run-secrets> machine # [ 1.212265] systemd[1]: Reached target Socket Units. vm-test-run-secrets> machine # [ 1.213979] systemd[1]: Starting Create List of Static Device Nodes... vm-test-run-secrets> machine # [ 1.222566] systemd[1]: Starting Load Kernel Module 9pnet_virtio... vm-test-run-secrets> machine # [ 1.223354] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs vm-test-run-secrets> machine # [ 1.225210] systemd[1]: Mounting Kernel Configuration File System... vm-test-run-secrets> machine # [ 1.232552] systemd[1]: Starting Journal Service... vm-test-run-secrets> machine # [ 1.249301] systemd[1]: Starting Load Kernel Modules... vm-test-run-secrets> machine # [ 1.252030] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki vm-test-run-secrets> machine # [ 1.268135] systemd[1]: Starting Coldplug All udev Devices... vm-test-run-secrets> machine # [ 1.271116] systemd-journald[73]: Collecting audit messages is disabled. vm-test-run-secrets> machine # [ 1.271726] systemd[1]: Finished Create List of Static Device Nodes. vm-test-run-secrets> machine # [ 1.273059] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. vm-test-run-secrets> machine # [ 1.276071] systemd[1]: Finished Load Kernel Module 9pnet_virtio. vm-test-run-secrets> machine # [ 1.276288] systemd[1]: Mounted Kernel Configuration File System. vm-test-run-secrets> machine # [ 1.293852] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... vm-test-run-secrets> machine # [ 1.300078] usb 1-2: new high-speed USB device number 3 using ehci-pci vm-test-run-secrets> machine # [ 1.316406] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. vm-test-run-secrets> machine # [ 1.325256] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. vm-test-run-secrets> machine # [ 1.326710] systemd[1]: Starting Create Static Device Nodes in /dev... vm-test-run-secrets> machine # [ 1.340081] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev vm-test-run-secrets> machine # [ 1.347915] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0 vm-test-run-secrets> machine # [ 1.359173] systemd[1]: Started Journal Service. vm-test-run-secrets> machine # [ 1.360135] [drm] features: -virgl +edid -resource_blob -host_visible vm-test-run-secrets> machine # [ 1.360170] [drm] features: -context_init vm-test-run-secrets> machine # [ 1.360641] [drm] number of scanouts: 1 vm-test-run-secrets> machine # [ 1.360657] [drm] number of cap sets: 0 vm-test-run-secrets> machine # [ 1.368279] virtio-pci 0000:00:09.0: [drm] Registered 1 planes with drm panic vm-test-run-secrets> machine # [ 1.368294] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0 vm-test-run-secrets> machine # [ 1.365561] systemd-modules-load[75]: Inserted module 'dm_mod' vm-test-run-secrets> machine # [ 1.366932] systemd-modules-load[75]: Module 'virtio_balloon' is built in vm-test-run-secrets> machine # [ 1.367702] systemd-modules-load[75]: Module 'virtio_console' is built in vm-test-run-secrets> machine # [ 1.370649] systemd[1]: Finished Create Static Device Nodes in /dev. vm-test-run-secrets> machine # [ 1.371327] systemd[1]: Reached target Preparation for Local File Systems. vm-test-run-secrets> machine # [ 1.379280] systemd[1]: Reached target Local File Systems. vm-test-run-secrets> machine # [ 1.392342] Console: switching to colour frame buffer device 160x50 vm-test-run-secrets> machine # [ 1.397734] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device vm-test-run-secrets> machine # [ 1.391601] systemd[1]: Starting Create System Files and Directories... vm-test-run-secrets> machine # [ 1.400983] systemd[1]: Starting Rule-based Manager for Device Events and Files... vm-test-run-secrets> machine # [ 1.402213] systemd-modules-load[75]: Inserted module 'virtio_gpu' vm-test-run-secrets> machine # [ 1.402827] systemd-modules-load[75]: Module 'virtio_rng' is built in vm-test-run-secrets> machine # [ 1.420131] systemd[1]: Finished Load Kernel Modules. vm-test-run-secrets> machine # [ 1.420731] systemd[1]: Starting Apply Kernel Variables... vm-test-run-secrets> machine # [ 1.444610] systemd[1]: Finished Create System Files and Directories. vm-test-run-secrets> machine # [ 1.450154] systemd[1]: Finished Apply Kernel Variables. vm-test-run-secrets> machine # [ 1.460644] 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-secrets> machine # [ 1.462548] 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-secrets> machine # [ 1.470979] systemd-udevd[84]: Using default interface naming scheme 'v260'. vm-test-run-secrets> machine # [ 1.484306] systemd[1]: Started Rule-based Manager for Device Events and Files. vm-test-run-secrets> machine # [ 1.532088] systemd[1]: Starting Virtual Console Setup... vm-test-run-secrets> machine # [ 1.580416] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones. vm-test-run-secrets> machine # [ 1.582723] systemd[1]: Finished Virtual Console Setup. vm-test-run-secrets> machine # [ 1.840824] systemd[1]: Finished Coldplug All udev Devices. vm-test-run-secrets> machine # [ 1.841411] systemd[1]: Reached target System Initialization. vm-test-run-secrets> machine # [ 1.841933] systemd[1]: Reached target Basic System. vm-test-run-secrets> machine # [ 1.948082] (udev-worker)[99]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-secrets> machine # [ 1.959265] (udev-worker)[97]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-secrets> machine # [ 2.003952] systemd[1]: Found device /dev/disk/by-label/nixos. vm-test-run-secrets> machine # [ 2.005293] systemd[1]: Reached target Initrd Root Device. vm-test-run-secrets> machine # [ 2.009003] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... vm-test-run-secrets> machine # [ 2.042341] systemd-fsck[113]: nixos: clean, 12/65536 files, 13019/262144 blocks vm-test-run-secrets> machine # [ 2.049212] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. vm-test-run-secrets> machine # [ 2.263469] systemd[1]: Mounting /sysroot... vm-test-run-secrets> machine # [ 2.297076] EXT4-fs (vda): mounted filesystem 868cfc6e-22d2-46de-96e7-26ccf2697120 r/w with ordered data mode. Quota mode: none. vm-test-run-secrets> machine # [ 2.293789] systemd[1]: Mounted /sysroot. vm-test-run-secrets> machine # [ 2.295349] systemd[1]: Reached target Initrd Root File System. vm-test-run-secrets> machine # [ 2.298458] systemd[1]: Starting Mountpoints Configured in the Real Root... vm-test-run-secrets> machine # [ 2.319170] systemd-sysroot-fstab-check[121]: /sysroot should be mounted in the initrd, will request daemon-reload. vm-test-run-secrets> machine # [ 2.323860] systemd[1]: Reload requested from client PID 121 ('systemd-sysroot') (unit initrd-parse-etc.service)... vm-test-run-secrets> machine # [ 2.327455] systemd[1]: Reloading... vm-test-run-secrets> machine # [ 2.502937] systemd[1]: Reloading finished in 176 ms. vm-test-run-secrets> machine # [ 2.507664] systemd-sysroot-fstab-check[121]: Requesting initrd-fs.target/start/replace... vm-test-run-secrets> machine # [ 2.510287] systemd-sysroot-fstab-check[121]: Requesting swap.target/start/replace... vm-test-run-secrets> machine # [ 2.516435] systemd[1]: Starting Load Kernel Module 9pnet_virtio... vm-test-run-secrets> machine # [ 2.520856] systemd[1]: initrd-parse-etc.service: Deactivated successfully. vm-test-run-secrets> machine # [ 2.522164] systemd[1]: Finished Mountpoints Configured in the Real Root. vm-test-run-secrets> machine # [ 2.524083] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. vm-test-run-secrets> machine # [ 2.540411] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. vm-test-run-secrets> machine # [ 2.541472] systemd[1]: Finished Load Kernel Module 9pnet_virtio. vm-test-run-secrets> machine # [ 2.825148] (udev-worker)[101]: mtd0ro: Failed to find and pin callout binary "/nix/store/x8r7i65cbx5zbf8f0dmnvwrm00r5ild8-systemd-260.2/lib/udev/mtd_probe": No such file or directory vm-test-run-secrets> machine # [ 2.830157] (udev-worker)[101]: mtd0ro: /nix/store/x8r7i65cbx5zbf8f0dmnvwrm00r5ild8-systemd-260.2/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-secrets> machine # [ 2.846250] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-secrets> machine # [ 2.847464] systemd[1]: Stopped Virtual Console Setup. vm-test-run-secrets> machine # [ 2.849438] systemd[1]: Stopping Virtual Console Setup... vm-test-run-secrets> machine # [ 2.849969] systemd[1]: Starting Virtual Console Setup... vm-test-run-secrets> machine # [ 2.874806] systemd-vconsole-setup[142]: Configuration of first virtual console was skipped, ignoring remaining ones. vm-test-run-secrets> machine # [ 2.877217] systemd[1]: Finished Virtual Console Setup. vm-test-run-secrets> machine # [ 3.267189] systemd[1]: Mounting /sysroot/nix/.ro-store... vm-test-run-secrets> machine # [ 3.276277] systemd[1]: Mounting /sysroot/nix/.rw-store... vm-test-run-secrets> machine # [ 3.284287] systemd[1]: Mounting /sysroot/run... vm-test-run-secrets> machine # [ 3.293520] systemd[1]: Mounting /sysroot/tmp/shared... vm-test-run-secrets> machine # [ 3.312411] systemd[1]: Mounting /sysroot/tmp/xchg... vm-test-run-secrets> machine # [ 3.319726] systemd[1]: Mounted /sysroot/run. vm-test-run-secrets> machine # [ 3.323462] systemd[1]: Mounted /sysroot/nix/.rw-store. vm-test-run-secrets> machine # [ 3.324682] systemd[1]: Mounted /sysroot/nix/.ro-store. vm-test-run-secrets> machine # [ 3.326222] systemd[1]: Mounted /sysroot/tmp/shared. vm-test-run-secrets> machine # [ 3.339077] systemd[1]: Starting rw-sysroot-nix-store.service... vm-test-run-secrets> machine # [ 3.343114] systemd[1]: Mounted /sysroot/tmp/xchg. vm-test-run-secrets> machine # [ 3.353370] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. vm-test-run-secrets> machine # [ 3.354340] systemd[1]: Finished rw-sysroot-nix-store.service. vm-test-run-secrets> machine # [ 3.356283] systemd[1]: Mounting /sysroot/nix/store... vm-test-run-secrets> machine # [ 3.383885] systemd[1]: Mounted /sysroot/nix/store. vm-test-run-secrets> machine # [ 3.384901] systemd[1]: Reached target Initrd File Systems. vm-test-run-secrets> machine # [ 3.386457] systemd[1]: Starting Find NixOS closure... vm-test-run-secrets> machine # [ 3.391929] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... vm-test-run-secrets> machine # [ 3.416865] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. vm-test-run-secrets> machine # [ 3.429619] systemd[1]: Finished Find NixOS closure. vm-test-run-secrets> machine # [ 3.430474] systemd[1]: Reached target Initrd Default Target. vm-test-run-secrets> machine # [ 3.432276] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... vm-test-run-secrets> machine # [ 3.454856] systemd[1]: Stopped target Initrd Default Target. vm-test-run-secrets> machine # [ 3.455822] systemd[1]: Stopped target Basic System. vm-test-run-secrets> machine # [ 3.459343] systemd[1]: Stopped target Initrd Root Device. vm-test-run-secrets> machine # [ 3.459851] systemd[1]: Stopped target Path Units. vm-test-run-secrets> machine # [ 3.460644] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. vm-test-run-secrets> machine # [ 3.461335] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. vm-test-run-secrets> machine # [ 3.462309] systemd[1]: Stopped target Slice Units. vm-test-run-secrets> machine # [ 3.463987] systemd[1]: Stopped target Socket Units. vm-test-run-secrets> machine # [ 3.464549] systemd[1]: Stopped target System Initialization. vm-test-run-secrets> machine # [ 3.465880] systemd[1]: Stopped target Swaps. vm-test-run-secrets> machine # [ 3.468116] systemd[1]: Stopped target Timer Units. vm-test-run-secrets> machine # [ 3.468617] systemd[1]: dbus.socket: Deactivated successfully. vm-test-run-secrets> machine # [ 3.469156] systemd[1]: Closed D-Bus System Message Bus Socket. vm-test-run-secrets> machine # [ 3.470112] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. vm-test-run-secrets> machine # [ 3.471742] systemd[1]: Stopped Find NixOS closure. vm-test-run-secrets> machine # [ 3.473215] systemd[1]: Starting Load Kernel Module 9pnet_virtio... vm-test-run-secrets> machine # [ 3.476835] systemd[1]: Starting rw-sysroot-nix-store.service... vm-test-run-secrets> machine # [ 3.477443] systemd[1]: systemd-sysctl.service: Deactivated successfully. vm-test-run-secrets> machine # [ 3.479382] systemd[1]: Stopped Apply Kernel Variables. vm-test-run-secrets> machine # [ 3.480572] systemd[1]: systemd-modules-load.service: Deactivated successfully. vm-test-run-secrets> machine # [ 3.482874] systemd[1]: Stopped Load Kernel Modules. vm-test-run-secrets> machine # [ 3.485668] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. vm-test-run-secrets> machine # [ 3.488217] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. vm-test-run-secrets> machine # [ 3.488973] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. vm-test-run-secrets> machine # [ 3.490020] systemd[1]: Stopped Create System Files and Directories. vm-test-run-secrets> machine # [ 3.493322] systemd[1]: Stopped target Local File Systems. vm-test-run-secrets> machine # [ 3.493873] systemd[1]: Stopped target Preparation for Local File Systems. vm-test-run-secrets> machine # [ 3.495064] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. vm-test-run-secrets> machine # [ 3.497008] systemd[1]: Stopped Coldplug All udev Devices. vm-test-run-secrets> machine # [ 3.498768] systemd[1]: Stopping Rule-based Manager for Device Events and Files... vm-test-run-secrets> machine # [ 3.499434] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-secrets> machine # [ 3.500948] systemd[1]: Stopped Virtual Console Setup. vm-test-run-secrets> machine # [ 3.501488] systemd[1]: systemd-udevd.service: Deactivated successfully. vm-test-run-secrets> machine # [ 3.508130] systemd[1]: Stopped Rule-based Manager for Device Events and Files. vm-test-run-secrets> machine # [ 3.508875] systemd[1]: initrd-cleanup.service: Deactivated successfully. vm-test-run-secrets> machine # [ 3.509493] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. vm-test-run-secrets> machine # [ 3.514437] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. vm-test-run-secrets> machine # [ 3.515211] systemd[1]: Finished rw-sysroot-nix-store.service. vm-test-run-secrets> machine # [ 3.517463] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. vm-test-run-secrets> machine # [ 3.519716] systemd[1]: Finished Load Kernel Module 9pnet_virtio. vm-test-run-secrets> machine # [ 3.520890] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. vm-test-run-secrets> machine # [ 3.524259] systemd[1]: Closed udev Control Socket. vm-test-run-secrets> machine # [ 3.524839] systemd[1]: Starting Cleanup udev Database... vm-test-run-secrets> machine # [ 3.525396] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. vm-test-run-secrets> machine # [ 3.527597] systemd[1]: Stopped Create Static Device Nodes in /dev. vm-test-run-secrets> machine # [ 3.528261] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. vm-test-run-secrets> machine # [ 3.529393] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. vm-test-run-secrets> machine # [ 3.530087] systemd[1]: kmod-static-nodes.service: Deactivated successfully. vm-test-run-secrets> machine # [ 3.530722] systemd[1]: Stopped Create List of Static Device Nodes. vm-test-run-secrets> machine # [ 3.551168] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. vm-test-run-secrets> machine # [ 3.552816] systemd[1]: Finished Cleanup udev Database. vm-test-run-secrets> machine # [ 3.554215] systemd[1]: Reached target Switch Root. vm-test-run-secrets> machine # [ 3.554957] systemd[1]: Starting NixOS Activation... vm-test-run-secrets> machine # [ 3.752163] initrd-nixos-activation-start[179]: booting system configuration /nix/store/3fqikzln17f27r2b92vav49s7hskhlqf-nixos-system-machine-test vm-test-run-secrets> machine # [ 3.820990] initrd-nixos-activation-start[179]: running activation script... vm-test-run-secrets> machine # [ 4.295161] initrd-nixos-activation-start[202]: setting up /etc... vm-test-run-secrets> machine # [ 4.484854] initrd-nixos-activation-start[202]: setting up secrets... vm-test-run-secrets> machine # [ 4.820944] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. vm-test-run-secrets> machine # [ 4.822740] systemd[1]: Finished NixOS Activation. vm-test-run-secrets> machine # [ 4.824101] systemd[1]: Starting Switch Root... vm-test-run-secrets> machine # [ 4.836247] systemd[1]: Switching root. vm-test-run-secrets> machine # [ 4.892492] systemd-journald[73]: Received SIGTERM from PID 1 (systemd). vm-test-run-secrets> machine # [ 5.483461] systemd[1]: systemd 260.2 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-secrets> machine # [ 5.490981] systemd[1]: Detected virtualization qemu. vm-test-run-secrets> machine # [ 5.493061] systemd[1]: Detected architecture arm64. vm-test-run-secrets> machine # [ 5.494385] systemd[1]: Detected first boot. vm-test-run-secrets> machine # [ 5.502506] systemd[1]: Initializing machine ID from random generator. vm-test-run-secrets> machine # [ 5.773147] systemd[1]: bpf-restrict-fs: LSM BPF program attached vm-test-run-secrets> machine # [ 5.910922] systemd[1]: Applying preset policy. vm-test-run-secrets> machine # [ 6.347909] systemd[1]: Populated /etc with preset unit settings. vm-test-run-secrets> machine # [ 6.793158] systemd[1]: initrd-switch-root.service: Deactivated successfully. vm-test-run-secrets> machine # [ 6.794102] systemd[1]: Stopped initrd-switch-root.service. vm-test-run-secrets> machine # [ 6.796147] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. vm-test-run-secrets> machine # [ 6.798253] systemd[1]: Created slice Slice /system/getty. vm-test-run-secrets> machine # [ 6.799870] systemd[1]: Created slice User and Session Slice. vm-test-run-secrets> machine # [ 6.801150] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. vm-test-run-secrets> machine # [ 6.802599] systemd[1]: Started Forward Password Requests to Wall Directory Watch. vm-test-run-secrets> machine # [ 6.804132] systemd[1]: Expecting device /dev/hvc0... vm-test-run-secrets> machine # [ 6.804653] systemd[1]: Expecting device /dev/ttyAMA0... vm-test-run-secrets> machine # [ 6.805732] systemd[1]: Reached target Local Encrypted Volumes. vm-test-run-secrets> machine # [ 6.806891] systemd[1]: Stopped target initrd-fs.target. vm-test-run-secrets> machine # [ 6.807976] systemd[1]: Stopped target initrd-root-fs.target. vm-test-run-secrets> machine # [ 6.809068] systemd[1]: Stopped target initrd-switch-root.target. vm-test-run-secrets> machine # [ 6.810164] systemd[1]: Reached target Virtual Machines and Containers. vm-test-run-secrets> machine # [ 6.811844] systemd[1]: Reached target Path Units. vm-test-run-secrets> machine # [ 6.813341] systemd[1]: Reached target Remote File Systems. vm-test-run-secrets> machine # [ 6.814845] systemd[1]: Reached target Slice Units. vm-test-run-secrets> machine # [ 6.816437] systemd[1]: Reached target Swaps. vm-test-run-secrets> machine # [ 6.820992] systemd[1]: Listening on Process Core Dump Socket. vm-test-run-secrets> machine # [ 6.824808] systemd[1]: Listening on Credential Encryption/Decryption. vm-test-run-secrets> machine # [ 6.829769] systemd[1]: Starting Journal Log Access Socket... vm-test-run-secrets> machine # [ 6.831417] systemd[1]: Listening on Journal Audit Socket. vm-test-run-secrets> machine # [ 6.832639] systemd[1]: Listening on Network Management Metrics Varlink Socket. vm-test-run-secrets> machine # [ 6.834444] systemd[1]: Listening on Network Management Netlink Socket. vm-test-run-secrets> machine # [ 6.836518] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. vm-test-run-secrets> machine # [ 6.838241] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki vm-test-run-secrets> machine # [ 6.840275] systemd[1]: Listening on udev Control Socket. vm-test-run-secrets> machine # [ 6.844933] systemd[1]: Mounting Huge Pages File System... vm-test-run-secrets> machine # [ 6.848989] systemd[1]: Mounting POSIX Message Queue File System... vm-test-run-secrets> machine # [ 6.856126] systemd[1]: Mounting Kernel Debug File System... vm-test-run-secrets> machine # [ 6.867377] systemd[1]: Mounting Kernel Trace File System... vm-test-run-secrets> machine # [ 6.876294] systemd[1]: Starting Create List of Static Device Nodes... vm-test-run-secrets> machine # [ 6.884220] systemd[1]: Starting Load Kernel Module 9pnet_virtio... vm-test-run-secrets> machine # [ 6.885426] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs vm-test-run-secrets> machine # [ 6.898132] systemd[1]: Mounting Kernel Configuration File System... vm-test-run-secrets> machine # [ 6.899880] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm vm-test-run-secrets> machine # [ 6.901650] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore vm-test-run-secrets> machine # [ 6.912960] systemd[1]: Starting Load Kernel Module fuse... vm-test-run-secrets> machine # [ 6.916456] 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-secrets> machine # [ 6.976577] systemd[1]: Starting Journal Service... vm-test-run-secrets> machine # [ 7.004930] systemd[1]: Starting Load Kernel Modules... vm-test-run-secrets> machine # [ 7.024264] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... vm-test-run-secrets> machine # [ 7.046154] systemd[1]: Starting Remount Root and Kernel File Systems... vm-test-run-secrets> machine # [ 7.053531] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki vm-test-run-secrets> machine # [ 7.077792] systemd[1]: Starting Coldplug All udev Devices... vm-test-run-secrets> machine # [ 7.091901] systemd[1]: Listening on Journal Log Access Socket. vm-test-run-secrets> machine # [ 7.104718] systemd[1]: Mounted Huge Pages File System. vm-test-run-secrets> machine # [ 7.118178] fuse: init (API version 7.45) vm-test-run-secrets> machine # [ 7.121604] systemd[1]: Mounted POSIX Message Queue File System. vm-test-run-secrets> machine # [ 7.122127] systemd[1]: Mounted Kernel Debug File System. vm-test-run-secrets> machine # [ 7.122543] systemd[1]: Mounted Kernel Trace File System. vm-test-run-secrets> machine # [ 7.129162] systemd[1]: Finished Create List of Static Device Nodes. vm-test-run-secrets> machine # [ 7.132727] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. vm-test-run-secrets> machine # [ 7.140335] systemd[1]: Finished Load Kernel Module 9pnet_virtio. vm-test-run-secrets> machine # [ 7.140943] systemd[1]: Mounted Kernel Configuration File System. vm-test-run-secrets> machine # [ 7.141411] systemd[1]: modprobe@fuse.service: Deactivated successfully. vm-test-run-secrets> machine # [ 7.145998] systemd[1]: Finished Load Kernel Module fuse. vm-test-run-secrets> machine # [ 7.156147] systemd[1]: Finished Load Kernel Modules. vm-test-run-secrets> machine # [ 7.161007] systemd[1]: Mounting FUSE Control File System... vm-test-run-secrets> machine # [ 7.170285] systemd[1]: Starting Firewall... vm-test-run-secrets> machine # [ 7.183536] systemd[1]: Starting Apply Kernel Variables... vm-test-run-secrets> machine # [ 7.184098] EXT4-fs (vda): re-mounted 868cfc6e-22d2-46de-96e7-26ccf2697120. vm-test-run-secrets> machine # [ 7.191066] systemd-journald[277]: Collecting audit messages is enabled. vm-test-run-secrets> machine # [ 7.194317] systemd[1]: Queued start job for default target Multi-User System. vm-test-run-secrets> machine # [ 7.196899] systemd[1]: systemd-journald.service: Deactivated successfully. vm-test-run-secrets> machine # [ 7.200401] systemd-modules-load[278]: Module 'atkbd' is built in vm-test-run-secrets> machine # [ 7.204102] systemd-modules-load[278]: Module 'loop' is built in vm-test-run-secrets> machine # [ 7.205371] systemd-oomd[279]: No swap; memory pressure usage will be degraded vm-test-run-secrets> machine # [ 7.216238] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... vm-test-run-secrets> machine # [ 7.221199] systemd[1]: Started Journal Service. vm-test-run-secrets> machine # [ 7.228968] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. vm-test-run-secrets> machine # [ 7.233540] systemd[1]: Finished Remount Root and Kernel File Systems. vm-test-run-secrets> machine # [ 7.288283] systemd[1]: Starting Flush Journal to Persistent Storage... vm-test-run-secrets> machine # [ 7.289790] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore vm-test-run-secrets> machine # [ 7.298414] systemd[1]: Starting Load/Save OS Random Seed... vm-test-run-secrets> machine # [ 7.302320] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki vm-test-run-secrets> machine # [ 7.305855] systemd[1]: Mounted FUSE Control File System. vm-test-run-secrets> machine # [ 7.347619] systemd[1]: Finished Apply Kernel Variables. vm-test-run-secrets> machine # [ 7.355687] systemd[1]: Starting Network Name Resolution... vm-test-run-secrets> machine # [ 7.399477] systemd-journald[277]: Received client request to flush runtime journal. vm-test-run-secrets> machine # [ 7.493628] systemd[1]: Finished Load/Save OS Random Seed. vm-test-run-secrets> machine # [ 7.495676] systemd[1]: Reached target First Boot Complete. vm-test-run-secrets> machine # [ 7.500672] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. vm-test-run-secrets> machine # [ 7.501360] systemd[1]: Starting Create Static Device Nodes in /dev... vm-test-run-secrets> machine # [ 7.504187] systemd[1]: Finished Flush Journal to Persistent Storage. vm-test-run-secrets> machine # [ 7.547200] systemd-resolved[306]: Positive Trust Anchors: vm-test-run-secrets> machine # [ 7.552495] systemd-resolved[306]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d vm-test-run-secrets> machine # [ 7.554351] systemd-resolved[306]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 vm-test-run-secrets> machine # [ 7.556613] systemd-resolved[306]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test vm-test-run-secrets> machine # [ 7.587244] systemd[1]: Finished Create Static Device Nodes in /dev. vm-test-run-secrets> machine # [ 7.587954] systemd[1]: Reached target Preparation for Local File Systems. vm-test-run-secrets> machine # [ 7.590966] systemd[1]: Starting Rule-based Manager for Device Events and Files... vm-test-run-secrets> machine # [ 7.698794] systemd-udevd[321]: Using default interface naming scheme 'v260'. vm-test-run-secrets> machine # [ 7.789043] systemd-resolved[306]: Using system hostname 'machine'. vm-test-run-secrets> machine # [ 7.790677] systemd[1]: Mounting /run/wrappers... vm-test-run-secrets> machine # [ 7.798754] systemd[1]: Started Network Name Resolution. vm-test-run-secrets> machine # [ 7.852186] systemd[1]: Mounted /run/wrappers. vm-test-run-secrets> machine # [ 7.856342] systemd[1]: Reached target Local File Systems. vm-test-run-secrets> machine # [ 7.860501] systemd[1]: Listening on Boot Loader Control Service Socket. vm-test-run-secrets> machine # [ 7.863175] systemd[1]: Starting register-nix-paths.service... vm-test-run-secrets> machine # [ 7.874914] systemd[1]: Starting Create SUID/SGID Wrappers... vm-test-run-secrets> machine # [ 7.875975] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. vm-test-run-secrets> machine # [ 7.882648] systemd[1]: Starting Save Transient machine-id to Disk... vm-test-run-secrets> machine # [ 7.914750] systemd[1]: Starting Create System Files and Directories... vm-test-run-secrets> machine # [ 7.922317] systemd[1]: Started Rule-based Manager for Device Events and Files. vm-test-run-secrets> machine # [ 8.039382] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. vm-test-run-secrets> machine # [ 8.047821] systemd[1]: Finished Save Transient machine-id to Disk. vm-test-run-secrets> machine # [ 8.098356] systemd[1]: Finished Create System Files and Directories. vm-test-run-secrets> machine # [ 8.106192] systemd[1]: Starting Rebuild Journal Catalog... vm-test-run-secrets> machine # [ 8.111334] systemd[1]: Starting Record System Boot/Shutdown in UTMP... vm-test-run-secrets> machine # [ 8.229864] systemd[1]: Finished Record System Boot/Shutdown in UTMP. vm-test-run-secrets> machine # [ 8.332294] systemd[1]: Finished Rebuild Journal Catalog. vm-test-run-secrets> machine # [ 8.343413] systemd[1]: Starting Update is Completed... vm-test-run-secrets> machine # [ 8.424639] systemd[1]: Finished Update is Completed. vm-test-run-secrets> machine # [ 8.483516] systemd[1]: Finished Coldplug All udev Devices. vm-test-run-secrets> machine # [ 8.649075] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs vm-test-run-secrets> machine # [ 8.898803] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. vm-test-run-secrets> machine # [ 8.902618] systemd[1]: Finished Create SUID/SGID Wrappers. vm-test-run-secrets> machine # [ 8.954159] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. vm-test-run-secrets> machine # [ 9.019557] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. vm-test-run-secrets> machine # [ 9.110201] systemd[1]: Finished Firewall. vm-test-run-secrets> machine # [ 9.112434] systemd[1]: Reached target Preparation for Network. vm-test-run-secrets> machine # [ 9.118073] systemd[1]: Starting Network Management... vm-test-run-secrets> machine # [ 9.170091] systemd[1]: Finished register-nix-paths.service. vm-test-run-secrets> machine # [ 9.170708] systemd[1]: Reached target System Initialization. vm-test-run-secrets> machine # [ 9.171213] systemd[1]: Started Discard unused filesystem blocks once a week. vm-test-run-secrets> machine # [ 9.171837] systemd[1]: Started Daily Cleanup of Temporary Directories. vm-test-run-secrets> machine # [ 9.177745] systemd[1]: Reached target Timer Units. vm-test-run-secrets> machine # [ 9.179924] systemd[1]: Listening on D-Bus System Message Bus Socket. vm-test-run-secrets> machine # [ 9.182492] systemd[1]: Listening on Nix Daemon Socket. vm-test-run-secrets> machine # [ 9.185683] systemd[1]: Listening on Hostname Service Socket. vm-test-run-secrets> machine # [ 9.189146] systemd[1]: Reached target Socket Units. vm-test-run-secrets> machine # [ 9.189666] systemd[1]: Reached target Basic System. vm-test-run-secrets> machine # [ 9.191103] systemd[1]: Started backdoor.service. vm-test-run-secrets> machine # [ 9.197227] systemd[1]: Starting Import lastlog data into lastlog2 database... vm-test-run-secrets> machine # [ 9.197990] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-secrets> machine # [ 9.208624] systemd[1]: Starting Post-Boot Actions... vm-test-run-secrets> machine # [ 9.238153] systemd[1]: Started Reset console on configuration changes. vm-test-run-secrets> machine # [ 9.299058] systemd[1]: Starting D-Bus System Message Bus... vm-test-run-secrets> machine # [ 9.366243] systemd[1]: Finished Post-Boot Actions. vm-test-run-secrets> machine # connecting to host... vm-test-run-secrets> machine # [ 9.418170] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-secrets> machine # [ 9.422296] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-secrets> machine # [ 9.428092] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-secrets> machine: Guest shell says: b'Spawning backdoor root shell...\n' vm-test-run-secrets> machine: connected to guest root shell vm-test-run-secrets> machine: (connecting took 9.70 seconds) vm-test-run-secrets> machine: (finished: waiting for the VM to finish booting, in 10.16 seconds) vm-test-run-secrets> machine # [ 9.434470] nsncd[507]: Sep 10 00:20:01.260 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-secrets> machine # [ 9.443150] systemd[1]: Starting User Login Management... vm-test-run-secrets> machine # [ 9.464773] (udev-worker)[353]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-secrets> machine # [ 9.480327] (udev-worker)[357]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-secrets> machine # [ 9.488109] systemd[1]: Finished Import lastlog data into lastlog2 database. vm-test-run-secrets> machine # [ 9.504437] cfg80211: Loading compiled-in X.509 certificates for regulatory database vm-test-run-secrets> machine # foo[ 9.548790] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' vm-test-run-secrets> machine # [ 9.549293] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' vm-test-run-secrets> machine # [ 9.553711] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 vm-test-run-secrets> machine # [ 9.554103] cfg80211: failed to load regulatory.db vm-test-run-secrets> machine: (finished: must succeed: cat /etc/secret >&2, in 10.26 seconds) vm-test-run-secrets> machine: must succeed: cat /etc/group-secret >&2 vm-test-run-secrets> machine # [ 9.563263] dbus-broker-launch[512]: Looking up NSS user entry for 'systemd-timesync'... vm-test-run-secrets> machine # [ 9.595542] dbus-broker-launch[512]: NSS returned no entry for 'systemd-timesync' vm-test-run-secrets> machine # [ 9.596330] dbus-broker-launch[512]: Invalid user-name in /nix/store/0rz3j4j33snlxzx4k33366ah0mga02m8-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" vm-test-run-secrets> machine: (finished: must succeed: cat /etc/group-secret >&2, in 0.07 seconds) vm-test-run-secrets> machine: must succeed: [ "$(cat /etc/secret-sops-file)" != "$(cat /etc/secret-sops-file-legacy)" ] vm-test-run-secrets> machine # foo[ 9.644721] systemd[1]: Started D-Bus System Message Bus. vm-test-run-secrets> machine # [ 9.652280] systemd-networkd[502]: lo: Link UP vm-test-run-secrets> machine # [ 9.656437] systemd-networkd[502]: lo: Gained carrier vm-test-run-secrets> machine # [ 9.660939] systemd-logind[531]: Watching system buttons on /dev/input/event0 (gpio-keys) vm-test-run-secrets> machine # [ 9.663540] systemd-logind[531]: New seat seat0. vm-test-run-secrets> machine # [ 9.693693] dbus-broker-launch[512]: Ready vm-test-run-secrets> machine # [ 9.700246] systemd[1]: Started User Login Management. vm-test-run-secrets> machine # [ 9.700791] systemd[1]: Started Network Management. vm-test-run-secrets> machine # [ 9.701212] systemd[1]: Reached target Network. vm-test-run-secrets> machine # [ 9.706964] systemd[1]: Starting linger-users.service... vm-test-run-secrets> machine # [ 9.711533] systemd[1]: Starting Enable Persistent Storage in systemd-networkd... vm-test-run-secrets> machine: (finished: must succeed: [ "$(cat /etc/secret-sops-file)" != "$(cat /etc/secret-sops-file-legacy)" ], in 0.10 seconds) vm-test-run-secrets> (finished: run the VM test script, in 10.42 seconds) vm-test-run-secrets> machine # [ 9.718289] systemd[1]: Starting Permit User Sessions... vm-test-run-secrets> machine # [ 9.752287] systemd-networkd[502]: eth0: Configuring with /etc/systemd/network/99-ethernet-default-dhcp.network. vm-test-run-secrets> machine # [ 9.755220] systemd-networkd[502]: eth0: Link UP vm-test-run-secrets> machine # [ 9.756940] systemd-networkd[502]: eth0: Gained carrier vm-test-run-secrets> machine # [ 9.774568] systemd-networkd[502]: eth0: DHCPv4 address 10.0.2.15/24, gateway 10.0.2.2 acquired from 10.0.2.2 vm-test-run-secrets> machine # [ 9.790032] systemd-networkd[502]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network vm-test-run-secrets> machine # [ 9.801329] systemd-networkd[502]: eth1: Configuring with /etc/systemd/network/40-eth1.network. vm-test-run-secrets> machine # [ 9.802060] systemd-networkd[502]: eth1: Link UP vm-test-run-secrets> machine # [ 9.802467] systemd-networkd[502]: eth1: Gained carrier vm-test-run-secrets> machine # [ 9.802936] systemd-networkd[502]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network vm-test-run-secrets> test script finished in 10.54s vm-test-run-secrets> cleanup vm-test-run-secrets> kill QemuMachine (pid 12) vm-test-run-secrets> machine # qemu-system-aarch64: terminating on signal 15 from pid 6 (/nix/store/akbq19lqha5w5h9hcchn309znqm94pq0-python3-3.13.15/bin/python3.13) vm-test-run-secrets> (finished: cleanup, in 0.15 seconds) upload niks3: failed time=2026-09-10T00:34:58.594Z level=WARN msg="Request returned retryable status, retrying" attempt=1 max_attempts=6 backoff=100ms status=502 url=https://niks3.clan.lol/api/pending_closures time=2026-09-10T00:36:03.546Z level=WARN msg="Request returned retryable status, retrying" attempt=2 max_attempts=6 backoff=187.155328ms status=502 url=https://niks3.clan.lol/api/pending_closures time=2026-09-10T00:41:38.531Z level=WARN msg="Request returned retryable status, retrying" attempt=1 max_attempts=6 backoff=100ms status=504 url=https://niks3.clan.lol/api/pending_closures time=2026-09-10T00:46:38.632Z level=WARN msg="Request returned retryable status, retrying" attempt=2 max_attempts=6 backoff=182.285456ms status=504 url=https://niks3.clan.lol/api/pending_closures time=2026-09-10T00:52:05.427Z level=WARN msg="Request returned retryable status, retrying" attempt=1 max_attempts=6 backoff=100ms status=504 url=https://niks3.clan.lol/api/pending_closures time=2026-09-10T00:57:05.530Z level=WARN msg="Request returned retryable status, retrying" attempt=2 max_attempts=6 backoff=216.110839ms status=504 url=https://niks3.clan.lol/api/pending_closures time=2026-09-10T01:02:05.748Z level=WARN msg="Request returned retryable status, retrying" attempt=3 max_attempts=6 backoff=374.38175ms status=504 url=https://niks3.clan.lol/api/pending_closures time=2026-09-10T01:07:06.123Z level=WARN msg="Request returned retryable status, retrying" attempt=4 max_attempts=6 backoff=789.765369ms status=504 url=https://niks3.clan.lol/api/pending_closures time=2026-09-10T01:12:06.915Z level=WARN msg="Request returned retryable status, retrying" attempt=5 max_attempts=6 backoff=1.610297597s status=504 url=https://niks3.clan.lol/api/pending_closures time=2026-09-10T01:17:08.527Z level=ERROR msg="Fatal error" error="pushing paths: creating pending closures: creating pending closure: server returned 504: "