nixbot

builds

succeeded vm-test-run-flakelet checks.aarch64-linux.vm · build #33 · raw

1tribuchet: building on eliza2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.00 seconds)5Test will time out and terminate in 3600 seconds6run the VM test script7machine: waiting for unit multi-user.target8machine: waiting for the VM to finish booting9machine: starting vm10machine # Disk image does not exist, creating the virtualisation disk image...11machine: QEMU running (pid 45)12machine # Formatting '/build/vm-state-machine/tmp.KuQLVbD9Yu', fmt=raw size=107374182413machine # mke2fs 1.47.4 (6-Mar-2025)14machine # Discarding device blocks: 0/262144 done15machine # Creating filesystem with 262144 4k blocks and 65536 inodes16machine # Filesystem UUID: 11adae6e-999b-4ff0-99c7-12315f938e3e17machine # Superblock backups stored on blocks:18machine # 32768, 98304, 163840, 22937619machine # 20machine # Allocating group tables: 0/8 done21machine # Writing inode tables: 0/8 done22machine # Creating journal (8192 blocks): done23machine # Writing superblocks and filesystem accounting information: 0/8 done24machine # 25machine # Virtualisation disk image created.26machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]27machine # [ 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 202628machine # [ 0.000000] KASLR enabled29machine # [ 0.000000] random: crng init done30machine # [ 0.000000] Machine model: linux,dummy-virt31machine # [ 0.000000] efi: UEFI not found.32machine # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT33machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000013fffffff]34machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x13fdeb740-0x13fdeeebf]35machine # [ 0.000000] Zone ranges:36machine # [ 0.000000] DMA [mem 0x0000000040000000-0x00000000ffffffff]37machine # [ 0.000000] DMA32 empty38machine # [ 0.000000] Normal [mem 0x0000000100000000-0x000000013fffffff]39machine # [ 0.000000] Device empty40machine # [ 0.000000] Movable zone start for each node41machine # [ 0.000000] Early memory node ranges42machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000013fffffff]43machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000013fffffff]44machine # [ 0.000000] cma: Reserved 32 MiB at 0x00000000fe00000045machine # [ 0.000000] psci: probing for conduit method from DT.46machine # [ 0.000000] psci: PSCIv1.3 detected in firmware.47machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs48machine # [ 0.000000] psci: Trusted OS migration not required49machine # [ 0.000000] psci: SMC Calling Convention v1.150machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)51machine # [ 0.000000] percpu: Embedded 76 pages/cpu s186392 r8192 d116712 u31129652machine # [ 0.000000] Detected PIPT I-cache on CPU053machine # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)54machine # [ 0.000000] CPU features: detected: GICv3 CPU interface55machine # [ 0.000000] CPU features: detected: Spectre-v456machine # [ 0.000000] CPU features: detected: Spectre-BHB57machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_3858machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_2359machine # [ 0.000000] alternatives: applying boot alternatives60machine # [ 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=tty061machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/i4amarwnjgkhazjc3n4a2m4axhmy83sx-closure-info/registration", will be passed to user space.62machine # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes63machine # [ 0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)64machine # [ 0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)65machine # [ 0.000000] software IO TLB: area num 4.66machine # [ 0.000000] software IO TLB: mapped [mem 0x00000000fa000000-0x00000000fe000000] (64MB)67machine # [ 0.000000] Fallback order for Node 0: 068machine # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 104857669machine # [ 0.000000] Policy zone: Normal70machine # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off71machine # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=172machine # [ 0.000000] allocated 8388608 bytes of page_ext73machine # [ 0.000000] ftrace: allocating 74754 entries in 294 pages74machine # [ 0.000000] ftrace: allocated 294 pages with 4 groups75machine # [ 0.000000] rcu: Hierarchical RCU implementation.76machine # [ 0.000000] rcu: RCU event tracing is enabled.77machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=4.78machine # [ 0.000000] Trampoline variant of Tasks RCU enabled.79machine # [ 0.000000] Rude variant of Tasks RCU enabled.80machine # [ 0.000000] Tracing variant of Tasks RCU enabled.81machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.82machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=483machine # [ 0.000000] RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4.84machine # [ 0.000000] RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4.85machine # [ 0.000000] RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4.86machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 087machine # [ 0.000000] GICv3: 256 SPIs implemented88machine # [ 0.000000] GICv3: 0 Extended SPIs implemented89machine # [ 0.000000] Root IRQ handler: gic_handle_irq90machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI91machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=092machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a000093machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]94machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @100b10000 (indirect, esz 8, psz 64K, shr 1)95machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @100b20000 (flat, esz 8, psz 64K, shr 1)96machine # [ 0.000000] GICv3: using LPI property table @0x0000000100b4000097machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000100b5000098machine # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.99machine # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns100machine # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).101machine # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns102machine # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns103machine # [ 0.000029] arm-pv: using stolen time PV104machine # [ 0.000427] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)105machine # [ 0.000614] Console: colour dummy device 80x25106machine # [ 0.000621] printk: legacy console [tty0] enabled107machine # [ 0.000798] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)108machine # [ 0.000804] pid_max: default: 32768 minimum: 301109machine # [ 0.000887] LSM: initializing lsm=capability,landlock,yama,bpf,ima110machine # [ 0.001049] landlock: Up and running.111machine # [ 0.001052] Yama: becoming mindful.112machine # [ 0.001509] LSM support for eBPF active113machine # [ 0.001662] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)114machine # [ 0.001720] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)115machine # [ 0.002895] cacheinfo: Unable to detect cache hierarchy for CPU 0116machine # [ 0.003623] rcu: Hierarchical SRCU implementation.117machine # [ 0.003627] rcu: Max phase no-delay instances is 1000.118machine # [ 0.003786] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level119machine # [ 0.005146] fsl-mc MSI: its@8080000 domain created120machine # [ 0.005236] EFI services will not be available.121machine # [ 0.005426] smp: Bringing up secondary CPUs ...122machine # [ 0.006073] Detected PIPT I-cache on CPU1123machine # [ 0.006177] GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000124machine # [ 0.006309] GICv3: CPU1: using allocated LPI pending table @0x0000000100b60000125machine # [ 0.006441] CPU1: Booted secondary processor 0x0000000001 [0xc00fac40]126machine # [ 0.007563] Detected PIPT I-cache on CPU2127machine # [ 0.007678] GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000128machine # [ 0.007815] GICv3: CPU2: using allocated LPI pending table @0x0000000100b70000129machine # [ 0.007949] CPU2: Booted secondary processor 0x0000000002 [0xc00fac40]130machine # [ 0.009043] Detected PIPT I-cache on CPU3131machine # [ 0.009161] GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000132machine # [ 0.009295] GICv3: CPU3: using allocated LPI pending table @0x0000000100b80000133machine # [ 0.009423] CPU3: Booted secondary processor 0x0000000003 [0xc00fac40]134machine # [ 0.009957] smp: Brought up 1 node, 4 CPUs135machine # [ 0.009983] SMP: Total of 4 processors activated.136machine # [ 0.009986] CPU: All CPU(s) started at EL1137machine # [ 0.009994] CPU features: detected: Branch Target Identification138machine # [ 0.009997] CPU features: detected: ARMv8.4 Translation Table Level139machine # [ 0.010000] CPU features: detected: Instruction cache invalidation not required for I/D coherence140machine # [ 0.010004] CPU features: detected: Data cache clean to the PoU not required for I/D coherence141machine # [ 0.010007] CPU features: detected: Common not Private translations142machine # [ 0.010010] CPU features: detected: CRC32 instructions143machine # [ 0.010012] CPU features: detected: Data cache clean to Point of Deep Persistence144machine # [ 0.010015] CPU features: detected: Data cache clean to Point of Persistence145machine # [ 0.010018] CPU features: detected: Data independent timing control (DIT)146machine # [ 0.010021] CPU features: detected: E0PD147machine # [ 0.010023] CPU features: detected: Enhanced Counter Virtualization148machine # [ 0.010026] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)149machine # [ 0.010028] CPU features: detected: Enhanced Virtualization Traps150machine # [ 0.010031] CPU features: detected: Fine Grained Traps151machine # [ 0.010034] CPU features: detected: Generic authentication (architected QARMA5 algorithm)152machine # [ 0.010037] CPU features: detected: RCpc load-acquire (LDAPR)153machine # [ 0.010040] CPU features: detected: LSE atomic instructions154machine # [ 0.010042] CPU features: detected: Privileged Access Never155machine # [ 0.010045] CPU features: detected: PMUv3156machine # [ 0.010047] CPU features: detected: RAS Extension Support157machine # [ 0.010049] CPU features: detected: RASv1p1 Extension Support158machine # [ 0.010052] CPU features: detected: Random Number Generator159machine # [ 0.010054] CPU features: detected: Speculation barrier (SB)160machine # [ 0.010056] CPU features: detected: Stage-2 Force Write-Back161machine # [ 0.010059] CPU features: detected: TLB range maintenance instructions162machine # [ 0.010063] CPU features: detected: Speculative Store Bypassing Safe (SSBS)163machine # [ 0.010262] alternatives: applying system-wide alternatives164machine # [ 0.013136] CPU features: detected: BBM Level 2 without TLB conflict abort165machine # [ 0.013383] Memory: 3910032K/4194304K available (24384K kernel code, 7086K rwdata, 26316K rodata, 4736K init, 1102K bss, 233732K reserved, 32768K cma-reserved)166machine # [ 0.014799] devtmpfs: initialized167machine # [ 0.018378] posixtimers hash table entries: 2048 (order: 3, 32768 bytes, linear)168machine # [ 0.018446] futex hash table entries: 1024 (65536 bytes on 1 NUMA nodes, total 64 KiB, linear).169machine # [ 0.018643] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL170machine # [ 0.018648] 0 pages in range for non-PLT usage171machine # [ 0.018649] 508320 pages in range for PLT usage172machine # [ 0.018770] pinctrl core: initialized pinctrl subsystem173machine # [ 0.019579] DMI not present or invalid.174machine # [ 0.022853] NET: Registered PF_NETLINK/PF_ROUTE protocol family175machine # [ 0.025345] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations176machine # [ 0.025521] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations177machine # [ 0.025742] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations178machine # [ 0.025761] audit: initializing netlink subsys (disabled)179machine # [ 0.026069] audit: type=2000 audit(0.024:1): state=initialized audit_enabled=0 res=1180machine # [ 0.026533] thermal_sys: Registered thermal governor 'fair_share'181machine # [ 0.026536] thermal_sys: Registered thermal governor 'bang_bang'182machine # [ 0.026540] thermal_sys: Registered thermal governor 'step_wise'183machine # [ 0.026543] thermal_sys: Registered thermal governor 'user_space'184machine # [ 0.026545] thermal_sys: Registered thermal governor 'power_allocator'185machine # [ 0.026630] cpuidle: using governor ladder186machine # [ 0.026655] cpuidle: using governor menu187machine # [ 0.026843] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.188machine # [ 0.027066] ASID allocator initialised with 65536 entries189machine # [ 0.028237] Serial: AMBA PL011 UART driver190machine # [ 0.033429] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1191machine # [ 0.033733] printk: console [ttyAMA0] enabled192machine # [ 0.038992] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages193machine # [ 0.038999] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page194machine # [ 0.039002] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages195machine # [ 0.039004] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page196machine # [ 0.039007] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages197machine # [ 0.039010] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page198machine # [ 0.039013] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages199machine # [ 0.039015] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page200machine # [ 0.050324] fbcon: Taking over console201machine # [ 0.050353] ACPI: Interpreter disabled.202machine # [ 0.053023] iommu: Default domain type: Translated203machine # [ 0.053035] iommu: DMA domain TLB invalidation policy: strict mode204machine # [ 0.072071] SCSI subsystem initialized205machine # [ 0.074111] usbcore: registered new interface driver usbfs206machine # [ 0.074258] usbcore: registered new interface driver hub207machine # [ 0.074363] usbcore: registered new device driver usb208machine # [ 0.075311] pps_core: LinuxPPS API ver. 1 registered209machine # [ 0.075323] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>210machine # [ 0.075375] PTP clock support registered211machine # [ 0.075521] EDAC MC: Ver: 3.0.0212machine # [ 0.076256] scmi_core: SCMI protocol bus registered213machine # [ 0.077235] FPGA manager framework214machine # [ 0.079935] vgaarb: loaded215machine # [ 0.080807] clocksource: Switched to clocksource arch_sys_counter216machine # [ 0.081415] VFS: Disk quotas dquot_6.6.0217machine # [ 0.082197] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)218machine # [ 0.083080] netfs: FS-Cache loaded219machine # [ 0.083492] pnp: PnP ACPI: disabled220machine # [ 0.093351] NET: Registered PF_INET protocol family221machine # [ 0.094939] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)222machine # [ 0.150930] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)223machine # [ 0.150987] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)224machine # [ 0.151048] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)225machine # [ 0.151300] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear)226machine # [ 0.151724] TCP: Hash tables configured (established 32768 bind 32768)227machine # [ 0.151859] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear)228machine # [ 0.151922] UDP hash table entries: 2048 (order: 5, 131072 bytes, linear)229machine # [ 0.152011] UDP-Lite hash table entries: 2048 (order: 5, 131072 bytes, linear)230machine # [ 0.152234] NET: Registered PF_UNIX/PF_LOCAL protocol family231machine # [ 0.152311] NET: Registered PF_XDP protocol family232machine # [ 0.152331] PCI: CLS 0 bytes, default 64233machine # [ 0.152700] Trying to unpack rootfs image as initramfs...234machine # [ 0.156958] kvm [1]: HYP mode not available235machine # [ 0.219786] Initialise system trusted keyrings236machine # [ 0.221051] workingset: timestamp_bits=42 max_order=20 bucket_order=0237machine # [ 0.225680] squashfs: version 4.0 (2009/01/31) Phillip Lougher238machine # [ 0.225823] 9p: Installing v9fs 9p2000 file system support239machine # [ 0.242421] Key type asymmetric registered240machine # [ 0.242427] Asymmetric key parser 'x509' registered241machine # [ 0.242554] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)242machine # [ 0.245057] io scheduler mq-deadline registered243machine # [ 0.245066] io scheduler kyber registered244machine # [ 0.254952] pl061_gpio 9030000.pl061: PL061 GPIO chip registered245machine # [ 0.261028] ledtrig-cpu: registered to indicate activity on CPUs246machine # [ 0.261694] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:247machine # [ 0.261715] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000248machine # [ 0.261729] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000249machine # [ 0.261737] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000250machine # [ 0.261776] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits251machine # [ 0.261806] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]252machine # [ 0.261921] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00253machine # [ 0.261932] pci_bus 0000:00: root bus resource [bus 00-ff]254machine # [ 0.261937] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]255machine # [ 0.261942] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]256machine # [ 0.261947] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]257machine # [ 0.262116] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint258machine # [ 0.262923] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint259machine # [ 0.263270] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]260machine # [ 0.263290] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]261machine # [ 0.263339] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]262machine # [ 0.263358] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]263machine # [ 0.264192] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint264machine # [ 0.264542] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]265machine # [ 0.264560] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]266machine # [ 0.264608] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]267machine # [ 0.265488] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint268machine # [ 0.265827] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]269machine # [ 0.265847] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]270machine # [ 0.265890] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]271machine # [ 0.266725] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint272machine # [ 0.267072] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]273machine # [ 0.267091] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]274machine # [ 0.267133] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]275machine # [ 0.267988] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint276machine # [ 0.268336] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]277machine # [ 0.268354] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]278machine # [ 0.268395] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]279machine # [ 0.269311] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint280machine # [ 0.269661] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]281machine # [ 0.269681] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]282machine # [ 0.269723] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]283machine # [ 0.270607] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint284machine # [ 0.270952] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]285machine # [ 0.270976] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]286machine # [ 0.271018] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]287machine # [ 0.271041] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]288machine # [ 0.271970] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint289machine # [ 0.272320] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]290machine # [ 0.272363] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]291machine # [ 0.273266] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint292machine # [ 0.273582] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]293machine # [ 0.273624] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]294machine # [ 0.274325] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint295machine # [ 0.274654] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]296machine # [ 0.275098] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint297machine # [ 0.275524] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]298machine # [ 0.275544] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]299machine # [ 0.275593] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]300machine # [ 0.276484] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint301machine # [ 0.276839] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]302machine # [ 0.276858] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]303machine # [ 0.276900] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]304machine # [ 0.277873] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned305machine # [ 0.277883] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned306machine # [ 0.277889] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned307machine # [ 0.277965] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned308machine # [ 0.278044] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned309machine # [ 0.278125] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned310machine # [ 0.278211] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned311machine # [ 0.278287] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned312machine # [ 0.278362] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned313machine # [ 0.278436] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned314machine # [ 0.278506] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned315machine # [ 0.278584] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned316machine # [ 0.278688] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned317machine # [ 0.278765] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned318machine # [ 0.278793] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned319machine # [ 0.278820] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned320machine # [ 0.278847] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned321machine # [ 0.278876] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned322machine # [ 0.278903] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned323machine # [ 0.278931] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned324machine # [ 0.278961] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned325machine # [ 0.278990] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned326machine # [ 0.279018] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned327machine # [ 0.279057] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned328machine # [ 0.279088] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned329machine # [ 0.279115] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned330machine # [ 0.279143] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned331machine # [ 0.279172] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned332machine # [ 0.279200] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned333machine # [ 0.279227] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned334machine # [ 0.279255] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned335machine # [ 0.279283] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned336machine # [ 0.279310] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned337machine # [ 0.279339] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned338machine # [ 0.279373] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]339machine # [ 0.279381] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]340machine # [ 0.279385] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]341machine # [ 0.281533] pci 0000:00:0a.0: enabling device (0000 -> 0002)342machine # [ 0.298838] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)343machine # [ 0.301840] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)344machine # [ 0.304660] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)345machine # [ 0.307619] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)346machine # [ 0.311359] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)347machine # [ 0.315654] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)348machine # [ 0.318256] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)349machine # [ 0.321006] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)350machine # [ 0.325250] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)351machine # [ 0.329949] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)352machine # [ 0.333209] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)353machine # [ 0.340959] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled354machine # [ 0.343509] msm_serial: driver initialized355machine # [ 0.343693] SuperH (H)SCI(F) driver initialized356machine # [ 0.343770] STM32 USART driver initialized357machine # [ 0.366072] loop: module loaded358machine # [ 0.366326] virtio_blk virtio5: 4/0/0 default/read/poll queues359machine # [ 0.368742] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)360machine # [ 0.371738] megasas: 07.734.00.00-rc1361machine # [ 0.372669] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]362machine # [ 0.377303] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000363machine # [ 0.377326] Intel/Sharp Extended Query Table at 0x0031364machine # [ 0.379188] Using buffer write method365machine # [ 0.379227] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]366machine # [ 0.381249] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000367machine # [ 0.381268] Intel/Sharp Extended Query Table at 0x0031368machine # [ 0.383287] Using buffer write method369machine # [ 0.383305] Concatenating MTD devices:370machine # [ 0.383308] (0): "0.flash"371machine # [ 0.383311] (1): "0.flash"372machine # [ 0.383313] into device "0.flash"373machine # [ 0.660215] Freeing initrd memory: 27052K374machine # [ 0.679030] tun: Universal TUN/TAP device driver, 1.6375machine # [ 0.687119] thunder_xcv, ver 1.0376machine # [ 0.687211] thunder_bgx, ver 1.0377machine # [ 0.687274] nicpf, ver 1.0378machine # [ 0.688706] e1000: Intel(R) PRO/1000 Network Driver379machine # [ 0.688716] e1000: Copyright (c) 1999-2006 Intel Corporation.380machine # [ 0.688789] e1000e: Intel(R) PRO/1000 Network Driver381machine # [ 0.688801] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.382machine # [ 0.688894] igb: Intel(R) Gigabit Ethernet Network Driver383machine # [ 0.688903] igb: Copyright (c) 2007-2014 Intel Corporation.384machine # [ 0.688965] igbvf: Intel(R) Gigabit Virtual Function Network Driver385machine # [ 0.688974] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.386machine # [ 0.689333] sky2: driver version 1.30387machine # [ 0.693869] usbcore: registered new interface driver usb-storage388machine # [ 0.694109] ehci-pci 0000:00:0a.0: EHCI Host Controller389machine # [ 0.694189] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1390machine # [ 0.694204] usbcore: registered new interface driver usbserial_generic391machine # [ 0.694265] usbserial: USB Serial support registered for generic392machine # [ 0.694682] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000393machine # [ 0.695811] hv_vmbus: registering driver hyperv_keyboard394machine # [ 0.698143] rtc-pl031 9010000.pl031: registered as rtc0395machine # [ 0.698193] rtc-pl031 9010000.pl031: setting system clock to 2026-08-31T07:37:06 UTC (1788161826)396machine # [ 0.698980] i2c_dev: i2c /dev entries driver397machine # [ 0.706362] sdhci: Secure Digital Host Controller Interface driver398machine # [ 0.706375] sdhci: Copyright(c) Pierre Ossman399machine # [ 0.707069] Synopsys Designware Multimedia Card Interface Driver400machine # [ 0.708030] sdhci-pltfm: SDHCI platform and OF driver helper401machine # [ 0.709001] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00402machine # [ 0.710000] hub 1-0:1.0: USB hub found403machine # [ 0.710059] hub 1-0:1.0: 6 ports detected404machine # [ 0.712385] hid: raw HID events driver (C) Jiri Kosina405machine # [ 0.713223] usbcore: registered new interface driver usbhid406machine # [ 0.713232] usbhid: USB HID core driver407machine # [ 0.741602] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available408machine # [ 0.746504] drop_monitor: Initializing network drop monitor service409machine # [ 0.746900] NET: Registered PF_INET6 protocol family410machine # [ 0.749389] Segment Routing with IPv6411machine # [ 0.749428] In-situ OAM (IOAM) with IPv6412machine # [ 0.749500] NET: Registered PF_PACKET protocol family413machine # [ 0.749880] 9pnet: Installing 9P2000 support414machine # [ 0.756202] Key type dns_resolver registered415machine # [ 0.774420] registered taskstats version 1416machine # [ 0.774946] Loading compiled-in X.509 certificates417machine # [ 0.796729] Demotion targets for Node 0: null418machine # [ 0.797026] Key type .fscrypt registered419machine # [ 0.797035] Key type fscrypt-provisioning registered420machine # [ 0.797247] ima: No TPM chip found, activating TPM-bypass!421machine # [ 0.797274] ima: Allocated hash algorithm: sha1422machine # [ 0.797324] ima: No architecture policies found423machine # [ 0.798859] input: gpio-keys as /devices/platform/gpio-keys/input/input0424machine # [ 0.831902] clk: Disabling unused clocks425machine # [ 0.831936] PM: genpd: Disabling unused power domains426machine # [ 0.837487] Freeing unused kernel memory: 4736K427machine # [ 0.837751] Run /init as init process428machine # [ 0.880401] systemd[1]: Successfully made /usr/ read-only.429machine # [ 0.964937] usb 1-1: new high-speed USB device number 2 using ehci-pci430machine # [ 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/input1431machine # [ 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/input0432machine # [ 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)433machine # [ 1.215568] systemd[1]: Detected virtualization qemu.434machine # [ 1.215644] systemd[1]: Detected architecture arm64.435machine # [ 1.215658] systemd[1]: Running in initrd.436machine # [ 1.216519] systemd[1]: Initializing machine ID from random generator.437machine # [ 1.216937] systemd[1]: Hostname set to <machine>.438machine # [ 1.324892] usb 1-2: new high-speed USB device number 3 using ehci-pci439machine # [ 1.446722] systemd[1]: bpf-restrict-fs: LSM BPF program attached440machine # [ 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/input2441machine # [ 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/input0442machine # [ 1.539193] systemd[1]: Queued start job for default target Initrd Default Target.443machine # [ 1.568585] systemd[1]: Created slice Slice /system/modprobe.444machine # [ 1.569038] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.445machine # [ 1.569086] systemd[1]: Expecting device /dev/disk/by-label/nixos...446machine # [ 1.569122] systemd[1]: Reached target Path Units.447machine # [ 1.569144] systemd[1]: Reached target Slice Units.448machine # [ 1.569166] systemd[1]: Reached target Swaps.449machine # [ 1.569192] systemd[1]: Reached target Timer Units.450machine # [ 1.569413] systemd[1]: Listening on D-Bus System Message Bus Socket.451machine # [ 1.569632] systemd[1]: Listening on Journal Socket (/dev/log).452machine # [ 1.569839] systemd[1]: Listening on Journal Sockets.453machine # [ 1.570034] systemd[1]: Listening on udev Control Socket.454machine # [ 1.570152] systemd[1]: Listening on udev Kernel Socket.455machine # [ 1.570177] systemd[1]: Reached target Socket Units.456machine # [ 1.572459] systemd[1]: Starting Create List of Static Device Nodes...457machine # [ 1.574776] systemd[1]: Starting Load Kernel Module 9pnet_virtio...458machine # [ 1.574877] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs459machine # [ 1.577245] systemd[1]: Mounting Kernel Configuration File System...460machine # [ 1.603456] systemd[1]: Starting Journal Service...461machine # [ 1.605748] systemd[1]: Starting Load Kernel Modules...462machine # [ 1.605873] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os463machine # [ 1.609460] systemd[1]: Starting Coldplug All udev Devices...464machine # [ 1.611412] systemd[1]: Finished Create List of Static Device Nodes.465machine # [ 1.612575] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.466machine # [ 1.614722] systemd[1]: Finished Load Kernel Module 9pnet_virtio.467machine # [ 1.615464] systemd[1]: Mounted Kernel Configuration File System.468machine # [ 1.617293] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...469machine # [ 1.633954] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.470machine # [ 1.638419] systemd[1]: Starting Create Static Device Nodes in /dev...471machine # [ 1.654372] systemd-journald[94]: Collecting audit messages is disabled.472machine # [ 1.663312] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.473machine # [ 1.663795] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev474machine # [ 1.671573] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0475machine # [ 1.671898] [drm] features: -virgl +edid -resource_blob -host_visible476machine # [ 1.671905] [drm] features: -context_init477machine # [ 1.673488] [drm] number of scanouts: 1478machine # [ 1.673512] [drm] number of cap sets: 0479machine # [ 1.677271] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic480machine # [ 1.677306] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0481machine # [ 1.680643] systemd[1]: Finished Create Static Device Nodes in /dev.482machine # [ 1.681070] systemd[1]: Reached target Preparation for Local File Systems.483machine # [ 1.681106] systemd[1]: Reached target Local File Systems.484machine # [ 1.686339] systemd[1]: Starting Rule-based Manager for Device Events and Files...485machine # [ 1.689830] Console: switching to colour frame buffer device 160x50486machine # [ 1.697909] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device487machine # [ 1.710249] systemd[1]: Finished Load Kernel Modules.488machine # [ 1.715676] systemd[1]: Starting Apply Kernel Variables...489machine # [ 1.734498] systemd[1]: Finished Apply Kernel Variables.490machine # [ 1.746309] systemd[1]: Started Journal Service.491machine # [ 1.741624] systemd-modules-load[95]: Using 4 probe threads492machine # [ 1.745607] systemd-modules-load[95]: Module 'virtio_balloon' is built in493machine # [ 1.749331] systemd-modules-load[95]: Module 'virtio_console' is built in494machine # [ 1.751099] systemd-modules-load[95]: Module 'virtio_rng' is built in495machine # [ 1.752662] systemd-modules-load[95]: Inserted module 'dm_mod'496machine # [ 1.754049] systemd-modules-load[95]: Inserted module 'virtio_gpu'497machine # [ 1.755499] systemd[1]: Starting Create System Files and Directories...498machine # [ 1.757509] systemd-udevd[105]: Using default interface naming scheme 'v261'.499machine # [ 1.773700] systemd[1]: Finished Create System Files and Directories.500machine # [ 1.782215] systemd[1]: Started Rule-based Manager for Device Events and Files.501machine # [ 1.801338] systemd[1]: Starting Virtual Console Setup...502machine # [ 1.852857] systemd-vconsole-setup[131]: Configuration of first virtual console was skipped, ignoring remaining ones.503machine # [ 1.858064] systemd[1]: Finished Virtual Console Setup.504machine # [ 2.285123] systemd[1]: Finished Coldplug All udev Devices.505machine # [ 2.287630] systemd[1]: Reached target System Initialization.506machine # [ 2.290252] systemd[1]: Reached target Basic System.507machine # [ 2.463271] (udev-worker)[135]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.508machine # [ 2.469724] (udev-worker)[135]: Network interface NamePolicy= disabled on kernel command line.509machine # [ 2.477288] (udev-worker)[138]: Network interface NamePolicy= disabled on kernel command line.510machine # [ 2.485410] systemd[1]: Found device /dev/disk/by-label/nixos.511machine # [ 2.487499] systemd[1]: Reached target Initrd Root Device.512machine # [ 2.492416] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...513machine # [ 2.546405] systemd-fsck[153]: nixos: clean, 12/65536 files, 13019/262144 blocks514machine # [ 2.553075] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.515machine # [ 2.612437] systemd[1]: Mounting /sysroot...516machine # [ 2.681156] EXT4-fs (vda): mounted filesystem 11adae6e-999b-4ff0-99c7-12315f938e3e r/w with ordered data mode. Quota mode: none.517machine # [ 2.680934] systemd[1]: Mounted /sysroot.518machine # [ 2.683060] systemd[1]: Reached target Initrd Root File System.519machine # [ 2.687640] systemd[1]: Mounting /sysroot/nix/.ro-store...520machine # [ 2.690595] systemd[1]: Mounting /sysroot/run...521machine # [ 2.696190] systemd[1]: Mounting /sysroot/tmp/shared...522machine # [ 2.708533] systemd[1]: Mounting /sysroot/tmp/xchg...523machine # [ 2.711208] systemd[1]: Starting Mountpoints Configured in the Real Root...524machine # [ 2.717580] systemd[1]: Starting rw-sysroot-nix-store.service...525machine # [ 2.740421] systemd-sysroot-fstab-check[165]: /sysroot should be mounted in the initrd, will request daemon-reload.526machine # [ 2.748493] systemd[1]: Mounted /sysroot/run.527machine # [ 2.749572] systemd[1]: Mounted /sysroot/tmp/shared.528machine # [ 2.750704] systemd[1]: Mounted /sysroot/tmp/xchg.529machine # [ 2.751733] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.530machine # [ 2.753314] systemd[1]: Finished rw-sysroot-nix-store.service.531machine # [ 2.754537] systemd[1]: Mounted /sysroot/nix/.ro-store.532machine # [ 2.757282] systemd[1]: Reload requested from client PID 165 ('systemd-sysroot') (unit initrd-parse-etc.service)...533machine # [ 2.759399] systemd[1]: Reloading...534machine # [ 2.853095] systemd[1]: Reloading finished in 95 ms.535machine # [ 2.900919] systemd-sysroot-fstab-check[165]: Requesting initrd-fs.target/start/replace...536machine # [ 2.904222] systemd-sysroot-fstab-check[165]: Requesting swap.target/start/replace...537machine # [ 2.907268] systemd[1]: Starting rw-sysroot-nix-store.service...538machine # [ 2.909490] systemd[1]: initrd-parse-etc.service: Deactivated successfully.539machine # [ 2.920610] systemd[1]: Finished Mountpoints Configured in the Real Root.540machine # [ 2.922255] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.541machine # [ 2.929421] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.542machine # [ 2.931398] systemd[1]: Finished rw-sysroot-nix-store.service.543machine # [ 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 directory544machine # [ 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 directory545machine # [ 3.070523] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.546machine # [ 3.071635] systemd[1]: Stopped Virtual Console Setup.547machine # [ 3.072495] systemd[1]: Stopping Virtual Console Setup...548machine # [ 3.073261] systemd[1]: Starting Virtual Console Setup...549machine # [ 3.078154] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.550machine # [ 3.079424] systemd[1]: Stopped Virtual Console Setup.551machine # [ 3.080861] systemd[1]: Starting Virtual Console Setup...552machine # [ 3.116690] systemd-vconsole-setup[194]: Configuration of first virtual console was skipped, ignoring remaining ones.553machine # [ 3.119051] systemd[1]: Finished Virtual Console Setup.554machine # [ 3.611655] systemd[1]: Mounting /sysroot/nix/store...555machine # [ 3.692932] systemd[1]: Mounted /sysroot/nix/store.556machine # [ 3.695174] systemd[1]: Reached target Initrd File Systems.557machine # [ 3.697657] systemd[1]: Starting Find NixOS closure...558machine # [ 3.700480] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...559machine # [ 3.740898] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.560machine # [ 3.744490] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.561machine # [ 3.761620] systemd[1]: Finished Find NixOS closure.562machine # [ 3.764004] systemd[1]: Reached target Initrd Default Target.563machine # [ 3.766524] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...564machine # [ 3.816513] systemd[1]: Stopped target Initrd Default Target.565machine # [ 3.819058] systemd[1]: Stopped target Basic System.566machine # [ 3.821335] systemd[1]: Stopped target Initrd Root Device.567machine # [ 3.823690] systemd[1]: Stopped target Path Units.568machine # [ 3.825871] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.569machine # [ 3.829077] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.570machine # [ 3.832332] systemd[1]: Stopped target Slice Units.571machine # [ 3.834477] systemd[1]: Stopped target Socket Units.572machine # [ 3.836703] systemd[1]: Stopped target System Initialization.573machine # [ 3.839159] systemd[1]: Stopped target Swaps.574machine # [ 3.841168] systemd[1]: Stopped target Timer Units.575machine # [ 3.843300] systemd[1]: dbus.socket: Deactivated successfully.576machine # [ 3.849025] systemd[1]: Closed D-Bus System Message Bus Socket.577machine # [ 3.851443] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.578machine # [ 3.856558] systemd[1]: Stopped Find NixOS closure.579machine # [ 3.858828] systemd[1]: Starting Load Kernel Module 9pnet_virtio...580machine # [ 3.862626] systemd[1]: Starting rw-sysroot-nix-store.service...581machine # [ 3.864723] systemd[1]: systemd-sysctl.service: Deactivated successfully.582machine # [ 3.866889] systemd[1]: Stopped Apply Kernel Variables.583machine # [ 3.868698] systemd[1]: systemd-modules-load.service: Deactivated successfully.584machine # [ 3.870838] systemd[1]: Stopped Load Kernel Modules.585machine # [ 3.872427] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.586machine # [ 3.874629] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.587machine # [ 3.876741] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.588machine # [ 3.878646] systemd[1]: Stopped Create System Files and Directories.589machine # [ 3.880326] systemd[1]: Stopped target Local File Systems.590machine # [ 3.881831] systemd[1]: Stopped target Preparation for Local File Systems.591machine # [ 3.883542] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.592machine # [ 3.885306] systemd[1]: Stopped Coldplug All udev Devices.593machine # [ 3.886609] systemd[1]: Stopping Rule-based Manager for Device Events and Files...594machine # [ 3.888272] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.595machine # [ 3.889888] systemd[1]: Stopped Virtual Console Setup.596machine # [ 3.891043] systemd[1]: initrd-cleanup.service: Deactivated successfully.597machine # [ 3.892506] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.598machine # [ 3.893884] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.599machine # [ 3.895372] systemd[1]: Finished Load Kernel Module 9pnet_virtio.600machine # [ 3.896667] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.601machine # [ 3.898106] systemd[1]: Finished rw-sysroot-nix-store.service.602machine # [ 3.899264] systemd[1]: systemd-udevd.service: Deactivated successfully.603machine # [ 3.900602] systemd[1]: Stopped Rule-based Manager for Device Events and Files.604machine # [ 3.901989] systemd[1]: systemd-udevd.service: Consumed 2.201s CPU time over 2.201s wall clock time, 30.8M memory peak.605machine # [ 3.903891] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.606machine # [ 3.905312] systemd[1]: Closed udev Control Socket.607machine # [ 3.906262] systemd[1]: Starting Cleanup udev Database...608machine # [ 3.907257] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.609machine # [ 3.908659] systemd[1]: Stopped Create Static Device Nodes in /dev.610machine # [ 3.909772] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.611machine # [ 3.911169] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.612machine # [ 3.912428] systemd[1]: kmod-static-nodes.service: Deactivated successfully.613machine # [ 3.913678] systemd[1]: Stopped Create List of Static Device Nodes.614machine # [ 4.003057] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.615machine # [ 4.007488] systemd[1]: Finished Cleanup udev Database.616machine # [ 4.010854] systemd[1]: Reached target Switch Root.617machine # [ 4.013062] systemd[1]: Starting NixOS Activation...618machine # [ 4.309201] initrd-nixos-activation-start[221]: booting system configuration /nix/store/6jjral78h0pim0k25ahd9qxi06rwmd23-nixos-system-machine-test619machine # [ 4.413519] initrd-nixos-activation-start[221]: running activation script...620machine # [ 4.938418] initrd-nixos-activation-start[244]: setting up /etc...621machine # [ 5.301720] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.622machine # [ 5.305259] systemd[1]: Finished NixOS Activation.623machine # [ 5.307377] systemd[1]: Starting Switch Root...624machine # [ 5.342127] systemd[1]: Switching root.625machine # [ 5.491122] systemd-journald[94]: Received SIGTERM from PID 1 (systemd).626machine # [ 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)627machine # [ 6.214855] systemd[1]: Detected virtualization qemu.628machine # [ 6.214946] systemd[1]: Detected architecture arm64.629machine # [ 6.215130] systemd[1]: Detected first boot.630machine # [ 6.222276] systemd[1]: Initializing machine ID from random generator.631machine # [ 6.489252] systemd[1]: bpf-restrict-fs: LSM BPF program attached632machine # [ 6.651991] systemd[1]: Applying preset policy.633machine # [ 7.157762] systemd[1]: Populated /etc with preset unit settings.634machine # [ 7.696752] systemd[1]: initrd-switch-root.service: Deactivated successfully.635machine # [ 7.697067] systemd[1]: Stopped initrd-switch-root.service.636machine # [ 7.698497] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.637machine # [ 7.707126] systemd[1]: Created slice Slice /system/getty.638machine # [ 7.711096] systemd[1]: Created slice User and Session Slice.639machine # [ 7.711707] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.640machine # [ 7.712685] systemd[1]: Started Forward Password Requests to Wall Directory Watch.641machine # [ 7.713498] systemd[1]: Expecting device /dev/hvc0...642machine # [ 7.714640] systemd[1]: Expecting device /dev/ttyAMA0...643machine # [ 7.715778] systemd[1]: Reached target Local Encrypted Volumes.644machine # [ 7.716928] systemd[1]: Reached target flakelet contract providers ready.645machine # [ 7.718046] systemd[1]: Stopped target initrd-fs.target.646machine # [ 7.719147] systemd[1]: Stopped target initrd-root-fs.target.647machine # [ 7.720218] systemd[1]: Stopped target initrd-switch-root.target.648machine # [ 7.721354] systemd[1]: Reached target Virtual Machines and Containers.649machine # [ 7.722517] systemd[1]: Reached target Path Units.650machine # [ 7.723609] systemd[1]: Reached target Remote File Systems.651machine # [ 7.724670] systemd[1]: Reached target Slice Units.652machine # [ 7.725761] systemd[1]: Reached target Swaps.653machine # [ 7.731754] systemd[1]: Listening on Query the User Interactively for a Password.654machine # [ 7.738826] systemd[1]: Listening on Process Core Dump Socket.655machine # [ 7.744465] systemd[1]: Listening on Credential Encryption/Decryption.656machine # [ 7.750302] systemd[1]: Listening on Factory Reset Management.657machine # [ 7.751735] systemd[1]: Listening on Hostname Service Socket.658machine # [ 7.763755] systemd[1]: Starting Journal Log Access Socket...659machine # [ 7.765601] systemd[1]: Listening on Journal Audit Socket.660machine # [ 7.771239] systemd[1]: Listening on Console Output Muting Service Socket.661machine # [ 7.772891] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.662machine # [ 7.773910] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os663machine # [ 7.774828] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki664machine # [ 7.786928] systemd[1]: Listening on Disk Repartitioning Service Socket.665machine # [ 7.787575] systemd[1]: Listening on udev Control Socket.666machine # [ 7.788072] systemd[1]: Listening on udev Varlink Socket.667machine # [ 7.797083] systemd[1]: Mounting Huge Pages File System...668machine # [ 7.807111] systemd[1]: Mounting POSIX Message Queue File System...669machine # [ 7.835096] systemd[1]: Mounting Kernel Debug File System...670machine # [ 7.843117] systemd[1]: Mounting Kernel Trace File System...671machine # [ 7.850850] systemd[1]: Starting Create List of Static Device Nodes...672machine # [ 7.859841] systemd[1]: Starting Load Kernel Module 9pnet_virtio...673machine # [ 7.861070] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs674machine # [ 7.878909] systemd[1]: Mounting Kernel Configuration File System...675machine # [ 7.879599] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm676machine # [ 7.880540] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore677machine # [ 7.921504] systemd[1]: Starting Load Kernel Module fuse...678machine # [ 7.922731] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67679machine # [ 7.939506] systemd[1]: Starting Journal Service...680machine # [ 7.950130] systemd[1]: Starting Load Kernel Modules...681machine # [ 7.973222] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...682machine # [ 7.982922] systemd[1]: Starting Remount Root and Kernel File Systems...683machine # [ 7.984026] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os684machine # [ 7.995298] systemd[1]: Starting Coldplug All udev Devices...685machine # [ 8.004778] systemd[1]: Listening on Journal Log Access Socket.686machine # [ 8.006837] systemd[1]: Mounted Huge Pages File System.687machine # [ 8.007563] systemd[1]: Mounted POSIX Message Queue File System.688machine # [ 8.008318] systemd[1]: Mounted Kernel Debug File System.689machine # [ 8.009391] systemd[1]: Mounted Kernel Trace File System.690machine # [ 8.010815] systemd[1]: Finished Create List of Static Device Nodes.691machine # [ 8.012449] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.692machine # [ 8.013736] systemd[1]: Finished Load Kernel Module 9pnet_virtio.693machine # [ 8.014866] systemd[1]: Mounted Kernel Configuration File System.694machine # [ 8.024676] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...695machine # [ 8.058764] systemd[1]: Finished Load Kernel Modules.696machine # [ 8.064240] systemd[1]: Starting Firewall...697machine # [ 8.065331] fuse: init (API version 7.45)698machine # [ 8.075501] systemd[1]: Starting Apply Kernel Variables...699machine # [ 8.076581] systemd[1]: modprobe@fuse.service: Deactivated successfully.700machine # [ 8.077426] systemd[1]: Finished Load Kernel Module fuse.701machine # [ 8.087663] EXT4-fs (vda): re-mounted 11adae6e-999b-4ff0-99c7-12315f938e3e.702machine # [ 8.089945] systemd-journald[315]: Collecting audit messages is enabled.703machine # [ 8.091306] systemd[1]: Mounting FUSE Control File System...704machine # [ 8.098945] systemd[1]: Finished Remount Root and Kernel File Systems.705machine # [ 8.100516] systemd[1]: Listening on Disk Image Download Service Socket.706machine # [ 8.101854] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore707machine # [ 8.113248] systemd[1]: Starting Load/Save OS Random Seed...708machine # [ 8.115246] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os709machine # [ 8.119404] systemd[1]: Started Journal Service.710machine # [ 8.112364] systemd[1]: Queued start job for default target Multi-User System.711machine # [ 8.134072] systemd[1]: systemd-journald.service: Deactivated successfully.712machine # [ 8.143298] systemd-modules-load[316]: Using 2 probe threads713machine # [ 8.151756] systemd-modules-load[316]: Module 'atkbd' is built in714machine # [ 8.159751] systemd-modules-load[316]: Module 'loop' is built in715machine # [ 8.175378] systemd[1]: Starting Flush Journal to Persistent Storage...716machine # [ 8.183882] systemd-oomd[318]: No swap; memory pressure usage will be degraded717machine # [ 8.204958] systemd-journald[315]: Received client request to flush runtime journal.718machine # [ 8.252902] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.719machine # [ 8.257229] systemd[1]: Mounted FUSE Control File System.720machine # [ 8.261372] systemd[1]: Finished Apply Kernel Variables.721machine # [ 8.264673] systemd[1]: Finished Load/Save OS Random Seed.722machine # [ 8.268392] systemd[1]: Reached target First Boot Complete.723machine # [ 8.271765] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.724machine # [ 8.282609] systemd[1]: Starting Create Static Device Nodes in /dev...725machine # [ 8.285012] systemd[1]: Finished Flush Journal to Persistent Storage.726machine # [ 8.298925] systemd[1]: Finished Create Static Device Nodes in /dev.727machine # [ 8.300197] systemd[1]: Reached target Preparation for Local File Systems.728machine # [ 8.303587] systemd[1]: Starting Rule-based Manager for Device Events and Files...729machine # [ 8.387976] systemd-udevd[356]: Using default interface naming scheme 'v261'.730machine # [ 8.499822] systemd[1]: Started Rule-based Manager for Device Events and Files.731machine # [ 8.702066] systemd[1]: Mounting /run/wrappers...732machine # [ 8.751471] systemd[1]: Finished Coldplug All udev Devices.733machine # [ 8.787055] systemd[1]: Mounted /run/wrappers.734machine # [ 8.789588] systemd[1]: Reached target Local File Systems.735machine # [ 8.796175] systemd[1]: Listening on Boot Loader Control Service Socket.736machine # [ 8.800581] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs737machine # [ 8.808237] systemd[1]: Starting register-nix-paths.service...738machine # [ 8.813308] systemd[1]: Starting Create SUID/SGID Wrappers...739machine # [ 8.818275] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.740machine # [ 8.829478] systemd[1]: Starting Save Transient machine-id to Disk...741machine # [ 8.836420] systemd[1]: Starting Create System Files and Directories...742machine # [ 8.900084] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.743machine # [ 8.907558] systemd[1]: Finished Save Transient machine-id to Disk.744machine # [ 8.915452] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.745machine # [ 8.953298] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.746machine # [ 8.960949] (udev-worker)[421]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.747machine # [ 8.965874] (udev-worker)[421]: Network interface NamePolicy= disabled on kernel command line.748machine # [ 8.969263] (udev-worker)[416]: Network interface NamePolicy= disabled on kernel command line.749machine # [ 8.986546] systemd[1]: Finished Create System Files and Directories.750machine # [ 8.994196] systemd[1]: Starting Rebuild Journal Catalog...751machine # [ 8.999374] systemd[1]: Starting Record System Boot/Shutdown in UTMP...752machine # [ 9.024103] systemd[1]: Condition check resulted in Virtio network device being skipped.753machine # [ 9.028032] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore754machine # [ 9.032987] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.755machine # [ 9.038494] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67756machine # [ 9.045196] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore757machine # [ 9.050492] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os758machine # [ 9.053476] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os759machine # [ 9.059522] systemd[1]: Finished Record System Boot/Shutdown in UTMP.760machine # [ 9.109300] mousedev: PS/2 mouse device common for all mice761machine # [ 9.106499] systemd[1]: Finished Rebuild Journal Catalog.762machine # [ 9.110455] systemd[1]: Starting Update is Completed...763machine # [ 9.166336] systemd[1]: Finished Update is Completed.764machine # [ 9.403266] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.765machine # [ 9.404644] systemd[1]: Finished Create SUID/SGID Wrappers.766machine # [ 9.450135] systemd[1]: Finished Firewall.767machine # [ 9.608441] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input3768machine # [ 9.643304] systemd[1]: Finished register-nix-paths.service.769machine # [ 9.650626] systemd[1]: Reached target System Initialization.770machine # [ 9.651779] systemd[1]: Started Discard unused filesystem blocks once a week.771machine # [ 9.653535] systemd[1]: Started Daily Cleanup of Temporary Directories.772machine # [ 9.655840] systemd[1]: Reached target Timer Units.773machine # [ 9.657931] systemd[1]: Listening on D-Bus System Message Bus Socket.774machine # [ 9.659154] systemd[1]: Listening on Nix Daemon Socket.775machine # [ 9.659928] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.776machine # [ 9.663670] systemd[1]: Reached target Socket Units.777machine # [ 9.664808] systemd[1]: Reached target Basic System.778machine # [ 9.665540] systemd[1]: Started backdoor.service.779machine # [ 9.666268] systemd[1]: Starting Re-link flakelet services at boot...780machine # [ 9.670419] systemd[1]: Starting Import lastlog data into lastlog2 database...781machine # [ 9.683192] systemd[1]: Starting Name Service Cache Daemon (nsncd)...782machine # [ 9.687871] systemd[1]: Starting Post-Boot Actions...783machine # [ 9.693960] systemd[1]: Started Reset console on configuration changes.784machine # [ 9.700524] systemd[1]: Starting resolvconf update...785machine # [ 9.722296] systemd[1]: Starting D-Bus System Message Bus...786machine # [ 9.727993] systemd[1]: Starting Virtual Console Setup...787machine # [ 9.743803] systemd[1]: Finished Post-Boot Actions.788machine # [ 9.749199] systemd[1]: Finished Re-link flakelet services at boot.789machine # [ 9.755567] systemd[1]: Starting Reconcile flakelet services with the host configuration...790machine # connecting to host...791machine # [ 9.779931] systemd[1]: Finished Import lastlog data into lastlog2 database.792machine # [ 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"793machine # [ 9.793207] systemd[1]: Started Name Service Cache Daemon (nsncd).794machine # [ 9.796725] systemd[1]: Reached target Host and Network Name Lookups.795machine: Guest shell says: b'Spawning backdoor root shell...\n'796machine # [ 9.800531] systemd[1]: Reached target User and Group Name Lookups.797machine # [ 9.803939] systemd[1]: Starting User Login Management...798machine: connected to guest root shell799machine # [ 9.807543] systemd[1]: Finished Reconcile flakelet services with the host configuration.800machine: (connecting took 10.29 seconds)801machine: (finished: waiting for the VM to finish booting, in 10.79 seconds)802machine # [ 9.860452] dbus-broker-launch[568]: Looking up NSS user entry for 'systemd-timesync'...803machine # [ 9.880056] systemd-logind[596]: New seat seat0.804machine # [ 9.882759] systemd-logind[596]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)805machine # [ 9.884123] systemd-logind[596]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)806machine # [ 9.885471] systemd-logind[596]: Watching system buttons on /dev/input/event0 (gpio-keys)807machine # [ 9.929269] systemd[1]: Started User Login Management.808machine # [ 9.932373] systemd[1]: Stopped target Host and Network Name Lookups.809machine # [ 9.935222] systemd[1]: Stopping Host and Network Name Lookups...810machine # [ 9.940336] dbus-broker-launch[568]: NSS returned no entry for 'systemd-timesync'811machine # [ 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"812machine # [ 9.944681] systemd[1]: Stopped target User and Group Name Lookups.813machine # [ 9.945758] systemd[1]: Stopping User and Group Name Lookups...814machine # [ 9.947264] systemd[1]: Starting linger-users.service...815machine # [ 9.948810] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...816machine # [ 9.950357] systemd[1]: nscd.service: Deactivated successfully.817machine # [ 9.951780] systemd[1]: Stopped Name Service Cache Daemon (nsncd).818machine # [ 9.967581] systemd[1]: Starting Name Service Cache Daemon (nsncd)...819machine # [ 9.974964] systemd[1]: Started D-Bus System Message Bus.820machine # [ 10.001343] dbus-broker-launch[568]: Ready821machine # [ 10.003967] systemd[1]: linger-users.service: Deactivated successfully.822machine # [ 10.005884] systemd[1]: Finished linger-users.service.823machine # [ 10.009393] systemd[1]: Started Name Service Cache Daemon (nsncd).824machine # [ 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"825machine # [ 10.014218] systemd[1]: Reached target Host and Network Name Lookups.826machine # [ 10.015223] systemd[1]: Reached target User and Group Name Lookups.827machine # [ 10.026193] systemd[1]: Finished resolvconf update.828machine # [ 10.028107] systemd[1]: Reached target Preparation for Network.829machine # [ 10.033058] systemd[1]: Starting DHCP Client...830machine # [ 10.037302] systemd[1]: Starting Address configuration of eth1...831machine # [ 10.041735] systemd[1]: Starting Extra networking commands....832machine # [ 10.128557] network-addresses-eth1-start[678]: adding address 192.168.1.1/24... done833machine # [ 10.140624] network-addresses-eth1-start[678]: adding address 2001:db8:1::1/64... done834machine # [ 10.157425] systemd[1]: Finished Address configuration of eth1.835machine # [ 10.171400] dhcpcd[686]: dhcpcd-10.3.2 starting836machine # [ 10.182046] dhcpcd[731]: dev: loaded udev837machine # [ 10.207926] systemd[1]: Finished Extra networking commands..838machine # [ 10.210550] systemd[1]: Reached target Network.839machine # [ 10.212589] systemd[1]: Starting Permit User Sessions...[ 10.217500] 8021q: 802.1Q VLAN Support v1.8840machine # 841machine # [ 10.217924] 8021q: adding VLAN 0 to HW filter on device eth1842machine # [ 10.219216] systemd[1]: Starting Update flakelet service static...843machine # [ 10.223284] systemd[1]: Starting Update flakelet service web...844machine # [ 10.247316] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.845machine # [ 10.251238] systemd-vconsole-setup[569]: Configuration of first virtual console was skipped, ignoring remaining ones.846machine # [ 10.255588] systemd[1]: Finished Virtual Console Setup.847machine # [ 10.264176] systemd[1]: Finished Permit User Sessions.848machine # [ 10.269299] systemd[1]: Started Getty on tty1.849machine # [ 10.272042] flakelet[748]: web: resolving path:/nix/store/1ndj6dy6hwr8inncmsdbwhm9pd6vbdvp-flake.nix850machine # [ 10.274961] flakelet[747]: static: using prebuilt artifact /nix/store/i681mnikp0zi79fghryxjffl3amkxnhn-flakelet-static851machine # [ 10.278518] systemd[1]: Reached target Login Prompts.852machine # [ 10.281499] flakelet[747]: static: activating generation 1853machine # [ 10.290989] cfg80211: Loading compiled-in X.509 certificates for regulatory database854machine # [ 10.294629] systemd[1]: Reload requested from client PID 753 ('systemctl') (unit flakelet-static.service)...855machine # [ 10.296924] systemd[1]: Reloading...856machine # [ 10.322284] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'857machine # [ 10.322804] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'858machine # [ 10.325632] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2859machine # [ 10.325976] cfg80211: failed to load regulatory.db860machine # [ 10.401205] 8021q: adding VLAN 0 to HW filter on device eth0861machine # [ 10.397381] dhcpcd[731]: eth0: waiting for carrier862machine # [ 10.399162] dhcpcd[731]: eth0: carrier acquired863machine # [ 10.410877] dhcpcd[731]: DUID 00:01:00:01:32:27:eb:ac:52:54:00:12:34:56864machine # [ 10.412167] dhcpcd[731]: eth0: IAID 00:12:34:56865machine # [ 10.412953] dhcpcd[731]: eth0: adding address fe80::5054:ff:fe12:3456866machine # [ 10.859803] systemd[1]: Reloading finished in 561 ms.867machine # [ 10.931664] systemd[1]: Started Nix Daemon.868machine # [ 10.991328] systemd[1]: Reload requested from client PID 807 ('systemctl') (unit flakelet-static.service)...869machine # [ 10.999440] systemd[1]: Reloading...870machine # [ 11.641122] systemd[1]: Reloading finished in 647 ms.871machine # [ 11.724295] dhcpcd[731]: eth0: soliciting a DHCP lease872machine # [ 11.736985] dhcpcd[731]: eth0: offered 10.0.2.15 from 10.0.2.2873machine # [ 11.752583] dhcpcd[731]: eth0: probing address 10.0.2.15/24874machine # [ 11.844931] nix-daemon[804]: accepted connection from pid 752, user flakelet875machine # [ 11.869093] systemd[1]: Created slice Slice /system/static-echo.876machine # [ 11.872634] systemd[1]: Listening on static-echo@1.socket.877machine # [ 11.875723] systemd[1]: Listening on static-echo@2.socket.878machine # [ 11.880682] systemd[1]: Starting prebuilt flakelet service static...879machine # [ 11.932651] systemd[1]: Started prebuilt flakelet service static.880machine # [ 12.140415] flakelet[748]: web: evaluating /nix/store/5021f2kwgs9vhdrqlvahpgzg3fc0adgq-flakelet-driver.nix881machine # [ 12.317912] nix-daemon[804]: accepted connection from pid 874, user flakelet882machine # [ 12.485235] flakelet[747]: static: updated to generation 1883machine # [ 12.488690] systemd[1]: Finished Update flakelet service static.884machine # [ 13.250398] dhcpcd[731]: eth0: soliciting an IPv6 router885machine # [ 13.250708] dhcpcd[731]: eth0: Router Advertisement from fe80::2886machine # [ 13.250840] dhcpcd[731]: eth0: adding address fec0::5054:ff:fe12:3456/64887machine # [ 13.250965] dhcpcd[731]: eth0: adding route to fec0::/64888machine # [ 13.251162] dhcpcd[731]: eth0: adding default route via fe80::2889machine # [ 16.353151] dhcpcd[731]: eth0: leased 10.0.2.15 for 86400 seconds890machine # [ 16.353449] dhcpcd[731]: eth0: adding route to 10.0.2.0/24891machine # [ 16.353581] dhcpcd[731]: eth0: adding default route via 10.0.2.2892machine # [ 16.544233] systemd[1]: Started DHCP Client.893machine # [ 20.630659] flakelet[748]: web: building /nix/store/j25ylrbpc0fh4gm9irhnxqx0mrzicswr-flakelet-web.drv894machine # [ 22.011174] nix-daemon[804]: accepted connection from pid 1125, user flakelet895machine # [ 22.045423] flakelet[748]: web: activating generation 1896machine # [ 22.059272] systemd[1]: Reload requested from client PID 1138 ('systemctl') (unit flakelet-web.service)...897machine # [ 22.064386] systemd[1]: Reloading...898machine # [ 22.705620] systemd[1]: Reloading finished in 644 ms.899machine # [ 22.802502] systemd[1]: Reload requested from client PID 1173 ('systemctl') (unit flakelet-web.service)...900machine # [ 22.807810] systemd[1]: Reloading...901machine # [ 23.440544] systemd[1]: Reloading finished in 635 ms.902machine # [ 23.623436] systemd[1]: Starting flakelet test service...903machine # [ 23.673203] systemd[1]: Started flakelet test service.904machine # [ 23.844497] flakelet[748]: web: updated to generation 1905machine # [ 23.847087] systemd[1]: Finished Update flakelet service web.906machine # [ 23.849544] systemd[1]: Reached target flakelet managed services.907machine # [ 23.852140] systemd[1]: Reached target Multi-User System.908machine # [ 23.854381] systemd[1]: Startup finished in 844ms (kernel) + 4.795s (initrd) + 18.207s (userspace) = 23.848s.909machine: (finished: waiting for unit multi-user.target, in 25.73 seconds)910machine: must succeed: systemctl start flakelet-web.service911machine: (finished: must succeed: systemctl start flakelet-web.service, in 0.07 seconds)912machine: must succeed: systemctl is-active web.service913machine: (finished: must succeed: systemctl is-active web.service, in 0.04 seconds)914machine: must succeed: systemctl show web.service -p Environment | grep -q GREETING=hello915machine: (finished: must succeed: systemctl show web.service -p Environment | grep -q GREETING=hello, in 0.05 seconds)916machine: must succeed: test -f /nix/var/nix/gcroots/flakelet/web/gen-1/manifest.json917machine: (finished: must succeed: test -f /nix/var/nix/gcroots/flakelet/web/gen-1/manifest.json, in 0.03 seconds)918machine: must succeed: flakelet status | grep -q '^web'919machine: (finished: must succeed: flakelet status | grep -q '^web', in 0.67 seconds)920machine: must succeed: grep -q '"port": 8080' /run/flakelet/exports/web.json921machine: (finished: must succeed: grep -q '"port": 8080' /run/flakelet/exports/web.json, in 0.04 seconds)922machine: must succeed: systemctl start flakelet-static.service923machine: (finished: must succeed: systemctl start flakelet-static.service, in 0.06 seconds)924machine: must succeed: systemctl is-active static.service925machine: (finished: must succeed: systemctl is-active static.service, in 0.03 seconds)926machine: must succeed: systemctl is-active static-echo@1.socket static-echo@2.socket927machine: (finished: must succeed: systemctl is-active static-echo@1.socket static-echo@2.socket, in 0.04 seconds)928machine: must succeed: /nix/store/2r7kl4a7jbdbs2nxz9whzp7hh5zc324l-socat-1.8.1.3/bin/socat -u /dev/null UNIX-CONNECT:/run/static-echo/2.sock929machine: (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)930machine: waiting for success: systemctl is-active static-echo@2.service931machine # [ 25.908184] systemd[1]: Starting static-echo@2.service...932machine # [ 25.969362] systemd[1]: Started static-echo@2.service.933machine: (finished: waiting for success: systemctl is-active static-echo@2.service, in 1.11 seconds)934machine: must succeed: flakelet activate cli /nix/store/h9fyr3a28yhqhfdm2ydikjjamk7khzcw-flakelet-cli935machine # cli: using prebuilt artifact /nix/store/h9fyr3a28yhqhfdm2ydikjjamk7khzcw-flakelet-cli936machine # cli: activating generation 1937machine # [ 27.107074] systemd[1]: Reload requested from client PID 1284 ('systemctl') (unit backdoor.service)...938machine # [ 27.112238] systemd[1]: Reloading...939machine # [ 27.729532] systemd[1]: Reloading finished in 620 ms.940machine # [ 27.855552] systemd[1]: Reload requested from client PID 1322 ('systemctl') (unit backdoor.service)...941machine # [ 27.860677] systemd[1]: Reloading...942machine # [ 28.437202] systemd[1]: Reloading finished in 579 ms.943machine # [ 28.516322] systemd[1]: Created slice Slice /system/cli-echo.944machine # [ 28.519459] systemd[1]: Listening on cli-echo@1.socket.945machine # [ 28.522916] systemd[1]: Listening on cli-echo@2.socket.946machine # [ 28.532189] systemd[1]: Starting prebuilt flakelet service cli...947machine # [ 28.580179] systemd[1]: Started prebuilt flakelet service cli.948machine: (finished: must succeed: flakelet activate cli /nix/store/h9fyr3a28yhqhfdm2ydikjjamk7khzcw-flakelet-cli, in 2.11 seconds)949machine: must succeed: systemctl is-active cli.service950machine: (finished: must succeed: systemctl is-active cli.service, in 0.03 seconds)951machine: must succeed: flakelet status --json | grep -q 'prebuilt:cli'952machine: (finished: must succeed: flakelet status --json | grep -q 'prebuilt:cli', in 0.86 seconds)953machine: must fail: flakelet activate cli /nix/store/5rlafdbdfvmf0jiv0mp6xdaxf9cpyhs2-flakelet-cli-broken954machine # cli: using prebuilt artifact /nix/store/5rlafdbdfvmf0jiv0mp6xdaxf9cpyhs2-flakelet-cli-broken955machine # cli: activating generation 2956machine # [ 30.180945] systemd[1]: cli-echo@1.socket: Deactivated successfully.957machine # [ 30.184769] systemd[1]: Closed cli-echo@1.socket.958machine # [ 30.189785] systemd[1]: cli-echo@2.socket: Deactivated successfully.959machine # [ 30.192596] systemd[1]: Closed cli-echo@2.socket.960machine # [ 30.201797] systemd[1]: Stopping prebuilt flakelet service cli...961machine # [ 30.205799] systemd[1]: cli.service: Deactivated successfully.962machine # [ 30.209772] systemd[1]: Stopped prebuilt flakelet service cli.963machine # [ 30.364453] systemd[1]: Reload requested from client PID 1391 ('systemctl') (unit backdoor.service)...964machine # [ 30.368980] systemd[1]: Reloading...965machine # [ 31.018672] systemd[1]: Reloading finished in 646 ms.966machine # [ 31.156810] systemd[1]: Reload requested from client PID 1427 ('systemctl') (unit backdoor.service)...967machine # [ 31.161873] systemd[1]: Reloading...968machine # [ 31.799210] systemd[1]: Reloading finished in 638 ms.969machine # [ 31.878637] systemd[1]: Reload requested from client PID 1462 ('systemctl') (unit backdoor.service)...970machine # [ 31.883986] systemd[1]: Reloading...971machine # [ 32.521548] systemd[1]: Reloading finished in 639 ms.972machine # [ 32.618426] systemd[1]: Reload requested from client PID 1498 ('systemctl') (unit backdoor.service)...973machine # [ 32.623537] systemd[1]: Reloading...974machine # [ 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 name975machine # [ 33.231256] systemd[1]: Reloading finished in 610 ms.976machine # [ 33.322204] systemd[1]: Starting cli.service...977machine # [ 33.361133] (nonexistent)[1535]: cli.service: Unable to locate executable '/nonexistent': No such file or directory978machine # [ 33.368319] (nonexistent)[1535]: cli.service: Failed at step EXEC spawning /nonexistent: No such file or directory979machine # [ 33.372963] systemd[1]: cli.service: Main process exited, code=exited, status=203/EXEC980machine # [ 33.376685] systemd[1]: cli.service: Failed with result 'exit-code'.981machine # [ 33.381035] systemd[1]: Failed to start cli.service.982machine # [ 33.474911] systemd[1]: Reload requested from client PID 1541 ('systemctl') (unit backdoor.service)...983machine # [ 33.480081] systemd[1]: Reloading...984machine # [ 34.145866] systemd[1]: Reloading finished in 667 ms.985machine # [ 34.234576] systemd[1]: Reload requested from client PID 1577 ('systemctl') (unit backdoor.service)...986machine # [ 34.237381] systemd[1]: Reloading...987machine # [ 34.862176] systemd[1]: Reloading finished in 624 ms.988machine # [ 34.947637] systemd[1]: Reload requested from client PID 1612 ('systemctl') (unit backdoor.service)...989machine # [ 34.952812] systemd[1]: Reloading...990machine # [ 35.578459] systemd[1]: Reloading finished in 628 ms.991machine # [ 35.770091] systemd[1]: Reload requested from client PID 1650 ('systemctl') (unit backdoor.service)...992machine # [ 35.775372] systemd[1]: Reloading...993machine # [ 36.470698] systemd[1]: Reloading finished in 697 ms.994machine # [ 36.599161] systemd[1]: Listening on cli-echo@1.socket.995machine # [ 36.613437] systemd[1]: Listening on cli-echo@2.socket.996machine # [ 36.631096] systemd[1]: Starting prebuilt flakelet service cli...997machine # [ 36.702357] systemd[1]: Started prebuilt flakelet service cli.998machine: (finished: must fail: flakelet activate cli /nix/store/5rlafdbdfvmf0jiv0mp6xdaxf9cpyhs2-flakelet-cli-broken, in 6.69 seconds)999machine: must succeed: systemctl is-active cli.service1000machine: (finished: must succeed: systemctl is-active cli.service, in 0.05 seconds)1001machine: must succeed: test "$(ls /nix/var/nix/gcroots/flakelet/cli)" = gen-11002machine: (finished: must succeed: test "$(ls /nix/var/nix/gcroots/flakelet/cli)" = gen-1, in 0.05 seconds)1003machine: must fail: flakelet activate cli /nix/store/5rlafdbdfvmf0jiv0mp6xdaxf9cpyhs2-flakelet-cli-broken1004machine # cli: using prebuilt artifact /nix/store/5rlafdbdfvmf0jiv0mp6xdaxf9cpyhs2-flakelet-cli-broken1005machine: (finished: must fail: flakelet activate cli /nix/store/5rlafdbdfvmf0jiv0mp6xdaxf9cpyhs2-flakelet-cli-broken, in 0.06 seconds)1006machine: must succeed: /nix/store/2r7kl4a7jbdbs2nxz9whzp7hh5zc324l-socat-1.8.1.3/bin/socat -u /dev/null UNIX-CONNECT:/run/cli-echo/1.sock1007machine: (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)1008machine: waiting for success: systemctl is-active cli-echo@1.service1009machine # [ 36.911429] systemd[1]: Starting cli-echo@1.service...1010machine # [ 36.952767] systemd[1]: Started cli-echo@1.service.1011machine: (finished: waiting for success: systemctl is-active cli-echo@1.service, in 0.06 seconds)1012machine: must succeed: systemctl show -P MainPID cli-echo@1.service1013machine: (finished: must succeed: systemctl show -P MainPID cli-echo@1.service, in 0.16 seconds)1014machine: must succeed: systemctl show -P MainPID cli.service1015machine: (finished: must succeed: systemctl show -P MainPID cli.service, in 0.10 seconds)1016machine: must succeed: flakelet activate cli /nix/store/y2bbmw13rkrasic4x7af0c106l26dsnd-flakelet-cli2 | grep -q 'generation 2'1017machine # cli: using prebuilt artifact /nix/store/y2bbmw13rkrasic4x7af0c106l26dsnd-flakelet-cli21018machine # cli: activating generation 21019machine # [ 37.309089] systemd[1]: Stopping prebuilt flakelet service cli...1020machine # [ 37.312749] systemd[1]: cli.service: Deactivated successfully.1021machine # [ 37.315713] systemd[1]: Stopped prebuilt flakelet service cli.1022machine # [ 37.362290] systemd[1]: Reload requested from client PID 1724 ('systemctl') (unit backdoor.service)...1023machine # [ 37.367340] systemd[1]: Reloading...1024machine # [ 38.018080] systemd[1]: Reloading finished in 651 ms.1025machine # [ 38.110234] systemd[1]: Reload requested from client PID 1761 ('systemctl') (unit backdoor.service)...1026machine # [ 38.115401] systemd[1]: Reloading...1027machine # [ 38.744072] systemd[1]: Reloading finished in 631 ms.1028machine # [ 38.887360] systemd[1]: Reload requested from client PID 1797 ('systemctl') (unit backdoor.service)...1029machine # [ 38.892815] systemd[1]: Reloading...1030machine # [ 39.566020] systemd[1]: Reloading finished in 674 ms.1031machine # [ 39.736159] systemd[1]: Reload requested from client PID 1836 ('systemctl') (unit backdoor.service)...1032machine # [ 39.741428] systemd[1]: Reloading...1033machine # [ 40.351354] systemd[1]: Reloading finished in 613 ms.1034machine # [ 40.458444] systemd[1]: Starting prebuilt flakelet service cli...1035machine # [ 40.498136] systemd[1]: Started prebuilt flakelet service cli.1036machine: (finished: must succeed: flakelet activate cli /nix/store/y2bbmw13rkrasic4x7af0c106l26dsnd-flakelet-cli2 | grep -q 'generation 2', in 3.77 seconds)1037machine: must succeed: systemctl show -P MainPID cli-echo@1.service1038machine: (finished: must succeed: systemctl show -P MainPID cli-echo@1.service, in 0.05 seconds)1039machine: must succeed: systemctl show -P MainPID cli.service1040machine: (finished: must succeed: systemctl show -P MainPID cli.service, in 0.04 seconds)1041machine: must succeed: flakelet rollback cli | grep -q 'generation 1'1042machine # [ 41.160673] systemd[1]: Stopping prebuilt flakelet service cli...1043machine # [ 41.165931] systemd[1]: cli.service: Deactivated successfully.1044machine # [ 41.168686] systemd[1]: Stopped prebuilt flakelet service cli.1045machine # [ 41.217858] systemd[1]: Reload requested from client PID 1895 ('systemctl') (unit backdoor.service)...1046machine # [ 41.222951] systemd[1]: Reloading...1047machine # [ 41.917881] systemd[1]: Reloading finished in 696 ms.1048machine # [ 42.032574] systemd[1]: Reload requested from client PID 1932 ('systemctl') (unit backdoor.service)...1049machine # [ 42.037709] systemd[1]: Reloading...1050machine # [ 42.646473] systemd[1]: Reloading finished in 610 ms.1051machine # [ 42.721302] systemd[1]: Reload requested from client PID 1968 ('systemctl') (unit backdoor.service)...1052machine # [ 42.726506] systemd[1]: Reloading...1053machine # [ 43.342426] systemd[1]: Reloading finished in 619 ms.1054machine # [ 43.486080] systemd[1]: Reload requested from client PID 2007 ('systemctl') (unit backdoor.service)...1055machine # [ 43.491317] systemd[1]: Reloading...1056machine # [ 44.100607] systemd[1]: Reloading finished in 611 ms.1057machine # [ 44.243827] systemd[1]: Starting prebuilt flakelet service cli...1058machine # [ 44.293914] systemd[1]: Started prebuilt flakelet service cli.1059machine: (finished: must succeed: flakelet rollback cli | grep -q 'generation 1', in 3.22 seconds)1060machine: must succeed: systemctl is-active cli.service1061machine: (finished: must succeed: systemctl is-active cli.service, in 0.04 seconds)1062machine: must succeed: flakelet lock cli | grep -q 'prebuilt:cli'1063machine: (finished: must succeed: flakelet lock cli | grep -q 'prebuilt:cli', in 0.05 seconds)1064machine: must succeed: flakelet unlock cli1065machine: (finished: must succeed: flakelet unlock cli, in 0.05 seconds)1066machine: must succeed: touch /tmp/failjob1067machine: (finished: must succeed: touch /tmp/failjob, in 0.04 seconds)1068machine: must fail: systemctl start web-job.service1069machine # [ 44.529327] systemd[1]: Starting web-job.service...1070machine # [ 44.596446] systemd[1]: web-job.service: Main process exited, code=exited, status=1/FAILURE1071machine # [ 44.599974] systemd[1]: web-job.service: Failed with result 'exit-code'.1072machine # Job for web-job.service failed because the control process exited with error code.1073machine # [ 44.603235] systemd[1]: Failed to start web-job.service.1074machine # See "systemctl status web-job.service" and "journalctl -xeu web-job.service" for details.1075machine: (finished: must fail: systemctl start web-job.service, in 0.14 seconds)1076machine: must succeed: systemctl is-failed web-job.service && rm /tmp/failjob1077machine: (finished: must succeed: systemctl is-failed web-job.service && rm /tmp/failjob, in 0.06 seconds)1078machine: must succeed: flakelet update web --force --no-refresh | grep -q 'updated to generation'1079machine # web: resolving path:/nix/store/1ndj6dy6hwr8inncmsdbwhm9pd6vbdvp-flake.nix1080machine # [ 44.852529] nix-daemon[804]: accepted connection from pid 2078, user flakelet1081machine # web: evaluating /nix/store/5021f2kwgs9vhdrqlvahpgzg3fc0adgq-flakelet-driver.nix1082machine # [ 45.116348] nix-daemon[804]: accepted connection from pid 2098, user flakelet1083machine # web: building /nix/store/j25ylrbpc0fh4gm9irhnxqx0mrzicswr-flakelet-web.drv1084machine # [ 49.891775] nix-daemon[804]: accepted connection from pid 2107, user flakelet1085machine # web: activating generation 21086machine # [ 50.122646] systemd[1]: Stopping flakelet test service...1087machine # [ 50.126745] systemd[1]: web.service: Deactivated successfully.1088machine # [ 50.129320] systemd[1]: Stopped flakelet test service.1089machine # [ 50.197642] systemd[1]: Reload requested from client PID 2120 ('systemctl') (unit backdoor.service)...1090machine # [ 50.202779] systemd[1]: Reloading...1091machine # [ 50.857894] systemd[1]: Reloading finished in 656 ms.1092machine # [ 50.948287] systemd[1]: Reload requested from client PID 2157 ('systemctl') (unit backdoor.service)...1093machine # [ 50.953351] systemd[1]: Reloading...1094machine # [ 51.604327] systemd[1]: Reloading finished in 653 ms.1095machine # [ 51.681838] systemd[1]: Reload requested from client PID 2193 ('systemctl') (unit backdoor.service)...1096machine # [ 51.687136] systemd[1]: Reloading...1097machine # [ 52.348781] systemd[1]: Reloading finished in 664 ms.1098machine # [ 52.440810] systemd[1]: Reload requested from client PID 2230 ('systemctl') (unit backdoor.service)...1099machine # [ 52.445948] systemd[1]: Reloading...1100machine # [ 53.112932] systemd[1]: Reloading finished in 669 ms.1101machine # [ 53.214058] systemd[1]: Starting flakelet test service...1102machine # [ 53.270021] systemd[1]: Started flakelet test service.1103machine: (finished: must succeed: flakelet update web --force --no-refresh | grep -q 'updated to generation', in 8.75 seconds)1104machine: must succeed: flakelet reconcile1105machine: (finished: must succeed: flakelet reconcile, in 0.05 seconds)1106machine: must succeed: systemctl is-active web.service static.service cli.service1107machine: (finished: must succeed: systemctl is-active web.service static.service cli.service, in 0.04 seconds)1108machine: must succeed: flakelet check --build --no-refresh --gc-roots-dir /tmp/roots | grep -q '^web: built /nix/store/'1109machine # [ 53.677195] nix-daemon[804]: accepted connection from pid 2281, user flakelet1110machine # [ 53.937733] nix-daemon[804]: accepted connection from pid 2301, user flakelet1111machine: (finished: must succeed: flakelet check --build --no-refresh --gc-roots-dir /tmp/roots | grep -q '^web: built /nix/store/', in 5.05 seconds)1112machine: must succeed: test -L /tmp/roots/web1113machine: (finished: must succeed: test -L /tmp/roots/web, in 0.03 seconds)1114machine: must succeed: flakelet build web --no-refresh --out-link /tmp/out && test -L /tmp/out/web1115machine # [ 58.740449] nix-daemon[804]: accepted connection from pid 2317, user flakelet1116machine # [ 58.979553] nix-daemon[804]: accepted connection from pid 2337, user flakelet1117machine: (finished: must succeed: flakelet build web --no-refresh --out-link /tmp/out && test -L /tmp/out/web, in 4.99 seconds)1118machine: must fail: flakelet check nosuchservice --no-refresh1119machine # error: service 'nosuchservice' is not configured1120machine: (finished: must fail: flakelet check nosuchservice --no-refresh, in 0.05 seconds)1121machine: must succeed: rm /run/systemd/system/web.service1122machine: (finished: must succeed: rm /run/systemd/system/web.service, in 0.04 seconds)1123machine: must succeed: flakelet boot1124machine # [ 63.749851] systemd[1]: Reload requested from client PID 2355 ('systemctl') (unit backdoor.service)...1125machine # [ 63.753906] systemd[1]: Reloading...1126machine # [ 64.450375] systemd[1]: Reloading finished in 693 ms.1127machine # [ 64.595760] systemd[1]: Reload requested from client PID 2395 ('systemctl') (unit backdoor.service)...1128machine # [ 64.600519] systemd[1]: Reloading...1129machine # [ 65.231625] systemd[1]: Reloading finished in 627 ms.1130machine # [ 65.327977] systemd[1]: Reload requested from client PID 2434 ('systemctl') (unit backdoor.service)...1131machine # [ 65.333026] systemd[1]: Reloading...1132machine # [ 65.948175] systemd[1]: Reloading finished in 618 ms.1133machine # [ 66.101719] systemd[1]: Reload requested from client PID 2474 ('systemctl') (unit backdoor.service)...1134machine # [ 66.106321] systemd[1]: Reloading...1135machine # [ 66.751513] systemd[1]: Reloading finished in 642 ms.1136machine # [ 66.852895] systemd[1]: Reload requested from client PID 2513 ('systemctl') (unit backdoor.service)...1137machine # [ 66.856243] systemd[1]: Reloading...1138machine # [ 67.455505] systemd[1]: Reloading finished in 597 ms.1139machine # [ 67.549208] systemd[1]: Reload requested from client PID 2551 ('systemctl') (unit backdoor.service)...1140machine # [ 67.553018] systemd[1]: Reloading...1141machine # [ 68.249176] systemd[1]: Reloading finished in 693 ms.1142machine: (finished: must succeed: flakelet boot, in 4.68 seconds)1143machine: must succeed: test -L /run/systemd/system/web.service1144machine: (finished: must succeed: test -L /run/systemd/system/web.service, in 0.03 seconds)1145machine: waiting for the VM to power off1146additionally exposed symbols:1147 machine,1148 vlan1,1149 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_ssh1150Aug 31 07:37:16 machine systemd[1]: Starting Update flakelet service web...1151Aug 31 07:37:16 machine flakelet[748]: web: resolving path:/nix/store/1ndj6dy6hwr8inncmsdbwhm9pd6vbdvp-flake.nix1152Aug 31 07:37:17 machine flakelet[748]: web: evaluating /nix/store/5021f2kwgs9vhdrqlvahpgzg3fc0adgq-flakelet-driver.nix1153Aug 31 07:37:26 machine flakelet[748]: web: building /nix/store/j25ylrbpc0fh4gm9irhnxqx0mrzicswr-flakelet-web.drv1154Aug 31 07:37:27 machine flakelet[748]: web: activating generation 11155Aug 31 07:37:29 machine flakelet[748]: web: updated to generation 11156Aug 31 07:37:29 machine systemd[1]: Finished Update flakelet service web.11571158machine # [ 68.416530] systemd-logind[596]: poweroff requested from client PID 2593 ('poweroff') (unit backdoor.service)...1159machine # [ 68.421492] systemd-logind[596]: The system will power off now!1160machine # [ 68.428810] systemd-logind[596]: System is powering down.1161machine # [ 68.455023] systemd[1]: Removed slice Slice /system/modprobe.1162machine # [ 68.458023] systemd[1]: Stopped target Multi-User System.1163machine # [ 68.460428] systemd[1]: Stopped target flakelet managed services.1164machine # [ 68.463503] systemd[1]: Stopped target Login Prompts.1165machine # [ 68.468558] systemd[1]: Stopped target Virtual Machines and Containers.1166machine # [ 68.473585] dhcpcd[731]: received SIGTERM, stopping1167machine # [ 68.477693] systemd[1]: Stopped target Host and Network Name Lookups.1168machine # [ 68.482215] dhcpcd[731]: eth0: removing interface1169machine # [ 68.484471] systemd[1]: Stopped target Timer Units.1170machine # [ 68.486981] dhcpcd[731]: eth0: deleting address fec0::5054:ff:fe12:3456/641171machine # [ 68.490883] systemd[1]: fstrim.timer: Deactivated successfully.1172machine # [ 68.493900] dhcpcd[731]: eth0: deleting route to fec0::/641173machine # [ 68.497012] systemd[1]: Stopped Discard unused filesystem blocks once a week.1174machine # [ 68.504947] dhcpcd[731]: eth0: deleting default route via fe80::21175machine # [ 68.512594] systemd[1]: systemd-tmpfiles-clean.timer: Deactivated successfully.1176machine # [ 68.520940] systemd[1]: Stopped Daily Cleanup of Temporary Directories.1177machine # [ 68.527135] systemd[1]: systemd-rfkill.socket: Deactivated successfully.1178machine # [ 68.537175] systemd[1]: Closed Load/Save RF Kill Switch Status /dev/rfkill Watch.1179machine # [ 68.544806] systemd[1]: Mounting /run/initramfs...1180machine # [ 68.550887] systemd[1]: Stopping backdoor.service...1181machine # [ 68.554788] systemd[1]: Stopping cli-echo@1.service...1182machine # [ 68.561164] systemd[1]: Stopping prebuilt flakelet service cli...1183machine # [ 68.569529] systemd[1]: Stopping DHCP Client...1184machine # [ 68.575425] systemd[1]: Stopping Getty on tty1...1185machine # [ 68.580273] systemd[1]: lastlog2-import.service: Deactivated successfully.1186machine # [ 68.586474] network-addresses-eth1-pre-stop[2597]: deleting address 192.168.1.1/24... done1187machine # [ 68.593826] dhcpcd[731]: eth0: deleting address fe80::5054:ff:fe12:34561188machine # [ 68.598834] systemd[1]: Stopped Import lastlog data into lastlog2 database.1189machine # [ 68.604861] network-addresses-eth1-pre-stop[2597]: deleting address 2001:db8:1::1/64... done1190machine # [ 68.609829] dhcpcd[731]: eth0: deleting route to 10.0.2.0/241191machine # [ 68.615666] systemd[1]: Stopping Address configuration of eth1...1192machine # [ 68.619984] dhcpcd[731]: eth0: deleting default route via 10.0.2.21193machine # [ 68.622877] systemd[1]: Stopping Nix Daemon...1194machine # [ 68.625272] dhcpcd[731]: dhcpcd exited1195machine # [ 68.627304] systemd[1]: Stopping Post-Boot Actions...1196machine # [ 68.629714] systemd[1]: reload-systemd-vconsole-setup.service: Deactivated successfully.1197machine # [ 68.633672] systemd[1]: Stopped Reset console on configuration changes.1198machine # [ 68.637919] systemd[1]: Stopping static-echo@2.service...1199machine # [ 68.645878] systemd[1]: Stopping prebuilt flakelet service static...1200machine # [ 68.650801] systemd[1]: Stopping User Login Management...1201machine # [ 68.654303] systemd[1]: systemd-machine-id-commit.service: Deactivated successfully.1202machine # [ 68.658803] systemd[1]: Stopped Save Transient machine-id to Disk.1203machine # [ 68.661734] systemd[1]: Stopped target First Boot Complete.1204machine # [ 68.664139] systemd[1]: Stopping Userspace Out-Of-Memory (OOM) Killer...1205machine # [ 68.666856] systemd[1]: Stopping Load/Save OS Random Seed...1206machine # [ 68.669293] systemd[1]: Stopping flakelet test service...1207machine # [ 68.672218] systemd[1]: flakelet-static.service: Deactivated successfully.1208machine # [ 68.675492] systemd[1]: Stopped Update flakelet service static.1209machine # [ 68.678149] systemd[1]: flakelet-web.service: Deactivated successfully.1210machine # [ 68.680694] systemd[1]: Stopped Update flakelet service web.1211machine # [ 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.1212machine # [ 68.687051] systemd[1]: Stopped target flakelet contract providers ready.1213machine # [ 68.689360] systemd[1]: flakelet-reconcile.service: Deactivated successfully.1214machine # [ 68.693171] systemd[1]: Stopped Reconcile flakelet services with the host configuration.1215machine # [ 68.696813] systemd[1]: flakelet-boot.service: Deactivated successfully.1216machine # [ 68.700975] systemd[1]: Stopped Re-link flakelet services at boot.1217machine # [ 68.703009] systemd[1]: systemd-oomd.service: Deactivated successfully.1218machine # [ 68.706022] systemd[1]: Stopped Userspace Out-Of-Memory (OOM) Killer.1219machine # [ 68.709606] systemd[1]: backdoor.service: Deactivated successfully.1220machine # [ 68.713756] systemd[1]: Stopped backdoor.service.1221machine # [ 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.1222machine # [ 68.725182] systemd[1]: systemd-logind.service: Deactivated successfully.1223machine # [ 68.732463] systemd[1]: Stopped User Login Management.1224machine # [ 68.736467] make-initrd-ng[2628]: /etc/initrd-release -> /nix/store/94m2cr9q6r1gdr1df0sz9ayq29mj68kz-etc-os-release1225machine # [ 68.743798] make-initrd-ng[2628]: /etc/os-release -> /nix/store/94m2cr9q6r1gdr1df0sz9ayq29mj68kz-etc-os-release1226machine # [ 68.751069] make-initrd-ng[2628]: /shutdown -> /nix/store/z2nxjmk4666nbka3hgyxlg13prrnvx38-systemd-261/lib/systemd/systemd-shutdown1227machine # [ 68.764105] systemd[1]: getty@tty1.service: Deactivated successfully.1228machine # [ 68.772750] systemd[1]: Stopped Getty on tty1.1229machine # [ 68.777805] systemd[1]: nix-daemon.service: Deactivated successfully.1230machine # [ 68.785707] systemd[1]: Stopped Nix Daemon.1231machine # [ 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.1232machine # [ 68.802572] systemd[1]: static.service: Deactivated successfully.1233machine # [ 68.810361] systemd[1]: Stopped prebuilt flakelet service static.1234machine # [ 68.816097] systemd[1]: static-echo@2.service: Deactivated successfully.1235machine # [ 68.824634] systemd[1]: Stopped static-echo@2.service.1236machine # [ 68.831787] systemd[1]: cli-echo@1.service: Deactivated successfully.1237machine # [ 68.836566] systemd[1]: Stopped cli-echo@1.service.1238machine # [ 68.845076] systemd[1]: cli.service: Deactivated successfully.1239machine # [ 68.850229] systemd[1]: Stopped prebuilt flakelet service cli.1240machine # [ 68.855022] systemd[1]: web.service: Deactivated successfully.1241machine # [ 68.858897] systemd[1]: Stopped flakelet test service.1242machine # [ 68.861275] systemd[1]: Mounted /run/initramfs.1243machine # [ 68.864260] systemd[1]: post-boot.service: Deactivated successfully.1244machine # [ 68.867087] systemd[1]: Stopped Post-Boot Actions.1245machine # [ 68.869371] systemd[1]: systemd-random-seed.service: Deactivated successfully.1246machine # [ 68.874617] systemd[1]: Stopped Load/Save OS Random Seed.1247machine # [ 68.878698] systemd[1]: Removed slice Slice /system/getty.1248machine # [ 68.882985] systemd[1]: Starting Generate shutdown ramfs...1249machine # [ 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"1250machine # [ 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"1251machine # [ 68.908480] systemd[1]: Stopping Permit User Sessions...1252machine # [ 68.912779] systemd[1]: network-addresses-eth1.service: Deactivated successfully.1253machine # [ 68.918208] systemd[1]: Stopped Address configuration of eth1.1254machine # [ 68.922498] systemd[1]: dhcpcd.service: Deactivated successfully.1255machine # [ 68.927476] systemd[1]: Stopped DHCP Client.1256machine # [ 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.1257machine # [ 68.942084] systemd[1]: systemd-user-sessions.service: Deactivated successfully.1258machine # [ 68.947804] systemd[1]: Stopped Permit User Sessions.1259machine # [ 68.951757] systemd[1]: Stopped target Network.1260machine # [ 68.954105] systemd[1]: Stopped target User and Group Name Lookups.1261machine # [ 68.957044] systemd[1]: Stopped target Remote File Systems.1262machine # [ 68.959601] systemd[1]: network-local-commands.service: Deactivated successfully.1263machine # [ 68.962826] systemd[1]: Stopped Extra networking commands..1264machine # [ 68.965166] systemd[1]: Stopped target Preparation for Network.1265machine # [ 68.967421] systemd[1]: Stopping Firewall...1266machine # [ 68.969138] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1267machine # [ 68.971310] systemd[1]: resolvconf.service: Deactivated successfully.1268machine # [ 68.973500] systemd[1]: Stopped resolvconf update.1269machine # [ 68.975096] systemd[1]: nscd.service: Deactivated successfully.1270machine # [ 68.976983] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1271machine # [ 68.978805] systemd[1]: Stopped target Basic System.1272machine # [ 68.980331] systemd[1]: Stopped target Path Units.1273machine # [ 68.981903] systemd[1]: Stopped target Slice Units.1274machine # [ 68.983374] systemd[1]: Removed slice User and Session Slice.1275machine # [ 68.985198] systemd[1]: Stopped target Socket Units.1276machine # [ 68.986661] systemd[1]: cli-echo@1.socket: Deactivated successfully.1277machine # [ 68.988408] systemd[1]: Closed cli-echo@1.socket.1278machine # [ 68.989768] systemd[1]: cli-echo@2.socket: Deactivated successfully.1279machine # [ 68.991368] systemd[1]: Closed cli-echo@2.socket.1280machine # [ 68.992698] systemd[1]: Removed slice Slice /system/cli-echo.1281machine # [ 68.994094] systemd[1]: nix-daemon.socket: Deactivated successfully.1282machine # [ 68.995525] systemd[1]: Closed Nix Daemon Socket.1283machine # [ 68.996713] systemd[1]: static-echo@1.socket: Deactivated successfully.1284machine # [ 68.998203] systemd[1]: Closed static-echo@1.socket.1285machine # [ 68.999318] systemd[1]: static-echo@2.socket: Deactivated successfully.1286machine # [ 69.000782] systemd[1]: Closed static-echo@2.socket.1287machine # [ 69.001893] systemd[1]: Removed slice Slice /system/static-echo.1288machine # [ 69.003147] systemd[1]: systemd-hostnamed.socket: Deactivated successfully.1289machine # [ 69.004608] systemd[1]: Closed Hostname Service Socket.1290machine # [ 69.006627] systemd[1]: systemd-importd.socket: Deactivated successfully.1291machine # [ 69.007960] systemd[1]: Closed Disk Image Download Service Socket.1292machine # [ 69.009194] systemd[1]: systemd-machined.socket: Deactivated successfully.1293machine # [ 69.010639] systemd[1]: Closed Virtual Machine and Container Registration Service Socket.1294machine # [ 69.012449] systemd[1]: systemd-mute-console.socket: Deactivated successfully.1295machine # [ 69.014074] systemd[1]: Closed Console Output Muting Service Socket.1296machine # [ 69.015543] systemd[1]: systemd-oomd.socket: Deactivated successfully.1297machine # [ 69.017102] systemd[1]: Closed Userspace Out-Of-Memory (OOM) Killer Socket.1298machine # [ 69.018680] systemd[1]: systemd-repart.socket: Deactivated successfully.1299machine # [ 69.020200] systemd[1]: Closed Disk Repartitioning Service Socket.1300machine # [ 69.021893] dbus-broker[659]: Dispatched 23728 messages @ 4(±5)μs / message.1301machine # [ 69.023522] systemd[1]: Stopping D-Bus System Message Bus...1302machine # [ 69.024904] systemd[1]: dbus-broker.service: Deactivated successfully.1303machine # [ 69.026386] systemd[1]: Stopped D-Bus System Message Bus.1304machine # [ 69.027620] systemd[1]: dbus.socket: Deactivated successfully.1305machine # [ 69.029026] systemd[1]: Closed D-Bus System Message Bus Socket.1306machine # [ 69.030337] systemd[1]: Stopped target System Initialization.1307machine # [ 69.031566] systemd[1]: Stopped target Local Encrypted Volumes.1308machine # [ 69.032915] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1309machine # [ 69.034477] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1310machine # [ 69.036040] systemd[1]: systemd-ask-password-wall.path: Deactivated successfully.1311machine # [ 69.037580] systemd[1]: Stopped Forward Password Requests to Wall Directory Watch.1312machine # [ 69.039098] systemd[1]: register-nix-paths.service: Deactivated successfully.1313machine # [ 69.040696] systemd[1]: Stopped register-nix-paths.service.1314machine # [ 69.041815] systemd[1]: systemd-sysctl.service: Deactivated successfully.1315machine # [ 69.043079] systemd[1]: Stopped Apply Kernel Variables.1316machine # [ 69.044121] systemd[1]: systemd-coredump.socket: Deactivated successfully.1317machine # [ 69.045404] systemd[1]: Closed Process Core Dump Socket.1318machine # [ 69.046413] systemd[1]: systemd-update-done.service: Deactivated successfully.1319machine # [ 69.047686] systemd[1]: Stopped Update is Completed.1320machine # [ 69.048751] systemd[1]: systemd-journal-catalog-update.service: Deactivated successfully.1321machine # [ 69.050179] systemd[1]: Stopped Rebuild Journal Catalog.1322machine # [ 69.051133] systemd[1]: Stopping Record System Boot/Shutdown in UTMP...1323machine # [ 69.052305] systemd[1]: systemd-update-utmp.service: Deactivated successfully.1324machine # [ 69.053556] systemd[1]: Stopped Record System Boot/Shutdown in UTMP.1325machine # [ 69.054643] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1326machine # [ 69.055865] systemd[1]: Stopped Create System Files and Directories.1327machine # [ 69.056998] systemd[1]: Stopped target Local File Systems.1328machine # [ 69.057937] systemd[1]: Unmounting /run/keys...1329machine # [ 69.058709] systemd[1]: Unmounting /run/wrappers...1330machine # [ 69.059540] systemd[1]: run-keys.mount: Deactivated successfully.1331machine # [ 69.060574] systemd[1]: Unmounted /run/keys.1332machine # [ 69.061315] systemd[1]: run-wrappers.mount: Deactivated successfully.1333machine # [ 69.062360] systemd[1]: Unmounted /run/wrappers.1334machine # [ 69.063127] systemd[1]: Stopped target Preparation for Local File Systems.1335machine # [ 69.064205] systemd[1]: Stopped target Swaps.1336machine # [ 69.064929] systemd[1]: Reached target Unmount All Filesystems.1337machine # [ 69.065865] systemd[1]: systemd-remount-fs.service: Deactivated successfully.1338machine # [ 69.066954] systemd[1]: Stopped Remount Root and Kernel File Systems.1339machine # [ 69.067953] systemd[1]: systemd-fsck-root.service: Deactivated successfully.1340machine # [ 69.069139] systemd[1]: Stopped File System Check on Root Device.1341machine # [ 69.070095] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1342machine # [ 69.071253] systemd[1]: Stopped Create Static Device Nodes in /dev.1343machine # [ 69.072245] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1344machine # [ 69.073453] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1345machine # [ 69.074501] systemd[1]: firewall.service: Deactivated successfully.1346machine # [ 69.075414] systemd[1]: Stopped Firewall.1347machine # [ 69.076057] systemd[1]: systemd-modules-load.service: Deactivated successfully.1348machine # [ 69.077119] systemd[1]: Stopped Load Kernel Modules.1349machine # [ 69.077894] systemd[1]: generate-shutdown-ramfs.service: Deactivated successfully.1350machine # [ 69.078942] systemd[1]: Finished Generate shutdown ramfs.1351machine # [ 69.079732] systemd[1]: Reached target System Shutdown.1352machine # [ 69.080549] systemd[1]: Reached target Late Shutdown Services.1353machine # [ 69.081384] systemd[1]: systemd-poweroff.service: Deactivated successfully.1354machine # [ 69.082345] systemd[1]: Finished System Power Off.1355machine # [ 69.083051] systemd[1]: Reached target System Power Off.1356machine # [ 69.083801] systemd[1]: Shutting down.1357machine # [ 69.200562] systemd-shutdown[1]: Syncing filesystems and block devices.1358machine # [ 69.210031] systemd-shutdown[1]: Sending SIGTERM to remaining processes...1359machine # [ 69.222146] systemd-journald[315]: Received SIGTERM from PID 1 (systemd-shutdow).1360machine # [ 69.268464] systemd-shutdown[1]: Sending SIGKILL to remaining processes...1361machine # [ 69.279414] systemd-shutdown[1]: Unmounting file systems.1362machine # [ 69.285402] (sd-umount)[2663]: Unmounting '/run/credentials/systemd-journald.service'.1363machine # [ 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'.1364machine # [ 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'.1365machine # [ 69.326029] (sd-remount)[2666]: Remounting '/nix/.ro-store' read-only with options 'cache=0xf,access=client,msize=16384,trans=virtio'.1366machine # [ 69.557933] (sd-umount)[2667]: Unmounting '/nix/.ro-store'.1367machine # [ 69.562942] (sd-remount)[2668]: Remounting '/tmp/xchg' read-only with options 'access=client,msize=16384,trans=virtio'.1368machine # [ 69.564675] (sd-umount)[2669]: Unmounting '/tmp/xchg'.1369machine # [ 69.586826] (sd-remount)[2670]: Remounting '/tmp/shared' read-only with options 'access=client,msize=16384,trans=virtio'.1370machine # [ 69.588576] (sd-umount)[2671]: Unmounting '/tmp/shared'.1371machine # [ 69.618842] (sd-remount)[2672]: Remounting '/' read-only with options ''.1372machine # [ 69.635919] EXT4-fs (vda): re-mounted 11adae6e-999b-4ff0-99c7-12315f938e3e ro.1373machine # [ 69.644050] systemd-shutdown[1]: All filesystems unmounted.1374machine # [ 69.644134] systemd-shutdown[1]: Deactivating swaps.1375machine # [ 69.644232] systemd-shutdown[1]: All swaps deactivated.1376machine # [ 69.644262] systemd-shutdown[1]: Detaching loop devices.1377machine # [ 69.663280] systemd-shutdown[1]: All loop devices detached.1378machine # [ 69.663508] systemd-shutdown[1]: Stopping MD devices.1379machine # [ 69.664942] systemd-shutdown[1]: All MD devices stopped.1380machine # [ 69.665435] systemd-shutdown[1]: Detaching DM devices.1381machine # [ 69.666683] systemd-shutdown[1]: All DM devices detached.1382machine # [ 69.667356] systemd-shutdown[1]: All filesystems, swaps, loop devices, MD devices and DM devices detached.1383machine # [ 69.670181] systemd-shutdown[1]: Failed to chase and open directory '/etc/systemd/system-shutdown', ignoring: Input/output error1384machine # [ 70.006831] systemd-shutdown[1]: Successfully changed into root pivot.1385machine # [ 70.006894] systemd-shutdown[1]: Entering exitrd...1386machine # [ 70.021972] shutdown[1]: Syncing filesystems and block devices.1387machine # [ 70.023579] shutdown[1]: Sending SIGTERM to remaining processes...1388machine # [ 70.033238] shutdown[1]: Sending SIGKILL to remaining processes...1389machine # [ 70.042673] shutdown[1]: Unmounting file systems.1390machine # [ 70.046334] (sd-umoun[2674]: Unmounting '/run/credentials'.1391machine # [ 70.051641] (sd-umoun[2675]: Unmounting '/oldroot/sys/fs/fuse/connections'.1392machine # [ 70.057467] (sd-umoun[2676]: Unmounting '/oldroot/sys/kernel/config'.1393machine # [ 70.063035] (sd-umoun[2677]: Unmounting '/oldroot/dev/mqueue'.1394machine # [ 70.068425] (sd-umoun[2678]: Unmounting '/oldroot/sys/kernel/debug'.1395machine # [ 70.073895] (sd-umoun[2679]: Unmounting '/oldroot/sys/kernel/tracing'.1396machine # [ 70.079462] (sd-umoun[2680]: Unmounting '/oldroot/dev/hugepages'.1397machine # [ 70.084991] (sd-umoun[2681]: Unmounting '/oldroot/sys/fs/bpf'.1398machine # [ 70.090233] (sd-umoun[2682]: Unmounting '/oldroot/sys/fs/pstore'.1399machine # [ 70.095617] (sd-umoun[2683]: Unmounting '/oldroot/sys/fs/cgroup'.1400machine # [ 70.101081] (sd-umoun[2684]: Unmounting '/oldroot/sys/kernel/security'.1401machine # [ 70.106796] (sd-umoun[2685]: Unmounting '/oldroot/nix/store'.1402machine # [ 70.112117] (sd-umoun[2686]: Unmounting '/oldroot/sys'.1403machine # [ 70.117265] (sd-umoun[2687]: Unmounting '/oldroot/proc'.1404machine # [ 70.122315] (sd-umoun[2688]: Unmounting '/oldroot/dev/shm'.1405machine # [ 70.127479] (sd-umoun[2689]: Unmounting '/oldroot/dev/pts'.1406machine # [ 70.132726] (sd-umoun[2690]: Unmounting '/oldroot/dev'.1407machine # [ 70.137848] (sd-umoun[2691]: Unmounting '/oldroot/nix/store'.1408machine # [ 70.234690] (sd-umoun[2692]: Unmounting '/oldroot/run'.1409machine # [ 70.240041] (sd-umoun[2693]: Unmounting '/oldroot'.1410machine # [ 70.266118] EXT4-fs (vda): unmounting filesystem 11adae6e-999b-4ff0-99c7-12315f938e3e.1411machine # [ 70.271665] shutdown[1]: All filesystems unmounted.1412machine # [ 70.272464] shutdown[1]: Deactivating swaps.1413machine # [ 70.273088] shutdown[1]: All swaps deactivated.1414machine # [ 70.273586] shutdown[1]: Detaching loop devices.1415machine # [ 70.280392] shutdown[1]: All loop devices detached.1416machine # [ 70.281298] shutdown[1]: Stopping MD devices.1417machine # [ 70.282552] shutdown[1]: All MD devices stopped.1418machine # [ 70.283338] shutdown[1]: Detaching DM devices.1419machine # [ 70.284472] shutdown[1]: All DM devices detached.1420machine # [ 70.285260] shutdown[1]: All filesystems, swaps, loop devices, MD devices and DM devices detached.1421machine # [ 70.286766] shutdown[1]: Syncing filesystems and block devices.1422machine # [ 70.288198] shutdown[1]: Powering off.1423machine # [ 70.337408] Console: switching to colour dummy device 80x251424machine # [ 70.365738] Flash device refused suspend due to active operation (state 20)1425machine # [ 70.365775] Flash device refused suspend due to active operation (state 20)1426machine # [ 70.371033] reboot: Power down1427machine: (finished: waiting for the VM to power off, in 2.30 seconds)1428machine: starting vm1429machine: QEMU running (pid 91)1430machine: waiting for unit web.service1431machine: waiting for the VM to finish booting1432machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]1433machine # [ 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 20261434machine # [ 0.000000] KASLR enabled1435machine # [ 0.000000] random: crng init done1436machine # [ 0.000000] Machine model: linux,dummy-virt1437machine # [ 0.000000] efi: UEFI not found.1438machine # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT1439machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000013fffffff]1440machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x13fdeb740-0x13fdeeebf]1441machine # [ 0.000000] Zone ranges:1442machine # [ 0.000000] DMA [mem 0x0000000040000000-0x00000000ffffffff]1443machine # [ 0.000000] DMA32 empty1444machine # [ 0.000000] Normal [mem 0x0000000100000000-0x000000013fffffff]1445machine # [ 0.000000] Device empty1446machine # [ 0.000000] Movable zone start for each node1447machine # [ 0.000000] Early memory node ranges1448machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000013fffffff]1449machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000013fffffff]1450machine # [ 0.000000] cma: Reserved 32 MiB at 0x00000000fe0000001451machine # [ 0.000000] psci: probing for conduit method from DT.1452machine # [ 0.000000] psci: PSCIv1.3 detected in firmware.1453machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs1454machine # [ 0.000000] psci: Trusted OS migration not required1455machine # [ 0.000000] psci: SMC Calling Convention v1.11456machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)1457machine # [ 0.000000] percpu: Embedded 76 pages/cpu s186392 r8192 d116712 u3112961458machine # [ 0.000000] Detected PIPT I-cache on CPU01459machine # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)1460machine # [ 0.000000] CPU features: detected: GICv3 CPU interface1461machine # [ 0.000000] CPU features: detected: Spectre-v41462machine # [ 0.000000] CPU features: detected: Spectre-BHB1463machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_381464machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_231465machine # [ 0.000000] alternatives: applying boot alternatives1466machine # [ 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=tty01467machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/i4amarwnjgkhazjc3n4a2m4axhmy83sx-closure-info/registration", will be passed to user space.1468machine # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes1469machine # [ 0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)1470machine # [ 0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)1471machine # [ 0.000000] software IO TLB: area num 4.1472machine # [ 0.000000] software IO TLB: mapped [mem 0x00000000fa000000-0x00000000fe000000] (64MB)1473machine # [ 0.000000] Fallback order for Node 0: 01474machine # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 10485761475machine # [ 0.000000] Policy zone: Normal1476machine # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off1477machine # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=11478machine # [ 0.000000] allocated 8388608 bytes of page_ext1479machine # [ 0.000000] ftrace: allocating 74754 entries in 294 pages1480machine # [ 0.000000] ftrace: allocated 294 pages with 4 groups1481machine # [ 0.000000] rcu: Hierarchical RCU implementation.1482machine # [ 0.000000] rcu: RCU event tracing is enabled.1483machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=4.1484machine # [ 0.000000] Trampoline variant of Tasks RCU enabled.1485machine # [ 0.000000] Rude variant of Tasks RCU enabled.1486machine # [ 0.000000] Tracing variant of Tasks RCU enabled.1487machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.1488machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=41489machine # [ 0.000000] RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4.1490machine # [ 0.000000] RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4.1491machine # [ 0.000000] RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4.1492machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 01493machine # [ 0.000000] GICv3: 256 SPIs implemented1494machine # [ 0.000000] GICv3: 0 Extended SPIs implemented1495machine # [ 0.000000] Root IRQ handler: gic_handle_irq1496machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI1497machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=01498machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a00001499machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]1500machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @100b10000 (indirect, esz 8, psz 64K, shr 1)1501machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @100b20000 (flat, esz 8, psz 64K, shr 1)1502machine # [ 0.000000] GICv3: using LPI property table @0x0000000100b300001503machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000100b400001504machine # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.1505machine # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns1506machine # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).1507machine # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns1508machine # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns1509machine # [ 0.000030] arm-pv: using stolen time PV1510machine # [ 0.000368] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)1511machine # [ 0.000573] Console: colour dummy device 80x251512machine # [ 0.000580] printk: legacy console [tty0] enabled1513machine # [ 0.000756] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)1514machine # [ 0.000762] pid_max: default: 32768 minimum: 3011515machine # [ 0.000844] LSM: initializing lsm=capability,landlock,yama,bpf,ima1516machine # [ 0.000979] landlock: Up and running.1517machine # [ 0.000982] Yama: becoming mindful.1518machine # [ 0.001375] LSM support for eBPF active1519machine # [ 0.001535] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)1520machine # [ 0.001592] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)1521machine # [ 0.002706] cacheinfo: Unable to detect cache hierarchy for CPU 01522machine # [ 0.003455] rcu: Hierarchical SRCU implementation.1523machine # [ 0.003459] rcu: Max phase no-delay instances is 1000.1524machine # [ 0.003620] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level1525machine # [ 0.004647] fsl-mc MSI: its@8080000 domain created1526machine # [ 0.004740] EFI services will not be available.1527machine # [ 0.004937] smp: Bringing up secondary CPUs ...1528machine # [ 0.005609] Detected PIPT I-cache on CPU11529machine # [ 0.005713] GICv3: CPU1: found redistributor 1 region 0:0x00000000080c00001530machine # [ 0.005846] GICv3: CPU1: using allocated LPI pending table @0x0000000100b500001531machine # [ 0.005976] CPU1: Booted secondary processor 0x0000000001 [0xc00fac40]1532machine # [ 0.007100] Detected PIPT I-cache on CPU21533machine # [ 0.007212] GICv3: CPU2: found redistributor 2 region 0:0x00000000080e00001534machine # [ 0.007349] GICv3: CPU2: using allocated LPI pending table @0x0000000100b600001535machine # [ 0.007479] CPU2: Booted secondary processor 0x0000000002 [0xc00fac40]1536machine # [ 0.008910] Detected PIPT I-cache on CPU31537machine # [ 0.009026] GICv3: CPU3: found redistributor 3 region 0:0x00000000081000001538machine # [ 0.009160] GICv3: CPU3: using allocated LPI pending table @0x0000000100b700001539machine # [ 0.009289] CPU3: Booted secondary processor 0x0000000003 [0xc00fac40]1540machine # [ 0.009805] smp: Brought up 1 node, 4 CPUs1541machine # [ 0.009832] SMP: Total of 4 processors activated.1542machine # [ 0.009834] CPU: All CPU(s) started at EL11543machine # [ 0.009843] CPU features: detected: Branch Target Identification1544machine # [ 0.009847] CPU features: detected: ARMv8.4 Translation Table Level1545machine # [ 0.009849] CPU features: detected: Instruction cache invalidation not required for I/D coherence1546machine # [ 0.009853] CPU features: detected: Data cache clean to the PoU not required for I/D coherence1547machine # [ 0.009856] CPU features: detected: Common not Private translations1548machine # [ 0.009859] CPU features: detected: CRC32 instructions1549machine # [ 0.009862] CPU features: detected: Data cache clean to Point of Deep Persistence1550machine # [ 0.009866] CPU features: detected: Data cache clean to Point of Persistence1551machine # [ 0.009869] CPU features: detected: Data independent timing control (DIT)1552machine # [ 0.009872] CPU features: detected: E0PD1553machine # [ 0.009874] CPU features: detected: Enhanced Counter Virtualization1554machine # [ 0.009877] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)1555machine # [ 0.009880] CPU features: detected: Enhanced Virtualization Traps1556machine # [ 0.009883] CPU features: detected: Fine Grained Traps1557machine # [ 0.009886] CPU features: detected: Generic authentication (architected QARMA5 algorithm)1558machine # [ 0.009891] CPU features: detected: RCpc load-acquire (LDAPR)1559machine # [ 0.009894] CPU features: detected: LSE atomic instructions1560machine # [ 0.009897] CPU features: detected: Privileged Access Never1561machine # [ 0.009899] CPU features: detected: PMUv31562machine # [ 0.009902] CPU features: detected: RAS Extension Support1563machine # [ 0.009904] CPU features: detected: RASv1p1 Extension Support1564machine # [ 0.009907] CPU features: detected: Random Number Generator1565machine # [ 0.009910] CPU features: detected: Speculation barrier (SB)1566machine # [ 0.009913] CPU features: detected: Stage-2 Force Write-Back1567machine # [ 0.009915] CPU features: detected: TLB range maintenance instructions1568machine # [ 0.009919] CPU features: detected: Speculative Store Bypassing Safe (SSBS)1569machine # [ 0.010052] alternatives: applying system-wide alternatives1570machine # [ 0.012998] CPU features: detected: BBM Level 2 without TLB conflict abort1571machine # [ 0.013264] Memory: 3910056K/4194304K available (24384K kernel code, 7086K rwdata, 26316K rodata, 4736K init, 1102K bss, 233732K reserved, 32768K cma-reserved)1572machine # [ 0.014573] devtmpfs: initialized1573machine # [ 0.018235] posixtimers hash table entries: 2048 (order: 3, 32768 bytes, linear)1574machine # [ 0.018303] futex hash table entries: 1024 (65536 bytes on 1 NUMA nodes, total 64 KiB, linear).1575machine # [ 0.018482] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL1576machine # [ 0.018486] 0 pages in range for non-PLT usage1577machine # [ 0.018488] 508320 pages in range for PLT usage1578machine # [ 0.018619] pinctrl core: initialized pinctrl subsystem1579machine # [ 0.019375] DMI not present or invalid.1580machine # [ 0.022546] NET: Registered PF_NETLINK/PF_ROUTE protocol family1581machine # [ 0.025004] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations1582machine # [ 0.025196] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations1583machine # [ 0.025423] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations1584machine # [ 0.025443] audit: initializing netlink subsys (disabled)1585machine # [ 0.025738] audit: type=2000 audit(0.024:1): state=initialized audit_enabled=0 res=11586machine # [ 0.026231] thermal_sys: Registered thermal governor 'fair_share'1587machine # [ 0.026234] thermal_sys: Registered thermal governor 'bang_bang'1588machine # [ 0.026239] thermal_sys: Registered thermal governor 'step_wise'1589machine # [ 0.026241] thermal_sys: Registered thermal governor 'user_space'1590machine # [ 0.026244] thermal_sys: Registered thermal governor 'power_allocator'1591machine # [ 0.026321] cpuidle: using governor ladder1592machine # [ 0.026346] cpuidle: using governor menu1593machine # [ 0.026537] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.1594machine # [ 0.026709] ASID allocator initialised with 65536 entries1595machine # [ 0.027816] Serial: AMBA PL011 UART driver1596machine # [ 0.032960] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev11597machine # [ 0.033232] printk: console [ttyAMA0] enabled1598machine # [ 0.037918] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages1599machine # [ 0.037926] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page1600machine # [ 0.037929] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages1601machine # [ 0.037932] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page1602machine # [ 0.037935] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages1603machine # [ 0.037937] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page1604machine # [ 0.037940] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages1605machine # [ 0.037943] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page1606machine # [ 0.049597] fbcon: Taking over console1607machine # [ 0.049626] ACPI: Interpreter disabled.1608machine # [ 0.052253] iommu: Default domain type: Translated1609machine # [ 0.052264] iommu: DMA domain TLB invalidation policy: strict mode1610machine # [ 0.062076] SCSI subsystem initialized1611machine # [ 0.062504] usbcore: registered new interface driver usbfs1612machine # [ 0.062537] usbcore: registered new interface driver hub1613machine # [ 0.062552] usbcore: registered new device driver usb1614machine # [ 0.062836] pps_core: LinuxPPS API ver. 1 registered1615machine # [ 0.062840] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>1616machine # [ 0.062848] PTP clock support registered1617machine # [ 0.062886] EDAC MC: Ver: 3.0.01618machine # [ 0.063356] scmi_core: SCMI protocol bus registered1619machine # [ 0.064284] FPGA manager framework1620machine # [ 0.065242] vgaarb: loaded1621machine # [ 0.066372] clocksource: Switched to clocksource arch_sys_counter1622machine # [ 0.083480] VFS: Disk quotas dquot_6.6.01623machine # [ 0.083546] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)1624machine # [ 0.084310] netfs: FS-Cache loaded1625machine # [ 0.084571] pnp: PnP ACPI: disabled1626machine # [ 0.095663] NET: Registered PF_INET protocol family1627machine # [ 0.097120] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)1628machine # [ 0.155702] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)1629machine # [ 0.155755] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)1630machine # [ 0.155796] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)1631machine # [ 0.155987] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear)1632machine # [ 0.156424] TCP: Hash tables configured (established 32768 bind 32768)1633machine # [ 0.156553] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear)1634machine # [ 0.156614] UDP hash table entries: 2048 (order: 5, 131072 bytes, linear)1635machine # [ 0.156705] UDP-Lite hash table entries: 2048 (order: 5, 131072 bytes, linear)1636machine # [ 0.156883] NET: Registered PF_UNIX/PF_LOCAL protocol family1637machine # [ 0.156911] NET: Registered PF_XDP protocol family1638machine # [ 0.156929] PCI: CLS 0 bytes, default 641639machine # [ 0.157325] Trying to unpack rootfs image as initramfs...1640machine # [ 0.174638] kvm [1]: HYP mode not available1641machine # [ 0.254645] Initialise system trusted keyrings1642machine # [ 0.254892] workingset: timestamp_bits=42 max_order=20 bucket_order=01643machine # [ 0.255587] squashfs: version 4.0 (2009/01/31) Phillip Lougher1644machine # [ 0.255773] 9p: Installing v9fs 9p2000 file system support1645machine # [ 0.271050] Key type asymmetric registered1646machine # [ 0.271063] Asymmetric key parser 'x509' registered1647machine # [ 0.271121] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)1648machine # [ 0.271379] io scheduler mq-deadline registered1649machine # [ 0.271386] io scheduler kyber registered1650machine # [ 0.279547] pl061_gpio 9030000.pl061: PL061 GPIO chip registered1651machine # [ 0.282504] ledtrig-cpu: registered to indicate activity on CPUs1652machine # [ 0.282930] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:1653machine # [ 0.282946] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x00000000001654machine # [ 0.282966] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x00100000001655machine # [ 0.282975] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x80000000001656machine # [ 0.282995] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits1657machine # [ 0.283018] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]1658machine # [ 0.283182] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:001659machine # [ 0.283191] pci_bus 0000:00: root bus resource [bus 00-ff]1660machine # [ 0.283196] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]1661machine # [ 0.283199] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]1662machine # [ 0.283204] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]1663machine # [ 0.283314] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint1664machine # [ 0.283924] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint1665machine # [ 0.284174] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]1666machine # [ 0.284189] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]1667machine # [ 0.284229] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1668machine # [ 0.284244] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]1669machine # [ 0.284886] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint1670machine # [ 0.285146] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]1671machine # [ 0.285161] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]1672machine # [ 0.285199] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1673machine # [ 0.285843] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint1674machine # [ 0.286112] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]1675machine # [ 0.286133] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]1676machine # [ 0.286172] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1677machine # [ 0.286853] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint1678machine # [ 0.287137] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]1679machine # [ 0.287152] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]1680machine # [ 0.287185] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1681machine # [ 0.287847] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint1682machine # [ 0.288115] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]1683machine # [ 0.288136] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]1684machine # [ 0.288174] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1685machine # [ 0.288815] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint1686machine # [ 0.289071] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]1687machine # [ 0.289086] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]1688machine # [ 0.289119] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1689machine # [ 0.289748] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint1690machine # [ 0.289995] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]1691machine # [ 0.290010] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]1692machine # [ 0.290049] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1693machine # [ 0.290071] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]1694machine # [ 0.290784] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint1695machine # [ 0.291066] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]1696machine # [ 0.291100] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1697machine # [ 0.291767] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint1698machine # [ 0.292032] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]1699machine # [ 0.292072] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1700machine # [ 0.292621] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint1701machine # [ 0.292876] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]1702machine # [ 0.293220] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint1703machine # [ 0.293577] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]1704machine # [ 0.293593] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]1705machine # [ 0.293632] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1706machine # [ 0.294270] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint1707machine # [ 0.294550] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]1708machine # [ 0.294564] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]1709machine # [ 0.294603] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1710machine # [ 0.295418] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned1711machine # [ 0.295426] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned1712machine # [ 0.295430] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned1713machine # [ 0.295483] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned1714machine # [ 0.295541] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned1715machine # [ 0.295603] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned1716machine # [ 0.295663] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned1717machine # [ 0.295725] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned1718machine # [ 0.295785] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned1719machine # [ 0.295847] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned1720machine # [ 0.295901] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned1721machine # [ 0.295955] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned1722machine # [ 0.296037] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned1723machine # [ 0.296097] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned1724machine # [ 0.296126] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned1725machine # [ 0.296148] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned1726machine # [ 0.296169] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned1727machine # [ 0.296192] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned1728machine # [ 0.296214] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned1729machine # [ 0.296242] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned1730machine # [ 0.296265] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned1731machine # [ 0.296294] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned1732machine # [ 0.296316] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned1733machine # [ 0.296339] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned1734machine # [ 0.296362] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned1735machine # [ 0.296384] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned1736machine # [ 0.296414] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned1737machine # [ 0.296436] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned1738machine # [ 0.296457] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned1739machine # [ 0.296484] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned1740machine # [ 0.296507] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned1741machine # [ 0.296529] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned1742machine # [ 0.296551] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned1743machine # [ 0.296573] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned1744machine # [ 0.296606] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]1745machine # [ 0.296612] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]1746machine # [ 0.296616] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]1747machine # [ 0.298300] pci 0000:00:0a.0: enabling device (0000 -> 0002)1748machine # [ 0.312744] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)1749machine # [ 0.315572] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)1750machine # [ 0.318220] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)1751machine # [ 0.320952] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)1752machine # [ 0.324938] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)1753machine # [ 0.329589] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)1754machine # [ 0.332254] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)1755machine # [ 0.335025] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)1756machine # [ 0.339624] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)1757machine # [ 0.343703] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)1758machine # [ 0.346845] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)1759machine # [ 0.354186] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled1760machine # [ 0.356423] msm_serial: driver initialized1761machine # [ 0.356594] SuperH (H)SCI(F) driver initialized1762machine # [ 0.356653] STM32 USART driver initialized1763machine # [ 0.388106] loop: module loaded1764machine # [ 0.388359] virtio_blk virtio5: 4/0/0 default/read/poll queues1765machine # [ 0.391050] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1766machine # [ 0.393902] megasas: 07.734.00.00-rc11767machine # [ 0.394745] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]1768machine # [ 0.401206] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001769machine # [ 0.401229] Intel/Sharp Extended Query Table at 0x00311770machine # [ 0.403469] Using buffer write method1771machine # [ 0.403511] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]1772machine # [ 0.405904] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001773machine # [ 0.405927] Intel/Sharp Extended Query Table at 0x00311774machine # [ 0.409992] Using buffer write method1775machine # [ 0.410014] Concatenating MTD devices:1776machine # [ 0.410017] (0): "0.flash"1777machine # [ 0.410020] (1): "0.flash"1778machine # [ 0.410022] into device "0.flash"1779machine # [ 0.600290] Freeing initrd memory: 27052K1780machine # [ 0.617500] tun: Universal TUN/TAP device driver, 1.61781machine # [ 0.626269] thunder_xcv, ver 1.01782machine # [ 0.626482] thunder_bgx, ver 1.01783machine # [ 0.626552] nicpf, ver 1.01784machine # [ 0.628337] e1000: Intel(R) PRO/1000 Network Driver1785machine # [ 0.628352] e1000: Copyright (c) 1999-2006 Intel Corporation.1786machine # [ 0.628436] e1000e: Intel(R) PRO/1000 Network Driver1787machine # [ 0.628450] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.1788machine # [ 0.628517] igb: Intel(R) Gigabit Ethernet Network Driver1789machine # [ 0.628526] igb: Copyright (c) 2007-2014 Intel Corporation.1790machine # [ 0.628593] igbvf: Intel(R) Gigabit Virtual Function Network Driver1791machine # [ 0.628603] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.1792machine # [ 0.628986] sky2: driver version 1.301793machine # [ 0.633337] ehci-pci 0000:00:0a.0: EHCI Host Controller1794machine # [ 0.633365] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 11795machine # [ 0.633608] ehci-pci 0000:00:0a.0: irq 15, io mem 0x100890001796machine # [ 0.633840] usbcore: registered new interface driver usb-storage1797machine # [ 0.634047] usbcore: registered new interface driver usbserial_generic1798machine # [ 0.634122] usbserial: USB Serial support registered for generic1799machine # [ 0.636030] hv_vmbus: registering driver hyperv_keyboard1800machine # [ 0.638624] rtc-pl031 9010000.pl031: registered as rtc01801machine # [ 0.638681] rtc-pl031 9010000.pl031: setting system clock to 2026-08-31T07:38:18 UTC (1788161898)1802machine # [ 0.639579] i2c_dev: i2c /dev entries driver1803machine # [ 0.642591] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.001804machine # [ 0.644195] hub 1-0:1.0: USB hub found1805machine # [ 0.644303] hub 1-0:1.0: 6 ports detected1806machine # [ 0.647936] sdhci: Secure Digital Host Controller Interface driver1807machine # [ 0.647951] sdhci: Copyright(c) Pierre Ossman1808machine # [ 0.648787] Synopsys Designware Multimedia Card Interface Driver1809machine # [ 0.649903] sdhci-pltfm: SDHCI platform and OF driver helper1810machine # [ 0.654438] hid: raw HID events driver (C) Jiri Kosina1811machine # [ 0.655335] usbcore: registered new interface driver usbhid1812machine # [ 0.655344] usbhid: USB HID core driver1813machine # [ 0.699949] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available1814machine # [ 0.704559] drop_monitor: Initializing network drop monitor service1815machine # [ 0.704946] NET: Registered PF_INET6 protocol family1816machine # [ 0.707564] Segment Routing with IPv61817machine # [ 0.707630] In-situ OAM (IOAM) with IPv61818machine # [ 0.707873] NET: Registered PF_PACKET protocol family1819machine # [ 0.708308] 9pnet: Installing 9P2000 support1820machine # [ 0.715152] Key type dns_resolver registered1821machine # [ 0.734343] registered taskstats version 11822machine # [ 0.734948] Loading compiled-in X.509 certificates1823machine # [ 0.762936] Demotion targets for Node 0: null1824machine # [ 0.763231] Key type .fscrypt registered1825machine # [ 0.763239] Key type fscrypt-provisioning registered1826machine # [ 0.763526] ima: No TPM chip found, activating TPM-bypass!1827machine # [ 0.763551] ima: Allocated hash algorithm: sha11828machine # [ 0.763664] ima: No architecture policies found1829machine # [ 0.765195] input: gpio-keys as /devices/platform/gpio-keys/input/input01830machine # [ 0.797101] clk: Disabling unused clocks1831machine # [ 0.797141] PM: genpd: Disabling unused power domains1832machine # [ 0.803159] Freeing unused kernel memory: 4736K1833machine # [ 0.803467] Run /init as init process1834machine # [ 0.849777] systemd[1]: Successfully made /usr/ read-only.1835machine # [ 0.890458] usb 1-1: new high-speed USB device number 2 using ehci-pci1836machine # [ 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/input11837machine # [ 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/input01838machine # [ 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)1839machine # [ 1.184779] systemd[1]: Detected virtualization qemu.1840machine # [ 1.184845] systemd[1]: Detected architecture arm64.1841machine # [ 1.184858] systemd[1]: Running in initrd.1842machine # [ 1.185667] systemd[1]: Initializing machine ID from random generator.1843machine # [ 1.186013] systemd[1]: Hostname set to <machine>.1844machine # [ 1.250469] usb 1-2: new high-speed USB device number 3 using ehci-pci1845machine # [ 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/input21846machine # [ 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/input01847machine # [ 1.447779] systemd[1]: bpf-restrict-fs: LSM BPF program attached1848machine # [ 1.532351] systemd[1]: Queued start job for default target Initrd Default Target.1849machine # [ 1.549483] systemd[1]: Created slice Slice /system/modprobe.1850machine # [ 1.549781] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1851machine # [ 1.549817] systemd[1]: Expecting device /dev/disk/by-label/nixos...1852machine # [ 1.549845] systemd[1]: Reached target Path Units.1853machine # [ 1.549865] systemd[1]: Reached target Slice Units.1854machine # [ 1.549884] systemd[1]: Reached target Swaps.1855machine # [ 1.549903] systemd[1]: Reached target Timer Units.1856machine # [ 1.550084] systemd[1]: Listening on D-Bus System Message Bus Socket.1857machine # [ 1.550262] systemd[1]: Listening on Journal Socket (/dev/log).1858machine # [ 1.550546] systemd[1]: Listening on Journal Sockets.1859machine # [ 1.550711] systemd[1]: Listening on udev Control Socket.1860machine # [ 1.550807] systemd[1]: Listening on udev Kernel Socket.1861machine # [ 1.550829] systemd[1]: Reached target Socket Units.1862machine # [ 1.552760] systemd[1]: Starting Create List of Static Device Nodes...1863machine # [ 1.554611] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1864machine # [ 1.554691] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1865machine # [ 1.556569] systemd[1]: Mounting Kernel Configuration File System...1866machine # [ 1.580035] systemd[1]: Starting Journal Service...1867machine # [ 1.585441] systemd[1]: Starting Load Kernel Modules...1868machine # [ 1.585711] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1869machine # [ 1.589114] systemd[1]: Starting Coldplug All udev Devices...1870machine # [ 1.594804] systemd[1]: Finished Create List of Static Device Nodes.1871machine # [ 1.595939] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1872machine # [ 1.602074] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1873machine # [ 1.603876] systemd[1]: Mounted Kernel Configuration File System.1874machine # [ 1.612578] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1875machine # [ 1.620765] systemd-journald[96]: Collecting audit messages is disabled.1876machine # [ 1.627051] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1877machine # [ 1.627416] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1878machine # [ 1.632431] [drm] pci: virtio-gpu-pci detected at 0000:00:08.01879machine # [ 1.632679] [drm] features: -virgl +edid -resource_blob -host_visible1880machine # [ 1.632682] [drm] features: -context_init1881machine # [ 1.633508] [drm] number of scanouts: 11882machine # [ 1.633520] [drm] number of cap sets: 01883machine # [ 1.634482] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic1884machine # [ 1.634500] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 01885machine # [ 1.650136] Console: switching to colour frame buffer device 160x501886machine # [ 1.657755] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device1887machine # [ 1.664205] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1888machine # [ 1.667995] systemd[1]: Starting Create Static Device Nodes in /dev...1889machine # [ 1.668589] systemd[1]: Finished Load Kernel Modules.1890machine # [ 1.671869] systemd[1]: Starting Apply Kernel Variables...1891machine # [ 1.691507] systemd[1]: Finished Apply Kernel Variables.1892machine # [ 1.703794] systemd[1]: Finished Create Static Device Nodes in /dev.1893machine # [ 1.704038] systemd[1]: Reached target Preparation for Local File Systems.1894machine # [ 1.704649] systemd[1]: Reached target Local File Systems.1895machine # [ 1.710299] systemd[1]: Starting Rule-based Manager for Device Events and Files...1896machine # [ 1.705741] systemd-modules-load[97]: Using 4 probe threads1897machine # [ 1.715183] systemd-modules-load[97]: Module 'virtio_balloon' is built in[ 1.711021] systemd[1]: Started Journal Service.1898machine # 1899machine # [ 1.719567] systemd-modules-load[97]: Module 'virtio_console' is built in1900machine # [ 1.721622] systemd-modules-load[97]: Module 'virtio_rng' is built in1901machine # [ 1.723644] systemd-modules-load[97]: Inserted module 'dm_mod'1902machine # [ 1.726084] systemd-modules-load[97]: Inserted module 'virtio_gpu'1903machine # [ 1.727332] systemd[1]: Starting Create System Files and Directories...1904machine # [ 1.738633] systemd-udevd[107]: Using default interface naming scheme 'v261'.1905machine # [ 1.741163] systemd[1]: Finished Create System Files and Directories.1906machine # [ 1.752109] systemd[1]: Started Rule-based Manager for Device Events and Files.1907machine # [ 1.780104] systemd[1]: Starting Virtual Console Setup...1908machine # [ 1.850118] systemd-vconsole-setup[129]: Configuration of first virtual console was skipped, ignoring remaining ones.1909machine # [ 1.855190] systemd[1]: Finished Virtual Console Setup.1910machine # [ 2.220997] systemd[1]: Finished Coldplug All udev Devices.1911machine # [ 2.223454] systemd[1]: Reached target System Initialization.1912machine # [ 2.225991] systemd[1]: Reached target Basic System.1913machine # [ 2.421192] (udev-worker)[138]: Network interface NamePolicy= disabled on kernel command line.1914machine # [ 2.425167] (udev-worker)[122]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1915machine # [ 2.429662] (udev-worker)[122]: Network interface NamePolicy= disabled on kernel command line.1916machine # [ 2.493999] systemd[1]: Found device /dev/disk/by-label/nixos.1917machine # [ 2.495534] systemd[1]: Reached target Initrd Root Device.1918machine # [ 2.496956] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1919machine # [ 2.540572] systemd-fsck[151]: nixos: clean, 1214/65536 files, 18917/262144 blocks1920machine # [ 2.543253] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1921machine # [ 2.590015] systemd[1]: Mounting /sysroot...1922machine # [ 2.638035] EXT4-fs (vda): mounted filesystem 11adae6e-999b-4ff0-99c7-12315f938e3e r/w with ordered data mode. Quota mode: none.1923machine # [ 2.641939] systemd[1]: Mounted /sysroot.1924machine # [ 2.643039] systemd[1]: Reached target Initrd Root File System.1925machine # [ 2.646689] systemd[1]: Mounting /sysroot/nix/.ro-store...1926machine # [ 2.652363] systemd[1]: Mounting /sysroot/run...1927machine # [ 2.655713] systemd[1]: Mounting /sysroot/tmp/shared...1928machine # [ 2.673247] systemd[1]: Mounting /sysroot/tmp/xchg...1929machine # [ 2.680172] systemd[1]: Starting Mountpoints Configured in the Real Root...1930machine # [ 2.688778] systemd[1]: Starting rw-sysroot-nix-store.service...1931machine # [ 2.690084] systemd-sysroot-fstab-check[163]: /sysroot should be mounted in the initrd, will request daemon-reload.1932machine # [ 2.699663] systemd[1]: Mounted /sysroot/nix/.ro-store.1933machine # [ 2.700846] systemd[1]: Mounted /sysroot/run.1934machine # [ 2.701612] systemd[1]: Mounted /sysroot/tmp/shared.1935machine # [ 2.702357] systemd[1]: Mounted /sysroot/tmp/xchg.1936machine # [ 2.703096] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1937machine # [ 2.704272] systemd[1]: Finished rw-sysroot-nix-store.service.1938machine # [ 2.708118] systemd[1]: Mounting /sysroot/nix/store...1939machine # [ 2.709901] systemd[1]: Reload requested from client PID 163 ('systemd-sysroot') (unit initrd-parse-etc.service)...1940machine # [ 2.711486] systemd[1]: Reloading...1941machine # [ 2.804141] systemd[1]: Reloading finished in 96 ms.1942machine # [ 2.858415] systemd-sysroot-fstab-check[163]: Requesting initrd-fs.target/start/replace...1943machine # [ 2.860159] systemd[1]: Mounted /sysroot/nix/store.1944machine # [ 2.862115] systemd-sysroot-fstab-check[163]: Requesting swap.target/start/replace...1945machine # [ 2.863295] systemd[1]: Starting Find NixOS closure...1946machine # [ 2.866273] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1947machine # [ 2.867501] systemd[1]: Finished Mountpoints Configured in the Real Root.1948machine # [ 2.868512] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1949machine # [ 2.870474] systemd[1]: Reached target Initrd File Systems.1950machine # [ 2.876783] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1951machine # [ 2.889177] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1952machine # [ 2.895644] systemd[1]: Finished Find NixOS closure.1953machine # [ 2.896882] systemd[1]: Reached target Initrd Default Target.1954machine # [ 2.900140] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1955machine # [ 2.912987] systemd[1]: Stopped target Initrd Default Target.1956machine # [ 2.914378] systemd[1]: Stopped target Basic System.1957machine # [ 2.915148] systemd[1]: Stopped target Initrd Root Device.1958machine # [ 2.915914] systemd[1]: Stopped target Path Units.1959machine # [ 2.916729] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1960machine # [ 2.917758] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1961machine # [ 2.918888] systemd[1]: Stopped target Slice Units.1962machine # [ 2.919658] systemd[1]: Stopped target Socket Units.1963machine # [ 2.921422] systemd[1]: Stopped target System Initialization.1964machine # [ 2.922867] systemd[1]: Stopped target Swaps.1965machine # [ 2.923658] systemd[1]: Stopped target Timer Units.1966machine # [ 2.926577] systemd[1]: dbus.socket: Deactivated successfully.1967machine # [ 2.927470] systemd[1]: Closed D-Bus System Message Bus Socket.1968machine # [ 2.928366] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1969machine # [ 2.929424] systemd[1]: Stopped Find NixOS closure.1970machine # [ 2.930171] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1971machine # [ 2.931146] systemd[1]: Starting rw-sysroot-nix-store.service...1972machine # [ 2.931988] systemd[1]: systemd-sysctl.service: Deactivated successfully.1973machine # [ 2.933078] systemd[1]: Stopped Apply Kernel Variables.1974machine # [ 2.934270] systemd[1]: systemd-modules-load.service: Deactivated successfully.1975machine # [ 2.935291] systemd[1]: Stopped Load Kernel Modules.1976machine # [ 2.936029] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1977machine # [ 2.937134] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1978machine # [ 2.938181] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1979machine # [ 2.939165] systemd[1]: Stopped Create System Files and Directories.1980machine # [ 2.940091] systemd[1]: Stopped target Local File Systems.1981machine # [ 2.940855] systemd[1]: Stopped target Preparation for Local File Systems.1982machine # [ 2.941774] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1983machine # [ 2.942740] systemd[1]: Stopped Coldplug All udev Devices.1984machine # [ 2.943496] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1985machine # [ 2.944645] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1986machine # [ 2.945640] systemd[1]: Stopped Virtual Console Setup.1987machine # [ 2.946356] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1988machine # [ 2.947328] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1989machine # [ 2.948180] systemd[1]: initrd-cleanup.service: Deactivated successfully.1990machine # [ 2.949091] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1991machine # [ 2.949981] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1992machine # [ 2.950943] systemd[1]: Finished rw-sysroot-nix-store.service.1993machine # [ 2.958121] systemd[1]: systemd-udevd.service: Deactivated successfully.1994machine # [ 2.959025] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1995machine # [ 2.959973] systemd[1]: systemd-udevd.service: Consumed 1.831s CPU time over 1.250s wall clock time, 25.8M memory peak.1996machine # [ 2.961473] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1997machine # [ 2.962445] systemd[1]: Closed udev Control Socket.1998machine # [ 2.963136] systemd[1]: Starting Cleanup udev Database...1999machine # [ 2.963882] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.2000machine # [ 2.964984] systemd[1]: Stopped Create Static Device Nodes in /dev.2001machine # [ 2.965833] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.2002machine # [ 2.967015] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.2003machine # [ 2.967978] systemd[1]: kmod-static-nodes.service: Deactivated successfully.2004machine # [ 2.968992] systemd[1]: Stopped Create List of Static Device Nodes.2005machine # [ 3.000233] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.2006machine # [ 3.001474] systemd[1]: Finished Cleanup udev Database.2007machine # [ 3.002327] systemd[1]: Reached target Switch Root.2008machine # [ 3.003632] systemd[1]: Starting NixOS Activation...2009machine # [ 3.253853] initrd-nixos-activation-start[208]: booting system configuration /nix/store/6jjral78h0pim0k25ahd9qxi06rwmd23-nixos-system-machine-test2010machine # [ 3.367347] initrd-nixos-activation-start[208]: running activation script...2011machine # [ 3.911283] initrd-nixos-activation-start[233]: setting up /etc...2012machine # [ 4.294074] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.2013machine # [ 4.297632] systemd[1]: Finished NixOS Activation.2014machine # [ 4.299753] systemd[1]: Starting Switch Root...2015machine # [ 4.335056] systemd[1]: Switching root.2016machine # [ 4.487652] systemd-journald[96]: Received SIGTERM from PID 1 (systemd).2017machine # [ 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)2018machine # [ 5.197649] systemd[1]: Detected virtualization qemu.2019machine # [ 5.197729] systemd[1]: Detected architecture arm64.2020machine # [ 5.443958] systemd[1]: bpf-restrict-fs: LSM BPF program attached2021machine # [ 6.261681] systemd[1]: initrd-switch-root.service: Deactivated successfully.2022machine # [ 6.261935] systemd[1]: Stopped initrd-switch-root.service.2023machine # [ 6.263331] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.2024machine # [ 6.271979] systemd[1]: Created slice Slice /system/getty.2025machine # [ 6.275077] systemd[1]: Created slice User and Session Slice.2026machine # [ 6.275970] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.2027machine # [ 6.277333] systemd[1]: Started Forward Password Requests to Wall Directory Watch.2028machine # [ 6.278473] systemd[1]: Expecting device /dev/hvc0...2029machine # [ 6.279564] systemd[1]: Expecting device /dev/ttyAMA0...2030machine # [ 6.280634] systemd[1]: Reached target Local Encrypted Volumes.2031machine # [ 6.281704] systemd[1]: Reached target flakelet contract providers ready.2032machine # [ 6.282780] systemd[1]: Stopped target initrd-fs.target.2033machine # [ 6.283838] systemd[1]: Stopped target initrd-root-fs.target.2034machine # [ 6.284970] systemd[1]: Stopped target initrd-switch-root.target.2035machine # [ 6.286030] systemd[1]: Reached target Virtual Machines and Containers.2036machine # [ 6.287159] systemd[1]: Reached target Path Units.2037machine # [ 6.288203] systemd[1]: Reached target Remote File Systems.2038machine # [ 6.289231] systemd[1]: Reached target Slice Units.2039machine # [ 6.290264] systemd[1]: Reached target Swaps.2040machine # [ 6.296345] systemd[1]: Listening on Query the User Interactively for a Password.2041machine # [ 6.303270] systemd[1]: Listening on Process Core Dump Socket.2042machine # [ 6.308782] systemd[1]: Listening on Credential Encryption/Decryption.2043machine # [ 6.314290] systemd[1]: Listening on Factory Reset Management.2044machine # [ 6.315705] systemd[1]: Listening on Hostname Service Socket.2045machine # [ 6.327618] systemd[1]: Starting Journal Log Access Socket...2046machine # [ 6.329687] systemd[1]: Listening on Journal Audit Socket.2047machine # [ 6.335385] systemd[1]: Listening on Console Output Muting Service Socket.2048machine # [ 6.336953] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.2049machine # [ 6.338005] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2050machine # [ 6.339013] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2051machine # [ 6.353382] systemd[1]: Listening on Disk Repartitioning Service Socket.2052machine # [ 6.354584] systemd[1]: Listening on udev Control Socket.2053machine # [ 6.355764] systemd[1]: Listening on udev Varlink Socket.2054machine # [ 6.364222] systemd[1]: Mounting Huge Pages File System...2055machine # [ 6.376423] systemd[1]: Mounting POSIX Message Queue File System...2056machine # [ 6.385267] systemd[1]: Mounting Kernel Debug File System...2057machine # [ 6.395246] systemd[1]: Mounting Kernel Trace File System...2058machine # [ 6.407899] systemd[1]: Starting Create List of Static Device Nodes...2059machine # [ 6.419894] systemd[1]: Starting Load Kernel Module 9pnet_virtio...2060machine # [ 6.420919] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs2061machine # [ 6.452698] systemd[1]: Mounting Kernel Configuration File System...2062machine # [ 6.453606] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm2063machine # [ 6.454456] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2064machine # [ 6.462679] systemd[1]: Starting Load Kernel Module fuse...2065machine # [ 6.465298] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672066machine # [ 6.511843] systemd[1]: Starting Journal Service...2067machine # [ 6.517469] systemd[1]: Starting Load Kernel Modules...2068machine # [ 6.524015] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...2069machine # [ 6.529095] systemd[1]: Starting Remount Root and Kernel File Systems...2070machine # [ 6.529846] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2071machine # [ 6.543407] systemd[1]: Starting Coldplug All udev Devices...2072machine # [ 6.549606] systemd[1]: Listening on Journal Log Access Socket.2073machine # [ 6.550479] systemd[1]: Mounted Huge Pages File System.2074machine # [ 6.551656] systemd[1]: Mounted POSIX Message Queue File System.2075machine # [ 6.552637] systemd[1]: Mounted Kernel Debug File System.2076machine # [ 6.553452] systemd[1]: Mounted Kernel Trace File System.2077machine # [ 6.554916] systemd[1]: Finished Create List of Static Device Nodes.2078machine # [ 6.556322] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.2079machine # [ 6.557360] systemd[1]: Finished Load Kernel Module 9pnet_virtio.2080machine # [ 6.558609] systemd[1]: Mounted Kernel Configuration File System.2081machine # [ 6.570246] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...2082machine # [ 6.582724] fuse: init (API version 7.45)2083machine # [ 6.587763] systemd[1]: modprobe@fuse.service: Deactivated successfully.2084machine # [ 6.589159] systemd[1]: Finished Load Kernel Module fuse.2085machine # [ 6.601483] systemd[1]: Mounting FUSE Control File System...2086machine # [ 6.631167] systemd[1]: Finished Load Kernel Modules.2087machine # [ 6.633891] EXT4-fs (vda): re-mounted 11adae6e-999b-4ff0-99c7-12315f938e3e.2088machine # [ 6.642621] systemd[1]: Starting Firewall...2089machine # [ 6.652632] systemd[1]: Starting Apply Kernel Variables...2090machine # [ 6.656186] systemd[1]: Finished Remount Root and Kernel File Systems.2091machine # [ 6.658642] systemd[1]: Mounted FUSE Control File System.2092machine # [ 6.659438] systemd[1]: Listening on Disk Image Download Service Socket.2093machine # [ 6.661164] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2094machine # [ 6.672568] systemd-journald[305]: Collecting audit messages is enabled.2095machine # [ 6.680554] systemd[1]: Starting Load/Save OS Random Seed...2096machine # [ 6.681155] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2097machine # [ 6.689984] systemd[1]: Queued start job for default target Multi-User System.2098machine # [ 6.695835] systemd[1]: Started Journal Service.2099machine # [ 6.694909] systemd[1]: systemd-journald.service: Deactivated successfully.2100machine # [ 6.703266] systemd-modules-load[306]: Using 2 probe threads2101machine # [ 6.705651] systemd-modules-load[306]: Module 'atkbd' is built in2102machine # [ 6.707089] systemd-modules-load[306]: Module 'loop' is built in2103machine # [ 6.709040] systemd-oomd[307]: No swap; memory pressure usage will be degraded2104machine # [ 6.711232] systemd[1]: Starting Flush Journal to Persistent Storage...2105machine # [ 6.713167] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.2106machine # [ 6.715306] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.2107machine # [ 6.717791] systemd[1]: Starting Create Static Device Nodes in /dev...2108machine # [ 6.746831] systemd[1]: Finished Load/Save OS Random Seed.2109machine # [ 6.749853] systemd[1]: First Boot Complete skipped, unmet condition check ConditionFirstBoot=yes2110machine # [ 6.763017] systemd-journald[305]: Received client request to flush runtime journal.2111machine # [ 6.802719] systemd[1]: Finished Apply Kernel Variables.2112machine # [ 6.806507] systemd[1]: Finished Create Static Device Nodes in /dev.2113machine # [ 6.807716] systemd[1]: Reached target Preparation for Local File Systems.2114machine # [ 6.808835] systemd[1]: Starting Rule-based Manager for Device Events and Files...2115machine # [ 6.809870] systemd[1]: Finished Flush Journal to Persistent Storage.2116machine # [ 6.931481] systemd-udevd[341]: Using default interface naming scheme 'v261'.2117machine # [ 7.031970] systemd[1]: Started Rule-based Manager for Device Events and Files.2118machine # [ 7.231122] systemd[1]: Finished Coldplug All udev Devices.2119machine # [ 7.272371] systemd[1]: Mounting /run/wrappers...2120machine # [ 7.316139] systemd[1]: Mounted /run/wrappers.2121machine # [ 7.318017] systemd[1]: Reached target Local File Systems.2122machine # [ 7.322556] systemd[1]: Listening on Boot Loader Control Service Socket.2123machine # [ 7.400786] systemd[1]: Starting register-nix-paths.service...2124machine # [ 7.410149] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input32125machine # [ 7.460205] systemd[1]: Starting Create SUID/SGID Wrappers...2126machine # [ 7.463123] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2127machine # [ 7.466233] systemd[1]: Save Transient machine-id to Disk skipped, unmet condition check ConditionPathIsMountPoint=/etc/machine-id2128machine # [ 7.488115] systemd[1]: Starting Create System Files and Directories...2129machine # [ 7.525077] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs2130machine # [ 7.534774] systemd[1]: Starting Virtual Console Setup...2131machine # [ 7.544062] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.2132machine # [ 7.586988] systemd[1]: Finished Create System Files and Directories.2133machine # [ 7.591663] systemd[1]: Rebuild Journal Catalog skipped, unmet condition check ConditionNeedsUpdate=/var2134machine # [ 7.597440] systemd[1]: Update is Completed skipped, no trigger condition checks were met.2135machine # [ 7.600037] systemd[1]: Starting Record System Boot/Shutdown in UTMP...2136machine # [ 7.610830] (udev-worker)[375]: Network interface NamePolicy= disabled on kernel command line.2137machine # [ 7.616806] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.2138machine # [ 7.630925] (udev-worker)[374]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.2139machine # [ 7.641073] (udev-worker)[374]: Network interface NamePolicy= disabled on kernel command line.2140machine # [ 7.655158] systemd[1]: Finished Record System Boot/Shutdown in UTMP.2141machine # [ 7.677764] systemd[1]: Condition check resulted in Virtio network device being skipped.2142machine # [ 7.681109] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2143machine # [ 7.685429] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2144machine # [ 7.690376] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672145machine # [ 7.700491] systemd[1]: Rebuild Journal Catalog skipped, unmet condition check ConditionNeedsUpdate=/var2146machine # [ 7.702373] systemd[1]: Save Transient machine-id to Disk skipped, unmet condition check ConditionPathIsMountPoint=/etc/machine-id2147machine # [ 7.708774] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2148machine # [ 7.712193] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2149machine # [ 7.715465] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2150machine # [ 7.720584] systemd[1]: Update is Completed skipped, no trigger condition checks were met.2151machine # [ 7.738545] mousedev: PS/2 mouse device common for all mice2152machine # [ 7.828755] systemd[1]: Finished Firewall.2153machine # [ 7.975796] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2154machine # [ 7.978174] systemd[1]: Finished Create SUID/SGID Wrappers.2155machine # [ 8.040613] systemd-vconsole-setup[446]: Configuration of first virtual console was skipped, ignoring remaining ones.2156machine # [ 8.044380] systemd[1]: Finished Virtual Console Setup.2157machine # [ 8.145980] systemd[1]: Finished register-nix-paths.service.2158machine # [ 8.148100] systemd[1]: Reached target System Initialization.2159machine # [ 8.150375] systemd[1]: Started Discard unused filesystem blocks once a week.2160machine # [ 8.153324] systemd[1]: Started Daily Cleanup of Temporary Directories.2161machine # [ 8.154289] systemd[1]: Reached target Timer Units.2162machine # [ 8.155053] systemd[1]: Listening on D-Bus System Message Bus Socket.2163machine # [ 8.157133] systemd[1]: Listening on Nix Daemon Socket.2164machine # [ 8.157936] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.2165machine # [ 8.163599] systemd[1]: Reached target Socket Units.2166machine # [ 8.164961] systemd[1]: Reached target Basic System.2167machine # [ 8.167448] systemd[1]: Started backdoor.service.2168machine # [ 8.175593] systemd[1]: Starting Re-link flakelet services at boot...2169machine # [ 8.177183] systemd[1]: Import lastlog data into lastlog2 database skipped, unmet condition check ConditionPathExists=!/var/lib/lastlog/lastlog2.db2170machine # [ 8.194170] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2171machine # [ 8.200159] systemd[1]: Starting Post-Boot Actions...2172machine # [ 8.210021] systemd[1]: Started Reset console on configuration changes.2173machine # [ 8.213696] systemd[1]: Starting resolvconf update...2174machine # [ 8.234906] systemd[1]: Starting D-Bus System Message Bus...2175machine # [ 8.268063] systemd[1]: Finished Post-Boot Actions.2176machine # connecting to host...2177machine # [ 8.278032] systemd[1]: Reload requested from client PID 564 ('systemctl') (unit flakelet-boot.service)...2178machine # [ 8.280431] systemd[1]: Reloading...2179machine # [ 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"2180machine: Guest shell says: b'Spawning backdoor root shell...\n'2181machine: connected to guest root shell2182machine: (connecting took 8.72 seconds)2183machine: (finished: waiting for the VM to finish booting, in 8.72 seconds)2184machine # [ 8.368274] dbus-broker-launch[557]: Looking up NSS user entry for 'systemd-timesync'...2185machine # [ 8.835417] systemd[1]: Reloading finished in 551 ms.2186machine # [ 8.882792] systemd[1]: Started Name Service Cache Daemon (nsncd).2187machine # [ 8.893375] dbus-broker-launch[557]: NSS returned no entry for 'systemd-timesync'2188machine # [ 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"2189machine # [ 8.924706] systemd[1]: Started D-Bus System Message Bus.2190machine # [ 8.953931] dbus-broker-launch[557]: Ready2191machine # [ 8.960627] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...2192machine # [ 8.964684] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.2193machine # [ 8.968722] systemd[1]: Stopped Virtual Console Setup.2194machine # [ 8.972917] systemd[1]: Stopping Virtual Console Setup...2195machine # [ 8.976418] systemd[1]: Starting Virtual Console Setup...2196machine # [ 8.979452] systemd[1]: nscd.service: Deactivated successfully.2197machine # [ 8.985378] systemd[1]: Stopped Name Service Cache Daemon (nsncd).2198machine # [ 8.986387] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2199machine # [ 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"2200machine # [ 9.038592] systemd[1]: Started Name Service Cache Daemon (nsncd).2201machine # [ 9.044169] systemd[1]: Reload requested from client PID 672 ('systemctl') (unit flakelet-boot.service)...2202machine # [ 9.050605] systemd[1]: Reloading...2203machine # [ 9.307516] systemd-vconsole-setup[661]: Configuration of first virtual console was skipped, ignoring remaining ones.2204machine # [ 9.639992] systemd[1]: Reloading finished in 598 ms.2205machine # [ 9.703556] systemd[1]: Finished Virtual Console Setup.2206machine # [ 9.737686] systemd[1]: Created slice Slice /system/cli-echo.2207machine # [ 9.740325] systemd[1]: Reached target Host and Network Name Lookups.2208machine # [ 9.742938] systemd[1]: Reached target User and Group Name Lookups.2209machine # [ 9.745622] systemd[1]: Listening on cli-echo@1.socket.2210machine # [ 9.747874] systemd[1]: Listening on cli-echo@2.socket.2211machine # [ 9.753102] systemd[1]: Starting User Login Management...2212machine # [ 9.765364] systemd[1]: Starting prebuilt flakelet service cli...2213machine # [ 9.785126] systemd[1]: Finished resolvconf update.2214machine # [ 9.792823] systemd[1]: Reached target Preparation for Network.2215machine # [ 9.802849] systemd[1]: Starting DHCP Client...2216machine # [ 9.809402] systemd[1]: Starting Address configuration of eth1...2217machine # [ 9.817081] systemd[1]: Starting Extra networking commands....2218machine # [ 9.822455] systemd[1]: Started prebuilt flakelet service cli.2219machine # [ 9.831642] systemd[1]: Reload requested from client PID 728 ('systemctl') (unit flakelet-boot.service)...2220machine # [ 9.838958] systemd[1]: Reloading...2221machine # [ 9.899582] systemd-logind[721]: New seat seat0.2222machine # [ 9.909474] systemd-logind[721]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)2223machine # [ 9.910946] systemd-logind[721]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)2224machine # [ 9.912407] systemd-logind[721]: Watching system buttons on /dev/input/event0 (gpio-keys)2225machine # [ 9.958984] network-addresses-eth1-start[732]: adding address 192.168.1.1/24... done2226machine # [ 9.974260] network-addresses-eth1-start[732]: adding address 2001:db8:1::1/64... done2227machine # [ 10.438190] systemd[1]: Reloading finished in 603 ms.2228machine # [ 10.515665] systemd[1]: Started User Login Management.2229machine # [ 10.519086] systemd[1]: Finished Address configuration of eth1.2230machine # [ 10.522041] systemd[1]: Finished Extra networking commands..2231machine # [ 10.549146] systemd[1]: Reached target Network.2232machine # [ 10.553725] systemd[1]: Starting linger-users.service...2233machine # [ 10.560850] systemd[1]: Starting Permit User Sessions...2234machine # [ 10.623418] systemd[1]: linger-users.service: Deactivated successfully.2235machine # [ 10.624657] systemd[1]: Finished linger-users.service.2236machine # [ 10.625570] systemd[1]: Finished Permit User Sessions.2237machine # [ 10.633952] systemd[1]: Reload requested from client PID 838 ('systemctl') (unit flakelet-boot.service)...2238machine # [ 10.635624] systemd[1]: Reloading...2239machine # [ 11.269792] systemd[1]: Reloading finished in 631 ms.2240machine # [ 11.376428] systemd[1]: Created slice Slice /system/static-echo.2241machine # [ 11.379066] systemd[1]: Listening on static-echo@1.socket.2242machine # [ 11.381546] systemd[1]: Listening on static-echo@2.socket.2243machine # [ 11.384468] systemd[1]: Started Getty on tty1.2244machine # [ 11.387358] systemd[1]: Reached target Login Prompts.2245machine # [ 11.392444] systemd[1]: Starting prebuilt flakelet service static...2246machine # [ 11.412916] systemd[1]: Reload requested from client PID 880 ('systemctl') (unit flakelet-boot.service)...2247machine # [ 11.419416] systemd[1]: Reloading...2248machine # [ 11.487718] dhcpcd[842]: dhcpcd-10.3.2 starting2249machine # [ 11.506958] dhcpcd[898]: dev: loaded udev2250machine # [ 11.509313] dhcpcd[898]: DUID 00:01:00:01:32:27:eb:ac:52:54:00:12:34:562251machine # [ 11.554339] 8021q: 802.1Q VLAN Support v1.82252machine # [ 11.555083] 8021q: adding VLAN 0 to HW filter on device eth12253machine # [ 11.649497] cfg80211: Loading compiled-in X.509 certificates for regulatory database2254machine # [ 11.682016] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'2255machine # [ 11.683419] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'2256machine # [ 11.688153] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -22257machine # [ 11.689065] cfg80211: failed to load regulatory.db2258machine # [ 11.776121] 8021q: adding VLAN 0 to HW filter on device eth02259machine # [ 11.774515] dhcpcd[898]: eth0: waiting for carrier2260machine # [ 11.780748] dhcpcd[898]: eth0: carrier acquired2261machine # [ 11.786401] dhcpcd[898]: eth0: IAID 00:12:34:562262machine # [ 11.789273] dhcpcd[898]: eth0: adding address fe80::5054:ff:fe12:34562263machine # [ 12.095459] systemd[1]: Reloading finished in 679 ms.2264machine # [ 12.195995] systemd[1]: Started prebuilt flakelet service static.2265machine # [ 12.233112] systemd[1]: Reload requested from client PID 931 ('systemctl') (unit flakelet-boot.service)...2266machine # [ 12.241701] systemd[1]: Reloading...2267machine # [ 12.865610] systemd[1]: Reloading finished in 628 ms.2268machine # [ 12.942378] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.2269machine # [ 13.030424] systemd[1]: Starting flakelet test service...2270machine # [ 13.035448] flakelet[551]: cli: units re-linked2271machine # [ 13.037196] flakelet[551]: static: units re-linked2272machine # [ 13.038057] flakelet[551]: web: units re-linked2273machine # [ 13.041449] systemd[1]: Finished Re-link flakelet services at boot.2274machine # [ 13.069080] systemd[1]: Starting Reconcile flakelet services with the host configuration...2275machine # [ 13.083740] systemd[1]: Started flakelet test service.2276machine # [ 13.122271] systemd[1]: Finished Reconcile flakelet services with the host configuration.2277machine # [ 13.128530] systemd[1]: Starting Update flakelet service static...2278machine # [ 13.134276] systemd[1]: Starting Update flakelet service web...2279machine # [ 13.182119] flakelet[991]: static: using prebuilt artifact /nix/store/i681mnikp0zi79fghryxjffl3amkxnhn-flakelet-static2280machine # [ 13.191876] flakelet[991]: static: up to date2281machine # [ 13.194623] systemd[1]: Finished Update flakelet service static.2282machine # [ 13.199460] flakelet[992]: web: resolving path:/nix/store/1ndj6dy6hwr8inncmsdbwhm9pd6vbdvp-flake.nix2283machine # [ 13.256585] dhcpcd[898]: eth0: soliciting an IPv6 router2284machine # [ 13.258901] dhcpcd[898]: eth0: Router Advertisement from fe80::22285machine # [ 13.261440] dhcpcd[898]: eth0: adding address fec0::5054:ff:fe12:3456/642286machine # [ 13.264716] dhcpcd[898]: eth0: adding route to fec0::/642287machine # [ 13.267813] dhcpcd[898]: eth0: adding default route via fe80::22288machine # [ 13.288977] systemd[1]: Started Nix Daemon.2289machine # [ 13.427408] nix-daemon[1000]: accepted connection from pid 994, user flakelet2290machine # [ 13.531139] dhcpcd[898]: eth0: rebinding lease of 10.0.2.152291machine # [ 13.580834] dhcpcd[898]: eth0: probing address 10.0.2.15/242292machine # [ 13.584359] flakelet[992]: web: evaluating /nix/store/5021f2kwgs9vhdrqlvahpgzg3fc0adgq-flakelet-driver.nix2293machine # [ 13.685214] nix-daemon[1000]: accepted connection from pid 1019, user flakelet2294machine: (finished: waiting for unit web.service, in 14.56 seconds)2295machine: waiting for unit cli.service2296machine: (finished: waiting for unit cli.service, in 0.13 seconds)2297(finished: run the VM test script, in 86.70 seconds)2298test script finished in 86.76s2299cleanup2300kill QemuMachine (pid 91)2301machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/ymm5c1kb7p2r6331bgcdxijayqhcbvqy-python3-3.14.6/bin/python3.14)2302(finished: cleanup, in 0.31 seconds)