vm-test-run-nix-grpc-store-acme-substituter
checks.x86_64-linux.acme-vm
· build #76
· raw
1tribuchet: building on jamie2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.00 seconds)5Test will time out and terminate in 600.0 seconds6run the VM test script7start all VMs8host1: starting vm9server: starting vm10server: QEMU running (pid 48)11server # Disk image does not exist, creating the virtualisation disk image...12server # Formatting '/build/vm-state-server/tmp.8cURAJ3HL7', fmt=raw size=107374182413server # mke2fs 1.47.4 (6-Mar-2025)14server # Discarding device blocks: 0/262144 done15server # Creating filesystem with 262144 4k blocks and 65536 inodes16server # Filesystem UUID: 52965386-8de7-4c6e-9512-5ac99ee14a8917server # Superblock backups stored on blocks:18server # 32768, 98304, 163840, 22937619server # 20server # Allocating group tables: 0/8 done21server # Writing inode tables: 0/8 done22server # Creating journal (8192 blocks): done23server # Writing superblocks and filesystem accounting information: 0/8 done24server # 25server # Virtualisation disk image created.26server # KVM: entry failed, hardware error 0xffffffff27server # EAX=00000000 EBX=00000000 ECX=00000000 EDX=00a10f1128server # ESI=00000000 EDI=00000000 EBP=00000000 ESP=0000000029server # EIP=0000fff0 EFL=00000002 [-------] CPL=0 II=0 A20=1 SMM=0 HLT=030server # ES =0000 00000000 0000ffff 0000930031server # CS =f000 ffff0000 0000ffff 00009b0032server # SS =0000 00000000 0000ffff 0000930033server # DS =0000 00000000 0000ffff 0000930034server # FS =0000 00000000 0000ffff 0000930035server # GS =0000 00000000 0000ffff 0000930036server # LDT=0000 00000000 0000ffff 0000820037server # TR =0000 00000000 0000ffff 00008b0038server # GDT= 00000000 0000ffff39server # IDT= 00000000 0000ffff40server # CR0=60000010 CR2=00000000 CR3=00000000 CR4=0000000041server # DR0=0000000000000000 DR1=0000000000000000 DR2=0000000000000000 DR3=000000000000000042server # DR6=00000000ffff0ff0 DR7=000000000000040043server # EFER=000000000000000044server # Code=09 66 31 ca 80 fa 80 80 d9 00 66 0f b6 d1 e9 ce b6 cd 1b cb <ea> 5b e0 00 f0 30 36 2f 32 33 2f 39 39 00 fc 00 ?? ?? ?? ?? ?? ?? ?? ?? ?? ?? ?? ?? ?? ??45host1: QEMU running (pid 47)46host1 # Disk image does not exist, creating the virtualisation disk image...47host1 # Formatting '/build/vm-state-host1/tmp.e1nSw2QRrw', fmt=raw size=107374182448host1 # mke2fs 1.47.4 (6-Mar-2025)49host1 # Discarding device blocks: 0/262144 done50host1 # Creating filesystem with 262144 4k blocks and 65536 inodes51(finished: start all VMs, in 0.23 seconds)52host1 # Filesystem UUID: c435e7c2-2850-4429-b17e-626353b3846453server: waiting for unit step-ca.service54host1 # Superblock backups stored on blocks:55server: waiting for the VM to finish booting56host1 # 32768, 98304, 163840, 22937657host1 # 58host1 # Allocating group tables: 0/8 done59host1 # Writing inode tables: 0/8 done60host1 # Creating journal (8192 blocks): done61host1 # Writing superblocks and filesystem accounting information: 0/8 done62host1 # 63host1 # Virtualisation disk image created.64host1 # KVM: entry failed, hardware error 0xffffffff65host1 # EAX=00000000 EBX=00000000 ECX=00000000 EDX=00a10f1166host1 # ESI=00000000 EDI=00000000 EBP=00000000 ESP=0000000067host1 # EIP=0000fff0 EFL=00000002 [-------] CPL=0 II=0 A20=1 SMM=0 HLT=068host1 # ES =0000 00000000 0000ffff 0000930069host1 # CS =f000 ffff0000 0000ffff 00009b0070host1 # SS =0000 00000000 0000ffff 0000930071host1 # DS =0000 00000000 0000ffff 0000930072host1 # FS =0000 00000000 0000ffff 0000930073host1 # GS =0000 00000000 0000ffff 0000930074host1 # LDT=0000 00000000 0000ffff 0000820075host1 # TR =0000 00000000 0000ffff 00008b0076host1 # GDT= 00000000 0000ffff77host1 # IDT= 00000000 0000ffff78host1 # CR0=60000010 CR2=00000000 CR3=00000000 CR4=0000000079host1 # DR0=0000000000000000 DR1=0000000000000000 DR2=0000000000000000 DR3=000000000000000080host1 # DR6=00000000ffff0ff0 DR7=000000000000040081host1 # EFER=000000000000000082host1 # Code=09 66 31 ca 80 fa 80 80 d9 00 66 0f b6 d1 e9 ce b6 cd 1b cb <ea> 5b e0 00 f0 30 36 2f 32 33 2f 39 39 00 fc 00 ?? ?? ?? ?? ?? ?? ?? ?? ?? ?? ?? ?? ?? ??83server: Guest root shell did not produce any data yet...84server: To debug, enter the VM and run 'systemctl status backdoor.service'.85server: Guest root shell did not produce any data yet...86server: To debug, enter the VM and run 'systemctl status backdoor.service'.87server: Guest root shell did not produce any data yet...88server: To debug, enter the VM and run 'systemctl status backdoor.service'.89server: Guest root shell did not produce any data yet...90server: To debug, enter the VM and run 'systemctl status backdoor.service'.91server: Guest root shell did not produce any data yet...92server: To debug, enter the VM and run 'systemctl status backdoor.service'.93server: Guest root shell did not produce any data yet...94server: To debug, enter the VM and run 'systemctl status backdoor.service'.95server: Guest root shell did not produce any data yet...96server: To debug, enter the VM and run 'systemctl status backdoor.service'.97server: Guest root shell did not produce any data yet...98server: To debug, enter the VM and run 'systemctl status backdoor.service'.99server: Guest root shell did not produce any data yet...100server: To debug, enter the VM and run 'systemctl status backdoor.service'.101server: Guest root shell did not produce any data yet...102server: To debug, enter the VM and run 'systemctl status backdoor.service'.103cleanup104kill QemuMachine (pid 47)105host1 # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/bin/python3.14)106kill QemuMachine (pid 48)107server # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/bin/python3.14)108(finished: cleanup, in 0.12 seconds)109additionally exposed symbols:110 host1, server,111 vlan1,112 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_ssh113Traceback (most recent call last):114 File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/bin/.nixos-test-driver-wrapped", line 9, in <module>115 sys.exit(main())116 ~~~~^^117 File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/__init__.py", line 194, in main118 driver.run_tests()119 ~~~~~~~~~~~~~~~~^^120 File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/driver.py", line 437, in run_tests121 self.test_script()122 ~~~~~~~~~~~~~~~~^^123 File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/driver.py", line 395, in test_script124 exec(self.tests, symbols, None)125 ~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^126 File "<string>", line 2, in <module>127 File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 405, in wait_for_unit128 retry(check_active, as_timedelta(timeout))129 ~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^130 File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 141, in retry131 if fn(False):132 ~~^^^^^^^133 File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 386, in check_active134 state = self.get_unit_property(unit, "ActiveState", user)135 File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 441, in get_unit_property136 status, lines = self.systemctl(137 ~~~~~~~~~~~~~~^138 f'--no-pager show "{unit}" --property="{property}"',139 ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^140 user,141 ^^^^^142 )143 ^144 File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 370, in systemctl145 return self.execute(f"systemctl {q}")146 ~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^147 File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 722, in execute148 return self._execute(149 ~~~~~~~~~~~~~^150 command=command,151 ^^^^^^^^^^^^^^^^152 ...<2 lines>...153 timeout=as_timedelta(timeout) if timeout is not None else None,154 ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^155 )156 ^157 File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 983, in _execute158 self.connect()159 ~~~~~~~~~~~~^^160 File "/nix/store/raq2dn1v9hnqcadzwci0xzc3ayjzpqy3-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 1172, in connect161 raise RuntimeError("Shell did not start in time")162RuntimeError: Shell did not start in time