nixbot

1these 16 derivations will be built:2  /nix/store/89h9r8mfygccmnvbnj4l2jdgyq7ibnjq-nix.conf.drv3  /nix/store/459zgdsy16ryv37qznnf7ysqi59ypjjg-unit-nix-grpc-daemon-mtls.service.drv4  /nix/store/l6kxvxniys1mfvawmlz8jfqnsm8j1wll-unit-nix-grpc-daemon-strict.service.drv5  /nix/store/nv14h0cfl2y2gq0lxdkq5mdfpzj0mwgl-X-Restart-Triggers-nix-daemon.drv6  /nix/store/nh5xs1yhwai37cxcaah1234ahxb7s9qi-unit-nix-daemon.service.drv7  /nix/store/v82mdhdhldq1i64a8q4pg0q04sipmcs8-unit-nix-grpc-daemon.service.drv8  /nix/store/p7d6y9vrfi4idjyh5lk0lrrqc0p9r5z8-system-units.drv9  /nix/store/rhsy7y6ilymai12kprclbnsx6crg8sl1-etc.drv10  /nix/store/7qwfvlmai6cchb0m8wajhpsb33kf408l-activate.drv11  /nix/store/zs95fhn16lfy4fbilq2yyf97hbs78s9i-nixos-system-machine-test.drv12  /nix/store/50g7hqzcw13vagmdicc1ks1q74qdm1g6-closure-info.drv13  /nix/store/1myci58mgr65hbypjalzgykil7b8c2aa-run-nixos-vm.drv14  /nix/store/syx583xglamcf7i5mdmbnjk47rihxh4r-nixos-vm.drv15  /nix/store/vly9laikija81lgsi1ix8lhi0dqy0m4w-driverConfiguration.json.drv16  /nix/store/g467gsksd3yd6qax6srblzqlijlarx48-nixos-test-driver-nix-grpc-store-main.drv17  /nix/store/yrr1pja1qnkc2xmvpngcf3vr8pjnkrak-vm-test-run-nix-grpc-store-main.drv18building '/nix/store/459zgdsy16ryv37qznnf7ysqi59ypjjg-unit-nix-grpc-daemon-mtls.service.drv'19building '/nix/store/l6kxvxniys1mfvawmlz8jfqnsm8j1wll-unit-nix-grpc-daemon-strict.service.drv'20building '/nix/store/v82mdhdhldq1i64a8q4pg0q04sipmcs8-unit-nix-grpc-daemon.service.drv'21unit-nix-grpc-daemon-mtls.service> tribuchet: building on eliza22unit-nix-grpc-daemon-strict.service> tribuchet: building on eliza23unit-nix-grpc-daemon.service> tribuchet: building on eliza24unit-nix-grpc-daemon-strict.service> structuredAttrs is enabled25unit-nix-grpc-daemon.service> structuredAttrs is enabled26unit-nix-grpc-daemon-mtls.service> structuredAttrs is enabled27building '/nix/store/vly9laikija81lgsi1ix8lhi0dqy0m4w-driverConfiguration.json.drv'28driverConfiguration.json> tribuchet: building on eliza29driverConfiguration.json> structuredAttrs is enabled30building '/nix/store/g467gsksd3yd6qax6srblzqlijlarx48-nixos-test-driver-nix-grpc-store-main.drv'31nixos-test-driver-nix-grpc-store-main> tribuchet: building on eliza32nixos-test-driver-nix-grpc-store-main> Running type check (enable/disable: config.skipTypeCheck)33nixos-test-driver-nix-grpc-store-main> See https://nixos.org/manual/nixos/stable/#test-opt-skipTypeCheck34nixos-test-driver-nix-grpc-store-main> All checks passed!35nixos-test-driver-nix-grpc-store-main> Linting test script (enable/disable: config.skipLint)36nixos-test-driver-nix-grpc-store-main> See https://nixos.org/manual/nixos/stable/#test-opt-skipLint37nixos-test-driver-nix-grpc-store-main> All checks passed!38building '/nix/store/yrr1pja1qnkc2xmvpngcf3vr8pjnkrak-vm-test-run-nix-grpc-store-main.drv'39vm-test-run-nix-grpc-store-main> tribuchet: building on eliza40vm-test-run-nix-grpc-store-main> [0.00s] Machine state will be reset. To keep it, pass --keep-machine-state41vm-test-run-nix-grpc-store-main> [0.00s] start all VLans42vm-test-run-nix-grpc-store-main> [5.25s] (finished: start all VLans, in 5.25 seconds)43vm-test-run-nix-grpc-store-main> [5.25s] start vhost-device-vsock44vm-test-run-nix-grpc-store-main> [5.26s] (finished: start vhost-device-vsock, in 0.00 seconds)45vm-test-run-nix-grpc-store-main> [5.26s] Test will time out and terminate in 600.0 seconds46vm-test-run-nix-grpc-store-main> [5.26s] run the VM test script47vm-test-run-nix-grpc-store-main> [5.26s] machine: waiting for unit nix-daemon.socket48vm-test-run-nix-grpc-store-main> [5.26s] machine: waiting for the VM to finish booting49vm-test-run-nix-grpc-store-main> [5.26s] machine: starting vm50vm-test-run-nix-grpc-store-main> machine # Disk image does not exist, creating the virtualisation disk image...51vm-test-run-nix-grpc-store-main> [63.06s] machine: QEMU running (pid 46)52vm-test-run-nix-grpc-store-main> machine # Formatting '/build/vm-state-machine/tmp.iAQOZOB48R', fmt=raw size=2576980377653vm-test-run-nix-grpc-store-main> machine # mke2fs 1.47.4 (6-Mar-2025)54vm-test-run-nix-grpc-store-main> machine # Discarding device blocks:       0/6291456               done55vm-test-run-nix-grpc-store-main> machine # Creating filesystem with 6291456 4k blocks and 1572864 inodes56vm-test-run-nix-grpc-store-main> machine # Filesystem UUID: 6d823918-4c5a-402b-8f3f-9c4bbee6f9c757vm-test-run-nix-grpc-store-main> machine # Superblock backups stored on blocks:58vm-test-run-nix-grpc-store-main> machine # 	32768, 98304, 163840, 229376, 294912, 819200, 884736, 1605632, 2654208,59vm-test-run-nix-grpc-store-main> machine # 	409600060vm-test-run-nix-grpc-store-main> machine # 61vm-test-run-nix-grpc-store-main> machine # Allocating group tables:   0/192       done62vm-test-run-nix-grpc-store-main> machine # Writing inode tables:   0/192       done63vm-test-run-nix-grpc-store-main> machine # Creating journal (32768 blocks): done64vm-test-run-nix-grpc-store-main> machine # Writing superblocks and filesystem accounting information:   0/192       done65vm-test-run-nix-grpc-store-main> machine # 66vm-test-run-nix-grpc-store-main> machine # Virtualisation disk image created.67vm-test-run-nix-grpc-store-main> machine # Starting virtiofs daemons...68vm-test-run-nix-grpc-store-main> machine # [2026-11-12T08:46:37Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)69vm-test-run-nix-grpc-store-main> machine # [2026-11-12T08:46:37Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether70vm-test-run-nix-grpc-store-main> machine # [2026-11-12T08:46:37Z INFO  virtiofsd] Waiting for vhost-user socket connection...71vm-test-run-nix-grpc-store-main> machine # [2026-11-12T08:46:37Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)72vm-test-run-nix-grpc-store-main> machine # [2026-11-12T08:46:37Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether73vm-test-run-nix-grpc-store-main> machine # [2026-11-12T08:46:37Z INFO  virtiofsd] Waiting for vhost-user socket connection...74vm-test-run-nix-grpc-store-main> machine # [2026-11-12T08:46:37Z WARN  virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)75vm-test-run-nix-grpc-store-main> machine # [2026-11-12T08:46:37Z WARN  virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether76vm-test-run-nix-grpc-store-main> machine # [2026-11-12T08:46:37Z INFO  virtiofsd] Waiting for vhost-user socket connection...77vm-test-run-nix-grpc-store-main> machine # [2026-11-12T08:46:38Z INFO  virtiofsd] Client connected, servicing requests78vm-test-run-nix-grpc-store-main> machine # [2026-11-12T08:46:38Z INFO  virtiofsd] Client connected, servicing requests79vm-test-run-nix-grpc-store-main> machine # [2026-11-12T08:46:38Z INFO  virtiofsd] Client connected, servicing requests80vm-test-run-nix-grpc-store-main> machine # [    0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]81vm-test-run-nix-grpc-store-main> machine # [    0.000000] Linux version 6.18.60 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT @179336200182vm-test-run-nix-grpc-store-main> machine # [    0.000000] KASLR enabled83vm-test-run-nix-grpc-store-main> machine # [    0.000000] random: crng init done84vm-test-run-nix-grpc-store-main> machine # [    0.000000] Machine model: linux,dummy-virt85vm-test-run-nix-grpc-store-main> machine # [    0.000000] efi: UEFI not found.86vm-test-run-nix-grpc-store-main> machine # [    0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT87vm-test-run-nix-grpc-store-main> machine # [    0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x00000000bfffffff]88vm-test-run-nix-grpc-store-main> machine # [    0.000000] NODE_DATA(0) allocated [mem 0xbfdec0c0-0xbfdef83f]89vm-test-run-nix-grpc-store-main> machine # [    0.000000] Zone ranges:90vm-test-run-nix-grpc-store-main> machine # [    0.000000]   DMA      [mem 0x0000000040000000-0x00000000bfffffff]91vm-test-run-nix-grpc-store-main> machine # [    0.000000]   DMA32    empty92vm-test-run-nix-grpc-store-main> machine # [    0.000000]   Normal   empty93vm-test-run-nix-grpc-store-main> machine # [    0.000000]   Device   empty94vm-test-run-nix-grpc-store-main> machine # [    0.000000] Movable zone start for each node95vm-test-run-nix-grpc-store-main> machine # [    0.000000] Early memory node ranges96vm-test-run-nix-grpc-store-main> machine # [    0.000000]   node   0: [mem 0x0000000040000000-0x00000000bfffffff]97vm-test-run-nix-grpc-store-main> machine # [    0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x00000000bfffffff]98vm-test-run-nix-grpc-store-main> machine # [    0.000000] cma: Reserved 32 MiB at 0x00000000bbc0000099vm-test-run-nix-grpc-store-main> machine # [    0.000000] psci: probing for conduit method from DT.100vm-test-run-nix-grpc-store-main> machine # [    0.000000] psci: PSCIv1.3 detected in firmware.101vm-test-run-nix-grpc-store-main> machine # [    0.000000] psci: Using standard PSCI v0.2 function IDs102vm-test-run-nix-grpc-store-main> machine # [    0.000000] psci: Trusted OS migration not required103vm-test-run-nix-grpc-store-main> machine # [    0.000000] psci: SMC Calling Convention v1.1104vm-test-run-nix-grpc-store-main> machine # [    0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)105vm-test-run-nix-grpc-store-main> machine # [    0.000000] percpu: Embedded 76 pages/cpu s187672 r8192 d115432 u311296106vm-test-run-nix-grpc-store-main> machine # [    0.000000] Detected PIPT I-cache on CPU0107vm-test-run-nix-grpc-store-main> machine # [    0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)108vm-test-run-nix-grpc-store-main> machine # [    0.000000] CPU features: detected: GICv3 CPU interface109vm-test-run-nix-grpc-store-main> machine # [    0.000000] CPU features: detected: Spectre-v4110vm-test-run-nix-grpc-store-main> machine # [    0.000000] CPU features: detected: Spectre-BHB111vm-test-run-nix-grpc-store-main> machine # [    0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38112vm-test-run-nix-grpc-store-main> machine # [    0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23113vm-test-run-nix-grpc-store-main> machine # [    0.000000] alternatives: applying boot alternatives114vm-test-run-nix-grpc-store-main> 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/dpiamv2m807xifzrxys3xbaj61jqnkz3-nixos-system-machine-test/init regInfo=/nix/.ro-store/frb0pkc8wdj0w35azgl9p45h3md2g54b-closure-info/registration console=ttyAMA0,115200n8 console=tty0115vm-test-run-nix-grpc-store-main> machine # [    0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/frb0pkc8wdj0w35azgl9p45h3md2g54b-closure-info/registration", will be passed to user space.116vm-test-run-nix-grpc-store-main> machine # [    0.000000] printk: log buffer data + meta data: 1048576 + 3670016 = 4718592 bytes117vm-test-run-nix-grpc-store-main> machine # [    0.000000] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)118vm-test-run-nix-grpc-store-main> machine # [    0.000000] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)119vm-test-run-nix-grpc-store-main> machine # [    0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 2MB120vm-test-run-nix-grpc-store-main> machine # [    0.000000] software IO TLB: area num 2.121vm-test-run-nix-grpc-store-main> machine # [    0.000000] software IO TLB: mapped [mem 0x00000000bb800000-0x00000000bba00000] (2MB)122vm-test-run-nix-grpc-store-main> machine # [    0.000000] Fallback order for Node 0: 0123vm-test-run-nix-grpc-store-main> machine # [    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 524288124vm-test-run-nix-grpc-store-main> machine # [    0.000000] Policy zone: DMA125vm-test-run-nix-grpc-store-main> machine # [    0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off126vm-test-run-nix-grpc-store-main> machine # [    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1127vm-test-run-nix-grpc-store-main> machine # [    0.000000] allocated 4194304 bytes of page_ext128vm-test-run-nix-grpc-store-main> machine # [    0.000000] ftrace: allocating 75323 entries in 296 pages129vm-test-run-nix-grpc-store-main> machine # [    0.000000] ftrace: allocated 296 pages with 3 groups130vm-test-run-nix-grpc-store-main> machine # [    0.000000] rcu: Hierarchical RCU implementation.131vm-test-run-nix-grpc-store-main> machine # [    0.000000] rcu: 	RCU event tracing is enabled.132vm-test-run-nix-grpc-store-main> machine # [    0.000000] rcu: 	RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2.133vm-test-run-nix-grpc-store-main> machine # [    0.000000] 	Trampoline variant of Tasks RCU enabled.134vm-test-run-nix-grpc-store-main> machine # [    0.000000] 	Rude variant of Tasks RCU enabled.135vm-test-run-nix-grpc-store-main> machine # [    0.000000] 	Tracing variant of Tasks RCU enabled.136vm-test-run-nix-grpc-store-main> machine # [    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.137vm-test-run-nix-grpc-store-main> machine # [    0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2138vm-test-run-nix-grpc-store-main> machine # [    0.000000] RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.139vm-test-run-nix-grpc-store-main> machine # [    0.000000] RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.140vm-test-run-nix-grpc-store-main> machine # [    0.000000] RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.141vm-test-run-nix-grpc-store-main> machine # [    0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0142vm-test-run-nix-grpc-store-main> machine # [    0.000000] GICv3: 256 SPIs implemented143vm-test-run-nix-grpc-store-main> machine # [    0.000000] GICv3: 0 Extended SPIs implemented144vm-test-run-nix-grpc-store-main> machine # [    0.000000] Root IRQ handler: gic_handle_irq145vm-test-run-nix-grpc-store-main> machine # [    0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI146vm-test-run-nix-grpc-store-main> machine # [    0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0147vm-test-run-nix-grpc-store-main> machine # [    0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000148vm-test-run-nix-grpc-store-main> machine # [    0.000000] ITS [mem 0x08080000-0x0809ffff]149vm-test-run-nix-grpc-store-main> machine # [    0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44f00000 (indirect, esz 8, psz 64K, shr 1)150vm-test-run-nix-grpc-store-main> machine # [    0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44f10000 (flat, esz 8, psz 64K, shr 1)151vm-test-run-nix-grpc-store-main> machine # [    0.000000] GICv3: using LPI property table @0x0000000044f20000152vm-test-run-nix-grpc-store-main> machine # [    0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044f30000153vm-test-run-nix-grpc-store-main> machine # [    0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.154vm-test-run-nix-grpc-store-main> machine # [    0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns155vm-test-run-nix-grpc-store-main> machine # [    0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).156vm-test-run-nix-grpc-store-main> machine # [    0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns157vm-test-run-nix-grpc-store-main> machine # [    0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns158vm-test-run-nix-grpc-store-main> machine # [    0.000036] arm-pv: using stolen time PV159vm-test-run-nix-grpc-store-main> machine # [    0.000409] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)160vm-test-run-nix-grpc-store-main> machine # [    0.001897] Console: colour dummy device 80x25161vm-test-run-nix-grpc-store-main> machine # [    0.001907] printk: legacy console [tty0] enabled162vm-test-run-nix-grpc-store-main> machine # [    0.002131] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)163vm-test-run-nix-grpc-store-main> machine # [    0.002139] pid_max: default: 32768 minimum: 301164vm-test-run-nix-grpc-store-main> machine # [    0.002236] LSM: initializing lsm=lockdown,capability,landlock,yama,bpf,ima165vm-test-run-nix-grpc-store-main> machine # [    0.002384] landlock: Up and running.166vm-test-run-nix-grpc-store-main> machine # [    0.002387] Yama: becoming mindful.167vm-test-run-nix-grpc-store-main> machine # [    0.002915] LSM support for eBPF active168vm-test-run-nix-grpc-store-main> machine # [    0.003092] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)169vm-test-run-nix-grpc-store-main> machine # [    0.003130] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)170vm-test-run-nix-grpc-store-main> machine # [    0.005729] rcu: Hierarchical SRCU implementation.171vm-test-run-nix-grpc-store-main> machine # [    0.005740] rcu: 	Max phase no-delay instances is 1000.172vm-test-run-nix-grpc-store-main> machine # [    0.005960] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level173vm-test-run-nix-grpc-store-main> machine # [    0.007282] fsl-mc MSI: its@8080000 domain created174vm-test-run-nix-grpc-store-main> machine # [    0.007426] EFI services will not be available.175vm-test-run-nix-grpc-store-main> machine # [    0.007607] smp: Bringing up secondary CPUs ...176vm-test-run-nix-grpc-store-main> machine # [    0.008428] Detected PIPT I-cache on CPU1177vm-test-run-nix-grpc-store-main> machine # [    0.008501] GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000178vm-test-run-nix-grpc-store-main> machine # [    0.008579] GICv3: CPU1: using allocated LPI pending table @0x0000000044f40000179vm-test-run-nix-grpc-store-main> machine # [    0.008662] CPU1: Booted secondary processor 0x0000000001 [0xc00fac40]180vm-test-run-nix-grpc-store-main> machine # [    0.009800] smp: Brought up 1 node, 2 CPUs181vm-test-run-nix-grpc-store-main> machine # [    0.009820] SMP: Total of 2 processors activated.182vm-test-run-nix-grpc-store-main> machine # [    0.009835] CPU: All CPU(s) started at EL1183vm-test-run-nix-grpc-store-main> machine # [    0.009845] CPU features: detected: Branch Target Identification184vm-test-run-nix-grpc-store-main> machine # [    0.009848] CPU features: detected: ARMv8.4 Translation Table Level185vm-test-run-nix-grpc-store-main> machine # [    0.009851] CPU features: detected: Instruction cache invalidation not required for I/D coherence186vm-test-run-nix-grpc-store-main> machine # [    0.009855] CPU features: detected: Data cache clean to the PoU not required for I/D coherence187vm-test-run-nix-grpc-store-main> machine # [    0.009859] CPU features: detected: Common not Private translations188vm-test-run-nix-grpc-store-main> machine # [    0.009862] CPU features: detected: CRC32 instructions189vm-test-run-nix-grpc-store-main> machine # [    0.009864] CPU features: detected: Data cache clean to Point of Deep Persistence190vm-test-run-nix-grpc-store-main> machine # [    0.009867] CPU features: detected: Data cache clean to Point of Persistence191vm-test-run-nix-grpc-store-main> machine # [    0.009870] CPU features: detected: Data independent timing control (DIT)192vm-test-run-nix-grpc-store-main> machine # [    0.009873] CPU features: detected: E0PD193vm-test-run-nix-grpc-store-main> machine # [    0.009875] CPU features: detected: Enhanced Counter Virtualization194vm-test-run-nix-grpc-store-main> machine # [    0.009878] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)195vm-test-run-nix-grpc-store-main> machine # [    0.009881] CPU features: detected: Enhanced Virtualization Traps196vm-test-run-nix-grpc-store-main> machine # [    0.009884] CPU features: detected: Fine Grained Traps197vm-test-run-nix-grpc-store-main> machine # [    0.009887] CPU features: detected: Generic authentication (architected QARMA5 algorithm)198vm-test-run-nix-grpc-store-main> machine # [    0.009891] CPU features: detected: RCpc load-acquire (LDAPR)199vm-test-run-nix-grpc-store-main> machine # [    0.009893] CPU features: detected: LSE atomic instructions200vm-test-run-nix-grpc-store-main> machine # [    0.009900] CPU features: detected: Privileged Access Never201vm-test-run-nix-grpc-store-main> machine # [    0.009903] CPU features: detected: PMUv3202vm-test-run-nix-grpc-store-main> machine # [    0.009906] CPU features: detected: RAS Extension Support203vm-test-run-nix-grpc-store-main> machine # [    0.009908] CPU features: detected: RASv1p1 Extension Support204vm-test-run-nix-grpc-store-main> machine # [    0.009911] CPU features: detected: Random Number Generator205vm-test-run-nix-grpc-store-main> machine # [    0.009913] CPU features: detected: Speculation barrier (SB)206vm-test-run-nix-grpc-store-main> machine # [    0.009916] CPU features: detected: Stage-2 Force Write-Back207vm-test-run-nix-grpc-store-main> machine # [    0.009919] CPU features: detected: TLB range maintenance instructions208vm-test-run-nix-grpc-store-main> machine # [    0.009922] CPU features: detected: Speculative Store Bypassing Safe (SSBS)209vm-test-run-nix-grpc-store-main> machine # [    0.009998] alternatives: applying system-wide alternatives210vm-test-run-nix-grpc-store-main> machine # [    0.013454] CPU features: detected: BBM Level 2 without TLB conflict abort211vm-test-run-nix-grpc-store-main> machine # [    0.014318] Memory: 1913384K/2097152K available (24640K kernel code, 10246K rwdata, 26664K rodata, 7808K init, 2086K bss, 139076K reserved, 32768K cma-reserved)212vm-test-run-nix-grpc-store-main> machine # [    0.016367] devtmpfs: initialized213vm-test-run-nix-grpc-store-main> machine # [    0.019797] posixtimers hash table entries: 1024 (order: 2, 16384 bytes, linear)214vm-test-run-nix-grpc-store-main> machine # [    0.019845] futex hash table entries: 512 (32768 bytes on 1 NUMA nodes, total 32 KiB, linear).215vm-test-run-nix-grpc-store-main> machine # [    0.020105] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL216vm-test-run-nix-grpc-store-main> machine # [    0.020117] 0 pages in range for non-PLT usage217vm-test-run-nix-grpc-store-main> machine # [    0.020118] 506368 pages in range for PLT usage218vm-test-run-nix-grpc-store-main> machine # [    0.020274] pinctrl core: initialized pinctrl subsystem219vm-test-run-nix-grpc-store-main> machine # [    0.021298] DMI not present or invalid.220vm-test-run-nix-grpc-store-main> machine # [    0.025969] NET: Registered PF_NETLINK/PF_ROUTE protocol family221vm-test-run-nix-grpc-store-main> machine # [    0.029480] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations222vm-test-run-nix-grpc-store-main> machine # [    0.030920] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations223vm-test-run-nix-grpc-store-main> machine # [    0.034447] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations224vm-test-run-nix-grpc-store-main> machine # [    0.034497] audit: initializing netlink subsys (disabled)225vm-test-run-nix-grpc-store-main> machine # [    0.036517] audit: type=2000 audit(0.032:1): state=initialized audit_enabled=0 res=1226vm-test-run-nix-grpc-store-main> machine # [    0.037907] thermal_sys: Registered thermal governor 'fair_share'227vm-test-run-nix-grpc-store-main> machine # [    0.037916] thermal_sys: Registered thermal governor 'bang_bang'228vm-test-run-nix-grpc-store-main> machine # [    0.037926] thermal_sys: Registered thermal governor 'step_wise'229vm-test-run-nix-grpc-store-main> machine # [    0.037931] thermal_sys: Registered thermal governor 'user_space'230vm-test-run-nix-grpc-store-main> machine # [    0.037935] thermal_sys: Registered thermal governor 'power_allocator'231vm-test-run-nix-grpc-store-main> machine # [    0.038017] cpuidle: using governor ladder232vm-test-run-nix-grpc-store-main> machine # [    0.038057] cpuidle: using governor menu233vm-test-run-nix-grpc-store-main> machine # [    0.038535] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.234vm-test-run-nix-grpc-store-main> machine # [    0.038614] ASID allocator initialised with 65536 entries235vm-test-run-nix-grpc-store-main> machine # [    0.040780] Serial: AMBA PL011 UART driver236vm-test-run-nix-grpc-store-main> machine # [    0.052135] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1237vm-test-run-nix-grpc-store-main> machine # [    0.052289] printk: console [ttyAMA0] enabled238vm-test-run-nix-grpc-store-main> machine # [    0.204481] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages239vm-test-run-nix-grpc-store-main> machine # [    0.204499] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page240vm-test-run-nix-grpc-store-main> machine # [    0.204504] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages241vm-test-run-nix-grpc-store-main> machine # [    0.204508] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page242vm-test-run-nix-grpc-store-main> machine # [    0.204512] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages243vm-test-run-nix-grpc-store-main> machine # [    0.204516] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page244vm-test-run-nix-grpc-store-main> machine # [    0.204520] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages245vm-test-run-nix-grpc-store-main> machine # [    0.204525] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page246vm-test-run-nix-grpc-store-main> machine # [    0.223581] fbcon: Taking over console247vm-test-run-nix-grpc-store-main> machine # [    0.223610] ACPI: Interpreter disabled.248vm-test-run-nix-grpc-store-main> machine # [    0.224905] iommu: Default domain type: Translated249vm-test-run-nix-grpc-store-main> machine # [    0.224913] iommu: DMA domain TLB invalidation policy: strict mode250vm-test-run-nix-grpc-store-main> machine # [    0.228061] SCSI subsystem initialized251vm-test-run-nix-grpc-store-main> machine # [    0.228702] usbcore: registered new interface driver usbfs252vm-test-run-nix-grpc-store-main> machine # [    0.228772] usbcore: registered new interface driver hub253vm-test-run-nix-grpc-store-main> machine # [    0.228802] usbcore: registered new device driver usb254vm-test-run-nix-grpc-store-main> machine # [    0.229434] pps_core: LinuxPPS API ver. 1 registered255vm-test-run-nix-grpc-store-main> machine # [    0.229442] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>256vm-test-run-nix-grpc-store-main> machine # [    0.229457] PTP clock support registered257vm-test-run-nix-grpc-store-main> machine # [    0.229544] EDAC MC: Ver: 3.0.0258vm-test-run-nix-grpc-store-main> machine # [    0.236229] scmi_core: SCMI protocol bus registered259vm-test-run-nix-grpc-store-main> machine # [    0.239640] FPGA manager framework260vm-test-run-nix-grpc-store-main> machine # [    0.240964] vgaarb: loaded261vm-test-run-nix-grpc-store-main> machine # [    0.242643] clocksource: Switched to clocksource arch_sys_counter262vm-test-run-nix-grpc-store-main> machine # [    0.246147] VFS: Disk quotas dquot_6.6.0263vm-test-run-nix-grpc-store-main> machine # [    0.246191] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)264vm-test-run-nix-grpc-store-main> machine # [    0.246847] netfs: FS-Cache loaded265vm-test-run-nix-grpc-store-main> machine # [    0.247004] pnp: PnP ACPI: disabled266vm-test-run-nix-grpc-store-main> machine # [    0.253062] NET: Registered PF_INET protocol family267vm-test-run-nix-grpc-store-main> machine # [    0.253484] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear)268vm-test-run-nix-grpc-store-main> machine # [    0.289887] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear)269vm-test-run-nix-grpc-store-main> machine # [    0.289945] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)270vm-test-run-nix-grpc-store-main> machine # [    0.289986] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear)271vm-test-run-nix-grpc-store-main> machine # [    0.290097] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear)272vm-test-run-nix-grpc-store-main> machine # [    0.290242] TCP: Hash tables configured (established 16384 bind 16384)273vm-test-run-nix-grpc-store-main> machine # [    0.290372] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear)274vm-test-run-nix-grpc-store-main> machine # [    0.290440] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear)275vm-test-run-nix-grpc-store-main> machine # [    0.290479] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear)276vm-test-run-nix-grpc-store-main> machine # [    0.290914] NET: Registered PF_UNIX/PF_LOCAL protocol family277vm-test-run-nix-grpc-store-main> machine # [    0.290986] NET: Registered PF_XDP protocol family278vm-test-run-nix-grpc-store-main> machine # [    0.291013] PCI: CLS 0 bytes, default 64279vm-test-run-nix-grpc-store-main> machine # [    0.294889] Trying to unpack rootfs image as initramfs...280vm-test-run-nix-grpc-store-main> machine # [    0.303486] kvm [1]: HYP mode not available281vm-test-run-nix-grpc-store-main> machine # [    0.407219] Initialise system trusted keyrings282vm-test-run-nix-grpc-store-main> machine # [    0.407303] Key type blacklist registered283vm-test-run-nix-grpc-store-main> machine # [    0.411869] workingset: timestamp_bits=42 max_order=19 bucket_order=0284vm-test-run-nix-grpc-store-main> machine # [    0.412336] squashfs: version 4.0 (2009/01/31) Phillip Lougher285vm-test-run-nix-grpc-store-main> machine # [    0.412424] 9p: Installing v9fs 9p2000 file system support286vm-test-run-nix-grpc-store-main> machine # [    0.412612] integrity: Platform Keyring initialized287vm-test-run-nix-grpc-store-main> machine # [    0.412624] integrity: Machine keyring initialized288vm-test-run-nix-grpc-store-main> machine # [    0.429041] Key type asymmetric registered289vm-test-run-nix-grpc-store-main> machine # [    0.429052] Asymmetric key parser 'x509' registered290vm-test-run-nix-grpc-store-main> machine # [    0.429698] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)291vm-test-run-nix-grpc-store-main> machine # [    0.432702] io scheduler mq-deadline registered292vm-test-run-nix-grpc-store-main> machine # [    0.432714] io scheduler kyber registered293vm-test-run-nix-grpc-store-main> machine # [    0.446806] pl061_gpio 9030000.pl061: PL061 GPIO chip registered294vm-test-run-nix-grpc-store-main> machine # [    0.454680] ledtrig-cpu: registered to indicate activity on CPUs295vm-test-run-nix-grpc-store-main> machine # [    0.455459] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:296vm-test-run-nix-grpc-store-main> machine # [    0.455478] pci-host-generic 4010000000.pcie:       IO 0x003eff0000..0x003effffff -> 0x0000000000297vm-test-run-nix-grpc-store-main> machine # [    0.455501] pci-host-generic 4010000000.pcie:      MEM 0x0010000000..0x003efeffff -> 0x0010000000298vm-test-run-nix-grpc-store-main> machine # [    0.455508] pci-host-generic 4010000000.pcie:      MEM 0x8000000000..0xffffffffff -> 0x8000000000299vm-test-run-nix-grpc-store-main> machine # [    0.455536] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits300vm-test-run-nix-grpc-store-main> machine # [    0.455567] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]301vm-test-run-nix-grpc-store-main> machine # [    0.455683] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00302vm-test-run-nix-grpc-store-main> machine # [    0.455692] pci_bus 0000:00: root bus resource [bus 00-ff]303vm-test-run-nix-grpc-store-main> machine # [    0.455698] pci_bus 0000:00: root bus resource [io  0x0000-0xffff]304vm-test-run-nix-grpc-store-main> machine # [    0.455701] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]305vm-test-run-nix-grpc-store-main> machine # [    0.455704] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]306vm-test-run-nix-grpc-store-main> machine # [    0.455783] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint307vm-test-run-nix-grpc-store-main> machine # [    0.456301] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint308vm-test-run-nix-grpc-store-main> machine # [    0.456511] pci 0000:00:01.0: BAR 0 [io  0x0000-0x001f]309vm-test-run-nix-grpc-store-main> machine # [    0.456524] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]310vm-test-run-nix-grpc-store-main> machine # [    0.456552] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]311vm-test-run-nix-grpc-store-main> machine # [    0.456565] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]312vm-test-run-nix-grpc-store-main> machine # [    0.457112] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint313vm-test-run-nix-grpc-store-main> machine # [    0.457318] pci 0000:00:02.0: BAR 0 [io  0x0000-0x001f]314vm-test-run-nix-grpc-store-main> machine # [    0.457330] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]315vm-test-run-nix-grpc-store-main> machine # [    0.457357] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]316vm-test-run-nix-grpc-store-main> machine # [    0.458519] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint317vm-test-run-nix-grpc-store-main> machine # [    0.466919] pci 0000:00:03.0: BAR 0 [io  0x0000-0x007f]318vm-test-run-nix-grpc-store-main> machine # [    0.466932] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]319vm-test-run-nix-grpc-store-main> machine # [    0.466959] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]320vm-test-run-nix-grpc-store-main> machine # [    0.468069] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint321vm-test-run-nix-grpc-store-main> machine # [    0.468268] pci 0000:00:04.0: BAR 0 [io  0x0000-0x001f]322vm-test-run-nix-grpc-store-main> machine # [    0.468279] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]323vm-test-run-nix-grpc-store-main> machine # [    0.468306] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]324vm-test-run-nix-grpc-store-main> machine # [    0.468318] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]325vm-test-run-nix-grpc-store-main> machine # [    0.468840] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint326vm-test-run-nix-grpc-store-main> machine # [    0.469041] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]327vm-test-run-nix-grpc-store-main> machine # [    0.469068] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]328vm-test-run-nix-grpc-store-main> machine # [    0.469566] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint329vm-test-run-nix-grpc-store-main> machine # [    0.469771] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]330vm-test-run-nix-grpc-store-main> machine # [    0.469795] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]331vm-test-run-nix-grpc-store-main> machine # [    0.470197] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint332vm-test-run-nix-grpc-store-main> machine # [    0.470382] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]333vm-test-run-nix-grpc-store-main> machine # [    0.470706] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint334vm-test-run-nix-grpc-store-main> machine # [    0.470893] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]335vm-test-run-nix-grpc-store-main> machine # [    0.470918] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]336vm-test-run-nix-grpc-store-main> machine # [    0.471392] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint337vm-test-run-nix-grpc-store-main> machine # [    0.471582] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]338vm-test-run-nix-grpc-store-main> machine # [    0.471608] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]339vm-test-run-nix-grpc-store-main> machine # [    0.472957] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint340vm-test-run-nix-grpc-store-main> machine # [    0.473156] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]341vm-test-run-nix-grpc-store-main> machine # [    0.473183] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]342vm-test-run-nix-grpc-store-main> machine # [    0.473765] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint343vm-test-run-nix-grpc-store-main> machine # [    0.474090] pci 0000:00:0b.0: BAR 0 [io  0x0000-0x003f]344vm-test-run-nix-grpc-store-main> machine # [    0.474103] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]345vm-test-run-nix-grpc-store-main> machine # [    0.474130] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]346vm-test-run-nix-grpc-store-main> machine # [    0.512673] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint347vm-test-run-nix-grpc-store-main> machine # [    0.512874] pci 0000:00:0c.0: BAR 0 [io  0x0000-0x001f]348vm-test-run-nix-grpc-store-main> machine # [    0.512887] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]349vm-test-run-nix-grpc-store-main> machine # [    0.512913] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]350vm-test-run-nix-grpc-store-main> machine # [    0.513737] pci 0000:00:0d.0: [1af4:1053] type 00 class 0x078000 conventional PCI endpoint351vm-test-run-nix-grpc-store-main> machine # [    0.513936] pci 0000:00:0d.0: BAR 1 [mem 0x00000000-0x00000fff]352vm-test-run-nix-grpc-store-main> machine # [    0.513966] pci 0000:00:0d.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]353vm-test-run-nix-grpc-store-main> machine # [    0.514618] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned354vm-test-run-nix-grpc-store-main> machine # [    0.514626] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned355vm-test-run-nix-grpc-store-main> machine # [    0.514629] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned356vm-test-run-nix-grpc-store-main> machine # [    0.522911] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned357vm-test-run-nix-grpc-store-main> machine # [    0.522959] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned358vm-test-run-nix-grpc-store-main> machine # [    0.523005] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned359vm-test-run-nix-grpc-store-main> machine # [    0.523051] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned360vm-test-run-nix-grpc-store-main> machine # [    0.523098] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned361vm-test-run-nix-grpc-store-main> machine # [    0.523143] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned362vm-test-run-nix-grpc-store-main> machine # [    0.523189] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned363vm-test-run-nix-grpc-store-main> machine # [    0.523234] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned364vm-test-run-nix-grpc-store-main> machine # [    0.523280] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned365vm-test-run-nix-grpc-store-main> machine # [    0.523353] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned366vm-test-run-nix-grpc-store-main> machine # [    0.523431] pci 0000:00:0d.0: BAR 4 [mem 0x800002c000-0x800002ffff 64bit pref]: assigned367vm-test-run-nix-grpc-store-main> machine # [    0.523475] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned368vm-test-run-nix-grpc-store-main> machine # [    0.523493] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned369vm-test-run-nix-grpc-store-main> machine # [    0.523511] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned370vm-test-run-nix-grpc-store-main> machine # [    0.523529] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned371vm-test-run-nix-grpc-store-main> machine # [    0.523546] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned372vm-test-run-nix-grpc-store-main> machine # [    0.523565] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned373vm-test-run-nix-grpc-store-main> machine # [    0.523584] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned374vm-test-run-nix-grpc-store-main> machine # [    0.523606] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned375vm-test-run-nix-grpc-store-main> machine # [    0.523625] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned376vm-test-run-nix-grpc-store-main> machine # [    0.523644] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned377vm-test-run-nix-grpc-store-main> machine # [    0.523662] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned378vm-test-run-nix-grpc-store-main> machine # [    0.523682] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned379vm-test-run-nix-grpc-store-main> machine # [    0.523700] pci 0000:00:0d.0: BAR 1 [mem 0x1008c000-0x1008cfff]: assigned380vm-test-run-nix-grpc-store-main> machine # [    0.523718] pci 0000:00:03.0: BAR 0 [io  0x1000-0x107f]: assigned381vm-test-run-nix-grpc-store-main> machine # [    0.523735] pci 0000:00:0b.0: BAR 0 [io  0x1080-0x10bf]: assigned382vm-test-run-nix-grpc-store-main> machine # [    0.523753] pci 0000:00:01.0: BAR 0 [io  0x10c0-0x10df]: assigned383vm-test-run-nix-grpc-store-main> machine # [    0.523771] pci 0000:00:02.0: BAR 0 [io  0x10e0-0x10ff]: assigned384vm-test-run-nix-grpc-store-main> machine # [    0.523788] pci 0000:00:04.0: BAR 0 [io  0x1100-0x111f]: assigned385vm-test-run-nix-grpc-store-main> machine # [    0.523810] pci 0000:00:0c.0: BAR 0 [io  0x1120-0x113f]: assigned386vm-test-run-nix-grpc-store-main> machine # [    0.523834] pci_bus 0000:00: resource 4 [io  0x0000-0xffff]387vm-test-run-nix-grpc-store-main> machine # [    0.523840] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]388vm-test-run-nix-grpc-store-main> machine # [    0.523847] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]389vm-test-run-nix-grpc-store-main> machine # [    0.525461] pci 0000:00:07.0: enabling device (0000 -> 0002)390vm-test-run-nix-grpc-store-main> machine # [    0.575835] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)391vm-test-run-nix-grpc-store-main> machine # [    3.037450] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)392vm-test-run-nix-grpc-store-main> machine # [    3.042013] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)393vm-test-run-nix-grpc-store-main> machine # [    3.049697] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)394vm-test-run-nix-grpc-store-main> machine # [    3.053717] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)395vm-test-run-nix-grpc-store-main> machine # [    3.061496] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)396vm-test-run-nix-grpc-store-main> machine # [    3.072460] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)397vm-test-run-nix-grpc-store-main> machine # [    5.437226] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)398vm-test-run-nix-grpc-store-main> machine # [    5.441471] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)399vm-test-run-nix-grpc-store-main> machine # [    5.445986] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)400vm-test-run-nix-grpc-store-main> machine # [    5.452401] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)401vm-test-run-nix-grpc-store-main> machine # [    5.457631] virtio-pci 0000:00:0d.0: enabling device (0000 -> 0002)402vm-test-run-nix-grpc-store-main> machine # [    5.465818] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled403vm-test-run-nix-grpc-store-main> machine # [    5.469664] msm_serial: driver initialized404vm-test-run-nix-grpc-store-main> machine # [    5.469892] SuperH (H)SCI(F) driver initialized405vm-test-run-nix-grpc-store-main> machine # [    5.469974] STM32 USART driver initialized406vm-test-run-nix-grpc-store-main> machine # [    5.495016] loop: module loaded407vm-test-run-nix-grpc-store-main> machine # [    5.495330] virtio_blk virtio2: 2/0/0 default/read/poll queues408vm-test-run-nix-grpc-store-main> machine # [    5.496642] virtio_blk virtio2: [vda] 50331648 512-byte logical blocks (25.8 GB/24.0 GiB)409vm-test-run-nix-grpc-store-main> machine # [    5.505222] megasas: 07.734.00.00-rc1410vm-test-run-nix-grpc-store-main> machine # [    5.506284] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]411vm-test-run-nix-grpc-store-main> machine # [    5.511561] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000412vm-test-run-nix-grpc-store-main> machine # [    5.511592] Intel/Sharp Extended Query Table at 0x0031413vm-test-run-nix-grpc-store-main> machine # [    5.743154] Freeing initrd memory: 25268K414vm-test-run-nix-grpc-store-main> machine # [   11.876911] Using buffer write method415vm-test-run-nix-grpc-store-main> machine # [   11.877097] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]416vm-test-run-nix-grpc-store-main> machine # [   11.887451] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000417vm-test-run-nix-grpc-store-main> machine # [   11.887529] Intel/Sharp Extended Query Table at 0x0031418vm-test-run-nix-grpc-store-main> machine # [   11.891118] Using buffer write method419vm-test-run-nix-grpc-store-main> machine # [   11.891157] Concatenating MTD devices:420vm-test-run-nix-grpc-store-main> machine # [   11.891161] (0): "0.flash"421vm-test-run-nix-grpc-store-main> machine # [   11.891177] (1): "0.flash"422vm-test-run-nix-grpc-store-main> machine # [   11.891182] into device "0.flash"423vm-test-run-nix-grpc-store-main> machine # [   11.903838] tun: Universal TUN/TAP device driver, 1.6424vm-test-run-nix-grpc-store-main> machine # [   11.913987] thunder_xcv, ver 1.0425vm-test-run-nix-grpc-store-main> machine # [   11.914042] thunder_bgx, ver 1.0426vm-test-run-nix-grpc-store-main> machine # [   11.914074] nicpf, ver 1.0427vm-test-run-nix-grpc-store-main> machine # [   11.915239] e1000: Intel(R) PRO/1000 Network Driver428vm-test-run-nix-grpc-store-main> machine # [   11.915253] e1000: Copyright (c) 1999-2006 Intel Corporation.429vm-test-run-nix-grpc-store-main> machine # [   11.915301] e1000e: Intel(R) PRO/1000 Network Driver430vm-test-run-nix-grpc-store-main> machine # [   11.915314] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.431vm-test-run-nix-grpc-store-main> machine # [   11.915373] igb: Intel(R) Gigabit Ethernet Network Driver432vm-test-run-nix-grpc-store-main> machine # [   11.915382] igb: Copyright (c) 2007-2014 Intel Corporation.433vm-test-run-nix-grpc-store-main> machine # [   11.915424] igbvf: Intel(R) Gigabit Virtual Function Network Driver434vm-test-run-nix-grpc-store-main> machine # [   11.915434] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.435vm-test-run-nix-grpc-store-main> machine # [   11.915663] sky2: driver version 1.30436vm-test-run-nix-grpc-store-main> machine # [   11.919885] ehci-pci 0000:00:07.0: EHCI Host Controller437vm-test-run-nix-grpc-store-main> machine # [   11.919937] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1438vm-test-run-nix-grpc-store-main> machine # [   11.920285] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000439vm-test-run-nix-grpc-store-main> machine # [   11.920779] usbcore: registered new interface driver usb-storage440vm-test-run-nix-grpc-store-main> machine # [   11.921092] usbcore: registered new interface driver usbserial_generic441vm-test-run-nix-grpc-store-main> machine # [   11.921116] usbserial: USB Serial support registered for generic442vm-test-run-nix-grpc-store-main> machine # [   11.922210] hv_vmbus: registering driver hyperv_keyboard443vm-test-run-nix-grpc-store-main> machine # [   11.923939] rtc-pl031 9010000.pl031: registered as rtc0444vm-test-run-nix-grpc-store-main> machine # [   11.923988] rtc-pl031 9010000.pl031: setting system clock to 2026-11-12T08:47:31 UTC (1794473251)445vm-test-run-nix-grpc-store-main> machine # [   11.924529] i2c_dev: i2c /dev entries driver446vm-test-run-nix-grpc-store-main> machine # [   11.931140] sdhci: Secure Digital Host Controller Interface driver447vm-test-run-nix-grpc-store-main> machine # [   11.931154] sdhci: Copyright(c) Pierre Ossman448vm-test-run-nix-grpc-store-main> machine # [   11.931655] Synopsys Designware Multimedia Card Interface Driver449vm-test-run-nix-grpc-store-main> machine # [   11.932314] sdhci-pltfm: SDHCI platform and OF driver helper450vm-test-run-nix-grpc-store-main> machine # [   11.934733] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00451vm-test-run-nix-grpc-store-main> machine # [   11.935373] hub 1-0:1.0: USB hub found452vm-test-run-nix-grpc-store-main> machine # [   11.935411] hub 1-0:1.0: 6 ports detected453vm-test-run-nix-grpc-store-main> machine # [   11.938057] hid: raw HID events driver (C) Jiri Kosina454vm-test-run-nix-grpc-store-main> machine # [   11.938545] usbcore: registered new interface driver usbhid455vm-test-run-nix-grpc-store-main> machine # [   11.938552] usbhid: USB HID core driver456vm-test-run-nix-grpc-store-main> machine # [   11.942201] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available457vm-test-run-nix-grpc-store-main> machine # [   11.945217] drop_monitor: Initializing network drop monitor service458vm-test-run-nix-grpc-store-main> machine # [   11.945464] NET: Registered PF_INET6 protocol family459vm-test-run-nix-grpc-store-main> machine # [   11.949437] Segment Routing with IPv6460vm-test-run-nix-grpc-store-main> machine # [   11.949460] In-situ OAM (IOAM) with IPv6461vm-test-run-nix-grpc-store-main> machine # [   11.949545] NET: Registered PF_PACKET protocol family462vm-test-run-nix-grpc-store-main> machine # [   11.949733] 9pnet: Installing 9P2000 support463vm-test-run-nix-grpc-store-main> machine # [   11.949840] Key type dns_resolver registered464vm-test-run-nix-grpc-store-main> machine # [   11.958924] registered taskstats version 1465vm-test-run-nix-grpc-store-main> machine # [   11.959274] Loading compiled-in X.509 certificates466vm-test-run-nix-grpc-store-main> machine # [   11.972675] Demotion targets for Node 0: null467vm-test-run-nix-grpc-store-main> machine # [   11.972950] Key type .fscrypt registered468vm-test-run-nix-grpc-store-main> machine # [   11.972956] Key type fscrypt-provisioning registered469vm-test-run-nix-grpc-store-main> machine # [   11.973131] ima: No TPM chip found, activating TPM-bypass!470vm-test-run-nix-grpc-store-main> machine # [   11.973175] ima: Allocated hash algorithm: sha1471vm-test-run-nix-grpc-store-main> machine # [   11.973231] ima: No architecture policies found472vm-test-run-nix-grpc-store-main> machine # [   11.974239] input: gpio-keys as /devices/platform/gpio-keys/input/input0473vm-test-run-nix-grpc-store-main> machine # [   12.000827] clk: Disabling unused clocks474vm-test-run-nix-grpc-store-main> machine # [   12.000853] PM: genpd: Disabling unused power domains475vm-test-run-nix-grpc-store-main> machine # [   12.007847] Freeing unused kernel memory: 7808K476vm-test-run-nix-grpc-store-main> machine # [   12.008221] Run /init as init process477vm-test-run-nix-grpc-store-main> machine # [   12.040502] systemd[1]: Successfully made /usr/ read-only.478vm-test-run-nix-grpc-store-main> machine # [   12.182744] usb 1-1: new high-speed USB device number 2 using ehci-pci479vm-test-run-nix-grpc-store-main> machine # [   12.334812] 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/input1480vm-test-run-nix-grpc-store-main> machine # [   12.374927] systemd[1]: systemd 262 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -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)481vm-test-run-nix-grpc-store-main> machine # [   12.374961] systemd[1]: Detected virtualization qemu.482vm-test-run-nix-grpc-store-main> machine # [   12.375050] systemd[1]: Detected architecture arm64.483vm-test-run-nix-grpc-store-main> machine # [   12.375061] systemd[1]: Running in initrd.484vm-test-run-nix-grpc-store-main> machine # [   12.375729] systemd[1]: Initializing machine ID from random generator.485vm-test-run-nix-grpc-store-main> machine # [   12.375928] systemd[1]: Hostname set to <machine>.486vm-test-run-nix-grpc-store-main> machine # [   12.454727] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:07.0-1/input0487vm-test-run-nix-grpc-store-main> machine # [   12.523040] systemd[1]: bpf-restrict-fs: LSM BPF program attached488vm-test-run-nix-grpc-store-main> machine # [   12.574690] usb 1-2: new high-speed USB device number 3 using ehci-pci489vm-test-run-nix-grpc-store-main> machine # [   12.581025] systemd[1]: Queued start job for default target Initrd Default Target.490vm-test-run-nix-grpc-store-main> machine # [   12.599230] systemd[1]: Created slice Slice /system/modprobe.491vm-test-run-nix-grpc-store-main> machine # [   12.599499] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.492vm-test-run-nix-grpc-store-main> machine # [   12.599535] systemd[1]: Expecting device /dev/disk/by-label/nixos...493vm-test-run-nix-grpc-store-main> machine # [   12.599565] systemd[1]: Reached target Path Units.494vm-test-run-nix-grpc-store-main> machine # [   12.599581] systemd[1]: Reached target Slice Units.495vm-test-run-nix-grpc-store-main> machine # [   12.599596] systemd[1]: Reached target Swaps.496vm-test-run-nix-grpc-store-main> machine # [   12.599610] systemd[1]: Reached target Timer Units.497vm-test-run-nix-grpc-store-main> machine # [   12.599785] systemd[1]: Listening on D-Bus System Message Bus Socket.498vm-test-run-nix-grpc-store-main> machine # [   12.599932] systemd[1]: Listening on Journal Socket (/dev/log).499vm-test-run-nix-grpc-store-main> machine # [   12.600060] systemd[1]: Listening on Journal Sockets.500vm-test-run-nix-grpc-store-main> machine # [   12.600146] systemd[1]: Listening on udev Kernel Socket.501vm-test-run-nix-grpc-store-main> machine # [   12.600326] systemd[1]: Listening on udev Varlink Socket.502vm-test-run-nix-grpc-store-main> machine # [   12.600341] systemd[1]: Reached target Socket Units.503vm-test-run-nix-grpc-store-main> machine # [   12.602495] systemd[1]: Starting Create List of Static Device Nodes...504vm-test-run-nix-grpc-store-main> machine # [   12.602600] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs505vm-test-run-nix-grpc-store-main> machine # [   12.604434] systemd[1]: Mounting Kernel Configuration File System...506vm-test-run-nix-grpc-store-main> machine # [   12.624352] systemd[1]: Starting Journal Service...507vm-test-run-nix-grpc-store-main> machine # [   12.630953] systemd[1]: Starting Load Kernel Modules...508vm-test-run-nix-grpc-store-main> machine # [   12.631184] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os509vm-test-run-nix-grpc-store-main> machine # [   12.647879] systemd[1]: Starting Coldplug All udev Devices...510vm-test-run-nix-grpc-store-main> machine # [   12.649367] systemd[1]: Mounted Kernel Configuration File System.511vm-test-run-nix-grpc-store-main> machine # [   12.665610] systemd[1]: Finished Create List of Static Device Nodes.512vm-test-run-nix-grpc-store-main> machine # [   12.671265] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...513vm-test-run-nix-grpc-store-main> machine # [   12.677470] virtio_dma_buf: module verification failed: signature and/or required key missing - tainting kernel514vm-test-run-nix-grpc-store-main> machine # [   12.699505] systemd-journald[77]: Collecting audit messages is disabled.515vm-test-run-nix-grpc-store-main> machine # [   12.706215] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0516vm-test-run-nix-grpc-store-main> machine # [   12.706512] [drm] features: -virgl +edid -resource_blob -host_visible517vm-test-run-nix-grpc-store-main> machine # [   12.706520] [drm] features: -context_init518vm-test-run-nix-grpc-store-main> machine # [   12.716021] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.519vm-test-run-nix-grpc-store-main> machine # [   12.721547] [drm] number of scanouts: 1520vm-test-run-nix-grpc-store-main> machine # [   12.721568] [drm] number of cap sets: 0521vm-test-run-nix-grpc-store-main> machine # [   12.722008] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.522vm-test-run-nix-grpc-store-main> machine # [   12.724813] systemd[1]: Starting Create Static Device Nodes in /dev...523vm-test-run-nix-grpc-store-main> machine # [   12.726935] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev524vm-test-run-nix-grpc-store-main> machine # [   12.734705] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic525vm-test-run-nix-grpc-store-main> machine # [   12.734720] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0526vm-test-run-nix-grpc-store-main> machine # [   12.742432] NET: Registered PF_VSOCK protocol family527vm-test-run-nix-grpc-store-main> machine # [   12.750462] Console: switching to colour frame buffer device 160x50528vm-test-run-nix-grpc-store-main> machine # [   12.759803] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device529vm-test-run-nix-grpc-store-main> machine # [   12.782132] 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/input2530vm-test-run-nix-grpc-store-main> machine # [   12.782566] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input0531vm-test-run-nix-grpc-store-main> machine # [   12.784365] systemd[1]: Finished Load Kernel Modules.532vm-test-run-nix-grpc-store-main> machine # [   12.789276] systemd[1]: Starting Apply Kernel Variables...533vm-test-run-nix-grpc-store-main> machine # [   12.815799] systemd[1]: Finished Create Static Device Nodes in /dev.534vm-test-run-nix-grpc-store-main> machine # [   12.816124] systemd[1]: Reached target Preparation for Local File Systems.535vm-test-run-nix-grpc-store-main> machine # [   12.816161] systemd[1]: Reached target Local File Systems.536vm-test-run-nix-grpc-store-main> machine # [   12.826365] systemd-modules-load[78]: Using 2 probe threads537vm-test-run-nix-grpc-store-main> machine # [   12.828215] systemd-modules-load[78]: Module 'virtio_balloon' is built in538vm-test-run-nix-grpc-store-main> machine # [   12.829840] systemd-modules-load[78]: Module 'virtio_console' is built in539vm-test-run-nix-grpc-store-main> machine # [   12.831160] systemd-modules-load[78]: Inserted module 'dm_mod'540vm-test-run-nix-grpc-store-main> machine # [   12.846883] systemd[1]: Starting Rule-based Manager for Device Events and Files...541vm-test-run-nix-grpc-store-main> machine # [   12.847682] systemd[1]: Started Journal Service.542vm-test-run-nix-grpc-store-main> machine # [   12.845199] systemd-modules-load[78]: Module 'virtio_rng' is built in543vm-test-run-nix-grpc-store-main> machine # [   12.853251] systemd-modules-load[78]: Inserted module 'virtio_gpu'544vm-test-run-nix-grpc-store-main> machine # [   12.856755] systemd-modules-load[78]: Inserted module 'vmw_vsock_virtio_transport'545vm-test-run-nix-grpc-store-main> machine # [   12.860569] systemd[1]: Finished Apply Kernel Variables.546vm-test-run-nix-grpc-store-main> machine # [   12.866133] systemd[1]: Starting Create System Files and Directories...547vm-test-run-nix-grpc-store-main> machine # [   12.881590] systemd-udevd[89]: Using default interface naming scheme 'v261'.548vm-test-run-nix-grpc-store-main> machine # [   12.904335] systemd[1]: Started Rule-based Manager for Device Events and Files.549vm-test-run-nix-grpc-store-main> machine # [   12.937831] systemd[1]: Finished Create System Files and Directories.550vm-test-run-nix-grpc-store-main> machine # [   12.955850] systemd[1]: Starting Virtual Console Setup...551vm-test-run-nix-grpc-store-main> machine # [   12.986798] systemd-vconsole-setup[115]: Configuration of first virtual console was skipped, ignoring remaining ones.552vm-test-run-nix-grpc-store-main> machine # [   12.991791] systemd[1]: Finished Virtual Console Setup.553vm-test-run-nix-grpc-store-main> machine # [   13.550741] systemd[1]: Finished Coldplug All udev Devices.554vm-test-run-nix-grpc-store-main> machine # [   13.553051] systemd[1]: Reached target System Initialization.555vm-test-run-nix-grpc-store-main> machine # [   13.554579] systemd[1]: Reached target Basic System.556vm-test-run-nix-grpc-store-main> machine # [   13.694585] (udev-worker)[105]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.557vm-test-run-nix-grpc-store-main> machine # [   13.699689] (udev-worker)[105]: Network interface NamePolicy= disabled on kernel command line.558vm-test-run-nix-grpc-store-main> machine # [   13.758381] (udev-worker)[106]: Network interface NamePolicy= disabled on kernel command line.559vm-test-run-nix-grpc-store-main> machine # [   13.762360] systemd[1]: Found device /dev/disk/by-label/nixos.560vm-test-run-nix-grpc-store-main> machine # [   13.767024] systemd[1]: Reached target Initrd Root Device.561vm-test-run-nix-grpc-store-main> machine # [   13.768787] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...562vm-test-run-nix-grpc-store-main> machine # [   13.822584] systemd-fsck[124]: nixos: clean, 12/1572864 files, 142772/6291456 blocks563vm-test-run-nix-grpc-store-main> machine # [   13.829553] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.564vm-test-run-nix-grpc-store-main> machine # [   13.835739] systemd[1]: Mounting /sysroot...565vm-test-run-nix-grpc-store-main> machine # [   13.878905] EXT4-fs (vda): mounted filesystem 6d823918-4c5a-402b-8f3f-9c4bbee6f9c7 r/w with ordered data mode. Quota mode: none.566vm-test-run-nix-grpc-store-main> machine # [   13.873757] systemd[1]: Mounted /sysroot.567vm-test-run-nix-grpc-store-main> machine # [   13.878824] systemd[1]: Reached target Initrd Root File System.568vm-test-run-nix-grpc-store-main> machine # [   13.889341] systemd[1]: Starting Mountpoints Configured in the Real Root...569vm-test-run-nix-grpc-store-main> machine # [   13.896218] systemd[1]: Starting rw-sysroot-nix-store.service...570vm-test-run-nix-grpc-store-main> machine # [   13.939675] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.571vm-test-run-nix-grpc-store-main> machine # [   13.943839] systemd[1]: Finished rw-sysroot-nix-store.service.572vm-test-run-nix-grpc-store-main> machine # [   13.947470] systemd-sysroot-fstab-check[133]: /sysroot should be mounted in the initrd, will request daemon-reload.573vm-test-run-nix-grpc-store-main> machine # [   13.954329] systemd[1]: Reload requested from client PID 133 ('systemd-sysroot') (unit initrd-parse-etc.service)...574vm-test-run-nix-grpc-store-main> machine # [   13.958221] systemd[1]: Reloading...575vm-test-run-nix-grpc-store-main> machine # [   14.104158] systemd[1]: Reloading finished in 153 ms.576vm-test-run-nix-grpc-store-main> machine # [   14.143895] systemd-sysroot-fstab-check[133]: Requesting initrd-fs.target/start/replace...577vm-test-run-nix-grpc-store-main> machine # [   14.147314] systemd-sysroot-fstab-check[133]: Requesting swap.target/start/replace...578vm-test-run-nix-grpc-store-main> machine # [   14.149437] systemd[1]: Starting rw-sysroot-nix-store.service...579vm-test-run-nix-grpc-store-main> machine # [   14.153234] systemd[1]: initrd-parse-etc.service: Deactivated successfully.580vm-test-run-nix-grpc-store-main> machine # [   14.167608] systemd[1]: Finished Mountpoints Configured in the Real Root.581vm-test-run-nix-grpc-store-main> machine # [   14.170263] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.582vm-test-run-nix-grpc-store-main> machine # [   14.179630] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.583vm-test-run-nix-grpc-store-main> machine # [   14.182545] systemd[1]: Finished rw-sysroot-nix-store.service.584vm-test-run-nix-grpc-store-main> machine # [   14.642629] systemd[1]: Mounting /sysroot/nix/.ro-store...585vm-test-run-nix-grpc-store-main> machine # [   14.652810] systemd[1]: Mounting /sysroot/run...586vm-test-run-nix-grpc-store-main> machine # [   14.684740] systemd[1]: Mounting /sysroot/tmp/shared...587vm-test-run-nix-grpc-store-main> machine # [   14.700111] systemd[1]: Mounting /sysroot/tmp/xchg...588vm-test-run-nix-grpc-store-main> machine # [   14.717783] fuse: init (API version 7.45)589vm-test-run-nix-grpc-store-main> machine # [   14.711590] systemd[1]: Mounted /sysroot/run.590vm-test-run-nix-grpc-store-main> machine # [   14.727233] virtiofs virtio6: discovered new tag: nix-store591vm-test-run-nix-grpc-store-main> machine # [   14.800007] virtiofs virtio6: virtio_fs_setup_dax: No cache capability592vm-test-run-nix-grpc-store-main> machine # [   14.824387] virtiofs virtio7: discovered new tag: shared593vm-test-run-nix-grpc-store-main> machine # [   14.825453] virtiofs virtio7: virtio_fs_setup_dax: No cache capability594vm-test-run-nix-grpc-store-main> machine # [   14.830084] virtiofs virtio8: discovered new tag: xchg595vm-test-run-nix-grpc-store-main> machine # [   14.835086] virtiofs virtio8: virtio_fs_setup_dax: No cache capability596vm-test-run-nix-grpc-store-main> machine # [   14.863157] systemd[1]: Mounted /sysroot/nix/.ro-store.597vm-test-run-nix-grpc-store-main> machine # [   14.868215] systemd[1]: Mounted /sysroot/tmp/shared.598vm-test-run-nix-grpc-store-main> machine # [   14.869260] systemd[1]: Mounted /sysroot/tmp/xchg.599vm-test-run-nix-grpc-store-main> machine # [   14.879259] systemd[1]: Mounting /sysroot/nix/store...600vm-test-run-nix-grpc-store-main> machine # [   14.925647] (udev-worker)[106]: mtd0ro: Failed to find and pin callout binary "/nix/store/rzzrvlm7r31iq3im3h66nhxc2zh996l9-systemd-262/lib/udev/mtd_probe": No such file or directory601vm-test-run-nix-grpc-store-main> machine # [   14.936234] (udev-worker)[106]: mtd0ro: /etc/udev/rules.d/75-probe_mtd.rules:5 IMPORT{program}="mtd_probe $devnode": Failed to execute "mtd_probe /dev/mtd0ro", ignoring: No such file or directory602vm-test-run-nix-grpc-store-main> machine # [   14.941583] systemd[1]: Mounted /sysroot/nix/store.603vm-test-run-nix-grpc-store-main> machine # [   14.949738] systemd[1]: Reached target Initrd File Systems.604vm-test-run-nix-grpc-store-main> machine # [   14.958325] systemd[1]: Starting Find NixOS closure...605vm-test-run-nix-grpc-store-main> machine # [   14.960306] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...606vm-test-run-nix-grpc-store-main> machine # [   14.969132] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.607vm-test-run-nix-grpc-store-main> machine # [   14.971318] systemd[1]: Stopped Virtual Console Setup.608vm-test-run-nix-grpc-store-main> machine # [   14.972388] systemd[1]: Stopping Virtual Console Setup...609vm-test-run-nix-grpc-store-main> machine # [   14.990706] systemd[1]: Starting Virtual Console Setup...610vm-test-run-nix-grpc-store-main> machine # [   15.007265] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.611vm-test-run-nix-grpc-store-main> machine # [   15.009048] systemd[1]: Finished Find NixOS closure.612vm-test-run-nix-grpc-store-main> machine # [   15.019843] systemd[1]: Reached target Initrd Default Target.613vm-test-run-nix-grpc-store-main> machine # [   15.024757] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...614vm-test-run-nix-grpc-store-main> machine # [   15.037642] systemd-vconsole-setup[175]: Configuration of first virtual console was skipped, ignoring remaining ones.615vm-test-run-nix-grpc-store-main> machine # [   15.040774] systemd[1]: Finished Virtual Console Setup.616vm-test-run-nix-grpc-store-main> machine # [   15.060141] systemd[1]: Stopped target Initrd Default Target.617vm-test-run-nix-grpc-store-main> machine # [   15.061375] systemd[1]: Stopped target Basic System.618vm-test-run-nix-grpc-store-main> machine # [   15.062206] systemd[1]: Stopped target Initrd Root Device.619vm-test-run-nix-grpc-store-main> machine # [   15.063131] systemd[1]: Stopped target Path Units.620vm-test-run-nix-grpc-store-main> machine # [   15.063922] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.621vm-test-run-nix-grpc-store-main> machine # [   15.065777] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.622vm-test-run-nix-grpc-store-main> machine # [   15.067271] systemd[1]: Stopped target Slice Units.623vm-test-run-nix-grpc-store-main> machine # [   15.068172] systemd[1]: Stopped target Socket Units.624vm-test-run-nix-grpc-store-main> machine # [   15.068924] systemd[1]: Stopped target System Initialization.625vm-test-run-nix-grpc-store-main> machine # [   15.069825] systemd[1]: Stopped target Swaps.626vm-test-run-nix-grpc-store-main> machine # [   15.070531] systemd[1]: Stopped target Timer Units.627vm-test-run-nix-grpc-store-main> machine # [   15.071435] systemd[1]: dbus.socket: Deactivated successfully.628vm-test-run-nix-grpc-store-main> machine # [   15.072399] systemd[1]: Closed D-Bus System Message Bus Socket.629vm-test-run-nix-grpc-store-main> machine # [   15.073350] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.630vm-test-run-nix-grpc-store-main> machine # [   15.074539] systemd[1]: Stopped Find NixOS closure.631vm-test-run-nix-grpc-store-main> machine # [   15.075384] systemd[1]: Starting rw-sysroot-nix-store.service...632vm-test-run-nix-grpc-store-main> machine # [   15.076478] systemd[1]: systemd-sysctl.service: Deactivated successfully.633vm-test-run-nix-grpc-store-main> machine # [   15.077538] systemd[1]: Stopped Apply Kernel Variables.634vm-test-run-nix-grpc-store-main> machine # [   15.080704] systemd[1]: systemd-modules-load.service: Deactivated successfully.635vm-test-run-nix-grpc-store-main> machine # [   15.082702] systemd[1]: Stopped Load Kernel Modules.636vm-test-run-nix-grpc-store-main> machine # [   15.083813] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.637vm-test-run-nix-grpc-store-main> machine # [   15.085260] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.638vm-test-run-nix-grpc-store-main> machine # [   15.086530] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.639vm-test-run-nix-grpc-store-main> machine # [   15.087710] systemd[1]: Stopped Create System Files and Directories.640vm-test-run-nix-grpc-store-main> machine # [   15.088844] systemd[1]: Stopped target Local File Systems.641vm-test-run-nix-grpc-store-main> machine # [   15.089717] systemd[1]: Stopped target Preparation for Local File Systems.642vm-test-run-nix-grpc-store-main> machine # [   15.090728] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.643vm-test-run-nix-grpc-store-main> machine # [   15.091811] systemd[1]: Stopped Coldplug All udev Devices.644vm-test-run-nix-grpc-store-main> machine # [   15.092729] systemd[1]: Stopping Rule-based Manager for Device Events and Files...645vm-test-run-nix-grpc-store-main> machine # [   15.094107] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.646vm-test-run-nix-grpc-store-main> machine # [   15.095269] systemd[1]: Stopped Virtual Console Setup.647vm-test-run-nix-grpc-store-main> machine # [   15.096186] systemd[1]: initrd-cleanup.service: Deactivated successfully.648vm-test-run-nix-grpc-store-main> machine # [   15.097594] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.649vm-test-run-nix-grpc-store-main> machine # [   15.102606] systemd[1]: systemd-udevd.service: Deactivated successfully.650vm-test-run-nix-grpc-store-main> machine # [   15.112340] systemd[1]: Stopped Rule-based Manager for Device Events and Files.651vm-test-run-nix-grpc-store-main> machine # [   15.113894] systemd[1]: systemd-udevd.service: Consumed 2.300s CPU time over 2.267s wall clock time, 26.5M memory peak.652vm-test-run-nix-grpc-store-main> machine # [   15.115585] systemd[1]: systemd-udevd-varlink.socket: Deactivated successfully.653vm-test-run-nix-grpc-store-main> machine # [   15.116888] systemd[1]: Closed udev Varlink Socket.654vm-test-run-nix-grpc-store-main> machine # [   15.120784] systemd[1]: Starting Cleanup udev Database...655vm-test-run-nix-grpc-store-main> machine # [   15.121877] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.656vm-test-run-nix-grpc-store-main> machine # [   15.125389] systemd[1]: Stopped Create Static Device Nodes in /dev.657vm-test-run-nix-grpc-store-main> machine # [   15.126659] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.658vm-test-run-nix-grpc-store-main> machine # [   15.128178] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.659vm-test-run-nix-grpc-store-main> machine # [   15.129350] systemd[1]: kmod-static-nodes.service: Deactivated successfully.660vm-test-run-nix-grpc-store-main> machine # [   15.130484] systemd[1]: Stopped Create List of Static Device Nodes.661vm-test-run-nix-grpc-store-main> machine # [   15.132129] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.662vm-test-run-nix-grpc-store-main> machine # [   15.133371] systemd[1]: Finished rw-sysroot-nix-store.service.663vm-test-run-nix-grpc-store-main> machine # [   15.177198] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.664vm-test-run-nix-grpc-store-main> machine # [   15.178641] systemd[1]: Finished Cleanup udev Database.665vm-test-run-nix-grpc-store-main> machine # [   15.179625] systemd[1]: Reached target Switch Root.666vm-test-run-nix-grpc-store-main> machine # [   15.180467] systemd[1]: Starting NixOS Activation...667vm-test-run-nix-grpc-store-main> machine # [   15.337685] initrd-nixos-activation-start[193]: booting system configuration /nix/store/dpiamv2m807xifzrxys3xbaj61jqnkz3-nixos-system-machine-test668vm-test-run-nix-grpc-store-main> machine # [   15.390001] initrd-nixos-activation-start[193]: running activation script...669vm-test-run-nix-grpc-store-main> machine # [   16.011871] initrd-nixos-activation-start[216]: setting up /etc...670vm-test-run-nix-grpc-store-main> machine # [   16.240681] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.671vm-test-run-nix-grpc-store-main> machine # [   16.242188] systemd[1]: Finished NixOS Activation.672vm-test-run-nix-grpc-store-main> machine # [   16.244130] systemd[1]: Starting Switch Root...673vm-test-run-nix-grpc-store-main> machine # [   16.278183] systemd[1]: Switching root.674vm-test-run-nix-grpc-store-main> machine # [   16.394890] systemd-journald[77]: Received SIGTERM from PID 1 (systemd).675vm-test-run-nix-grpc-store-main> machine # [   16.987497] systemd[1]: systemd 262 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -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)676vm-test-run-nix-grpc-store-main> machine # [   16.987561] systemd[1]: Detected virtualization qemu.677vm-test-run-nix-grpc-store-main> machine # [   16.987649] systemd[1]: Detected architecture arm64.678vm-test-run-nix-grpc-store-main> machine # [   16.987789] systemd[1]: Detected first boot.679vm-test-run-nix-grpc-store-main> machine # [   17.000889] systemd[1]: Initializing machine ID from random generator.680vm-test-run-nix-grpc-store-main> machine # [   17.191724] systemd[1]: bpf-restrict-fs: LSM BPF program attached681vm-test-run-nix-grpc-store-main> machine # [   17.462471] systemd[1]: Applying preset policy.682vm-test-run-nix-grpc-store-main> machine # [   17.984687] systemd[1]: Populated /etc with preset unit settings.683vm-test-run-nix-grpc-store-main> machine # [   18.379249] systemd[1]: initrd-switch-root.service: Deactivated successfully.684vm-test-run-nix-grpc-store-main> machine # [   18.380139] systemd[1]: Stopped initrd-switch-root.service.685vm-test-run-nix-grpc-store-main> machine # [   18.382571] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.686vm-test-run-nix-grpc-store-main> machine # [   18.391110] systemd[1]: Created slice Slice /system/getty.687vm-test-run-nix-grpc-store-main> machine # [   18.393100] systemd[1]: Created slice User and Session Slice.688vm-test-run-nix-grpc-store-main> machine # [   18.394019] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.689vm-test-run-nix-grpc-store-main> machine # [   18.395076] systemd[1]: Started Forward Password Requests to Wall Directory Watch.690vm-test-run-nix-grpc-store-main> machine # [   18.395527] systemd[1]: Expecting device /dev/hvc0...691vm-test-run-nix-grpc-store-main> machine # [   18.395877] systemd[1]: Expecting device /dev/ttyAMA0...692vm-test-run-nix-grpc-store-main> machine # [   18.396208] systemd[1]: Reached target Local Encrypted Volumes.693vm-test-run-nix-grpc-store-main> machine # [   18.396557] systemd[1]: Stopped target initrd-fs.target.694vm-test-run-nix-grpc-store-main> machine # [   18.396891] systemd[1]: Stopped target initrd-root-fs.target.695vm-test-run-nix-grpc-store-main> machine # [   18.397211] systemd[1]: Stopped target initrd-switch-root.target.696vm-test-run-nix-grpc-store-main> machine # [   18.397562] systemd[1]: Reached target Virtual Machines and Containers.697vm-test-run-nix-grpc-store-main> machine # [   18.397897] systemd[1]: Reached target Path Units.698vm-test-run-nix-grpc-store-main> machine # [   18.398208] systemd[1]: Reached target Remote File Systems.699vm-test-run-nix-grpc-store-main> machine # [   18.398507] systemd[1]: Reached target Slice Units.700vm-test-run-nix-grpc-store-main> machine # [   18.398986] systemd[1]: Reached target Swaps.701vm-test-run-nix-grpc-store-main> machine # [   18.410494] systemd[1]: Listening on Query the User Interactively for a Password.702vm-test-run-nix-grpc-store-main> machine # [   18.415433] systemd[1]: Listening on Process Core Dump Socket.703vm-test-run-nix-grpc-store-main> machine # [   18.417392] systemd[1]: Listening on Credential Encryption/Decryption.704vm-test-run-nix-grpc-store-main> machine # [   18.420866] systemd[1]: Listening on Factory Reset Management.705vm-test-run-nix-grpc-store-main> machine # [   18.421646] systemd[1]: Listening on Hostname Service Socket.706vm-test-run-nix-grpc-store-main> machine # [   18.429051] systemd[1]: Starting Journal Log Access Socket...707vm-test-run-nix-grpc-store-main> machine # [   18.430898] systemd[1]: Listening on Journal Audit Socket.708vm-test-run-nix-grpc-store-main> machine # [   18.433310] systemd[1]: Listening on Console Output Muting Service Socket.709vm-test-run-nix-grpc-store-main> machine # [   18.434299] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.710vm-test-run-nix-grpc-store-main> machine # [   18.435065] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os711vm-test-run-nix-grpc-store-main> machine # [   18.436462] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki712vm-test-run-nix-grpc-store-main> machine # [   18.443000] systemd[1]: Listening on Disk Repartitioning Service Socket.713vm-test-run-nix-grpc-store-main> machine # [   18.443842] systemd[1]: Listening on udev Varlink Socket.714vm-test-run-nix-grpc-store-main> machine # [   18.449558] systemd[1]: Mounting Huge Pages File System...715vm-test-run-nix-grpc-store-main> machine # [   18.453852] systemd[1]: Mounting POSIX Message Queue File System...716vm-test-run-nix-grpc-store-main> machine # [   18.460128] systemd[1]: Mounting Kernel Debug File System...717vm-test-run-nix-grpc-store-main> machine # [   18.487228] systemd[1]: Mounting Kernel Trace File System...718vm-test-run-nix-grpc-store-main> machine # [   18.495324] systemd[1]: Starting Create List of Static Device Nodes...719vm-test-run-nix-grpc-store-main> machine # [   18.495853] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs720vm-test-run-nix-grpc-store-main> machine # [   18.509020] systemd[1]: Mounting Kernel Configuration File System...721vm-test-run-nix-grpc-store-main> machine # [   18.509630] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm722vm-test-run-nix-grpc-store-main> machine # [   18.510124] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore723vm-test-run-nix-grpc-store-main> machine # [   18.510559] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse724vm-test-run-nix-grpc-store-main> machine # [   18.532189] systemd[1]: Mounting FUSE Control File System...725vm-test-run-nix-grpc-store-main> machine # [   18.533131] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67726vm-test-run-nix-grpc-store-main> machine # [   18.546565] systemd[1]: Starting Journal Service...727vm-test-run-nix-grpc-store-main> machine # [   18.565584] systemd[1]: Starting Load Kernel Modules...728vm-test-run-nix-grpc-store-main> machine # [   18.578910] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...729vm-test-run-nix-grpc-store-main> machine # [   18.605732] systemd[1]: Starting Remount Root and Kernel File Systems...730vm-test-run-nix-grpc-store-main> machine # [   18.610018] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os731vm-test-run-nix-grpc-store-main> machine # [   18.619163] systemd[1]: Starting Coldplug All udev Devices...732vm-test-run-nix-grpc-store-main> machine # [   18.628671] systemd[1]: Listening on Journal Log Access Socket.733vm-test-run-nix-grpc-store-main> machine # [   18.630195] systemd[1]: Mounted Huge Pages File System.734vm-test-run-nix-grpc-store-main> machine # [   18.632531] systemd[1]: Mounted POSIX Message Queue File System.735vm-test-run-nix-grpc-store-main> machine # [   18.633225] systemd[1]: Mounted Kernel Debug File System.736vm-test-run-nix-grpc-store-main> machine # [   18.633928] systemd[1]: Mounted Kernel Trace File System.737vm-test-run-nix-grpc-store-main> machine # [   18.634584] systemd[1]: Mounted Kernel Configuration File System.738vm-test-run-nix-grpc-store-main> machine # [   18.636669] systemd[1]: Mounted FUSE Control File System.739vm-test-run-nix-grpc-store-main> machine # [   18.655576] systemd[1]: Finished Create List of Static Device Nodes.740vm-test-run-nix-grpc-store-main> machine # [   18.669003] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...741vm-test-run-nix-grpc-store-main> machine # [   18.728220] systemd-journald[287]: Collecting audit messages is enabled.742vm-test-run-nix-grpc-store-main> machine # [   18.745138] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.743vm-test-run-nix-grpc-store-main> machine # [   18.751328] systemd[1]: Started Journal Service.744vm-test-run-nix-grpc-store-main> machine # [   18.752050] EXT4-fs (vda): re-mounted 6d823918-4c5a-402b-8f3f-9c4bbee6f9c7.745vm-test-run-nix-grpc-store-main> machine # [   18.755099] systemd[1]: Queued start job for default target Multi-User System.746vm-test-run-nix-grpc-store-main> machine # [   18.759224] systemd[1]: systemd-journald.service: Deactivated successfully.747vm-test-run-nix-grpc-store-main> machine # [   18.766135] systemd-modules-load[288]: Using 2 probe threads748vm-test-run-nix-grpc-store-main> machine # [   18.781194] systemd-oomd[289]: No swap; memory pressure usage will be degraded749vm-test-run-nix-grpc-store-main> machine # [   18.797007] systemd-modules-load[288]: Module 'atkbd' is built in750vm-test-run-nix-grpc-store-main> machine # [   18.805356] systemd-modules-load[288]: Module 'loop' is built in751vm-test-run-nix-grpc-store-main> machine # [   18.813775] systemd[1]: Finished Load Kernel Modules.752vm-test-run-nix-grpc-store-main> machine # [   18.823207] systemd[1]: Starting Firewall...753vm-test-run-nix-grpc-store-main> machine # [   18.837463] systemd[1]: Starting Apply Kernel Variables...754vm-test-run-nix-grpc-store-main> machine # [   18.845225] systemd[1]: Finished Remount Root and Kernel File Systems.755vm-test-run-nix-grpc-store-main> machine # [   18.856779] systemd[1]: Listening on Disk Image Download Service Socket.756vm-test-run-nix-grpc-store-main> machine # [   18.867809] systemd[1]: Starting Flush Journal to Persistent Storage...757vm-test-run-nix-grpc-store-main> machine # [   18.883226] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore758vm-test-run-nix-grpc-store-main> machine # [   18.895171] systemd[1]: Starting Load/Save OS Random Seed...759vm-test-run-nix-grpc-store-main> machine # [   18.902430] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os760vm-test-run-nix-grpc-store-main> machine # [   18.935524] systemd-journald[287]: Received client request to flush runtime journal.761vm-test-run-nix-grpc-store-main> machine # [   18.969997] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.762vm-test-run-nix-grpc-store-main> machine # [   18.972981] systemd[1]: Finished Load/Save OS Random Seed.763vm-test-run-nix-grpc-store-main> machine # [   18.974032] systemd[1]: Reached target First Boot Complete.764vm-test-run-nix-grpc-store-main> machine # [   18.974979] systemd[1]: Starting Create Static Device Nodes in /dev...765vm-test-run-nix-grpc-store-main> machine # [   18.989839] systemd[1]: Finished Flush Journal to Persistent Storage.766vm-test-run-nix-grpc-store-main> machine # [   19.013385] systemd[1]: Finished Apply Kernel Variables.767vm-test-run-nix-grpc-store-main> machine # [   19.091132] systemd[1]: Finished Create Static Device Nodes in /dev.768vm-test-run-nix-grpc-store-main> machine # [   19.092941] systemd[1]: Reached target Preparation for Local File Systems.769vm-test-run-nix-grpc-store-main> machine # [   19.094753] systemd[1]: Starting Rule-based Manager for Device Events and Files...770vm-test-run-nix-grpc-store-main> machine # [   19.182404] systemd-udevd[326]: Using default interface naming scheme 'v261'.771vm-test-run-nix-grpc-store-main> machine # [   19.267242] systemd[1]: Started Rule-based Manager for Device Events and Files.772vm-test-run-nix-grpc-store-main> machine # [   19.376567] systemd[1]: Mounting /run/wrappers...773vm-test-run-nix-grpc-store-main> machine # [   19.446418] systemd[1]: Mounted /run/wrappers.774vm-test-run-nix-grpc-store-main> machine # [   19.448108] systemd[1]: Reached target Local File Systems.775vm-test-run-nix-grpc-store-main> machine # [   19.456611] systemd[1]: Listening on Boot Loader Control Service Socket.776vm-test-run-nix-grpc-store-main> machine # [   19.460139] systemd[1]: Starting register-nix-paths.service...777vm-test-run-nix-grpc-store-main> machine # [   19.467527] systemd[1]: Starting Create SUID/SGID Wrappers...778vm-test-run-nix-grpc-store-main> machine # [   19.474705] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.779vm-test-run-nix-grpc-store-main> machine # [   19.480662] systemd[1]: Starting Save Transient machine-id to Disk...780vm-test-run-nix-grpc-store-main> machine # [   19.484545] systemd[1]: Starting Create System Files and Directories...781vm-test-run-nix-grpc-store-main> machine # [   19.639154] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.782vm-test-run-nix-grpc-store-main> machine # [   19.643678] systemd[1]: Finished Save Transient machine-id to Disk.783vm-test-run-nix-grpc-store-main> machine # [   19.775123] systemd[1]: Finished Create System Files and Directories.784vm-test-run-nix-grpc-store-main> machine # [   19.783957] systemd[1]: Starting Rebuild Journal Catalog...785vm-test-run-nix-grpc-store-main> machine # [   19.791799] systemd[1]: Starting Record System Boot/Shutdown in UTMP...786vm-test-run-nix-grpc-store-main> machine # [   19.825898] systemd[1]: Finished Coldplug All udev Devices.787vm-test-run-nix-grpc-store-main> machine # [   19.837360] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs788vm-test-run-nix-grpc-store-main> machine # [   19.905306] systemd[1]: Finished Record System Boot/Shutdown in UTMP.789vm-test-run-nix-grpc-store-main> machine # [   19.907247] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse790vm-test-run-nix-grpc-store-main> machine # [   19.943985] systemd[1]: Finished Rebuild Journal Catalog.791vm-test-run-nix-grpc-store-main> machine # [   19.948778] systemd[1]: Starting Update is Completed...792vm-test-run-nix-grpc-store-main> machine # [   20.051528] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.793vm-test-run-nix-grpc-store-main> machine # [   20.249161] systemd[1]: Finished Update is Completed.794vm-test-run-nix-grpc-store-main> machine # [   20.276216] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.795vm-test-run-nix-grpc-store-main> machine # [   20.382691] (udev-worker)[346]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.796vm-test-run-nix-grpc-store-main> machine # [   20.391698] (udev-worker)[346]: Network interface NamePolicy= disabled on kernel command line.797vm-test-run-nix-grpc-store-main> machine # [   20.398594] (udev-worker)[372]: Network interface NamePolicy= disabled on kernel command line.798vm-test-run-nix-grpc-store-main> machine # [   20.694462] systemd[1]: Condition check resulted in Virtio network device being skipped.799vm-test-run-nix-grpc-store-main> machine # [   20.698153] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore800vm-test-run-nix-grpc-store-main> machine # [   20.703003] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.801vm-test-run-nix-grpc-store-main> machine # [   20.707678] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67802vm-test-run-nix-grpc-store-main> machine # [   20.713083] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore803vm-test-run-nix-grpc-store-main> machine # [   20.716930] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os804vm-test-run-nix-grpc-store-main> machine # [   20.719128] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os805vm-test-run-nix-grpc-store-main> machine # [   20.755801] mousedev: PS/2 mouse device common for all mice806vm-test-run-nix-grpc-store-main> machine # [   20.863869] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.807vm-test-run-nix-grpc-store-main> machine # [   20.868876] systemd[1]: Finished Create SUID/SGID Wrappers.808vm-test-run-nix-grpc-store-main> machine # [   20.951278] systemd[1]: Finished Firewall.809vm-test-run-nix-grpc-store-main> machine # [   21.285729] systemd[1]: Finished register-nix-paths.service.810vm-test-run-nix-grpc-store-main> machine # [   21.291137] systemd[1]: Reached target System Initialization.811vm-test-run-nix-grpc-store-main> machine # [   21.293354] systemd[1]: Started Discard unused filesystem blocks once a week.812vm-test-run-nix-grpc-store-main> machine # [   21.294557] systemd[1]: Started Daily Cleanup of Temporary Directories.813vm-test-run-nix-grpc-store-main> machine # [   21.295598] systemd[1]: Reached target Timer Units.814vm-test-run-nix-grpc-store-main> machine # [   21.296897] systemd[1]: Listening on D-Bus System Message Bus Socket.815vm-test-run-nix-grpc-store-main> machine # [   21.297952] systemd[1]: Listening on Nix Daemon Socket.816vm-test-run-nix-grpc-store-main> machine # [   21.302380] systemd[1]: Listening on Nix worker-protocol over gRPC.817vm-test-run-nix-grpc-store-main> machine # [   21.306251] systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local).818vm-test-run-nix-grpc-store-main> machine # [   21.314292] systemd[1]: Starting OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK)...819vm-test-run-nix-grpc-store-main> machine # [   21.321585] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.820vm-test-run-nix-grpc-store-main> machine # [   21.325292] systemd[1]: Starting D-Bus System Message Bus...821vm-test-run-nix-grpc-store-main> machine # [   21.363560] systemd-ssh-issue[515]: Options --make-vsock/--rm-vsock have been replaced by make-vsock/rm-vsock verbs.822vm-test-run-nix-grpc-store-main> machine # [   21.371807] systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK).823vm-test-run-nix-grpc-store-main> machine # [   21.373768] systemd[1]: Reached target Socket Units.824vm-test-run-nix-grpc-store-main> machine # [   21.415344] dbus-broker-launch[516]: Looking up NSS user entry for 'systemd-timesync'...825vm-test-run-nix-grpc-store-main> machine # [   21.419602] dbus-broker-launch[516]: NSS returned no entry for 'systemd-timesync'826vm-test-run-nix-grpc-store-main> machine # [   21.421560] dbus-broker-launch[516]: Invalid user-name in /nix/store/5w4naxg4616imc5qj1l4sca5ldgajzps-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"827vm-test-run-nix-grpc-store-main> machine # [   21.437145] systemd[1]: Started D-Bus System Message Bus.828vm-test-run-nix-grpc-store-main> machine # [   21.440601] systemd[1]: Reached target Basic System.829vm-test-run-nix-grpc-store-main> machine # [   21.446374] systemd[1]: Started backdoor.service.830vm-test-run-nix-grpc-store-main> machine # [   21.454051] systemd[1]: Starting Import lastlog data into lastlog2 database...831vm-test-run-nix-grpc-store-main> machine # [   21.463091] systemd[1]: Started mock-oidc.service.832vm-test-run-nix-grpc-store-main> machine # [   21.475365] systemd[1]: Starting nix-grpc-certs.service...833vm-test-run-nix-grpc-store-main> machine # [   21.479177] dbus-broker-launch[516]: Ready834vm-test-run-nix-grpc-store-main> machine # [   21.494553] systemd[1]: Starting Name Service Cache Daemon (nsncd)...835vm-test-run-nix-grpc-store-main> machine # [   21.509536] systemd[1]: Starting Post-Boot Actions...836vm-test-run-nix-grpc-store-main> machine # [   21.518949] systemd[1]: Started Reset console on configuration changes.837vm-test-run-nix-grpc-store-main> machine # [   21.530720] systemd[1]: Starting resolvconf update...838vm-test-run-nix-grpc-store-main> machine # [   21.540268] systemd[1]: Starting SSH Host Keys Generation...839vm-test-run-nix-grpc-store-main> machine # [   21.694436] systemd[1]: Finished Post-Boot Actions.840vm-test-run-nix-grpc-store-main> machine # [   21.709212] systemd[1]: Started Name Service Cache Daemon (nsncd).841vm-test-run-nix-grpc-store-main> machine # [   21.717593] nsncd[523]: Nov 12 08:47:41.282 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"842vm-test-run-nix-grpc-store-main> machine # [   21.732129] systemd[1]: Reached target Host and Network Name Lookups.843vm-test-run-nix-grpc-store-main> machine # [   21.733363] systemd[1]: Reached target User and Group Name Lookups.844vm-test-run-nix-grpc-store-main> machine # [   21.734462] systemd[1]: Starting User Login Management...845vm-test-run-nix-grpc-store-main> machine # connecting to host...846vm-test-run-nix-grpc-store-main> machine # [   21.782098] nix-grpc-certs-start[540]: ...+..+++++++++++++++++++++++++++++++++++++++*.+....................+...+.......+.....+......+....+...+...+...+.....+.......+++++++++++++++++++++++++++++++++++++++*...+..........+.........+..+.++++++847vm-test-run-nix-grpc-store-main> machine # [   21.798830] systemd[1]: Finished Import lastlog data into lastlog2 database.848vm-test-run-nix-grpc-store-main> [81.91s] machine: Guest shell says: b'Spawning backdoor root shell...\n'849vm-test-run-nix-grpc-store-main> [81.93s] machine: connected to guest root shell850vm-test-run-nix-grpc-store-main> [81.93s] machine: (connecting took 18.87 seconds)851vm-test-run-nix-grpc-store-main> [81.93s] machine: (finished: waiting for the VM to finish booting, in 76.67 seconds)852vm-test-run-nix-grpc-store-main> machine # [   21.877448] nix-grpc-certs-start[540]: .....+......+.+..+......+.+.....+......+.......+..+++++++++++++++++++++++++++++++++++++++*...+....+.....+...+.......+..+.+.....+...+.......+........................+..................+++++++++++++++++++++++++++++++++++++++*.+...+..................+...+..+....+...........+.............+.....+....+..+...+...............+............+.+.........+.....+......+...+....+..+..........+.........+............+.....+.......+......+....................+.+...+...+........+......+.........................+...+..+...+......++++++853vm-test-run-nix-grpc-store-main> machine # [   21.928464] nix-grpc-certs-start[540]: -----854vm-test-run-nix-grpc-store-main> machine # [   21.948801] systemd-logind[550]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)855vm-test-run-nix-grpc-store-main> machine # [   21.953705] systemd-logind[550]: Watching system buttons on /dev/input/event0 (gpio-keys)856vm-test-run-nix-grpc-store-main> machine # [   21.959768] systemd-logind[550]: New seat seat0.857vm-test-run-nix-grpc-store-main> machine # [   21.968962] systemd[1]: Started User Login Management.858vm-test-run-nix-grpc-store-main> machine # [   21.983566] systemd[1]: Starting linger-users.service...859vm-test-run-nix-grpc-store-main> [82.14s] machine: (finished: waiting for unit nix-daemon.socket, in 76.88 seconds)860vm-test-run-nix-grpc-store-main> [82.14s] machine: waiting for unit nix-grpc-daemon.socket861vm-test-run-nix-grpc-store-main> machine # [   22.111158] nix-grpc-certs-start[575]: ..+.......+.....+.+..+...+...+....+........+....+...+......+.........+..+.+.....+.......+.....+...+...+....+...+++++++++++++++++++++++++++++++++++++++*.........+....+............+............+.....+.............+..+.......+...+...+........+.+.....+.............+..+...+............+......+...+....+..+...+.+++++++++++++++++++++++++++++++++++++++*.+.........+.....+...+...+...+..........+......+......+..............+....+......+...+.....+.............+..............+....+......+...+..+......+.......+.....+.......+......+........+.......+..+.......+........+.......+...++++++862vm-test-run-nix-grpc-store-main> machine # [   22.148246] nix-grpc-certs-start[575]: .+..+...+....+..+....+.....+++++++++++++++++++++++++++++++++++++++*........+.........+++++++++++++++++++++++++++++++++++++++*...+........+..........+.....++++++863vm-test-run-nix-grpc-store-main> machine # [   22.177681] nix-grpc-certs-start[575]: -----864vm-test-run-nix-grpc-store-main> [82.23s] machine: (finished: waiting for unit nix-grpc-daemon.socket, in 0.09 seconds)865vm-test-run-nix-grpc-store-main> [82.23s] subtest: daemon lifecycle866vm-test-run-nix-grpc-store-main> machine # [   22.204384] systemd[1]: linger-users.service: Deactivated successfully.867vm-test-run-nix-grpc-store-main> machine # [   22.205722] systemd[1]: Finished linger-users.service.868vm-test-run-nix-grpc-store-main> 869vm-test-run-nix-grpc-store-main> running 5 tests870vm-test-run-nix-grpc-store-main> test lifecycle::a_failed_connection_while_nix_daemon_is_down_does_not_poison_the_worker ... machine # [   22.250388] systemd[1]: Stopped target Host and Network Name Lookups.871vm-test-run-nix-grpc-store-main> machine # [   22.251816] systemd[1]: Stopping Host and Network Name Lookups...872vm-test-run-nix-grpc-store-main> machine # [   22.260489] systemd[1]: Stopped target User and Group Name Lookups.873vm-test-run-nix-grpc-store-main> machine # [   22.261644] systemd[1]: Stopping User and Group Name Lookups...874vm-test-run-nix-grpc-store-main> machine # [   22.262611] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...875vm-test-run-nix-grpc-store-main> machine # [   22.277083] systemd[1]: nscd.service: Deactivated successfully.876vm-test-run-nix-grpc-store-main> machine # [   22.280383] systemd[1]: Stopped Name Service Cache Daemon (nsncd).877vm-test-run-nix-grpc-store-main> machine # [   22.281409] systemd[1]: Starting Name Service Cache Daemon (nsncd)...878vm-test-run-nix-grpc-store-main> machine # [   22.305981] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3879vm-test-run-nix-grpc-store-main> machine # [   22.341460] nix-grpc-certs-start[616]: Certificate request self-signature ok880vm-test-run-nix-grpc-store-main> machine # [   22.343352] nix-grpc-certs-start[616]: subject=CN=localhost881vm-test-run-nix-grpc-store-main> machine # [   22.360722] mock-oidc-server[521]: Mock OIDC Server running882vm-test-run-nix-grpc-store-main> machine # [   22.361780] mock-oidc-server[521]:   OIDC Address: 127.0.0.1:8080883vm-test-run-nix-grpc-store-main> machine # [   22.362780] mock-oidc-server[521]:   Issue Address: 127.0.0.1:8081884vm-test-run-nix-grpc-store-main> machine # [   22.363713] mock-oidc-server[521]:   Issuer: http://127.0.0.1:8080/oidc885vm-test-run-nix-grpc-store-main> machine # [   22.365672] mock-oidc-server[521]:   JWKS: http://127.0.0.1:8080/oidc/.well-known/jwks.json886vm-test-run-nix-grpc-store-main> machine # [   22.367044] mock-oidc-server[521]:   Discovery: http://127.0.0.1:8080/oidc/.well-known/openid-configuration887vm-test-run-nix-grpc-store-main> machine # [   22.369948] mock-oidc-server[521]:   Issue tokens: http://127.0.0.1:8081/issue?sub=...888vm-test-run-nix-grpc-store-main> machine # [   22.396898] nsncd[625]: Nov 12 08:47:41.981 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"889vm-test-run-nix-grpc-store-main> machine # [   22.399310] systemd[1]: Started Name Service Cache Daemon (nsncd).890vm-test-run-nix-grpc-store-main> machine # [   22.402542] systemd[1]: Reached target Host and Network Name Lookups.891vm-test-run-nix-grpc-store-main> machine # [   22.403785] systemd[1]: Reached target User and Group Name Lookups.892vm-test-run-nix-grpc-store-main> machine # [   22.463436] systemd[1]: Finished resolvconf update.893vm-test-run-nix-grpc-store-main> machine # [   22.464995] systemd[1]: Reached target Preparation for Network.894vm-test-run-nix-grpc-store-main> machine # [   22.471951] systemd[1]: Starting DHCP Client...895vm-test-run-nix-grpc-store-main> machine # [   22.476490] systemd[1]: Starting Address configuration of eth1...896vm-test-run-nix-grpc-store-main> machine # [   22.492283] systemd[1]: Starting Extra networking commands....897vm-test-run-nix-grpc-store-main> machine # [   22.507507] nix-grpc-certs-start[636]: ......+....+......+.....+.........+++++++++++++++++++++++++++++++++++++++*.............+..........+++++++++++++++++++++++++++++++++++++++*..+............+..+...+...............+.......+...............+........+.......+......+............+..+...+......+.+.....+.+.....+............+..........+........+....+...+...+...+.........+......+...........+...+............+.+........+.+...++++++898vm-test-run-nix-grpc-store-main> machine # [   22.659839] network-addresses-eth1-start[650]: adding address 192.168.1.1/24... done899vm-test-run-nix-grpc-store-main> machine # [   22.684232] nix-grpc-certs-start[636]: ..+++++++++++++++++++++++++++++++++++++++*...+.....+.......+.....+....+........+.+..+...+....+.....+++++++++++++++++++++++++++++++++++++++*.+...+.+...........+.......+........+..........+............+..+.........+.......+...+......+...+..+...................+..+....+...+...+..+...+...+.+........................+...............+.....+.+......+.........+...+..+.+........+......+...+.+...........+.+..+............+...............+......+.......+.....+.+.........+.....+...+...+.+.............................+.+.....+.+.....+.........+.............+.....................+......+...+...........+.+.....+...+.+......+......+...+.........+.....+......+.......+.....+..........+..+.......+...+...........+.+...........+..........+...+.....+.......+...+...........+.+............+...+.....+...+......+..........+.....+......++++++900vm-test-run-nix-grpc-store-main> machine # [   22.723638] nix-grpc-certs-start[636]: -----901vm-test-run-nix-grpc-store-main> machine # [   22.726067] network-addresses-eth1-start[650]: adding address 2001:db8:1::1/64... done902vm-test-run-nix-grpc-store-main> machine # [   22.843726] nix-grpc-certs-start[683]: Certificate request self-signature ok903vm-test-run-nix-grpc-store-main> machine # [   22.846670] nix-grpc-certs-start[683]: subject=CN=localhost904vm-test-run-nix-grpc-store-main> machine # [   22.971083] dhcpcd[665]: dhcpcd-10.3.2 starting905vm-test-run-nix-grpc-store-main> machine # [   22.976944] dhcpcd[722]: dev: loaded udev906vm-test-run-nix-grpc-store-main> machine # [   23.013000] systemd[1]: Finished Address configuration of eth1.907vm-test-run-nix-grpc-store-main> machine # [   23.049177] 8021q: 802.1Q VLAN Support v1.8908vm-test-run-nix-grpc-store-main> machine # [   23.049637] 8021q: adding VLAN 0 to HW filter on device eth1909vm-test-run-nix-grpc-store-main> machine # [   23.128770] nix-grpc-certs-start[712]: ..+.......+..+.+..+.+..+..................+.+..............+....+.....+.......+..............+....+..+.+..+...+...+.+...+...+...+...........+++++++++++++++++++++++++++++++++++++++*..+.........+..+.+...+..+.........+..................+.+.....+......+.+.........+.....+.+.....+...+....+.....+......+...............+....+....................+...+...+.......+.....+.........+.+........+.+++++++++++++++++++++++++++++++++++++++*....+.........+......+...+.+.........+..+....+..+...+.+..............+......+.+..............+..........+...+...+.....+...+......+.+.....+...+.......+.........+.........+..............+.+......+........+......+.+......+...+..+..........+.....+...+.+...+..+......+...+......+..........+........+......+....+...+.....+...+....+..+.....................+....+...+...+..+...+.............+.....+......+......+....+.......................+......+....+..+.........+......+......+.......+...........+.+..............+......+...+.+...............+.....+....+.....+.+.....+....+...+........+.+..............+.......+.........+.....+.+...+..++++++[   23.144959] cfg80211: Loading compiled-in X.509 certificates for regulatory database910vm-test-run-nix-grpc-store-main> machine # 911vm-test-run-nix-grpc-store-main> machine # [   23.155650] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'912vm-test-run-nix-grpc-store-main> machine # [   23.156312] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'913vm-test-run-nix-grpc-store-main> machine # [   23.165202] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2914vm-test-run-nix-grpc-store-main> machine # [   23.165754] cfg80211: failed to load regulatory.db915vm-test-run-nix-grpc-store-main> machine # [   23.184309] nix-grpc-certs-start[712]: .+...+..+....+..+.........+....+......+...+..+...+++++++++++++++++++++++++++++++++++++++*.........+.......+++++++++++++++++++++++++++++++++++++++*....+.........+.......+..+...+...+.+......+........++++++916vm-test-run-nix-grpc-store-main> machine # [   23.199381] systemd[1]: Finished Extra networking commands..917vm-test-run-nix-grpc-store-main> machine # [   23.202005] systemd[1]: Reached target Network.918vm-test-run-nix-grpc-store-main> machine # [   23.202938] systemd[1]: Starting Permit User Sessions...919vm-test-run-nix-grpc-store-main> machine # [   23.212263] nix-grpc-certs-start[712]: -----920vm-test-run-nix-grpc-store-main> machine # [   23.282112] systemd[1]: Finished Permit User Sessions.921vm-test-run-nix-grpc-store-main> machine # [   23.300534] systemd[1]: Started Getty on tty1.922vm-test-run-nix-grpc-store-main> machine # [   23.301578] systemd[1]: Reached target Login Prompts.923vm-test-run-nix-grpc-store-main> machine # [   23.364799] nix-grpc-certs-start[742]: Certificate request self-signature ok924vm-test-run-nix-grpc-store-main> machine # [   23.366002] nix-grpc-certs-start[742]: subject=CN=ro-client925vm-test-run-nix-grpc-store-main> machine # [   23.420397] 8021q: adding VLAN 0 to HW filter on device eth0926vm-test-run-nix-grpc-store-main> machine # [   23.411853] dhcpcd[722]: eth0: waiting for carrier927vm-test-run-nix-grpc-store-main> machine # [   23.413787] dhcpcd[722]: eth0: carrier acquired928vm-test-run-nix-grpc-store-main> machine # [   23.443541] dhcpcd[722]: DUID 00:01:00:01:32:88:39:af:52:54:00:12:34:56929vm-test-run-nix-grpc-store-main> machine # [   23.444943] dhcpcd[722]: eth0: IAID 00:12:34:56930vm-test-run-nix-grpc-store-main> machine # [   23.446475] dhcpcd[722]: eth0: adding address fe80::5054:ff:fe12:3456931vm-test-run-nix-grpc-store-main> machine # [   23.611012] nix-grpc-certs-start[749]: .+.+......+.........+..+....+...+...+...+............+++++++++++++++++++++++++++++++++++++++*......+..+.+......+.....+.........+......+...+++++++++++++++++++++++++++++++++++++++*..........+......+..........+...+..+....+.....+..........+...........+.+..+.+.....+.......+.........+..................+.................+....+..+....+.........+..+....+......+..+................+......+.....+.+..+...+....+..............+.......+...+........................+..+...+...+...+.+......+..+..........+..+.+.........+.....+...+.....................+.+..............+....+...+..+.+......+.....+......+.......+......+............+..+................+.........+...+........+.+.........+.........+...+..+...+.............+.....+....+.....+...+...+.+........+.............+..............+.+..+...+...+....+......+.....+......+...+...+.......+............+...+...........+.+.....+.+..+.+...........+.+.........+...+...............+........+.........+...+...............+.............+...+.....+.+......+.........+.....+...+.+.....+.........+.......+......+.....+.........+.+..+...+.......+..+...+......+.+...+......+......+...+.......................+.......+........+....+...+..+....+............+...+...........+....+.....+.........+............+...+......+.......+...+..............+.......+...+........+..........+............+..++++++932vm-test-run-nix-grpc-store-main> machine # [   23.644166] nix-grpc-certs-start[749]: ..+.........+...+.+++++++++++++++++++++++++++++++++++++++*....+..+...+++++++++++++++++++++++++++++++++++++++*.........+..............+.+......+...............+..+............+..........+......+.........+...+...........+.+........+...+...+......+...+.......++++++933vm-test-run-nix-grpc-store-main> machine # [   23.656123] nix-grpc-certs-start[749]: -----934vm-test-run-nix-grpc-store-main> machine # [   23.697146] nix-grpc-certs-start[754]: Certificate request self-signature ok935vm-test-run-nix-grpc-store-main> machine # [   23.700129] nix-grpc-certs-start[754]: subject=CN=rw-client936vm-test-run-nix-grpc-store-main> machine # [   23.735922] nix-grpc-certs-start[755]: ..+.........+.+.....+..........+..+.+......+...+..+......+....+...+...+...+......+........................+.....+++++++++++++++++++++++++++++++++++++++*.+..+...+...+.+++++++++++++++++++++++++++++++++++++++*...+..+......+.+........................+..+..........+.....+...++++++937vm-test-run-nix-grpc-store-main> machine # [   23.775393] nix-grpc-certs-start[755]: .+..+.+...+..+.........+.+..+.+++++++++++++++++++++++++++++++++++++++*...............+....+.....+....+...+..+...+....+++++++++++++++++++++++++++++++++++++++*.+.......+........+....+..+...+.............+...+.....+....+......+..+.........+....+...............+......+........+..................+...+....+.....+...+...+......+....+.....+.........+...+....+........+......+.......+.....+....+......+...++++++938vm-test-run-nix-grpc-store-main> machine # [   23.802502] nix-grpc-certs-start[755]: -----939vm-test-run-nix-grpc-store-main> machine # [   23.844776] nix-grpc-certs-start[758]: Certificate request self-signature ok940vm-test-run-nix-grpc-store-main> machine # [   23.845994] nix-grpc-certs-start[758]: subject=CN=stranger941vm-test-run-nix-grpc-store-main> machine # [   23.895499] systemd[1]: Starting Virtual Console Setup...942vm-test-run-nix-grpc-store-main> machine # [   23.912262] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.943vm-test-run-nix-grpc-store-main> machine # [   23.939641] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.944vm-test-run-nix-grpc-store-main> machine # [   23.941112] systemd[1]: Stopped Virtual Console Setup.945vm-test-run-nix-grpc-store-main> machine # [   23.945338] systemd[1]: Starting Virtual Console Setup...946vm-test-run-nix-grpc-store-main> machine # [   23.964465] dhcpcd[722]: eth0: soliciting a DHCP lease947vm-test-run-nix-grpc-store-main> machine # [   23.972545] systemd-logind[550]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)948vm-test-run-nix-grpc-store-main> machine # [   23.977458] dhcpcd[722]: eth0: offered 10.0.2.15 from 10.0.2.2949vm-test-run-nix-grpc-store-main> machine # [   23.992409] dhcpcd[722]: eth0: probing address 10.0.2.15/24950vm-test-run-nix-grpc-store-main> machine # [   24.004734] nix-grpc-certs-start[760]: .....+......+++++++++++++++++++++++++++++++++++++++*.....+......+.........+.+...+.....+......+.+...+...............+...+.....+............+++++++++++++++++++++++++++++++++++++++*..+...+..+.......+......+.................+....+...+..............................+.....+............+......+.......+......+...........+...+.+..+...................+..............+.......+..+.+.....+.+...+...+..+...+....+......+...............+..+.+...........................+...+.....+.+......+...+...........+...+.+..+.........+...+...+.......+......+.....+............+.......+.....+......+....+.....+.......+...+......+......+........+............+................+.....+.........+.+..++++++951vm-test-run-nix-grpc-store-main> machine # [   24.120223] nix-grpc-certs-start[760]: ...+....+..+...+.......+...+......+..+...+++++++++++++++++++++++++++++++++++++++*..+...+++++++++++++++++++++++++++++++++++++++*......+...+...+.......+.....+..........+...............+..+.+...........+......+...+...............+......+.+.........+.....+....+.....+.+......+..+.+......+.....+....+.....+................+.....+.+........+.+...+...+...............+.........+.........+....................+.+.....+...+.+...............+...........+...+...+....+........................+......+...+..+..................+...+.......+.....+......+.........+......+.......+.....+...+.+.........+.....+.......+...+..+..................+.+........+.+..+.........+...+.+......+......+..+...+.......+........+....+.....+......+..........+..+..........+......+.....+....+...+............+...+..............+...+...+.......+...............+...+....................+....+.....+....+.........+........+...+.+...++++++952vm-test-run-nix-grpc-store-main> machine # [   24.144453] nix-grpc-certs-start[760]: -----953vm-test-run-nix-grpc-store-main> machine # [   24.150871] sshd-keygen-start[569]: Generating public/private rsa key pair.954vm-test-run-nix-grpc-store-main> machine # [   24.153290] sshd-keygen-start[569]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key955vm-test-run-nix-grpc-store-main> machine # [   24.154679] sshd-keygen-start[569]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub956vm-test-run-nix-grpc-store-main> machine # [   24.155982] sshd-keygen-start[569]: The key fingerprint is:957vm-test-run-nix-grpc-store-main> machine # [   24.157732] sshd-keygen-start[569]: SHA256:K6+onwQbZUEpb92xpUVYPGWwGkqFn5XIqMbLmuz6A8g root@machine958vm-test-run-nix-grpc-store-main> machine # [   24.159367] sshd-keygen-start[569]: The key's randomart image is:959vm-test-run-nix-grpc-store-main> machine # [   24.160415] sshd-keygen-start[569]: +---[RSA 4096]----+960vm-test-run-nix-grpc-store-main> machine # [   24.161332] sshd-keygen-start[569]: |   .o. +.*++o    |961vm-test-run-nix-grpc-store-main> machine # [   24.162163] sshd-keygen-start[569]: |  . ..o.= Bo     |962vm-test-run-nix-grpc-store-main> machine # [   24.163078] sshd-keygen-start[569]: |   +oo.o.O..     |963vm-test-run-nix-grpc-store-main> machine # [   24.163926] sshd-keygen-start[569]: |   o*...*o       |964vm-test-run-nix-grpc-store-main> machine # [   24.164958] sshd-keygen-start[569]: |o o+ .. S        |965vm-test-run-nix-grpc-store-main> machine # [   24.165884] sshd-keygen-start[569]: |oE +o    .       |966vm-test-run-nix-grpc-store-main> machine # [   24.166774] sshd-keygen-start[569]: | o.o. . .        |967vm-test-run-nix-grpc-store-main> machine # [   24.167566] sshd-keygen-start[569]: |  =. o o         |968vm-test-run-nix-grpc-store-main> machine # [   24.168490] sshd-keygen-start[569]: |.++++ ...        |969vm-test-run-nix-grpc-store-main> machine # [   24.169384] sshd-keygen-start[569]: +----[SHA256]-----+970vm-test-run-nix-grpc-store-main> machine # [   24.171258] systemd[1]: Created slice Slice /system/sshd-vsock.971vm-test-run-nix-grpc-store-main> machine # [   24.191207] nix-grpc-certs-start[763]: Certificate request self-signature ok972vm-test-run-nix-grpc-store-main> machine # [   24.196872] nix-grpc-certs-start[763]: subject=CN=localhost973vm-test-run-nix-grpc-store-main> machine # [   24.212182] systemd[1]: Finished nix-grpc-certs.service.974vm-test-run-nix-grpc-store-main> machine # [   24.217943] systemd[1]: Started nix-grpc-daemon-mtls.service.975vm-test-run-nix-grpc-store-main> machine # [   24.225251] systemd[1]: Started nix-grpc-daemon-strict.service.976vm-test-run-nix-grpc-store-main> machine # [   24.238447] sshd-keygen-start[770]: Generating public/private ed25519 key pair.977vm-test-run-nix-grpc-store-main> machine # [   24.239920] sshd-keygen-start[770]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key978vm-test-run-nix-grpc-store-main> machine # [   24.241604] sshd-keygen-start[770]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub979vm-test-run-nix-grpc-store-main> machine # [   24.243019] sshd-keygen-start[770]: The key fingerprint is:980vm-test-run-nix-grpc-store-main> machine # [   24.243861] sshd-keygen-start[770]: SHA256:R1hBl9vxq2XUqAA5+8vuJ1KB/8rTK93aRDPSmiQa4NE root@machine981vm-test-run-nix-grpc-store-main> machine # [   24.246145] sshd-keygen-start[770]: The key's randomart image is:982vm-test-run-nix-grpc-store-main> machine # [   24.247674] sshd-keygen-start[770]: +--[ED25519 256]--+983vm-test-run-nix-grpc-store-main> machine # [   24.249173] sshd-keygen-start[770]: |         o+...   |984vm-test-run-nix-grpc-store-main> machine # [   24.250134] sshd-keygen-start[770]: |       .+o .. .  |985vm-test-run-nix-grpc-store-main> machine # [   24.251265] sshd-keygen-start[770]: |      o E=.  o +.|986vm-test-run-nix-grpc-store-main> machine # [   24.252277] sshd-keygen-start[770]: |     . oo.o ..o.o|987vm-test-run-nix-grpc-store-main> machine # [   24.253233] sshd-keygen-start[770]: |      . Soooo.* .|988vm-test-run-nix-grpc-store-main> machine # [   24.254123] sshd-keygen-start[770]: |         ++o.= * |989vm-test-run-nix-grpc-store-main> machine # [   24.255076] sshd-keygen-start[770]: |        .o =o.=  |990vm-test-run-nix-grpc-store-main> machine # [   24.255949] sshd-keygen-start[770]: |        ..* =+.  |991vm-test-run-nix-grpc-store-main> machine # [   24.258943] sshd-keygen-start[770]: |         +=*oo.  |992vm-test-run-nix-grpc-store-main> machine # [   24.260510] sshd-keygen-start[770]: +----[SHA256]-----+993vm-test-run-nix-grpc-store-main> machine # [   24.325538] sshd-keygen-start[779]: Generating public/private mldsa44-ed25519 key pair.994vm-test-run-nix-grpc-store-main> machine # [   24.327449] sshd-keygen-start[779]: Your identification has been saved in /etc/ssh/ssh_host_mldsa44_ed25519_key995vm-test-run-nix-grpc-store-main> machine # [   24.330455] sshd-keygen-start[779]: Your public key has been saved in /etc/ssh/ssh_host_mldsa44_ed25519_key.pub996vm-test-run-nix-grpc-store-main> machine # [   24.332798] sshd-keygen-start[779]: The key fingerprint is:997vm-test-run-nix-grpc-store-main> machine # [   24.334720] sshd-keygen-start[779]: SHA256:5/PFPxNWdl1HyEpiSwcrnW4rdkmqW0IG9KNbi6mb8RY root@machine998vm-test-run-nix-grpc-store-main> machine # [   24.338109] sshd-keygen-start[779]: The key's randomart image is:999vm-test-run-nix-grpc-store-main> machine # [   24.339977] sshd-keygen-start[779]: +[MLDSA44-ED25519-+1000vm-test-run-nix-grpc-store-main> machine # [   24.341224] sshd-keygen-start[779]: |    .     .. . o.|1001vm-test-run-nix-grpc-store-main> machine # [   24.342075] sshd-keygen-start[779]: |   . .   .+oo o o|1002vm-test-run-nix-grpc-store-main> machine # [   24.343071] sshd-keygen-start[779]: |    . o .o+= .  +|1003vm-test-run-nix-grpc-store-main> machine # [   24.343942] sshd-keygen-start[779]: |     o . o. .   =|1004vm-test-run-nix-grpc-store-main> machine # [   24.345946] sshd-keygen-start[779]: |    . + S =    .o|1005vm-test-run-nix-grpc-store-main> machine # [   24.348389] sshd-keygen-start[779]: |    EB . * o . o |1006vm-test-run-nix-grpc-store-main> machine # [   24.349681] sshd-keygen-start[779]: |  . +.o = *   + .|1007vm-test-run-nix-grpc-store-main> machine # [   24.352978] sshd-keygen-start[779]: |   =.  = o o . + |1008vm-test-run-nix-grpc-store-main> machine # [   24.354845] sshd-keygen-start[779]: |  +o. o.    .   +|1009vm-test-run-nix-grpc-store-main> machine # [   24.356363] sshd-keygen-start[779]: +----[SHA256]-----+1010vm-test-run-nix-grpc-store-main> machine # [   24.359200] systemd[1]: sshd-keygen.service: Deactivated successfully.1011vm-test-run-nix-grpc-store-main> machine # [   24.364128] systemd[1]: Finished SSH Host Keys Generation.1012vm-test-run-nix-grpc-store-main> machine # [   24.367496] systemd[1]: sshd-keygen.service: Consumed 1.252s CPU time over 2.808s wall clock time, 2.5M memory peak.1013vm-test-run-nix-grpc-store-main> machine # [   24.370363] systemd[1]: Started SSH per-connection Daemon (vsock:2:0).1014vm-test-run-nix-grpc-store-main> machine # [   24.371596] systemd[1]: Starting SSH Daemon...1015vm-test-run-nix-grpc-store-main> machine # [   24.465547] sshd[782]: Server listening on 0.0.0.0 port 22.1016vm-test-run-nix-grpc-store-main> machine # [   24.467591] sshd[782]: Server listening on :: port 22.1017vm-test-run-nix-grpc-store-main> machine # [   24.468903] systemd[1]: Started SSH Daemon.1018vm-test-run-nix-grpc-store-main> machine # [   24.476910] systemd-vconsole-setup[761]: Configuration of first virtual console was skipped, ignoring remaining ones.1019vm-test-run-nix-grpc-store-main> machine # [   24.488442] systemd[1]: Finished Virtual Console Setup.1020vm-test-run-nix-grpc-store-main> machine # [   24.580709] nix-grpc-daemon[772]: ts=2026-11-12T08:47:44Z level=info event=oidc_provider name=mock issuer=http://127.0.0.1:8080/oidc1021vm-test-run-nix-grpc-store-main> machine # [   24.583156] nix-grpc-daemon[773]: ts=2026-11-12T08:47:44Z level=info event=roles builder=1 scheduler=1 scheduler_addr="" advertise=127.0.0.1:50053 niks3="" max_jobs=21022vm-test-run-nix-grpc-store-main> machine # [   24.586486] nix-grpc-daemon[772]: ts=2026-11-12T08:47:44Z level=info event=roles builder=1 scheduler=1 scheduler_addr="" advertise=127.0.0.1:50052 niks3="" max_jobs=21023vm-test-run-nix-grpc-store-main> machine # [   24.642373] nix-grpc-daemon[773]: ts=2026-11-12T08:47:44Z level=info event=startup listen=127.0.0.1:50053 proxy_socket=/nix/var/nix/daemon-socket/socket1024vm-test-run-nix-grpc-store-main> machine # [   24.645094] nix-grpc-daemon[772]: ts=2026-11-12T08:47:44Z level=info event=startup listen=127.0.0.1:50052 proxy_socket=/nix/var/nix/daemon-socket/socket1025vm-test-run-nix-grpc-store-main> machine # [   24.647423] nix-grpc-daemon[772]: ts=2026-11-12T08:47:44Z level=info event=worker_hello addr=127.0.0.1:50052 systems=aarch64-linux max_jobs=2 running=01026vm-test-run-nix-grpc-store-main> machine # [   24.649631] nix-grpc-daemon[773]: ts=2026-11-12T08:47:44Z level=info event=worker_hello addr=127.0.0.1:50053 systems=aarch64-linux max_jobs=2 running=01027vm-test-run-nix-grpc-store-main> machine # [   24.657268] sshd-session[781]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it1028vm-test-run-nix-grpc-store-main> machine # [   24.667126] sshd-session[781]: Accepted none for root from UNKNOWN port 65535 ssh21029vm-test-run-nix-grpc-store-main> machine # [   24.680057] sshd-session[781]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)1030vm-test-run-nix-grpc-store-main> machine # [   24.706416] systemd[1]: Created slice Slice /user/0.1031vm-test-run-nix-grpc-store-main> machine # [   24.713037] systemd[1]: Starting User Runtime Directory /run/user/0...1032vm-test-run-nix-grpc-store-main> machine # [   24.726650] systemd-logind[550]: New session '1' of user 'root' with class 'user' and type 'tty'.1033vm-test-run-nix-grpc-store-main> machine # [   24.768727] systemd[1]: Finished User Runtime Directory /run/user/0.1034vm-test-run-nix-grpc-store-main> machine # [   24.777596] systemd[1]: Starting User Manager for UID 0...1035vm-test-run-nix-grpc-store-main> machine # [   24.822374] (systemd)[814]: pam_unix(systemd-user:session): session opened for user root(uid=0) by (uid=0)1036vm-test-run-nix-grpc-store-main> machine # [   24.829304] systemd-logind[550]: New session '2' of user 'root' with class 'manager-early' and type 'unspecified'.1037vm-test-run-nix-grpc-store-main> machine # [   24.953699] systemd[814]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1038vm-test-run-nix-grpc-store-main> machine # [   25.126205] systemd[814]: Queued start job for default target Main User Target.1039vm-test-run-nix-grpc-store-main> machine # [   25.145479] systemd[814]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1040vm-test-run-nix-grpc-store-main> machine # [   25.148225] systemd[814]: Created slice User Application Slice.1041vm-test-run-nix-grpc-store-main> machine # [   25.149684] systemd[814]: Started Daily Cleanup of User's Temporary Directories.1042vm-test-run-nix-grpc-store-main> machine # [   25.151280] systemd[814]: Reached target Paths.1043vm-test-run-nix-grpc-store-main> machine # [   25.154339] systemd[814]: Reached target Timers.1044vm-test-run-nix-grpc-store-main> machine # [   25.155749] systemd[814]: Starting D-Bus User Message Bus Socket...1045vm-test-run-nix-grpc-store-main> machine # [   25.160052] systemd[814]: Starting Create User Files and Directories...1046vm-test-run-nix-grpc-store-main> machine # [   25.209421] systemd[814]: Finished Create User Files and Directories.1047vm-test-run-nix-grpc-store-main> machine # [   25.257787] systemd[814]: Listening on D-Bus User Message Bus Socket.1048vm-test-run-nix-grpc-store-main> machine # [   25.260773] systemd[814]: Reached target Sockets.1049vm-test-run-nix-grpc-store-main> machine # [   25.261842] systemd[814]: Reached target Basic System.1050vm-test-run-nix-grpc-store-main> machine # [   25.263182] systemd[814]: Run user-specific NixOS activation skipped, unmet condition check ConditionUser=!@system1051vm-test-run-nix-grpc-store-main> machine # [   25.264953] systemd[814]: Reached target Main User Target.1052vm-test-run-nix-grpc-store-main> machine # [   25.265842] systemd[814]: Startup finished in 404ms.1053vm-test-run-nix-grpc-store-main> machine # [   25.267437] systemd[1]: Started User Manager for UID 0.1054vm-test-run-nix-grpc-store-main> machine # [   25.273565] systemd[1]: Started Session 1 of User root.1055vm-test-run-nix-grpc-store-main> machine # [   25.295141] sshd-session[827]: Received disconnect from UNKNOWN port 65535:11: disconnected by user1056vm-test-run-nix-grpc-store-main> machine # [   25.299571] sshd-session[827]: Disconnected from user root UNKNOWN port 655351057vm-test-run-nix-grpc-store-main> machine # [   25.300830] sshd-session[781]: pam_unix(sshd:session): session closed for user root1058vm-test-run-nix-grpc-store-main> machine # [   25.301991] systemd[1]: sshd-vsock@0-1-3:22-2:0.service: Deactivated successfully.1059vm-test-run-nix-grpc-store-main> machine # [   25.306047] systemd[1]: session-1.scope: Deactivated successfully.1060vm-test-run-nix-grpc-store-main> machine # [   25.309580] systemd-logind[550]: Session 1 logged out. Waiting for processes to exit.1061vm-test-run-nix-grpc-store-main> machine # [   25.311426] systemd-logind[550]: Removed session 1.1062vm-test-run-nix-grpc-store-main> machine # [   25.895905] dhcpcd[722]: eth0: soliciting an IPv6 router1063vm-test-run-nix-grpc-store-main> machine # [   25.896358] dhcpcd[722]: eth0: Router Advertisement from fe80::21064vm-test-run-nix-grpc-store-main> machine # [   25.896479] dhcpcd[722]: eth0: adding address fec0::5054:ff:fe12:3456/641065vm-test-run-nix-grpc-store-main> machine # [   25.901057] dhcpcd[722]: eth0: adding route to fec0::/641066vm-test-run-nix-grpc-store-main> machine # [   25.902333] dhcpcd[722]: eth0: adding default route via fe80::21067vm-test-run-nix-grpc-store-main> machine # [   28.181167] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.1068vm-test-run-nix-grpc-store-main> machine # [   28.186838] systemd[1]: Started SSH per-connection Daemon (vsock:2:1).1069vm-test-run-nix-grpc-store-main> machine # [   28.300154] sshd-session[838]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it1070vm-test-run-nix-grpc-store-main> machine # [   28.310256] sshd-session[838]: Accepted none for root from UNKNOWN port 65535 ssh21071vm-test-run-nix-grpc-store-main> machine # [   28.321723] sshd-session[838]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)1072vm-test-run-nix-grpc-store-main> machine # [   28.337294] systemd-logind[550]: New session '3' of user 'root' with class 'user' and type 'tty'.1073vm-test-run-nix-grpc-store-main> machine # [   28.348121] systemd[1]: Started Session 3 of User root.1074vm-test-run-nix-grpc-store-main> machine # [   28.404106] sshd-session[844]: Received disconnect from UNKNOWN port 65535:11: disconnected by user1075vm-test-run-nix-grpc-store-main> machine # [   28.406305] sshd-session[844]: Disconnected from user root UNKNOWN port 655351076vm-test-run-nix-grpc-store-main> machine # [   28.408746] sshd-session[838]: pam_unix(sshd:session): session closed for user root1077vm-test-run-nix-grpc-store-main> machine # [   28.414497] systemd[1]: sshd-vsock@1-2-3:22-2:1.service: Deactivated successfully.1078vm-test-run-nix-grpc-store-main> machine # [   28.420172] systemd[1]: session-3.scope: Deactivated successfully.1079vm-test-run-nix-grpc-store-main> machine # [   28.423225] systemd-logind[550]: Session 3 logged out. Waiting for processes to exit.1080vm-test-run-nix-grpc-store-main> machine # [   28.427287] systemd-logind[550]: Removed session 3.1081vm-test-run-nix-grpc-store-main> machine # [   29.041085] dhcpcd[722]: eth0: leased 10.0.2.15 for 86400 seconds1082vm-test-run-nix-grpc-store-main> machine # [   29.042925] dhcpcd[722]: eth0: adding route to 10.0.2.0/241083vm-test-run-nix-grpc-store-main> machine # [   29.044410] dhcpcd[722]: eth0: adding default route via 10.0.2.21084vm-test-run-nix-grpc-store-main> machine # [   29.192775] systemd[1]: Started DHCP Client.1085vm-test-run-nix-grpc-store-main> machine # [   29.194056] systemd[1]: Reached target Network is Online.1086vm-test-run-nix-grpc-store-main> machine # [   29.207790] systemd[1]: Started Envoy reverse proxy.1087vm-test-run-nix-grpc-store-main> machine # [   29.210851] systemd[1]: Reached target Multi-User System.1088vm-test-run-nix-grpc-store-main> machine # [   29.211859] systemd[1]: Startup finished in 12.007s (kernel) + 4.467s (initrd) + 12.734s (userspace) = 29.208s.1089vm-test-run-nix-grpc-store-main> machine # [   29.997708] envoy[904]: [2026-11-12 08:47:49.582][904][warning][misc] [source/server/cgroup_cpu_util.cc:253] Cgroup path /system.slice/envoy.service is outside mount root /system.slice/envoy.service/memory.pressure1090vm-test-run-nix-grpc-store-main> machine # [   30.020572] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:463] initializing epoch 0 (base id=0, hot restart version=11.120)1091vm-test-run-nix-grpc-store-main> machine # [   30.024335] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:465] statically linked extensions:1092vm-test-run-nix-grpc-store-main> machine # [   30.026911] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.http.stateful_session: envoy.http.stateful_session.cookie, envoy.http.stateful_session.envelope, envoy.http.stateful_session.header1093vm-test-run-nix-grpc-store-main> machine # [   30.030614] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.network.dns_resolver: envoy.network.dns_resolver.cares, envoy.network.dns_resolver.getaddrinfo, envoy.network.dns_resolver.hickory1094vm-test-run-nix-grpc-store-main> machine # [   30.035010] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.access_loggers.extension_filters: envoy.access_loggers.extension_filters.cel, envoy.access_loggers.extension_filters.process_ratelimit1095vm-test-run-nix-grpc-store-main> machine # [   30.038633] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.tls_handshakers: envoy.tls.handshakers.dynamic_modules1096vm-test-run-nix-grpc-store-main> machine # [   30.041158] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.http.ai_filters: envoy.http.ai_filters.request_info, envoy.http.ai_filters.schema_validation, envoy.http.ai_filters.transcoder1097vm-test-run-nix-grpc-store-main> machine # [   30.044368] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.matching.network.input: envoy.matching.inputs.application_protocol, envoy.matching.inputs.destination_ip, envoy.matching.inputs.destination_port, envoy.matching.inputs.direct_source_ip, envoy.matching.inputs.dns_san, envoy.matching.inputs.filter_state, envoy.matching.inputs.network_namespace, envoy.matching.inputs.server_name, envoy.matching.inputs.source_ip, envoy.matching.inputs.source_port, envoy.matching.inputs.source_type, envoy.matching.inputs.subject, envoy.matching.inputs.transport_protocol, envoy.matching.inputs.uri_san1098vm-test-run-nix-grpc-store-main> machine # [   30.053491] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.thrift_proxy.filters: envoy.filters.thrift.header_to_metadata, envoy.filters.thrift.payload_to_metadata, envoy.filters.thrift.rate_limit, envoy.filters.thrift.router1099vm-test-run-nix-grpc-store-main> machine # [   30.057349] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.tls.cert_validator: envoy.tls.cert_validator.default, envoy.tls.cert_validator.dynamic_modules, envoy.tls.cert_validator.spiffe1100vm-test-run-nix-grpc-store-main> machine # [   30.060565] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.tls.upstream_certificate_mappers: envoy.tls.certificate_mappers.static_name, envoy.tls.upstream_certificate_mappers.filter_state_override1101vm-test-run-nix-grpc-store-main> machine # [   30.065610] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.matching.action: envoy.matching.action.transport_socket.name, envoy.matching.actions.format_string1102vm-test-run-nix-grpc-store-main> machine # [   30.069309] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.health_checkers: envoy.health_checkers.dynamic_modules, envoy.health_checkers.grpc, envoy.health_checkers.http, envoy.health_checkers.redis, envoy.health_checkers.tcp, envoy.health_checkers.thrift, envoy.health_checkers.udp1103vm-test-run-nix-grpc-store-main> machine # [   30.074853] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.matching.generic_proxy_request_input.input: envoy.matching.generic_proxy.input.host, envoy.matching.generic_proxy.input.method, envoy.matching.generic_proxy.input.path, envoy.matching.generic_proxy.input.property, envoy.matching.generic_proxy.input.request, envoy.matching.generic_proxy.input.service1104vm-test-run-nix-grpc-store-main> machine # [   30.081956] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.quic.client_packet_writer: envoy.quic.packet_writer.default1105vm-test-run-nix-grpc-store-main> machine # [   30.084397] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.filters.udp_listener: envoy.filters.udp.dns_filter, envoy.filters.udp_listener.dynamic_modules, envoy.filters.udp_listener.udp_proxy1106vm-test-run-nix-grpc-store-main> machine # [   30.087360] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.route_config_update_requester: envoy.route_config_update_requester.default1107vm-test-run-nix-grpc-store-main> machine # [   30.089733] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.grpc_credentials: envoy.grpc_credentials.default, envoy.grpc_credentials.file_based_metadata1108vm-test-run-nix-grpc-store-main> machine # [   30.092415] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.matching.http.input: envoy.matching.inputs.cel_data_input, envoy.matching.inputs.destination_ip, envoy.matching.inputs.destination_port, envoy.matching.inputs.direct_source_ip, envoy.matching.inputs.dns_san, envoy.matching.inputs.dynamic_metadata, envoy.matching.inputs.dynamic_module_data_input, envoy.matching.inputs.dynamic_module_string_data_input, envoy.matching.inputs.filter_state, envoy.matching.inputs.local_reply, envoy.matching.inputs.network_namespace, envoy.matching.inputs.request_headers, envoy.matching.inputs.request_trailers, envoy.matching.inputs.response_headers, envoy.matching.inputs.response_trailers, envoy.matching.inputs.server_name, envoy.matching.inputs.source_ip, envoy.matching.inputs.source_port, envoy.matching.inputs.source_type, envoy.matching.inputs.status_code_class_input, envoy.matching.inputs.status_code_input, envoy.matching.inputs.subject, envoy.matching.inputs.uri_san, query_params1109vm-test-run-nix-grpc-store-main> machine # [   30.105028] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.http.injected_credentials: envoy.http.injected_credentials.generic, envoy.http.injected_credentials.oauth21110vm-test-run-nix-grpc-store-main> machine # [   30.107637] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.filters.upstream_network: envoy.filters.upstream_network.reverse_tunnel_lifecycle1111vm-test-run-nix-grpc-store-main> machine # [   30.109977] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.http.ext_proc.response_processors: envoy.extensions.http.ext_proc.save_processing_response1112vm-test-run-nix-grpc-store-main> machine # [   30.112320] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.http.early_header_mutation: envoy.http.early_header_mutation.dynamic_modules, envoy.http.early_header_mutation.header_mutation1113vm-test-run-nix-grpc-store-main> machine # [   30.115046] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.generic_proxy.filters: envoy.filters.generic.router1114vm-test-run-nix-grpc-store-main> machine # [   30.117013] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.regex_engines: envoy.regex_engines.google_re21115vm-test-run-nix-grpc-store-main> machine # [   30.119048] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.guarddog_actions: envoy.watchdog.abort_action, envoy.watchdog.backtrace_action, envoy.watchdog.profile_action1116vm-test-run-nix-grpc-store-main> machine # [   30.121723] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.access_loggers: envoy.access_loggers.dynamic_modules, envoy.access_loggers.file, envoy.access_loggers.fluentd, envoy.access_loggers.http_grpc, envoy.access_loggers.open_telemetry, envoy.access_loggers.stats, envoy.access_loggers.stderr, envoy.access_loggers.stdout, envoy.access_loggers.tcp_grpc, envoy.access_loggers.wasm, envoy.file_access_log, envoy.fluentd_access_log, envoy.http_grpc_access_log, envoy.open_telemetry_access_log, envoy.stderr_access_log, envoy.stdout_access_log, envoy.tcp_grpc_access_log, envoy.wasm_access_log1117vm-test-run-nix-grpc-store-main> machine # [   30.129223] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.bootstrap: envoy.bootstrap.dynamic_modules, envoy.bootstrap.internal_listener, envoy.bootstrap.reverse_tunnel.downstream_socket_interface, envoy.bootstrap.reverse_tunnel.upstream_socket_interface, envoy.bootstrap.wasm, envoy.extensions.network.socket_interface.default_socket_interface, envoy.extensions.network.socket_interface.sockmap1118vm-test-run-nix-grpc-store-main> machine # [   30.134503] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.tls.certificate_mappers: envoy.tls.certificate_mappers.sni, envoy.tls.certificate_mappers.static_name1119vm-test-run-nix-grpc-store-main> machine # [   30.137094] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.quic.connection_id_generator: envoy.quic.connection_id_generator.quic_lb, envoy.quic.deterministic_connection_id_generator1120vm-test-run-nix-grpc-store-main> machine # [   30.139808] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.http.header_validators: envoy.http.header_validators.envoy_default1121vm-test-run-nix-grpc-store-main> machine # [   30.142140] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.compression.decompressor: envoy.compression.brotli.decompressor, envoy.compression.gzip.decompressor, envoy.compression.zstd.decompressor1122vm-test-run-nix-grpc-store-main> machine # [   30.145256] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.dubbo_proxy.serializers: dubbo.hessian21123vm-test-run-nix-grpc-store-main> machine # [   30.147067] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.http.original_ip_detection: envoy.http.original_ip_detection.custom_header, envoy.http.original_ip_detection.xff1124vm-test-run-nix-grpc-store-main> machine # [   30.149715] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.dubbo_proxy.protocols: dubbo1125vm-test-run-nix-grpc-store-main> machine # [   30.151429] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.connection_handler: envoy.connection_handler.default1126vm-test-run-nix-grpc-store-main> machine # [   30.153368] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.matching.common_inputs: envoy.matching.common_inputs.environment_variable1127vm-test-run-nix-grpc-store-main> machine # [   30.155449] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.srds_factory: envoy.srds_factory.default1128vm-test-run-nix-grpc-store-main> machine # [   30.157266] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.rate_limit_descriptors: envoy.rate_limit_descriptors.expr, envoy.rate_limit_descriptors.jwt_claim1129vm-test-run-nix-grpc-store-main> machine # [   30.159808] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.http.custom_response: envoy.extensions.http.custom_response.local_response_policy, envoy.extensions.http.custom_response.redirect_policy1130vm-test-run-nix-grpc-store-main> machine # [   30.162956] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.filters.udp.session: envoy.filters.udp.session.dynamic_forward_proxy, envoy.filters.udp.session.ext_authz, envoy.filters.udp.session.http_capsule1131vm-test-run-nix-grpc-store-main> machine # [   30.166072] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.tls.certificate_selectors: envoy.tls.certificate_selectors.on_demand_secret1132vm-test-run-nix-grpc-store-main> machine # [   30.168813] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.filters.network: envoy.echo, envoy.ext_authz, envoy.filters.network.connection_limit, envoy.filters.network.direct_response, envoy.filters.network.dubbo_proxy, envoy.filters.network.dynamic_modules, envoy.filters.network.echo, envoy.filters.network.ext_authz, envoy.filters.network.ext_proc, envoy.filters.network.generic_proxy, envoy.filters.network.geoip, envoy.filters.network.http_connection_manager, envoy.filters.network.local_ratelimit, envoy.filters.network.mongo_proxy, envoy.filters.network.ratelimit, envoy.filters.network.rbac, envoy.filters.network.redis_proxy, envoy.filters.network.reverse_tunnel, envoy.filters.network.reverse_tunnel_drain_aware_http_connection_manager, envoy.filters.network.set_filter_state, envoy.filters.network.sni_cluster, envoy.filters.network.sni_dynamic_forward_proxy, envoy.filters.network.tcp_bandwidth_limit, envoy.filters.network.tcp_proxy, envoy.filters.network.thrift_proxy, envoy.filters.network.wasm, envoy.filters.network.zookeeper_proxy, envoy.http_connection_manager, envoy.mongo_proxy, envoy.ratelimit, envoy.redis_proxy, envoy.tcp_proxy1133vm-test-run-nix-grpc-store-main> machine # [   30.182865] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.resource_monitors: envoy.resource_monitors.cgroup_memory, envoy.resource_monitors.cpu_utilization, envoy.resource_monitors.fixed_heap, envoy.resource_monitors.injected_resource1134vm-test-run-nix-grpc-store-main> machine # [   30.187025] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.dubbo_proxy.filters: envoy.filters.dubbo.router1135vm-test-run-nix-grpc-store-main> machine # [   30.188986] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.resolvers: envoy.ip, envoy.resolvers.reverse_connection1136vm-test-run-nix-grpc-store-main> machine # [   30.190947] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.router.route_specifiers: envoy.router.route_specifiers.dynamic_modules1137vm-test-run-nix-grpc-store-main> machine # [   30.193126] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.compression.compressor: envoy.compression.brotli.compressor, envoy.compression.gzip.compressor, envoy.compression.zstd.compressor1138vm-test-run-nix-grpc-store-main> machine # [   30.195915] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.generic_proxy.codecs: envoy.generic_proxy.codecs.dubbo, envoy.generic_proxy.codecs.http11139vm-test-run-nix-grpc-store-main> machine # [   30.198332] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.tls.upstream_certificate_selectors: envoy.tls.certificate_selectors.on_demand_secret1140vm-test-run-nix-grpc-store-main> machine # [   30.200726] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.clusters: envoy.cluster.dns, envoy.cluster.eds, envoy.cluster.logical_dns, envoy.cluster.original_dst, envoy.cluster.static, envoy.cluster.strict_dns, envoy.clusters.aggregate, envoy.clusters.composite, envoy.clusters.dynamic_forward_proxy, envoy.clusters.dynamic_modules, envoy.clusters.mcp_multicluster, envoy.clusters.redis, envoy.clusters.reverse_connection1141vm-test-run-nix-grpc-store-main> machine # [   30.206340] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.quic.server_preferred_address: quic.server_preferred_address.datasource, quic.server_preferred_address.fixed1142vm-test-run-nix-grpc-store-main> machine # [   30.209009] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.tracers.opentelemetry.samplers: envoy.tracers.opentelemetry.samplers.always_on, envoy.tracers.opentelemetry.samplers.cel, envoy.tracers.opentelemetry.samplers.dynatrace, envoy.tracers.opentelemetry.samplers.parent_based, envoy.tracers.opentelemetry.samplers.trace_id_ratio_based1143vm-test-run-nix-grpc-store-main> machine # [   30.213386] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.matching.stat_tag_matching_data.input: stat_tag_value_input1144vm-test-run-nix-grpc-store-main> machine # [   30.215399] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.content_parsers: envoy.content_parsers.json1145vm-test-run-nix-grpc-store-main> machine # [   30.217245] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.config.validators: envoy.config.validators.dynamic_modules, envoy.config.validators.minimum_clusters, envoy.config.validators.minimum_clusters_validator1146vm-test-run-nix-grpc-store-main> machine # [   30.220264] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.queue_policy: envoy.queue_policy.fifo1147vm-test-run-nix-grpc-store-main> machine # [   30.221975] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.quic.connection_debug_visitor: envoy.quic.connection_debug_visitor.basic, envoy.quic.connection_debug_visitor.quic_stats1148vm-test-run-nix-grpc-store-main> machine # [   30.224819] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.upstream_options: envoy.extensions.upstreams.http.reverse_tunnel.v3.ReverseTunnelUpstreamCodecOptions, envoy.extensions.upstreams.http.v3.HttpProtocolOptions, envoy.extensions.upstreams.tcp.v3.TcpProtocolOptions, envoy.upstreams.http.http_protocol_options, envoy.upstreams.tcp.tcp_protocol_options1149vm-test-run-nix-grpc-store-main> machine # [   30.229407] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.transport_sockets.downstream: envoy.transport_sockets.alts, envoy.transport_sockets.dynamic_modules, envoy.transport_sockets.quic, envoy.transport_sockets.raw_buffer, envoy.transport_sockets.starttls, envoy.transport_sockets.tap, envoy.transport_sockets.tcp_stats, envoy.transport_sockets.tls, raw_buffer, starttls, tls1150vm-test-run-nix-grpc-store-main> machine # [   30.234489] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.load_balancing_policies: envoy.load_balancing_policies.client_side_weighted_round_robin, envoy.load_balancing_policies.cluster_provided, envoy.load_balancing_policies.dynamic_modules, envoy.load_balancing_policies.least_request, envoy.load_balancing_policies.load_aware_locality, envoy.load_balancing_policies.maglev, envoy.load_balancing_policies.override_host, envoy.load_balancing_policies.random, envoy.load_balancing_policies.ring_hash, envoy.load_balancing_policies.round_robin, envoy.load_balancing_policies.subset, envoy.load_balancing_policies.wrr_locality1151vm-test-run-nix-grpc-store-main> machine # [   30.242428] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.formatter: envoy.formatter.cel, envoy.formatter.dynamic_modules, envoy.formatter.file_content, envoy.formatter.generic_secret, envoy.formatter.metadata, envoy.formatter.req_without_query1152vm-test-run-nix-grpc-store-main> machine # [   30.246022] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.filters.http.upstream: envoy.buffer, envoy.ext_proc, envoy.extensions.filters.http.dynamic_modules, envoy.filters.http.admission_control, envoy.filters.http.ai_protocol_manager, envoy.filters.http.aws_lambda, envoy.filters.http.aws_request_signing, envoy.filters.http.body_size_limit, envoy.filters.http.buffer, envoy.filters.http.composite, envoy.filters.http.compressor, envoy.filters.http.credential_injector, envoy.filters.http.ext_proc, envoy.filters.http.header_mutation, envoy.filters.http.lua, envoy.filters.http.match_delegate, envoy.filters.http.upstream_codec, envoy.filters.http.upstream_rbac, envoy.filters.http.wasm1153vm-test-run-nix-grpc-store-main> machine # [   30.254750] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.transport_sockets.upstream: envoy.transport_sockets.alts, envoy.transport_sockets.dynamic_modules, envoy.transport_sockets.http_11_proxy, envoy.transport_sockets.internal_upstream, envoy.transport_sockets.quic, envoy.transport_sockets.raw_buffer, envoy.transport_sockets.starttls, envoy.transport_sockets.tap, envoy.transport_sockets.tcp_stats, envoy.transport_sockets.tls, envoy.transport_sockets.upstream_proxy_protocol, raw_buffer, starttls, tls1154vm-test-run-nix-grpc-store-main> machine # [   30.261289] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.route.early_data_policy: envoy.route.early_data_policy.default1155vm-test-run-nix-grpc-store-main> machine # [   30.263296] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   quic.http_server_connection: quic.http_server_connection.default1156vm-test-run-nix-grpc-store-main> machine # [   30.265273] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.health_check.event_sinks: envoy.health_check.event_sink.file1157vm-test-run-nix-grpc-store-main> machine # [   30.267219] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.retry_priorities: envoy.retry_priorities.previous_priorities1158vm-test-run-nix-grpc-store-main> machine # [   30.270608] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.built_in_formatters: envoy.built_in_formatters.cel, envoy.built_in_formatters.http.default, envoy.built_in_formatters.metadata, envoy.built_in_formatters.stream_info.default, envoy.built_in_formatters.xfcc_value1159vm-test-run-nix-grpc-store-main> machine # [   30.274419] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.rbac.matchers: envoy.rbac.matchers.upstream_ip_port1160vm-test-run-nix-grpc-store-main> machine # [   30.276351] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.filters.listener: envoy.filters.listener.dynamic_modules, envoy.filters.listener.http_inspector, envoy.filters.listener.local_ratelimit, envoy.filters.listener.original_dst, envoy.filters.listener.original_src, envoy.filters.listener.proxy_protocol, envoy.filters.listener.set_filter_state, envoy.filters.listener.tls_inspector, envoy.listener.http_inspector, envoy.listener.original_dst, envoy.listener.original_src, envoy.listener.proxy_protocol, envoy.listener.tls_inspector1161vm-test-run-nix-grpc-store-main> machine # [   30.285631] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.udp_packet_writer: envoy.udp_packet_writer.default, envoy.udp_packet_writer.gso1162vm-test-run-nix-grpc-store-main> machine # [   30.288082] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.matching.stat_matching_data.input: stat_full_name_match_input1163vm-test-run-nix-grpc-store-main> machine # [   30.290066] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.geoip_providers: envoy.geoip_providers.maxmind1164vm-test-run-nix-grpc-store-main> machine # [   30.291937] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.http.ext_proc.processing_request_modifiers: envoy.extensions.http.ext_proc.mapped_attribute_builder1165vm-test-run-nix-grpc-store-main> machine # [   30.294484] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.retry_host_predicates: envoy.retry_host_predicates.omit_canary_hosts, envoy.retry_host_predicates.omit_host_metadata, envoy.retry_host_predicates.previous_hosts1166vm-test-run-nix-grpc-store-main> machine # [   30.297653] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.rbac.principals: envoy.rbac.principals.mtls_authenticated1167vm-test-run-nix-grpc-store-main> machine # [   30.299715] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.matching.transport_socket.input: envoy.matching.inputs.endpoint_metadata, envoy.matching.inputs.locality_metadata, envoy.matching.inputs.transport_socket_filter_state1168vm-test-run-nix-grpc-store-main> machine # [   30.303172] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.http.cache_v2: envoy.extensions.http.cache_v2.file_system_http_cache, envoy.extensions.http.cache_v2.simple1169vm-test-run-nix-grpc-store-main> machine # [   30.305868] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.upstreams: envoy.filters.connection_pools.tcp.generic1170vm-test-run-nix-grpc-store-main> machine # [   30.307774] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.http.forward_client_cert_details: forward_client_cert1171vm-test-run-nix-grpc-store-main> machine # [   30.309776] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.upstream.local_address_selector: envoy.upstream.local_address_selector.default_local_address_selector, envoy.upstream.local_address_selector.filter_state_override1172vm-test-run-nix-grpc-store-main> machine # [   30.313050] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.path.rewrite: envoy.path.rewrite.uri_template.uri_template_rewriter1173vm-test-run-nix-grpc-store-main> machine # [   30.315432] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   filter_state.object: envoy.ai.llm_protocol.request, envoy.ai.model.request, envoy.bool, envoy.filters.listener.original_dst.local_ip, envoy.filters.listener.original_dst.remote_ip, envoy.hashable_string, envoy.network.application_protocols, envoy.network.ip, envoy.network.network_namespace, envoy.network.transport_socket.http_11_proxy.info, envoy.network.transport_socket.original_dst_address, envoy.network.upstream_server_name, envoy.network.upstream_subject_alt_names, envoy.ratelimit.hits_addend, envoy.router.debug_config, envoy.string, envoy.tcp_proxy.cluster, envoy.tcp_proxy.disable_tunneling, envoy.tcp_proxy.per_connection_idle_timeout_ms, envoy.upstream.dynamic_host, envoy.upstream.dynamic_port1174vm-test-run-nix-grpc-store-main> machine # [   30.328580] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.tracers: envoy.tracers.datadog, envoy.tracers.dynamic_modules, envoy.tracers.fluentd, envoy.tracers.opentelemetry, envoy.tracers.skywalking, envoy.tracers.xray, envoy.tracers.zipkin, envoy.zipkin1175vm-test-run-nix-grpc-store-main> machine # [   30.334260] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.string_matcher: envoy.string_matcher.lua1176vm-test-run-nix-grpc-store-main> machine # [   30.337079] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.thrift_proxy.transports: auto, framed, header, unframed1177vm-test-run-nix-grpc-store-main> machine # [   30.339520] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.quic.server.crypto_stream: envoy.quic.crypto_stream.server.quiche1178vm-test-run-nix-grpc-store-main> machine # [   30.342286] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.request_id: envoy.request_id.uuid1179vm-test-run-nix-grpc-store-main> machine # [   30.344074] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.http.cache: envoy.extensions.http.cache.file_system_http_cache, envoy.extensions.http.cache.simple1180vm-test-run-nix-grpc-store-main> machine # [   30.346392] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.rds_factory: envoy.rds_factory.default1181vm-test-run-nix-grpc-store-main> machine # [   30.348148] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.matching.input_matchers: envoy.matching.input_matchers.generic_request_matcher, envoy.matching.matchers.cel_matcher, envoy.matching.matchers.consistent_hashing, envoy.matching.matchers.dynamic_modules, envoy.matching.matchers.ip, envoy.matching.matchers.metadata_matcher, envoy.matching.matchers.runtime_fraction1182vm-test-run-nix-grpc-store-main> machine # [   30.353099] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.matching.http.custom_matchers: envoy.matching.custom_matchers.domain_matcher, envoy.matching.custom_matchers.ip_range_matcher1183vm-test-run-nix-grpc-store-main> machine # [   30.355740] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   network.connection.client: default, envoy_internal1184vm-test-run-nix-grpc-store-main> machine # [   30.357607] envoy[904]: [2026-11-12 08:47:49.607][904][info][main] [source/server/server.cc:467]   envoy.listener_manager_impl: envoy.listener_manager_impl.default, envoy.listener_manager_impl.validation1185vm-test-run-nix-grpc-store-main> machine # [   30.360090] envoy[904]: [2026-11-12 08:47:49.608][904][info][main] [source/server/server.cc:467]   envoy.filters.http: envoy.bandwidth_limit, envoy.buffer, envoy.cors, envoy.csrf, envoy.ext_authz, envoy.ext_proc, envoy.extensions.filters.http.dynamic_modules, envoy.fault, envoy.filters.http.a2a, envoy.filters.http.adaptive_concurrency, envoy.filters.http.admission_control, envoy.filters.http.ai_protocol_manager, envoy.filters.http.alternate_protocols_cache, envoy.filters.http.api_key_auth, envoy.filters.http.aws_eventstream_parser, envoy.filters.http.aws_lambda, envoy.filters.http.aws_request_signing, envoy.filters.http.bandwidth_limit, envoy.filters.http.bandwidth_share, envoy.filters.http.basic_auth, envoy.filters.http.body_size_limit, envoy.filters.http.buffer, envoy.filters.http.cache, envoy.filters.http.cache_v2, envoy.filters.http.cdn_loop, envoy.filters.http.composite, envoy.filters.http.compressor, envoy.filters.http.connect_grpc_bridge, envoy.filters.http.cors, envoy.filters.http.credential_injector, envoy.filters.http.csrf, envoy.filters.http.custom_response, envoy.filters.http.decompressor, envoy.filters.http.dynamic_forward_proxy, envoy.filters.http.ext_authz, envoy.filters.http.ext_proc, envoy.filters.http.fault, envoy.filters.http.file_server, envoy.filters.http.file_system_buffer, envoy.filters.http.filter_chain, envoy.filters.http.gcp_authn, envoy.filters.http.geoip, envoy.filters.http.grpc_field_extraction, envoy.filters.http.grpc_http1_bridge, envoy.filters.http.grpc_http1_reverse_bridge, envoy.filters.http.grpc_json_reverse_transcoder, envoy.filters.http.grpc_json_transcoder, envoy.filters.http.grpc_stats, envoy.filters.http.grpc_web, envoy.filters.http.header_mutation, envoy.filters.http.header_to_metadata, envoy.filters.http.health_check, envoy.filters.http.ip_tagging, envoy.filters.http.json_to_metadata, envoy.filters.http.jwt_authn, envoy.filters.http.local_ratelimit, envoy.filters.http.lua, envoy.filters.http.match_delegate, envoy.filters.http.mcp, envoy.filters.http.mcp_json_rest_bridge, envoy.filters.http.mcp_router, envoy.filters.http.oauth2, envoy.filters.http.on_demand, envoy.filters.http.original_src, envoy.filters.http.proto_api_scrubber, envoy.filters.http.proto_message_extraction, envoy.filters.http.rate_limit_quota, envoy.filters.http.ratelimit, envoy.filters.http.rbac, envoy.filters.http.router, envoy.filters.http.set_filter_state, envoy.filters.http.set_metadata, envoy.filters.http.sse_to_metadata, envoy.filters.http.stateful_session, envoy.filters.http.tap, envoy.filters.http.thrift_to_metadata, envoy.filters.http.transform, envoy.filters.http.wasm, envoy.geoip, envoy.grpc_http1_bridge, envoy.grpc_json_transcoder, envoy.grpc_web, envoy.health_check, envoy.ip_tagging, envoy.local_rate_limit, envoy.lua, envoy.rate_limit, envoy.router1186vm-test-run-nix-grpc-store-main> machine # [   30.393632] envoy[904]: [2026-11-12 08:47:49.608][904][info][main] [source/server/server.cc:467]   envoy.config_subscription: envoy.config_subscription.ads, envoy.config_subscription.ads_collection, envoy.config_subscription.aggregated_grpc_collection, envoy.config_subscription.delta_grpc, envoy.config_subscription.delta_grpc_collection, envoy.config_subscription.filesystem, envoy.config_subscription.filesystem_collection, envoy.config_subscription.grpc, envoy.config_subscription.rest1187vm-test-run-nix-grpc-store-main> machine # [   30.399827] envoy[904]: [2026-11-12 08:47:49.608][904][info][main] [source/server/server.cc:467]   envoy.router.cluster_specifier_plugin: envoy.router.cluster_specifier_plugin.dynamic_modules, envoy.router.cluster_specifier_plugin.lua, envoy.router.cluster_specifier_plugin.matcher, envoy.router.cluster_specifier_plugin.priority_group1188vm-test-run-nix-grpc-store-main> machine # [   30.404063] envoy[904]: [2026-11-12 08:47:49.608][904][info][main] [source/server/server.cc:467]   envoy.ssl.server_context_factory: envoy.ssl.server_context_factory.default1189vm-test-run-nix-grpc-store-main> machine # [   30.405975] envoy[904]: [2026-11-12 08:47:49.608][904][info][main] [source/server/server.cc:467]   envoy.stats_sinks: envoy.dog_statsd, envoy.graphite_statsd, envoy.metrics_service, envoy.open_telemetry_stat_sink, envoy.stat_sinks.dog_statsd, envoy.stat_sinks.dynamic_modules, envoy.stat_sinks.graphite_statsd, envoy.stat_sinks.hystrix, envoy.stat_sinks.metrics_service, envoy.stat_sinks.open_telemetry, envoy.stat_sinks.statsd, envoy.stat_sinks.wasm, envoy.statsd1190vm-test-run-nix-grpc-store-main> machine # [   30.411951] envoy[904]: [2026-11-12 08:47:49.608][904][info][main] [source/server/server.cc:467]   envoy.tracers.opentelemetry.resource_detectors: envoy.tracers.opentelemetry.resource_detectors.dynatrace, envoy.tracers.opentelemetry.resource_detectors.environment, envoy.tracers.opentelemetry.resource_detectors.static_config1191vm-test-run-nix-grpc-store-main> machine # [   30.417178] envoy[904]: [2026-11-12 08:47:49.608][904][info][main] [source/server/server.cc:467]   envoy.wasm.runtime: envoy.wasm.runtime.null, envoy.wasm.runtime.v81192vm-test-run-nix-grpc-store-main> machine # [   30.419839] envoy[904]: [2026-11-12 08:47:49.608][904][info][main] [source/server/server.cc:467]   envoy.common.key_value: envoy.key_value.file_based1193vm-test-run-nix-grpc-store-main> machine # [   30.422334] envoy[904]: [2026-11-12 08:47:49.608][904][info][main] [source/server/server.cc:467]   envoy.http.stateful_header_formatters: envoy.http.stateful_header_formatters.dynamic_modules, envoy.http.stateful_header_formatters.preserve_case, preserve_case1194vm-test-run-nix-grpc-store-main> machine # [   30.426527] envoy[904]: [2026-11-12 08:47:49.608][904][info][main] [source/server/server.cc:467]   envoy.matching.network.custom_matchers: envoy.matching.custom_matchers.domain_matcher, envoy.matching.custom_matchers.ip_range_matcher1195vm-test-run-nix-grpc-store-main> machine # [   30.429150] envoy[904]: [2026-11-12 08:47:49.608][904][info][main] [source/server/server.cc:467]   envoy.quic.proof_source: envoy.quic.proof_source.filter_chain1196vm-test-run-nix-grpc-store-main> machine # [   30.431048] envoy[904]: [2026-11-12 08:47:49.608][904][info][main] [source/server/server.cc:467]   envoy.thrift_proxy.protocols: auto, binary, binary/non-strict, compact, twitter1197vm-test-run-nix-grpc-store-main> machine # [   30.433139] envoy[904]: [2026-11-12 08:47:49.608][904][info][main] [source/server/server.cc:467]   envoy.config_mux: envoy.config_mux.delta_grpc_mux_factory, envoy.config_mux.grpc_mux_factory, envoy.config_mux.new_grpc_mux_factory, envoy.config_mux.sotw_grpc_mux_factory1198vm-test-run-nix-grpc-store-main> machine # [   30.436151] envoy[904]: [2026-11-12 08:47:49.608][904][info][main] [source/server/server.cc:467]   envoy.path.match: envoy.path.match.uri_template.uri_template_matcher1199vm-test-run-nix-grpc-store-main> machine # [   30.438145] envoy[904]: [2026-11-12 08:47:49.608][904][info][main] [source/server/server.cc:467]   envoy.internal_redirect_predicates: envoy.internal_redirect_predicates.allow_listed_routes, envoy.internal_redirect_predicates.filter_state, envoy.internal_redirect_predicates.previous_routes, envoy.internal_redirect_predicates.safe_cross_scheme1200vm-test-run-nix-grpc-store-main> machine # [   30.442365] envoy[904]: [2026-11-12 08:47:49.632][904][info][main] [source/server/server.cc:544] HTTP header map info:1201vm-test-run-nix-grpc-store-main> machine # [   30.443875] envoy[904]: [2026-11-12 08:47:49.640][904][info][main] [source/server/server.cc:547]   request header map: 648 bytes: :authority,:method,:path,:protocol,:scheme,accept,accept-encoding,access-control-request-headers,access-control-request-method,access-control-request-private-network,authentication,authorization,cache-control,cdn-loop,connection,content-encoding,content-length,content-type,expect,grpc-accept-encoding,grpc-timeout,if-match,if-modified-since,if-none-match,if-range,if-unmodified-since,keep-alive,origin,pragma,proxy-connection,proxy-status,referer,te,transfer-encoding,upgrade,user-agent,via,x-client-trace-id,x-envoy-attempt-count,x-envoy-decorator-operation,x-envoy-downstream-service-cluster,x-envoy-downstream-service-node,x-envoy-expected-rq-timeout-ms,x-envoy-external-address,x-envoy-force-trace,x-envoy-hedge-on-per-try-timeout,x-envoy-internal,x-envoy-ip-tags,x-envoy-is-timeout-retry,x-envoy-max-retries,x-envoy-original-host,x-envoy-original-path,x-envoy-original-url,x-envoy-retriable-header-names,x-envoy-retriable-status-codes,x-envoy-retry-grpc-on,x-envoy-retry-on,x-envoy-upstream-alt-stat-name,x-envoy-upstream-rq-per-try-timeout-ms,x-envoy-upstream-rq-timeout-alt-response,x-envoy-upstream-rq-timeout-ms,x-envoy-upstream-stream-duration-ms,x-forwarded-client-cert,x-forwarded-for,x-forwarded-host,x-forwarded-port,x-forwarded-proto,x-request-id1202vm-test-run-nix-grpc-store-main> machine # [   30.459903] envoy[904]: [2026-11-12 08:47:49.640][904][info][main] [source/server/server.cc:547]   request trailer map: 104 bytes:1203vm-test-run-nix-grpc-store-main> machine # [   30.461556] envoy[904]: [2026-11-12 08:47:49.640][904][info][main] [source/server/server.cc:547]   response header map: 416 bytes: :status,access-control-allow-credentials,access-control-allow-headers,access-control-allow-methods,access-control-allow-origin,access-control-allow-private-network,access-control-expose-headers,access-control-max-age,age,cache-control,connection,content-encoding,content-length,content-type,date,etag,expires,grpc-message,grpc-status,keep-alive,last-modified,location,proxy-connection,proxy-status,server,transfer-encoding,upgrade,vary,via,x-envoy-attempt-count,x-envoy-decorator-operation,x-envoy-degraded,x-envoy-immediate-health-check-fail,x-envoy-ratelimited,x-envoy-upstream-canary,x-envoy-upstream-healthchecked-cluster,x-envoy-upstream-service-time,x-request-id1204vm-test-run-nix-grpc-store-main> machine # [   30.470917] envoy[904]: [2026-11-12 08:47:49.640][904][info][main] [source/server/server.cc:547]   response trailer map: 128 bytes: grpc-message,grpc-status1205vm-test-run-nix-grpc-store-main> machine # [   30.474338] envoy[904]: [2026-11-12 08:47:49.702][904][info][main] [source/server/server.cc:989] runtime: {}1206vm-test-run-nix-grpc-store-main> machine # [   30.475698] envoy[904]: [2026-11-12 08:47:49.708][904][info][main] [source/server/server.cc:820] No admin address given, so no admin HTTP server started.1207vm-test-run-nix-grpc-store-main> machine # [   30.477639] envoy[904]: [2026-11-12 08:47:49.715][904][info][config] [source/server/configuration_impl.cc:181] loading tracing configuration1208vm-test-run-nix-grpc-store-main> machine # [   30.479399] envoy[904]: [2026-11-12 08:47:49.715][904][info][config] [source/server/configuration_impl.cc:132] loading 0 static secret(s)1209vm-test-run-nix-grpc-store-main> machine # [   30.481128] envoy[904]: [2026-11-12 08:47:49.715][904][info][config] [source/server/configuration_impl.cc:138] loading 1 cluster(s)1210vm-test-run-nix-grpc-store-main> machine # [   30.482727] envoy[904]: [2026-11-12 08:47:49.740][904][info][config] [source/server/configuration_impl.cc:148] loading 1 listener(s)1211vm-test-run-nix-grpc-store-main> machine # [   30.484318] envoy[904]: [2026-11-12 08:47:49.752][904][info][config] [source/server/configuration_impl.cc:164] loading stats configuration1212vm-test-run-nix-grpc-store-main> machine # [   30.485953] envoy[904]: [2026-11-12 08:47:49.752][904][info][runtime] [source/common/runtime/runtime_impl.cc:567] RTDS has finished initialization1213vm-test-run-nix-grpc-store-main> machine # [   30.487752] envoy[904]: [2026-11-12 08:47:49.752][904][info][upstream] [source/common/upstream/cluster_manager_impl.cc:251] cm init: all clusters initialized1214vm-test-run-nix-grpc-store-main> machine # [   30.489738] envoy[904]: [2026-11-12 08:47:49.754][904][warning][main] [source/server/server.cc:1059] There is no configured limit to the number of allowed active downstream connections. Configure a limit in `envoy.resource_monitors.global_downstream_max_connections` resource monitor.1215vm-test-run-nix-grpc-store-main> machine # [   30.493048] envoy[904]: [2026-11-12 08:47:49.754][904][info][main] [source/server/server.cc:1078] all clusters initialized. initializing init manager1216vm-test-run-nix-grpc-store-main> machine # [   30.494776] envoy[904]: [2026-11-12 08:47:49.754][904][info][config] [source/common/listener_manager/listener_manager_impl.cc:1149] all dependencies initialized. starting workers1217vm-test-run-nix-grpc-store-main> machine # [   30.499701] envoy[904]: [2026-11-12 08:47:49.755][904][info][main] [source/server/server.cc:1098] starting main dispatch loop1218vm-test-run-nix-grpc-store-main> machine # [   36.172950] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.1219vm-test-run-nix-grpc-store-main> machine # [   36.180163] systemd[1]: Started SSH per-connection Daemon (vsock:2:2).1220vm-test-run-nix-grpc-store-main> machine # [   36.318107] sshd-session[919]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it1221vm-test-run-nix-grpc-store-main> machine # [   36.348738] sshd-session[919]: Accepted none for root from UNKNOWN port 65535 ssh21222vm-test-run-nix-grpc-store-main> machine # [   36.364264] sshd-session[919]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)1223vm-test-run-nix-grpc-store-main> machine # [   36.378704] systemd-logind[550]: New session '4' of user 'root' with class 'user' and type 'tty'.1224vm-test-run-nix-grpc-store-main> machine # [   36.394342] systemd[1]: Started Session 4 of User root.1225vm-test-run-nix-grpc-store-main> machine # [   36.429300] sshd-session[926]: Received disconnect from UNKNOWN port 65535:11: disconnected by user1226vm-test-run-nix-grpc-store-main> machine # [   36.431522] sshd-session[926]: Disconnected from user root UNKNOWN port 655351227vm-test-run-nix-grpc-store-main> machine # [   36.433117] sshd-session[919]: pam_unix(sshd:session): session closed for user root1228vm-test-run-nix-grpc-store-main> machine # [   36.438689] systemd[1]: sshd-vsock@2-3-3:22-2:2.service: Deactivated successfully.1229vm-test-run-nix-grpc-store-main> machine # [   36.443773] systemd[1]: session-4.scope: Deactivated successfully.1230vm-test-run-nix-grpc-store-main> machine # [   36.446099] systemd[1]: session-4.scope: Consumed 27ms CPU time over 51ms wall clock time, 2.4M memory peak, 112B incoming IP traffic, 164B outgoing IP traffic.1231vm-test-run-nix-grpc-store-main> machine # [   36.448764] systemd-logind[550]: Session 4 logged out. Waiting for processes to exit.1232vm-test-run-nix-grpc-store-main> machine # [   36.450621] systemd-logind[550]: Removed session 4.1233vm-test-run-nix-grpc-store-main> machine # [   36.922231] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.1234vm-test-run-nix-grpc-store-main> machine # [   36.928581] systemd[1]: Started SSH per-connection Daemon (vsock:2:3).1235vm-test-run-nix-grpc-store-main> machine # [   37.063526] sshd-session[931]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it1236vm-test-run-nix-grpc-store-main> machine # [   37.076881] sshd-session[931]: Accepted none for root from UNKNOWN port 65535 ssh21237vm-test-run-nix-grpc-store-main> machine # [   37.093829] sshd-session[931]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)1238vm-test-run-nix-grpc-store-main> machine # [   37.106819] systemd-logind[550]: New session '5' of user 'root' with class 'user' and type 'tty'.1239vm-test-run-nix-grpc-store-main> machine # [   37.129259] systemd[1]: Started Session 5 of User root.1240vm-test-run-nix-grpc-store-main> machine # [   37.183968] sshd-session[937]: Received disconnect from UNKNOWN port 65535:11: disconnected by user1241vm-test-run-nix-grpc-store-main> machine # [   37.187447] sshd-session[937]: Disconnected from user root UNKNOWN port 655351242vm-test-run-nix-grpc-store-main> machine # [   37.189292] sshd-session[931]: pam_unix(sshd:session): session closed for user root1243vm-test-run-nix-grpc-store-main> machine # [   37.192418] systemd[1]: sshd-vsock@3-4-3:22-2:3.service: Deactivated successfully.1244vm-test-run-nix-grpc-store-main> machine # [   37.197828] systemd[1]: session-5.scope: Deactivated successfully.1245vm-test-run-nix-grpc-store-main> machine # [   37.200189] systemd-logind[550]: Session 5 logged out. Waiting for processes to exit.1246vm-test-run-nix-grpc-store-main> machine # [   37.203927] systemd-logind[550]: Removed session 5.1247vm-test-run-nix-grpc-store-main> machine # [   37.351397] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.1248vm-test-run-nix-grpc-store-main> machine # [   37.358650] systemd[1]: Started SSH per-connection Daemon (vsock:2:4).1249vm-test-run-nix-grpc-store-main> machine # [   37.464933] sshd-session[942]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it1250vm-test-run-nix-grpc-store-main> machine # [   37.472670] sshd-session[942]: Accepted none for root from UNKNOWN port 65535 ssh21251vm-test-run-nix-grpc-store-main> machine # [   37.482828] sshd-session[942]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)1252vm-test-run-nix-grpc-store-main> machine # [   37.490975] systemd-logind[550]: New session '6' of user 'root' with class 'user' and type 'tty'.1253vm-test-run-nix-grpc-store-main> machine # [   37.516728] systemd[1]: Started Session 6 of User root.1254vm-test-run-nix-grpc-store-main> machine # [   37.784911] systemd[1]: Started Nix Daemon.1255vm-test-run-nix-grpc-store-main> machine # [   38.023920] nix-daemon[961]: accepted connection from pid 772, user root (trusted)1256vm-test-run-nix-grpc-store-main> machine # [   38.058169] nix-grpc-daemon[772]: warning: unable to download 'https://cache.nixos.org/nix-cache-info': Could not resolve hostname (6) Could not resolve host: cache.nixos.org; retrying in 55 ms (attempt 1/5)1257vm-test-run-nix-grpc-store-main> machine # [   38.119319] nix-grpc-daemon[772]: warning: unable to download 'https://cache.nixos.org/nix-cache-info': Could not resolve hostname (6) Could not resolve host: cache.nixos.org; retrying in 144 ms (attempt 2/5)1258vm-test-run-nix-grpc-store-main> machine # [   38.263415] nix-grpc-daemon[772]: warning: unable to download 'https://cache.nixos.org/nix-cache-info': Could not resolve hostname (6) Could not resolve host: cache.nixos.org; retrying in 387 ms (attempt 3/5)1259vm-test-run-nix-grpc-store-main> machine # [   38.652343] nix-grpc-daemon[772]: warning: unable to download 'https://cache.nixos.org/nix-cache-info': Could not resolve hostname (6) Could not resolve host: cache.nixos.org; retrying in 376 ms (attempt 4/5)1260vm-test-run-nix-grpc-store-main> machine # [   39.031772] nix-grpc-daemon[772]: disabling binary cache 'https://cache.nixos.org' for 60 seconds1261vm-test-run-nix-grpc-store-main> machine # [   39.036551] nix-grpc-daemon[772]: warning: unable to download 'https://cache.nixos.org/nix-cache-info': Could not resolve hostname (6) Could not resolve host: cache.nixos.org1262vm-test-run-nix-grpc-store-main> machine # [   39.063765] nix-daemon[961]: accepted connection from pid 772, user root (trusted)1263vm-test-run-nix-grpc-store-main> machine # [   39.092221] nix-daemon[961]: accepted connection from pid 772, user root (trusted)1264vm-test-run-nix-grpc-store-main> machine # [   39.108303] nix-daemon[961]: accepted connection from pid 772, user root (trusted)1265vm-test-run-nix-grpc-store-main> machine # [   40.340444] nix-grpc-daemon[772]: ts=2026-11-12T08:47:59Z level=info event=rpc method=BuildDerivation cn=localhost peer=ipv4:127.0.0.1:54582 duration_s=1 drv=kkr1m31ja6qn4sc39z93j6w6mmkx0az9-hello-grpc.drv assign_id=1 outputs=1 inputs=0 inputs_fetched=0 input_bytes=0 input_s=01266vm-test-run-nix-grpc-store-main> machine # [   40.367673] nix-daemon[961]: reaped child process 974, status = succeeded1267vm-test-run-nix-grpc-store-main> machine # [   40.369766] nix-daemon[961]: reaped child process 976, status = succeeded1268vm-test-run-nix-grpc-store-main> machine # [   40.387716] sshd-session[948]: Received disconnect from UNKNOWN port 65535:11: disconnected by user1269vm-test-run-nix-grpc-store-main> machine # [   40.390159] sshd-session[948]: Disconnected from user root UNKNOWN port 655351270vm-test-run-nix-grpc-store-main> machine # [   40.393132] sshd-session[942]: pam_unix(sshd:session): session closed for user root1271vm-test-run-nix-grpc-store-main> machine # [   40.400817] systemd[1]: sshd-vsock@4-4097-3:22-2:4.service: Deactivated successfully.1272vm-test-run-nix-grpc-store-main> machine # [   40.406817] systemd[1]: session-6.scope: Deactivated successfully.1273vm-test-run-nix-grpc-store-main> machine # [   40.408834] systemd[1]: session-6.scope: Consumed 270ms CPU time over 2.890s wall clock time, 36.1M memory peak, 9.1K incoming IP traffic, 7.8K outgoing IP traffic.1274vm-test-run-nix-grpc-store-main> machine # [   40.414729] systemd-logind[550]: Session 6 logged out. Waiting for processes to exit.1275vm-test-run-nix-grpc-store-main> machine # [   40.417029] systemd-logind[550]: Removed session 6.1276vm-test-run-nix-grpc-store-main> machine # [   40.734862] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.1277vm-test-run-nix-grpc-store-main> machine # [   40.741278] systemd[1]: Started SSH per-connection Daemon (vsock:2:5).1278vm-test-run-nix-grpc-store-main> machine # [   40.865437] sshd-session[997]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it1279vm-test-run-nix-grpc-store-main> machine # [   40.875903] sshd-session[997]: Accepted none for root from UNKNOWN port 65535 ssh21280vm-test-run-nix-grpc-store-main> machine # [   40.888951] sshd-session[997]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)1281vm-test-run-nix-grpc-store-main> machine # [   40.897970] systemd-logind[550]: New session '7' of user 'root' with class 'user' and type 'tty'.1282vm-test-run-nix-grpc-store-main> machine # [   40.921670] systemd[1]: Started Session 7 of User root.1283vm-test-run-nix-grpc-store-main> machine # [   40.962412] sshd-session[1003]: Received disconnect from UNKNOWN port 65535:11: disconnected by user1284vm-test-run-nix-grpc-store-main> machine # [   40.964934] sshd-session[1003]: Disconnected from user root UNKNOWN port 655351285vm-test-run-nix-grpc-store-main> machine # [   40.966897] sshd-session[997]: pam_unix(sshd:session): session closed for user root1286vm-test-run-nix-grpc-store-main> machine # [   40.969555] systemd[1]: sshd-vsock@5-4098-3:22-2:5.service: Deactivated successfully.1287vm-test-run-nix-grpc-store-main> machine # [   40.975641] systemd[1]: session-7.scope: Deactivated successfully.1288vm-test-run-nix-grpc-store-main> machine # [   40.979240] systemd-logind[550]: Session 7 logged out. Waiting for processes to exit.1289vm-test-run-nix-grpc-store-main> machine # [   40.981943] systemd-logind[550]: Removed session 7.1290vm-test-run-nix-grpc-store-main> machine # [   44.092848] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.1291vm-test-run-nix-grpc-store-main> machine # [   44.097341] systemd[1]: Started SSH per-connection Daemon (vsock:2:6).1292vm-test-run-nix-grpc-store-main> machine # [   44.216687] sshd-session[1009]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it1293vm-test-run-nix-grpc-store-main> machine # [   44.227586] sshd-session[1009]: Accepted none for root from UNKNOWN port 65535 ssh21294vm-test-run-nix-grpc-store-main> machine # [   44.241956] sshd-session[1009]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)1295vm-test-run-nix-grpc-store-main> machine # [   44.253227] systemd-logind[550]: New session '8' of user 'root' with class 'user' and type 'tty'.1296vm-test-run-nix-grpc-store-main> machine # [   44.269238] systemd[1]: Started Session 8 of User root.1297vm-test-run-nix-grpc-store-main> machine # [   44.362861] systemd[1]: Stopping Nix Daemon...1298vm-test-run-nix-grpc-store-main> machine # [   44.375213] systemd[1]: nix-daemon.service: Deactivated successfully.1299vm-test-run-nix-grpc-store-main> machine # [   44.377646] systemd[1]: nix-daemon.service: Unit process 964 (nix-daemon) remains running after unit stopped.1300vm-test-run-nix-grpc-store-main> machine # [   44.379941] systemd[1]: nix-daemon.service: Unit process 969 (nix-daemon) remains running after unit stopped.1301vm-test-run-nix-grpc-store-main> machine # [   44.383463] systemd[1]: Stopped Nix Daemon.1302vm-test-run-nix-grpc-store-main> machine # [   44.384301] systemd[1]: nix-daemon.service: Consumed 590ms CPU time over 6.591s wall clock time, 44M memory peak, 2.8K outgoing IP traffic.1303vm-test-run-nix-grpc-store-main> machine # [   44.386246] systemd[1]: nix-daemon.socket: Deactivated successfully.1304vm-test-run-nix-grpc-store-main> machine # [   44.387280] systemd[1]: Closed Nix Daemon Socket.1305vm-test-run-nix-grpc-store-main> machine # [   44.388928] sshd-session[1015]: Received disconnect from UNKNOWN port 65535:11: disconnected by user1306vm-test-run-nix-grpc-store-main> machine # [   44.390703] sshd-session[1015]: Disconnected from user root UNKNOWN port 655351307vm-test-run-nix-grpc-store-main> machine # [   44.392115] sshd-session[1009]: pam_unix(sshd:session): session closed for user root1308vm-test-run-nix-grpc-store-main> machine # [   44.398286] systemd[1]: sshd-vsock@6-5-3:22-2:6.service: Deactivated successfully.1309vm-test-run-nix-grpc-store-main> machine # [   44.402676] systemd[1]: session-8.scope: Deactivated successfully.1310vm-test-run-nix-grpc-store-main> machine # [   44.405932] systemd-logind[550]: Session 8 logged out. Waiting for processes to exit.1311vm-test-run-nix-grpc-store-main> machine # [   44.408799] systemd-logind[550]: Removed session 8.1312vm-test-run-nix-grpc-store-main> machine # [   44.566256] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.1313vm-test-run-nix-grpc-store-main> machine # [   44.572878] systemd[1]: Started SSH per-connection Daemon (vsock:2:7).1314vm-test-run-nix-grpc-store-main> machine # [   44.688900] sshd-session[1020]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it1315vm-test-run-nix-grpc-store-main> machine # [   44.699220] sshd-session[1020]: Accepted none for root from UNKNOWN port 65535 ssh21316vm-test-run-nix-grpc-store-main> machine # [   44.710249] sshd-session[1020]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)1317vm-test-run-nix-grpc-store-main> machine # [   44.719852] systemd-logind[550]: New session '9' of user 'root' with class 'user' and type 'tty'.1318vm-test-run-nix-grpc-store-main> machine # [   44.736999] systemd[1]: Started Session 9 of User root.1319vm-test-run-nix-grpc-store-main> machine # [   52.554261] sshd-session[1026]: Received disconnect from UNKNOWN port 65535:11: disconnected by user1320vm-test-run-nix-grpc-store-main> machine # [   52.554858] sshd-session[1026]: Disconnected from user root UNKNOWN port 655351321vm-test-run-nix-grpc-store-main> machine # [   52.558885] sshd-session[1020]: pam_unix(sshd:session): session closed for user root1322vm-test-run-nix-grpc-store-main> machine # [   52.564524] systemd[1]: sshd-vsock@7-6-3:22-2:7.service: Deactivated successfully.1323vm-test-run-nix-grpc-store-main> machine # [   52.570947] systemd[1]: session-9.scope: Deactivated successfully.1324vm-test-run-nix-grpc-store-main> machine # [   52.572205] systemd[1]: session-9.scope: Consumed 219ms CPU time over 7.834s wall clock time, 32.8M memory peak, 8.7K incoming IP traffic, 7.3K outgoing IP traffic.1325vm-test-run-nix-grpc-store-main> machine # [   52.576597] systemd-logind[550]: Session 9 logged out. Waiting for processes to exit.1326vm-test-run-nix-grpc-store-main> machine # [   52.580174] systemd-logind[550]: Removed session 9.1327vm-test-run-nix-grpc-store-main> [e2e] heartbeat t=30s1328vm-test-run-nix-grpc-store-main> machine # [   54.304333] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.1329vm-test-run-nix-grpc-store-main> machine # [   54.312560] systemd[1]: Started SSH per-connection Daemon (vsock:2:8).1330vm-test-run-nix-grpc-store-main> machine # [   54.430216] sshd-session[1046]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it1331vm-test-run-nix-grpc-store-main> machine # [   54.441568] sshd-session[1046]: Accepted none for root from UNKNOWN port 65535 ssh21332vm-test-run-nix-grpc-store-main> machine # [   54.454185] sshd-session[1046]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)1333vm-test-run-nix-grpc-store-main> machine # [   54.468436] systemd-logind[550]: New session '10' of user 'root' with class 'user' and type 'tty'.1334vm-test-run-nix-grpc-store-main> machine # [   54.477434] systemd[1]: Started Session 10 of User root.1335vm-test-run-nix-grpc-store-main> machine # [   54.515222] systemd[1]: Listening on Nix Daemon Socket.1336vm-test-run-nix-grpc-store-main> machine # [   54.524433] sshd-session[1052]: Received disconnect from UNKNOWN port 65535:11: disconnected by user1337vm-test-run-nix-grpc-store-main> machine # [   54.526812] sshd-session[1052]: Disconnected from user root UNKNOWN port 655351338vm-test-run-nix-grpc-store-main> machine # [   54.528556] sshd-session[1046]: pam_unix(sshd:session): session closed for user root1339vm-test-run-nix-grpc-store-main> machine # [   54.533192] systemd[1]: sshd-vsock@8-4099-3:22-2:8.service: Deactivated successfully.1340vm-test-run-nix-grpc-store-main> machine # [   54.539052] systemd[1]: session-10.scope: Deactivated successfully.1341vm-test-run-nix-grpc-store-main> machine # [   54.543105] systemd-logind[550]: Session 10 logged out. Waiting for processes to exit.1342vm-test-run-nix-grpc-store-main> machine # [   54.546365] systemd-logind[550]: Removed session 10.1343vm-test-run-nix-grpc-store-main> machine # [   59.509307] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.1344vm-test-run-nix-grpc-store-main> machine # [   59.516177] systemd[1]: Started SSH per-connection Daemon (vsock:2:9).1345vm-test-run-nix-grpc-store-main> machine # [   59.634006] sshd-session[1058]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it1346vm-test-run-nix-grpc-store-main> machine # [   59.644925] sshd-session[1058]: Accepted none for root from UNKNOWN port 65535 ssh21347vm-test-run-nix-grpc-store-main> machine # [   59.656863] sshd-session[1058]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)1348vm-test-run-nix-grpc-store-main> machine # [   59.667633] systemd-logind[550]: New session '11' of user 'root' with class 'user' and type 'tty'.1349vm-test-run-nix-grpc-store-main> machine # [   59.681020] systemd[1]: Started Session 11 of User root.1350vm-test-run-nix-grpc-store-main> machine # [   59.905011] systemd[1]: nix-daemon.service: Found left-over process 969 (nix-daemon) in control group while starting unit. Ignoring.1351vm-test-run-nix-grpc-store-main> machine # [   59.908294] systemd[1]: nix-daemon.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies.1352vm-test-run-nix-grpc-store-main> machine # [   59.912166] systemd[1]: Started Nix Daemon.1353vm-test-run-nix-grpc-store-main> machine # [   60.082168] nix-daemon[1070]: accepted connection from pid 1066, user root (trusted)1354vm-test-run-nix-grpc-store-main> machine # [   60.104559] nix-daemon[1070]: reaped child process 1073, status = succeeded1355vm-test-run-nix-grpc-store-main> machine # [   60.113592] sshd-session[1064]: Received disconnect from UNKNOWN port 65535:11: disconnected by user1356vm-test-run-nix-grpc-store-main> machine # [   60.115389] sshd-session[1064]: Disconnected from user root UNKNOWN port 655351357vm-test-run-nix-grpc-store-main> machine # [   60.116792] sshd-session[1058]: pam_unix(sshd:session): session closed for user root1358vm-test-run-nix-grpc-store-main> machine # [   60.120954] systemd[1]: sshd-vsock@9-7-3:22-2:9.service: Deactivated successfully.1359vm-test-run-nix-grpc-store-main> machine # [   60.125352] systemd[1]: session-11.scope: Deactivated successfully.1360vm-test-run-nix-grpc-store-main> machine # [   60.128545] systemd-logind[550]: Session 11 logged out. Waiting for processes to exit.1361vm-test-run-nix-grpc-store-main> machine # [   60.131439] systemd-logind[550]: Removed session 11.1362vm-test-run-nix-grpc-store-main> machine # [   60.308982] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.1363vm-test-run-nix-grpc-store-main> machine # [   60.317017] systemd[1]: Started SSH per-connection Daemon (vsock:2:10).1364vm-test-run-nix-grpc-store-main> machine # [   60.434953] sshd-session[1077]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it1365vm-test-run-nix-grpc-store-main> machine # [   60.444302] sshd-session[1077]: Accepted none for root from UNKNOWN port 65535 ssh21366vm-test-run-nix-grpc-store-main> machine # [   60.455603] sshd-session[1077]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)1367vm-test-run-nix-grpc-store-main> machine # [   60.467391] systemd-logind[550]: New session '12' of user 'root' with class 'user' and type 'tty'.1368vm-test-run-nix-grpc-store-main> machine # [   60.473804] systemd[1]: Started Session 12 of User root.1369vm-test-run-nix-grpc-store-main> machine # [   60.655217] nix-daemon[1070]: accepted connection from pid 772, user root (trusted)1370vm-test-run-nix-grpc-store-main> machine # [   60.671270] nix-grpc-daemon[772]: warning: unable to download 'https://cache.nixos.org/nix-cache-info': Could not resolve hostname (6) Could not resolve host: cache.nixos.org; retrying in 67 ms (attempt 1/5)1371vm-test-run-nix-grpc-store-main> machine # [   60.739673] nix-grpc-daemon[772]: warning: unable to download 'https://cache.nixos.org/nix-cache-info': Could not resolve hostname (6) Could not resolve host: cache.nixos.org; retrying in 96 ms (attempt 2/5)1372vm-test-run-nix-grpc-store-main> machine # [   60.838688] nix-grpc-daemon[772]: warning: unable to download 'https://cache.nixos.org/nix-cache-info': Could not resolve hostname (6) Could not resolve host: cache.nixos.org; retrying in 147 ms (attempt 3/5)1373vm-test-run-nix-grpc-store-main> machine # [   60.987536] nix-grpc-daemon[772]: warning: unable to download 'https://cache.nixos.org/nix-cache-info': Could not resolve hostname (6) Could not resolve host: cache.nixos.org; retrying in 178 ms (attempt 4/5)1374vm-test-run-nix-grpc-store-main> machine # [   61.168182] nix-grpc-daemon[772]: disabling binary cache 'https://cache.nixos.org' for 60 seconds1375vm-test-run-nix-grpc-store-main> machine # [   61.170270] nix-grpc-daemon[772]: warning: unable to download 'https://cache.nixos.org/nix-cache-info': Could not resolve hostname (6) Could not resolve host: cache.nixos.org1376vm-test-run-nix-grpc-store-main> machine # [   61.186744] nix-daemon[1070]: accepted connection from pid 772, user root (trusted)1377vm-test-run-nix-grpc-store-main> machine # [   61.202480] nix-daemon[1070]: accepted connection from pid 772, user root (trusted)1378vm-test-run-nix-grpc-store-main> machine # [   61.219331] nix-daemon[1070]: accepted connection from pid 772, user root (trusted)1379vm-test-run-nix-grpc-store-main> machine # [   62.258181] nix-grpc-daemon[772]: ts=2026-11-12T08:48:21Z level=info event=rpc method=BuildDerivation cn=localhost peer=ipv4:127.0.0.1:49690 duration_s=1 drv=7xivr35y5zddh6dskqkrrsw241maj7d7-reconnect-after-daemon-restart.drv assign_id=2 outputs=1 inputs=0 inputs_fetched=0 input_bytes=0 input_s=01380vm-test-run-nix-grpc-store-main> machine # [   62.273365] nix-daemon[1070]: reaped child process 1107, status = succeeded1381vm-test-run-nix-grpc-store-main> machine # [   62.275470] nix-daemon[1070]: reaped child process 1105, status = succeeded1382vm-test-run-nix-grpc-store-main> machine # [   62.294520] sshd-session[1083]: Received disconnect from UNKNOWN port 65535:11: disconnected by user1383vm-test-run-nix-grpc-store-main> machine # [   62.296281] sshd-session[1083]: Disconnected from user root UNKNOWN port 655351384vm-test-run-nix-grpc-store-main> machine # [   62.297797] sshd-session[1077]: pam_unix(sshd:session): session closed for user root1385vm-test-run-nix-grpc-store-main> machine # [   62.300679] systemd[1]: sshd-vsock@10-4100-3:22-2:10.service: Deactivated successfully.1386vm-test-run-nix-grpc-store-main> machine # [   62.305451] systemd[1]: session-12.scope: Deactivated successfully.1387vm-test-run-nix-grpc-store-main> machine # [   62.307481] systemd[1]: session-12.scope: Consumed 193ms CPU time over 1.832s wall clock time, 32.2M memory peak, 9.3K incoming IP traffic, 8K outgoing IP traffic.1388vm-test-run-nix-grpc-store-main> machine # [   62.312672] systemd-logind[550]: Session 12 logged out. Waiting for processes to exit.1389vm-test-run-nix-grpc-store-main> machine # [   62.314655] systemd-logind[550]: Removed session 12.1390vm-test-run-nix-grpc-store-main> machine # [   64.686569] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.1391vm-test-run-nix-grpc-store-main> machine # [   64.694761] systemd[1]: Started SSH per-connection Daemon (vsock:2:11).1392vm-test-run-nix-grpc-store-main> machine # [   64.850041] sshd-session[1126]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it1393vm-test-run-nix-grpc-store-main> machine # [   64.860725] sshd-session[1126]: Accepted none for root from UNKNOWN port 65535 ssh21394vm-test-run-nix-grpc-store-main> machine # [   64.873420] sshd-session[1126]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)1395vm-test-run-nix-grpc-store-main> machine # [   64.884936] systemd-logind[550]: New session '13' of user 'root' with class 'user' and type 'tty'.1396vm-test-run-nix-grpc-store-main> machine # [   64.897038] systemd[1]: Started Session 13 of User root.1397vm-test-run-nix-grpc-store-main> machine # [   64.939026] sshd-session[1132]: Received disconnect from UNKNOWN port 65535:11: disconnected by user1398vm-test-run-nix-grpc-store-main> machine # [   64.941398] sshd-session[1132]: Disconnected from user root UNKNOWN port 655351399vm-test-run-nix-grpc-store-main> machine # [   64.942661] sshd-session[1126]: pam_unix(sshd:session): session closed for user root1400vm-test-run-nix-grpc-store-main> machine # [   64.945355] systemd[1]: sshd-vsock@11-4101-3:22-2:11.service: Deactivated successfully.1401vm-test-run-nix-grpc-store-main> machine # [   64.950293] systemd[1]: session-13.scope: Deactivated successfully.1402vm-test-run-nix-grpc-store-main> machine # [   64.953146] systemd-logind[550]: Session 13 logged out. Waiting for processes to exit.1403vm-test-run-nix-grpc-store-main> machine # [   64.955596] systemd-logind[550]: Removed session 13.1404vm-test-run-nix-grpc-store-main> ok1405vm-test-run-nix-grpc-store-main> test lifecycle::default_client_cert_lookup ... machine # [   70.661360] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.1406vm-test-run-nix-grpc-store-main> machine # [   70.670871] systemd[1]: Started SSH per-connection Daemon (vsock:2:12).1407vm-test-run-nix-grpc-store-main> machine # [   70.791767] sshd-session[1137]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it1408vm-test-run-nix-grpc-store-main> machine # [   70.802648] sshd-session[1137]: Accepted none for root from UNKNOWN port 65535 ssh21409vm-test-run-nix-grpc-store-main> machine # [   70.814620] sshd-session[1137]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)1410vm-test-run-nix-grpc-store-main> machine # [   70.827793] systemd-logind[550]: New session '14' of user 'root' with class 'user' and type 'tty'.1411vm-test-run-nix-grpc-store-main> machine # [   70.841146] systemd[1]: Started Session 14 of User root.1412vm-test-run-nix-grpc-store-main> machine # [   70.881743] sshd-session[1143]: Received disconnect from UNKNOWN port 65535:11: disconnected by user1413vm-test-run-nix-grpc-store-main> machine # [   70.884454] sshd-session[1143]: Disconnected from user root UNKNOWN port 655351414vm-test-run-nix-grpc-store-main> machine # [   70.886304] sshd-session[1137]: pam_unix(sshd:session): session closed for user root1415vm-test-run-nix-grpc-store-main> machine # [   70.896287] systemd[1]: sshd-vsock@12-4102-3:22-2:12.service: Deactivated successfully.1416vm-test-run-nix-grpc-store-main> machine # [   70.898780] systemd[1]: session-14.scope: Deactivated successfully.1417vm-test-run-nix-grpc-store-main> machine # [   70.901948] systemd-logind[550]: Session 14 logged out. Waiting for processes to exit.1418vm-test-run-nix-grpc-store-main> machine # [   70.904768] systemd-logind[550]: Removed session 14.1419vm-test-run-nix-grpc-store-main> machine # [   75.264777] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.1420vm-test-run-nix-grpc-store-main> machine # [   75.271703] systemd[1]: Started SSH per-connection Daemon (vsock:2:13).1421vm-test-run-nix-grpc-store-main> machine # [   75.390580] sshd-session[1148]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it1422vm-test-run-nix-grpc-store-main> machine # [   75.400468] sshd-session[1148]: Accepted none for root from UNKNOWN port 65535 ssh21423vm-test-run-nix-grpc-store-main> machine # [   75.411381] sshd-session[1148]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)1424vm-test-run-nix-grpc-store-main> machine # [   75.424759] systemd-logind[550]: New session '15' of user 'root' with class 'user' and type 'tty'.1425vm-test-run-nix-grpc-store-main> machine # [   75.437256] systemd[1]: Started Session 15 of User root.1426vm-test-run-nix-grpc-store-main> machine # [   75.476841] sshd-session[1154]: Received disconnect from UNKNOWN port 65535:11: disconnected by user1427vm-test-run-nix-grpc-store-main> machine # [   75.479152] sshd-session[1154]: Disconnected from user root UNKNOWN port 655351428vm-test-run-nix-grpc-store-main> machine # [   75.481252] sshd-session[1148]: pam_unix(sshd:session): session closed for user root1429vm-test-run-nix-grpc-store-main> machine # [   75.493378] systemd[1]: sshd-vsock@13-4103-3:22-2:13.service: Deactivated successfully.1430vm-test-run-nix-grpc-store-main> machine # [   75.498585] systemd[1]: session-15.scope: Deactivated successfully.1431vm-test-run-nix-grpc-store-main> machine # [   75.501595] systemd[1]: session-15.scope: Consumed 32ms CPU time over 62ms wall clock time, 2.1M memory peak, 112B incoming IP traffic, 216B outgoing IP traffic.1432vm-test-run-nix-grpc-store-main> machine # [   75.505378] systemd-logind[550]: Session 15 logged out. Waiting for processes to exit.1433vm-test-run-nix-grpc-store-main> machine # [   75.507206] systemd-logind[550]: Removed session 15.1434vm-test-run-nix-grpc-store-main> machine # [   76.472103] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.1435vm-test-run-nix-grpc-store-main> machine # [   76.478322] systemd[1]: Started SSH per-connection Daemon (vsock:2:14).1436vm-test-run-nix-grpc-store-main> machine # [   76.595113] sshd-session[1159]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it1437vm-test-run-nix-grpc-store-main> machine # [   76.602607] sshd-session[1159]: Accepted none for root from UNKNOWN port 65535 ssh21438vm-test-run-nix-grpc-store-main> machine # [   76.614501] sshd-session[1159]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)1439vm-test-run-nix-grpc-store-main> machine # [   76.624594] systemd-logind[550]: New session '16' of user 'root' with class 'user' and type 'tty'.1440vm-test-run-nix-grpc-store-main> machine # [   76.637184] systemd[1]: Started Session 16 of User root.1441vm-test-run-nix-grpc-store-main> machine # [   76.674678] sshd-session[1165]: Received disconnect from UNKNOWN port 65535:11: disconnected by user1442vm-test-run-nix-grpc-store-main> machine # [   76.676489] sshd-session[1165]: Disconnected from user root UNKNOWN port 655351443vm-test-run-nix-grpc-store-main> machine # [   76.677576] sshd-session[1159]: pam_unix(sshd:session): session closed for user root1444vm-test-run-nix-grpc-store-main> machine # [   76.682894] systemd[1]: sshd-vsock@14-4104-3:22-2:14.service: Deactivated successfully.1445vm-test-run-nix-grpc-store-main> machine # [   76.687318] systemd[1]: session-16.scope: Deactivated successfully.1446vm-test-run-nix-grpc-store-main> machine # [   76.690642] systemd-logind[550]: Session 16 logged out. Waiting for processes to exit.1447vm-test-run-nix-grpc-store-main> machine # [   76.693037] systemd-logind[550]: Removed session 16.1448vm-test-run-nix-grpc-store-main> machine # [   79.293547] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.1449vm-test-run-nix-grpc-store-main> machine # [   79.300644] systemd[1]: Started SSH per-connection Daemon (vsock:2:15).1450vm-test-run-nix-grpc-store-main> machine # [   79.412371] sshd-session[1170]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it1451vm-test-run-nix-grpc-store-main> machine # [   79.423233] sshd-session[1170]: Accepted none for root from UNKNOWN port 65535 ssh21452vm-test-run-nix-grpc-store-main> machine # [   79.435112] sshd-session[1170]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)1453vm-test-run-nix-grpc-store-main> machine # [   79.447447] systemd-logind[550]: New session '17' of user 'root' with class 'user' and type 'tty'.1454vm-test-run-nix-grpc-store-main> machine # [   79.473517] systemd[1]: Started Session 17 of User root.1455vm-test-run-nix-grpc-store-main> machine # [   79.511876] sshd-session[1176]: Received disconnect from UNKNOWN port 65535:11: disconnected by user1456vm-test-run-nix-grpc-store-main> machine # [   79.514895] sshd-session[1176]: Disconnected from user root UNKNOWN port 655351457vm-test-run-nix-grpc-store-main> machine # [   79.517088] sshd-session[1170]: pam_unix(sshd:session): session closed for user root1458vm-test-run-nix-grpc-store-main> machine # [   79.523078] systemd[1]: sshd-vsock@15-8-3:22-2:15.service: Deactivated successfully.1459vm-test-run-nix-grpc-store-main> machine # [   79.529327] systemd[1]: session-17.scope: Deactivated successfully.1460vm-test-run-nix-grpc-store-main> machine # [   79.532495] systemd-logind[550]: Session 17 logged out. Waiting for processes to exit.1461vm-test-run-nix-grpc-store-main> machine # [   79.535316] systemd-logind[550]: Removed session 17.1462vm-test-run-nix-grpc-store-main> machine # [   82.312866] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.1463vm-test-run-nix-grpc-store-main> machine # [   82.319622] systemd[1]: Started SSH per-connection Daemon (vsock:2:16).1464vm-test-run-nix-grpc-store-main> machine # [   82.441607] sshd-session[1181]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it1465vm-test-run-nix-grpc-store-main> machine # [   82.451986] sshd-session[1181]: Accepted none for root from UNKNOWN port 65535 ssh21466vm-test-run-nix-grpc-store-main> machine # [   82.465945] sshd-session[1181]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)1467vm-test-run-nix-grpc-store-main> machine # [   82.478719] systemd-logind[550]: New session '18' of user 'root' with class 'user' and type 'tty'.1468vm-test-run-nix-grpc-store-main> machine # [   82.497032] systemd[1]: Started Session 18 of User root.1469vm-test-run-nix-grpc-store-main> machine # [   82.535282] sshd-session[1187]: Received disconnect from UNKNOWN port 65535:11: disconnected by user1470vm-test-run-nix-grpc-store-main> machine # [   82.537933] sshd-session[1187]: Disconnected from user root UNKNOWN port 655351471vm-test-run-nix-grpc-store-main> machine # [   82.539706] sshd-session[1181]: pam_unix(sshd:session): session closed for user root1472vm-test-run-nix-grpc-store-main> machine # [   82.545365] systemd[1]: sshd-vsock@16-4105-3:22-2:16.service: Deactivated successfully.1473vm-test-run-nix-grpc-store-main> machine # [   82.551608] systemd[1]: session-18.scope: Deactivated successfully.1474vm-test-run-nix-grpc-store-main> machine # [   82.555904] systemd-logind[550]: Session 18 logged out. Waiting for processes to exit.1475vm-test-run-nix-grpc-store-main> machine # [   82.558694] systemd-logind[550]: Removed session 18.1476vm-test-run-nix-grpc-store-main> machine # [   83.047437] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.1477vm-test-run-nix-grpc-store-main> machine # [   83.053726] systemd[1]: Started SSH per-connection Daemon (vsock:2:17).1478vm-test-run-nix-grpc-store-main> [e2e] heartbeat t=60s1479vm-test-run-nix-grpc-store-main> machine # [   83.178763] sshd-session[1192]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it1480vm-test-run-nix-grpc-store-main> machine # [   83.190748] sshd-session[1192]: Accepted none for root from UNKNOWN port 65535 ssh21481vm-test-run-nix-grpc-store-main> machine # [   83.202435] sshd-session[1192]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)1482vm-test-run-nix-grpc-store-main> machine # [   83.212380] systemd-logind[550]: New session '19' of user 'root' with class 'user' and type 'tty'.1483vm-test-run-nix-grpc-store-main> machine # [   83.229187] systemd[1]: Started Session 19 of User root.1484vm-test-run-nix-grpc-store-main> machine # [   83.425446] nix-daemon[1070]: accepted connection from pid 772, user root (trusted)1485vm-test-run-nix-grpc-store-main> machine # [   83.459044] nix-daemon[1070]: reaped child process 1213, status = succeeded1486vm-test-run-nix-grpc-store-main> machine # [   83.462606] nix-grpc-daemon[772]: ts=2026-11-12T08:48:43Z level=info event=rpc method=Connect cn=localhost peer=ipv4:127.0.0.1:43732 duration_s=0 bytes_in=672 bytes_out=1921487vm-test-run-nix-grpc-store-main> machine # [   83.473912] sshd-session[1198]: Received disconnect from UNKNOWN port 65535:11: disconnected by user1488vm-test-run-nix-grpc-store-main> machine # [   83.476306] sshd-session[1198]: Disconnected from user root UNKNOWN port 655351489vm-test-run-nix-grpc-store-main> machine # [   83.477843] sshd-session[1192]: pam_unix(sshd:session): session closed for user root1490vm-test-run-nix-grpc-store-main> machine # [   83.482819] systemd[1]: sshd-vsock@17-4106-3:22-2:17.service: Deactivated successfully.1491vm-test-run-nix-grpc-store-main> machine # [   83.487550] systemd[1]: session-19.scope: Deactivated successfully.1492vm-test-run-nix-grpc-store-main> machine # [   83.489253] systemd[1]: session-19.scope: Consumed 183ms CPU time over 259ms wall clock time, 34.1M memory peak, 7K incoming IP traffic, 5.8K outgoing IP traffic.1493vm-test-run-nix-grpc-store-main> machine # [   83.493391] systemd-logind[550]: Session 19 logged out. Waiting for processes to exit.1494vm-test-run-nix-grpc-store-main> machine # [   83.494780] systemd-logind[550]: Removed session 19.1495vm-test-run-nix-grpc-store-main> machine # [   87.722546] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.1496vm-test-run-nix-grpc-store-main> machine # [   87.729162] systemd[1]: Started SSH per-connection Daemon (vsock:2:18).1497vm-test-run-nix-grpc-store-main> machine # [   87.855948] sshd-session[1218]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it1498vm-test-run-nix-grpc-store-main> machine # [   87.878746] sshd-session[1218]: Accepted none for root from UNKNOWN port 65535 ssh21499vm-test-run-nix-grpc-store-main> machine # [   87.892004] sshd-session[1218]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)1500vm-test-run-nix-grpc-store-main> machine # [   87.905966] systemd-logind[550]: New session '20' of user 'root' with class 'user' and type 'tty'.1501vm-test-run-nix-grpc-store-main> machine # [   87.916932] systemd[1]: Started Session 20 of User root.1502vm-test-run-nix-grpc-store-main> machine # [   87.960575] sshd-session[1224]: Received disconnect from UNKNOWN port 65535:11: disconnected by user1503vm-test-run-nix-grpc-store-main> machine # [   87.962734] sshd-session[1224]: Disconnected from user root UNKNOWN port 655351504vm-test-run-nix-grpc-store-main> machine # [   87.965203] sshd-session[1218]: pam_unix(sshd:session): session closed for user root1505vm-test-run-nix-grpc-store-main> machine # [   87.970242] systemd[1]: sshd-vsock@18-4107-3:22-2:18.service: Deactivated successfully.1506vm-test-run-nix-grpc-store-main> machine # [   87.975658] systemd[1]: session-20.scope: Deactivated successfully.1507vm-test-run-nix-grpc-store-main> machine # [   87.980156] systemd-logind[550]: Session 20 logged out. Waiting for processes to exit.1508vm-test-run-nix-grpc-store-main> machine # [   87.983535] systemd-logind[550]: Removed session 20.1509vm-test-run-nix-grpc-store-main> ok1510vm-test-run-nix-grpc-store-main> test lifecycle::idle_exit_and_socket_activation ... machine # [   91.170386] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.1511vm-test-run-nix-grpc-store-main> machine # [   91.176478] systemd[1]: Started SSH per-connection Daemon (vsock:2:19).1512vm-test-run-nix-grpc-store-main> machine # [   91.272996] sshd-session[1229]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it1513vm-test-run-nix-grpc-store-main> machine # [   91.283115] sshd-session[1229]: Accepted none for root from UNKNOWN port 65535 ssh21514vm-test-run-nix-grpc-store-main> machine # [   91.293860] sshd-session[1229]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)1515vm-test-run-nix-grpc-store-main> machine # [   91.306686] systemd-logind[550]: New session '21' of user 'root' with class 'user' and type 'tty'.1516vm-test-run-nix-grpc-store-main> machine # [   91.312941] systemd[1]: Started Session 21 of User root.1517vm-test-run-nix-grpc-store-main> machine # [   91.352817] sshd-session[1235]: Received disconnect from UNKNOWN port 65535:11: disconnected by user1518vm-test-run-nix-grpc-store-main> machine # [   91.355254] sshd-session[1235]: Disconnected from user root UNKNOWN port 655351519vm-test-run-nix-grpc-store-main> machine # [   91.357733] sshd-session[1229]: pam_unix(sshd:session): session closed for user root1520vm-test-run-nix-grpc-store-main> machine # [   91.361111] systemd[1]: sshd-vsock@19-4108-3:22-2:19.service: Deactivated successfully.1521vm-test-run-nix-grpc-store-main> machine # [   91.367094] systemd[1]: session-21.scope: Deactivated successfully.1522vm-test-run-nix-grpc-store-main> machine # [   91.369728] systemd-logind[550]: Session 21 logged out. Waiting for processes to exit.1523vm-test-run-nix-grpc-store-main> machine # [   91.372509] systemd-logind[550]: Removed session 21.