elastic-arm-e65ee682: building l269cj68pif7g3wwvfl9w1rhffbv2p6d-vm-test-run-maintainer-mode.drv Machine state will be reset. To keep it, pass --keep-machine-state start all VLans (finished: start all VLans, in 0.00 seconds) Test will time out and terminate in 3600.0 seconds run the VM test script additionally exposed symbols: machine, vlan1, start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh machine: waiting for unit maintainer-mode.service machine: waiting for the VM to finish booting machine: starting vm machine # Disk image does not exist, creating the virtualisation disk image... machine # Formatting '/build/vm-state-machine/tmp.depcDncLdp', fmt=raw size=1073741824 machine # mke2fs 1.47.4 (6-Mar-2025) machine: QEMU running (pid 45) machine # Discarding device blocks: 0/262144 done machine # Creating filesystem with 262144 4k blocks and 65536 inodes machine # Filesystem UUID: 06135a21-e688-4aa4-b89d-ea8f13802f42 machine # Superblock backups stored on blocks: machine # 32768, 98304, 163840, 229376 machine # machine # Allocating group tables: 0/8 done machine # Writing inode tables: 0/8 done machine # Creating journal (8192 blocks): done machine # Writing superblocks and filesystem accounting information: 0/8 done machine # machine # Virtualisation disk image created. machine # Starting virtiofs daemons... machine # [2026-10-24T20:10:29Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-24T20:10:29Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-24T20:10:29Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-24T20:10:29Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-24T20:10:29Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-24T20:10:29Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-24T20:10:29Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-24T20:10:29Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-24T20:10:29Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-24T20:10:29Z INFO virtiofsd] Client connected, servicing requests machine # [2026-10-24T20:10:29Z INFO virtiofsd] Client connected, servicing requests machine # [2026-10-24T20:10:29Z INFO virtiofsd] Client connected, servicing requests machine # qemu-system-aarch64: Could not access KVM kernel module: No such file or directory machine # qemu-system-aarch64: failed to initialize kvm: No such file or directory machine # qemu-system-aarch64: falling back to tcg machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x000f0510] machine # [ 0.000000] Linux version 6.18.53 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Mon Sep 21 13:06:06 UTC 2026 machine # [ 0.000000] KASLR enabled machine # [ 0.000000] random: crng init done machine # [ 0.000000] Machine model: linux,dummy-virt machine # [ 0.000000] efi: UEFI not found. machine # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc07440-0x7fc0abbf] machine # [ 0.000000] Zone ranges: machine # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] DMA32 empty machine # [ 0.000000] Normal empty machine # [ 0.000000] Device empty machine # [ 0.000000] Movable zone start for each node machine # [ 0.000000] Early memory node ranges machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca00000 machine # [ 0.000000] psci: probing for conduit method from DT. machine # [ 0.000000] psci: PSCIv1.1 detected in firmware. machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs machine # [ 0.000000] psci: Trusted OS migration not required machine # [ 0.000000] psci: SMC Calling Convention v1.0 machine # [ 0.000000] percpu: Embedded 76 pages/cpu s186776 r8192 d116328 u311296 machine # [ 0.000000] Detected PIPT I-cache on CPU0 machine # [ 0.000000] CPU features: detected: Address authentication (IMP DEF algorithm) machine # [ 0.000000] CPU features: detected: GICv3 CPU interface machine # [ 0.000000] CPU features: detected: HCRX_EL2 register machine # [ 0.000000] CPU features: detected: Stage-1 Permission Indirection Extension (S1PIE) machine # [ 0.000000] CPU features: detected: 52-bit Virtual Addressing (LPA2) machine # [ 0.000000] CPU features: detected: Store Only MTE Tag Check machine # [ 0.000000] CPU features: detected: Spectre-v4 machine # [ 0.000000] alternatives: applying boot alternatives machine # [ 0.000000] Kernel command line: console=ttyAMA0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/gq880zyaiimz3n8gvl4dd201gsgk06yq-nixos-system-machine-test/init regInfo=/nix/.ro-store/vf5if7j3f27i0xy700vyzwif3a7v4k68-closure-info/registration console=ttyAMA0,115200n8 console=tty0 machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/vf5if7j3f27i0xy700vyzwif3a7v4k68-closure-info/registration", will be passed to user space. machine # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes machine # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) machine # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) machine # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB machine # [ 0.000000] software IO TLB: area num 1. machine # [ 0.000000] software IO TLB: mapped [mem 0x000000007c733000-0x000000007c833000] (1MB) machine # [ 0.000000] Fallback order for Node 0: 0 machine # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144 machine # [ 0.000000] Policy zone: DMA machine # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off machine # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 machine # [ 0.000000] allocated 2097152 bytes of page_ext machine # [ 0.000000] ftrace: allocating 74963 entries in 294 pages machine # [ 0.000000] ftrace: allocated 294 pages with 4 groups machine # [ 0.000000] rcu: Hierarchical RCU implementation. machine # [ 0.000000] rcu: RCU event tracing is enabled. machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. machine # [ 0.000000] Trampoline variant of Tasks RCU enabled. machine # [ 0.000000] Rude variant of Tasks RCU enabled. machine # [ 0.000000] Tracing variant of Tasks RCU enabled. machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 machine # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 machine # [ 0.000000] GICv3: 256 SPIs implemented machine # [ 0.000000] GICv3: 0 Extended SPIs implemented machine # [ 0.000000] Root IRQ handler: gic_handle_irq machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0 machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1) machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1) machine # [ 0.000000] GICv3: using LPI property table @0x0000000044d00000 machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d10000 machine # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. machine # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns machine # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt). machine # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns machine # [ 0.000081] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns machine # [ 0.005808] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) machine # [ 0.032783] Console: colour dummy device 80x25 machine # [ 0.036333] printk: legacy console [tty0] enabled machine # [ 0.050770] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) machine # [ 0.051713] pid_max: default: 32768 minimum: 301 machine # [ 0.058738] LSM: initializing lsm=capability,landlock,yama,bpf,ima machine # [ 0.061621] landlock: Up and running. machine # [ 0.061779] Yama: becoming mindful. machine # [ 0.064036] LSM support for eBPF active machine # [ 0.069864] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.070136] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.165306] rcu: Hierarchical SRCU implementation. machine # [ 0.165511] rcu: Max phase no-delay instances is 1000. machine # [ 0.184863] fsl-mc MSI: its@8080000 domain created machine # [ 0.189514] EFI services will not be available. machine # [ 0.193120] smp: Bringing up secondary CPUs ... machine # [ 0.194470] smp: Brought up 1 node, 1 CPU machine # [ 0.194613] SMP: Total of 1 processors activated. machine # [ 0.194728] CPU: All CPU(s) started at EL1 machine # [ 0.197304] CPU features: detected: Branch Target Identification machine # [ 0.197486] CPU features: detected: 32-bit EL0 Support machine # [ 0.197574] CPU features: detected: 32-bit EL1 Support machine # [ 0.197710] CPU features: detected: ARMv8.4 Translation Table Level machine # [ 0.197810] CPU features: detected: Instruction cache invalidation not required for I/D coherence machine # [ 0.197915] CPU features: detected: Data cache clean to the PoU not required for I/D coherence machine # [ 0.198052] CPU features: detected: Common not Private translations machine # [ 0.198124] CPU features: detected: CRC32 instructions machine # [ 0.198186] CPU features: detected: Data cache clean to Point of Deep Persistence machine # [ 0.198263] CPU features: detected: Data cache clean to Point of Persistence machine # [ 0.198333] CPU features: detected: Data independent timing control (DIT) machine # [ 0.198401] CPU features: detected: E0PD machine # [ 0.198456] CPU features: detected: Enhanced Counter Virtualization machine # [ 0.198523] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) machine # [ 0.198603] CPU features: detected: Enhanced Privileged Access Never machine # [ 0.198672] CPU features: detected: Enhanced Virtualization Traps machine # [ 0.198737] CPU features: detected: FPMR machine # [ 0.198793] CPU features: detected: Fine Grained Traps machine # [ 0.198889] CPU features: detected: Guarded Control Stack (GCS) machine # [ 0.199037] CPU features: detected: Generic authentication (IMP DEF algorithm) machine # [ 0.199217] CPU features: detected: RCpc load-acquire (LDAPR) machine # [ 0.199340] CPU features: detected: 52-bit Virtual Addressing for KVM (LPA2) machine # [ 0.199412] CPU features: detected: LSE atomic instructions machine # [ 0.199506] CPU features: detected: Memory Copy and Memory Set instructions machine # [ 0.200184] CPU features: detected: Privileged Access Never machine # [ 0.200313] CPU features: detected: PMUv3 machine # [ 0.200372] CPU features: detected: SCTLR2 machine # [ 0.200429] CPU features: detected: RAS Extension Support machine # [ 0.200566] CPU features: detected: RASv1p1 Extension Support machine # [ 0.200647] CPU features: detected: Random Number Generator machine # [ 0.200712] CPU features: detected: Speculation barrier (SB) machine # [ 0.200776] CPU features: detected: Stage-2 Force Write-Back machine # [ 0.200840] CPU features: detected: Trap EL0 IMPLEMENTATION DEFINED functionality machine # [ 0.200916] CPU features: detected: TLB range maintenance instructions machine # [ 0.200984] CPU features: detected: WFx with timeout machine # [ 0.201168] CPU features: detected: FAR on MTE Tag Check Fault machine # [ 0.201237] CPU features: detected: Scalable Matrix Extension machine # [ 0.201301] CPU features: detected: FA64 machine # [ 0.201356] CPU features: detected: SME2 machine # [ 0.201412] CPU features: detected: Speculative Store Bypassing Safe (SSBS) machine # [ 0.201484] CPU features: detected: Scalable Vector Extension machine # [ 0.219470] alternatives: applying system-wide alternatives machine # [ 0.244731] CPU features: detected: Hardware dirty bit management on CPU0 machine # [ 0.246178] SVE: maximum available vector length 256 bytes per vector machine # [ 0.246362] SVE: default vector length 64 bytes per vector machine # [ 0.248850] SME: minimum available vector length 16 bytes per vector machine # [ 0.248995] SME: maximum available vector length 256 bytes per vector machine # [ 0.249089] SME: default vector length 32 bytes per vector machine # [ 0.278005] Memory: 889420K/1048576K available (24448K kernel code, 7094K rwdata, 26592K rodata, 4736K init, 1107K bss, 117868K reserved, 32768K cma-reserved) machine # [ 0.325454] devtmpfs: initialized machine # [ 0.385418] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.386261] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). machine # [ 0.392518] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL machine # [ 0.392773] 0 pages in range for non-PLT usage machine # [ 0.392912] 508224 pages in range for PLT usage machine # [ 0.398806] pinctrl core: initialized pinctrl subsystem machine # [ 0.425232] DMI not present or invalid. machine # [ 0.459768] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.485100] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations machine # [ 0.488647] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations machine # [ 0.492242] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.493142] audit: initializing netlink subsys (disabled) machine # [ 0.497842] audit: type=2000 audit(0.416:1): state=initialized audit_enabled=0 res=1 machine # [ 0.512873] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.512994] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.513116] thermal_sys: Registered thermal governor 'step_wise' machine # [ 0.513188] thermal_sys: Registered thermal governor 'user_space' machine # [ 0.513256] thermal_sys: Registered thermal governor 'power_allocator' machine # [ 0.514533] cpuidle: using governor ladder machine # [ 0.514982] cpuidle: using governor menu machine # [ 0.519721] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. machine # [ 0.520689] ASID allocator initialised with 65536 entries machine # [ 0.541209] Serial: AMBA PL011 UART driver machine # [ 0.690487] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 machine # [ 0.695727] printk: console [ttyAMA0] enabled machine # [ 0.893388] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages machine # [ 0.893581] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.893774] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages machine # [ 0.893856] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page machine # [ 0.893936] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.894010] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.894088] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages machine # [ 0.894161] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page machine # [ 0.952523] fbcon: Taking over console machine # [ 0.953199] ACPI: Interpreter disabled. machine # [ 1.000529] iommu: Default domain type: Translated machine # [ 1.000740] iommu: DMA domain TLB invalidation policy: strict mode machine # [ 1.008225] SCSI subsystem initialized machine # [ 1.024204] usbcore: registered new interface driver usbfs machine # [ 1.024934] usbcore: registered new interface driver hub machine # [ 1.025337] usbcore: registered new device driver usb machine # [ 1.040814] pps_core: LinuxPPS API ver. 1 registered machine # [ 1.040971] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti machine # [ 1.041189] PTP clock support registered machine # [ 1.042138] EDAC MC: Ver: 3.0.0 machine # [ 1.054861] scmi_core: SCMI protocol bus registered machine # [ 1.071729] FPGA manager framework machine # [ 1.119704] vgaarb: loaded machine # [ 1.139400] clocksource: Switched to clocksource arch_sys_counter machine # [ 1.258760] VFS: Disk quotas dquot_6.6.0 machine # [ 1.260172] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) machine # [ 1.268372] netfs: FS-Cache loaded machine # [ 1.271862] pnp: PnP ACPI: disabled machine # [ 1.340650] NET: Registered PF_INET protocol family machine # [ 1.342669] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) machine # [ 1.574199] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 1.574605] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) machine # [ 1.577827] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) machine # [ 1.578382] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) machine # [ 1.580283] TCP: Hash tables configured (established 8192 bind 8192) machine # [ 1.582814] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) machine # [ 1.584772] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 1.585245] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 1.589564] NET: Registered PF_UNIX/PF_LOCAL protocol family machine # [ 1.590404] NET: Registered PF_XDP protocol family machine # [ 1.590848] PCI: CLS 0 bytes, default 64 machine # [ 1.603876] Trying to unpack rootfs image as initramfs... machine # [ 1.615263] kvm [1]: HYP mode not available machine # [ 2.271513] Initialise system trusted keyrings machine # [ 2.274345] workingset: timestamp_bits=42 max_order=18 bucket_order=0 machine # [ 2.292333] squashfs: version 4.0 (2009/01/31) Phillip Lougher machine # [ 2.303351] 9p: Installing v9fs 9p2000 file system support machine # [ 2.566088] Key type asymmetric registered machine # [ 2.566403] Asymmetric key parser 'x509' registered machine # [ 2.568486] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) machine # [ 2.572848] io scheduler mq-deadline registered machine # [ 2.573062] io scheduler kyber registered machine # [ 2.733959] pl061_gpio 9030000.pl061: PL061 GPIO chip registered machine # [ 2.761282] ledtrig-cpu: registered to indicate activity on CPUs machine # [ 2.770702] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: machine # [ 2.780466] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 machine # [ 2.781472] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 machine # [ 2.781754] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 machine # [ 2.795763] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits machine # [ 2.796928] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] machine # [ 2.801867] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 machine # [ 2.802521] pci_bus 0000:00: root bus resource [bus 00-ff] machine # [ 2.802882] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] machine # [ 2.805807] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] machine # [ 2.805929] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] machine # [ 2.816885] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint machine # [ 2.826423] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 2.835561] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] machine # [ 2.835868] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 2.836010] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 2.836212] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 2.837801] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 2.838035] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] machine # [ 2.838128] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 2.838222] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 2.852183] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 2.852468] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f] machine # [ 2.852564] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 2.852686] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 2.853950] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 2.854173] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] machine # [ 2.854265] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 2.854361] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 2.854454] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 2.864247] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint machine # [ 2.864515] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 2.864641] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 2.866020] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 2.866246] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 2.866347] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 2.876089] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint machine # [ 2.876350] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff] machine # [ 2.877887] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 2.878113] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 2.878215] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 2.888007] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 2.888294] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 2.888400] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 2.889796] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 2.890025] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 2.890128] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 2.904104] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint machine # [ 2.904521] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] machine # [ 2.904649] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 2.904749] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 2.906024] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 2.906246] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] machine # [ 2.906337] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 2.906431] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 2.915366] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned machine # [ 2.915819] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned machine # [ 2.916084] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned machine # [ 2.916417] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned machine # [ 2.916624] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned machine # [ 2.916771] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned machine # [ 2.916905] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned machine # [ 2.917034] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned machine # [ 2.917163] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned machine # [ 2.917293] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned machine # [ 2.917421] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned machine # [ 2.917547] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned machine # [ 2.917772] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned machine # [ 2.917942] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned machine # [ 2.918066] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned machine # [ 2.918169] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned machine # [ 2.918268] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned machine # [ 2.918368] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned machine # [ 2.918467] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned machine # [ 2.918567] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned machine # [ 2.918723] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned machine # [ 2.939389] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned machine # [ 2.939582] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned machine # [ 2.939718] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned machine # [ 2.939828] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned machine # [ 2.939976] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned machine # [ 2.940119] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned machine # [ 2.940219] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned machine # [ 2.940317] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned machine # [ 2.940415] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned machine # [ 2.940513] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned machine # [ 2.941182] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] machine # [ 2.941321] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] machine # [ 2.941413] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] machine # [ 2.960512] pci 0000:00:07.0: enabling device (0000 -> 0002) machine # [ 3.317456] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) machine # [ 3.343619] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) machine # [ 3.347845] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) machine # [ 3.359694] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) machine # [ 3.364009] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002) machine # [ 3.376054] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002) machine # [ 3.379904] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) machine # [ 3.382585] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) machine # [ 3.393352] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002) machine # [ 3.404302] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) machine # [ 3.408828] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) machine # [ 3.507517] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 3.552125] msm_serial: driver initialized machine # [ 3.554409] SuperH (H)SCI(F) driver initialized machine # [ 3.563862] STM32 USART driver initialized machine # [ 3.781360] loop: module loaded machine # [ 3.782494] virtio_blk virtio2: 1/0/0 default/read/poll queues machine # [ 3.797085] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 3.861199] megasas: 07.734.00.00-rc1 machine # [ 3.883171] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] machine # [ 3.904262] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 3.905214] Intel/Sharp Extended Query Table at 0x0031 machine # [ 3.909431] Using buffer write method machine # [ 3.910566] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] machine # [ 3.919758] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 3.920023] Intel/Sharp Extended Query Table at 0x0031 machine # [ 3.921500] Using buffer write method machine # [ 3.921893] Concatenating MTD devices: machine # [ 3.921988] (0): "0.flash" machine # [ 3.922055] (1): "0.flash" machine # [ 3.922118] into device "0.flash" machine # [ 5.199935] Freeing initrd memory: 26892K machine # [ 5.439274] tun: Universal TUN/TAP device driver, 1.6 machine # [ 5.468693] thunder_xcv, ver 1.0 machine # [ 5.469178] thunder_bgx, ver 1.0 machine # [ 5.469586] nicpf, ver 1.0 machine # [ 5.480372] e1000: Intel(R) PRO/1000 Network Driver machine # [ 5.480521] e1000: Copyright (c) 1999-2006 Intel Corporation. machine # [ 5.480942] e1000e: Intel(R) PRO/1000 Network Driver machine # [ 5.481031] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. machine # [ 5.481400] igb: Intel(R) Gigabit Ethernet Network Driver machine # [ 5.481486] igb: Copyright (c) 2007-2014 Intel Corporation. machine # [ 5.481970] igbvf: Intel(R) Gigabit Virtual Function Network Driver machine # [ 5.482076] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. machine # [ 5.488296] sky2: driver version 1.30 machine # [ 5.516019] ehci-pci 0000:00:07.0: EHCI Host Controller machine # [ 5.516963] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1 machine # [ 5.522376] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000 machine # [ 5.531550] usbcore: registered new interface driver usb-storage machine # [ 5.532752] usbcore: registered new interface driver usbserial_generic machine # [ 5.533231] usbserial: USB Serial support registered for generic machine # [ 5.543577] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00 machine # [ 5.560135] hv_vmbus: registering driver hyperv_keyboard machine # [ 5.566078] hub 1-0:1.0: USB hub found machine # [ 5.568077] hub 1-0:1.0: 6 ports detected machine # [ 5.590768] rtc-pl031 9010000.pl031: registered as rtc0 machine # [ 5.591999] rtc-pl031 9010000.pl031: setting system clock to 2026-10-24T20:10:36 UTC (1792872636) machine # [ 5.598490] i2c_dev: i2c /dev entries driver machine # [ 5.652816] sdhci: Secure Digital Host Controller Interface driver machine # [ 5.652980] sdhci: Copyright(c) Pierre Ossman machine # [ 5.658861] Synopsys Designware Multimedia Card Interface Driver machine # [ 5.666181] sdhci-pltfm: SDHCI platform and OF driver helper machine # [ 5.690426] hid: raw HID events driver (C) Jiri Kosina machine # [ 5.696277] usbcore: registered new interface driver usbhid machine # [ 5.696421] usbhid: USB HID core driver machine # [ 5.722235] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available machine # [ 5.747937] drop_monitor: Initializing network drop monitor service machine # [ 5.750396] NET: Registered PF_INET6 protocol family machine # [ 5.769246] Segment Routing with IPv6 machine # [ 5.769943] In-situ OAM (IOAM) with IPv6 machine # [ 5.772295] NET: Registered PF_PACKET protocol family machine # [ 5.774022] 9pnet: Installing 9P2000 support machine # [ 5.775938] Key type dns_resolver registered machine # [ 5.844068] usb 1-1: new high-speed USB device number 2 using ehci-pci machine # [ 5.889516] registered taskstats version 1 machine # [ 5.895680] Loading compiled-in X.509 certificates machine # [ 6.077843] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input0 machine # [ 6.092353] Demotion targets for Node 0: null machine # [ 6.094708] Key type .fscrypt registered machine # [ 6.095669] Key type fscrypt-provisioning registered machine # [ 6.101445] ima: No TPM chip found, activating TPM-bypass! machine # [ 6.101714] ima: Allocated hash algorithm: sha1 machine # [ 6.108095] ima: No architecture policies found machine # [ 6.124007] input: gpio-keys as /devices/platform/gpio-keys/input/input1 machine # [ 6.148205] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:07.0-1/input0 machine # [ 6.257096] clk: Disabling unused clocks machine # [ 6.257581] PM: genpd: Disabling unused power domains machine # [ 6.280932] usb 1-2: new high-speed USB device number 3 using ehci-pci machine # [ 6.565687] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2 machine # [ 6.568083] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input0 machine # [ 6.905735] Freeing unused kernel memory: 4736K machine # [ 6.909018] Run /init as init process machine # [ 7.178482] systemd[1]: Successfully made /usr/ read-only. machine # [ 7.548693] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) machine # [ 7.549233] systemd[1]: Detected virtualization qemu. machine # [ 7.549991] systemd[1]: Detected architecture arm64. machine # [ 7.550185] systemd[1]: Running in initrd. machine # [ 7.570166] systemd[1]: Initializing machine ID from random generator. machine # [ 7.580119] systemd[1]: Hostname set to . machine # [ 9.883670] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 11.388542] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 11.487398] systemd[1]: Created slice Slice /system/modprobe. machine # [ 11.497812] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 11.501444] systemd[1]: Expecting device /dev/disk/by-label/nixos... machine # [ 11.502683] systemd[1]: Reached target Path Units. machine # [ 11.505039] systemd[1]: Reached target Slice Units. machine # [ 11.505656] systemd[1]: Reached target Swaps. machine # [ 11.506236] systemd[1]: Reached target Timer Units. machine # [ 11.515773] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 11.521502] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 11.526291] systemd[1]: Listening on Journal Sockets. machine # [ 11.531661] systemd[1]: Listening on udev Control Socket. machine # [ 11.534167] systemd[1]: Listening on udev Kernel Socket. machine # [ 11.534868] systemd[1]: Reached target Socket Units. machine # [ 11.596840] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 11.603876] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 11.668987] systemd[1]: Mounting Kernel Configuration File System... machine # [ 11.885187] systemd[1]: Starting Journal Service... machine # [ 12.068858] systemd[1]: Starting Load Kernel Modules... machine # [ 12.088234] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 12.176800] systemd[1]: Starting Coldplug All udev Devices... machine # [ 12.457188] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 12.694095] systemd[1]: Mounted Kernel Configuration File System. machine # [ 12.844920] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 13.133221] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. machine # [ 13.152691] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev machine # [ 13.399626] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0 machine # [ 13.400928] [drm] features: -virgl +edid -resource_blob -host_visible machine # [ 13.400993] [drm] features: -context_init machine # [ 13.422120] [drm] number of scanouts: 1 machine # [ 13.422321] [drm] number of cap sets: 0 machine # [ 13.503235] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic machine # [ 13.503510] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0 machine # [ 13.789952] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 13.885499] Console: switching to colour frame buffer device 160x50 machine # [ 13.910196] systemd-journald[72]: Collecting audit messages is disabled. machine # [ 13.932765] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 13.948711] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device machine # [ 14.064452] systemd[1]: Finished Load Kernel Modules. machine # [ 14.244641] systemd[1]: Starting Apply Kernel Variables... machine # [ 14.950493] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 15.000183] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 15.001313] systemd[1]: Reached target Local File Systems. machine # [ 15.137105] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 15.221947] systemd[1]: Finished Apply Kernel Variables. machine # [ 17.856990] systemd[1]: Started Journal Service. machine # [ 17.763509] systemd-modules-load[73]: Inserted module 'dm_mod' machine # [ 17.826366] systemd-modules-load[73]: Module 'virtio_balloon' is built in machine # [ 17.870455] systemd-modules-load[73]: Module 'virtio_console' is built in machine # [ 17.902359] systemd-modules-load[73]: Inserted module 'virtio_gpu' machine # [ 17.933947] systemd-modules-load[73]: Module 'virtio_rng' is built in machine # [ 17.997547] systemd-udevd[79]: Using default interface naming scheme 'v261'. machine # [ 18.039450] systemd[1]: Starting Create System Files and Directories... machine # [ 18.265483] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 18.915209] systemd[1]: Finished Create System Files and Directories. machine # [ 19.896078] systemd[1]: Starting Virtual Console Setup... machine # [ 21.539130] systemd-vconsole-setup[100]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 21.642750] systemd[1]: Finished Virtual Console Setup. machine: Guest root shell did not produce any data yet... machine: To debug, enter the VM and run 'systemctl status backdoor.service'. machine # [ 35.135820] systemd[1]: Finished Coldplug All udev Devices. machine # [ 35.147038] systemd[1]: Reached target System Initialization. machine # [ 35.158494] systemd[1]: Reached target Basic System. machine # [ 42.463683] (udev-worker)[120]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 42.476020] (udev-worker)[120]: Network interface NamePolicy= disabled on kernel command line. machine # [ 42.499328] (udev-worker)[122]: Network interface NamePolicy= disabled on kernel command line. machine # [ 43.645320] systemd[1]: Found device /dev/disk/by-label/nixos. machine # [ 43.657110] systemd[1]: Reached target Initrd Root Device. machine # [ 43.704901] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... machine # [ 44.553065] systemd-fsck[139]: nixos: clean, 12/65536 files, 13019/262144 blocks machine # [ 44.667263] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. machine # [ 44.745180] systemd[1]: Mounting /sysroot... machine # [ 45.429150] EXT4-fs (vda): mounted filesystem 06135a21-e688-4aa4-b89d-ea8f13802f42 r/w with ordered data mode. Quota mode: none. machine # [ 45.420740] systemd[1]: Mounted /sysroot. machine # [ 45.453265] systemd[1]: Reached target Initrd Root File System. machine # [ 45.605120] systemd[1]: Mounting /sysroot/nix/.ro-store... machine # [ 45.735126] systemd[1]: Mounting /sysroot/nix/.rw-store... machine # [ 45.895330] systemd[1]: Mounting /sysroot/run... machine # [ 46.139128] systemd[1]: Mounting /sysroot/tmp/shared... machine # [ 46.283119] systemd[1]: Mounting /sysroot/tmp/xchg... machine # [ 46.450929] systemd[1]: Starting Mountpoints Configured in the Real Root... machine # [ 47.101186] fuse: init (API version 7.45) machine # [ 47.171894] virtiofs virtio6: discovered new tag: nix-store machine # [ 47.194264] virtiofs virtio6: virtio_fs_setup_dax: No cache capability machine # [ 47.221826] virtiofs virtio7: discovered new tag: shared machine # [ 47.238194] virtiofs virtio7: virtio_fs_setup_dax: No cache capability machine # [ 47.253453] virtiofs virtio8: discovered new tag: xchg machine # [ 47.266577] virtiofs virtio8: virtio_fs_setup_dax: No cache capability machine # [ 47.563313] systemd-sysroot-fstab-check[152]: /sysroot should be mounted in the initrd, will request daemon-reload. machine # [ 47.722845] systemd[1]: Mounted /sysroot/nix/.ro-store. machine # [ 47.782477] systemd[1]: Mounted /sysroot/nix/.rw-store. machine # [ 47.793093] systemd[1]: Mounted /sysroot/run. machine # [ 47.803124] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 47.814294] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 47.947729] systemd[1]: Reload requested from client PID 152 ('systemd-sysroot') (unit initrd-parse-etc.service)... machine # [ 47.955046] systemd[1]: Reloading... machine # [ 50.566511] systemd[1]: Reloading finished in 2581 ms. machine # [ 50.821251] systemd-sysroot-fstab-check[152]: Requesting initrd-fs.target/start/replace... machine # [ 50.874337] systemd-sysroot-fstab-check[152]: Requesting swap.target/start/replace... machine # [ 50.953823] systemd[1]: initrd-parse-etc.service: Deactivated successfully. machine # [ 50.966860] systemd[1]: Finished Mountpoints Configured in the Real Root. machine # [ 50.979089] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. machine # [ 51.059150] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 51.477188] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 51.498454] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 51.607960] systemd[1]: Mounting /sysroot/nix/store... machine # [ 52.271413] systemd[1]: Mounted /sysroot/nix/store. machine # [ 52.309180] systemd[1]: Reached target Initrd File Systems. machine # [ 52.343025] systemd[1]: Starting Find NixOS closure... machine # [ 52.394854] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 53.235525] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. machine # [ 53.301011] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. machine # [ 53.759065] systemd[1]: Finished Find NixOS closure. machine # [ 53.789319] systemd[1]: Reached target Initrd Default Target. machine # [ 53.851330] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 54.566698] systemd[1]: Stopped target Initrd Default Target. machine # [ 54.578409] systemd[1]: Stopped target Basic System. machine # [ 54.586629] systemd[1]: Stopped target Initrd Root Device. machine # [ 54.597859] systemd[1]: Stopped target Path Units. machine # [ 54.607237] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 54.629228] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 54.658034] systemd[1]: Stopped target Slice Units. machine # [ 54.670492] systemd[1]: Stopped target Socket Units. machine # [ 54.683086] systemd[1]: Stopped target System Initialization. machine # [ 54.699369] systemd[1]: Stopped target Swaps. machine # [ 54.715720] systemd[1]: Stopped target Timer Units. machine # [ 54.727387] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 54.743132] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 54.761202] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. machine # [ 54.777202] systemd[1]: Stopped Find NixOS closure. machine # [ 54.865308] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 54.871587] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 54.903377] systemd[1]: Stopped Apply Kernel Variables. machine # [ 54.928053] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 54.959453] systemd[1]: Stopped Load Kernel Modules. machine # [ 54.997119] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 55.014754] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 55.049020] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 55.073375] systemd[1]: Stopped Create System Files and Directories. machine # [ 55.115950] systemd[1]: Stopped target Local File Systems. machine # [ 55.125835] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 55.150782] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 55.177274] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 55.209079] systemd[1]: systemd-udev-trigger.service: Consumed 12.126s CPU time over 43.131s wall clock time, 8.8M memory peak. machine # [ 55.237154] systemd[1]: Stopping Rule-based Manager for Device Events and Files... machine # [ 55.247930] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 55.273066] systemd[1]: Stopped Virtual Console Setup. machine # [ 55.646998] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 55.655074] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 55.671995] systemd[1]: initrd-cleanup.service: Deactivated successfully. machine # [ 55.685873] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. machine # [ 56.500619] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 56.511992] systemd[1]: Stopped Rule-based Manager for Device Events and Files. machine # [ 56.521425] systemd[1]: systemd-udevd.service: Consumed 15.397s CPU time over 41.496s wall clock time, 20.4M memory peak. machine # [ 56.535028] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. machine # [ 56.543562] systemd[1]: Closed udev Control Socket. machine # [ 56.574803] systemd[1]: Starting Cleanup udev Database... machine # [ 56.581939] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 56.589763] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 56.593969] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 56.601577] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 56.604071] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 56.617841] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 56.956922] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. machine # [ 56.962496] systemd[1]: Finished Cleanup udev Database. machine # [ 56.980784] systemd[1]: Reached target Switch Root. machine # [ 57.021769] systemd[1]: Starting NixOS Activation... machine # [ 58.971425] initrd-nixos-activation-start[206]: booting system configuration /nix/store/gq880zyaiimz3n8gvl4dd201gsgk06yq-nixos-system-machine-test machine: Guest root shell did not produce any data yet... machine: To debug, enter the VM and run 'systemctl status backdoor.service'. machine # [ 59.837435] initrd-nixos-activation-start[206]: running activation script... machine # [ 65.766909] initrd-nixos-activation-start[229]: setting up /etc... machine # [ 69.163341] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. machine # [ 69.176967] systemd[1]: Finished NixOS Activation. machine # [ 69.179499] systemd[1]: initrd-nixos-activation.service: Consumed 8.140s CPU time over 12.132s wall clock time, 26.8M memory peak. machine # [ 69.214819] systemd[1]: Starting Switch Root... machine # [ 69.506737] systemd[1]: Switching root. machine # [ 70.078378] systemd-journald[72]: Received SIGTERM from PID 1 (systemd). machine # [ 72.490261] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) machine # [ 72.495770] systemd[1]: Detected virtualization qemu. machine # [ 72.505222] systemd[1]: Detected architecture arm64. machine # [ 72.513772] systemd[1]: Detected first boot. machine # [ 72.551124] systemd[1]: Initializing machine ID from random generator. machine # [ 75.331975] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 77.341228] systemd[1]: Applying preset policy. machine # [ 82.415216] systemd[1]: Populated /etc with preset unit settings. machine # [ 88.917509] systemd[1]: initrd-switch-root.service: Deactivated successfully. machine # [ 88.934535] systemd[1]: Stopped initrd-switch-root.service. machine # [ 88.997801] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 89.040621] systemd[1]: Created slice Slice /system/getty. machine # [ 89.067460] systemd[1]: Created slice User and Session Slice. machine # [ 89.080888] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 89.092057] systemd[1]: Started Forward Password Requests to Wall Directory Watch. machine # [ 89.101310] systemd[1]: Expecting device /dev/hvc0... machine # [ 89.109667] systemd[1]: Expecting device /dev/ttyAMA0... machine # [ 89.118222] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 89.128073] systemd[1]: Stopped target initrd-fs.target. machine # [ 89.137176] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 89.145917] systemd[1]: Stopped target initrd-switch-root.target. machine # [ 89.154277] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 89.163422] systemd[1]: Reached target Path Units. machine # [ 89.171974] systemd[1]: Reached target Remote File Systems. machine # [ 89.183629] systemd[1]: Reached target Slice Units. machine # [ 89.192008] systemd[1]: Reached target Swaps. machine # [ 89.242150] systemd[1]: Listening on Query the User Interactively for a Password. machine # [ 89.296882] systemd[1]: Listening on Process Core Dump Socket. machine: Guest root shell did not produce any data yet... machine: To debug, enter the VM and run 'systemctl status backdoor.service'. machine # [ 89.340360] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 89.394140] systemd[1]: Listening on Factory Reset Management. machine # [ 89.404965] systemd[1]: Listening on Hostname Service Socket. machine # [ 89.479843] systemd[1]: Starting Journal Log Access Socket... machine # [ 89.521448] systemd[1]: Listening on Journal Audit Socket. machine # [ 89.586246] systemd[1]: Listening on Console Output Muting Service Socket. machine # [ 89.600503] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 89.611539] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.620156] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 89.728009] systemd[1]: Listening on Disk Repartitioning Service Socket. machine # [ 89.738571] systemd[1]: Listening on udev Control Socket. machine # [ 89.754066] systemd[1]: Listening on udev Varlink Socket. machine # [ 89.825049] systemd[1]: Mounting Huge Pages File System... machine # [ 89.922110] systemd[1]: Mounting POSIX Message Queue File System... machine # [ 90.056787] systemd[1]: Mounting Kernel Debug File System... machine # [ 90.256965] systemd[1]: Mounting Kernel Trace File System... machine # [ 90.561113] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 90.602375] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 90.928929] systemd[1]: Mounting Kernel Configuration File System... machine # [ 90.980496] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm machine # [ 91.039793] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 91.089299] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 91.724888] systemd[1]: Mounting FUSE Control File System... machine # [ 91.833959] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 92.333293] systemd[1]: Starting Journal Service... machine # [ 92.553991] systemd[1]: Starting Load Kernel Modules... machine # [ 92.860641] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 93.254361] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 93.330516] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.808820] systemd[1]: Starting Coldplug All udev Devices... machine # [ 94.405007] systemd-journald[303]: Collecting audit messages is enabled. machine # [ 94.450412] systemd[1]: Listening on Journal Log Access Socket. machine # [ 94.522250] systemd[1]: Mounted Huge Pages File System. machine # [ 94.588306] systemd[1]: Mounted POSIX Message Queue File System. machine # [ 94.644455] systemd[1]: Mounted Kernel Debug File System. machine # [ 94.693803] systemd[1]: Mounted Kernel Trace File System. machine # [ 94.819943] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 94.872907] systemd[1]: Mounted Kernel Configuration File System. machine # [ 94.925164] systemd[1]: Mounted FUSE Control File System. machine # [ 95.028604] systemd[1]: Finished Load Kernel Modules. machine # [ 95.151745] EXT4-fs (vda): re-mounted 06135a21-e688-4aa4-b89d-ea8f13802f42. machine # [ 95.199310] systemd[1]: Queued start job for default target Multi-User System. machine # [ 95.243074] systemd[1]: systemd-journald.service: Deactivated successfully. machine # [ 95.384447] systemd[1]: Starting Firewall... machine # [ 95.283016] systemd[1]: systemd-journald.service: Consumed 2.269s CPU time over 1min 16.930s wall clock time, 3.5M memory peak. machine # [ 95.336433] systemd-modules-load[304]: Module 'atkbd' is built in machine # [ 95.385749] systemd-modules-load[304]: Module 'loop' is built in machine # [ 95.894236] systemd[1]: Starting Apply Kernel Variables... machine # [ 96.244645] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 96.612539] systemd[1]: Started Journal Service. machine # [ 97.157457] systemd[1]: Finished Remount Root and Kernel File Systems. machine # [ 98.543175] systemd[1]: Listening on Disk Image Download Service Socket. machine # [ 98.733181] systemd[1]: Starting Flush Journal to Persistent Storage... machine # [ 98.747915] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 98.903338] systemd-oomd[305]: No swap; memory pressure usage will be degraded machine # [ 99.173292] systemd[1]: Starting Load/Save OS Random Seed... machine # [ 99.235157] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 99.366640] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 99.621564] systemd[1]: Finished Apply Kernel Variables. machine # [ 100.710863] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 101.077678] systemd-journald[303]: Received client request to flush runtime journal. machine # [ 102.967538] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 103.029333] systemd[1]: Finished Load/Save OS Random Seed. machine # [ 103.053700] systemd[1]: Reached target First Boot Complete. machine # [ 103.077745] systemd[1]: Finished Flush Journal to Persistent Storage. machine # [ 103.489367] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 103.577151] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 103.717477] systemd[1]: Mounting /run/wrappers... machine # [ 103.999449] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 105.494273] systemd[1]: Mounted /run/wrappers. machine # [ 105.558604] systemd[1]: Reached target Local File Systems. machine # [ 105.685382] systemd[1]: Listening on Boot Loader Control Service Socket. machine # [ 105.889642] systemd[1]: Starting register-nix-paths.service... machine # [ 106.194879] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 106.249724] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 106.794298] systemd[1]: Starting Save Transient machine-id to Disk... machine # [ 107.380595] systemd[1]: Starting Create System Files and Directories... machine # [ 109.851948] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [ 109.982718] systemd[1]: Finished Save Transient machine-id to Disk. machine # [ 113.419174] systemd[1]: Finished Create System Files and Directories. machine # [ 113.845135] systemd[1]: Starting Rebuild Journal Catalog... machine # [ 114.300747] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 117.479758] systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine: Guest root shell did not produce any data yet... machine: To debug, enter the VM and run 'systemctl status backdoor.service'. machine # [ 120.250634] systemd[1]: Finished Rebuild Journal Catalog. machine # [ 120.534652] systemd[1]: Starting Update is Completed... machine # [ 122.554340] systemd[1]: Finished Update is Completed. machine # [ 128.363607] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 128.405826] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 128.422793] systemd[1]: suid-sgid-wrappers.service: Consumed 2.860s CPU time over 22.148s wall clock time, 4.7M memory peak. machine # [ 134.095427] systemd[1]: Finished register-nix-paths.service. machine # [ 136.278658] systemd-udevd[349]: Using default interface naming scheme 'v261'. machine # [ 136.886326] systemd[1]: Finished Firewall. machine # [ 138.347817] systemd[1]: Started Rule-based Manager for Device Events and Files. machine: Guest root shell did not produce any data yet... machine: To debug, enter the VM and run 'systemctl status backdoor.service'. machine # [ 153.559970] systemd[1]: Finished Coldplug All udev Devices. machine # [ 153.589041] systemd[1]: Reached target System Initialization. machine # [ 153.612957] systemd[1]: Started Discard unused filesystem blocks once a week. machine # [ 153.622349] systemd[1]: Started maintainer-mode-credentials.timer. machine # [ 153.634468] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 153.642427] systemd[1]: Reached target Timer Units. machine # [ 153.658521] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 153.670036] systemd[1]: Listening on Nix Daemon Socket. machine # [ 153.682333] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [ 153.695565] systemd[1]: Reached target Socket Units. machine # [ 153.702246] systemd[1]: Reached target Basic System. machine # [ 153.766712] systemd[1]: Starting Import lastlog data into lastlog2 database... machine # [ 153.970027] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 154.253788] systemd[1]: Starting Post-Boot Actions... machine # [ 154.694902] systemd[1]: Started Reset console on configuration changes. machine # [ 155.105015] systemd[1]: Starting resolvconf update... machine # [ 156.510524] nsncd[538]: Oct 24 20:13:07.396 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 156.682702] systemd[1]: Starting D-Bus System Message Bus... machine # [ 156.776562] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 156.914080] systemd[1]: Finished Post-Boot Actions. machine # [ 157.313063] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 157.331334] systemd[1]: Reached target User and Group Name Lookups. machine # [ 157.893588] systemd[1]: Starting User Login Management... machine # [ 158.011000] systemd[1]: Finished Import lastlog data into lastlog2 database. machine # [ 160.014770] dbus-broker-launch[552]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 160.306203] dbus-broker-launch[552]: NSS returned no entry for 'systemd-timesync' machine # [ 160.317410] dbus-broker-launch[552]: Invalid user-name in /nix/store/0qxngi76f2qyfz4syq3ccpv4xmfwlrdl-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 160.814589] systemd[1]: Started D-Bus System Message Bus. machine # [ 162.147487] dbus-broker-launch[552]: Ready machine # [ 162.576045] systemd-logind[559]: New seat seat0. machine # [ 162.759210] systemd[1]: Started User Login Management. machine # [ 162.858866] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 162.871659] systemd[1]: Stopping Host and Network Name Lookups... machine # [ 162.894977] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 162.906277] systemd[1]: Stopping User and Group Name Lookups... machine # [ 163.039819] systemd[1]: Starting linger-users.service... machine # [ 163.121720] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 163.299948] systemd[1]: nscd.service: Deactivated successfully. machine # [ 163.369275] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [ 164.197360] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 164.905369] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 164.994451] systemd[1]: Finished linger-users.service. machine # [ 165.105360] systemd[1]: Finished resolvconf update. machine # [ 165.255515] systemd[1]: Reached target Preparation for Network. machine # [ 165.405820] systemd[1]: Starting DHCP Client... machine # [ 165.607361] nsncd[616]: Oct 24 20:13:16.609 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 165.658978] systemd[1]: Starting Extra networking commands.... machine # [ 165.743072] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 165.847550] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 165.880869] systemd[1]: Reached target User and Group Name Lookups. machine # [ 171.554626] dhcpcd[644]: dhcpcd-10.3.2 starting machine # [ 171.795682] dhcpcd[697]: dev: loaded udev machine # [ 171.887972] systemd[1]: Finished Extra networking commands.. machine # [ 171.944982] systemd[1]: Reached target Network. machine # [ 172.031203] dhcpcd[697]: no valid interfaces found machine # [ 172.042255] dhcpcd[697]: no valid interfaces found machine # [ 172.104388] systemd[1]: Starting Permit User Sessions... machine # [ 172.823616] systemd[1]: Finished Permit User Sessions. machine # [ 172.999761] systemd[1]: Started Getty on tty1. machine # [ 173.048815] systemd[1]: Reached target Login Prompts. machine # [ 173.631164] systemd-logind[559]: Watching system buttons on /dev/input/event1 (gpio-keys) machine # [ 176.597577] mousedev: PS/2 mouse device common for all mice machine: Guest root shell did not produce any data yet... machine: To debug, enter the VM and run 'systemctl status backdoor.service'. machine # [ 179.667954] systemd-logind[559]: Watching system buttons on /dev/input/event0 (QEMU QEMU USB Keyboard) machine # [ 202.099494] dhcpcd[697]: timed out machine # [ 202.124994] dhcpcd[697]: timed out machine # [ 202.182568] systemd[1]: Started DHCP Client. machine # [ 202.216733] systemd[1]: Reached target Network is Online. machine # [ 202.377686] systemd[1]: Starting Maintainer Mode... machine # [ 204.927518] systemd[1]: Started Maintainer Mode. machine # [ 207.270178] maintainer-mode[809]: 2026-10-24T20:13:58.277166Z INFO maintainer_mode: GitHub App 1 syncs first machine # [ 207.683051] maintainer-mode[809]: 2026-10-24T20:13:58.725502Z INFO maintainer_mode: notifications poller on machine # [ 207.752641] maintainer-mode[809]: 2026-10-24T20:13:58.766222Z INFO maintainer_mode: listening on 127.0.0.1:8790 machine # [ 207.966764] maintainer-mode[809]: 2026-10-24T20:13:59.003204Z INFO maintainer_mode::channels: channels wait for the master index machine # [ 208.459348] maintainer-mode[809]: 2026-10-24T20:13:59.436954Z WARN maintainer_mode: nixpkgs index: error sending request for url (https://api.github.com/repos/NixOS/nixpkgs/commits/master): client error (Connect): dns error: failed to lookup address information: Name or service not known machine # [ 208.622005] maintainer-mode[809]: 2026-10-24T20:13:59.663045Z WARN maintainer_mode::events: events poll: error sending request for url (https://api.github.com/repos/NixOS/nixpkgs/events?per_page=100&page=1): client error (Connect): dns error: failed to lookup address information: Name or service not known machine # [ 208.633902] maintainer-mode[809]: 2026-10-24T20:13:59.673423Z WARN maintainer_mode::health: repology: error sending request for url (https://repology.org/api/v1/projects/?inrepo=nix_unstable&outdated=1): client error (Connect): dns error: failed to lookup address information: Name or service not known machine # [ 208.667417] maintainer-mode[809]: 2026-10-24T20:13:59.705131Z WARN maintainer_mode::notifications: notifications: error sending request for url (https://api.github.com/notifications?all=false&participating=false&per_page=50): client error (Connect): dns error: failed to lookup address information: Name or service not known machine # [ 208.691254] maintainer-mode[809]: 2026-10-24T20:13:59.733628Z WARN maintainer_mode::events: GH Archive https://data.gharchive.org/2026-10-24-19.json.gz: error sending request for url (https://data.gharchive.org/2026-10-24-19.json.gz): client error (Connect): dns error: failed to lookup address information: Name or service not known machine # [ 208.703106] maintainer-mode[809]: 2026-10-24T20:13:59.738469Z INFO maintainer_mode::archive: archive NixOS/nixpkgs: 0 rows written from the archive machine # [ 208.735081] maintainer-mode[809]: 2026-10-24T20:13:59.773585Z WARN maintainer_mode: GitHub App token: error sending request for url (https://api.github.com/app): client error (Connect): dns error: failed to lookup address information: Name or service not known machine # [ 208.801103] maintainer-mode[809]: 2026-10-24T20:13:59.838308Z INFO maintainer_mode: network unreachable; next pass in 5 s machine # [ 208.811077] maintainer-mode[809]: 2026-10-24T20:13:59.849323Z WARN maintainer_mode::health: security tracker: error sending request for url (https://tracker.security.nixos.org/api/v1/issues?expand=suggestions&limit=100): client error (Connect): dns error: failed to lookup address information: Name or service not known machine # [ 208.822226] maintainer-mode[809]: 2026-10-24T20:13:59.862093Z INFO maintainer_mode::health: cve: 0 records read, 0 not published · 0 of 0 CVEs have a score · 0 left machine # [ 208.877191] maintainer-mode[809]: 2026-10-24T20:13:59.917949Z INFO maintainer_mode::health: nvd: off: no API key machine # [ 208.927186] maintainer-mode[809]: 2026-10-24T20:13:59.964684Z INFO maintainer_mode::health: upstream: waiting for an index with source URLs machine # [ 209.057453] maintainer-mode[809]: 2026-10-24T20:14:00.095166Z WARN maintainer_mode::builds: hydra builds: error sending request for url (https://hydra.nixos.org/api/latestbuilds?nr=200&project=nixpkgs&jobset=unstable&system=x86_64-linux): client error (Connect): dns error: failed to lookup address information: Name or service not known machine # [ 209.230817] maintainer-mode[809]: 2026-10-24T20:14:00.270268Z WARN maintainer_mode::archive: archive NixOS/nixpkgs: error sending request for url (https://api.github.com/graphql): client error (Connect): dns error: failed to lookup address information: Name or service not known machine: Guest root shell did not produce any data yet... machine: To debug, enter the VM and run 'systemctl status backdoor.service'. machine # [ 213.865666] maintainer-mode[809]: 2026-10-24T20:14:04.875168Z WARN maintainer_mode: nixpkgs index: error sending request for url (https://api.github.com/repos/NixOS/nixpkgs/commits/master): client error (Connect): dns error: failed to lookup address information: Name or service not known machine # [ 213.915757] maintainer-mode[809]: 2026-10-24T20:14:04.957021Z WARN maintainer_mode: GitHub App token: error sending request for url (https://api.github.com/app): client error (Connect): dns error: failed to lookup address information: Name or service not known machine # [ 213.931713] maintainer-mode[809]: 2026-10-24T20:14:04.974290Z INFO maintainer_mode: network unreachable; next pass in 10 s machine # [ 224.045277] maintainer-mode[809]: 2026-10-24T20:14:15.049305Z WARN maintainer_mode: nixpkgs index: error sending request for url (https://api.github.com/repos/NixOS/nixpkgs/commits/master): client error (Connect): dns error: failed to lookup address information: Name or service not known machine # [ 224.093075] maintainer-mode[809]: 2026-10-24T20:14:15.133316Z WARN maintainer_mode: GitHub App token: error sending request for url (https://api.github.com/app): client error (Connect): dns error: failed to lookup address information: Name or service not known machine # [ 224.105935] maintainer-mode[809]: 2026-10-24T20:14:15.146951Z INFO maintainer_mode: network unreachable; next pass in 20 s machine # [ 237.414002] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3 machine: Guest root shell did not produce any data yet... machine: To debug, enter the VM and run 'systemctl status backdoor.service'. machine # [ 244.169414] maintainer-mode[809]: 2026-10-24T20:14:35.181474Z WARN maintainer_mode: nixpkgs index: error sending request for url (https://api.github.com/repos/NixOS/nixpkgs/commits/master): client error (Connect): dns error: failed to lookup address information: Name or service not known machine # [ 244.217038] maintainer-mode[809]: 2026-10-24T20:14:35.257139Z WARN maintainer_mode: GitHub App token: error sending request for url (https://api.github.com/app): client error (Connect): dns error: failed to lookup address information: Name or service not known machine # [ 244.233069] maintainer-mode[809]: 2026-10-24T20:14:35.275277Z INFO maintainer_mode: network unreachable; next pass in 40 s machine # [ 252.866680] systemd[1]: Starting Virtual Console Setup... machine # [ 253.634928] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 253.669109] systemd[1]: Stopped Virtual Console Setup. machine # [ 253.963491] systemd[1]: Starting Virtual Console Setup... machine # [ 258.907894] systemd-vconsole-setup[984]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 258.981269] systemd[1]: Finished Virtual Console Setup. machine # [ 262.622446] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 268.679653] maintainer-mode[809]: 2026-10-24T20:14:59.700807Z WARN maintainer_mode::events: events poll: error sending request for url (https://api.github.com/repos/NixOS/nixpkgs/events?per_page=100&page=1): client error (Connect): dns error: failed to lookup address information: Name or service not known machine # [ 268.710617] maintainer-mode[809]: 2026-10-24T20:14:59.753231Z WARN maintainer_mode::notifications: notifications: error sending request for url (https://api.github.com/notifications?all=false&participating=false&per_page=50): client error (Connect): dns error: failed to lookup address information: Name or service not known machine: Guest root shell did not produce any data yet... machine: To debug, enter the VM and run 'systemctl status backdoor.service'. machine # [ 270.227074] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 271.002160] 8021q: 802.1Q VLAN Support v1.8 machine # [ 271.367454] (udev-worker)[1024]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 271.387008] (udev-worker)[1024]: Network interface NamePolicy= disabled on kernel command line. machine # [ 271.432971] (udev-worker)[1023]: Network interface NamePolicy= disabled on kernel command line. machine # [ 272.241055] cfg80211: Loading compiled-in X.509 certificates for regulatory database machine # [ 272.645439] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' machine # [ 272.664014] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' machine # [ 272.684124] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 machine # [ 272.685102] cfg80211: failed to load regulatory.db machine # [ 273.150566] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 273.305236] systemd[1]: Starting Address configuration of eth1... machine # [ 275.344790] 8021q: adding VLAN 0 to HW filter on device eth0 machine # [ 275.280991] dhcpcd[697]: eth0: waiting for carrier machine # [ 275.321146] dhcpcd[697]: eth0: carrier acquired machine # [ 275.841264] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 275.773974] dhcpcd[697]: DUID 00:01:00:01:32:6f:ce:4a:52:54:00:12:34:56 machine # [ 275.793865] dhcpcd[697]: eth0: IAID 00:12:34:56 machine # [ 275.822397] dhcpcd[697]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 276.153279] network-addresses-eth1-start[1044]: adding address 192.168.1.1/24... done machine # [ 276.410581] dhcpcd[697]: eth0: soliciting a DHCP lease machine # [ 276.418479] network-addresses-eth1-start[1044]: adding address 2001:db8:1::1/64... done machine # [ 276.433517] dhcpcd[697]: eth0: offered 10.0.2.15 from 10.0.2.2 machine # [ 276.472972] dhcpcd[697]: eth0: probing address 10.0.2.15/24 machine # [ 276.757739] systemd[1]: Finished Address configuration of eth1. machine # [ 277.885478] dhcpcd[697]: eth0: soliciting an IPv6 router machine # [ 277.897915] dhcpcd[697]: eth0: Router Advertisement from fe80::2 machine # [ 277.910962] dhcpcd[697]: eth0: adding address fec0::5054:ff:fe12:3456/64 machine # [ 277.941062] dhcpcd[697]: eth0: adding route to fec0::/64 machine # [ 277.948873] dhcpcd[697]: eth0: adding default route via fe80::2 machine # [ 278.807170] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. machine # [ 278.909091] systemd[1]: Started backdoor.service. machine # [ 278.958191] systemd[1]: Reached target Multi-User System. machine # [ 278.997161] systemd[1]: Startup finished in 6.829s (kernel) + 1min 4.271s (initrd) + 3min 27.892s (userspace) = 4min 38.993s. machine # connecting to host... machine: Guest shell says: b'Spawning backdoor root shell...\n' machine: connected to guest root shell machine: (connecting took 282.05 seconds) machine: (finished: waiting for the VM to finish booting, in 282.36 seconds) machine: (finished: waiting for unit maintainer-mode.service, in 284.21 seconds) machine: waiting for TCP port 8790 on localhost machine # [ 283.102314] dhcpcd[697]: eth0: leased 10.0.2.15 for 86400 seconds machine # [ 283.117602] dhcpcd[697]: eth0: adding route to 10.0.2.0/24 machine # [ 283.119863] dhcpcd[697]: eth0: adding default route via 10.0.2.2 machine # [ 284.415537] maintainer-mode[809]: 2026-10-24T20:15:15.387068Z WARN maintainer_mode: nixpkgs index: error sending request for url (https://api.github.com/repos/NixOS/nixpkgs/commits/master): client error (Connect): dns error: failed to lookup address information: Name or service not known machine # [ 284.535271] maintainer-mode[809]: 2026-10-24T20:15:15.577913Z WARN maintainer_mode: GitHub App token: error sending request for url (https://api.github.com/app): client error (Connect): dns error: failed to lookup address information: Name or service not known machine # [ 284.558022] maintainer-mode[809]: 2026-10-24T20:15:15.597442Z INFO maintainer_mode: network unreachable; next pass in 80 s machine # Connection to localhost (127.0.0.1) 8790 port [tcp/*] succeeded! machine: (finished: waiting for TCP port 8790 on localhost, in 2.20 seconds) machine: must succeed: curl -sf http://127.0.0.1:8790/healthz machine: (finished: must succeed: curl -sf http://127.0.0.1:8790/healthz, in 2.32 seconds) machine: must succeed: curl -sf http://127.0.0.1:8790/ -o /tmp/page && grep -q 'Maintainer Mode' /tmp/page machine: (finished: must succeed: curl -sf http://127.0.0.1:8790/ -o /tmp/page && grep -q 'Maintainer Mode' /tmp/page, in 2.22 seconds) machine: must succeed: grep -q 'id="intro"' /tmp/page && grep -q 'nixpkgs/blob/master/CONTRIBUTING.md">nixpkgs contributor guide' /tmp/page machine: (finished: must succeed: grep -q 'id="intro"' /tmp/page && grep -q 'nixpkgs/blob/master/CONTRIBUTING.md">nixpkgs contributor guide' /tmp/page, in 1.04 seconds) machine: must succeed: curl -s -D /tmp/intro.h -o /dev/null -X POST http://127.0.0.1:8790/intro/dismiss && grep -q '^HTTP/1.1 303' /tmp/intro.h && grep -qi '^set-cookie: intro=hidden' /tmp/intro.h machine: (finished: must succeed: curl -s -D /tmp/intro.h -o /dev/null -X POST http://127.0.0.1:8790/intro/dismiss && grep -q '^HTTP/1.1 303' /tmp/intro.h && grep -qi '^set-cookie: intro=hidden' /tmp/intro.h, in 1.81 seconds) machine: must succeed: curl -sf -H 'Cookie: intro=hidden' http://127.0.0.1:8790/ -o /tmp/page && ! grep -q 'id="intro"' /tmp/page machine: (finished: must succeed: curl -sf -H 'Cookie: intro=hidden' http://127.0.0.1:8790/ -o /tmp/page && ! grep -q 'id="intro"' /tmp/page, in 1.52 seconds) machine: must succeed: grep -q '

Maintainer Mode

' /tmp/page && ! grep -q 'Subhead-heading' /tmp/page machine: (finished: must succeed: grep -q '

Maintainer Mode

' /tmp/page && ! grep -q 'Subhead-heading' /tmp/page, in 0.86 seconds) machine: must succeed: curl -sf http://127.0.0.1:8790/ -o /tmp/page && grep -o ' /tmp/h1 && grep -qx 1 /tmp/h1 && grep -q 'flex-auto">Tools that make it easier' /tmp/page machine: (finished: must succeed: curl -sf http://127.0.0.1:8790/ -o /tmp/page && grep -o ' /tmp/h1 && grep -qx 1 /tmp/h1 && grep -q 'flex-auto">Tools that make it easier' /tmp/page, in 2.27 seconds) machine: must succeed: curl -sf http://127.0.0.1:8790/ -o /tmp/home && grep -q 'Pull requests with no maintainer' /tmp/home && grep -q 'nixpkgs in numbers' /tmp/home machine: (finished: must succeed: curl -sf http://127.0.0.1:8790/ -o /tmp/home && grep -q 'Pull requests with no maintainer' /tmp/home && grep -q 'nixpkgs in numbers' /tmp/home, in 1.66 seconds) machine: must succeed: grep -q 'href="/review?tab=unowned"' /tmp/home machine: (finished: must succeed: grep -q 'href="/review?tab=unowned"' /tmp/home, in 0.83 seconds) machine: must succeed: curl -s -D /tmp/merge.h -o /dev/null http://127.0.0.1:8790/merge && grep -qi '^location: /review?tab=ready' /tmp/merge.h machine: (finished: must succeed: curl -s -D /tmp/merge.h -o /dev/null http://127.0.0.1:8790/merge && grep -qi '^location: /review?tab=ready' /tmp/merge.h, in 1.33 seconds) machine: must succeed: curl -s -D /tmp/committer.h -o /dev/null http://127.0.0.1:8790/committer && grep -qi '^location: /review?tab=ready' /tmp/committer.h machine: (finished: must succeed: curl -s -D /tmp/committer.h -o /dev/null http://127.0.0.1:8790/committer && grep -qi '^location: /review?tab=ready' /tmp/committer.h, in 1.43 seconds) machine: must succeed: curl -s -D /tmp/bumps.h -o /dev/null http://127.0.0.1:8790/bumps && grep -qi '^location: /review?tab=bumps' /tmp/bumps.h machine: (finished: must succeed: curl -s -D /tmp/bumps.h -o /dev/null http://127.0.0.1:8790/bumps && grep -qi '^location: /review?tab=bumps' /tmp/bumps.h, in 1.60 seconds) machine: must succeed: curl -sf 'http://127.0.0.1:8790/review?tab=ready' -o /tmp/merge && grep -q 'aria-current="page">Ready to merge 0' /tmp/merge machine: (finished: must succeed: curl -sf 'http://127.0.0.1:8790/review?tab=ready' -o /tmp/merge && grep -q 'aria-current="page">Ready to merge 0' /tmp/merge, in 1.60 seconds) machine: must succeed: grep -q 'Work in progress.' /tmp/merge && grep -q 'Nothing is ready yet.' /tmp/merge machine: (finished: must succeed: grep -q 'Work in progress.' /tmp/merge && grep -q 'Nothing is ready yet.' /tmp/merge, in 1.04 seconds) machine: must succeed: grep -q 'Maintainer Mode never merges' /tmp/merge && grep -q 'A committer sees the section' /tmp/merge && grep -q 'Approved by a maintainer' /tmp/merge machine: (finished: must succeed: grep -q 'Maintainer Mode never merges' /tmp/merge && grep -q 'A committer sees the section' /tmp/merge && grep -q 'Approved by a maintainer' /tmp/merge, in 1.01 seconds) machine: must fail: grep -q 'href="/committer"' /tmp/merge machine: (finished: must fail: grep -q 'href="/committer"' /tmp/merge, in 0.68 seconds) machine: must succeed: curl -sf 'http://127.0.0.1:8790/review?tab=ready§ion=security' -o /tmp/sec && grep -q 'Back to Ready to merge' /tmp/sec && grep -q 'No security fix is ready.' /tmp/sec machine: (finished: must succeed: curl -sf 'http://127.0.0.1:8790/review?tab=ready§ion=security' -o /tmp/sec && grep -q 'Back to Ready to merge' /tmp/sec && grep -q 'No security fix is ready.' /tmp/sec, in 1.84 seconds) machine: must succeed: ! grep -q 'Waiting longest' /tmp/sec && ! grep -q 'A committer sees the section' /tmp/sec machine: (finished: must succeed: ! grep -q 'Waiting longest' /tmp/sec && ! grep -q 'A committer sees the section' /tmp/sec, in 0.98 seconds) machine: must succeed: curl -sf 'http://127.0.0.1:8790/review?tab=ready§ion=nonsense' -o /tmp/sec2 && grep -q 'Waiting longest' /tmp/sec2 machine: (finished: must succeed: curl -sf 'http://127.0.0.1:8790/review?tab=ready§ion=nonsense' -o /tmp/sec2 && grep -q 'Waiting longest' /tmp/sec2, in 1.56 seconds) machine: must succeed: curl -s -D /tmp/w1.h -o /dev/null http://127.0.0.1:8790/welcome && grep -q '^HTTP/1.1 308' /tmp/w1.h && grep -qi '^location: /#start' /tmp/w1.h machine: (finished: must succeed: curl -s -D /tmp/w1.h -o /dev/null http://127.0.0.1:8790/welcome && grep -q '^HTTP/1.1 308' /tmp/w1.h && grep -qi '^location: /#start' /tmp/w1.h, in 1.46 seconds) machine: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST -d done=1 http://127.0.0.1:8790/me/start > /tmp/w2 && grep -q 303 /tmp/w2 machine: (finished: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST -d done=1 http://127.0.0.1:8790/me/start > /tmp/w2 && grep -q 303 /tmp/w2, in 1.53 seconds) machine: must succeed: curl -sf http://127.0.0.1:8790/api/v1/status -o /tmp/page && grep -q move_days /tmp/page machine: (finished: must succeed: curl -sf http://127.0.0.1:8790/api/v1/status -o /tmp/page && grep -q move_days /tmp/page, in 1.56 seconds) machine: must succeed: curl -sf 'http://127.0.0.1:8790/state?tab=rules' -o /tmp/rules && grep -q 'id="the-rules"' /tmp/rules machine: (finished: must succeed: curl -sf 'http://127.0.0.1:8790/state?tab=rules' -o /tmp/rules && grep -q 'id="the-rules"' /tmp/rules, in 1.64 seconds) machine: must succeed: grep -q 'id="contributor-guide"' /tmp/rules && grep -q 'nixpkgs/blob/master/pkgs/README.md' /tmp/rules machine: (finished: must succeed: grep -q 'id="contributor-guide"' /tmp/rules && grep -q 'nixpkgs/blob/master/pkgs/README.md' /tmp/rules, in 0.93 seconds) machine: must succeed: grep -q 'selected" href="/state?tab=rules" aria-current="page">Rules' /tmp/rules machine: (finished: must succeed: grep -q 'selected" href="/state?tab=rules" aria-current="page">Rules' /tmp/rules, in 0.64 seconds) machine: must succeed: curl -s -D /tmp/rules.h -o /dev/null http://127.0.0.1:8790/rules && grep -qi '^location: /state?tab=rules' /tmp/rules.h machine: (finished: must succeed: curl -s -D /tmp/rules.h -o /dev/null http://127.0.0.1:8790/rules && grep -qi '^location: /state?tab=rules' /tmp/rules.h, in 1.37 seconds) machine: must succeed: curl -sf 'http://127.0.0.1:8790/state?tab=docs' -o /tmp/docs && grep -q 'href="/state?tab=docs&doc=health"' /tmp/docs machine: (finished: must succeed: curl -sf 'http://127.0.0.1:8790/state?tab=docs' -o /tmp/docs && grep -q 'href="/state?tab=docs&doc=health"' /tmp/docs, in 1.58 seconds) machine: must succeed: curl -sf 'http://127.0.0.1:8790/state?tab=docs&doc=personal' -o /tmp/doc && grep -q 'Your own view' /tmp/doc && grep -q 'href="/state?tab=docs&doc=health#the-risk-score"' /tmp/doc machine: (finished: must succeed: curl -sf 'http://127.0.0.1:8790/state?tab=docs&doc=personal' -o /tmp/doc && grep -q 'Your own view' /tmp/doc && grep -q 'href="/state?tab=docs&doc=health#the-risk-score"' /tmp/doc, in 1.84 seconds) machine: must succeed: curl -s -D /tmp/sync.h -o /dev/null http://127.0.0.1:8790/sync && grep -qi '^location: /state?tab=status' /tmp/sync.h machine: (finished: must succeed: curl -s -D /tmp/sync.h -o /dev/null http://127.0.0.1:8790/sync && grep -qi '^location: /state?tab=status' /tmp/sync.h, in 1.44 seconds) machine: must succeed: curl -sf http://127.0.0.1:8790/review -o /tmp/review machine: (finished: must succeed: curl -sf http://127.0.0.1:8790/review -o /tmp/review, in 1.10 seconds) machine: must succeed: grep -q 'selected" href="/review?tab=unowned" aria-current="page">No maintainer 0' /tmp/review machine: (finished: must succeed: grep -q 'selected" href="/review?tab=unowned" aria-current="page">No maintainer 0' /tmp/review, in 0.72 seconds) machine: must succeed: grep -q 'href="/review?tab=bumps">Bumps' /tmp/review && grep -q 'href="/review?tab=ready">Ready to merge' /tmp/review machine # [ 328.894442] maintainer-mode[809]: 2026-10-24T20:15:59.884873Z WARN maintainer_mode::notifications: notifications: error sending request for url (https://api.github.com/notifications?all=false&participating=false&per_page=50): client error (Connect): dns error: failed to lookup address information: Name or service not known machine # [ 328.922037] maintainer-mode[809]: 2026-10-24T20:15:59.897009Z WARN maintainer_mode::events: events poll: error sending request for url (https://api.github.com/repos/NixOS/nixpkgs/events?per_page=100&page=1): client error (Connect): dns error: failed to lookup address information: Name or service not known machine: (finished: must succeed: grep -q 'href="/review?tab=bumps">Bumps' /tmp/review && grep -q 'href="/review?tab=ready">Ready to merge' /tmp/review, in 1.29 seconds) machine: must succeed: grep -q 'Review · Maintainer Mode' /tmp/review machine: (finished: must succeed: grep -q 'Review · Maintainer Mode' /tmp/review, in 1.16 seconds) machine: must succeed: grep -o 'href="/static/primer\.[0-9a-f]*\.css"' /tmp/review | cut -d'"' -f2 > /tmp/css.path machine: (finished: must succeed: grep -o 'href="/static/primer\.[0-9a-f]*\.css"' /tmp/review | cut -d'"' -f2 > /tmp/css.path, in 1.11 seconds) machine: must succeed: curl -sf -D /tmp/css.h -o /tmp/css http://127.0.0.1:8790$(cat /tmp/css.path) && grep -qi '^cache-control: public, max-age=31536000, immutable' /tmp/css.h machine: (finished: must succeed: curl -sf -D /tmp/css.h -o /tmp/css http://127.0.0.1:8790$(cat /tmp/css.path) && grep -qi '^cache-control: public, max-age=31536000, immutable' /tmp/css.h, in 2.01 seconds) machine: must succeed: grep -q 'data-dark-theme=dark' /tmp/css && ! grep -q dark_dimmed /tmp/css machine: (finished: must succeed: grep -q 'data-dark-theme=dark' /tmp/css && ! grep -q dark_dimmed /tmp/css, in 0.86 seconds) machine: must fail: curl -sf http://127.0.0.1:8790/static/primer.css machine: (finished: must fail: curl -sf http://127.0.0.1:8790/static/primer.css, in 1.13 seconds) machine: must succeed: grep -q '' /tmp/review && grep -q '' /tmp/review && grep -q ' /tmp/etag && curl -s -o /dev/null -w '%{http_code}' -H "If-None-Match: $(cat /tmp/etag)" http://127.0.0.1:8790/review > /tmp/etag.code && grep -qx 304 /tmp/etag.code machine: (finished: waiting for success: curl -s -D /tmp/etag.h -o /dev/null http://127.0.0.1:8790/review && grep -i '^etag: W/' /tmp/etag.h | cut -d' ' -f2 | tr -d '\r' > /tmp/etag && curl -s -o /dev/null -w '%{http_code}' -H "If-None-Match: $(cat /tmp/etag)" http://127.0.0.1:8790/review > /tmp/etag.code && grep -qx 304 /tmp/etag.code, in 3.44 seconds) machine: must succeed: curl -s -D /tmp/sync.h -o /dev/null 'http://127.0.0.1:8790/state?tab=status' && ! grep -qi '^etag' /tmp/sync.h machine: (finished: must succeed: curl -s -D /tmp/sync.h -o /dev/null 'http://127.0.0.1:8790/state?tab=status' && ! grep -qi '^etag' /tmp/sync.h, in 1.66 seconds) machine: must succeed: grep -q 'href="/review" aria-current="page"' /tmp/review machine: (finished: must succeed: grep -q 'href="/review" aria-current="page"' /tmp/review, in 0.91 seconds) machine: must succeed: grep -o 'class="site-tab"' /tmp/review | wc -l > /tmp/tabs && grep -qx 4 /tmp/tabs machine: (finished: must succeed: grep -o 'class="site-tab"' /tmp/review | wc -l > /tmp/tabs && grep -qx 4 /tmp/tabs, in 1.28 seconds) machine: must succeed: grep -q 'Data from the last 60 days' /tmp/review machine: (finished: must succeed: grep -q 'Data from the last 60 days' /tmp/review, in 0.92 seconds) machine: must fail: grep -q 'nixpkgs index' /tmp/review machine: (finished: must fail: grep -q 'nixpkgs index' /tmp/review, in 0.82 seconds) machine: must succeed: curl -s -D /tmp/me1.h -o /dev/null http://127.0.0.1:8790/me && grep -q '^HTTP/1.1 308' /tmp/me1.h && grep -qi '^location: /packages?filter=mine' /tmp/me1.h machine: (finished: must succeed: curl -s -D /tmp/me1.h -o /dev/null http://127.0.0.1:8790/me && grep -q '^HTTP/1.1 308' /tmp/me1.h && grep -qi '^location: /packages?filter=mine' /tmp/me1.h, in 1.52 seconds) machine: must succeed: curl -s -o /dev/null -w '%{http_code}' http://127.0.0.1:8790/me/runs > /tmp/me2 && grep -q 303 /tmp/me2 machine: (finished: must succeed: curl -s -o /dev/null -w '%{http_code}' http://127.0.0.1:8790/me/runs > /tmp/me2 && grep -q 303 /tmp/me2, in 1.57 seconds) machine: must succeed: curl -sf http://127.0.0.1:8790/actions -o /tmp/actions && grep -q 'href="https://github.com/apps/test-app"' /tmp/actions machine: (finished: must succeed: curl -sf http://127.0.0.1:8790/actions -o /tmp/actions && grep -q 'href="https://github.com/apps/test-app"' /tmp/actions, in 1.68 seconds) machine: must succeed: curl -s -D /tmp/at.h -o /dev/null 'http://127.0.0.1:8790/search?q=@nobody' && grep -qi '^location: /u/nobody' /tmp/at.h machine: (finished: must succeed: curl -s -D /tmp/at.h -o /dev/null 'http://127.0.0.1:8790/search?q=@nobody' && grep -qi '^location: /u/nobody' /tmp/at.h, in 1.60 seconds) machine: must fail: grep -q -e 'tab=foryou' -e 'your-progress' /tmp/review machine: (finished: must fail: grep -q -e 'tab=foryou' -e 'your-progress' /tmp/review, in 0.86 seconds) machine: must succeed: curl -sf http://127.0.0.1:8790/api/v1 -o /tmp/api.json && grep -q '/api/v1/prs' /tmp/api.json && grep -q '/api/v1/people/' /tmp/api.json machine: (finished: must succeed: curl -sf http://127.0.0.1:8790/api/v1 -o /tmp/api.json && grep -q '/api/v1/prs' /tmp/api.json && grep -q '/api/v1/people/' /tmp/api.json, in 1.58 seconds) machine: must succeed: curl -sf 'http://127.0.0.1:8790/api/v1/prs?queue=foryou&login=nobody' -o /tmp/q1 && grep -q '"items":\[\]' /tmp/q1 && grep -q '"next_cursor":null' /tmp/q1 machine: (finished: must succeed: curl -sf 'http://127.0.0.1:8790/api/v1/prs?queue=foryou&login=nobody' -o /tmp/q1 && grep -q '"items":\[\]' /tmp/q1 && grep -q '"next_cursor":null' /tmp/q1, in 1.75 seconds) machine: must succeed: curl -s -o /tmp/q2 -w '%{http_code}' 'http://127.0.0.1:8790/api/v1/prs?queue=foryou' > /tmp/q2.code && grep -q 400 /tmp/q2.code && grep -q 'needs login' /tmp/q2 machine: (finished: must succeed: curl -s -o /tmp/q2 -w '%{http_code}' 'http://127.0.0.1:8790/api/v1/prs?queue=foryou' > /tmp/q2.code && grep -q 400 /tmp/q2.code && grep -q 'needs login' /tmp/q2, in 1.89 seconds) machine: must succeed: curl -sf 'http://127.0.0.1:8790/api/v1/prs?queue=ready§ion=maintainer_approved' -o /tmp/q3 && grep -q '"section":"maintainer_approved"' /tmp/q3 machine: (finished: must succeed: curl -sf 'http://127.0.0.1:8790/api/v1/prs?queue=ready§ion=maintainer_approved' -o /tmp/q3 && grep -q '"section":"maintainer_approved"' /tmp/q3, in 1.70 seconds) machine: must succeed: maintainer-mode --server http://127.0.0.1:8790 --json prs --queue unowned > /tmp/q4 && grep -q '"queue":"unowned"' /tmp/q4 machine: (finished: must succeed: maintainer-mode --server http://127.0.0.1:8790 --json prs --queue unowned > /tmp/q4 && grep -q '"queue":"unowned"' /tmp/q4, in 1.36 seconds) machine: must fail: curl -sf http://127.0.0.1:8790/api/v1/queue/merge machine: (finished: must fail: curl -sf http://127.0.0.1:8790/api/v1/queue/merge, in 1.11 seconds) machine: must fail: curl -sf http://127.0.0.1:8790/api/v1/committer machine # [ 364.678328] maintainer-mode[809]: 2026-10-24T20:16:35.669467Z WARN maintainer_mode: nixpkgs index: error sending request for url (https://api.github.com/repos/NixOS/nixpkgs/commits/master): client error (Connect): dns error: failed to lookup address information: Name or service not known machine # [ 364.785186] maintainer-mode[809]: 2026-10-24T20:16:35.823235Z WARN maintainer_mode: GitHub App token: error sending request for url (https://api.github.com/app): client error (Connect): dns error: failed to lookup address information: Name or service not known machine # [ 364.802053] maintainer-mode[809]: 2026-10-24T20:16:35.842524Z INFO maintainer_mode: network unreachable; next pass in 160 s machine # [ 365.119227] systemd-logind[559]: Watching system buttons on /dev/input/event1 (gpio-keys) machine: (finished: must fail: curl -sf http://127.0.0.1:8790/api/v1/committer, in 1.46 seconds) machine: must succeed: curl -s -o /dev/null -w '%{http_code}' http://127.0.0.1:8790/me/progress > /tmp/p1 && grep -q 303 /tmp/p1 machine: (finished: must succeed: curl -s -o /dev/null -w '%{http_code}' http://127.0.0.1:8790/me/progress > /tmp/p1 && grep -q 303 /tmp/p1, in 1.65 seconds) machine: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST -d goal=3 http://127.0.0.1:8790/me/progress > /tmp/p2 && grep -q 303 /tmp/p2 machine: (finished: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST -d goal=3 http://127.0.0.1:8790/me/progress > /tmp/p2 && grep -q 303 /tmp/p2, in 1.64 seconds) machine: must succeed: curl -sf http://127.0.0.1:8790/state | grep -c 'State of nixpkgs' machine: (finished: must succeed: curl -sf http://127.0.0.1:8790/state | grep -c 'State of nixpkgs', in 1.57 seconds) machine: must succeed: curl -sf http://127.0.0.1:8790/state -o /tmp/state && grep -q 'id="packages"' /tmp/state && grep -q 'first nixpkgs index is still being built' /tmp/state machine: (finished: must succeed: curl -sf http://127.0.0.1:8790/state -o /tmp/state && grep -q 'id="packages"' /tmp/state && grep -q 'first nixpkgs index is still being built' /tmp/state, in 1.49 seconds) machine: must succeed: curl -sf http://127.0.0.1:8790/api/v1/metrics | grep -c 'concentration_365d' machine: (finished: must succeed: curl -sf http://127.0.0.1:8790/api/v1/metrics | grep -c 'concentration_365d', in 1.65 seconds) machine: must succeed: curl -sf http://127.0.0.1:8790/api/v1/metrics -o /tmp/metrics.json && grep -q '"open_bumps":0' /tmp/metrics.json machine: (finished: must succeed: curl -sf http://127.0.0.1:8790/api/v1/metrics -o /tmp/metrics.json && grep -q '"open_bumps":0' /tmp/metrics.json, in 1.36 seconds) machine: must fail: curl -sf http://127.0.0.1:8790/api/v1/people machine: (finished: must fail: curl -sf http://127.0.0.1:8790/api/v1/people, in 1.06 seconds) machine: must succeed: curl -sf -D /tmp/page.h http://127.0.0.1:8790/packages -o /tmp/page && grep -q 'Packages, modules and directories' /tmp/page machine: (finished: must succeed: curl -sf -D /tmp/page.h http://127.0.0.1:8790/packages -o /tmp/page && grep -q 'Packages, modules and directories' /tmp/page, in 1.58 seconds) machine: must succeed: ! grep -q -e 'filter=' -e 'Upload the packages' /tmp/page && ! grep -qi '^cache-control: private' /tmp/page.h machine: (finished: must succeed: ! grep -q -e 'filter=' -e 'Upload the packages' /tmp/page && ! grep -qi '^cache-control: private' /tmp/page.h, in 1.02 seconds) machine: must succeed: curl -sf 'http://127.0.0.1:8790/search?q=hello' -o /tmp/page && grep -q 'Nothing matches' /tmp/page machine: (finished: must succeed: curl -sf 'http://127.0.0.1:8790/search?q=hello' -o /tmp/page && grep -q 'Nothing matches' /tmp/page, in 1.27 seconds) machine: must succeed: curl -s -D /tmp/pq.h -o /dev/null 'http://127.0.0.1:8790/packages?q=hello' && grep -qi '^location: /search?q=hello' /tmp/pq.h machine: (finished: must succeed: curl -s -D /tmp/pq.h -o /dev/null 'http://127.0.0.1:8790/packages?q=hello' && grep -qi '^location: /search?q=hello' /tmp/pq.h, in 1.37 seconds) machine: must succeed: curl -s http://127.0.0.1:8790/p/hello -o /tmp/page && grep -q 'first index is still being built' /tmp/page machine: (finished: must succeed: curl -s http://127.0.0.1:8790/p/hello -o /tmp/page && grep -q 'first index is still being built' /tmp/page, in 1.55 seconds) machine: must fail: curl -sf http://127.0.0.1:8790/p/hello machine: (finished: must fail: curl -sf http://127.0.0.1:8790/p/hello, in 1.30 seconds) machine: must succeed: curl -sf http://127.0.0.1:8790/a/pkgs/by-name -o /tmp/area && grep -q 'pkgs/by-name/' /tmp/area machine: (finished: must succeed: curl -sf http://127.0.0.1:8790/a/pkgs/by-name -o /tmp/area && grep -q 'pkgs/by-name/' /tmp/area, in 1.71 seconds) machine: must succeed: curl -sf 'http://127.0.0.1:8790/review?tab=bumps' -o /tmp/bumps && grep -q 'No open version bump' /tmp/bumps && grep -q 'package-updates' /tmp/bumps machine: (finished: must succeed: curl -sf 'http://127.0.0.1:8790/review?tab=bumps' -o /tmp/bumps && grep -q 'No open version bump' /tmp/bumps && grep -q 'package-updates' /tmp/bumps, in 1.56 seconds) machine: must succeed: curl -sf 'http://127.0.0.1:8790/api/v1/prs?queue=bumps' -o /tmp/bumps.json && grep -q '"queue":"bumps"' /tmp/bumps.json && grep -q '"total":0' /tmp/bumps.json machine # [ 388.975843] maintainer-mode[809]: 2026-10-24T20:16:59.982582Z WARN maintainer_mode::events: events poll: error sending request for url (https://api.github.com/repos/NixOS/nixpkgs/events?per_page=100&page=1): client error (Connect): dns error: failed to lookup address information: Name or service not known machine # [ 388.983558] maintainer-mode[809]: 2026-10-24T20:16:59.983398Z WARN maintainer_mode::notifications: notifications: error sending request for url (https://api.github.com/notifications?all=false&participating=false&per_page=50): client error (Connect): dns error: failed to lookup address information: Name or service not known machine: (finished: must succeed: curl -sf 'http://127.0.0.1:8790/api/v1/prs?queue=bumps' -o /tmp/bumps.json && grep -q '"queue":"bumps"' /tmp/bumps.json && grep -q '"total":0' /tmp/bumps.json, in 1.74 seconds) machine: must succeed: curl -s -o /dev/null -w '%{http_code}' http://127.0.0.1:8790/u/nobody > /tmp/person.code && grep -q 200 /tmp/person.code machine # [ 390.091940] systemd-logind[559]: Watching system buttons on /dev/input/event0 (QEMU QEMU USB Keyboard) machine: (finished: must succeed: curl -s -o /dev/null -w '%{http_code}' http://127.0.0.1:8790/u/nobody > /tmp/person.code && grep -q 200 /tmp/person.code, in 2.13 seconds) machine: must succeed: curl -sf http://127.0.0.1:8790/u/nobody -o /tmp/person && grep -q 'selected" href="/u/nobody" aria-current="page">Overview' /tmp/person && grep -q 'href="/u/nobody?tab=reviews">Reviews' /tmp/person && grep -q 'href="/u/nobody?tab=maintains">Maintains' /tmp/person machine: (finished: must succeed: curl -sf http://127.0.0.1:8790/u/nobody -o /tmp/person && grep -q 'selected" href="/u/nobody" aria-current="page">Overview' /tmp/person && grep -q 'href="/u/nobody?tab=reviews">Reviews' /tmp/person && grep -q 'href="/u/nobody?tab=maintains">Maintains' /tmp/person, in 1.98 seconds) machine: must succeed: ! grep -q 'href="/packages" aria-current' /tmp/person && grep -q 'avatars.githubusercontent.com/nobody?s=96' /tmp/person && grep -q 'No open pull request in the synced data.' /tmp/person machine: (finished: must succeed: ! grep -q 'href="/packages" aria-current' /tmp/person && grep -q 'avatars.githubusercontent.com/nobody?s=96' /tmp/person && grep -q 'No open pull request in the synced data.' /tmp/person, in 1.35 seconds) machine: must succeed: curl -sf 'http://127.0.0.1:8790/u/nobody?tab=reviews' -o /tmp/page && grep -q 'aria-current="page">Reviews' /tmp/page && grep -q 'facts about reviews, not a judgement' /tmp/page machine: (finished: must succeed: curl -sf 'http://127.0.0.1:8790/u/nobody?tab=reviews' -o /tmp/page && grep -q 'aria-current="page">Reviews' /tmp/page && grep -q 'facts about reviews, not a judgement' /tmp/page, in 1.48 seconds) machine: must succeed: curl -sf 'http://127.0.0.1:8790/u/nobody?tab=maintains' -o /tmp/page && grep -q 'What nobody maintains' /tmp/page && grep -q 'aria-current="page">Maintains' /tmp/page machine: (finished: must succeed: curl -sf 'http://127.0.0.1:8790/u/nobody?tab=maintains' -o /tmp/page && grep -q 'What nobody maintains' /tmp/page && grep -q 'aria-current="page">Maintains' /tmp/page, in 1.80 seconds) machine: must succeed: curl -s -D /tmp/um.h -o /dev/null http://127.0.0.1:8790/u/nobody/maintains && grep -q '^HTTP/1.1 308' /tmp/um.h && grep -qi '^location: /u/nobody?tab=maintains' /tmp/um.h machine: (finished: must succeed: curl -s -D /tmp/um.h -o /dev/null http://127.0.0.1:8790/u/nobody/maintains && grep -q '^HTTP/1.1 308' /tmp/um.h && grep -qi '^location: /u/nobody?tab=maintains' /tmp/um.h, in 1.83 seconds) machine: must succeed: curl -s -o /dev/null -w '%{redirect_url}' 'http://127.0.0.1:8790/record?login=nobody' > /tmp/record.loc && grep -q '/u/nobody$' /tmp/record.loc machine: (finished: must succeed: curl -s -o /dev/null -w '%{redirect_url}' 'http://127.0.0.1:8790/record?login=nobody' > /tmp/record.loc && grep -q '/u/nobody$' /tmp/record.loc, in 1.75 seconds) machine: must succeed: curl -s -o /dev/null -w '%{redirect_url}' http://127.0.0.1:8790/record > /tmp/record.loc && grep -q '/packages$' /tmp/record.loc machine: (finished: must succeed: curl -s -o /dev/null -w '%{redirect_url}' http://127.0.0.1:8790/record > /tmp/record.loc && grep -q '/packages$' /tmp/record.loc, in 1.38 seconds) machine: must succeed: curl -s -D /tmp/watch.h -o /dev/null http://127.0.0.1:8790/watch && grep -q '^HTTP/1.1 308' /tmp/watch.h && grep -qi '^location: /packages?filter=watch' /tmp/watch.h machine: (finished: must succeed: curl -s -D /tmp/watch.h -o /dev/null http://127.0.0.1:8790/watch && grep -q '^HTTP/1.1 308' /tmp/watch.h && grep -qi '^location: /packages?filter=watch' /tmp/watch.h, in 1.80 seconds) machine: must succeed: curl -s -D /tmp/old-inbox.h -o /dev/null 'http://127.0.0.1:8790/me?tab=inbox' && grep -q '^HTTP/1.1 308' /tmp/old-inbox.h && grep -qi '^location: /inbox\s*$' /tmp/old-inbox.h machine: (finished: must succeed: curl -s -D /tmp/old-inbox.h -o /dev/null 'http://127.0.0.1:8790/me?tab=inbox' && grep -q '^HTTP/1.1 308' /tmp/old-inbox.h && grep -qi '^location: /inbox\s*$' /tmp/old-inbox.h, in 1.87 seconds) machine: must succeed: curl -s -D /tmp/old-maintain.h -o /dev/null 'http://127.0.0.1:8790/me?tab=maintain' && grep -q '^HTTP/1.1 308' /tmp/old-maintain.h && grep -qi '^location: /packages?filter=maintain\s*$' /tmp/old-maintain.h machine: (finished: must succeed: curl -s -D /tmp/old-maintain.h -o /dev/null 'http://127.0.0.1:8790/me?tab=maintain' && grep -q '^HTTP/1.1 308' /tmp/old-maintain.h && grep -qi '^location: /packages?filter=maintain\s*$' /tmp/old-maintain.h, in 1.93 seconds) machine: must succeed: curl -s -D /tmp/old-watch.h -o /dev/null 'http://127.0.0.1:8790/me?tab=watch' && grep -q '^HTTP/1.1 308' /tmp/old-watch.h && grep -qi '^location: /packages?filter=watch\s*$' /tmp/old-watch.h machine: (finished: must succeed: curl -s -D /tmp/old-watch.h -o /dev/null 'http://127.0.0.1:8790/me?tab=watch' && grep -q '^HTTP/1.1 308' /tmp/old-watch.h && grep -qi '^location: /packages?filter=watch\s*$' /tmp/old-watch.h, in 1.56 seconds) machine: must succeed: curl -s -D /tmp/old-machines.h -o /dev/null 'http://127.0.0.1:8790/me?tab=machines' && grep -q '^HTTP/1.1 308' /tmp/old-machines.h && grep -qi '^location: /packages?filter=machines\s*$' /tmp/old-machines.h machine: (finished: must succeed: curl -s -D /tmp/old-machines.h -o /dev/null 'http://127.0.0.1:8790/me?tab=machines' && grep -q '^HTTP/1.1 308' /tmp/old-machines.h && grep -qi '^location: /packages?filter=machines\s*$' /tmp/old-machines.h, in 1.79 seconds) machine: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST -d name=hello http://127.0.0.1:8790/me/watch > /tmp/watch2.code && grep -q 303 /tmp/watch2.code machine: (finished: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST -d name=hello http://127.0.0.1:8790/me/watch > /tmp/watch2.code && grep -q 303 /tmp/watch2.code, in 1.59 seconds) machine: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST http://127.0.0.1:8790/me/watch/maintained > /tmp/watch3.code && grep -q 303 /tmp/watch3.code machine: (finished: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST http://127.0.0.1:8790/me/watch/maintained > /tmp/watch3.code && grep -q 303 /tmp/watch3.code, in 1.71 seconds) machine: must succeed: curl -sf http://127.0.0.1:8790/api/v1/people/nobody -o /tmp/page && grep -q '"packages":\[\]' /tmp/page && grep -q '"dossier"' /tmp/page && grep -q '"open_prs":\[\]' /tmp/page && grep -q '"facts"' /tmp/page machine: (finished: must succeed: curl -sf http://127.0.0.1:8790/api/v1/people/nobody -o /tmp/page && grep -q '"packages":\[\]' /tmp/page && grep -q '"dossier"' /tmp/page && grep -q '"open_prs":\[\]' /tmp/page && grep -q '"facts"' /tmp/page, in 1.98 seconds) machine: must succeed: curl -sf http://127.0.0.1:8790/api/v1/status -o /tmp/status.json && grep -q nixpkgs-committers /tmp/status.json machine: (finished: must succeed: curl -sf http://127.0.0.1:8790/api/v1/status -o /tmp/status.json && grep -q nixpkgs-committers /tmp/status.json, in 1.63 seconds) machine: must fail: curl -sf http://127.0.0.1:8790/feed/nothing machine: (finished: must fail: curl -sf http://127.0.0.1:8790/feed/nothing, in 1.39 seconds) machine: must succeed: curl -sf 'http://127.0.0.1:8790/state?tab=status' -o /tmp/sync && grep -q 'How fast changes show here' /tmp/sync machine: (finished: must succeed: curl -sf 'http://127.0.0.1:8790/state?tab=status' -o /tmp/sync && grep -q 'How fast changes show here' /tmp/sync, in 1.69 seconds) machine: must succeed: grep -q 'Notifications
the notifications of the bot account' /tmp/sync machine: (finished: must succeed: grep -q 'Notifications
the notifications of the bot account' /tmp/sync, in 0.82 seconds) machine: must succeed: grep -q 'the poll of its notifications fails now' /tmp/sync machine: (finished: must succeed: grep -q 'the poll of its notifications fails now' /tmp/sync, in 0.67 seconds) machine: must succeed: curl -sf http://127.0.0.1:8790/api/v1/sync -o /tmp/sync.json && grep -q worst_delay_seconds /tmp/sync.json machine: (finished: must succeed: curl -sf http://127.0.0.1:8790/api/v1/sync -o /tmp/sync.json && grep -q worst_delay_seconds /tmp/sync.json, in 1.36 seconds) machine: must succeed: grep -q '"notifications":{[^}]*"enabled":true' /tmp/sync.json && grep -q rows_from_archive_at /tmp/sync.json machine: (finished: must succeed: grep -q '"notifications":{[^}]*"enabled":true' /tmp/sync.json && grep -q rows_from_archive_at /tmp/sync.json, in 1.10 seconds) machine: waiting for success: curl -sf 'http://127.0.0.1:8790/state?tab=status' -o /tmp/sync.n && grep -q 'errors in the last hour; the last: ' /tmp/sync.n machine: (finished: waiting for success: curl -sf 'http://127.0.0.1:8790/state?tab=status' -o /tmp/sync.n && grep -q 'errors in the last hour; the last: ' /tmp/sync.n, in 1.74 seconds) machine: must succeed: journalctl -u maintainer-mode -o cat > /tmp/log && grep -q 'notifications poller on' /tmp/log machine: (finished: must succeed: journalctl -u maintainer-mode -o cat > /tmp/log && grep -q 'notifications poller on' /tmp/log, in 1.23 seconds) machine: must succeed: systemctl show maintainer-mode -p Environment > /tmp/env && grep -q 'MAINTAINER_MODE_BOT_TOKEN_FILE=' /tmp/env && ! grep -q SYNC_TOKEN /tmp/env machine: (finished: must succeed: systemctl show maintainer-mode -p Environment > /tmp/env && grep -q 'MAINTAINER_MODE_BOT_TOKEN_FILE=' /tmp/env && ! grep -q SYNC_TOKEN /tmp/env, in 1.49 seconds) machine: must succeed: grep -q 'CVE Program records' /tmp/sync machine: (finished: must succeed: grep -q 'CVE Program records' /tmp/sync, in 0.74 seconds) machine: must succeed: grep -q 'its own task' /tmp/sync machine: (finished: must succeed: grep -q 'its own task' /tmp/sync, in 0.75 seconds) machine: must succeed: grep -q 'Packaging hygiene' /tmp/sync machine: (finished: must succeed: grep -q 'Packaging hygiene' /tmp/sync, in 0.91 seconds) machine: must succeed: grep -q 'Upstream tags and registries' /tmp/sync machine: (finished: must succeed: grep -q 'Upstream tags and registries' /tmp/sync, in 0.86 seconds) machine: must succeed: grep -q 'OSV records' /tmp/sync machine: (finished: must succeed: grep -q 'OSV records' /tmp/sync, in 0.78 seconds) machine: must succeed: grep -q 'at most 4 at a time and 30 a minute' /tmp/sync machine: (finished: must succeed: grep -q 'at most 4 at a time and 30 a minute' /tmp/sync, in 0.89 seconds) machine: must succeed: grep -q '"not_asked":0' /tmp/sync.json && grep -q '"per_minute":30' /tmp/sync.json machine: (finished: must succeed: grep -q '"not_asked":0' /tmp/sync.json && grep -q '"per_minute":30' /tmp/sync.json, in 1.13 seconds) machine: must succeed: grep -q with_gaps /tmp/sync.json machine: (finished: must succeed: grep -q with_gaps /tmp/sync.json, in 0.70 seconds) machine: must succeed: grep -q cves_with_score /tmp/sync.json machine: (finished: must succeed: grep -q cves_with_score /tmp/sync.json, in 0.71 seconds) machine: waiting for success: curl -sf http://127.0.0.1:8790/api/v1/sync -o /tmp/sync2.json && grep -q '0 records read' /tmp/sync2.json machine: (finished: waiting for success: curl -sf http://127.0.0.1:8790/api/v1/sync -o /tmp/sync2.json && grep -q '0 records read' /tmp/sync2.json, in 1.84 seconds) machine: waiting for success: curl -sf http://127.0.0.1:8790/api/v1/sync -o /tmp/sync3.json && grep -q 'waiting for an index with source URLs' /tmp/sync3.json machine: (finished: waiting for success: curl -sf http://127.0.0.1:8790/api/v1/sync -o /tmp/sync3.json && grep -q 'waiting for an index with source URLs' /tmp/sync3.json, in 1.83 seconds) machine: must succeed: grep -q 'Channel nixos-unstable' /tmp/sync machine: (finished: must succeed: grep -q 'Channel nixos-unstable' /tmp/sync, in 0.85 seconds) machine: must succeed: grep -q 'Channel nixos-26.05
not read yet' /tmp/sync machine: (finished: must succeed: grep -q 'Channel nixos-26.05
not read yet' /tmp/sync, in 0.84 seconds) machine: must succeed: grep -q '"rev":null' /tmp/sync.json && grep -q '"channel":"nixos-26.05"' /tmp/sync.json machine: (finished: must succeed: grep -q '"rev":null' /tmp/sync.json && grep -q '"channel":"nixos-26.05"' /tmp/sync.json, in 0.94 seconds) machine: waiting for success: journalctl -u maintainer-mode -o cat > /tmp/log && grep -q 'channels wait for the master index' /tmp/log machine: (finished: waiting for success: journalctl -u maintainer-mode -o cat > /tmp/log && grep -q 'channels wait for the master index' /tmp/log, in 1.11 seconds) machine: must succeed: curl -sf 'http://127.0.0.1:8790/state?tab=status' -o /tmp/sync && grep -q 'id="archive"' /tmp/sync && grep -q 'waiting for the first listing' /tmp/sync machine: (finished: must succeed: curl -sf 'http://127.0.0.1:8790/state?tab=status' -o /tmp/sync && grep -q 'id="archive"' /tmp/sync && grep -q 'waiting for the first listing' /tmp/sync, in 1.87 seconds) machine: must succeed: curl -sf http://127.0.0.1:8790/api/v1/sync -o /tmp/sync.json && grep -q '"repo":"NixOS/nixpkgs"' /tmp/sync.json machine: (finished: must succeed: curl -sf http://127.0.0.1:8790/api/v1/sync -o /tmp/sync.json && grep -q '"repo":"NixOS/nixpkgs"' /tmp/sync.json, in 1.68 seconds) machine: must succeed: curl -s -o /tmp/a1 -w '%{http_code}' http://127.0.0.1:8790/api/v1/archive/NixOS/nixpkgs/1 > /tmp/a1.code && grep -q 404 /tmp/a1.code && grep -q 'not in the archive yet' /tmp/a1 machine # [ 449.094812] maintainer-mode[809]: 2026-10-24T20:18:00.091001Z WARN maintainer_mode::notifications: notifications: error sending request for url (https://api.github.com/notifications?all=false&participating=false&per_page=50): client error (Connect): dns error: failed to lookup address information: Name or service not known machine # [ 449.139113] maintainer-mode[809]: 2026-10-24T20:18:00.109642Z WARN maintainer_mode::events: events poll: error sending request for url (https://api.github.com/repos/NixOS/nixpkgs/events?per_page=100&page=1): client error (Connect): dns error: failed to lookup address information: Name or service not known machine: (finished: must succeed: curl -s -o /tmp/a1 -w '%{http_code}' http://127.0.0.1:8790/api/v1/archive/NixOS/nixpkgs/1 > /tmp/a1.code && grep -q 404 /tmp/a1.code && grep -q 'not in the archive yet' /tmp/a1, in 2.55 seconds) machine: must succeed: curl -s -o /dev/null -w '%{http_code}' http://127.0.0.1:8790/api/v1/archive/NixOS/nix/1 > /tmp/a2.code && grep -q 404 /tmp/a2.code machine: (finished: must succeed: curl -s -o /dev/null -w '%{http_code}' http://127.0.0.1:8790/api/v1/archive/NixOS/nix/1 > /tmp/a2.code && grep -q 404 /tmp/a2.code, in 1.33 seconds) machine: must succeed: test -f /var/lib/maintainer-mode/archive/NixOS/nixpkgs.sqlite machine: (finished: must succeed: test -f /var/lib/maintainer-mode/archive/NixOS/nixpkgs.sqlite, in 0.53 seconds) machine: must succeed: maintainer-mode archive export --db /var/lib/maintainer-mode/maintainer-mode.sqlite --repo NixOS/nixpkgs --out /tmp/export 2> /tmp/export.log && grep -q '0 items of NixOS/nixpkgs' /tmp/export.log machine: (finished: must succeed: maintainer-mode archive export --db /var/lib/maintainer-mode/maintainer-mode.sqlite --repo NixOS/nixpkgs --out /tmp/export 2> /tmp/export.log && grep -q '0 items of NixOS/nixpkgs' /tmp/export.log, in 1.39 seconds) machine: must succeed: curl -sf http://127.0.0.1:8790/actions -o /tmp/page && grep -q 'Sign in to run workflows' /tmp/page machine: (finished: must succeed: curl -sf http://127.0.0.1:8790/actions -o /tmp/page && grep -q 'Sign in to run workflows' /tmp/page, in 1.50 seconds) machine: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST -d pr=1 http://127.0.0.1:8790/me/runs/review > /tmp/runs1 && grep -q 303 /tmp/runs1 machine: (finished: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST -d pr=1 http://127.0.0.1:8790/me/runs/review > /tmp/runs1 && grep -q 303 /tmp/runs1, in 1.34 seconds) machine: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST -H 'Sec-Fetch-Site: same-site' -d pr=1 http://127.0.0.1:8790/me/runs/review > /tmp/runs2 && grep -q 403 /tmp/runs2 machine: (finished: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST -H 'Sec-Fetch-Site: same-site' -d pr=1 http://127.0.0.1:8790/me/runs/review > /tmp/runs2 && grep -q 403 /tmp/runs2, in 1.73 seconds) machine: must fail: curl -sf http://127.0.0.1:8790/a/..%2Fetc machine: (finished: must fail: curl -sf http://127.0.0.1:8790/a/..%2Fetc, in 1.28 seconds) machine: must succeed: touch /tmp/events machine: (finished: must succeed: touch /tmp/events, in 0.85 seconds) machine: must succeed: grep -qi 'content-type: text/event-stream' /tmp/events.h machine: (finished: must succeed: grep -qi 'content-type: text/event-stream' /tmp/events.h, in 0.70 seconds) machine: must succeed: ! grep -q '^data:' /tmp/events machine: (finished: must succeed: ! grep -q '^data:' /tmp/events, in 0.77 seconds) machine: must succeed: test -d /var/lib/maintainer-mode/events machine: (finished: must succeed: test -d /var/lib/maintainer-mode/events, in 0.67 seconds) machine: must succeed: set -o pipefail; maintainer-mode --server http://127.0.0.1:8790 metrics | true machine: (finished: must succeed: set -o pipefail; maintainer-mode --server http://127.0.0.1:8790 metrics | true, in 1.09 seconds) machine: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST http://127.0.0.1:8790/api/v1/reports > /tmp/r1 && grep -q 401 /tmp/r1 machine: (finished: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST http://127.0.0.1:8790/api/v1/reports > /tmp/r1 && grep -q 401 /tmp/r1, in 1.65 seconds) machine: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST -H 'Authorization: Bearer nope' -d '{}' http://127.0.0.1:8790/api/v1/reports > /tmp/r2 && grep -q 401 /tmp/r2 machine: (finished: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST -H 'Authorization: Bearer nope' -d '{}' http://127.0.0.1:8790/api/v1/reports > /tmp/r2 && grep -q 401 /tmp/r2, in 1.31 seconds) machine: must succeed: curl -s -D /tmp/r3.h -o /dev/null http://127.0.0.1:8790/me/sets && grep -qi '^location: /packages?filter=machines' /tmp/r3.h machine: (finished: must succeed: curl -s -D /tmp/r3.h -o /dev/null http://127.0.0.1:8790/me/sets && grep -qi '^location: /packages?filter=machines' /tmp/r3.h, in 1.52 seconds) machine: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST http://127.0.0.1:8790/me/upload-token > /tmp/r4 && grep -q 303 /tmp/r4 machine: (finished: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST http://127.0.0.1:8790/me/upload-token > /tmp/r4 && grep -q 303 /tmp/r4, in 1.63 seconds) machine: must succeed: curl -s -o /dev/null -w '%{http_code}' http://127.0.0.1:8790/me/settings > /tmp/r5 && grep -q 303 /tmp/r5 machine: (finished: must succeed: curl -s -o /dev/null -w '%{http_code}' http://127.0.0.1:8790/me/settings > /tmp/r5 && grep -q 303 /tmp/r5, in 1.65 seconds) machine: must succeed: curl -s -D /tmp/r5.h -o /dev/null http://127.0.0.1:8790/me/settings && grep -qi '^cache-control: private, no-store' /tmp/r5.h machine: (finished: must succeed: curl -s -D /tmp/r5.h -o /dev/null http://127.0.0.1:8790/me/settings && grep -qi '^cache-control: private, no-store' /tmp/r5.h, in 1.41 seconds) machine: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST -d review_repo=a/b -d update_repo=a/b -d nixpkgs_fork=a/c http://127.0.0.1:8790/me/settings/workflows > /tmp/r12 && grep -q 303 /tmp/r12 machine: (finished: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST -d review_repo=a/b -d update_repo=a/b -d nixpkgs_fork=a/c http://127.0.0.1:8790/me/settings/workflows > /tmp/r12 && grep -q 303 /tmp/r12, in 1.33 seconds) machine: must succeed: curl -s -D /tmp/check.h -o /dev/null -X POST http://127.0.0.1:8790/me/settings/workflows/check && grep -q '^HTTP/1.1 303' /tmp/check.h && grep -qi '^cache-control: private, no-store' /tmp/check.h machine: (finished: must succeed: curl -s -D /tmp/check.h -o /dev/null -X POST http://127.0.0.1:8790/me/settings/workflows/check && grep -q '^HTTP/1.1 303' /tmp/check.h && grep -qi '^cache-control: private, no-store' /tmp/check.h, in 1.83 seconds) machine: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST -d tags=pkgs http://127.0.0.1:8790/me/tags > /tmp/r13 && grep -q 303 /tmp/r13 machine: (finished: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST -d tags=pkgs http://127.0.0.1:8790/me/tags > /tmp/r13 && grep -q 303 /tmp/r13, in 1.63 seconds) machine: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST http://127.0.0.1:8790/me/feed > /tmp/r14 && grep -q 303 /tmp/r14 machine: (finished: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST http://127.0.0.1:8790/me/feed > /tmp/r14 && grep -q 303 /tmp/r14, in 1.59 seconds) machine: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST -d llm_ok=1 http://127.0.0.1:8790/me/settings/llm > /tmp/r6 && grep -q 303 /tmp/r6 machine: (finished: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST -d llm_ok=1 http://127.0.0.1:8790/me/settings/llm > /tmp/r6 && grep -q 303 /tmp/r6, in 1.31 seconds) machine: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST http://127.0.0.1:8790/me/mcp-token > /tmp/r7 && grep -q 303 /tmp/r7 machine: (finished: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST http://127.0.0.1:8790/me/mcp-token > /tmp/r7 && grep -q 303 /tmp/r7, in 1.51 seconds) machine: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST -H 'Content-Type: application/json' -d '{}' http://127.0.0.1:8790/mcp > /tmp/r8 && grep -q 401 /tmp/r8 machine: (finished: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST -H 'Content-Type: application/json' -d '{}' http://127.0.0.1:8790/mcp > /tmp/r8 && grep -q 401 /tmp/r8, in 1.56 seconds) machine: must succeed: curl -s -D /tmp/r9.h -o /dev/null -X POST -H 'Authorization: Bearer nope' -H 'Content-Type: application/json' -H 'Accept: application/json, text/event-stream' -d '{"jsonrpc":"2.0","id":1,"method":"tools/list"}' http://127.0.0.1:8790/mcp && grep -q '^HTTP/1.1 401' /tmp/r9.h && grep -qi '^www-authenticate: Bearer' /tmp/r9.h machine: (finished: must succeed: curl -s -D /tmp/r9.h -o /dev/null -X POST -H 'Authorization: Bearer nope' -H 'Content-Type: application/json' -H 'Accept: application/json, text/event-stream' -d '{"jsonrpc":"2.0","id":1,"method":"tools/list"}' http://127.0.0.1:8790/mcp && grep -q '^HTTP/1.1 401' /tmp/r9.h && grep -qi '^www-authenticate: Bearer' /tmp/r9.h, in 1.93 seconds) machine: must succeed: curl -s -o /dev/null -w '%{http_code}' http://127.0.0.1:8790/mcp > /tmp/r10 && grep -q 405 /tmp/r10 machine: (finished: must succeed: curl -s -o /dev/null -w '%{http_code}' http://127.0.0.1:8790/mcp > /tmp/r10 && grep -q 405 /tmp/r10, in 1.32 seconds) machine: must succeed: curl -s -o /dev/null -w '%{http_code}' http://127.0.0.1:8790/claude/pr/1 > /tmp/r11 && grep -q 303 /tmp/r11 machine: (finished: must succeed: curl -s -o /dev/null -w '%{http_code}' http://127.0.0.1:8790/claude/pr/1 > /tmp/r11 && grep -q 303 /tmp/r11, in 1.48 seconds) machine: must succeed: curl -s -o /tmp/pr1 -w '%{http_code}' http://127.0.0.1:8790/pr/1 > /tmp/pr1.code && grep -q 200 /tmp/pr1.code machine: (finished: must succeed: curl -s -o /tmp/pr1 -w '%{http_code}' http://127.0.0.1:8790/pr/1 > /tmp/pr1.code && grep -q 200 /tmp/pr1.code, in 1.62 seconds) machine: must succeed: grep -q 'href="https://github.com/NixOS/nixpkgs/pull/1"' /tmp/pr1 && grep -q 'not in the data of this site' /tmp/pr1 machine: (finished: must succeed: grep -q 'href="https://github.com/NixOS/nixpkgs/pull/1"' /tmp/pr1 && grep -q 'not in the data of this site' /tmp/pr1, in 1.00 seconds) machine: must succeed: ! grep -q 'id="decide"' /tmp/pr1 machine: (finished: must succeed: ! grep -q 'id="decide"' /tmp/pr1, in 0.89 seconds) machine: must succeed: curl -s -o /dev/null -w '%{http_code}' http://127.0.0.1:8790/pr/18446744073709551615 > /tmp/pr2.code && grep -q 200 /tmp/pr2.code && curl -sf http://127.0.0.1:8790/healthz machine: (finished: must succeed: curl -s -o /dev/null -w '%{http_code}' http://127.0.0.1:8790/pr/18446744073709551615 > /tmp/pr2.code && grep -q 200 /tmp/pr2.code && curl -sf http://127.0.0.1:8790/healthz, in 1.95 seconds) machine: must succeed: curl -s -o /tmp/pr1.json -w '%{http_code}' http://127.0.0.1:8790/api/v1/prs/1 > /tmp/pr1.json.code && grep -q 404 /tmp/pr1.json.code machine: (finished: must succeed: curl -s -o /tmp/pr1.json -w '%{http_code}' http://127.0.0.1:8790/api/v1/prs/1 > /tmp/pr1.json.code && grep -q 404 /tmp/pr1.json.code, in 1.53 seconds) machine: must succeed: grep -q '"url":"https://github.com/NixOS/nixpkgs/pull/1"' /tmp/pr1.json machine: (finished: must succeed: grep -q '"url":"https://github.com/NixOS/nixpkgs/pull/1"' /tmp/pr1.json, in 0.81 seconds) machine: must fail: curl -sf http://127.0.0.1:8790/pr/nope machine: (finished: must fail: curl -sf http://127.0.0.1:8790/pr/nope, in 1.11 seconds) machine: must succeed: curl -sf -o /tmp/robots http://127.0.0.1:8790/robots.txt && grep -q '^Disallow: /pr/' /tmp/robots && grep -q '^Disallow: /api/v1/prs/' /tmp/robots machine: (finished: must succeed: curl -sf -o /tmp/robots http://127.0.0.1:8790/robots.txt && grep -q '^Disallow: /pr/' /tmp/robots && grep -q '^Disallow: /api/v1/prs/' /tmp/robots, in 1.48 seconds) machine: must succeed: curl -s -D /tmp/n1.h -o /dev/null http://127.0.0.1:8790/me/inbox && grep -qi '^location: /inbox' /tmp/n1.h && grep -qi '^cache-control: private, no-store' /tmp/n1.h machine: (finished: must succeed: curl -s -D /tmp/n1.h -o /dev/null http://127.0.0.1:8790/me/inbox && grep -qi '^location: /inbox' /tmp/n1.h && grep -qi '^cache-control: private, no-store' /tmp/n1.h, in 1.83 seconds) machine: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST http://127.0.0.1:8790/me/inbox/read > /tmp/n2 && grep -q 303 /tmp/n2 machine: (finished: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST http://127.0.0.1:8790/me/inbox/read > /tmp/n2 && grep -q 303 /tmp/n2, in 1.62 seconds) machine: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST -d k_pr=1 -d email=a@example.org http://127.0.0.1:8790/me/notify > /tmp/n3 && grep -q 303 /tmp/n3 machine # [ 509.270263] maintainer-mode[809]: 2026-10-24T20:19:00.244549Z WARN maintainer_mode::events: events poll: error sending request for url (https://api.github.com/repos/NixOS/nixpkgs/events?per_page=100&page=1): client error (Connect): dns error: failed to lookup address information: Name or service not known machine # [ 509.320948] maintainer-mode[809]: 2026-10-24T20:19:00.360589Z WARN maintainer_mode::notifications: notifications: error sending request for url (https://api.github.com/notifications?all=false&participating=false&per_page=50): client error (Connect): dns error: failed to lookup address information: Name or service not known machine # [ 509.415285] maintainer-mode[809]: 2026-10-24T20:19:00.450176Z WARN maintainer_mode::archive: archive NixOS/nixpkgs: error sending request for url (https://api.github.com/graphql): client error (Connect): dns error: failed to lookup address information: Name or service not known machine # [ 509.494020] maintainer-mode[809]: 2026-10-24T20:19:00.533772Z WARN maintainer_mode::builds: hydra builds: error sending request for url (https://hydra.nixos.org/api/latestbuilds?nr=200&project=nixpkgs&jobset=unstable&system=x86_64-linux): client error (Connect): dns error: failed to lookup address information: Name or service not known machine: (finished: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST -d k_pr=1 -d email=a@example.org http://127.0.0.1:8790/me/notify > /tmp/n3 && grep -q 303 /tmp/n3, in 2.21 seconds) machine: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST http://127.0.0.1:8790/me/notify/test > /tmp/n4 && grep -q 303 /tmp/n4 machine: (finished: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST http://127.0.0.1:8790/me/notify/test > /tmp/n4 && grep -q 303 /tmp/n4, in 1.28 seconds) machine: must succeed: curl -s -o /tmp/n5.body -w '%{http_code}' http://127.0.0.1:8790/unsubscribe/nope > /tmp/n5 && grep -q 404 /tmp/n5 && grep -q 'unsubscribe link is unknown' /tmp/n5.body machine: (finished: must succeed: curl -s -o /tmp/n5.body -w '%{http_code}' http://127.0.0.1:8790/unsubscribe/nope > /tmp/n5 && grep -q 404 /tmp/n5 && grep -q 'unsubscribe link is unknown' /tmp/n5.body, in 1.69 seconds) machine: must succeed: curl -s -o /dev/null -w '%{http_code}' http://127.0.0.1:8790/unsubscribe/0000000000000000000000000000000000000000000000000000000000000000 > /tmp/n6 && grep -q 404 /tmp/n6 machine: (finished: must succeed: curl -s -o /dev/null -w '%{http_code}' http://127.0.0.1:8790/unsubscribe/0000000000000000000000000000000000000000000000000000000000000000 > /tmp/n6 && grep -q 404 /tmp/n6, in 1.56 seconds) machine: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST http://127.0.0.1:8790/unsubscribe/nope > /tmp/n7 && grep -q 404 /tmp/n7 machine: (finished: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST http://127.0.0.1:8790/unsubscribe/nope > /tmp/n7 && grep -q 404 /tmp/n7, in 1.61 seconds) machine: must succeed: curl -s -o /tmp/n8.body -w '%{http_code}' http://127.0.0.1:8790/confirm/nope > /tmp/n8 && grep -q 404 /tmp/n8 && grep -q 'confirmation link is unknown' /tmp/n8.body machine: (finished: must succeed: curl -s -o /tmp/n8.body -w '%{http_code}' http://127.0.0.1:8790/confirm/nope > /tmp/n8 && grep -q 404 /tmp/n8 && grep -q 'confirmation link is unknown' /tmp/n8.body, in 1.54 seconds) machine: must succeed: curl -s -o /dev/null -w '%{http_code}' http://127.0.0.1:8790/confirm/0000000000000000000000000000000000000000000000000000000000000000 > /tmp/n9 && grep -q 404 /tmp/n9 machine: (finished: must succeed: curl -s -o /dev/null -w '%{http_code}' http://127.0.0.1:8790/confirm/0000000000000000000000000000000000000000000000000000000000000000 > /tmp/n9 && grep -q 404 /tmp/n9, in 1.54 seconds) machine: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST http://127.0.0.1:8790/confirm/0000000000000000000000000000000000000000000000000000000000000000 > /tmp/n10 && grep -q 404 /tmp/n10 machine: (finished: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST http://127.0.0.1:8790/confirm/0000000000000000000000000000000000000000000000000000000000000000 > /tmp/n10 && grep -q 404 /tmp/n10, in 1.65 seconds) machine: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST http://127.0.0.1:8790/me/notify/confirm > /tmp/n11 && grep -q 303 /tmp/n11 machine: (finished: must succeed: curl -s -o /dev/null -w '%{http_code}' -X POST http://127.0.0.1:8790/me/notify/confirm > /tmp/n11 && grep -q 303 /tmp/n11, in 1.63 seconds) machine: must fail: systemctl show maintainer-mode -p Environment > /tmp/env && grep -q MAINTAINER_MODE_SMTP /tmp/env machine # [ 524.915274] maintainer-mode[809]: 2026-10-24T20:19:15.913436Z WARN maintainer_mode: nixpkgs index: error sending request for url (https://api.github.com/repos/NixOS/nixpkgs/commits/master): client error (Connect): dns error: failed to lookup address information: Name or service not known machine # [ 524.997225] maintainer-mode[809]: 2026-10-24T20:19:16.034356Z WARN maintainer_mode: GitHub App token: error sending request for url (https://api.github.com/app): client error (Connect): dns error: failed to lookup address information: Name or service not known machine # [ 525.016976] maintainer-mode[809]: 2026-10-24T20:19:16.053491Z INFO maintainer_mode: network unreachable; next pass in 300 s machine: (finished: must fail: systemctl show maintainer-mode -p Environment > /tmp/env && grep -q MAINTAINER_MODE_SMTP /tmp/env, in 1.37 seconds) machine: must succeed: curl -s -o /tmp/r5.body -w '%{http_code}' -X POST -d name=web -d reference=github:o/r -d output=packages.x86_64-linux.default http://127.0.0.1:8790/me/sets/flakes > /tmp/r5 && grep -q 403 /tmp/r5 machine: (finished: must succeed: curl -s -o /tmp/r5.body -w '%{http_code}' -X POST -d name=web -d reference=github:o/r -d output=packages.x86_64-linux.default http://127.0.0.1:8790/me/sets/flakes > /tmp/r5 && grep -q 403 /tmp/r5, in 1.39 seconds) machine: must succeed: grep -q 'does not scan flakes' /tmp/r5.body machine: (finished: must succeed: grep -q 'does not scan flakes' /tmp/r5.body, in 0.80 seconds) machine: must succeed: curl -sf 'http://127.0.0.1:8790/state?tab=status' -o /tmp/sync && grep -q 'Flake rescans' /tmp/sync && grep -q 'off on this server' /tmp/sync machine: (finished: must succeed: curl -sf 'http://127.0.0.1:8790/state?tab=status' -o /tmp/sync && grep -q 'Flake rescans' /tmp/sync && grep -q 'off on this server' /tmp/sync, in 1.78 seconds) machine: must succeed: curl -sf http://127.0.0.1:8790/api/v1/sync -o /tmp/sync.json && grep -q '"rescans":{"enabled":false' /tmp/sync.json machine: (finished: must succeed: curl -sf http://127.0.0.1:8790/api/v1/sync -o /tmp/sync.json && grep -q '"rescans":{"enabled":false' /tmp/sync.json, in 1.70 seconds) machine: must succeed: grep -q 'Notification emails' /tmp/sync && grep -q 'did not set up SMTP' /tmp/sync machine: (finished: must succeed: grep -q 'Notification emails' /tmp/sync && grep -q 'did not set up SMTP' /tmp/sync, in 1.03 seconds) machine: must succeed: grep -q '"email":{"enabled":false,"per_day":null,"sent_24h":0,"skipped_24h":0}' /tmp/sync.json machine: (finished: must succeed: grep -q '"email":{"enabled":false,"per_day":null,"sent_24h":0,"skipped_24h":0}' /tmp/sync.json, in 0.72 seconds) machine: must fail: systemctl show maintainer-mode -p Environment > /tmp/env && grep -q MAINTAINER_MODE_RESCAN /tmp/env machine: (finished: must fail: systemctl show maintainer-mode -p Environment > /tmp/env && grep -q MAINTAINER_MODE_RESCAN /tmp/env, in 1.28 seconds) machine: must succeed: cp -rL /etc/scan /tmp/scan machine: (finished: must succeed: cp -rL /etc/scan /tmp/scan, in 0.93 seconds) machine: must succeed: curl -s -o /tmp/pi -w '%{http_code}' http://127.0.0.1:8790/api/v1/packages/index > /tmp/pi.code && grep -q 503 /tmp/pi.code && grep -q 'not built yet' /tmp/pi machine # [ 535.954737] maintainer-mode[809]: 2026-10-24T20:19:26.966109Z ERROR tower_http::trace::on_failure: response failed classification=Status code: 503 Service Unavailable latency=16 ms machine: (finished: must succeed: curl -s -o /tmp/pi -w '%{http_code}' http://127.0.0.1:8790/api/v1/packages/index > /tmp/pi.code && grep -q 503 /tmp/pi.code && grep -q 'not built yet' /tmp/pi, in 1.69 seconds) machine: must succeed: cd /tmp/scan && maintainer-mode scan --file host.nix --attr top machine # top: 4 packages, 4 new machine # 4 packages -> maintainer-mode-scan.json machine: (finished: must succeed: cd /tmp/scan && maintainer-mode scan --file host.nix --attr top, in 4.32 seconds) machine: must succeed: grep -q our-private-daemon /tmp/scan/maintainer-mode-scan.json machine: (finished: must succeed: grep -q our-private-daemon /tmp/scan/maintainer-mode-scan.json, in 0.71 seconds) machine: must fail: cd /tmp/scan && maintainer-mode --server http://127.0.0.1:8790 export --out report.json machine # [ 542.546717] maintainer-mode[809]: 2026-10-24T20:19:33.557328Z ERROR tower_http::trace::on_failure: response failed classification=Status code: 503 Service Unavailable latency=7 ms machine # error: http://127.0.0.1:8790/api/v1/packages/index: 503 Service Unavailable: the nixpkgs index is not built yet; try again later machine: (finished: must fail: cd /tmp/scan && maintainer-mode --server http://127.0.0.1:8790 export --out report.json, in 1.17 seconds) machine: must succeed: cd /tmp/scan && maintainer-mode export --index-file index.json --out report.json machine # 2 public packages, 1 of them with a version that the list does not have; 2 names kept back machine: (finished: must succeed: cd /tmp/scan && maintainer-mode export --index-file index.json --out report.json, in 1.16 seconds) machine: must succeed: grep -q '"attr": "python3Packages.requests"' /tmp/scan/report.json && grep -q '"modified": true' /tmp/scan/report.json machine: (finished: must succeed: grep -q '"attr": "python3Packages.requests"' /tmp/scan/report.json && grep -q '"modified": true' /tmp/scan/report.json, in 1.06 seconds) machine: must succeed: grep -q '"version": "2.12"' /tmp/scan/report.json && grep -q '"index_rev": "test"' /tmp/scan/report.json machine: (finished: must succeed: grep -q '"version": "2.12"' /tmp/scan/report.json && grep -q '"index_rev": "test"' /tmp/scan/report.json, in 1.17 seconds) machine: must succeed: grep -q '"unknown": 2' /tmp/scan/report.json machine: (finished: must succeed: grep -q '"unknown": 2' /tmp/scan/report.json, in 0.77 seconds) machine: must fail: grep -q -e our-private-daemon -e host.nix -e '"2.32"' -e '"name"' -e '"outputs"' /tmp/scan/report.json machine: (finished: must fail: grep -q -e our-private-daemon -e host.nix -e '"2.32"' -e '"name"' -e '"outputs"' /tmp/scan/report.json, in 0.64 seconds) machine: must succeed: cd /tmp/scan && maintainer-mode scan --file host.nix --attr top --attr other --out multi.json machine # top: 4 packages, 4 new machine # other: 5 packages, 1 new machine # 5 packages -> multi.json machine: (finished: must succeed: cd /tmp/scan && maintainer-mode scan --file host.nix --attr top --attr other --out multi.json, in 6.29 seconds) machine: must succeed: grep -q '"label": "other"' /tmp/scan/multi.json && grep -q '/nix/store/.*-hello-2.12.drv' /tmp/scan/multi.json machine: (finished: must succeed: grep -q '"label": "other"' /tmp/scan/multi.json && grep -q '/nix/store/.*-hello-2.12.drv' /tmp/scan/multi.json, in 0.98 seconds) machine: must succeed: cd /tmp/scan && maintainer-mode export --index-file index.json --report multi.json --with-outputs --out multi-report.json machine # 2 public packages, 1 of them with a version that the list does not have; 3 names kept back machine # 2 output labels: top, other machine: (finished: must succeed: cd /tmp/scan && maintainer-mode export --index-file index.json --report multi.json --with-outputs --out multi-report.json, in 0.88 seconds) machine: must succeed: tr -d ' \n' < /tmp/scan/multi-report.json > /tmp/mr && grep -q '"outputs":\["top","other"\]' /tmp/mr && grep -q '"attr":"hello","pname":"hello","version":"2.12","outputs":\[0,1\]' /tmp/mr machine: (finished: must succeed: tr -d ' \n' < /tmp/scan/multi-report.json > /tmp/mr && grep -q '"outputs":\["top","other"\]' /tmp/mr && grep -q '"attr":"hello","pname":"hello","version":"2.12","outputs":\[0,1\]' /tmp/mr, in 1.20 seconds) machine: must fail: grep -q -e /nix/store -e host.nix -e installable /tmp/scan/multi-report.json machine: (finished: must fail: grep -q -e /nix/store -e host.nix -e installable /tmp/scan/multi-report.json, in 0.92 seconds) machine: must succeed: cd /tmp/scan && maintainer-mode export --index-file index.json --report multi.json --out multi-plain.json && ! grep -q outputs /tmp/scan/multi-plain.json machine # 2 public packages, 1 of them with a version that the list does not have; 3 names kept back machine: (finished: must succeed: cd /tmp/scan && maintainer-mode export --index-file index.json --report multi.json --out multi-plain.json && ! grep -q outputs /tmp/scan/multi-plain.json, in 1.16 seconds) machine: must succeed: cd /tmp/scan && maintainer-mode why hello --report multi.json > /tmp/why.out && grep -q 'top holds hello-2.12' /tmp/why.out && grep -q 'other holds hello-2.12' /tmp/why.out && grep -q 'our-private-daemon-1.0.drv' /tmp/why.out machine # [ 569.314480] maintainer-mode[809]: 2026-10-24T20:20:00.318430Z WARN maintainer_mode::events: events poll: error sending request for url (https://api.github.com/repos/NixOS/nixpkgs/events?per_page=100&page=1): client error (Connect): dns error: failed to lookup address information: Name or service not known machine # [ 569.393637] maintainer-mode[809]: 2026-10-24T20:20:00.433189Z WARN maintainer_mode::notifications: notifications: error sending request for url (https://api.github.com/notifications?all=false&participating=false&per_page=50): client error (Connect): dns error: failed to lookup address information: Name or service not known machine: (finished: must succeed: cd /tmp/scan && maintainer-mode why hello --report multi.json > /tmp/why.out && grep -q 'top holds hello-2.12' /tmp/why.out && grep -q 'other holds hello-2.12' /tmp/why.out && grep -q 'our-private-daemon-1.0.drv' /tmp/why.out, in 12.58 seconds) machine: must succeed: cd /tmp/scan && maintainer-mode why hello --report multi.json --output other > /tmp/why2.out && ! grep -q 'top holds' /tmp/why2.out machine: (finished: must succeed: cd /tmp/scan && maintainer-mode why hello --report multi.json --output other > /tmp/why2.out && ! grep -q 'top holds' /tmp/why2.out, in 6.46 seconds) machine: must fail: cd /tmp/scan && maintainer-mode why hello --report multi.json --output nope machine # error: hello is not in nope; it is in other, top machine: (finished: must fail: cd /tmp/scan && maintainer-mode why hello --report multi.json --output nope, in 1.15 seconds) machine: must fail: cd /tmp/scan && maintainer-mode submit --to http://127.0.0.1:8790 machine # error: no upload token: run `maintainer-mode login` first machine: (finished: must fail: cd /tmp/scan && maintainer-mode submit --to http://127.0.0.1:8790, in 1.08 seconds) machine: must fail: cd /tmp/scan && MAINTAINER_MODE_UPLOAD_TOKEN=nope maintainer-mode submit --to http://127.0.0.1:8790 machine # error: http://127.0.0.1:8790/api/v1/packages/index: 503 Service Unavailable: the nixpkgs index is not built yet; try again later machine # [ 581.223369] maintainer-mode[809]: 2026-10-24T20:20:12.218877Z ERROR tower_http::trace::on_failure: response failed classification=Status code: 503 Service Unavailable latency=13 ms machine: (finished: must fail: cd /tmp/scan && MAINTAINER_MODE_UPLOAD_TOKEN=nope maintainer-mode submit --to http://127.0.0.1:8790, in 1.16 seconds) machine: must succeed: test -f /var/lib/maintainer-mode/maintainer-mode.sqlite machine: (finished: must succeed: test -f /var/lib/maintainer-mode/maintainer-mode.sqlite, in 0.70 seconds) machine: must succeed: sqlite3 -cmd '.timeout 5000' /var/lib/maintainer-mode/maintainer-mode.sqlite "INSERT INTO session (id, login, token, created_at, seen_at) VALUES ('vm-session', 'alice', 'vm-dummy-token', strftime('%Y-%m-%dT%H:%M:%SZ'), strftime('%Y-%m-%dT%H:%M:%SZ'))" && chown --reference=/var/lib/maintainer-mode/maintainer-mode.sqlite /var/lib/maintainer-mode/maintainer-mode.sqlite-wal /var/lib/maintainer-mode/maintainer-mode.sqlite-shm machine: (finished: must succeed: sqlite3 -cmd '.timeout 5000' /var/lib/maintainer-mode/maintainer-mode.sqlite "INSERT INTO session (id, login, token, created_at, seen_at) VALUES ('vm-session', 'alice', 'vm-dummy-token', strftime('%Y-%m-%dT%H:%M:%SZ'), strftime('%Y-%m-%dT%H:%M:%SZ'))" && chown --reference=/var/lib/maintainer-mode/maintainer-mode.sqlite /var/lib/maintainer-mode/maintainer-mode.sqlite-wal /var/lib/maintainer-mode/maintainer-mode.sqlite-shm, in 1.50 seconds) machine: must succeed: curl -s -H 'Cookie: session=vm-session' -D /tmp/s-home.h -o /tmp/s-home -w '%{http_code}' 'http://127.0.0.1:8790/' > /tmp/s-home.code && grep -qx 200 /tmp/s-home.code machine: (finished: must succeed: curl -s -H 'Cookie: session=vm-session' -D /tmp/s-home.h -o /tmp/s-home -w '%{http_code}' 'http://127.0.0.1:8790/' > /tmp/s-home.code && grep -qx 200 /tmp/s-home.code, in 1.52 seconds) machine: must succeed: grep -qi '^cache-control: private, no-store' /tmp/s-home.h machine: (finished: must succeed: grep -qi '^cache-control: private, no-store' /tmp/s-home.h, in 0.89 seconds) machine: must succeed: grep -q 'menu-login">alice<' /tmp/s-home machine: (finished: must succeed: grep -q 'menu-login">alice<' /tmp/s-home, in 0.89 seconds) machine: must succeed: curl -s -H 'Cookie: session=vm-session' -D /tmp/s-inbox.h -o /tmp/s-inbox -w '%{http_code}' 'http://127.0.0.1:8790/inbox' > /tmp/s-inbox.code && grep -qx 200 /tmp/s-inbox.code machine: (finished: must succeed: curl -s -H 'Cookie: session=vm-session' -D /tmp/s-inbox.h -o /tmp/s-inbox -w '%{http_code}' 'http://127.0.0.1:8790/inbox' > /tmp/s-inbox.code && grep -qx 200 /tmp/s-inbox.code, in 1.66 seconds) machine: must succeed: grep -qi '^cache-control: private, no-store' /tmp/s-inbox.h machine: (finished: must succeed: grep -qi '^cache-control: private, no-store' /tmp/s-inbox.h, in 0.90 seconds) machine: must succeed: grep -q 'menu-login">alice<' /tmp/s-inbox machine: (finished: must succeed: grep -q 'menu-login">alice<' /tmp/s-inbox, in 0.84 seconds) machine: must succeed: curl -s -H 'Cookie: session=vm-session' -D /tmp/s-settings.h -o /tmp/s-settings -w '%{http_code}' 'http://127.0.0.1:8790/me/settings' > /tmp/s-settings.code && grep -qx 200 /tmp/s-settings.code machine: (finished: must succeed: curl -s -H 'Cookie: session=vm-session' -D /tmp/s-settings.h -o /tmp/s-settings -w '%{http_code}' 'http://127.0.0.1:8790/me/settings' > /tmp/s-settings.code && grep -qx 200 /tmp/s-settings.code, in 1.64 seconds) machine: must succeed: grep -qi '^cache-control: private, no-store' /tmp/s-settings.h machine: (finished: must succeed: grep -qi '^cache-control: private, no-store' /tmp/s-settings.h, in 0.89 seconds) machine: must succeed: grep -q 'menu-login">alice<' /tmp/s-settings machine: (finished: must succeed: grep -q 'menu-login">alice<' /tmp/s-settings, in 0.93 seconds) machine: must succeed: curl -s -H 'Cookie: session=vm-session' -D /tmp/s-runs.h -o /tmp/s-runs -w '%{http_code}' 'http://127.0.0.1:8790/me/runs' > /tmp/s-runs.code && grep -qx 200 /tmp/s-runs.code machine: (finished: must succeed: curl -s -H 'Cookie: session=vm-session' -D /tmp/s-runs.h -o /tmp/s-runs -w '%{http_code}' 'http://127.0.0.1:8790/me/runs' > /tmp/s-runs.code && grep -qx 200 /tmp/s-runs.code, in 1.79 seconds) machine: must succeed: grep -qi '^cache-control: private, no-store' /tmp/s-runs.h machine: (finished: must succeed: grep -qi '^cache-control: private, no-store' /tmp/s-runs.h, in 1.01 seconds) machine: must succeed: grep -q 'menu-login">alice<' /tmp/s-runs machine: (finished: must succeed: grep -q 'menu-login">alice<' /tmp/s-runs, in 0.90 seconds) machine: must succeed: curl -s -H 'Cookie: session=vm-session' -D /tmp/s-progress.h -o /tmp/s-progress -w '%{http_code}' 'http://127.0.0.1:8790/me/progress' > /tmp/s-progress.code && grep -qx 200 /tmp/s-progress.code machine: (finished: must succeed: curl -s -H 'Cookie: session=vm-session' -D /tmp/s-progress.h -o /tmp/s-progress -w '%{http_code}' 'http://127.0.0.1:8790/me/progress' > /tmp/s-progress.code && grep -qx 200 /tmp/s-progress.code, in 1.47 seconds) machine: must succeed: grep -qi '^cache-control: private, no-store' /tmp/s-progress.h machine: (finished: must succeed: grep -qi '^cache-control: private, no-store' /tmp/s-progress.h, in 0.85 seconds) machine: must succeed: grep -q 'menu-login">alice<' /tmp/s-progress machine: (finished: must succeed: grep -q 'menu-login">alice<' /tmp/s-progress, in 0.96 seconds) machine: must succeed: curl -s -H 'Cookie: session=vm-session' -D /tmp/s-review.h -o /tmp/s-review -w '%{http_code}' 'http://127.0.0.1:8790/review' > /tmp/s-review.code && grep -qx 200 /tmp/s-review.code machine: (finished: must succeed: curl -s -H 'Cookie: session=vm-session' -D /tmp/s-review.h -o /tmp/s-review -w '%{http_code}' 'http://127.0.0.1:8790/review' > /tmp/s-review.code && grep -qx 200 /tmp/s-review.code, in 1.86 seconds) machine: must succeed: grep -qi '^cache-control: private, no-store' /tmp/s-review.h machine: (finished: must succeed: grep -qi '^cache-control: private, no-store' /tmp/s-review.h, in 0.97 seconds) machine: must succeed: grep -q 'menu-login">alice<' /tmp/s-review machine: (finished: must succeed: grep -q 'menu-login">alice<' /tmp/s-review, in 0.91 seconds) machine: must succeed: curl -s -H 'Cookie: session=vm-session' -D /tmp/s-ready.h -o /tmp/s-ready -w '%{http_code}' 'http://127.0.0.1:8790/review?tab=ready' > /tmp/s-ready.code && grep -qx 200 /tmp/s-ready.code machine: (finished: must succeed: curl -s -H 'Cookie: session=vm-session' -D /tmp/s-ready.h -o /tmp/s-ready -w '%{http_code}' 'http://127.0.0.1:8790/review?tab=ready' > /tmp/s-ready.code && grep -qx 200 /tmp/s-ready.code, in 1.51 seconds) machine: must succeed: grep -qi '^cache-control: private, no-store' /tmp/s-ready.h machine: (finished: must succeed: grep -qi '^cache-control: private, no-store' /tmp/s-ready.h, in 0.78 seconds) machine: must succeed: grep -q 'menu-login">alice<' /tmp/s-ready machine: (finished: must succeed: grep -q 'menu-login">alice<' /tmp/s-ready, in 0.83 seconds) machine: must succeed: curl -s -H 'Cookie: session=vm-session' -D /tmp/s-u.h -o /tmp/s-u -w '%{http_code}' 'http://127.0.0.1:8790/u/alice' > /tmp/s-u.code && grep -qx 200 /tmp/s-u.code machine: (finished: must succeed: curl -s -H 'Cookie: session=vm-session' -D /tmp/s-u.h -o /tmp/s-u -w '%{http_code}' 'http://127.0.0.1:8790/u/alice' > /tmp/s-u.code && grep -qx 200 /tmp/s-u.code, in 1.89 seconds) machine: must succeed: grep -qi '^cache-control: private, no-store' /tmp/s-u.h machine: (finished: must succeed: grep -qi '^cache-control: private, no-store' /tmp/s-u.h, in 0.81 seconds) machine: must succeed: grep -q 'menu-login">alice<' /tmp/s-u machine: (finished: must succeed: grep -q 'menu-login">alice<' /tmp/s-u, in 0.94 seconds) machine: must succeed: curl -s -H 'Cookie: session=vm-session' -D /tmp/s-packages.h -o /tmp/s-packages -w '%{http_code}' 'http://127.0.0.1:8790/packages' > /tmp/s-packages.code && grep -qx 200 /tmp/s-packages.code machine: (finished: must succeed: curl -s -H 'Cookie: session=vm-session' -D /tmp/s-packages.h -o /tmp/s-packages -w '%{http_code}' 'http://127.0.0.1:8790/packages' > /tmp/s-packages.code && grep -qx 200 /tmp/s-packages.code, in 1.56 seconds) machine: must succeed: grep -qi '^cache-control: private, no-store' /tmp/s-packages.h machine: (finished: must succeed: grep -qi '^cache-control: private, no-store' /tmp/s-packages.h, in 0.70 seconds) machine: must succeed: grep -q 'menu-login">alice<' /tmp/s-packages machine: (finished: must succeed: grep -q 'menu-login">alice<' /tmp/s-packages, in 0.78 seconds) machine: must succeed: curl -s -H 'Cookie: session=vm-session' -D /tmp/s-state.h -o /tmp/s-state -w '%{http_code}' 'http://127.0.0.1:8790/state' > /tmp/s-state.code && grep -qx 200 /tmp/s-state.code machine: (finished: must succeed: curl -s -H 'Cookie: session=vm-session' -D /tmp/s-state.h -o /tmp/s-state -w '%{http_code}' 'http://127.0.0.1:8790/state' > /tmp/s-state.code && grep -qx 200 /tmp/s-state.code, in 1.73 seconds) machine: must succeed: grep -qi '^cache-control: private, no-store' /tmp/s-state.h machine: (finished: must succeed: grep -qi '^cache-control: private, no-store' /tmp/s-state.h, in 0.82 seconds) machine: must succeed: grep -q 'menu-login">alice<' /tmp/s-state machine: (finished: must succeed: grep -q 'menu-login">alice<' /tmp/s-state, in 0.84 seconds) machine: must succeed: grep -q 'Needs you ' /tmp/s-home && grep -q 'aria-label="Moods"' /tmp/s-home && grep -q 'Your packages that need you' /tmp/s-home && grep -q 'href="/packages?filter=mine"' /tmp/s-home machine: (finished: must succeed: grep -q 'Needs you ' /tmp/s-home && grep -q 'aria-label="Moods"' /tmp/s-home && grep -q 'Your packages that need you' /tmp/s-home && grep -q 'href="/packages?filter=mine"' /tmp/s-home, in 1.58 seconds) machine: must succeed: ! grep -q 'Pull requests for you to review' /tmp/s-home && grep -q 'Keys: j' /tmp/s-home machine: (finished: must succeed: ! grep -q 'Pull requests for you to review' /tmp/s-home && grep -q 'Keys: j' /tmp/s-home, in 0.90 seconds) machine: must succeed: curl -sf -o /tmp/pub-home http://127.0.0.1:8790/ && ! grep -q -e 'Needs you' -e '