tribuchet: building on eliza Machine state will be reset. To keep it, pass --keep-machine-state start all VLans (finished: start all VLans, in 0.00 seconds) Test will time out and terminate in 3600 seconds run the VM test script machine: waiting for unit multi-user.target machine: waiting for the VM to finish booting machine: starting vm machine # Disk image does not exist, creating the virtualisation disk image... machine: QEMU running (pid 45) machine # Formatting '/build/vm-state-machine/tmp.KuQLVbD9Yu', fmt=raw size=1073741824 machine # mke2fs 1.47.4 (6-Mar-2025) machine # Discarding device blocks: 0/262144 done machine # Creating filesystem with 262144 4k blocks and 65536 inodes machine # Filesystem UUID: 11adae6e-999b-4ff0-99c7-12315f938e3e machine # Superblock backups stored on blocks: machine # 32768, 98304, 163840, 229376 machine # machine # Allocating group tables: 0/8 done machine # Writing inode tables: 0/8 done machine # Creating journal (8192 blocks): done machine # Writing superblocks and filesystem accounting information: 0/8 done machine # machine # Virtualisation disk image created. machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40] 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 machine # [ 0.000000] KASLR enabled machine # [ 0.000000] random: crng init done machine # [ 0.000000] Machine model: linux,dummy-virt machine # [ 0.000000] efi: UEFI not found. machine # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000013fffffff] machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x13fdeb740-0x13fdeeebf] machine # [ 0.000000] Zone ranges: machine # [ 0.000000] DMA [mem 0x0000000040000000-0x00000000ffffffff] machine # [ 0.000000] DMA32 empty machine # [ 0.000000] Normal [mem 0x0000000100000000-0x000000013fffffff] machine # [ 0.000000] Device empty machine # [ 0.000000] Movable zone start for each node machine # [ 0.000000] Early memory node ranges machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000013fffffff] machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000013fffffff] machine # [ 0.000000] cma: Reserved 32 MiB at 0x00000000fe000000 machine # [ 0.000000] psci: probing for conduit method from DT. machine # [ 0.000000] psci: PSCIv1.3 detected in firmware. machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs machine # [ 0.000000] psci: Trusted OS migration not required machine # [ 0.000000] psci: SMC Calling Convention v1.1 machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) machine # [ 0.000000] percpu: Embedded 76 pages/cpu s186392 r8192 d116712 u311296 machine # [ 0.000000] Detected PIPT I-cache on CPU0 machine # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm) machine # [ 0.000000] CPU features: detected: GICv3 CPU interface machine # [ 0.000000] CPU features: detected: Spectre-v4 machine # [ 0.000000] CPU features: detected: Spectre-BHB machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38 machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23 machine # [ 0.000000] alternatives: applying boot alternatives 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/6jjral78h0pim0k25ahd9qxi06rwmd23-nixos-system-machine-test/init regInfo=/nix/store/i4amarwnjgkhazjc3n4a2m4axhmy83sx-closure-info/registration console=ttyAMA0,115200n8 console=tty0 machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/i4amarwnjgkhazjc3n4a2m4axhmy83sx-closure-info/registration", will be passed to user space. machine # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes machine # [ 0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) machine # [ 0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) machine # [ 0.000000] software IO TLB: area num 4. machine # [ 0.000000] software IO TLB: mapped [mem 0x00000000fa000000-0x00000000fe000000] (64MB) machine # [ 0.000000] Fallback order for Node 0: 0 machine # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1048576 machine # [ 0.000000] Policy zone: Normal machine # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off machine # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 machine # [ 0.000000] allocated 8388608 bytes of page_ext machine # [ 0.000000] ftrace: allocating 74754 entries in 294 pages machine # [ 0.000000] ftrace: allocated 294 pages with 4 groups machine # [ 0.000000] rcu: Hierarchical RCU implementation. machine # [ 0.000000] rcu: RCU event tracing is enabled. machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=4. machine # [ 0.000000] Trampoline variant of Tasks RCU enabled. machine # [ 0.000000] Rude variant of Tasks RCU enabled. machine # [ 0.000000] Tracing variant of Tasks RCU enabled. machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 machine # [ 0.000000] RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. machine # [ 0.000000] RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. machine # [ 0.000000] RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 machine # [ 0.000000] GICv3: 256 SPIs implemented machine # [ 0.000000] GICv3: 0 Extended SPIs implemented machine # [ 0.000000] Root IRQ handler: gic_handle_irq machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0 machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @100b10000 (indirect, esz 8, psz 64K, shr 1) machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @100b20000 (flat, esz 8, psz 64K, shr 1) machine # [ 0.000000] GICv3: using LPI property table @0x0000000100b40000 machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000100b50000 machine # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. machine # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns machine # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt). machine # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns machine # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns machine # [ 0.000029] arm-pv: using stolen time PV machine # [ 0.000427] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) machine # [ 0.000614] Console: colour dummy device 80x25 machine # [ 0.000621] printk: legacy console [tty0] enabled machine # [ 0.000798] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) machine # [ 0.000804] pid_max: default: 32768 minimum: 301 machine # [ 0.000887] LSM: initializing lsm=capability,landlock,yama,bpf,ima machine # [ 0.001049] landlock: Up and running. machine # [ 0.001052] Yama: becoming mindful. machine # [ 0.001509] LSM support for eBPF active machine # [ 0.001662] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) machine # [ 0.001720] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) machine # [ 0.002895] cacheinfo: Unable to detect cache hierarchy for CPU 0 machine # [ 0.003623] rcu: Hierarchical SRCU implementation. machine # [ 0.003627] rcu: Max phase no-delay instances is 1000. machine # [ 0.003786] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level machine # [ 0.005146] fsl-mc MSI: its@8080000 domain created machine # [ 0.005236] EFI services will not be available. machine # [ 0.005426] smp: Bringing up secondary CPUs ... machine # [ 0.006073] Detected PIPT I-cache on CPU1 machine # [ 0.006177] GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 machine # [ 0.006309] GICv3: CPU1: using allocated LPI pending table @0x0000000100b60000 machine # [ 0.006441] CPU1: Booted secondary processor 0x0000000001 [0xc00fac40] machine # [ 0.007563] Detected PIPT I-cache on CPU2 machine # [ 0.007678] GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 machine # [ 0.007815] GICv3: CPU2: using allocated LPI pending table @0x0000000100b70000 machine # [ 0.007949] CPU2: Booted secondary processor 0x0000000002 [0xc00fac40] machine # [ 0.009043] Detected PIPT I-cache on CPU3 machine # [ 0.009161] GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 machine # [ 0.009295] GICv3: CPU3: using allocated LPI pending table @0x0000000100b80000 machine # [ 0.009423] CPU3: Booted secondary processor 0x0000000003 [0xc00fac40] machine # [ 0.009957] smp: Brought up 1 node, 4 CPUs machine # [ 0.009983] SMP: Total of 4 processors activated. machine # [ 0.009986] CPU: All CPU(s) started at EL1 machine # [ 0.009994] CPU features: detected: Branch Target Identification machine # [ 0.009997] CPU features: detected: ARMv8.4 Translation Table Level machine # [ 0.010000] CPU features: detected: Instruction cache invalidation not required for I/D coherence machine # [ 0.010004] CPU features: detected: Data cache clean to the PoU not required for I/D coherence machine # [ 0.010007] CPU features: detected: Common not Private translations machine # [ 0.010010] CPU features: detected: CRC32 instructions machine # [ 0.010012] CPU features: detected: Data cache clean to Point of Deep Persistence machine # [ 0.010015] CPU features: detected: Data cache clean to Point of Persistence machine # [ 0.010018] CPU features: detected: Data independent timing control (DIT) machine # [ 0.010021] CPU features: detected: E0PD machine # [ 0.010023] CPU features: detected: Enhanced Counter Virtualization machine # [ 0.010026] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) machine # [ 0.010028] CPU features: detected: Enhanced Virtualization Traps machine # [ 0.010031] CPU features: detected: Fine Grained Traps machine # [ 0.010034] CPU features: detected: Generic authentication (architected QARMA5 algorithm) machine # [ 0.010037] CPU features: detected: RCpc load-acquire (LDAPR) machine # [ 0.010040] CPU features: detected: LSE atomic instructions machine # [ 0.010042] CPU features: detected: Privileged Access Never machine # [ 0.010045] CPU features: detected: PMUv3 machine # [ 0.010047] CPU features: detected: RAS Extension Support machine # [ 0.010049] CPU features: detected: RASv1p1 Extension Support machine # [ 0.010052] CPU features: detected: Random Number Generator machine # [ 0.010054] CPU features: detected: Speculation barrier (SB) machine # [ 0.010056] CPU features: detected: Stage-2 Force Write-Back machine # [ 0.010059] CPU features: detected: TLB range maintenance instructions machine # [ 0.010063] CPU features: detected: Speculative Store Bypassing Safe (SSBS) machine # [ 0.010262] alternatives: applying system-wide alternatives machine # [ 0.013136] CPU features: detected: BBM Level 2 without TLB conflict abort machine # [ 0.013383] Memory: 3910032K/4194304K available (24384K kernel code, 7086K rwdata, 26316K rodata, 4736K init, 1102K bss, 233732K reserved, 32768K cma-reserved) machine # [ 0.014799] devtmpfs: initialized machine # [ 0.018378] posixtimers hash table entries: 2048 (order: 3, 32768 bytes, linear) machine # [ 0.018446] futex hash table entries: 1024 (65536 bytes on 1 NUMA nodes, total 64 KiB, linear). machine # [ 0.018643] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL machine # [ 0.018648] 0 pages in range for non-PLT usage machine # [ 0.018649] 508320 pages in range for PLT usage machine # [ 0.018770] pinctrl core: initialized pinctrl subsystem machine # [ 0.019579] DMI not present or invalid. machine # [ 0.022853] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.025345] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations machine # [ 0.025521] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations machine # [ 0.025742] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.025761] audit: initializing netlink subsys (disabled) machine # [ 0.026069] audit: type=2000 audit(0.024:1): state=initialized audit_enabled=0 res=1 machine # [ 0.026533] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.026536] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.026540] thermal_sys: Registered thermal governor 'step_wise' machine # [ 0.026543] thermal_sys: Registered thermal governor 'user_space' machine # [ 0.026545] thermal_sys: Registered thermal governor 'power_allocator' machine # [ 0.026630] cpuidle: using governor ladder machine # [ 0.026655] cpuidle: using governor menu machine # [ 0.026843] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers. machine # [ 0.027066] ASID allocator initialised with 65536 entries machine # [ 0.028237] Serial: AMBA PL011 UART driver machine # [ 0.033429] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 machine # [ 0.033733] printk: console [ttyAMA0] enabled machine # [ 0.038992] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages machine # [ 0.038999] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.039002] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages machine # [ 0.039004] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page machine # [ 0.039007] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.039010] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.039013] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages machine # [ 0.039015] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page machine # [ 0.050324] fbcon: Taking over console machine # [ 0.050353] ACPI: Interpreter disabled. machine # [ 0.053023] iommu: Default domain type: Translated machine # [ 0.053035] iommu: DMA domain TLB invalidation policy: strict mode machine # [ 0.072071] SCSI subsystem initialized machine # [ 0.074111] usbcore: registered new interface driver usbfs machine # [ 0.074258] usbcore: registered new interface driver hub machine # [ 0.074363] usbcore: registered new device driver usb machine # [ 0.075311] pps_core: LinuxPPS API ver. 1 registered machine # [ 0.075323] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti machine # [ 0.075375] PTP clock support registered machine # [ 0.075521] EDAC MC: Ver: 3.0.0 machine # [ 0.076256] scmi_core: SCMI protocol bus registered machine # [ 0.077235] FPGA manager framework machine # [ 0.079935] vgaarb: loaded machine # [ 0.080807] clocksource: Switched to clocksource arch_sys_counter machine # [ 0.081415] VFS: Disk quotas dquot_6.6.0 machine # [ 0.082197] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) machine # [ 0.083080] netfs: FS-Cache loaded machine # [ 0.083492] pnp: PnP ACPI: disabled machine # [ 0.093351] NET: Registered PF_INET protocol family machine # [ 0.094939] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) machine # [ 0.150930] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) machine # [ 0.150987] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) machine # [ 0.151048] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) machine # [ 0.151300] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) machine # [ 0.151724] TCP: Hash tables configured (established 32768 bind 32768) machine # [ 0.151859] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear) machine # [ 0.151922] UDP hash table entries: 2048 (order: 5, 131072 bytes, linear) machine # [ 0.152011] UDP-Lite hash table entries: 2048 (order: 5, 131072 bytes, linear) machine # [ 0.152234] NET: Registered PF_UNIX/PF_LOCAL protocol family machine # [ 0.152311] NET: Registered PF_XDP protocol family machine # [ 0.152331] PCI: CLS 0 bytes, default 64 machine # [ 0.152700] Trying to unpack rootfs image as initramfs... machine # [ 0.156958] kvm [1]: HYP mode not available machine # [ 0.219786] Initialise system trusted keyrings machine # [ 0.221051] workingset: timestamp_bits=42 max_order=20 bucket_order=0 machine # [ 0.225680] squashfs: version 4.0 (2009/01/31) Phillip Lougher machine # [ 0.225823] 9p: Installing v9fs 9p2000 file system support machine # [ 0.242421] Key type asymmetric registered machine # [ 0.242427] Asymmetric key parser 'x509' registered machine # [ 0.242554] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) machine # [ 0.245057] io scheduler mq-deadline registered machine # [ 0.245066] io scheduler kyber registered machine # [ 0.254952] pl061_gpio 9030000.pl061: PL061 GPIO chip registered machine # [ 0.261028] ledtrig-cpu: registered to indicate activity on CPUs machine # [ 0.261694] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: machine # [ 0.261715] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 machine # [ 0.261729] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 machine # [ 0.261737] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 machine # [ 0.261776] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits machine # [ 0.261806] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] machine # [ 0.261921] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 machine # [ 0.261932] pci_bus 0000:00: root bus resource [bus 00-ff] machine # [ 0.261937] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] machine # [ 0.261942] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] machine # [ 0.261947] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] machine # [ 0.262116] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.262923] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.263270] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.263290] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.263339] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.263358] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.264192] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.264542] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.264560] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.264608] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.265488] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint machine # [ 0.265827] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] machine # [ 0.265847] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.265890] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.266725] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint machine # [ 0.267072] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.267091] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.267133] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.267988] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint machine # [ 0.268336] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.268354] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.268395] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.269311] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.269661] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] machine # [ 0.269681] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.269723] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.270607] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.270952] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.270976] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.271018] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.271041] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.271970] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint machine # [ 0.272320] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.272363] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.273266] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 0.273582] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.273624] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.274325] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint machine # [ 0.274654] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] machine # [ 0.275098] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint machine # [ 0.275524] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] machine # [ 0.275544] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.275593] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.276484] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.276839] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.276858] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.276900] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.277873] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned machine # [ 0.277883] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned machine # [ 0.277889] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned machine # [ 0.277965] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned machine # [ 0.278044] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned machine # [ 0.278125] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned machine # [ 0.278211] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned machine # [ 0.278287] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned machine # [ 0.278362] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned machine # [ 0.278436] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned machine # [ 0.278506] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned machine # [ 0.278584] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned machine # [ 0.278688] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned machine # [ 0.278765] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned machine # [ 0.278793] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned machine # [ 0.278820] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned machine # [ 0.278847] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned machine # [ 0.278876] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned machine # [ 0.278903] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned machine # [ 0.278931] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned machine # [ 0.278961] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned machine # [ 0.278990] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned machine # [ 0.279018] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned machine # [ 0.279057] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned machine # [ 0.279088] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned machine # [ 0.279115] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned machine # [ 0.279143] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned machine # [ 0.279172] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned machine # [ 0.279200] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned machine # [ 0.279227] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned machine # [ 0.279255] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned machine # [ 0.279283] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned machine # [ 0.279310] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned machine # [ 0.279339] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned machine # [ 0.279373] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] machine # [ 0.279381] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] machine # [ 0.279385] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] machine # [ 0.281533] pci 0000:00:0a.0: enabling device (0000 -> 0002) machine # [ 0.298838] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) machine # [ 0.301840] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) machine # [ 0.304660] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) machine # [ 0.307619] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) machine # [ 0.311359] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) machine # [ 0.315654] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) machine # [ 0.318256] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) machine # [ 0.321006] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) machine # [ 0.325250] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) machine # [ 0.329949] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) machine # [ 0.333209] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) machine # [ 0.340959] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 0.343509] msm_serial: driver initialized machine # [ 0.343693] SuperH (H)SCI(F) driver initialized machine # [ 0.343770] STM32 USART driver initialized machine # [ 0.366072] loop: module loaded machine # [ 0.366326] virtio_blk virtio5: 4/0/0 default/read/poll queues machine # [ 0.368742] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 0.371738] megasas: 07.734.00.00-rc1 machine # [ 0.372669] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] machine # [ 0.377303] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.377326] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.379188] Using buffer write method machine # [ 0.379227] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] machine # [ 0.381249] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.381268] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.383287] Using buffer write method machine # [ 0.383305] Concatenating MTD devices: machine # [ 0.383308] (0): "0.flash" machine # [ 0.383311] (1): "0.flash" machine # [ 0.383313] into device "0.flash" machine # [ 0.660215] Freeing initrd memory: 27052K machine # [ 0.679030] tun: Universal TUN/TAP device driver, 1.6 machine # [ 0.687119] thunder_xcv, ver 1.0 machine # [ 0.687211] thunder_bgx, ver 1.0 machine # [ 0.687274] nicpf, ver 1.0 machine # [ 0.688706] e1000: Intel(R) PRO/1000 Network Driver machine # [ 0.688716] e1000: Copyright (c) 1999-2006 Intel Corporation. machine # [ 0.688789] e1000e: Intel(R) PRO/1000 Network Driver machine # [ 0.688801] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. machine # [ 0.688894] igb: Intel(R) Gigabit Ethernet Network Driver machine # [ 0.688903] igb: Copyright (c) 2007-2014 Intel Corporation. machine # [ 0.688965] igbvf: Intel(R) Gigabit Virtual Function Network Driver machine # [ 0.688974] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. machine # [ 0.689333] sky2: driver version 1.30 machine # [ 0.693869] usbcore: registered new interface driver usb-storage machine # [ 0.694109] ehci-pci 0000:00:0a.0: EHCI Host Controller machine # [ 0.694189] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 machine # [ 0.694204] usbcore: registered new interface driver usbserial_generic machine # [ 0.694265] usbserial: USB Serial support registered for generic machine # [ 0.694682] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 machine # [ 0.695811] hv_vmbus: registering driver hyperv_keyboard machine # [ 0.698143] rtc-pl031 9010000.pl031: registered as rtc0 machine # [ 0.698193] rtc-pl031 9010000.pl031: setting system clock to 2026-08-31T07:37:06 UTC (1788161826) machine # [ 0.698980] i2c_dev: i2c /dev entries driver machine # [ 0.706362] sdhci: Secure Digital Host Controller Interface driver machine # [ 0.706375] sdhci: Copyright(c) Pierre Ossman machine # [ 0.707069] Synopsys Designware Multimedia Card Interface Driver machine # [ 0.708030] sdhci-pltfm: SDHCI platform and OF driver helper machine # [ 0.709001] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 machine # [ 0.710000] hub 1-0:1.0: USB hub found machine # [ 0.710059] hub 1-0:1.0: 6 ports detected machine # [ 0.712385] hid: raw HID events driver (C) Jiri Kosina machine # [ 0.713223] usbcore: registered new interface driver usbhid machine # [ 0.713232] usbhid: USB HID core driver machine # [ 0.741602] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available machine # [ 0.746504] drop_monitor: Initializing network drop monitor service machine # [ 0.746900] NET: Registered PF_INET6 protocol family machine # [ 0.749389] Segment Routing with IPv6 machine # [ 0.749428] In-situ OAM (IOAM) with IPv6 machine # [ 0.749500] NET: Registered PF_PACKET protocol family machine # [ 0.749880] 9pnet: Installing 9P2000 support machine # [ 0.756202] Key type dns_resolver registered machine # [ 0.774420] registered taskstats version 1 machine # [ 0.774946] Loading compiled-in X.509 certificates machine # [ 0.796729] Demotion targets for Node 0: null machine # [ 0.797026] Key type .fscrypt registered machine # [ 0.797035] Key type fscrypt-provisioning registered machine # [ 0.797247] ima: No TPM chip found, activating TPM-bypass! machine # [ 0.797274] ima: Allocated hash algorithm: sha1 machine # [ 0.797324] ima: No architecture policies found machine # [ 0.798859] input: gpio-keys as /devices/platform/gpio-keys/input/input0 machine # [ 0.831902] clk: Disabling unused clocks machine # [ 0.831936] PM: genpd: Disabling unused power domains machine # [ 0.837487] Freeing unused kernel memory: 4736K machine # [ 0.837751] Run /init as init process machine # [ 0.880401] systemd[1]: Successfully made /usr/ read-only. machine # [ 0.964937] usb 1-1: new high-speed USB device number 2 using ehci-pci machine # [ 1.117227] 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 machine # [ 1.205496] 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 machine # [ 1.215496] 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) machine # [ 1.215568] systemd[1]: Detected virtualization qemu. machine # [ 1.215644] systemd[1]: Detected architecture arm64. machine # [ 1.215658] systemd[1]: Running in initrd. machine # [ 1.216519] systemd[1]: Initializing machine ID from random generator. machine # [ 1.216937] systemd[1]: Hostname set to . machine # [ 1.324892] usb 1-2: new high-speed USB device number 3 using ehci-pci machine # [ 1.446722] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 1.479186] 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 machine # [ 1.484594] 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 machine # [ 1.539193] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.568585] systemd[1]: Created slice Slice /system/modprobe. machine # [ 1.569038] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 1.569086] systemd[1]: Expecting device /dev/disk/by-label/nixos... machine # [ 1.569122] systemd[1]: Reached target Path Units. machine # [ 1.569144] systemd[1]: Reached target Slice Units. machine # [ 1.569166] systemd[1]: Reached target Swaps. machine # [ 1.569192] systemd[1]: Reached target Timer Units. machine # [ 1.569413] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 1.569632] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 1.569839] systemd[1]: Listening on Journal Sockets. machine # [ 1.570034] systemd[1]: Listening on udev Control Socket. machine # [ 1.570152] systemd[1]: Listening on udev Kernel Socket. machine # [ 1.570177] systemd[1]: Reached target Socket Units. machine # [ 1.572459] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 1.574776] systemd[1]: Starting Load Kernel Module 9pnet_virtio... machine # [ 1.574877] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 1.577245] systemd[1]: Mounting Kernel Configuration File System... machine # [ 1.603456] systemd[1]: Starting Journal Service... machine # [ 1.605748] systemd[1]: Starting Load Kernel Modules... machine # [ 1.605873] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 1.609460] systemd[1]: Starting Coldplug All udev Devices... machine # [ 1.611412] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 1.612575] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. machine # [ 1.614722] systemd[1]: Finished Load Kernel Module 9pnet_virtio. machine # [ 1.615464] systemd[1]: Mounted Kernel Configuration File System. machine # [ 1.617293] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 1.633954] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 1.638419] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 1.654372] systemd-journald[94]: Collecting audit messages is disabled. machine # [ 1.663312] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. machine # [ 1.663795] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev machine # [ 1.671573] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0 machine # [ 1.671898] [drm] features: -virgl +edid -resource_blob -host_visible machine # [ 1.671905] [drm] features: -context_init machine # [ 1.673488] [drm] number of scanouts: 1 machine # [ 1.673512] [drm] number of cap sets: 0 machine # [ 1.677271] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic machine # [ 1.677306] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0 machine # [ 1.680643] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 1.681070] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 1.681106] systemd[1]: Reached target Local File Systems. machine # [ 1.686339] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 1.689830] Console: switching to colour frame buffer device 160x50 machine # [ 1.697909] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device machine # [ 1.710249] systemd[1]: Finished Load Kernel Modules. machine # [ 1.715676] systemd[1]: Starting Apply Kernel Variables... machine # [ 1.734498] systemd[1]: Finished Apply Kernel Variables. machine # [ 1.746309] systemd[1]: Started Journal Service. machine # [ 1.741624] systemd-modules-load[95]: Using 4 probe threads machine # [ 1.745607] systemd-modules-load[95]: Module 'virtio_balloon' is built in machine # [ 1.749331] systemd-modules-load[95]: Module 'virtio_console' is built in machine # [ 1.751099] systemd-modules-load[95]: Module 'virtio_rng' is built in machine # [ 1.752662] systemd-modules-load[95]: Inserted module 'dm_mod' machine # [ 1.754049] systemd-modules-load[95]: Inserted module 'virtio_gpu' machine # [ 1.755499] systemd[1]: Starting Create System Files and Directories... machine # [ 1.757509] systemd-udevd[105]: Using default interface naming scheme 'v261'. machine # [ 1.773700] systemd[1]: Finished Create System Files and Directories. machine # [ 1.782215] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 1.801338] systemd[1]: Starting Virtual Console Setup... machine # [ 1.852857] systemd-vconsole-setup[131]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 1.858064] systemd[1]: Finished Virtual Console Setup. machine # [ 2.285123] systemd[1]: Finished Coldplug All udev Devices. machine # [ 2.287630] systemd[1]: Reached target System Initialization. machine # [ 2.290252] systemd[1]: Reached target Basic System. machine # [ 2.463271] (udev-worker)[135]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 2.469724] (udev-worker)[135]: Network interface NamePolicy= disabled on kernel command line. machine # [ 2.477288] (udev-worker)[138]: Network interface NamePolicy= disabled on kernel command line. machine # [ 2.485410] systemd[1]: Found device /dev/disk/by-label/nixos. machine # [ 2.487499] systemd[1]: Reached target Initrd Root Device. machine # [ 2.492416] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... machine # [ 2.546405] systemd-fsck[153]: nixos: clean, 12/65536 files, 13019/262144 blocks machine # [ 2.553075] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. machine # [ 2.612437] systemd[1]: Mounting /sysroot... machine # [ 2.681156] EXT4-fs (vda): mounted filesystem 11adae6e-999b-4ff0-99c7-12315f938e3e r/w with ordered data mode. Quota mode: none. machine # [ 2.680934] systemd[1]: Mounted /sysroot. machine # [ 2.683060] systemd[1]: Reached target Initrd Root File System. machine # [ 2.687640] systemd[1]: Mounting /sysroot/nix/.ro-store... machine # [ 2.690595] systemd[1]: Mounting /sysroot/run... machine # [ 2.696190] systemd[1]: Mounting /sysroot/tmp/shared... machine # [ 2.708533] systemd[1]: Mounting /sysroot/tmp/xchg... machine # [ 2.711208] systemd[1]: Starting Mountpoints Configured in the Real Root... machine # [ 2.717580] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 2.740421] systemd-sysroot-fstab-check[165]: /sysroot should be mounted in the initrd, will request daemon-reload. machine # [ 2.748493] systemd[1]: Mounted /sysroot/run. machine # [ 2.749572] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 2.750704] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 2.751733] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 2.753314] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 2.754537] systemd[1]: Mounted /sysroot/nix/.ro-store. machine # [ 2.757282] systemd[1]: Reload requested from client PID 165 ('systemd-sysroot') (unit initrd-parse-etc.service)... machine # [ 2.759399] systemd[1]: Reloading... machine # [ 2.853095] systemd[1]: Reloading finished in 95 ms. machine # [ 2.900919] systemd-sysroot-fstab-check[165]: Requesting initrd-fs.target/start/replace... machine # [ 2.904222] systemd-sysroot-fstab-check[165]: Requesting swap.target/start/replace... machine # [ 2.907268] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 2.909490] systemd[1]: initrd-parse-etc.service: Deactivated successfully. machine # [ 2.920610] systemd[1]: Finished Mountpoints Configured in the Real Root. machine # [ 2.922255] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. machine # [ 2.929421] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 2.931398] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 3.056819] (udev-worker)[147]: mtd0ro: Failed to find and pin callout binary "/nix/store/z2nxjmk4666nbka3hgyxlg13prrnvx38-systemd-261/lib/udev/mtd_probe": No such file or directory machine # [ 3.060350] (udev-worker)[147]: 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 machine # [ 3.070523] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 3.071635] systemd[1]: Stopped Virtual Console Setup. machine # [ 3.072495] systemd[1]: Stopping Virtual Console Setup... machine # [ 3.073261] systemd[1]: Starting Virtual Console Setup... machine # [ 3.078154] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 3.079424] systemd[1]: Stopped Virtual Console Setup. machine # [ 3.080861] systemd[1]: Starting Virtual Console Setup... machine # [ 3.116690] systemd-vconsole-setup[194]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 3.119051] systemd[1]: Finished Virtual Console Setup. machine # [ 3.611655] systemd[1]: Mounting /sysroot/nix/store... machine # [ 3.692932] systemd[1]: Mounted /sysroot/nix/store. machine # [ 3.695174] systemd[1]: Reached target Initrd File Systems. machine # [ 3.697657] systemd[1]: Starting Find NixOS closure... machine # [ 3.700480] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 3.740898] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. machine # [ 3.744490] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. machine # [ 3.761620] systemd[1]: Finished Find NixOS closure. machine # [ 3.764004] systemd[1]: Reached target Initrd Default Target. machine # [ 3.766524] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 3.816513] systemd[1]: Stopped target Initrd Default Target. machine # [ 3.819058] systemd[1]: Stopped target Basic System. machine # [ 3.821335] systemd[1]: Stopped target Initrd Root Device. machine # [ 3.823690] systemd[1]: Stopped target Path Units. machine # [ 3.825871] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 3.829077] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 3.832332] systemd[1]: Stopped target Slice Units. machine # [ 3.834477] systemd[1]: Stopped target Socket Units. machine # [ 3.836703] systemd[1]: Stopped target System Initialization. machine # [ 3.839159] systemd[1]: Stopped target Swaps. machine # [ 3.841168] systemd[1]: Stopped target Timer Units. machine # [ 3.843300] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 3.849025] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 3.851443] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. machine # [ 3.856558] systemd[1]: Stopped Find NixOS closure. machine # [ 3.858828] systemd[1]: Starting Load Kernel Module 9pnet_virtio... machine # [ 3.862626] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.864723] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 3.866889] systemd[1]: Stopped Apply Kernel Variables. machine # [ 3.868698] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 3.870838] systemd[1]: Stopped Load Kernel Modules. machine # [ 3.872427] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 3.874629] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 3.876741] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 3.878646] systemd[1]: Stopped Create System Files and Directories. machine # [ 3.880326] systemd[1]: Stopped target Local File Systems. machine # [ 3.881831] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 3.883542] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 3.885306] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 3.886609] systemd[1]: Stopping Rule-based Manager for Device Events and Files... machine # [ 3.888272] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 3.889888] systemd[1]: Stopped Virtual Console Setup. machine # [ 3.891043] systemd[1]: initrd-cleanup.service: Deactivated successfully. machine # [ 3.892506] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. machine # [ 3.893884] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. machine # [ 3.895372] systemd[1]: Finished Load Kernel Module 9pnet_virtio. machine # [ 3.896667] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.898106] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 3.899264] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 3.900602] systemd[1]: Stopped Rule-based Manager for Device Events and Files. machine # [ 3.901989] systemd[1]: systemd-udevd.service: Consumed 2.201s CPU time over 2.201s wall clock time, 30.8M memory peak. machine # [ 3.903891] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. machine # [ 3.905312] systemd[1]: Closed udev Control Socket. machine # [ 3.906262] systemd[1]: Starting Cleanup udev Database... machine # [ 3.907257] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 3.908659] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 3.909772] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 3.911169] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 3.912428] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 3.913678] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 4.003057] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. machine # [ 4.007488] systemd[1]: Finished Cleanup udev Database. machine # [ 4.010854] systemd[1]: Reached target Switch Root. machine # [ 4.013062] systemd[1]: Starting NixOS Activation... machine # [ 4.309201] initrd-nixos-activation-start[221]: booting system configuration /nix/store/6jjral78h0pim0k25ahd9qxi06rwmd23-nixos-system-machine-test machine # [ 4.413519] initrd-nixos-activation-start[221]: running activation script... machine # [ 4.938418] initrd-nixos-activation-start[244]: setting up /etc... machine # [ 5.301720] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. machine # [ 5.305259] systemd[1]: Finished NixOS Activation. machine # [ 5.307377] systemd[1]: Starting Switch Root... machine # [ 5.342127] systemd[1]: Switching root. machine # [ 5.491122] systemd-journald[94]: Received SIGTERM from PID 1 (systemd). machine # [ 6.214719] 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) machine # [ 6.214855] systemd[1]: Detected virtualization qemu. machine # [ 6.214946] systemd[1]: Detected architecture arm64. machine # [ 6.215130] systemd[1]: Detected first boot. machine # [ 6.222276] systemd[1]: Initializing machine ID from random generator. machine # [ 6.489252] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 6.651991] systemd[1]: Applying preset policy. machine # [ 7.157762] systemd[1]: Populated /etc with preset unit settings. machine # [ 7.696752] systemd[1]: initrd-switch-root.service: Deactivated successfully. machine # [ 7.697067] systemd[1]: Stopped initrd-switch-root.service. machine # [ 7.698497] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 7.707126] systemd[1]: Created slice Slice /system/getty. machine # [ 7.711096] systemd[1]: Created slice User and Session Slice. machine # [ 7.711707] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 7.712685] systemd[1]: Started Forward Password Requests to Wall Directory Watch. machine # [ 7.713498] systemd[1]: Expecting device /dev/hvc0... machine # [ 7.714640] systemd[1]: Expecting device /dev/ttyAMA0... machine # [ 7.715778] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 7.716928] systemd[1]: Reached target flakelet contract providers ready. machine # [ 7.718046] systemd[1]: Stopped target initrd-fs.target. machine # [ 7.719147] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 7.720218] systemd[1]: Stopped target initrd-switch-root.target. machine # [ 7.721354] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 7.722517] systemd[1]: Reached target Path Units. machine # [ 7.723609] systemd[1]: Reached target Remote File Systems. machine # [ 7.724670] systemd[1]: Reached target Slice Units. machine # [ 7.725761] systemd[1]: Reached target Swaps. machine # [ 7.731754] systemd[1]: Listening on Query the User Interactively for a Password. machine # [ 7.738826] systemd[1]: Listening on Process Core Dump Socket. machine # [ 7.744465] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 7.750302] systemd[1]: Listening on Factory Reset Management. machine # [ 7.751735] systemd[1]: Listening on Hostname Service Socket. machine # [ 7.763755] systemd[1]: Starting Journal Log Access Socket... machine # [ 7.765601] systemd[1]: Listening on Journal Audit Socket. machine # [ 7.771239] systemd[1]: Listening on Console Output Muting Service Socket. machine # [ 7.772891] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 7.773910] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 7.774828] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 7.786928] systemd[1]: Listening on Disk Repartitioning Service Socket. machine # [ 7.787575] systemd[1]: Listening on udev Control Socket. machine # [ 7.788072] systemd[1]: Listening on udev Varlink Socket. machine # [ 7.797083] systemd[1]: Mounting Huge Pages File System... machine # [ 7.807111] systemd[1]: Mounting POSIX Message Queue File System... machine # [ 7.835096] systemd[1]: Mounting Kernel Debug File System... machine # [ 7.843117] systemd[1]: Mounting Kernel Trace File System... machine # [ 7.850850] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 7.859841] systemd[1]: Starting Load Kernel Module 9pnet_virtio... machine # [ 7.861070] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 7.878909] systemd[1]: Mounting Kernel Configuration File System... machine # [ 7.879599] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm machine # [ 7.880540] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 7.921504] systemd[1]: Starting Load Kernel Module fuse... machine # [ 7.922731] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 7.939506] systemd[1]: Starting Journal Service... machine # [ 7.950130] systemd[1]: Starting Load Kernel Modules... machine # [ 7.973222] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 7.982922] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 7.984026] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 7.995298] systemd[1]: Starting Coldplug All udev Devices... machine # [ 8.004778] systemd[1]: Listening on Journal Log Access Socket. machine # [ 8.006837] systemd[1]: Mounted Huge Pages File System. machine # [ 8.007563] systemd[1]: Mounted POSIX Message Queue File System. machine # [ 8.008318] systemd[1]: Mounted Kernel Debug File System. machine # [ 8.009391] systemd[1]: Mounted Kernel Trace File System. machine # [ 8.010815] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 8.012449] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. machine # [ 8.013736] systemd[1]: Finished Load Kernel Module 9pnet_virtio. machine # [ 8.014866] systemd[1]: Mounted Kernel Configuration File System. machine # [ 8.024676] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 8.058764] systemd[1]: Finished Load Kernel Modules. machine # [ 8.064240] systemd[1]: Starting Firewall... machine # [ 8.065331] fuse: init (API version 7.45) machine # [ 8.075501] systemd[1]: Starting Apply Kernel Variables... machine # [ 8.076581] systemd[1]: modprobe@fuse.service: Deactivated successfully. machine # [ 8.077426] systemd[1]: Finished Load Kernel Module fuse. machine # [ 8.087663] EXT4-fs (vda): re-mounted 11adae6e-999b-4ff0-99c7-12315f938e3e. machine # [ 8.089945] systemd-journald[315]: Collecting audit messages is enabled. machine # [ 8.091306] systemd[1]: Mounting FUSE Control File System... machine # [ 8.098945] systemd[1]: Finished Remount Root and Kernel File Systems. machine # [ 8.100516] systemd[1]: Listening on Disk Image Download Service Socket. machine # [ 8.101854] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 8.113248] systemd[1]: Starting Load/Save OS Random Seed... machine # [ 8.115246] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 8.119404] systemd[1]: Started Journal Service. machine # [ 8.112364] systemd[1]: Queued start job for default target Multi-User System. machine # [ 8.134072] systemd[1]: systemd-journald.service: Deactivated successfully. machine # [ 8.143298] systemd-modules-load[316]: Using 2 probe threads machine # [ 8.151756] systemd-modules-load[316]: Module 'atkbd' is built in machine # [ 8.159751] systemd-modules-load[316]: Module 'loop' is built in machine # [ 8.175378] systemd[1]: Starting Flush Journal to Persistent Storage... machine # [ 8.183882] systemd-oomd[318]: No swap; memory pressure usage will be degraded machine # [ 8.204958] systemd-journald[315]: Received client request to flush runtime journal. machine # [ 8.252902] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 8.257229] systemd[1]: Mounted FUSE Control File System. machine # [ 8.261372] systemd[1]: Finished Apply Kernel Variables. machine # [ 8.264673] systemd[1]: Finished Load/Save OS Random Seed. machine # [ 8.268392] systemd[1]: Reached target First Boot Complete. machine # [ 8.271765] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 8.282609] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 8.285012] systemd[1]: Finished Flush Journal to Persistent Storage. machine # [ 8.298925] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 8.300197] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 8.303587] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 8.387976] systemd-udevd[356]: Using default interface naming scheme 'v261'. machine # [ 8.499822] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 8.702066] systemd[1]: Mounting /run/wrappers... machine # [ 8.751471] systemd[1]: Finished Coldplug All udev Devices. machine # [ 8.787055] systemd[1]: Mounted /run/wrappers. machine # [ 8.789588] systemd[1]: Reached target Local File Systems. machine # [ 8.796175] systemd[1]: Listening on Boot Loader Control Service Socket. machine # [ 8.800581] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 8.808237] systemd[1]: Starting register-nix-paths.service... machine # [ 8.813308] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 8.818275] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 8.829478] systemd[1]: Starting Save Transient machine-id to Disk... machine # [ 8.836420] systemd[1]: Starting Create System Files and Directories... machine # [ 8.900084] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [ 8.907558] systemd[1]: Finished Save Transient machine-id to Disk. machine # [ 8.915452] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 8.953298] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. machine # [ 8.960949] (udev-worker)[421]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 8.965874] (udev-worker)[421]: Network interface NamePolicy= disabled on kernel command line. machine # [ 8.969263] (udev-worker)[416]: Network interface NamePolicy= disabled on kernel command line. machine # [ 8.986546] systemd[1]: Finished Create System Files and Directories. machine # [ 8.994196] systemd[1]: Starting Rebuild Journal Catalog... machine # [ 8.999374] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 9.024103] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 9.028032] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 9.032987] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 9.038494] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 9.045196] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 9.050492] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 9.053476] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 9.059522] systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine # [ 9.109300] mousedev: PS/2 mouse device common for all mice machine # [ 9.106499] systemd[1]: Finished Rebuild Journal Catalog. machine # [ 9.110455] systemd[1]: Starting Update is Completed... machine # [ 9.166336] systemd[1]: Finished Update is Completed. machine # [ 9.403266] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 9.404644] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 9.450135] systemd[1]: Finished Firewall. machine # [ 9.608441] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input3 machine # [ 9.643304] systemd[1]: Finished register-nix-paths.service. machine # [ 9.650626] systemd[1]: Reached target System Initialization. machine # [ 9.651779] systemd[1]: Started Discard unused filesystem blocks once a week. machine # [ 9.653535] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 9.655840] systemd[1]: Reached target Timer Units. machine # [ 9.657931] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 9.659154] systemd[1]: Listening on Nix Daemon Socket. machine # [ 9.659928] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [ 9.663670] systemd[1]: Reached target Socket Units. machine # [ 9.664808] systemd[1]: Reached target Basic System. machine # [ 9.665540] systemd[1]: Started backdoor.service. machine # [ 9.666268] systemd[1]: Starting Re-link flakelet services at boot... machine # [ 9.670419] systemd[1]: Starting Import lastlog data into lastlog2 database... machine # [ 9.683192] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 9.687871] systemd[1]: Starting Post-Boot Actions... machine # [ 9.693960] systemd[1]: Started Reset console on configuration changes. machine # [ 9.700524] systemd[1]: Starting resolvconf update... machine # [ 9.722296] systemd[1]: Starting D-Bus System Message Bus... machine # [ 9.727993] systemd[1]: Starting Virtual Console Setup... machine # [ 9.743803] systemd[1]: Finished Post-Boot Actions. machine # [ 9.749199] systemd[1]: Finished Re-link flakelet services at boot. machine # [ 9.755567] systemd[1]: Starting Reconcile flakelet services with the host configuration... machine # connecting to host... machine # [ 9.779931] systemd[1]: Finished Import lastlog data into lastlog2 database. machine # [ 9.785009] nsncd[563]: Aug 31 07:37:15.589 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 9.793207] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 9.796725] systemd[1]: Reached target Host and Network Name Lookups. machine: Guest shell says: b'Spawning backdoor root shell...\n' machine # [ 9.800531] systemd[1]: Reached target User and Group Name Lookups. machine # [ 9.803939] systemd[1]: Starting User Login Management... machine: connected to guest root shell machine # [ 9.807543] systemd[1]: Finished Reconcile flakelet services with the host configuration. machine: (connecting took 10.29 seconds) machine: (finished: waiting for the VM to finish booting, in 10.79 seconds) machine # [ 9.860452] dbus-broker-launch[568]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 9.880056] systemd-logind[596]: New seat seat0. machine # [ 9.882759] systemd-logind[596]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) machine # [ 9.884123] systemd-logind[596]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) machine # [ 9.885471] systemd-logind[596]: Watching system buttons on /dev/input/event0 (gpio-keys) machine # [ 9.929269] systemd[1]: Started User Login Management. machine # [ 9.932373] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 9.935222] systemd[1]: Stopping Host and Network Name Lookups... machine # [ 9.940336] dbus-broker-launch[568]: NSS returned no entry for 'systemd-timesync' machine # [ 9.941700] dbus-broker-launch[568]: Invalid user-name in /nix/store/az79avzxcb95szkcyjmsj32zwdqxmm7i-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 9.944681] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 9.945758] systemd[1]: Stopping User and Group Name Lookups... machine # [ 9.947264] systemd[1]: Starting linger-users.service... machine # [ 9.948810] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 9.950357] systemd[1]: nscd.service: Deactivated successfully. machine # [ 9.951780] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [ 9.967581] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 9.974964] systemd[1]: Started D-Bus System Message Bus. machine # [ 10.001343] dbus-broker-launch[568]: Ready machine # [ 10.003967] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 10.005884] systemd[1]: Finished linger-users.service. machine # [ 10.009393] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 10.011397] nsncd[655]: Aug 31 07:37:15.815 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 10.014218] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 10.015223] systemd[1]: Reached target User and Group Name Lookups. machine # [ 10.026193] systemd[1]: Finished resolvconf update. machine # [ 10.028107] systemd[1]: Reached target Preparation for Network. machine # [ 10.033058] systemd[1]: Starting DHCP Client... machine # [ 10.037302] systemd[1]: Starting Address configuration of eth1... machine # [ 10.041735] systemd[1]: Starting Extra networking commands.... machine # [ 10.128557] network-addresses-eth1-start[678]: adding address 192.168.1.1/24... done machine # [ 10.140624] network-addresses-eth1-start[678]: adding address 2001:db8:1::1/64... done machine # [ 10.157425] systemd[1]: Finished Address configuration of eth1. machine # [ 10.171400] dhcpcd[686]: dhcpcd-10.3.2 starting machine # [ 10.182046] dhcpcd[731]: dev: loaded udev machine # [ 10.207926] systemd[1]: Finished Extra networking commands.. machine # [ 10.210550] systemd[1]: Reached target Network. machine # [ 10.212589] systemd[1]: Starting Permit User Sessions...[ 10.217500] 8021q: 802.1Q VLAN Support v1.8 machine # machine # [ 10.217924] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 10.219216] systemd[1]: Starting Update flakelet service static... machine # [ 10.223284] systemd[1]: Starting Update flakelet service web... machine # [ 10.247316] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 10.251238] systemd-vconsole-setup[569]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 10.255588] systemd[1]: Finished Virtual Console Setup. machine # [ 10.264176] systemd[1]: Finished Permit User Sessions. machine # [ 10.269299] systemd[1]: Started Getty on tty1. machine # [ 10.272042] flakelet[748]: web: resolving path:/nix/store/1ndj6dy6hwr8inncmsdbwhm9pd6vbdvp-flake.nix machine # [ 10.274961] flakelet[747]: static: using prebuilt artifact /nix/store/i681mnikp0zi79fghryxjffl3amkxnhn-flakelet-static machine # [ 10.278518] systemd[1]: Reached target Login Prompts. machine # [ 10.281499] flakelet[747]: static: activating generation 1 machine # [ 10.290989] cfg80211: Loading compiled-in X.509 certificates for regulatory database machine # [ 10.294629] systemd[1]: Reload requested from client PID 753 ('systemctl') (unit flakelet-static.service)... machine # [ 10.296924] systemd[1]: Reloading... machine # [ 10.322284] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' machine # [ 10.322804] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' machine # [ 10.325632] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 machine # [ 10.325976] cfg80211: failed to load regulatory.db machine # [ 10.401205] 8021q: adding VLAN 0 to HW filter on device eth0 machine # [ 10.397381] dhcpcd[731]: eth0: waiting for carrier machine # [ 10.399162] dhcpcd[731]: eth0: carrier acquired machine # [ 10.410877] dhcpcd[731]: DUID 00:01:00:01:32:27:eb:ac:52:54:00:12:34:56 machine # [ 10.412167] dhcpcd[731]: eth0: IAID 00:12:34:56 machine # [ 10.412953] dhcpcd[731]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 10.859803] systemd[1]: Reloading finished in 561 ms. machine # [ 10.931664] systemd[1]: Started Nix Daemon. machine # [ 10.991328] systemd[1]: Reload requested from client PID 807 ('systemctl') (unit flakelet-static.service)... machine # [ 10.999440] systemd[1]: Reloading... machine # [ 11.641122] systemd[1]: Reloading finished in 647 ms. machine # [ 11.724295] dhcpcd[731]: eth0: soliciting a DHCP lease machine # [ 11.736985] dhcpcd[731]: eth0: offered 10.0.2.15 from 10.0.2.2 machine # [ 11.752583] dhcpcd[731]: eth0: probing address 10.0.2.15/24 machine # [ 11.844931] nix-daemon[804]: accepted connection from pid 752, user flakelet machine # [ 11.869093] systemd[1]: Created slice Slice /system/static-echo. machine # [ 11.872634] systemd[1]: Listening on static-echo@1.socket. machine # [ 11.875723] systemd[1]: Listening on static-echo@2.socket. machine # [ 11.880682] systemd[1]: Starting prebuilt flakelet service static... machine # [ 11.932651] systemd[1]: Started prebuilt flakelet service static. machine # [ 12.140415] flakelet[748]: web: evaluating /nix/store/5021f2kwgs9vhdrqlvahpgzg3fc0adgq-flakelet-driver.nix machine # [ 12.317912] nix-daemon[804]: accepted connection from pid 874, user flakelet machine # [ 12.485235] flakelet[747]: static: updated to generation 1 machine # [ 12.488690] systemd[1]: Finished Update flakelet service static. machine # [ 13.250398] dhcpcd[731]: eth0: soliciting an IPv6 router machine # [ 13.250708] dhcpcd[731]: eth0: Router Advertisement from fe80::2 machine # [ 13.250840] dhcpcd[731]: eth0: adding address fec0::5054:ff:fe12:3456/64 machine # [ 13.250965] dhcpcd[731]: eth0: adding route to fec0::/64 machine # [ 13.251162] dhcpcd[731]: eth0: adding default route via fe80::2 machine # [ 16.353151] dhcpcd[731]: eth0: leased 10.0.2.15 for 86400 seconds machine # [ 16.353449] dhcpcd[731]: eth0: adding route to 10.0.2.0/24 machine # [ 16.353581] dhcpcd[731]: eth0: adding default route via 10.0.2.2 machine # [ 16.544233] systemd[1]: Started DHCP Client. machine # [ 20.630659] flakelet[748]: web: building /nix/store/j25ylrbpc0fh4gm9irhnxqx0mrzicswr-flakelet-web.drv machine # [ 22.011174] nix-daemon[804]: accepted connection from pid 1125, user flakelet machine # [ 22.045423] flakelet[748]: web: activating generation 1 machine # [ 22.059272] systemd[1]: Reload requested from client PID 1138 ('systemctl') (unit flakelet-web.service)... machine # [ 22.064386] systemd[1]: Reloading... machine # [ 22.705620] systemd[1]: Reloading finished in 644 ms. machine # [ 22.802502] systemd[1]: Reload requested from client PID 1173 ('systemctl') (unit flakelet-web.service)... machine # [ 22.807810] systemd[1]: Reloading... machine # [ 23.440544] systemd[1]: Reloading finished in 635 ms. machine # [ 23.623436] systemd[1]: Starting flakelet test service... machine # [ 23.673203] systemd[1]: Started flakelet test service. machine # [ 23.844497] flakelet[748]: web: updated to generation 1 machine # [ 23.847087] systemd[1]: Finished Update flakelet service web. machine # [ 23.849544] systemd[1]: Reached target flakelet managed services. machine # [ 23.852140] systemd[1]: Reached target Multi-User System. machine # [ 23.854381] systemd[1]: Startup finished in 844ms (kernel) + 4.795s (initrd) + 18.207s (userspace) = 23.848s. machine: (finished: waiting for unit multi-user.target, in 25.73 seconds) machine: must succeed: systemctl start flakelet-web.service machine: (finished: must succeed: systemctl start flakelet-web.service, in 0.07 seconds) machine: must succeed: systemctl is-active web.service machine: (finished: must succeed: systemctl is-active web.service, in 0.04 seconds) machine: must succeed: systemctl show web.service -p Environment | grep -q GREETING=hello machine: (finished: must succeed: systemctl show web.service -p Environment | grep -q GREETING=hello, in 0.05 seconds) machine: must succeed: test -f /nix/var/nix/gcroots/flakelet/web/gen-1/manifest.json machine: (finished: must succeed: test -f /nix/var/nix/gcroots/flakelet/web/gen-1/manifest.json, in 0.03 seconds) machine: must succeed: flakelet status | grep -q '^web' machine: (finished: must succeed: flakelet status | grep -q '^web', in 0.67 seconds) machine: must succeed: grep -q '"port": 8080' /run/flakelet/exports/web.json machine: (finished: must succeed: grep -q '"port": 8080' /run/flakelet/exports/web.json, in 0.04 seconds) machine: must succeed: systemctl start flakelet-static.service machine: (finished: must succeed: systemctl start flakelet-static.service, in 0.06 seconds) machine: must succeed: systemctl is-active static.service machine: (finished: must succeed: systemctl is-active static.service, in 0.03 seconds) machine: must succeed: systemctl is-active static-echo@1.socket static-echo@2.socket machine: (finished: must succeed: systemctl is-active static-echo@1.socket static-echo@2.socket, in 0.04 seconds) machine: must succeed: /nix/store/2r7kl4a7jbdbs2nxz9whzp7hh5zc324l-socat-1.8.1.3/bin/socat -u /dev/null UNIX-CONNECT:/run/static-echo/2.sock machine: (finished: must succeed: /nix/store/2r7kl4a7jbdbs2nxz9whzp7hh5zc324l-socat-1.8.1.3/bin/socat -u /dev/null UNIX-CONNECT:/run/static-echo/2.sock, in 0.05 seconds) machine: waiting for success: systemctl is-active static-echo@2.service machine # [ 25.908184] systemd[1]: Starting static-echo@2.service... machine # [ 25.969362] systemd[1]: Started static-echo@2.service. machine: (finished: waiting for success: systemctl is-active static-echo@2.service, in 1.11 seconds) machine: must succeed: flakelet activate cli /nix/store/h9fyr3a28yhqhfdm2ydikjjamk7khzcw-flakelet-cli machine # cli: using prebuilt artifact /nix/store/h9fyr3a28yhqhfdm2ydikjjamk7khzcw-flakelet-cli machine # cli: activating generation 1 machine # [ 27.107074] systemd[1]: Reload requested from client PID 1284 ('systemctl') (unit backdoor.service)... machine # [ 27.112238] systemd[1]: Reloading... machine # [ 27.729532] systemd[1]: Reloading finished in 620 ms. machine # [ 27.855552] systemd[1]: Reload requested from client PID 1322 ('systemctl') (unit backdoor.service)... machine # [ 27.860677] systemd[1]: Reloading... machine # [ 28.437202] systemd[1]: Reloading finished in 579 ms. machine # [ 28.516322] systemd[1]: Created slice Slice /system/cli-echo. machine # [ 28.519459] systemd[1]: Listening on cli-echo@1.socket. machine # [ 28.522916] systemd[1]: Listening on cli-echo@2.socket. machine # [ 28.532189] systemd[1]: Starting prebuilt flakelet service cli... machine # [ 28.580179] systemd[1]: Started prebuilt flakelet service cli. machine: (finished: must succeed: flakelet activate cli /nix/store/h9fyr3a28yhqhfdm2ydikjjamk7khzcw-flakelet-cli, in 2.11 seconds) machine: must succeed: systemctl is-active cli.service machine: (finished: must succeed: systemctl is-active cli.service, in 0.03 seconds) machine: must succeed: flakelet status --json | grep -q 'prebuilt:cli' machine: (finished: must succeed: flakelet status --json | grep -q 'prebuilt:cli', in 0.86 seconds) machine: must fail: flakelet activate cli /nix/store/5rlafdbdfvmf0jiv0mp6xdaxf9cpyhs2-flakelet-cli-broken machine # cli: using prebuilt artifact /nix/store/5rlafdbdfvmf0jiv0mp6xdaxf9cpyhs2-flakelet-cli-broken machine # cli: activating generation 2 machine # [ 30.180945] systemd[1]: cli-echo@1.socket: Deactivated successfully. machine # [ 30.184769] systemd[1]: Closed cli-echo@1.socket. machine # [ 30.189785] systemd[1]: cli-echo@2.socket: Deactivated successfully. machine # [ 30.192596] systemd[1]: Closed cli-echo@2.socket. machine # [ 30.201797] systemd[1]: Stopping prebuilt flakelet service cli... machine # [ 30.205799] systemd[1]: cli.service: Deactivated successfully. machine # [ 30.209772] systemd[1]: Stopped prebuilt flakelet service cli. machine # [ 30.364453] systemd[1]: Reload requested from client PID 1391 ('systemctl') (unit backdoor.service)... machine # [ 30.368980] systemd[1]: Reloading... machine # [ 31.018672] systemd[1]: Reloading finished in 646 ms. machine # [ 31.156810] systemd[1]: Reload requested from client PID 1427 ('systemctl') (unit backdoor.service)... machine # [ 31.161873] systemd[1]: Reloading... machine # [ 31.799210] systemd[1]: Reloading finished in 638 ms. machine # [ 31.878637] systemd[1]: Reload requested from client PID 1462 ('systemctl') (unit backdoor.service)... machine # [ 31.883986] systemd[1]: Reloading... machine # [ 32.521548] systemd[1]: Reloading finished in 639 ms. machine # [ 32.618426] systemd[1]: Reload requested from client PID 1498 ('systemctl') (unit backdoor.service)... machine # [ 32.623537] systemd[1]: Reloading... machine # [ 33.004790] 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 machine # [ 33.231256] systemd[1]: Reloading finished in 610 ms. machine # [ 33.322204] systemd[1]: Starting cli.service... machine # [ 33.361133] (nonexistent)[1535]: cli.service: Unable to locate executable '/nonexistent': No such file or directory machine # [ 33.368319] (nonexistent)[1535]: cli.service: Failed at step EXEC spawning /nonexistent: No such file or directory machine # [ 33.372963] systemd[1]: cli.service: Main process exited, code=exited, status=203/EXEC machine # [ 33.376685] systemd[1]: cli.service: Failed with result 'exit-code'. machine # [ 33.381035] systemd[1]: Failed to start cli.service. machine # [ 33.474911] systemd[1]: Reload requested from client PID 1541 ('systemctl') (unit backdoor.service)... machine # [ 33.480081] systemd[1]: Reloading... machine # [ 34.145866] systemd[1]: Reloading finished in 667 ms. machine # [ 34.234576] systemd[1]: Reload requested from client PID 1577 ('systemctl') (unit backdoor.service)... machine # [ 34.237381] systemd[1]: Reloading... machine # [ 34.862176] systemd[1]: Reloading finished in 624 ms. machine # [ 34.947637] systemd[1]: Reload requested from client PID 1612 ('systemctl') (unit backdoor.service)... machine # [ 34.952812] systemd[1]: Reloading... machine # [ 35.578459] systemd[1]: Reloading finished in 628 ms. machine # [ 35.770091] systemd[1]: Reload requested from client PID 1650 ('systemctl') (unit backdoor.service)... machine # [ 35.775372] systemd[1]: Reloading... machine # [ 36.470698] systemd[1]: Reloading finished in 697 ms. machine # [ 36.599161] systemd[1]: Listening on cli-echo@1.socket. machine # [ 36.613437] systemd[1]: Listening on cli-echo@2.socket. machine # [ 36.631096] systemd[1]: Starting prebuilt flakelet service cli... machine # [ 36.702357] systemd[1]: Started prebuilt flakelet service cli. machine: (finished: must fail: flakelet activate cli /nix/store/5rlafdbdfvmf0jiv0mp6xdaxf9cpyhs2-flakelet-cli-broken, in 6.69 seconds) machine: must succeed: systemctl is-active cli.service machine: (finished: must succeed: systemctl is-active cli.service, in 0.05 seconds) machine: must succeed: test "$(ls /nix/var/nix/gcroots/flakelet/cli)" = gen-1 machine: (finished: must succeed: test "$(ls /nix/var/nix/gcroots/flakelet/cli)" = gen-1, in 0.05 seconds) machine: must fail: flakelet activate cli /nix/store/5rlafdbdfvmf0jiv0mp6xdaxf9cpyhs2-flakelet-cli-broken machine # cli: using prebuilt artifact /nix/store/5rlafdbdfvmf0jiv0mp6xdaxf9cpyhs2-flakelet-cli-broken machine: (finished: must fail: flakelet activate cli /nix/store/5rlafdbdfvmf0jiv0mp6xdaxf9cpyhs2-flakelet-cli-broken, in 0.06 seconds) machine: must succeed: /nix/store/2r7kl4a7jbdbs2nxz9whzp7hh5zc324l-socat-1.8.1.3/bin/socat -u /dev/null UNIX-CONNECT:/run/cli-echo/1.sock machine: (finished: must succeed: /nix/store/2r7kl4a7jbdbs2nxz9whzp7hh5zc324l-socat-1.8.1.3/bin/socat -u /dev/null UNIX-CONNECT:/run/cli-echo/1.sock, in 0.04 seconds) machine: waiting for success: systemctl is-active cli-echo@1.service machine # [ 36.911429] systemd[1]: Starting cli-echo@1.service... machine # [ 36.952767] systemd[1]: Started cli-echo@1.service. machine: (finished: waiting for success: systemctl is-active cli-echo@1.service, in 0.06 seconds) machine: must succeed: systemctl show -P MainPID cli-echo@1.service machine: (finished: must succeed: systemctl show -P MainPID cli-echo@1.service, in 0.16 seconds) machine: must succeed: systemctl show -P MainPID cli.service machine: (finished: must succeed: systemctl show -P MainPID cli.service, in 0.10 seconds) machine: must succeed: flakelet activate cli /nix/store/y2bbmw13rkrasic4x7af0c106l26dsnd-flakelet-cli2 | grep -q 'generation 2' machine # cli: using prebuilt artifact /nix/store/y2bbmw13rkrasic4x7af0c106l26dsnd-flakelet-cli2 machine # cli: activating generation 2 machine # [ 37.309089] systemd[1]: Stopping prebuilt flakelet service cli... machine # [ 37.312749] systemd[1]: cli.service: Deactivated successfully. machine # [ 37.315713] systemd[1]: Stopped prebuilt flakelet service cli. machine # [ 37.362290] systemd[1]: Reload requested from client PID 1724 ('systemctl') (unit backdoor.service)... machine # [ 37.367340] systemd[1]: Reloading... machine # [ 38.018080] systemd[1]: Reloading finished in 651 ms. machine # [ 38.110234] systemd[1]: Reload requested from client PID 1761 ('systemctl') (unit backdoor.service)... machine # [ 38.115401] systemd[1]: Reloading... machine # [ 38.744072] systemd[1]: Reloading finished in 631 ms. machine # [ 38.887360] systemd[1]: Reload requested from client PID 1797 ('systemctl') (unit backdoor.service)... machine # [ 38.892815] systemd[1]: Reloading... machine # [ 39.566020] systemd[1]: Reloading finished in 674 ms. machine # [ 39.736159] systemd[1]: Reload requested from client PID 1836 ('systemctl') (unit backdoor.service)... machine # [ 39.741428] systemd[1]: Reloading... machine # [ 40.351354] systemd[1]: Reloading finished in 613 ms. machine # [ 40.458444] systemd[1]: Starting prebuilt flakelet service cli... machine # [ 40.498136] systemd[1]: Started prebuilt flakelet service cli. machine: (finished: must succeed: flakelet activate cli /nix/store/y2bbmw13rkrasic4x7af0c106l26dsnd-flakelet-cli2 | grep -q 'generation 2', in 3.77 seconds) machine: must succeed: systemctl show -P MainPID cli-echo@1.service machine: (finished: must succeed: systemctl show -P MainPID cli-echo@1.service, in 0.05 seconds) machine: must succeed: systemctl show -P MainPID cli.service machine: (finished: must succeed: systemctl show -P MainPID cli.service, in 0.04 seconds) machine: must succeed: flakelet rollback cli | grep -q 'generation 1' machine # [ 41.160673] systemd[1]: Stopping prebuilt flakelet service cli... machine # [ 41.165931] systemd[1]: cli.service: Deactivated successfully. machine # [ 41.168686] systemd[1]: Stopped prebuilt flakelet service cli. machine # [ 41.217858] systemd[1]: Reload requested from client PID 1895 ('systemctl') (unit backdoor.service)... machine # [ 41.222951] systemd[1]: Reloading... machine # [ 41.917881] systemd[1]: Reloading finished in 696 ms. machine # [ 42.032574] systemd[1]: Reload requested from client PID 1932 ('systemctl') (unit backdoor.service)... machine # [ 42.037709] systemd[1]: Reloading... machine # [ 42.646473] systemd[1]: Reloading finished in 610 ms. machine # [ 42.721302] systemd[1]: Reload requested from client PID 1968 ('systemctl') (unit backdoor.service)... machine # [ 42.726506] systemd[1]: Reloading... machine # [ 43.342426] systemd[1]: Reloading finished in 619 ms. machine # [ 43.486080] systemd[1]: Reload requested from client PID 2007 ('systemctl') (unit backdoor.service)... machine # [ 43.491317] systemd[1]: Reloading... machine # [ 44.100607] systemd[1]: Reloading finished in 611 ms. machine # [ 44.243827] systemd[1]: Starting prebuilt flakelet service cli... machine # [ 44.293914] systemd[1]: Started prebuilt flakelet service cli. machine: (finished: must succeed: flakelet rollback cli | grep -q 'generation 1', in 3.22 seconds) machine: must succeed: systemctl is-active cli.service machine: (finished: must succeed: systemctl is-active cli.service, in 0.04 seconds) machine: must succeed: flakelet lock cli | grep -q 'prebuilt:cli' machine: (finished: must succeed: flakelet lock cli | grep -q 'prebuilt:cli', in 0.05 seconds) machine: must succeed: flakelet unlock cli machine: (finished: must succeed: flakelet unlock cli, in 0.05 seconds) machine: must succeed: touch /tmp/failjob machine: (finished: must succeed: touch /tmp/failjob, in 0.04 seconds) machine: must fail: systemctl start web-job.service machine # [ 44.529327] systemd[1]: Starting web-job.service... machine # [ 44.596446] systemd[1]: web-job.service: Main process exited, code=exited, status=1/FAILURE machine # [ 44.599974] systemd[1]: web-job.service: Failed with result 'exit-code'. machine # Job for web-job.service failed because the control process exited with error code. machine # [ 44.603235] systemd[1]: Failed to start web-job.service. machine # See "systemctl status web-job.service" and "journalctl -xeu web-job.service" for details. machine: (finished: must fail: systemctl start web-job.service, in 0.14 seconds) machine: must succeed: systemctl is-failed web-job.service && rm /tmp/failjob machine: (finished: must succeed: systemctl is-failed web-job.service && rm /tmp/failjob, in 0.06 seconds) machine: must succeed: flakelet update web --force --no-refresh | grep -q 'updated to generation' machine # web: resolving path:/nix/store/1ndj6dy6hwr8inncmsdbwhm9pd6vbdvp-flake.nix machine # [ 44.852529] nix-daemon[804]: accepted connection from pid 2078, user flakelet machine # web: evaluating /nix/store/5021f2kwgs9vhdrqlvahpgzg3fc0adgq-flakelet-driver.nix machine # [ 45.116348] nix-daemon[804]: accepted connection from pid 2098, user flakelet machine # web: building /nix/store/j25ylrbpc0fh4gm9irhnxqx0mrzicswr-flakelet-web.drv machine # [ 49.891775] nix-daemon[804]: accepted connection from pid 2107, user flakelet machine # web: activating generation 2 machine # [ 50.122646] systemd[1]: Stopping flakelet test service... machine # [ 50.126745] systemd[1]: web.service: Deactivated successfully. machine # [ 50.129320] systemd[1]: Stopped flakelet test service. machine # [ 50.197642] systemd[1]: Reload requested from client PID 2120 ('systemctl') (unit backdoor.service)... machine # [ 50.202779] systemd[1]: Reloading... machine # [ 50.857894] systemd[1]: Reloading finished in 656 ms. machine # [ 50.948287] systemd[1]: Reload requested from client PID 2157 ('systemctl') (unit backdoor.service)... machine # [ 50.953351] systemd[1]: Reloading... machine # [ 51.604327] systemd[1]: Reloading finished in 653 ms. machine # [ 51.681838] systemd[1]: Reload requested from client PID 2193 ('systemctl') (unit backdoor.service)... machine # [ 51.687136] systemd[1]: Reloading... machine # [ 52.348781] systemd[1]: Reloading finished in 664 ms. machine # [ 52.440810] systemd[1]: Reload requested from client PID 2230 ('systemctl') (unit backdoor.service)... machine # [ 52.445948] systemd[1]: Reloading... machine # [ 53.112932] systemd[1]: Reloading finished in 669 ms. machine # [ 53.214058] systemd[1]: Starting flakelet test service... machine # [ 53.270021] systemd[1]: Started flakelet test service. machine: (finished: must succeed: flakelet update web --force --no-refresh | grep -q 'updated to generation', in 8.75 seconds) machine: must succeed: flakelet reconcile machine: (finished: must succeed: flakelet reconcile, in 0.05 seconds) machine: must succeed: systemctl is-active web.service static.service cli.service machine: (finished: must succeed: systemctl is-active web.service static.service cli.service, in 0.04 seconds) machine: must succeed: flakelet check --build --no-refresh --gc-roots-dir /tmp/roots | grep -q '^web: built /nix/store/' machine # [ 53.677195] nix-daemon[804]: accepted connection from pid 2281, user flakelet machine # [ 53.937733] nix-daemon[804]: accepted connection from pid 2301, user flakelet machine: (finished: must succeed: flakelet check --build --no-refresh --gc-roots-dir /tmp/roots | grep -q '^web: built /nix/store/', in 5.05 seconds) machine: must succeed: test -L /tmp/roots/web machine: (finished: must succeed: test -L /tmp/roots/web, in 0.03 seconds) machine: must succeed: flakelet build web --no-refresh --out-link /tmp/out && test -L /tmp/out/web machine # [ 58.740449] nix-daemon[804]: accepted connection from pid 2317, user flakelet machine # [ 58.979553] nix-daemon[804]: accepted connection from pid 2337, user flakelet machine: (finished: must succeed: flakelet build web --no-refresh --out-link /tmp/out && test -L /tmp/out/web, in 4.99 seconds) machine: must fail: flakelet check nosuchservice --no-refresh machine # error: service 'nosuchservice' is not configured machine: (finished: must fail: flakelet check nosuchservice --no-refresh, in 0.05 seconds) machine: must succeed: rm /run/systemd/system/web.service machine: (finished: must succeed: rm /run/systemd/system/web.service, in 0.04 seconds) machine: must succeed: flakelet boot machine # [ 63.749851] systemd[1]: Reload requested from client PID 2355 ('systemctl') (unit backdoor.service)... machine # [ 63.753906] systemd[1]: Reloading... machine # [ 64.450375] systemd[1]: Reloading finished in 693 ms. machine # [ 64.595760] systemd[1]: Reload requested from client PID 2395 ('systemctl') (unit backdoor.service)... machine # [ 64.600519] systemd[1]: Reloading... machine # [ 65.231625] systemd[1]: Reloading finished in 627 ms. machine # [ 65.327977] systemd[1]: Reload requested from client PID 2434 ('systemctl') (unit backdoor.service)... machine # [ 65.333026] systemd[1]: Reloading... machine # [ 65.948175] systemd[1]: Reloading finished in 618 ms. machine # [ 66.101719] systemd[1]: Reload requested from client PID 2474 ('systemctl') (unit backdoor.service)... machine # [ 66.106321] systemd[1]: Reloading... machine # [ 66.751513] systemd[1]: Reloading finished in 642 ms. machine # [ 66.852895] systemd[1]: Reload requested from client PID 2513 ('systemctl') (unit backdoor.service)... machine # [ 66.856243] systemd[1]: Reloading... machine # [ 67.455505] systemd[1]: Reloading finished in 597 ms. machine # [ 67.549208] systemd[1]: Reload requested from client PID 2551 ('systemctl') (unit backdoor.service)... machine # [ 67.553018] systemd[1]: Reloading... machine # [ 68.249176] systemd[1]: Reloading finished in 693 ms. machine: (finished: must succeed: flakelet boot, in 4.68 seconds) machine: must succeed: test -L /run/systemd/system/web.service machine: (finished: must succeed: test -L /run/systemd/system/web.service, in 0.03 seconds) machine: waiting for the VM to power off additionally exposed symbols: machine, vlan1, 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 Aug 31 07:37:16 machine systemd[1]: Starting Update flakelet service web... Aug 31 07:37:16 machine flakelet[748]: web: resolving path:/nix/store/1ndj6dy6hwr8inncmsdbwhm9pd6vbdvp-flake.nix Aug 31 07:37:17 machine flakelet[748]: web: evaluating /nix/store/5021f2kwgs9vhdrqlvahpgzg3fc0adgq-flakelet-driver.nix Aug 31 07:37:26 machine flakelet[748]: web: building /nix/store/j25ylrbpc0fh4gm9irhnxqx0mrzicswr-flakelet-web.drv Aug 31 07:37:27 machine flakelet[748]: web: activating generation 1 Aug 31 07:37:29 machine flakelet[748]: web: updated to generation 1 Aug 31 07:37:29 machine systemd[1]: Finished Update flakelet service web. machine # [ 68.416530] systemd-logind[596]: poweroff requested from client PID 2593 ('poweroff') (unit backdoor.service)... machine # [ 68.421492] systemd-logind[596]: The system will power off now! machine # [ 68.428810] systemd-logind[596]: System is powering down. machine # [ 68.455023] systemd[1]: Removed slice Slice /system/modprobe. machine # [ 68.458023] systemd[1]: Stopped target Multi-User System. machine # [ 68.460428] systemd[1]: Stopped target flakelet managed services. machine # [ 68.463503] systemd[1]: Stopped target Login Prompts. machine # [ 68.468558] systemd[1]: Stopped target Virtual Machines and Containers. machine # [ 68.473585] dhcpcd[731]: received SIGTERM, stopping machine # [ 68.477693] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 68.482215] dhcpcd[731]: eth0: removing interface machine # [ 68.484471] systemd[1]: Stopped target Timer Units. machine # [ 68.486981] dhcpcd[731]: eth0: deleting address fec0::5054:ff:fe12:3456/64 machine # [ 68.490883] systemd[1]: fstrim.timer: Deactivated successfully. machine # [ 68.493900] dhcpcd[731]: eth0: deleting route to fec0::/64 machine # [ 68.497012] systemd[1]: Stopped Discard unused filesystem blocks once a week. machine # [ 68.504947] dhcpcd[731]: eth0: deleting default route via fe80::2 machine # [ 68.512594] systemd[1]: systemd-tmpfiles-clean.timer: Deactivated successfully. machine # [ 68.520940] systemd[1]: Stopped Daily Cleanup of Temporary Directories. machine # [ 68.527135] systemd[1]: systemd-rfkill.socket: Deactivated successfully. machine # [ 68.537175] systemd[1]: Closed Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 68.544806] systemd[1]: Mounting /run/initramfs... machine # [ 68.550887] systemd[1]: Stopping backdoor.service... machine # [ 68.554788] systemd[1]: Stopping cli-echo@1.service... machine # [ 68.561164] systemd[1]: Stopping prebuilt flakelet service cli... machine # [ 68.569529] systemd[1]: Stopping DHCP Client... machine # [ 68.575425] systemd[1]: Stopping Getty on tty1... machine # [ 68.580273] systemd[1]: lastlog2-import.service: Deactivated successfully. machine # [ 68.586474] network-addresses-eth1-pre-stop[2597]: deleting address 192.168.1.1/24... done machine # [ 68.593826] dhcpcd[731]: eth0: deleting address fe80::5054:ff:fe12:3456 machine # [ 68.598834] systemd[1]: Stopped Import lastlog data into lastlog2 database. machine # [ 68.604861] network-addresses-eth1-pre-stop[2597]: deleting address 2001:db8:1::1/64... done machine # [ 68.609829] dhcpcd[731]: eth0: deleting route to 10.0.2.0/24 machine # [ 68.615666] systemd[1]: Stopping Address configuration of eth1... machine # [ 68.619984] dhcpcd[731]: eth0: deleting default route via 10.0.2.2 machine # [ 68.622877] systemd[1]: Stopping Nix Daemon... machine # [ 68.625272] dhcpcd[731]: dhcpcd exited machine # [ 68.627304] systemd[1]: Stopping Post-Boot Actions... machine # [ 68.629714] systemd[1]: reload-systemd-vconsole-setup.service: Deactivated successfully. machine # [ 68.633672] systemd[1]: Stopped Reset console on configuration changes. machine # [ 68.637919] systemd[1]: Stopping static-echo@2.service... machine # [ 68.645878] systemd[1]: Stopping prebuilt flakelet service static... machine # [ 68.650801] systemd[1]: Stopping User Login Management... machine # [ 68.654303] systemd[1]: systemd-machine-id-commit.service: Deactivated successfully. machine # [ 68.658803] systemd[1]: Stopped Save Transient machine-id to Disk. machine # [ 68.661734] systemd[1]: Stopped target First Boot Complete. machine # [ 68.664139] systemd[1]: Stopping Userspace Out-Of-Memory (OOM) Killer... machine # [ 68.666856] systemd[1]: Stopping Load/Save OS Random Seed... machine # [ 68.669293] systemd[1]: Stopping flakelet test service... machine # [ 68.672218] systemd[1]: flakelet-static.service: Deactivated successfully. machine # [ 68.675492] systemd[1]: Stopped Update flakelet service static. machine # [ 68.678149] systemd[1]: flakelet-web.service: Deactivated successfully. machine # [ 68.680694] systemd[1]: Stopped Update flakelet service web. machine # [ 68.682784] systemd[1]: flakelet-web.service: Consumed 4.191s CPU time over 58.304s wall clock time, 125.7M memory peak, 4K written to disk. machine # [ 68.687051] systemd[1]: Stopped target flakelet contract providers ready. machine # [ 68.689360] systemd[1]: flakelet-reconcile.service: Deactivated successfully. machine # [ 68.693171] systemd[1]: Stopped Reconcile flakelet services with the host configuration. machine # [ 68.696813] systemd[1]: flakelet-boot.service: Deactivated successfully. machine # [ 68.700975] systemd[1]: Stopped Re-link flakelet services at boot. machine # [ 68.703009] systemd[1]: systemd-oomd.service: Deactivated successfully. machine # [ 68.706022] systemd[1]: Stopped Userspace Out-Of-Memory (OOM) Killer. machine # [ 68.709606] systemd[1]: backdoor.service: Deactivated successfully. machine # [ 68.713756] systemd[1]: Stopped backdoor.service. machine # [ 68.715957] systemd[1]: backdoor.service: Consumed 9.316s CPU time over 58.900s wall clock time, 120.1M memory peak, 104K written to disk. machine # [ 68.725182] systemd[1]: systemd-logind.service: Deactivated successfully. machine # [ 68.732463] systemd[1]: Stopped User Login Management. machine # [ 68.736467] make-initrd-ng[2628]: /etc/initrd-release -> /nix/store/94m2cr9q6r1gdr1df0sz9ayq29mj68kz-etc-os-release machine # [ 68.743798] make-initrd-ng[2628]: /etc/os-release -> /nix/store/94m2cr9q6r1gdr1df0sz9ayq29mj68kz-etc-os-release machine # [ 68.751069] make-initrd-ng[2628]: /shutdown -> /nix/store/z2nxjmk4666nbka3hgyxlg13prrnvx38-systemd-261/lib/systemd/systemd-shutdown machine # [ 68.764105] systemd[1]: getty@tty1.service: Deactivated successfully. machine # [ 68.772750] systemd[1]: Stopped Getty on tty1. machine # [ 68.777805] systemd[1]: nix-daemon.service: Deactivated successfully. machine # [ 68.785707] systemd[1]: Stopped Nix Daemon. machine # [ 68.789767] systemd[1]: nix-daemon.service: Consumed 2.702s CPU time over 57.646s wall clock time, 53.7M memory peak, 5.1M written to disk. machine # [ 68.802572] systemd[1]: static.service: Deactivated successfully. machine # [ 68.810361] systemd[1]: Stopped prebuilt flakelet service static. machine # [ 68.816097] systemd[1]: static-echo@2.service: Deactivated successfully. machine # [ 68.824634] systemd[1]: Stopped static-echo@2.service. machine # [ 68.831787] systemd[1]: cli-echo@1.service: Deactivated successfully. machine # [ 68.836566] systemd[1]: Stopped cli-echo@1.service. machine # [ 68.845076] systemd[1]: cli.service: Deactivated successfully. machine # [ 68.850229] systemd[1]: Stopped prebuilt flakelet service cli. machine # [ 68.855022] systemd[1]: web.service: Deactivated successfully. machine # [ 68.858897] systemd[1]: Stopped flakelet test service. machine # [ 68.861275] systemd[1]: Mounted /run/initramfs. machine # [ 68.864260] systemd[1]: post-boot.service: Deactivated successfully. machine # [ 68.867087] systemd[1]: Stopped Post-Boot Actions. machine # [ 68.869371] systemd[1]: systemd-random-seed.service: Deactivated successfully. machine # [ 68.874617] systemd[1]: Stopped Load/Save OS Random Seed. machine # [ 68.878698] systemd[1]: Removed slice Slice /system/getty. machine # [ 68.882985] systemd[1]: Starting Generate shutdown ramfs... machine # [ 68.887159] make-initrd-ng[2628]: Warning: Couldn't satisfy dependency libcrypt.so.1 for "/nix/store/z2nxjmk4666nbka3hgyxlg13prrnvx38-systemd-261/lib/systemd/libsystemd-shared-261.so" machine # [ 68.897252] make-initrd-ng[2628]: Warning: Couldn't satisfy dependency libcrypt.so.1.1 for "/nix/store/z2nxjmk4666nbka3hgyxlg13prrnvx38-systemd-261/lib/systemd/libsystemd-shared-261.so" machine # [ 68.908480] systemd[1]: Stopping Permit User Sessions... machine # [ 68.912779] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 68.918208] systemd[1]: Stopped Address configuration of eth1. machine # [ 68.922498] systemd[1]: dhcpcd.service: Deactivated successfully. machine # [ 68.927476] systemd[1]: Stopped DHCP Client. machine # [ 68.930434] systemd[1]: dhcpcd.service: Consumed 357ms CPU time over 58.594s wall clock time, 6.1M memory peak, 8K written to disk, 96B incoming IP traffic, 56B outgoing IP traffic. machine # [ 68.942084] systemd[1]: systemd-user-sessions.service: Deactivated successfully. machine # [ 68.947804] systemd[1]: Stopped Permit User Sessions. machine # [ 68.951757] systemd[1]: Stopped target Network. machine # [ 68.954105] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 68.957044] systemd[1]: Stopped target Remote File Systems. machine # [ 68.959601] systemd[1]: network-local-commands.service: Deactivated successfully. machine # [ 68.962826] systemd[1]: Stopped Extra networking commands.. machine # [ 68.965166] systemd[1]: Stopped target Preparation for Network. machine # [ 68.967421] systemd[1]: Stopping Firewall... machine # [ 68.969138] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 68.971310] systemd[1]: resolvconf.service: Deactivated successfully. machine # [ 68.973500] systemd[1]: Stopped resolvconf update. machine # [ 68.975096] systemd[1]: nscd.service: Deactivated successfully. machine # [ 68.976983] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [ 68.978805] systemd[1]: Stopped target Basic System. machine # [ 68.980331] systemd[1]: Stopped target Path Units. machine # [ 68.981903] systemd[1]: Stopped target Slice Units. machine # [ 68.983374] systemd[1]: Removed slice User and Session Slice. machine # [ 68.985198] systemd[1]: Stopped target Socket Units. machine # [ 68.986661] systemd[1]: cli-echo@1.socket: Deactivated successfully. machine # [ 68.988408] systemd[1]: Closed cli-echo@1.socket. machine # [ 68.989768] systemd[1]: cli-echo@2.socket: Deactivated successfully. machine # [ 68.991368] systemd[1]: Closed cli-echo@2.socket. machine # [ 68.992698] systemd[1]: Removed slice Slice /system/cli-echo. machine # [ 68.994094] systemd[1]: nix-daemon.socket: Deactivated successfully. machine # [ 68.995525] systemd[1]: Closed Nix Daemon Socket. machine # [ 68.996713] systemd[1]: static-echo@1.socket: Deactivated successfully. machine # [ 68.998203] systemd[1]: Closed static-echo@1.socket. machine # [ 68.999318] systemd[1]: static-echo@2.socket: Deactivated successfully. machine # [ 69.000782] systemd[1]: Closed static-echo@2.socket. machine # [ 69.001893] systemd[1]: Removed slice Slice /system/static-echo. machine # [ 69.003147] systemd[1]: systemd-hostnamed.socket: Deactivated successfully. machine # [ 69.004608] systemd[1]: Closed Hostname Service Socket. machine # [ 69.006627] systemd[1]: systemd-importd.socket: Deactivated successfully. machine # [ 69.007960] systemd[1]: Closed Disk Image Download Service Socket. machine # [ 69.009194] systemd[1]: systemd-machined.socket: Deactivated successfully. machine # [ 69.010639] systemd[1]: Closed Virtual Machine and Container Registration Service Socket. machine # [ 69.012449] systemd[1]: systemd-mute-console.socket: Deactivated successfully. machine # [ 69.014074] systemd[1]: Closed Console Output Muting Service Socket. machine # [ 69.015543] systemd[1]: systemd-oomd.socket: Deactivated successfully. machine # [ 69.017102] systemd[1]: Closed Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 69.018680] systemd[1]: systemd-repart.socket: Deactivated successfully. machine # [ 69.020200] systemd[1]: Closed Disk Repartitioning Service Socket. machine # [ 69.021893] dbus-broker[659]: Dispatched 23728 messages @ 4(±5)μs / message. machine # [ 69.023522] systemd[1]: Stopping D-Bus System Message Bus... machine # [ 69.024904] systemd[1]: dbus-broker.service: Deactivated successfully. machine # [ 69.026386] systemd[1]: Stopped D-Bus System Message Bus. machine # [ 69.027620] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 69.029026] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 69.030337] systemd[1]: Stopped target System Initialization. machine # [ 69.031566] systemd[1]: Stopped target Local Encrypted Volumes. machine # [ 69.032915] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 69.034477] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 69.036040] systemd[1]: systemd-ask-password-wall.path: Deactivated successfully. machine # [ 69.037580] systemd[1]: Stopped Forward Password Requests to Wall Directory Watch. machine # [ 69.039098] systemd[1]: register-nix-paths.service: Deactivated successfully. machine # [ 69.040696] systemd[1]: Stopped register-nix-paths.service. machine # [ 69.041815] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 69.043079] systemd[1]: Stopped Apply Kernel Variables. machine # [ 69.044121] systemd[1]: systemd-coredump.socket: Deactivated successfully. machine # [ 69.045404] systemd[1]: Closed Process Core Dump Socket. machine # [ 69.046413] systemd[1]: systemd-update-done.service: Deactivated successfully. machine # [ 69.047686] systemd[1]: Stopped Update is Completed. machine # [ 69.048751] systemd[1]: systemd-journal-catalog-update.service: Deactivated successfully. machine # [ 69.050179] systemd[1]: Stopped Rebuild Journal Catalog. machine # [ 69.051133] systemd[1]: Stopping Record System Boot/Shutdown in UTMP... machine # [ 69.052305] systemd[1]: systemd-update-utmp.service: Deactivated successfully. machine # [ 69.053556] systemd[1]: Stopped Record System Boot/Shutdown in UTMP. machine # [ 69.054643] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 69.055865] systemd[1]: Stopped Create System Files and Directories. machine # [ 69.056998] systemd[1]: Stopped target Local File Systems. machine # [ 69.057937] systemd[1]: Unmounting /run/keys... machine # [ 69.058709] systemd[1]: Unmounting /run/wrappers... machine # [ 69.059540] systemd[1]: run-keys.mount: Deactivated successfully. machine # [ 69.060574] systemd[1]: Unmounted /run/keys. machine # [ 69.061315] systemd[1]: run-wrappers.mount: Deactivated successfully. machine # [ 69.062360] systemd[1]: Unmounted /run/wrappers. machine # [ 69.063127] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 69.064205] systemd[1]: Stopped target Swaps. machine # [ 69.064929] systemd[1]: Reached target Unmount All Filesystems. machine # [ 69.065865] systemd[1]: systemd-remount-fs.service: Deactivated successfully. machine # [ 69.066954] systemd[1]: Stopped Remount Root and Kernel File Systems. machine # [ 69.067953] systemd[1]: systemd-fsck-root.service: Deactivated successfully. machine # [ 69.069139] systemd[1]: Stopped File System Check on Root Device. machine # [ 69.070095] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 69.071253] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 69.072245] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 69.073453] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 69.074501] systemd[1]: firewall.service: Deactivated successfully. machine # [ 69.075414] systemd[1]: Stopped Firewall. machine # [ 69.076057] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 69.077119] systemd[1]: Stopped Load Kernel Modules. machine # [ 69.077894] systemd[1]: generate-shutdown-ramfs.service: Deactivated successfully. machine # [ 69.078942] systemd[1]: Finished Generate shutdown ramfs. machine # [ 69.079732] systemd[1]: Reached target System Shutdown. machine # [ 69.080549] systemd[1]: Reached target Late Shutdown Services. machine # [ 69.081384] systemd[1]: systemd-poweroff.service: Deactivated successfully. machine # [ 69.082345] systemd[1]: Finished System Power Off. machine # [ 69.083051] systemd[1]: Reached target System Power Off. machine # [ 69.083801] systemd[1]: Shutting down. machine # [ 69.200562] systemd-shutdown[1]: Syncing filesystems and block devices. machine # [ 69.210031] systemd-shutdown[1]: Sending SIGTERM to remaining processes... machine # [ 69.222146] systemd-journald[315]: Received SIGTERM from PID 1 (systemd-shutdow). machine # [ 69.268464] systemd-shutdown[1]: Sending SIGKILL to remaining processes... machine # [ 69.279414] systemd-shutdown[1]: Unmounting file systems. machine # [ 69.285402] (sd-umount)[2663]: Unmounting '/run/credentials/systemd-journald.service'. machine # [ 69.291496] (sd-remount)[2664]: 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'. machine # [ 69.316256] (sd-remount)[2665]: 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'. machine # [ 69.326029] (sd-remount)[2666]: Remounting '/nix/.ro-store' read-only with options 'cache=0xf,access=client,msize=16384,trans=virtio'. machine # [ 69.557933] (sd-umount)[2667]: Unmounting '/nix/.ro-store'. machine # [ 69.562942] (sd-remount)[2668]: Remounting '/tmp/xchg' read-only with options 'access=client,msize=16384,trans=virtio'. machine # [ 69.564675] (sd-umount)[2669]: Unmounting '/tmp/xchg'. machine # [ 69.586826] (sd-remount)[2670]: Remounting '/tmp/shared' read-only with options 'access=client,msize=16384,trans=virtio'. machine # [ 69.588576] (sd-umount)[2671]: Unmounting '/tmp/shared'. machine # [ 69.618842] (sd-remount)[2672]: Remounting '/' read-only with options ''. machine # [ 69.635919] EXT4-fs (vda): re-mounted 11adae6e-999b-4ff0-99c7-12315f938e3e ro. machine # [ 69.644050] systemd-shutdown[1]: All filesystems unmounted. machine # [ 69.644134] systemd-shutdown[1]: Deactivating swaps. machine # [ 69.644232] systemd-shutdown[1]: All swaps deactivated. machine # [ 69.644262] systemd-shutdown[1]: Detaching loop devices. machine # [ 69.663280] systemd-shutdown[1]: All loop devices detached. machine # [ 69.663508] systemd-shutdown[1]: Stopping MD devices. machine # [ 69.664942] systemd-shutdown[1]: All MD devices stopped. machine # [ 69.665435] systemd-shutdown[1]: Detaching DM devices. machine # [ 69.666683] systemd-shutdown[1]: All DM devices detached. machine # [ 69.667356] systemd-shutdown[1]: All filesystems, swaps, loop devices, MD devices and DM devices detached. machine # [ 69.670181] systemd-shutdown[1]: Failed to chase and open directory '/etc/systemd/system-shutdown', ignoring: Input/output error machine # [ 70.006831] systemd-shutdown[1]: Successfully changed into root pivot. machine # [ 70.006894] systemd-shutdown[1]: Entering exitrd... machine # [ 70.021972] shutdown[1]: Syncing filesystems and block devices. machine # [ 70.023579] shutdown[1]: Sending SIGTERM to remaining processes... machine # [ 70.033238] shutdown[1]: Sending SIGKILL to remaining processes... machine # [ 70.042673] shutdown[1]: Unmounting file systems. machine # [ 70.046334] (sd-umoun[2674]: Unmounting '/run/credentials'. machine # [ 70.051641] (sd-umoun[2675]: Unmounting '/oldroot/sys/fs/fuse/connections'. machine # [ 70.057467] (sd-umoun[2676]: Unmounting '/oldroot/sys/kernel/config'. machine # [ 70.063035] (sd-umoun[2677]: Unmounting '/oldroot/dev/mqueue'. machine # [ 70.068425] (sd-umoun[2678]: Unmounting '/oldroot/sys/kernel/debug'. machine # [ 70.073895] (sd-umoun[2679]: Unmounting '/oldroot/sys/kernel/tracing'. machine # [ 70.079462] (sd-umoun[2680]: Unmounting '/oldroot/dev/hugepages'. machine # [ 70.084991] (sd-umoun[2681]: Unmounting '/oldroot/sys/fs/bpf'. machine # [ 70.090233] (sd-umoun[2682]: Unmounting '/oldroot/sys/fs/pstore'. machine # [ 70.095617] (sd-umoun[2683]: Unmounting '/oldroot/sys/fs/cgroup'. machine # [ 70.101081] (sd-umoun[2684]: Unmounting '/oldroot/sys/kernel/security'. machine # [ 70.106796] (sd-umoun[2685]: Unmounting '/oldroot/nix/store'. machine # [ 70.112117] (sd-umoun[2686]: Unmounting '/oldroot/sys'. machine # [ 70.117265] (sd-umoun[2687]: Unmounting '/oldroot/proc'. machine # [ 70.122315] (sd-umoun[2688]: Unmounting '/oldroot/dev/shm'. machine # [ 70.127479] (sd-umoun[2689]: Unmounting '/oldroot/dev/pts'. machine # [ 70.132726] (sd-umoun[2690]: Unmounting '/oldroot/dev'. machine # [ 70.137848] (sd-umoun[2691]: Unmounting '/oldroot/nix/store'. machine # [ 70.234690] (sd-umoun[2692]: Unmounting '/oldroot/run'. machine # [ 70.240041] (sd-umoun[2693]: Unmounting '/oldroot'. machine # [ 70.266118] EXT4-fs (vda): unmounting filesystem 11adae6e-999b-4ff0-99c7-12315f938e3e. machine # [ 70.271665] shutdown[1]: All filesystems unmounted. machine # [ 70.272464] shutdown[1]: Deactivating swaps. machine # [ 70.273088] shutdown[1]: All swaps deactivated. machine # [ 70.273586] shutdown[1]: Detaching loop devices. machine # [ 70.280392] shutdown[1]: All loop devices detached. machine # [ 70.281298] shutdown[1]: Stopping MD devices. machine # [ 70.282552] shutdown[1]: All MD devices stopped. machine # [ 70.283338] shutdown[1]: Detaching DM devices. machine # [ 70.284472] shutdown[1]: All DM devices detached. machine # [ 70.285260] shutdown[1]: All filesystems, swaps, loop devices, MD devices and DM devices detached. machine # [ 70.286766] shutdown[1]: Syncing filesystems and block devices. machine # [ 70.288198] shutdown[1]: Powering off. machine # [ 70.337408] Console: switching to colour dummy device 80x25 machine # [ 70.365738] Flash device refused suspend due to active operation (state 20) machine # [ 70.365775] Flash device refused suspend due to active operation (state 20) machine # [ 70.371033] reboot: Power down machine: (finished: waiting for the VM to power off, in 2.30 seconds) machine: starting vm machine: QEMU running (pid 91) machine: waiting for unit web.service machine: waiting for the VM to finish booting machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40] 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 machine # [ 0.000000] KASLR enabled machine # [ 0.000000] random: crng init done machine # [ 0.000000] Machine model: linux,dummy-virt machine # [ 0.000000] efi: UEFI not found. machine # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000013fffffff] machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x13fdeb740-0x13fdeeebf] machine # [ 0.000000] Zone ranges: machine # [ 0.000000] DMA [mem 0x0000000040000000-0x00000000ffffffff] machine # [ 0.000000] DMA32 empty machine # [ 0.000000] Normal [mem 0x0000000100000000-0x000000013fffffff] machine # [ 0.000000] Device empty machine # [ 0.000000] Movable zone start for each node machine # [ 0.000000] Early memory node ranges machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000013fffffff] machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000013fffffff] machine # [ 0.000000] cma: Reserved 32 MiB at 0x00000000fe000000 machine # [ 0.000000] psci: probing for conduit method from DT. machine # [ 0.000000] psci: PSCIv1.3 detected in firmware. machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs machine # [ 0.000000] psci: Trusted OS migration not required machine # [ 0.000000] psci: SMC Calling Convention v1.1 machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) machine # [ 0.000000] percpu: Embedded 76 pages/cpu s186392 r8192 d116712 u311296 machine # [ 0.000000] Detected PIPT I-cache on CPU0 machine # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm) machine # [ 0.000000] CPU features: detected: GICv3 CPU interface machine # [ 0.000000] CPU features: detected: Spectre-v4 machine # [ 0.000000] CPU features: detected: Spectre-BHB machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38 machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23 machine # [ 0.000000] alternatives: applying boot alternatives 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/6jjral78h0pim0k25ahd9qxi06rwmd23-nixos-system-machine-test/init regInfo=/nix/store/i4amarwnjgkhazjc3n4a2m4axhmy83sx-closure-info/registration console=ttyAMA0,115200n8 console=tty0 machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/i4amarwnjgkhazjc3n4a2m4axhmy83sx-closure-info/registration", will be passed to user space. machine # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes machine # [ 0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) machine # [ 0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) machine # [ 0.000000] software IO TLB: area num 4. machine # [ 0.000000] software IO TLB: mapped [mem 0x00000000fa000000-0x00000000fe000000] (64MB) machine # [ 0.000000] Fallback order for Node 0: 0 machine # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1048576 machine # [ 0.000000] Policy zone: Normal machine # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off machine # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 machine # [ 0.000000] allocated 8388608 bytes of page_ext machine # [ 0.000000] ftrace: allocating 74754 entries in 294 pages machine # [ 0.000000] ftrace: allocated 294 pages with 4 groups machine # [ 0.000000] rcu: Hierarchical RCU implementation. machine # [ 0.000000] rcu: RCU event tracing is enabled. machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=4. machine # [ 0.000000] Trampoline variant of Tasks RCU enabled. machine # [ 0.000000] Rude variant of Tasks RCU enabled. machine # [ 0.000000] Tracing variant of Tasks RCU enabled. machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 machine # [ 0.000000] RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. machine # [ 0.000000] RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. machine # [ 0.000000] RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 machine # [ 0.000000] GICv3: 256 SPIs implemented machine # [ 0.000000] GICv3: 0 Extended SPIs implemented machine # [ 0.000000] Root IRQ handler: gic_handle_irq machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0 machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @100b10000 (indirect, esz 8, psz 64K, shr 1) machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @100b20000 (flat, esz 8, psz 64K, shr 1) machine # [ 0.000000] GICv3: using LPI property table @0x0000000100b30000 machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000100b40000 machine # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. machine # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns machine # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt). machine # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns machine # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns machine # [ 0.000030] arm-pv: using stolen time PV machine # [ 0.000368] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) machine # [ 0.000573] Console: colour dummy device 80x25 machine # [ 0.000580] printk: legacy console [tty0] enabled machine # [ 0.000756] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) machine # [ 0.000762] pid_max: default: 32768 minimum: 301 machine # [ 0.000844] LSM: initializing lsm=capability,landlock,yama,bpf,ima machine # [ 0.000979] landlock: Up and running. machine # [ 0.000982] Yama: becoming mindful. machine # [ 0.001375] LSM support for eBPF active machine # [ 0.001535] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) machine # [ 0.001592] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) machine # [ 0.002706] cacheinfo: Unable to detect cache hierarchy for CPU 0 machine # [ 0.003455] rcu: Hierarchical SRCU implementation. machine # [ 0.003459] rcu: Max phase no-delay instances is 1000. machine # [ 0.003620] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level machine # [ 0.004647] fsl-mc MSI: its@8080000 domain created machine # [ 0.004740] EFI services will not be available. machine # [ 0.004937] smp: Bringing up secondary CPUs ... machine # [ 0.005609] Detected PIPT I-cache on CPU1 machine # [ 0.005713] GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 machine # [ 0.005846] GICv3: CPU1: using allocated LPI pending table @0x0000000100b50000 machine # [ 0.005976] CPU1: Booted secondary processor 0x0000000001 [0xc00fac40] machine # [ 0.007100] Detected PIPT I-cache on CPU2 machine # [ 0.007212] GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 machine # [ 0.007349] GICv3: CPU2: using allocated LPI pending table @0x0000000100b60000 machine # [ 0.007479] CPU2: Booted secondary processor 0x0000000002 [0xc00fac40] machine # [ 0.008910] Detected PIPT I-cache on CPU3 machine # [ 0.009026] GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 machine # [ 0.009160] GICv3: CPU3: using allocated LPI pending table @0x0000000100b70000 machine # [ 0.009289] CPU3: Booted secondary processor 0x0000000003 [0xc00fac40] machine # [ 0.009805] smp: Brought up 1 node, 4 CPUs machine # [ 0.009832] SMP: Total of 4 processors activated. machine # [ 0.009834] CPU: All CPU(s) started at EL1 machine # [ 0.009843] CPU features: detected: Branch Target Identification machine # [ 0.009847] CPU features: detected: ARMv8.4 Translation Table Level machine # [ 0.009849] CPU features: detected: Instruction cache invalidation not required for I/D coherence machine # [ 0.009853] CPU features: detected: Data cache clean to the PoU not required for I/D coherence machine # [ 0.009856] CPU features: detected: Common not Private translations machine # [ 0.009859] CPU features: detected: CRC32 instructions machine # [ 0.009862] CPU features: detected: Data cache clean to Point of Deep Persistence machine # [ 0.009866] CPU features: detected: Data cache clean to Point of Persistence machine # [ 0.009869] CPU features: detected: Data independent timing control (DIT) machine # [ 0.009872] CPU features: detected: E0PD machine # [ 0.009874] CPU features: detected: Enhanced Counter Virtualization machine # [ 0.009877] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) machine # [ 0.009880] CPU features: detected: Enhanced Virtualization Traps machine # [ 0.009883] CPU features: detected: Fine Grained Traps machine # [ 0.009886] CPU features: detected: Generic authentication (architected QARMA5 algorithm) machine # [ 0.009891] CPU features: detected: RCpc load-acquire (LDAPR) machine # [ 0.009894] CPU features: detected: LSE atomic instructions machine # [ 0.009897] CPU features: detected: Privileged Access Never machine # [ 0.009899] CPU features: detected: PMUv3 machine # [ 0.009902] CPU features: detected: RAS Extension Support machine # [ 0.009904] CPU features: detected: RASv1p1 Extension Support machine # [ 0.009907] CPU features: detected: Random Number Generator machine # [ 0.009910] CPU features: detected: Speculation barrier (SB) machine # [ 0.009913] CPU features: detected: Stage-2 Force Write-Back machine # [ 0.009915] CPU features: detected: TLB range maintenance instructions machine # [ 0.009919] CPU features: detected: Speculative Store Bypassing Safe (SSBS) machine # [ 0.010052] alternatives: applying system-wide alternatives machine # [ 0.012998] CPU features: detected: BBM Level 2 without TLB conflict abort machine # [ 0.013264] Memory: 3910056K/4194304K available (24384K kernel code, 7086K rwdata, 26316K rodata, 4736K init, 1102K bss, 233732K reserved, 32768K cma-reserved) machine # [ 0.014573] devtmpfs: initialized machine # [ 0.018235] posixtimers hash table entries: 2048 (order: 3, 32768 bytes, linear) machine # [ 0.018303] futex hash table entries: 1024 (65536 bytes on 1 NUMA nodes, total 64 KiB, linear). machine # [ 0.018482] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL machine # [ 0.018486] 0 pages in range for non-PLT usage machine # [ 0.018488] 508320 pages in range for PLT usage machine # [ 0.018619] pinctrl core: initialized pinctrl subsystem machine # [ 0.019375] DMI not present or invalid. machine # [ 0.022546] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.025004] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations machine # [ 0.025196] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations machine # [ 0.025423] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.025443] audit: initializing netlink subsys (disabled) machine # [ 0.025738] audit: type=2000 audit(0.024:1): state=initialized audit_enabled=0 res=1 machine # [ 0.026231] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.026234] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.026239] thermal_sys: Registered thermal governor 'step_wise' machine # [ 0.026241] thermal_sys: Registered thermal governor 'user_space' machine # [ 0.026244] thermal_sys: Registered thermal governor 'power_allocator' machine # [ 0.026321] cpuidle: using governor ladder machine # [ 0.026346] cpuidle: using governor menu machine # [ 0.026537] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers. machine # [ 0.026709] ASID allocator initialised with 65536 entries machine # [ 0.027816] Serial: AMBA PL011 UART driver machine # [ 0.032960] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 machine # [ 0.033232] printk: console [ttyAMA0] enabled machine # [ 0.037918] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages machine # [ 0.037926] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.037929] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages machine # [ 0.037932] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page machine # [ 0.037935] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.037937] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.037940] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages machine # [ 0.037943] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page machine # [ 0.049597] fbcon: Taking over console machine # [ 0.049626] ACPI: Interpreter disabled. machine # [ 0.052253] iommu: Default domain type: Translated machine # [ 0.052264] iommu: DMA domain TLB invalidation policy: strict mode machine # [ 0.062076] SCSI subsystem initialized machine # [ 0.062504] usbcore: registered new interface driver usbfs machine # [ 0.062537] usbcore: registered new interface driver hub machine # [ 0.062552] usbcore: registered new device driver usb machine # [ 0.062836] pps_core: LinuxPPS API ver. 1 registered machine # [ 0.062840] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti machine # [ 0.062848] PTP clock support registered machine # [ 0.062886] EDAC MC: Ver: 3.0.0 machine # [ 0.063356] scmi_core: SCMI protocol bus registered machine # [ 0.064284] FPGA manager framework machine # [ 0.065242] vgaarb: loaded machine # [ 0.066372] clocksource: Switched to clocksource arch_sys_counter machine # [ 0.083480] VFS: Disk quotas dquot_6.6.0 machine # [ 0.083546] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) machine # [ 0.084310] netfs: FS-Cache loaded machine # [ 0.084571] pnp: PnP ACPI: disabled machine # [ 0.095663] NET: Registered PF_INET protocol family machine # [ 0.097120] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) machine # [ 0.155702] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) machine # [ 0.155755] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) machine # [ 0.155796] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) machine # [ 0.155987] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) machine # [ 0.156424] TCP: Hash tables configured (established 32768 bind 32768) machine # [ 0.156553] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear) machine # [ 0.156614] UDP hash table entries: 2048 (order: 5, 131072 bytes, linear) machine # [ 0.156705] UDP-Lite hash table entries: 2048 (order: 5, 131072 bytes, linear) machine # [ 0.156883] NET: Registered PF_UNIX/PF_LOCAL protocol family machine # [ 0.156911] NET: Registered PF_XDP protocol family machine # [ 0.156929] PCI: CLS 0 bytes, default 64 machine # [ 0.157325] Trying to unpack rootfs image as initramfs... machine # [ 0.174638] kvm [1]: HYP mode not available machine # [ 0.254645] Initialise system trusted keyrings machine # [ 0.254892] workingset: timestamp_bits=42 max_order=20 bucket_order=0 machine # [ 0.255587] squashfs: version 4.0 (2009/01/31) Phillip Lougher machine # [ 0.255773] 9p: Installing v9fs 9p2000 file system support machine # [ 0.271050] Key type asymmetric registered machine # [ 0.271063] Asymmetric key parser 'x509' registered machine # [ 0.271121] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) machine # [ 0.271379] io scheduler mq-deadline registered machine # [ 0.271386] io scheduler kyber registered machine # [ 0.279547] pl061_gpio 9030000.pl061: PL061 GPIO chip registered machine # [ 0.282504] ledtrig-cpu: registered to indicate activity on CPUs machine # [ 0.282930] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: machine # [ 0.282946] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 machine # [ 0.282966] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 machine # [ 0.282975] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 machine # [ 0.282995] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits machine # [ 0.283018] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] machine # [ 0.283182] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 machine # [ 0.283191] pci_bus 0000:00: root bus resource [bus 00-ff] machine # [ 0.283196] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] machine # [ 0.283199] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] machine # [ 0.283204] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] machine # [ 0.283314] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.283924] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.284174] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.284189] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.284229] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.284244] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.284886] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.285146] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.285161] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.285199] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.285843] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint machine # [ 0.286112] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] machine # [ 0.286133] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.286172] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.286853] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint machine # [ 0.287137] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.287152] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.287185] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.287847] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint machine # [ 0.288115] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.288136] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.288174] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.288815] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.289071] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] machine # [ 0.289086] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.289119] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.289748] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.289995] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.290010] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.290049] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.290071] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.290784] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint machine # [ 0.291066] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.291100] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.291767] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 0.292032] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.292072] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.292621] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint machine # [ 0.292876] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] machine # [ 0.293220] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint machine # [ 0.293577] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] machine # [ 0.293593] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.293632] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.294270] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.294550] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.294564] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.294603] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.295418] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned machine # [ 0.295426] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned machine # [ 0.295430] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned machine # [ 0.295483] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned machine # [ 0.295541] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned machine # [ 0.295603] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned machine # [ 0.295663] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned machine # [ 0.295725] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned machine # [ 0.295785] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned machine # [ 0.295847] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned machine # [ 0.295901] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned machine # [ 0.295955] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned machine # [ 0.296037] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned machine # [ 0.296097] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned machine # [ 0.296126] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned machine # [ 0.296148] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned machine # [ 0.296169] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned machine # [ 0.296192] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned machine # [ 0.296214] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned machine # [ 0.296242] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned machine # [ 0.296265] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned machine # [ 0.296294] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned machine # [ 0.296316] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned machine # [ 0.296339] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned machine # [ 0.296362] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned machine # [ 0.296384] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned machine # [ 0.296414] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned machine # [ 0.296436] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned machine # [ 0.296457] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned machine # [ 0.296484] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned machine # [ 0.296507] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned machine # [ 0.296529] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned machine # [ 0.296551] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned machine # [ 0.296573] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned machine # [ 0.296606] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] machine # [ 0.296612] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] machine # [ 0.296616] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] machine # [ 0.298300] pci 0000:00:0a.0: enabling device (0000 -> 0002) machine # [ 0.312744] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) machine # [ 0.315572] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) machine # [ 0.318220] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) machine # [ 0.320952] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) machine # [ 0.324938] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) machine # [ 0.329589] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) machine # [ 0.332254] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) machine # [ 0.335025] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) machine # [ 0.339624] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) machine # [ 0.343703] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) machine # [ 0.346845] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) machine # [ 0.354186] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 0.356423] msm_serial: driver initialized machine # [ 0.356594] SuperH (H)SCI(F) driver initialized machine # [ 0.356653] STM32 USART driver initialized machine # [ 0.388106] loop: module loaded machine # [ 0.388359] virtio_blk virtio5: 4/0/0 default/read/poll queues machine # [ 0.391050] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 0.393902] megasas: 07.734.00.00-rc1 machine # [ 0.394745] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] machine # [ 0.401206] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.401229] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.403469] Using buffer write method machine # [ 0.403511] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] machine # [ 0.405904] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.405927] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.409992] Using buffer write method machine # [ 0.410014] Concatenating MTD devices: machine # [ 0.410017] (0): "0.flash" machine # [ 0.410020] (1): "0.flash" machine # [ 0.410022] into device "0.flash" machine # [ 0.600290] Freeing initrd memory: 27052K machine # [ 0.617500] tun: Universal TUN/TAP device driver, 1.6 machine # [ 0.626269] thunder_xcv, ver 1.0 machine # [ 0.626482] thunder_bgx, ver 1.0 machine # [ 0.626552] nicpf, ver 1.0 machine # [ 0.628337] e1000: Intel(R) PRO/1000 Network Driver machine # [ 0.628352] e1000: Copyright (c) 1999-2006 Intel Corporation. machine # [ 0.628436] e1000e: Intel(R) PRO/1000 Network Driver machine # [ 0.628450] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. machine # [ 0.628517] igb: Intel(R) Gigabit Ethernet Network Driver machine # [ 0.628526] igb: Copyright (c) 2007-2014 Intel Corporation. machine # [ 0.628593] igbvf: Intel(R) Gigabit Virtual Function Network Driver machine # [ 0.628603] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. machine # [ 0.628986] sky2: driver version 1.30 machine # [ 0.633337] ehci-pci 0000:00:0a.0: EHCI Host Controller machine # [ 0.633365] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 machine # [ 0.633608] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 machine # [ 0.633840] usbcore: registered new interface driver usb-storage machine # [ 0.634047] usbcore: registered new interface driver usbserial_generic machine # [ 0.634122] usbserial: USB Serial support registered for generic machine # [ 0.636030] hv_vmbus: registering driver hyperv_keyboard machine # [ 0.638624] rtc-pl031 9010000.pl031: registered as rtc0 machine # [ 0.638681] rtc-pl031 9010000.pl031: setting system clock to 2026-08-31T07:38:18 UTC (1788161898) machine # [ 0.639579] i2c_dev: i2c /dev entries driver machine # [ 0.642591] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 machine # [ 0.644195] hub 1-0:1.0: USB hub found machine # [ 0.644303] hub 1-0:1.0: 6 ports detected machine # [ 0.647936] sdhci: Secure Digital Host Controller Interface driver machine # [ 0.647951] sdhci: Copyright(c) Pierre Ossman machine # [ 0.648787] Synopsys Designware Multimedia Card Interface Driver machine # [ 0.649903] sdhci-pltfm: SDHCI platform and OF driver helper machine # [ 0.654438] hid: raw HID events driver (C) Jiri Kosina machine # [ 0.655335] usbcore: registered new interface driver usbhid machine # [ 0.655344] usbhid: USB HID core driver machine # [ 0.699949] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available machine # [ 0.704559] drop_monitor: Initializing network drop monitor service machine # [ 0.704946] NET: Registered PF_INET6 protocol family machine # [ 0.707564] Segment Routing with IPv6 machine # [ 0.707630] In-situ OAM (IOAM) with IPv6 machine # [ 0.707873] NET: Registered PF_PACKET protocol family machine # [ 0.708308] 9pnet: Installing 9P2000 support machine # [ 0.715152] Key type dns_resolver registered machine # [ 0.734343] registered taskstats version 1 machine # [ 0.734948] Loading compiled-in X.509 certificates machine # [ 0.762936] Demotion targets for Node 0: null machine # [ 0.763231] Key type .fscrypt registered machine # [ 0.763239] Key type fscrypt-provisioning registered machine # [ 0.763526] ima: No TPM chip found, activating TPM-bypass! machine # [ 0.763551] ima: Allocated hash algorithm: sha1 machine # [ 0.763664] ima: No architecture policies found machine # [ 0.765195] input: gpio-keys as /devices/platform/gpio-keys/input/input0 machine # [ 0.797101] clk: Disabling unused clocks machine # [ 0.797141] PM: genpd: Disabling unused power domains machine # [ 0.803159] Freeing unused kernel memory: 4736K machine # [ 0.803467] Run /init as init process machine # [ 0.849777] systemd[1]: Successfully made /usr/ read-only. machine # [ 0.890458] usb 1-1: new high-speed USB device number 2 using ehci-pci machine # [ 1.042870] 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 machine # [ 1.130912] 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 machine # [ 1.184713] 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) machine # [ 1.184779] systemd[1]: Detected virtualization qemu. machine # [ 1.184845] systemd[1]: Detected architecture arm64. machine # [ 1.184858] systemd[1]: Running in initrd. machine # [ 1.185667] systemd[1]: Initializing machine ID from random generator. machine # [ 1.186013] systemd[1]: Hostname set to . machine # [ 1.250469] usb 1-2: new high-speed USB device number 3 using ehci-pci machine # [ 1.402622] 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 machine # [ 1.402972] 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 machine # [ 1.447779] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 1.532351] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.549483] systemd[1]: Created slice Slice /system/modprobe. machine # [ 1.549781] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 1.549817] systemd[1]: Expecting device /dev/disk/by-label/nixos... machine # [ 1.549845] systemd[1]: Reached target Path Units. machine # [ 1.549865] systemd[1]: Reached target Slice Units. machine # [ 1.549884] systemd[1]: Reached target Swaps. machine # [ 1.549903] systemd[1]: Reached target Timer Units. machine # [ 1.550084] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 1.550262] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 1.550546] systemd[1]: Listening on Journal Sockets. machine # [ 1.550711] systemd[1]: Listening on udev Control Socket. machine # [ 1.550807] systemd[1]: Listening on udev Kernel Socket. machine # [ 1.550829] systemd[1]: Reached target Socket Units. machine # [ 1.552760] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 1.554611] systemd[1]: Starting Load Kernel Module 9pnet_virtio... machine # [ 1.554691] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 1.556569] systemd[1]: Mounting Kernel Configuration File System... machine # [ 1.580035] systemd[1]: Starting Journal Service... machine # [ 1.585441] systemd[1]: Starting Load Kernel Modules... machine # [ 1.585711] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 1.589114] systemd[1]: Starting Coldplug All udev Devices... machine # [ 1.594804] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 1.595939] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. machine # [ 1.602074] systemd[1]: Finished Load Kernel Module 9pnet_virtio. machine # [ 1.603876] systemd[1]: Mounted Kernel Configuration File System. machine # [ 1.612578] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 1.620765] systemd-journald[96]: Collecting audit messages is disabled. machine # [ 1.627051] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. machine # [ 1.627416] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev machine # [ 1.632431] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0 machine # [ 1.632679] [drm] features: -virgl +edid -resource_blob -host_visible machine # [ 1.632682] [drm] features: -context_init machine # [ 1.633508] [drm] number of scanouts: 1 machine # [ 1.633520] [drm] number of cap sets: 0 machine # [ 1.634482] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic machine # [ 1.634500] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0 machine # [ 1.650136] Console: switching to colour frame buffer device 160x50 machine # [ 1.657755] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device machine # [ 1.664205] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 1.667995] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 1.668589] systemd[1]: Finished Load Kernel Modules. machine # [ 1.671869] systemd[1]: Starting Apply Kernel Variables... machine # [ 1.691507] systemd[1]: Finished Apply Kernel Variables. machine # [ 1.703794] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 1.704038] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 1.704649] systemd[1]: Reached target Local File Systems. machine # [ 1.710299] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 1.705741] systemd-modules-load[97]: Using 4 probe threads machine # [ 1.715183] systemd-modules-load[97]: Module 'virtio_balloon' is built in[ 1.711021] systemd[1]: Started Journal Service. machine # machine # [ 1.719567] systemd-modules-load[97]: Module 'virtio_console' is built in machine # [ 1.721622] systemd-modules-load[97]: Module 'virtio_rng' is built in machine # [ 1.723644] systemd-modules-load[97]: Inserted module 'dm_mod' machine # [ 1.726084] systemd-modules-load[97]: Inserted module 'virtio_gpu' machine # [ 1.727332] systemd[1]: Starting Create System Files and Directories... machine # [ 1.738633] systemd-udevd[107]: Using default interface naming scheme 'v261'. machine # [ 1.741163] systemd[1]: Finished Create System Files and Directories. machine # [ 1.752109] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 1.780104] systemd[1]: Starting Virtual Console Setup... machine # [ 1.850118] systemd-vconsole-setup[129]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 1.855190] systemd[1]: Finished Virtual Console Setup. machine # [ 2.220997] systemd[1]: Finished Coldplug All udev Devices. machine # [ 2.223454] systemd[1]: Reached target System Initialization. machine # [ 2.225991] systemd[1]: Reached target Basic System. machine # [ 2.421192] (udev-worker)[138]: Network interface NamePolicy= disabled on kernel command line. machine # [ 2.425167] (udev-worker)[122]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 2.429662] (udev-worker)[122]: Network interface NamePolicy= disabled on kernel command line. machine # [ 2.493999] systemd[1]: Found device /dev/disk/by-label/nixos. machine # [ 2.495534] systemd[1]: Reached target Initrd Root Device. machine # [ 2.496956] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... machine # [ 2.540572] systemd-fsck[151]: nixos: clean, 1214/65536 files, 18917/262144 blocks machine # [ 2.543253] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. machine # [ 2.590015] systemd[1]: Mounting /sysroot... machine # [ 2.638035] EXT4-fs (vda): mounted filesystem 11adae6e-999b-4ff0-99c7-12315f938e3e r/w with ordered data mode. Quota mode: none. machine # [ 2.641939] systemd[1]: Mounted /sysroot. machine # [ 2.643039] systemd[1]: Reached target Initrd Root File System. machine # [ 2.646689] systemd[1]: Mounting /sysroot/nix/.ro-store... machine # [ 2.652363] systemd[1]: Mounting /sysroot/run... machine # [ 2.655713] systemd[1]: Mounting /sysroot/tmp/shared... machine # [ 2.673247] systemd[1]: Mounting /sysroot/tmp/xchg... machine # [ 2.680172] systemd[1]: Starting Mountpoints Configured in the Real Root... machine # [ 2.688778] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 2.690084] systemd-sysroot-fstab-check[163]: /sysroot should be mounted in the initrd, will request daemon-reload. machine # [ 2.699663] systemd[1]: Mounted /sysroot/nix/.ro-store. machine # [ 2.700846] systemd[1]: Mounted /sysroot/run. machine # [ 2.701612] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 2.702357] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 2.703096] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 2.704272] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 2.708118] systemd[1]: Mounting /sysroot/nix/store... machine # [ 2.709901] systemd[1]: Reload requested from client PID 163 ('systemd-sysroot') (unit initrd-parse-etc.service)... machine # [ 2.711486] systemd[1]: Reloading... machine # [ 2.804141] systemd[1]: Reloading finished in 96 ms. machine # [ 2.858415] systemd-sysroot-fstab-check[163]: Requesting initrd-fs.target/start/replace... machine # [ 2.860159] systemd[1]: Mounted /sysroot/nix/store. machine # [ 2.862115] systemd-sysroot-fstab-check[163]: Requesting swap.target/start/replace... machine # [ 2.863295] systemd[1]: Starting Find NixOS closure... machine # [ 2.866273] systemd[1]: initrd-parse-etc.service: Deactivated successfully. machine # [ 2.867501] systemd[1]: Finished Mountpoints Configured in the Real Root. machine # [ 2.868512] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. machine # [ 2.870474] systemd[1]: Reached target Initrd File Systems. machine # [ 2.876783] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 2.889177] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. machine # [ 2.895644] systemd[1]: Finished Find NixOS closure. machine # [ 2.896882] systemd[1]: Reached target Initrd Default Target. machine # [ 2.900140] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 2.912987] systemd[1]: Stopped target Initrd Default Target. machine # [ 2.914378] systemd[1]: Stopped target Basic System. machine # [ 2.915148] systemd[1]: Stopped target Initrd Root Device. machine # [ 2.915914] systemd[1]: Stopped target Path Units. machine # [ 2.916729] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 2.917758] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 2.918888] systemd[1]: Stopped target Slice Units. machine # [ 2.919658] systemd[1]: Stopped target Socket Units. machine # [ 2.921422] systemd[1]: Stopped target System Initialization. machine # [ 2.922867] systemd[1]: Stopped target Swaps. machine # [ 2.923658] systemd[1]: Stopped target Timer Units. machine # [ 2.926577] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 2.927470] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 2.928366] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. machine # [ 2.929424] systemd[1]: Stopped Find NixOS closure. machine # [ 2.930171] systemd[1]: Starting Load Kernel Module 9pnet_virtio... machine # [ 2.931146] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 2.931988] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 2.933078] systemd[1]: Stopped Apply Kernel Variables. machine # [ 2.934270] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 2.935291] systemd[1]: Stopped Load Kernel Modules. machine # [ 2.936029] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 2.937134] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 2.938181] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 2.939165] systemd[1]: Stopped Create System Files and Directories. machine # [ 2.940091] systemd[1]: Stopped target Local File Systems. machine # [ 2.940855] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 2.941774] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 2.942740] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 2.943496] systemd[1]: Stopping Rule-based Manager for Device Events and Files... machine # [ 2.944645] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 2.945640] systemd[1]: Stopped Virtual Console Setup. machine # [ 2.946356] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. machine # [ 2.947328] systemd[1]: Finished Load Kernel Module 9pnet_virtio. machine # [ 2.948180] systemd[1]: initrd-cleanup.service: Deactivated successfully. machine # [ 2.949091] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. machine # [ 2.949981] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 2.950943] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 2.958121] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 2.959025] systemd[1]: Stopped Rule-based Manager for Device Events and Files. machine # [ 2.959973] systemd[1]: systemd-udevd.service: Consumed 1.831s CPU time over 1.250s wall clock time, 25.8M memory peak. machine # [ 2.961473] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. machine # [ 2.962445] systemd[1]: Closed udev Control Socket. machine # [ 2.963136] systemd[1]: Starting Cleanup udev Database... machine # [ 2.963882] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 2.964984] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 2.965833] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 2.967015] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 2.967978] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 2.968992] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 3.000233] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. machine # [ 3.001474] systemd[1]: Finished Cleanup udev Database. machine # [ 3.002327] systemd[1]: Reached target Switch Root. machine # [ 3.003632] systemd[1]: Starting NixOS Activation... machine # [ 3.253853] initrd-nixos-activation-start[208]: booting system configuration /nix/store/6jjral78h0pim0k25ahd9qxi06rwmd23-nixos-system-machine-test machine # [ 3.367347] initrd-nixos-activation-start[208]: running activation script... machine # [ 3.911283] initrd-nixos-activation-start[233]: setting up /etc... machine # [ 4.294074] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. machine # [ 4.297632] systemd[1]: Finished NixOS Activation. machine # [ 4.299753] systemd[1]: Starting Switch Root... machine # [ 4.335056] systemd[1]: Switching root. machine # [ 4.487652] systemd-journald[96]: Received SIGTERM from PID 1 (systemd). machine # [ 5.197516] 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) machine # [ 5.197649] systemd[1]: Detected virtualization qemu. machine # [ 5.197729] systemd[1]: Detected architecture arm64. machine # [ 5.443958] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 6.261681] systemd[1]: initrd-switch-root.service: Deactivated successfully. machine # [ 6.261935] systemd[1]: Stopped initrd-switch-root.service. machine # [ 6.263331] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 6.271979] systemd[1]: Created slice Slice /system/getty. machine # [ 6.275077] systemd[1]: Created slice User and Session Slice. machine # [ 6.275970] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 6.277333] systemd[1]: Started Forward Password Requests to Wall Directory Watch. machine # [ 6.278473] systemd[1]: Expecting device /dev/hvc0... machine # [ 6.279564] systemd[1]: Expecting device /dev/ttyAMA0... machine # [ 6.280634] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 6.281704] systemd[1]: Reached target flakelet contract providers ready. machine # [ 6.282780] systemd[1]: Stopped target initrd-fs.target. machine # [ 6.283838] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 6.284970] systemd[1]: Stopped target initrd-switch-root.target. machine # [ 6.286030] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 6.287159] systemd[1]: Reached target Path Units. machine # [ 6.288203] systemd[1]: Reached target Remote File Systems. machine # [ 6.289231] systemd[1]: Reached target Slice Units. machine # [ 6.290264] systemd[1]: Reached target Swaps. machine # [ 6.296345] systemd[1]: Listening on Query the User Interactively for a Password. machine # [ 6.303270] systemd[1]: Listening on Process Core Dump Socket. machine # [ 6.308782] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 6.314290] systemd[1]: Listening on Factory Reset Management. machine # [ 6.315705] systemd[1]: Listening on Hostname Service Socket. machine # [ 6.327618] systemd[1]: Starting Journal Log Access Socket... machine # [ 6.329687] systemd[1]: Listening on Journal Audit Socket. machine # [ 6.335385] systemd[1]: Listening on Console Output Muting Service Socket. machine # [ 6.336953] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 6.338005] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.339013] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 6.353382] systemd[1]: Listening on Disk Repartitioning Service Socket. machine # [ 6.354584] systemd[1]: Listening on udev Control Socket. machine # [ 6.355764] systemd[1]: Listening on udev Varlink Socket. machine # [ 6.364222] systemd[1]: Mounting Huge Pages File System... machine # [ 6.376423] systemd[1]: Mounting POSIX Message Queue File System... machine # [ 6.385267] systemd[1]: Mounting Kernel Debug File System... machine # [ 6.395246] systemd[1]: Mounting Kernel Trace File System... machine # [ 6.407899] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 6.419894] systemd[1]: Starting Load Kernel Module 9pnet_virtio... machine # [ 6.420919] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 6.452698] systemd[1]: Mounting Kernel Configuration File System... machine # [ 6.453606] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm machine # [ 6.454456] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 6.462679] systemd[1]: Starting Load Kernel Module fuse... machine # [ 6.465298] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 6.511843] systemd[1]: Starting Journal Service... machine # [ 6.517469] systemd[1]: Starting Load Kernel Modules... machine # [ 6.524015] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 6.529095] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 6.529846] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.543407] systemd[1]: Starting Coldplug All udev Devices... machine # [ 6.549606] systemd[1]: Listening on Journal Log Access Socket. machine # [ 6.550479] systemd[1]: Mounted Huge Pages File System. machine # [ 6.551656] systemd[1]: Mounted POSIX Message Queue File System. machine # [ 6.552637] systemd[1]: Mounted Kernel Debug File System. machine # [ 6.553452] systemd[1]: Mounted Kernel Trace File System. machine # [ 6.554916] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 6.556322] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. machine # [ 6.557360] systemd[1]: Finished Load Kernel Module 9pnet_virtio. machine # [ 6.558609] systemd[1]: Mounted Kernel Configuration File System. machine # [ 6.570246] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 6.582724] fuse: init (API version 7.45) machine # [ 6.587763] systemd[1]: modprobe@fuse.service: Deactivated successfully. machine # [ 6.589159] systemd[1]: Finished Load Kernel Module fuse. machine # [ 6.601483] systemd[1]: Mounting FUSE Control File System... machine # [ 6.631167] systemd[1]: Finished Load Kernel Modules. machine # [ 6.633891] EXT4-fs (vda): re-mounted 11adae6e-999b-4ff0-99c7-12315f938e3e. machine # [ 6.642621] systemd[1]: Starting Firewall... machine # [ 6.652632] systemd[1]: Starting Apply Kernel Variables... machine # [ 6.656186] systemd[1]: Finished Remount Root and Kernel File Systems. machine # [ 6.658642] systemd[1]: Mounted FUSE Control File System. machine # [ 6.659438] systemd[1]: Listening on Disk Image Download Service Socket. machine # [ 6.661164] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 6.672568] systemd-journald[305]: Collecting audit messages is enabled. machine # [ 6.680554] systemd[1]: Starting Load/Save OS Random Seed... machine # [ 6.681155] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.689984] systemd[1]: Queued start job for default target Multi-User System. machine # [ 6.695835] systemd[1]: Started Journal Service. machine # [ 6.694909] systemd[1]: systemd-journald.service: Deactivated successfully. machine # [ 6.703266] systemd-modules-load[306]: Using 2 probe threads machine # [ 6.705651] systemd-modules-load[306]: Module 'atkbd' is built in machine # [ 6.707089] systemd-modules-load[306]: Module 'loop' is built in machine # [ 6.709040] systemd-oomd[307]: No swap; memory pressure usage will be degraded machine # [ 6.711232] systemd[1]: Starting Flush Journal to Persistent Storage... machine # [ 6.713167] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 6.715306] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 6.717791] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 6.746831] systemd[1]: Finished Load/Save OS Random Seed. machine # [ 6.749853] systemd[1]: First Boot Complete skipped, unmet condition check ConditionFirstBoot=yes machine # [ 6.763017] systemd-journald[305]: Received client request to flush runtime journal. machine # [ 6.802719] systemd[1]: Finished Apply Kernel Variables. machine # [ 6.806507] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 6.807716] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 6.808835] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 6.809870] systemd[1]: Finished Flush Journal to Persistent Storage. machine # [ 6.931481] systemd-udevd[341]: Using default interface naming scheme 'v261'. machine # [ 7.031970] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 7.231122] systemd[1]: Finished Coldplug All udev Devices. machine # [ 7.272371] systemd[1]: Mounting /run/wrappers... machine # [ 7.316139] systemd[1]: Mounted /run/wrappers. machine # [ 7.318017] systemd[1]: Reached target Local File Systems. machine # [ 7.322556] systemd[1]: Listening on Boot Loader Control Service Socket. machine # [ 7.400786] systemd[1]: Starting register-nix-paths.service... machine # [ 7.410149] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input3 machine # [ 7.460205] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 7.463123] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 7.466233] systemd[1]: Save Transient machine-id to Disk skipped, unmet condition check ConditionPathIsMountPoint=/etc/machine-id machine # [ 7.488115] systemd[1]: Starting Create System Files and Directories... machine # [ 7.525077] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 7.534774] systemd[1]: Starting Virtual Console Setup... machine # [ 7.544062] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 7.586988] systemd[1]: Finished Create System Files and Directories. machine # [ 7.591663] systemd[1]: Rebuild Journal Catalog skipped, unmet condition check ConditionNeedsUpdate=/var machine # [ 7.597440] systemd[1]: Update is Completed skipped, no trigger condition checks were met. machine # [ 7.600037] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 7.610830] (udev-worker)[375]: Network interface NamePolicy= disabled on kernel command line. machine # [ 7.616806] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. machine # [ 7.630925] (udev-worker)[374]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 7.641073] (udev-worker)[374]: Network interface NamePolicy= disabled on kernel command line. machine # [ 7.655158] systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine # [ 7.677764] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 7.681109] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 7.685429] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 7.690376] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 7.700491] systemd[1]: Rebuild Journal Catalog skipped, unmet condition check ConditionNeedsUpdate=/var machine # [ 7.702373] systemd[1]: Save Transient machine-id to Disk skipped, unmet condition check ConditionPathIsMountPoint=/etc/machine-id machine # [ 7.708774] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 7.712193] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 7.715465] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 7.720584] systemd[1]: Update is Completed skipped, no trigger condition checks were met. machine # [ 7.738545] mousedev: PS/2 mouse device common for all mice machine # [ 7.828755] systemd[1]: Finished Firewall. machine # [ 7.975796] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 7.978174] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 8.040613] systemd-vconsole-setup[446]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 8.044380] systemd[1]: Finished Virtual Console Setup. machine # [ 8.145980] systemd[1]: Finished register-nix-paths.service. machine # [ 8.148100] systemd[1]: Reached target System Initialization. machine # [ 8.150375] systemd[1]: Started Discard unused filesystem blocks once a week. machine # [ 8.153324] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 8.154289] systemd[1]: Reached target Timer Units. machine # [ 8.155053] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 8.157133] systemd[1]: Listening on Nix Daemon Socket. machine # [ 8.157936] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [ 8.163599] systemd[1]: Reached target Socket Units. machine # [ 8.164961] systemd[1]: Reached target Basic System. machine # [ 8.167448] systemd[1]: Started backdoor.service. machine # [ 8.175593] systemd[1]: Starting Re-link flakelet services at boot... machine # [ 8.177183] systemd[1]: Import lastlog data into lastlog2 database skipped, unmet condition check ConditionPathExists=!/var/lib/lastlog/lastlog2.db machine # [ 8.194170] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 8.200159] systemd[1]: Starting Post-Boot Actions... machine # [ 8.210021] systemd[1]: Started Reset console on configuration changes. machine # [ 8.213696] systemd[1]: Starting resolvconf update... machine # [ 8.234906] systemd[1]: Starting D-Bus System Message Bus... machine # [ 8.268063] systemd[1]: Finished Post-Boot Actions. machine # connecting to host... machine # [ 8.278032] systemd[1]: Reload requested from client PID 564 ('systemctl') (unit flakelet-boot.service)... machine # [ 8.280431] systemd[1]: Reloading... machine # [ 8.293066] nsncd[552]: Aug 31 07:38:26.155 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine: Guest shell says: b'Spawning backdoor root shell...\n' machine: connected to guest root shell machine: (connecting took 8.72 seconds) machine: (finished: waiting for the VM to finish booting, in 8.72 seconds) machine # [ 8.368274] dbus-broker-launch[557]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 8.835417] systemd[1]: Reloading finished in 551 ms. machine # [ 8.882792] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 8.893375] dbus-broker-launch[557]: NSS returned no entry for 'systemd-timesync' machine # [ 8.901680] dbus-broker-launch[557]: Invalid user-name in /nix/store/az79avzxcb95szkcyjmsj32zwdqxmm7i-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 8.924706] systemd[1]: Started D-Bus System Message Bus. machine # [ 8.953931] dbus-broker-launch[557]: Ready machine # [ 8.960627] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 8.964684] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 8.968722] systemd[1]: Stopped Virtual Console Setup. machine # [ 8.972917] systemd[1]: Stopping Virtual Console Setup... machine # [ 8.976418] systemd[1]: Starting Virtual Console Setup... machine # [ 8.979452] systemd[1]: nscd.service: Deactivated successfully. machine # [ 8.985378] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [ 8.986387] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 9.032560] nsncd[666]: Aug 31 07:38:26.894 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 9.038592] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 9.044169] systemd[1]: Reload requested from client PID 672 ('systemctl') (unit flakelet-boot.service)... machine # [ 9.050605] systemd[1]: Reloading... machine # [ 9.307516] systemd-vconsole-setup[661]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 9.639992] systemd[1]: Reloading finished in 598 ms. machine # [ 9.703556] systemd[1]: Finished Virtual Console Setup. machine # [ 9.737686] systemd[1]: Created slice Slice /system/cli-echo. machine # [ 9.740325] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 9.742938] systemd[1]: Reached target User and Group Name Lookups. machine # [ 9.745622] systemd[1]: Listening on cli-echo@1.socket. machine # [ 9.747874] systemd[1]: Listening on cli-echo@2.socket. machine # [ 9.753102] systemd[1]: Starting User Login Management... machine # [ 9.765364] systemd[1]: Starting prebuilt flakelet service cli... machine # [ 9.785126] systemd[1]: Finished resolvconf update. machine # [ 9.792823] systemd[1]: Reached target Preparation for Network. machine # [ 9.802849] systemd[1]: Starting DHCP Client... machine # [ 9.809402] systemd[1]: Starting Address configuration of eth1... machine # [ 9.817081] systemd[1]: Starting Extra networking commands.... machine # [ 9.822455] systemd[1]: Started prebuilt flakelet service cli. machine # [ 9.831642] systemd[1]: Reload requested from client PID 728 ('systemctl') (unit flakelet-boot.service)... machine # [ 9.838958] systemd[1]: Reloading... machine # [ 9.899582] systemd-logind[721]: New seat seat0. machine # [ 9.909474] systemd-logind[721]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) machine # [ 9.910946] systemd-logind[721]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) machine # [ 9.912407] systemd-logind[721]: Watching system buttons on /dev/input/event0 (gpio-keys) machine # [ 9.958984] network-addresses-eth1-start[732]: adding address 192.168.1.1/24... done machine # [ 9.974260] network-addresses-eth1-start[732]: adding address 2001:db8:1::1/64... done machine # [ 10.438190] systemd[1]: Reloading finished in 603 ms. machine # [ 10.515665] systemd[1]: Started User Login Management. machine # [ 10.519086] systemd[1]: Finished Address configuration of eth1. machine # [ 10.522041] systemd[1]: Finished Extra networking commands.. machine # [ 10.549146] systemd[1]: Reached target Network. machine # [ 10.553725] systemd[1]: Starting linger-users.service... machine # [ 10.560850] systemd[1]: Starting Permit User Sessions... machine # [ 10.623418] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 10.624657] systemd[1]: Finished linger-users.service. machine # [ 10.625570] systemd[1]: Finished Permit User Sessions. machine # [ 10.633952] systemd[1]: Reload requested from client PID 838 ('systemctl') (unit flakelet-boot.service)... machine # [ 10.635624] systemd[1]: Reloading... machine # [ 11.269792] systemd[1]: Reloading finished in 631 ms. machine # [ 11.376428] systemd[1]: Created slice Slice /system/static-echo. machine # [ 11.379066] systemd[1]: Listening on static-echo@1.socket. machine # [ 11.381546] systemd[1]: Listening on static-echo@2.socket. machine # [ 11.384468] systemd[1]: Started Getty on tty1. machine # [ 11.387358] systemd[1]: Reached target Login Prompts. machine # [ 11.392444] systemd[1]: Starting prebuilt flakelet service static... machine # [ 11.412916] systemd[1]: Reload requested from client PID 880 ('systemctl') (unit flakelet-boot.service)... machine # [ 11.419416] systemd[1]: Reloading... machine # [ 11.487718] dhcpcd[842]: dhcpcd-10.3.2 starting machine # [ 11.506958] dhcpcd[898]: dev: loaded udev machine # [ 11.509313] dhcpcd[898]: DUID 00:01:00:01:32:27:eb:ac:52:54:00:12:34:56 machine # [ 11.554339] 8021q: 802.1Q VLAN Support v1.8 machine # [ 11.555083] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 11.649497] cfg80211: Loading compiled-in X.509 certificates for regulatory database machine # [ 11.682016] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' machine # [ 11.683419] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' machine # [ 11.688153] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 machine # [ 11.689065] cfg80211: failed to load regulatory.db machine # [ 11.776121] 8021q: adding VLAN 0 to HW filter on device eth0 machine # [ 11.774515] dhcpcd[898]: eth0: waiting for carrier machine # [ 11.780748] dhcpcd[898]: eth0: carrier acquired machine # [ 11.786401] dhcpcd[898]: eth0: IAID 00:12:34:56 machine # [ 11.789273] dhcpcd[898]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 12.095459] systemd[1]: Reloading finished in 679 ms. machine # [ 12.195995] systemd[1]: Started prebuilt flakelet service static. machine # [ 12.233112] systemd[1]: Reload requested from client PID 931 ('systemctl') (unit flakelet-boot.service)... machine # [ 12.241701] systemd[1]: Reloading... machine # [ 12.865610] systemd[1]: Reloading finished in 628 ms. machine # [ 12.942378] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 13.030424] systemd[1]: Starting flakelet test service... machine # [ 13.035448] flakelet[551]: cli: units re-linked machine # [ 13.037196] flakelet[551]: static: units re-linked machine # [ 13.038057] flakelet[551]: web: units re-linked machine # [ 13.041449] systemd[1]: Finished Re-link flakelet services at boot. machine # [ 13.069080] systemd[1]: Starting Reconcile flakelet services with the host configuration... machine # [ 13.083740] systemd[1]: Started flakelet test service. machine # [ 13.122271] systemd[1]: Finished Reconcile flakelet services with the host configuration. machine # [ 13.128530] systemd[1]: Starting Update flakelet service static... machine # [ 13.134276] systemd[1]: Starting Update flakelet service web... machine # [ 13.182119] flakelet[991]: static: using prebuilt artifact /nix/store/i681mnikp0zi79fghryxjffl3amkxnhn-flakelet-static machine # [ 13.191876] flakelet[991]: static: up to date machine # [ 13.194623] systemd[1]: Finished Update flakelet service static. machine # [ 13.199460] flakelet[992]: web: resolving path:/nix/store/1ndj6dy6hwr8inncmsdbwhm9pd6vbdvp-flake.nix machine # [ 13.256585] dhcpcd[898]: eth0: soliciting an IPv6 router machine # [ 13.258901] dhcpcd[898]: eth0: Router Advertisement from fe80::2 machine # [ 13.261440] dhcpcd[898]: eth0: adding address fec0::5054:ff:fe12:3456/64 machine # [ 13.264716] dhcpcd[898]: eth0: adding route to fec0::/64 machine # [ 13.267813] dhcpcd[898]: eth0: adding default route via fe80::2 machine # [ 13.288977] systemd[1]: Started Nix Daemon. machine # [ 13.427408] nix-daemon[1000]: accepted connection from pid 994, user flakelet machine # [ 13.531139] dhcpcd[898]: eth0: rebinding lease of 10.0.2.15 machine # [ 13.580834] dhcpcd[898]: eth0: probing address 10.0.2.15/24 machine # [ 13.584359] flakelet[992]: web: evaluating /nix/store/5021f2kwgs9vhdrqlvahpgzg3fc0adgq-flakelet-driver.nix machine # [ 13.685214] nix-daemon[1000]: accepted connection from pid 1019, user flakelet machine: (finished: waiting for unit web.service, in 14.56 seconds) machine: waiting for unit cli.service machine: (finished: waiting for unit cli.service, in 0.13 seconds) (finished: run the VM test script, in 86.70 seconds) test script finished in 86.76s cleanup kill QemuMachine (pid 91) machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/ymm5c1kb7p2r6331bgcdxijayqhcbvqy-python3-3.14.6/bin/python3.14) (finished: cleanup, in 0.31 seconds)