these 43 derivations will be built: /nix/store/w5n8dzw4rzj09mmrxhzg5n7zbbkqqy6l-tmpfiles.d.drv /nix/store/78kfrh18b31p6h3kvpp512p39m7i6j43-X-Restart-Triggers-systemd-tmpfiles-resetup.drv /nix/store/494dzwrxjwlkd7dc6d9c1qak5fdvrxb5-unit-systemd-tmpfiles-resetup.service.drv /nix/store/x9pys05w31v2x75cx9sz0kwkm7lwiwlk-system-path.drv /nix/store/i1rc4akxa7dc9iafszzx283b5fh1n1k9-dbus-1.drv /nix/store/6kvhipp7p8mpkkkvx3hisij14n9qlyyx-X-Restart-Triggers-dbus-broker.drv /nix/store/dq61y0yypwp4h613krcfvbfdn0f4pa7x-unit-dbus-broker.service.drv /nix/store/lsps3nwm4xpn5lnbdy2jyliq8zg4kqx9-nix.conf.drv /nix/store/vg823x3yh7bgwiyjivxsh6nivllgby93-X-Restart-Triggers-nix-daemon.drv /nix/store/ff3js9y8ph9yvf6s8b4cayxv4qqp308r-unit-nix-daemon.service.drv /nix/store/dk3ygjr2x7m0n9gczfpb9hph7bm2hlz7-system-units.drv /nix/store/inqli7kvhcjniwdd7s4pkdv80w74iva6-unit-dbus-broker.service.drv /nix/store/lb2ykvibwiiymjbi2ssgrlrrk0ypkf2k-user-units.drv /nix/store/xsyqb1dhwnav3a7s08h26ipafbzs8lsj-etc.drv /nix/store/hyf2syr8zhyy3sr20hr1490innllxhzz-activate.drv /nix/store/g82fyh561r489xjfif7gyz1c6pc3m0z3-nixos-system-host1-test.drv /nix/store/hgpbz3fdvlbvdk86jp2a1nbwygd3zn80-closure-info.drv /nix/store/a1xvdblzwbk6b7cpb88szc6d8nczy4jv-run-nixos-vm.drv /nix/store/4lw6zlimmip223lhwpmpmflz6shvx1ry-nixos-vm.drv /nix/store/2fnl7jk8rqmm3rxr2g7j2yjf9kp9avpb-system-shutdown.drv /nix/store/d15ipyzv1l41v847bah106arhac0y4gq-system-path.drv /nix/store/x9x6a98zlcqq4nhsjx3awb03adjc8r9v-dbus-1.drv /nix/store/lfrg2ygp2kajwfjmllavwxarspk8lwwd-X-Restart-Triggers-dbus-broker.drv /nix/store/18089jjyxfdkq98wphqdayjnn4bhzjdf-unit-dbus-broker.service.drv /nix/store/71jrwk0gzybx68vdyg6vhmnggxk122fm-user-units.drv /nix/store/cf54w45ma45a5vjiysm64jvcfrim3zb5-unit-dbus-broker.service.drv /nix/store/jq2yl9sm5qb6jvs6gml8r83gwj4izmnz-nix.conf.drv /nix/store/7wi46h9dfp5h3d6mb7sw98vlk3ghi2aa-X-Restart-Triggers-nix-daemon.drv /nix/store/j95bs4w4d09m9whbk5yaxh410h6vbsng-unit-nix-daemon.service.drv /nix/store/slgyxcr04k7854jl4pij2kj6iw2pg6hp-unit-nix-grpc-daemon.socket.drv /nix/store/wrjpa9f6h6lqnywldp54785b5mihb435-unit-nix-grpc-daemon.service.drv /nix/store/adv52azgpkdl87mvixbqqrsh8hyyrh9k-system-units.drv /nix/store/crkz5364615gjwgf0zwjakwgz90jm0rr-user-generators.drv /nix/store/pxhrr5bi6pnaisih9y0873idzxldlzbz-system-generators.drv /nix/store/qj69qphadn8gfz472g6b1v4qngjvv2w3-etc.drv /nix/store/0wwhvi6j2nrbsxp30snas6dfgah4mqnb-activate.drv /nix/store/6zll25zh7va53am37ym905j5335idmh7-nixos-system-server-test.drv /nix/store/fa4387dahf70fggfs84kqsvlfhy955ay-closure-info.drv /nix/store/6isd5lw556wnca93j6hlzm6l1xi5qhjg-run-nixos-vm.drv /nix/store/m9l2qzv2y28dpbyz4absxlf94710zmgh-nixos-vm.drv /nix/store/brlldnpjhwjn8rh4kdbwp5hmafsy6yx4-driverConfiguration.json.drv /nix/store/pdihbliagc8wca3iyvb81wgsfwx3wmxq-nixos-test-driver-nix-grpc-store-acme-substituter.drv /nix/store/0vk3q21glhzznkf9b41lw6zm1hf6bibw-vm-test-run-nix-grpc-store-acme-substituter.drv building '/nix/store/d15ipyzv1l41v847bah106arhac0y4gq-system-path.drv' building '/nix/store/x9pys05w31v2x75cx9sz0kwkm7lwiwlk-system-path.drv' building '/nix/store/jq2yl9sm5qb6jvs6gml8r83gwj4izmnz-nix.conf.drv' building '/nix/store/lsps3nwm4xpn5lnbdy2jyliq8zg4kqx9-nix.conf.drv' building '/nix/store/w5n8dzw4rzj09mmrxhzg5n7zbbkqqy6l-tmpfiles.d.drv' building '/nix/store/wrjpa9f6h6lqnywldp54785b5mihb435-unit-nix-grpc-daemon.service.drv' building '/nix/store/slgyxcr04k7854jl4pij2kj6iw2pg6hp-unit-nix-grpc-daemon.socket.drv' nix.conf> tribuchet: building on jamie nix.conf> tribuchet: building on jamie system-path> tribuchet: building on jamie system-path> tribuchet: building on jamie tmpfiles.d> tribuchet: building on jamie unit-nix-grpc-daemon.service> tribuchet: building on jamie building '/nix/store/pxhrr5bi6pnaisih9y0873idzxldlzbz-system-generators.drv' building '/nix/store/2fnl7jk8rqmm3rxr2g7j2yjf9kp9avpb-system-shutdown.drv' building '/nix/store/crkz5364615gjwgf0zwjakwgz90jm0rr-user-generators.drv' system-generators> tribuchet: building on jamie system-shutdown> tribuchet: building on jamie unit-nix-grpc-daemon.socket> tribuchet: building on jamie user-generators> tribuchet: building on jamie system-path> structuredAttrs is enabled system-path> structuredAttrs is enabled nix.conf> Validating generated nix.conf nix.conf> Validating generated nix.conf unit-nix-grpc-daemon.service> structuredAttrs is enabled unit-nix-grpc-daemon.socket> structuredAttrs is enabled system-path> created 6861 symlinks in user environment system-path> created 6861 symlinks in user environment system-path> install-info: warning: no info dir entry in `/nix/store/pnsbn0m7a96s3psz4pl73kbl8fzb3la5-system-path/share/info/gawknotes.info' system-path> install-info: warning: no info dir entry in `/nix/store/0l9mbpz1hf4g6j0v3z414f0bh006s8n1-system-path/share/info/gawknotes.info' building '/nix/store/vg823x3yh7bgwiyjivxsh6nivllgby93-X-Restart-Triggers-nix-daemon.drv' X-Restart-Triggers-nix-daemon> tribuchet: building on jamie building '/nix/store/7wi46h9dfp5h3d6mb7sw98vlk3ghi2aa-X-Restart-Triggers-nix-daemon.drv' building '/nix/store/78kfrh18b31p6h3kvpp512p39m7i6j43-X-Restart-Triggers-systemd-tmpfiles-resetup.drv' X-Restart-Triggers-nix-daemon> tribuchet: building on jamie X-Restart-Triggers-systemd-tmpfiles-resetup> tribuchet: building on jamie building '/nix/store/ff3js9y8ph9yvf6s8b4cayxv4qqp308r-unit-nix-daemon.service.drv' unit-nix-daemon.service> tribuchet: building on jamie building '/nix/store/j95bs4w4d09m9whbk5yaxh410h6vbsng-unit-nix-daemon.service.drv' building '/nix/store/494dzwrxjwlkd7dc6d9c1qak5fdvrxb5-unit-systemd-tmpfiles-resetup.service.drv' unit-nix-daemon.service> tribuchet: building on jamie unit-systemd-tmpfiles-resetup.service> tribuchet: building on jamie building '/nix/store/i1rc4akxa7dc9iafszzx283b5fh1n1k9-dbus-1.drv' unit-nix-daemon.service> structuredAttrs is enabled unit-nix-daemon.service> structuredAttrs is enabled unit-systemd-tmpfiles-resetup.service> structuredAttrs is enabled building '/nix/store/x9x6a98zlcqq4nhsjx3awb03adjc8r9v-dbus-1.drv' dbus-1> tribuchet: building on jamie dbus-1> tribuchet: building on jamie building '/nix/store/6kvhipp7p8mpkkkvx3hisij14n9qlyyx-X-Restart-Triggers-dbus-broker.drv' X-Restart-Triggers-dbus-broker> tribuchet: building on jamie building '/nix/store/lfrg2ygp2kajwfjmllavwxarspk8lwwd-X-Restart-Triggers-dbus-broker.drv' X-Restart-Triggers-dbus-broker> tribuchet: building on jamie building '/nix/store/dq61y0yypwp4h613krcfvbfdn0f4pa7x-unit-dbus-broker.service.drv' building '/nix/store/inqli7kvhcjniwdd7s4pkdv80w74iva6-unit-dbus-broker.service.drv' unit-dbus-broker.service> tribuchet: building on jamie building '/nix/store/18089jjyxfdkq98wphqdayjnn4bhzjdf-unit-dbus-broker.service.drv' building '/nix/store/cf54w45ma45a5vjiysm64jvcfrim3zb5-unit-dbus-broker.service.drv' unit-dbus-broker.service> tribuchet: building on jamie unit-dbus-broker.service> tribuchet: building on jamie unit-dbus-broker.service> tribuchet: building on jamie unit-dbus-broker.service> structuredAttrs is enabled unit-dbus-broker.service> structuredAttrs is enabled unit-dbus-broker.service> structuredAttrs is enabled unit-dbus-broker.service> structuredAttrs is enabled building '/nix/store/adv52azgpkdl87mvixbqqrsh8hyyrh9k-system-units.drv' building '/nix/store/dk3ygjr2x7m0n9gczfpb9hph7bm2hlz7-system-units.drv' building '/nix/store/71jrwk0gzybx68vdyg6vhmnggxk122fm-user-units.drv' building '/nix/store/lb2ykvibwiiymjbi2ssgrlrrk0ypkf2k-user-units.drv' system-units> tribuchet: building on jamie system-units> tribuchet: building on jamie user-units> tribuchet: building on jamie user-units> tribuchet: building on jamie building '/nix/store/qj69qphadn8gfz472g6b1v4qngjvv2w3-etc.drv' building '/nix/store/xsyqb1dhwnav3a7s08h26ipafbzs8lsj-etc.drv' etc> tribuchet: building on jamie etc> tribuchet: building on jamie building '/nix/store/0wwhvi6j2nrbsxp30snas6dfgah4mqnb-activate.drv' activate> tribuchet: building on jamie building '/nix/store/hyf2syr8zhyy3sr20hr1490innllxhzz-activate.drv' activate> tribuchet: building on jamie building '/nix/store/6zll25zh7va53am37ym905j5335idmh7-nixos-system-server-test.drv' building '/nix/store/g82fyh561r489xjfif7gyz1c6pc3m0z3-nixos-system-host1-test.drv' nixos-system-server-test> tribuchet: building on jamie nixos-system-host1-test> tribuchet: building on jamie nixos-system-server-test> structuredAttrs is enabled nixos-system-host1-test> structuredAttrs is enabled building '/nix/store/hgpbz3fdvlbvdk86jp2a1nbwygd3zn80-closure-info.drv' building '/nix/store/fa4387dahf70fggfs84kqsvlfhy955ay-closure-info.drv' closure-info> tribuchet: building on jamie closure-info> structuredAttrs is enabled closure-info> tribuchet: building on jamie building '/nix/store/a1xvdblzwbk6b7cpb88szc6d8nczy4jv-run-nixos-vm.drv' closure-info> structuredAttrs is enabled run-nixos-vm> tribuchet: building on jamie building '/nix/store/6isd5lw556wnca93j6hlzm6l1xi5qhjg-run-nixos-vm.drv' run-nixos-vm> tribuchet: building on jamie building '/nix/store/4lw6zlimmip223lhwpmpmflz6shvx1ry-nixos-vm.drv' nixos-vm> tribuchet: building on jamie building '/nix/store/m9l2qzv2y28dpbyz4absxlf94710zmgh-nixos-vm.drv' nixos-vm> tribuchet: building on jamie building '/nix/store/brlldnpjhwjn8rh4kdbwp5hmafsy6yx4-driverConfiguration.json.drv' driverConfiguration.json> tribuchet: building on jamie driverConfiguration.json> structuredAttrs is enabled building '/nix/store/pdihbliagc8wca3iyvb81wgsfwx3wmxq-nixos-test-driver-nix-grpc-store-acme-substituter.drv' nixos-test-driver-nix-grpc-store-acme-substituter> tribuchet: building on jamie nixos-test-driver-nix-grpc-store-acme-substituter> Running type check (enable/disable: config.skipTypeCheck) nixos-test-driver-nix-grpc-store-acme-substituter> See https://nixos.org/manual/nixos/stable/#test-opt-skipTypeCheck nixos-test-driver-nix-grpc-store-acme-substituter> All checks passed! nixos-test-driver-nix-grpc-store-acme-substituter> Linting test script (enable/disable: config.skipLint) nixos-test-driver-nix-grpc-store-acme-substituter> See https://nixos.org/manual/nixos/stable/#test-opt-skipLint nixos-test-driver-nix-grpc-store-acme-substituter> All checks passed! building '/nix/store/0vk3q21glhzznkf9b41lw6zm1hf6bibw-vm-test-run-nix-grpc-store-acme-substituter.drv' vm-test-run-nix-grpc-store-acme-substituter> tribuchet: building on jamie vm-test-run-nix-grpc-store-acme-substituter> Machine state will be reset. To keep it, pass --keep-machine-state vm-test-run-nix-grpc-store-acme-substituter> start all VLans vm-test-run-nix-grpc-store-acme-substituter> (finished: start all VLans, in 0.00 seconds) vm-test-run-nix-grpc-store-acme-substituter> Test will time out and terminate in 600.0 seconds vm-test-run-nix-grpc-store-acme-substituter> run the VM test script vm-test-run-nix-grpc-store-acme-substituter> start all VMs vm-test-run-nix-grpc-store-acme-substituter> host1: starting vm vm-test-run-nix-grpc-store-acme-substituter> server: starting vm vm-test-run-nix-grpc-store-acme-substituter> host1: QEMU running (pid 47) vm-test-run-nix-grpc-store-acme-substituter> server # Disk image does not exist, creating the virtualisation disk image... vm-test-run-nix-grpc-store-acme-substituter> server: QEMU running (pid 48) vm-test-run-nix-grpc-store-acme-substituter> server # Formatting '/build/vm-state-server/tmp.ICs2hbnLoB', fmt=raw size=1073741824 vm-test-run-nix-grpc-store-acme-substituter> host1 # Disk image does not exist, creating the virtualisation disk image... vm-test-run-nix-grpc-store-acme-substituter> server # mke2fs 1.47.4 (6-Mar-2025) vm-test-run-nix-grpc-store-acme-substituter> host1 # Formatting '/build/vm-state-host1/tmp.2m2KyAuKwl', fmt=raw size=1073741824 vm-test-run-nix-grpc-store-acme-substituter> server # Discarding device blocks: 0/262144 done vm-test-run-nix-grpc-store-acme-substituter> host1 # mke2fs 1.47.4 (6-Mar-2025) vm-test-run-nix-grpc-store-acme-substituter> server # Creating filesystem with 262144 4k blocks and 65536 inodes vm-test-run-nix-grpc-store-acme-substituter> host1 # Discarding device blocks: 0/262144 done vm-test-run-nix-grpc-store-acme-substituter> server # Filesystem UUID: 4573ecbd-e9fe-4eab-95bf-2d5eb44269fc vm-test-run-nix-grpc-store-acme-substituter> host1 # Creating filesystem with 262144 4k blocks and 65536 inodes vm-test-run-nix-grpc-store-acme-substituter> server # Superblock backups stored on blocks: vm-test-run-nix-grpc-store-acme-substituter> host1 # Filesystem UUID: 814c2739-1f1a-424c-9498-7d7d3b24ac99 vm-test-run-nix-grpc-store-acme-substituter> server # 32768, 98304, 163840, 229376 vm-test-run-nix-grpc-store-acme-substituter> host1 # Superblock backups stored on blocks: vm-test-run-nix-grpc-store-acme-substituter> server # vm-test-run-nix-grpc-store-acme-substituter> host1 # 32768, 98304, 163840, 229376 vm-test-run-nix-grpc-store-acme-substituter> server # Allocating group tables: 0/8 done vm-test-run-nix-grpc-store-acme-substituter> host1 # vm-test-run-nix-grpc-store-acme-substituter> server # Writing inode tables: 0/8 done vm-test-run-nix-grpc-store-acme-substituter> host1 # Allocating group tables: 0/8 done vm-test-run-nix-grpc-store-acme-substituter> server # Creating journal (8192 blocks): done vm-test-run-nix-grpc-store-acme-substituter> host1 # Writing inode tables: 0/8 done vm-test-run-nix-grpc-store-acme-substituter> server # Writing superblocks and filesystem accounting information: 0/8 done vm-test-run-nix-grpc-store-acme-substituter> host1 # Creating journal (8192 blocks): done vm-test-run-nix-grpc-store-acme-substituter> server # vm-test-run-nix-grpc-store-acme-substituter> host1 # Writing superblocks and filesystem accounting information: 0/8 done vm-test-run-nix-grpc-store-acme-substituter> server # Virtualisation disk image created. vm-test-run-nix-grpc-store-acme-substituter> host1 # vm-test-run-nix-grpc-store-acme-substituter> server # KVM: entry failed, hardware error 0xffffffff vm-test-run-nix-grpc-store-acme-substituter> host1 # Virtualisation disk image created. vm-test-run-nix-grpc-store-acme-substituter> server # EAX=00000000 EBX=00000000 ECX=00000000 EDX=00a10f11 vm-test-run-nix-grpc-store-acme-substituter> host1 # KVM: entry failed, hardware error 0xffffffff vm-test-run-nix-grpc-store-acme-substituter> server # ESI=00000000 EDI=00000000 EBP=00000000 ESP=00000000 vm-test-run-nix-grpc-store-acme-substituter> host1 # EAX=00000000 EBX=00000000 ECX=00000000 EDX=00a10f11 vm-test-run-nix-grpc-store-acme-substituter> server # EIP=0000fff0 EFL=00000002 [-------] CPL=0 II=0 A20=1 SMM=0 HLT=0 vm-test-run-nix-grpc-store-acme-substituter> host1 # ESI=00000000 EDI=00000000 EBP=00000000 ESP=00000000 vm-test-run-nix-grpc-store-acme-substituter> server # ES =0000 00000000 0000ffff 00009300 vm-test-run-nix-grpc-store-acme-substituter> host1 # EIP=0000fff0 EFL=00000002 [-------] CPL=0 II=0 A20=1 SMM=0 HLT=0 vm-test-run-nix-grpc-store-acme-substituter> server # CS =f000 ffff0000 0000ffff 00009b00 vm-test-run-nix-grpc-store-acme-substituter> host1 # ES =0000 00000000 0000ffff 00009300 vm-test-run-nix-grpc-store-acme-substituter> server # SS =0000 00000000 0000ffff 00009300 vm-test-run-nix-grpc-store-acme-substituter> host1 # CS =f000 ffff0000 0000ffff 00009b00 vm-test-run-nix-grpc-store-acme-substituter> server # DS =0000 00000000 0000ffff 00009300 vm-test-run-nix-grpc-store-acme-substituter> host1 # SS =0000 00000000 0000ffff 00009300 vm-test-run-nix-grpc-store-acme-substituter> server # FS =0000 00000000 0000ffff 00009300 vm-test-run-nix-grpc-store-acme-substituter> host1 # DS =0000 00000000 0000ffff 00009300 vm-test-run-nix-grpc-store-acme-substituter> server # GS =0000 00000000 0000ffff 00009300 vm-test-run-nix-grpc-store-acme-substituter> host1 # FS =0000 00000000 0000ffff 00009300 vm-test-run-nix-grpc-store-acme-substituter> server # LDT=0000 00000000 0000ffff 00008200 vm-test-run-nix-grpc-store-acme-substituter> host1 # GS =0000 00000000 0000ffff 00009300 vm-test-run-nix-grpc-store-acme-substituter> server # TR =0000 00000000 0000ffff 00008b00 vm-test-run-nix-grpc-store-acme-substituter> host1 # LDT=0000 00000000 0000ffff 00008200 vm-test-run-nix-grpc-store-acme-substituter> server # GDT= 00000000 0000ffff vm-test-run-nix-grpc-store-acme-substituter> host1 # TR =0000 00000000 0000ffff 00008b00 vm-test-run-nix-grpc-store-acme-substituter> server # IDT= 00000000 0000ffff vm-test-run-nix-grpc-store-acme-substituter> host1 # GDT= 00000000 0000ffff vm-test-run-nix-grpc-store-acme-substituter> server # CR0=60000010 CR2=00000000 CR3=00000000 CR4=00000000 vm-test-run-nix-grpc-store-acme-substituter> host1 # IDT= 00000000 0000ffff vm-test-run-nix-grpc-store-acme-substituter> server # DR0=0000000000000000 DR1=0000000000000000 DR2=0000000000000000 DR3=0000000000000000 vm-test-run-nix-grpc-store-acme-substituter> host1 # CR0=60000010 CR2=00000000 CR3=00000000 CR4=00000000 vm-test-run-nix-grpc-store-acme-substituter> server # DR6=00000000ffff0ff0 DR7=0000000000000400 vm-test-run-nix-grpc-store-acme-substituter> host1 # DR0=0000000000000000 DR1=0000000000000000 DR2=0000000000000000 DR3=0000000000000000 vm-test-run-nix-grpc-store-acme-substituter> server # EFER=0000000000000000 vm-test-run-nix-grpc-store-acme-substituter> host1 # DR6=00000000ffff0ff0 DR7=0000000000000400 vm-test-run-nix-grpc-store-acme-substituter> server # Code=09 66 31 ca 80 fa 80 80 d9 00 66 0f b6 d1 e9 ce b6 cd 1b cb 5b e0 00 f0 30 36 2f 32 33 2f 39 39 00 fc 00 ?? ?? ?? ?? ?? ?? ?? ?? ?? ?? ?? ?? ?? ?? vm-test-run-nix-grpc-store-acme-substituter> host1 # EFER=0000000000000000 vm-test-run-nix-grpc-store-acme-substituter> (finished: start all VMs, in 0.21 seconds) vm-test-run-nix-grpc-store-acme-substituter> host1 # Code=09 66 31 ca 80 fa 80 80 d9 00 66 0f b6 d1 e9 ce b6 cd 1b cb 5b e0 00 f0 30 36 2f 32 33 2f 39 39 00 fc 00 ?? ?? ?? ?? ?? ?? ?? ?? ?? ?? ?? ?? ?? ?? vm-test-run-nix-grpc-store-acme-substituter> server: waiting for unit step-ca.service vm-test-run-nix-grpc-store-acme-substituter> server: waiting for the VM to finish booting vm-test-run-nix-grpc-store-acme-substituter> server: Guest root shell did not produce any data yet... vm-test-run-nix-grpc-store-acme-substituter> server: To debug, enter the VM and run 'systemctl status backdoor.service'. vm-test-run-nix-grpc-store-acme-substituter> server: Guest root shell did not produce any data yet... vm-test-run-nix-grpc-store-acme-substituter> server: To debug, enter the VM and run 'systemctl status backdoor.service'. vm-test-run-nix-grpc-store-acme-substituter> server: Guest root shell did not produce any data yet... vm-test-run-nix-grpc-store-acme-substituter> server: To debug, enter the VM and run 'systemctl status backdoor.service'. vm-test-run-nix-grpc-store-acme-substituter> server: Guest root shell did not produce any data yet... vm-test-run-nix-grpc-store-acme-substituter> server: To debug, enter the VM and run 'systemctl status backdoor.service'. vm-test-run-nix-grpc-store-acme-substituter> server: Guest root shell did not produce any data yet... vm-test-run-nix-grpc-store-acme-substituter> server: To debug, enter the VM and run 'systemctl status backdoor.service'. vm-test-run-nix-grpc-store-acme-substituter> server: Guest root shell did not produce any data yet... vm-test-run-nix-grpc-store-acme-substituter> server: To debug, enter the VM and run 'systemctl status backdoor.service'. vm-test-run-nix-grpc-store-acme-substituter> server: Guest root shell did not produce any data yet... vm-test-run-nix-grpc-store-acme-substituter> server: To debug, enter the VM and run 'systemctl status backdoor.service'. vm-test-run-nix-grpc-store-acme-substituter> server: Guest root shell did not produce any data yet... vm-test-run-nix-grpc-store-acme-substituter> server: To debug, enter the VM and run 'systemctl status backdoor.service'. vm-test-run-nix-grpc-store-acme-substituter> server: Guest root shell did not produce any data yet... vm-test-run-nix-grpc-store-acme-substituter> server: To debug, enter the VM and run 'systemctl status backdoor.service'. vm-test-run-nix-grpc-store-acme-substituter> server: Guest root shell did not produce any data yet... vm-test-run-nix-grpc-store-acme-substituter> server: To debug, enter the VM and run 'systemctl status backdoor.service'. vm-test-run-nix-grpc-store-acme-substituter> cleanup vm-test-run-nix-grpc-store-acme-substituter> kill QemuMachine (pid 47) vm-test-run-nix-grpc-store-acme-substituter> host1 # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/bin/python3.14) vm-test-run-nix-grpc-store-acme-substituter> kill QemuMachine (pid 48) vm-test-run-nix-grpc-store-acme-substituter> server # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/bin/python3.14) vm-test-run-nix-grpc-store-acme-substituter> (finished: cleanup, in 0.11 seconds) vm-test-run-nix-grpc-store-acme-substituter> additionally exposed symbols: vm-test-run-nix-grpc-store-acme-substituter> host1, server, vm-test-run-nix-grpc-store-acme-substituter> vlan1, vm-test-run-nix-grpc-store-acme-substituter> start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh vm-test-run-nix-grpc-store-acme-substituter> Traceback (most recent call last): vm-test-run-nix-grpc-store-acme-substituter> File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/bin/.nixos-test-driver-wrapped", line 9, in vm-test-run-nix-grpc-store-acme-substituter> sys.exit(main()) vm-test-run-nix-grpc-store-acme-substituter> ~~~~^^ vm-test-run-nix-grpc-store-acme-substituter> File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/__init__.py", line 194, in main vm-test-run-nix-grpc-store-acme-substituter> driver.run_tests() vm-test-run-nix-grpc-store-acme-substituter> ~~~~~~~~~~~~~~~~^^ vm-test-run-nix-grpc-store-acme-substituter> File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/driver.py", line 437, in run_tests vm-test-run-nix-grpc-store-acme-substituter> self.test_script() vm-test-run-nix-grpc-store-acme-substituter> ~~~~~~~~~~~~~~~~^^ vm-test-run-nix-grpc-store-acme-substituter> File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/driver.py", line 395, in test_script vm-test-run-nix-grpc-store-acme-substituter> exec(self.tests, symbols, None) vm-test-run-nix-grpc-store-acme-substituter> ~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^ vm-test-run-nix-grpc-store-acme-substituter> File "", line 2, in vm-test-run-nix-grpc-store-acme-substituter> File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 405, in wait_for_unit vm-test-run-nix-grpc-store-acme-substituter> retry(check_active, as_timedelta(timeout)) vm-test-run-nix-grpc-store-acme-substituter> ~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ vm-test-run-nix-grpc-store-acme-substituter> File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 141, in retry vm-test-run-nix-grpc-store-acme-substituter> if fn(False): vm-test-run-nix-grpc-store-acme-substituter> ~~^^^^^^^ vm-test-run-nix-grpc-store-acme-substituter> File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 386, in check_active vm-test-run-nix-grpc-store-acme-substituter> state = self.get_unit_property(unit, "ActiveState", user) vm-test-run-nix-grpc-store-acme-substituter> File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 441, in get_unit_property vm-test-run-nix-grpc-store-acme-substituter> status, lines = self.systemctl( vm-test-run-nix-grpc-store-acme-substituter> ~~~~~~~~~~~~~~^ vm-test-run-nix-grpc-store-acme-substituter> f'--no-pager show "{unit}" --property="{property}"', vm-test-run-nix-grpc-store-acme-substituter> ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ vm-test-run-nix-grpc-store-acme-substituter> user, vm-test-run-nix-grpc-store-acme-substituter> ^^^^^ vm-test-run-nix-grpc-store-acme-substituter> ) vm-test-run-nix-grpc-store-acme-substituter> ^ vm-test-run-nix-grpc-store-acme-substituter> File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 370, in systemctl vm-test-run-nix-grpc-store-acme-substituter> return self.execute(f"systemctl {q}") vm-test-run-nix-grpc-store-acme-substituter> ~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^ vm-test-run-nix-grpc-store-acme-substituter> File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 722, in execute vm-test-run-nix-grpc-store-acme-substituter> return self._execute( vm-test-run-nix-grpc-store-acme-substituter> ~~~~~~~~~~~~~^ vm-test-run-nix-grpc-store-acme-substituter> command=command, vm-test-run-nix-grpc-store-acme-substituter> ^^^^^^^^^^^^^^^^ vm-test-run-nix-grpc-store-acme-substituter> ...<2 lines>... vm-test-run-nix-grpc-store-acme-substituter> timeout=as_timedelta(timeout) if timeout is not None else None, vm-test-run-nix-grpc-store-acme-substituter> ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ vm-test-run-nix-grpc-store-acme-substituter> ) vm-test-run-nix-grpc-store-acme-substituter> ^ vm-test-run-nix-grpc-store-acme-substituter> File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 983, in _execute vm-test-run-nix-grpc-store-acme-substituter> self.connect() vm-test-run-nix-grpc-store-acme-substituter> ~~~~~~~~~~~~^^ vm-test-run-nix-grpc-store-acme-substituter> File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 1172, in connect vm-test-run-nix-grpc-store-acme-substituter> raise RuntimeError("Shell did not start in time") vm-test-run-nix-grpc-store-acme-substituter> RuntimeError: Shell did not start in time error: Cannot build '/nix/store/0vk3q21glhzznkf9b41lw6zm1hf6bibw-vm-test-run-nix-grpc-store-acme-substituter.drv'. Reason: builder failed with exit code 1. Output paths: /nix/store/szywn0aw6v4akm9f4hzrqh5wjz60kwgn-vm-test-run-nix-grpc-store-acme-substituter Last 25 log lines: > f'--no-pager show "{unit}" --property="{property}"', > ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ > user, > ^^^^^ > ) > ^ > File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 370, in systemctl > return self.execute(f"systemctl {q}") > ~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^ > File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 722, in execute > return self._execute( > ~~~~~~~~~~~~~^ > command=command, > ^^^^^^^^^^^^^^^^ > ...<2 lines>... > timeout=as_timedelta(timeout) if timeout is not None else None, > ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ > ) > ^ > File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 983, in _execute > self.connect() > ~~~~~~~~~~~~^^ > File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 1172, in connect > raise RuntimeError("Shell did not start in time") > RuntimeError: Shell did not start in time For full logs, run: nix log /nix/store/0vk3q21glhzznkf9b41lw6zm1hf6bibw-vm-test-run-nix-grpc-store-acme-substituter.drv nixbot: transient error detected, retrying once this derivation will be built: /nix/store/0vk3q21glhzznkf9b41lw6zm1hf6bibw-vm-test-run-nix-grpc-store-acme-substituter.drv building '/nix/store/0vk3q21glhzznkf9b41lw6zm1hf6bibw-vm-test-run-nix-grpc-store-acme-substituter.drv' vm-test-run-nix-grpc-store-acme-substituter> tribuchet: building on jamie vm-test-run-nix-grpc-store-acme-substituter> Machine state will be reset. To keep it, pass --keep-machine-state vm-test-run-nix-grpc-store-acme-substituter> start all VLans vm-test-run-nix-grpc-store-acme-substituter> (finished: start all VLans, in 0.00 seconds) vm-test-run-nix-grpc-store-acme-substituter> Test will time out and terminate in 600.0 seconds vm-test-run-nix-grpc-store-acme-substituter> run the VM test script vm-test-run-nix-grpc-store-acme-substituter> start all VMs vm-test-run-nix-grpc-store-acme-substituter> host1: starting vm vm-test-run-nix-grpc-store-acme-substituter> server: starting vm vm-test-run-nix-grpc-store-acme-substituter> server: QEMU running (pid 48) vm-test-run-nix-grpc-store-acme-substituter> server # Disk image does not exist, creating the virtualisation disk image... vm-test-run-nix-grpc-store-acme-substituter> server # Formatting '/build/vm-state-server/tmp.8cURAJ3HL7', fmt=raw size=1073741824 vm-test-run-nix-grpc-store-acme-substituter> server # mke2fs 1.47.4 (6-Mar-2025) vm-test-run-nix-grpc-store-acme-substituter> server # Discarding device blocks: 0/262144 done vm-test-run-nix-grpc-store-acme-substituter> server # Creating filesystem with 262144 4k blocks and 65536 inodes vm-test-run-nix-grpc-store-acme-substituter> server # Filesystem UUID: 52965386-8de7-4c6e-9512-5ac99ee14a89 vm-test-run-nix-grpc-store-acme-substituter> server # Superblock backups stored on blocks: vm-test-run-nix-grpc-store-acme-substituter> server # 32768, 98304, 163840, 229376 vm-test-run-nix-grpc-store-acme-substituter> server # vm-test-run-nix-grpc-store-acme-substituter> server # Allocating group tables: 0/8 done vm-test-run-nix-grpc-store-acme-substituter> server # Writing inode tables: 0/8 done vm-test-run-nix-grpc-store-acme-substituter> server # Creating journal (8192 blocks): done vm-test-run-nix-grpc-store-acme-substituter> server # Writing superblocks and filesystem accounting information: 0/8 done vm-test-run-nix-grpc-store-acme-substituter> server # vm-test-run-nix-grpc-store-acme-substituter> server # Virtualisation disk image created. vm-test-run-nix-grpc-store-acme-substituter> server # KVM: entry failed, hardware error 0xffffffff vm-test-run-nix-grpc-store-acme-substituter> server # EAX=00000000 EBX=00000000 ECX=00000000 EDX=00a10f11 vm-test-run-nix-grpc-store-acme-substituter> server # ESI=00000000 EDI=00000000 EBP=00000000 ESP=00000000 vm-test-run-nix-grpc-store-acme-substituter> server # EIP=0000fff0 EFL=00000002 [-------] CPL=0 II=0 A20=1 SMM=0 HLT=0 vm-test-run-nix-grpc-store-acme-substituter> server # ES =0000 00000000 0000ffff 00009300 vm-test-run-nix-grpc-store-acme-substituter> server # CS =f000 ffff0000 0000ffff 00009b00 vm-test-run-nix-grpc-store-acme-substituter> server # SS =0000 00000000 0000ffff 00009300 vm-test-run-nix-grpc-store-acme-substituter> server # DS =0000 00000000 0000ffff 00009300 vm-test-run-nix-grpc-store-acme-substituter> server # FS =0000 00000000 0000ffff 00009300 vm-test-run-nix-grpc-store-acme-substituter> server # GS =0000 00000000 0000ffff 00009300 vm-test-run-nix-grpc-store-acme-substituter> server # LDT=0000 00000000 0000ffff 00008200 vm-test-run-nix-grpc-store-acme-substituter> server # TR =0000 00000000 0000ffff 00008b00 vm-test-run-nix-grpc-store-acme-substituter> server # GDT= 00000000 0000ffff vm-test-run-nix-grpc-store-acme-substituter> server # IDT= 00000000 0000ffff vm-test-run-nix-grpc-store-acme-substituter> server # CR0=60000010 CR2=00000000 CR3=00000000 CR4=00000000 vm-test-run-nix-grpc-store-acme-substituter> server # DR0=0000000000000000 DR1=0000000000000000 DR2=0000000000000000 DR3=0000000000000000 vm-test-run-nix-grpc-store-acme-substituter> server # DR6=00000000ffff0ff0 DR7=0000000000000400 vm-test-run-nix-grpc-store-acme-substituter> server # EFER=0000000000000000 vm-test-run-nix-grpc-store-acme-substituter> server # Code=09 66 31 ca 80 fa 80 80 d9 00 66 0f b6 d1 e9 ce b6 cd 1b cb 5b e0 00 f0 30 36 2f 32 33 2f 39 39 00 fc 00 ?? ?? ?? ?? ?? ?? ?? ?? ?? ?? ?? ?? ?? ?? vm-test-run-nix-grpc-store-acme-substituter> host1: QEMU running (pid 47) vm-test-run-nix-grpc-store-acme-substituter> host1 # Disk image does not exist, creating the virtualisation disk image... vm-test-run-nix-grpc-store-acme-substituter> host1 # Formatting '/build/vm-state-host1/tmp.e1nSw2QRrw', fmt=raw size=1073741824 vm-test-run-nix-grpc-store-acme-substituter> host1 # mke2fs 1.47.4 (6-Mar-2025) vm-test-run-nix-grpc-store-acme-substituter> host1 # Discarding device blocks: 0/262144 done vm-test-run-nix-grpc-store-acme-substituter> host1 # Creating filesystem with 262144 4k blocks and 65536 inodes vm-test-run-nix-grpc-store-acme-substituter> (finished: start all VMs, in 0.23 seconds) vm-test-run-nix-grpc-store-acme-substituter> host1 # Filesystem UUID: c435e7c2-2850-4429-b17e-626353b38464 vm-test-run-nix-grpc-store-acme-substituter> server: waiting for unit step-ca.service vm-test-run-nix-grpc-store-acme-substituter> host1 # Superblock backups stored on blocks: vm-test-run-nix-grpc-store-acme-substituter> server: waiting for the VM to finish booting vm-test-run-nix-grpc-store-acme-substituter> host1 # 32768, 98304, 163840, 229376 vm-test-run-nix-grpc-store-acme-substituter> host1 # vm-test-run-nix-grpc-store-acme-substituter> host1 # Allocating group tables: 0/8 done vm-test-run-nix-grpc-store-acme-substituter> host1 # Writing inode tables: 0/8 done vm-test-run-nix-grpc-store-acme-substituter> host1 # Creating journal (8192 blocks): done vm-test-run-nix-grpc-store-acme-substituter> host1 # Writing superblocks and filesystem accounting information: 0/8 done vm-test-run-nix-grpc-store-acme-substituter> host1 # vm-test-run-nix-grpc-store-acme-substituter> host1 # Virtualisation disk image created. vm-test-run-nix-grpc-store-acme-substituter> host1 # KVM: entry failed, hardware error 0xffffffff vm-test-run-nix-grpc-store-acme-substituter> host1 # EAX=00000000 EBX=00000000 ECX=00000000 EDX=00a10f11 vm-test-run-nix-grpc-store-acme-substituter> host1 # ESI=00000000 EDI=00000000 EBP=00000000 ESP=00000000 vm-test-run-nix-grpc-store-acme-substituter> host1 # EIP=0000fff0 EFL=00000002 [-------] CPL=0 II=0 A20=1 SMM=0 HLT=0 vm-test-run-nix-grpc-store-acme-substituter> host1 # ES =0000 00000000 0000ffff 00009300 vm-test-run-nix-grpc-store-acme-substituter> host1 # CS =f000 ffff0000 0000ffff 00009b00 vm-test-run-nix-grpc-store-acme-substituter> host1 # SS =0000 00000000 0000ffff 00009300 vm-test-run-nix-grpc-store-acme-substituter> host1 # DS =0000 00000000 0000ffff 00009300 vm-test-run-nix-grpc-store-acme-substituter> host1 # FS =0000 00000000 0000ffff 00009300 vm-test-run-nix-grpc-store-acme-substituter> host1 # GS =0000 00000000 0000ffff 00009300 vm-test-run-nix-grpc-store-acme-substituter> host1 # LDT=0000 00000000 0000ffff 00008200 vm-test-run-nix-grpc-store-acme-substituter> host1 # TR =0000 00000000 0000ffff 00008b00 vm-test-run-nix-grpc-store-acme-substituter> host1 # GDT= 00000000 0000ffff vm-test-run-nix-grpc-store-acme-substituter> host1 # IDT= 00000000 0000ffff vm-test-run-nix-grpc-store-acme-substituter> host1 # CR0=60000010 CR2=00000000 CR3=00000000 CR4=00000000 vm-test-run-nix-grpc-store-acme-substituter> host1 # DR0=0000000000000000 DR1=0000000000000000 DR2=0000000000000000 DR3=0000000000000000 vm-test-run-nix-grpc-store-acme-substituter> host1 # DR6=00000000ffff0ff0 DR7=0000000000000400 vm-test-run-nix-grpc-store-acme-substituter> host1 # EFER=0000000000000000 vm-test-run-nix-grpc-store-acme-substituter> host1 # Code=09 66 31 ca 80 fa 80 80 d9 00 66 0f b6 d1 e9 ce b6 cd 1b cb 5b e0 00 f0 30 36 2f 32 33 2f 39 39 00 fc 00 ?? ?? ?? ?? ?? ?? ?? ?? ?? ?? ?? ?? ?? ?? vm-test-run-nix-grpc-store-acme-substituter> server: Guest root shell did not produce any data yet... vm-test-run-nix-grpc-store-acme-substituter> server: To debug, enter the VM and run 'systemctl status backdoor.service'. vm-test-run-nix-grpc-store-acme-substituter> server: Guest root shell did not produce any data yet... vm-test-run-nix-grpc-store-acme-substituter> server: To debug, enter the VM and run 'systemctl status backdoor.service'. vm-test-run-nix-grpc-store-acme-substituter> server: Guest root shell did not produce any data yet... vm-test-run-nix-grpc-store-acme-substituter> server: To debug, enter the VM and run 'systemctl status backdoor.service'. vm-test-run-nix-grpc-store-acme-substituter> server: Guest root shell did not produce any data yet... vm-test-run-nix-grpc-store-acme-substituter> server: To debug, enter the VM and run 'systemctl status backdoor.service'. vm-test-run-nix-grpc-store-acme-substituter> server: Guest root shell did not produce any data yet... vm-test-run-nix-grpc-store-acme-substituter> server: To debug, enter the VM and run 'systemctl status backdoor.service'. vm-test-run-nix-grpc-store-acme-substituter> server: Guest root shell did not produce any data yet... vm-test-run-nix-grpc-store-acme-substituter> server: To debug, enter the VM and run 'systemctl status backdoor.service'. vm-test-run-nix-grpc-store-acme-substituter> server: Guest root shell did not produce any data yet... vm-test-run-nix-grpc-store-acme-substituter> server: To debug, enter the VM and run 'systemctl status backdoor.service'. vm-test-run-nix-grpc-store-acme-substituter> server: Guest root shell did not produce any data yet... vm-test-run-nix-grpc-store-acme-substituter> server: To debug, enter the VM and run 'systemctl status backdoor.service'. vm-test-run-nix-grpc-store-acme-substituter> server: Guest root shell did not produce any data yet... vm-test-run-nix-grpc-store-acme-substituter> server: To debug, enter the VM and run 'systemctl status backdoor.service'. vm-test-run-nix-grpc-store-acme-substituter> server: Guest root shell did not produce any data yet... vm-test-run-nix-grpc-store-acme-substituter> server: To debug, enter the VM and run 'systemctl status backdoor.service'. vm-test-run-nix-grpc-store-acme-substituter> cleanup vm-test-run-nix-grpc-store-acme-substituter> kill QemuMachine (pid 47) vm-test-run-nix-grpc-store-acme-substituter> host1 # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/bin/python3.14) vm-test-run-nix-grpc-store-acme-substituter> kill QemuMachine (pid 48) vm-test-run-nix-grpc-store-acme-substituter> server # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/bin/python3.14) vm-test-run-nix-grpc-store-acme-substituter> (finished: cleanup, in 0.12 seconds) vm-test-run-nix-grpc-store-acme-substituter> additionally exposed symbols: vm-test-run-nix-grpc-store-acme-substituter> host1, server, vm-test-run-nix-grpc-store-acme-substituter> vlan1, vm-test-run-nix-grpc-store-acme-substituter> start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh vm-test-run-nix-grpc-store-acme-substituter> Traceback (most recent call last): vm-test-run-nix-grpc-store-acme-substituter> File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/bin/.nixos-test-driver-wrapped", line 9, in vm-test-run-nix-grpc-store-acme-substituter> sys.exit(main()) vm-test-run-nix-grpc-store-acme-substituter> ~~~~^^ vm-test-run-nix-grpc-store-acme-substituter> File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/__init__.py", line 194, in main vm-test-run-nix-grpc-store-acme-substituter> driver.run_tests() vm-test-run-nix-grpc-store-acme-substituter> ~~~~~~~~~~~~~~~~^^ vm-test-run-nix-grpc-store-acme-substituter> File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/driver.py", line 437, in run_tests vm-test-run-nix-grpc-store-acme-substituter> self.test_script() vm-test-run-nix-grpc-store-acme-substituter> ~~~~~~~~~~~~~~~~^^ vm-test-run-nix-grpc-store-acme-substituter> File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/driver.py", line 395, in test_script vm-test-run-nix-grpc-store-acme-substituter> exec(self.tests, symbols, None) vm-test-run-nix-grpc-store-acme-substituter> ~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^ vm-test-run-nix-grpc-store-acme-substituter> File "", line 2, in vm-test-run-nix-grpc-store-acme-substituter> File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 405, in wait_for_unit vm-test-run-nix-grpc-store-acme-substituter> retry(check_active, as_timedelta(timeout)) vm-test-run-nix-grpc-store-acme-substituter> ~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ vm-test-run-nix-grpc-store-acme-substituter> File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 141, in retry vm-test-run-nix-grpc-store-acme-substituter> if fn(False): vm-test-run-nix-grpc-store-acme-substituter> ~~^^^^^^^ vm-test-run-nix-grpc-store-acme-substituter> File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 386, in check_active vm-test-run-nix-grpc-store-acme-substituter> state = self.get_unit_property(unit, "ActiveState", user) vm-test-run-nix-grpc-store-acme-substituter> File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 441, in get_unit_property vm-test-run-nix-grpc-store-acme-substituter> status, lines = self.systemctl( vm-test-run-nix-grpc-store-acme-substituter> ~~~~~~~~~~~~~~^ vm-test-run-nix-grpc-store-acme-substituter> f'--no-pager show "{unit}" --property="{property}"', vm-test-run-nix-grpc-store-acme-substituter> ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ vm-test-run-nix-grpc-store-acme-substituter> user, vm-test-run-nix-grpc-store-acme-substituter> ^^^^^ vm-test-run-nix-grpc-store-acme-substituter> ) vm-test-run-nix-grpc-store-acme-substituter> ^ vm-test-run-nix-grpc-store-acme-substituter> File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 370, in systemctl vm-test-run-nix-grpc-store-acme-substituter> return self.execute(f"systemctl {q}") vm-test-run-nix-grpc-store-acme-substituter> ~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^ vm-test-run-nix-grpc-store-acme-substituter> File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 722, in execute vm-test-run-nix-grpc-store-acme-substituter> return self._execute( vm-test-run-nix-grpc-store-acme-substituter> ~~~~~~~~~~~~~^ vm-test-run-nix-grpc-store-acme-substituter> command=command, vm-test-run-nix-grpc-store-acme-substituter> ^^^^^^^^^^^^^^^^ vm-test-run-nix-grpc-store-acme-substituter> ...<2 lines>... vm-test-run-nix-grpc-store-acme-substituter> timeout=as_timedelta(timeout) if timeout is not None else None, vm-test-run-nix-grpc-store-acme-substituter> ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ vm-test-run-nix-grpc-store-acme-substituter> ) vm-test-run-nix-grpc-store-acme-substituter> ^ vm-test-run-nix-grpc-store-acme-substituter> File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 983, in _execute vm-test-run-nix-grpc-store-acme-substituter> self.connect() vm-test-run-nix-grpc-store-acme-substituter> ~~~~~~~~~~~~^^ vm-test-run-nix-grpc-store-acme-substituter> File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 1172, in connect vm-test-run-nix-grpc-store-acme-substituter> raise RuntimeError("Shell did not start in time") vm-test-run-nix-grpc-store-acme-substituter> RuntimeError: Shell did not start in time error: Cannot build '/nix/store/0vk3q21glhzznkf9b41lw6zm1hf6bibw-vm-test-run-nix-grpc-store-acme-substituter.drv'. Reason: builder failed with exit code 1. Output paths: /nix/store/szywn0aw6v4akm9f4hzrqh5wjz60kwgn-vm-test-run-nix-grpc-store-acme-substituter Last 25 log lines: > f'--no-pager show "{unit}" --property="{property}"', > ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ > user, > ^^^^^ > ) > ^ > File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 370, in systemctl > return self.execute(f"systemctl {q}") > ~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^ > File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 722, in execute > return self._execute( > ~~~~~~~~~~~~~^ > command=command, > ^^^^^^^^^^^^^^^^ > ...<2 lines>... > timeout=as_timedelta(timeout) if timeout is not None else None, > ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ > ) > ^ > File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 983, in _execute > self.connect() > ~~~~~~~~~~~~^^ > File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 1172, in connect > raise RuntimeError("Shell did not start in time") > RuntimeError: Shell did not start in time For full logs, run: nix log /nix/store/0vk3q21glhzznkf9b41lw6zm1hf6bibw-vm-test-run-nix-grpc-store-acme-substituter.drv