these 6 derivations will be built: /nix/store/2rxrzsidfcj9kkv95w45vclkxcpcidjf-disko-format.drv /nix/store/gcg9bs2p5by0qf579qqklpm21rqr52b8-disko-destroy-format-mount.drv /nix/store/wi4pdkxl3kb78x83g7sy2q3z13r25vg2-test-script.drv /nix/store/rfkl47jj3m1ixs5vlnflj2fqwkik4zan-driverConfiguration.json.drv /nix/store/hb39dkvbs7fyawfwqwiahqljl9666q81-nixos-test-driver-disko-bcachefs.drv /nix/store/i2gh8k7a5k8hj2s2lhk5n9qjq2zha6ir-vm-test-run-disko-bcachefs.drv error: Cannot build '/nix/store/i2gh8k7a5k8hj2s2lhk5n9qjq2zha6ir-vm-test-run-disko-bcachefs.drv'. Reason: builder failed with exit code 1. Output paths: /nix/store/8mflcl33s6s2i6f5vfmixgaaj1rk3mhp-vm-test-run-disko-bcachefs Last 25 log lines: > booted_machine # > booted_machine # [ 20.523286] systemd-tty-ask-password-agent[250]: Password query on /dev/tty1 finished successfully. > booted_machine # [ 20.525104] unlock-bcachefs-nix-start[243]: bcachefs (/dev/disk/by-uuid/88d9c058-757d-c06e-0fb7-a612f2db8a7a): error reading superblock: Device or resource busy > booted_machine # [ 20.526953] systemd[1]: unlock-bcachefs-nix.service: Main process exited, code=exited, status=1/FAILURE > booted_machine # enter passphrase for / (press TAB for no echo) [ 20.532282] systemd[1]: unlock-bcachefs-nix.service: Failed with result 'exit-code'. > booted_machine # [ 20.533596] systemd-tty-ask-password-agent[250]: Starting password query on /dev/tty1. > booted_machine # [ 20.534782] systemd-tty-ask-password-agent[249]: Starting password query on /dev/ttyS0. > booted_machine # [ 20.873132] systemd[1]: unlock-bcachefs-nix.service: Scheduled restart job, restart counter is at 1. > booted_machine # [ 20.876289] systemd[1]: Starting Unlock bcachefs for /nix... > booted_machine # [ 20.887622] bcachefs[256]: Error: Error opening /dev/disk/by-uuid/88d9c058-757d-c06e-0fb7-a612f2db8a7a > booted_machine # [ 20.888847] bcachefs[256]: Caused by: > booted_machine # [ 20.889525] bcachefs[256]: Device or resource busy > booted_machine # [ 20.895689] bcachefs[256]: bcachefs (/dev/disk/by-uuid/88d9c058-757d-c06e-0fb7-a612f2db8a7a): error reading superblock: Device or resource busy > booted_machine # [ 20.897462] systemd[1]: unlock-bcachefs-nix.service: Skipped due to 'exec-condition'. > booted_machine # [ 20.900528] systemd[1]: Condition check resulted in Unlock bcachefs for /nix being skipped. > booted_machine: Last OCR attempt failed. Text was: ['S\n\nR e\n\nStarting Jourmal Service...\n\n3712541\n\nRS Eriel\n\nStarting Load Kernel Modules. ..\n\n3783011\n\nRS Eriel\n\nEarly TPH SRK Setup skipped, unmet condition check ConditionSecurity-measured-uki\n\n3860031\n\nFrSErie]\n\nStarting Coldplug All udev Devices. ..\n\n3978751\n\nsystend- journald[1241: Collecting audit messages is disabled.\n\nPt\n\nsystend[11: Finished Copy secrets into place.\n\n4205691\n\nRS Eriel\n\nFinished Create List of Static Device Nodes.\n\nprer]\n\nsystend[11: nodprobegconf igfs.service: Deactivated successfully.\n\n4321871\n\ndevice-napper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.\n\n4370691\n\nsystend[11: Finished Load Kernel Module configfs.\n\n4409651\n\ndevice-mapper: ioctl: 4.50.0-ioct] (2025-04-28) initialised: dm-devel@lists.linux.dev\n\n4505401\n\npYReIeh\n\nKernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config\n\n4625411\n\nRS Eriel\n\nStarting Create Static Device Nodes in sdev gracefully\n\n4840751\n\nRS Eriel\n\nFinished Load Kernel Modules.\n\nproeyss]\n\nRS Eriel\n\nStarting Apply Kernel Variables. ..\n\nCCEeny]\n\nRS Eriel\n\nFinished Create Static Device Nodes in sdev gracefully.\n\n5211441\n\nPYRTerishh\n\nStarting Create Static Device Nodes in /dev\n\n5339601\n\nsystend[11:\n\nStarted Journal Service.\n\n8520971\n\n[CT7Am\n\nPS/2 Controller [PNPO303:KBD,PNPOf13:MOU] at Ox60,0x64 irq 1,12\n\n8674351\n\nserio\n\n8042 KBD port at 0x60,0x64 irq 1\n\n8798071\n\nserio\n\n8042 AUX port at 0x60,0x64 irg 12\n\n9069281\n\nSCSI subsysten initialized\n\n9082121\n\nertest\n\n_blk virtiol: 1/0/0 default/read/poll queues\n\n9168331\n\ne\n\n_blk virtiol: [udal 8388608 512-byte logical blocks (4.29 GB/4.00 GiB)\n\n9205531\n\nperS\n\n[ ]\n\nErveCEl]\n\ne\n\nR RrEY\n\n9527571\n\nvirt\n\n_blk virtioz: 1,00 default/read/poll queues\n\n9612001\n\ne\n\nInstalling 9P2000 support\n\n9686641\n\n[ertest\n\n_blk virtioz: [udbl 8388608 512-byte logical blocks (4.29 GB/4.00 GiB)\n\nErea]\n\no\n\nAT Translated Set 2 keyboard as devices/platforn/i8042/serio0d, input,input0\n\n0128151\n\niy\n\no]\n\n0151731\n\n[errast\n\n_blk virtiod: 1,00 default/read/poll queues\n\n0284891\n\nTt\n\n_blk virtio3: [udc] 8388608 512-byte logical blocks (4.29 GB/4.00 GiB)\n\n0348401\n\nT TS O R T T\n\n0378421\n\no\n\no]\n\n0385661\n\net\n\n_blk virtiod: 1,00 default/read/poll queues\n\n0406331\n\ne\n\nRIVEBIIET]\n\n[udd] 8388608 512-byte logical blocks (4.29 GB/4.00 GiB)\n\n0449321\n\nscsi hosto: ata_piix\n\n0468321\n\nP N EI I T T Y\n\n0474071\n\natal: PATA max MWDMAZ cnd Ox1f0 ctl Ox3f6 bndma OxcZe® irq 14 lpn-pol ©\n\n0501621\n\nPLzr\n\nPATA max MUDMAZ cnd 0x170 ctl 0x376 bmdma OxcZe8 irg 15 Ipm-pol O\n\n0525191\n\ne\n\nTt\n\n2041311\n\nEree\n\nfound unknoun device (class 0)\n\n2076371\n\nata2.00: ATAPI: QEMU DUD-ROM, 2.5+, max UDMA,100\n\n2120761\n\nsesi 1\n\nCD-ROM\n\n]\n\n(LT ]\n\n2.5+ PQ: 0 ANSI: 5\n\n2971471\n\n=\n\n[sr0] scsi3-nnc driv\n\n4x/4x cd/ru xa/fornz tray\n\n3108081\n\ncdron: Uniform CD-ROM driver Revision: 3.20\n\n3\n\nB\n\n3218901\n\n=y\n\n[IERtE T R G S )\n\nenter passphrase for /nix\n\nN\n\nenter passphrase for ~ (press TAB for no echo)\n\x0c', '3608871\n\nsystemd[11]\n\nStarting Journal Service\n\n3712541\n\nsystemd[11]\n\nStarting Load Kernel Modules\n\n3783011\n\nsystemd([11]\n\nEarly TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki\n\nKIS0 lo )\n\nsystemd[11]\n\nStarting Coldplug All udev Devices\n\n3978751\n\nsystemd- journald[1241]\n\nCollecting audit messages is disabled\n\n305 ra\n\nsystemd([1]\n\nFinished Copy secrets into place\n\n4205691\n\nsystemd[11]\n\nFinished Create List of Static Device Nodes\n\n4232501\n\nsystemd[11]\n\nmodprobe@configfs.service: Deactivated successfully\n\n4321871\n\ndevice—-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log\n\n4370691\n\nsystemd[11]\n\nFinished Load Kernel Module configfs\n\n4409651\n\nISR Ty RN il g\n\nioctl\n\n4.50.0-ioct]l (2025-04-28) initialised: dm—-devel@lists.linux.dev\n\n4505401\n\nsystemd([11]\n\nKernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config\n\n4625411\n\nsystemd[11]\n\nStarting Create Static Device Nodes in sdeuv gracefully\n\n4840751\n\nsystemd[11]\n\nFinished Load Kernel Modules\n\nESLIVa N\n\nsystemd([1]\n\nStarting Apply Kernel Variables\n\nSO EE Y\n\nsystemd[11]\n\nFinished Create Static Device Nodes in sdev gracefully\n\n521144]\n\nsystemd[11]\n\nStarting Create Static Device Nodes in sdev\n\n5339601\n\nsystemd([11]\n\nStarted Journal Service.\n\n8520971\n\ni8042: PNP:\n\nPS/2 Controller [PNPO303:KBD,PNPOf13:MOU] at Ox60,0x64 irq 1,12\n\n8674351]\n\nNSG LN\n\ni8042 KBD port at Ox60,0x64 1rq 1\n\ni Yee i l0 Xl\n\nSerlo.\n\ni8042 AUX port at Ox60,0x64 irq 12\n\n9069281\n\nSCSI subsystem initialized\n\n9082121\n\nvirtio_blk virtiol: 1/0/0 default/read/poll queues\n\n9168331\n\nA I LIS a AT}\n\n[udal 8388608 512-byte logical blocks (4.29 GB/4.00 GiB)\n\n9205531\n\nnetfs: FS-Cache loaded\n\n9443991\n\nvda: vdal vda2\n\n9527571\n\nvirtio_blk virtioZ2: 1/0/0 default/read/poll queues\n\n9612001\n\nIpnet\n\nInstalling 9P2000 support\n\n9686641\n\nvirtio blk virtio2\n\n[udb] 8388608 512-byte logical blocks (4.29 GB/4.00 GiB)\n\nT 0V\n\ninput: AT Translated Set 2 keyboard as sdevices/platform/i804Z2/seriocO/input/input0®\n\n0128151\n\nvdb: udbl\n\n015173]\n\nvirtio_blk virtio3: 1/0/0 default/read/poll queues\n\n0284891\n\n35S LIS g i K]\n\n[udc] 8388608 512-byte logical blocks (4.29 GB/4.00 GiB)\n\n0348401\n\nlibata version 3.00 loaded\n\n0378421\n\nvdc: vdcl\n\n0K 1Yoy\n\nvirtio_blk virtio4: 1/0/0 default/read/poll queues\n\n0406331\n\nS BI IISgAak !\n\n[udd] 8388608 512-byte logical blocks (4.29 GB/4.00 GiB)\n\n0449321\n\nSCsS1\n\nhost0: ata_piix\n\n0468321\n\nAN R |\n\nhostl: ata_piix\n\n0474071\n\natal\n\nPATA max MWDMAZ cmd Ox1f0 ctl Ox3f6 bmdma Oxc2e0 irq 14 lpm-pol O\n\n0501621\n\nataz\n\nPATA max MWDMAZ cmd Ox170 ctl 0x376 bmdma Oxcle8 irq 15 lpm-pol O\n\n0525191\n\nvdd\n\nL TN\n\n2041311\n\nataz\n\nfound unknoun device (class 0)\n\n2076371\n\nata2\n\nY\n\nQEMU DUD-ROM, 2.5+\n\nmax UDMA/100\n\n2120761\n\nAN 0 |\n\n1:0:0:0: CD-ROM\n\n()0 1\n\nQEMU DUD-ROM\n\n2.5+ PQ: 0 ANSI\n\nS5\n\n2971471\n\nsr 1:0:0:0\n\n[sr0] scsi3—-mmc drive: 4x/4x cd/rw xa/formZ tray\n\n3108081\n\ncdrom: Uniform CD-ROM driver Revision: 3.20\n\n3218901\n\nsr 1:0:0:0: Attached scsi CD-ROM sr0O\n\nenter passphrase for /nix eeccecccecee\n\nenter passphrase for - (press TAB for no echo)\n\x0c', '3608871\n\nsystemd[1]:\n\nStarting Journal Service. ..\n\n3712541\n\nsystemd[11]:\n\nStarting Load Kernel Modules. ..\n\n3783011\n\nsystemd[1]:\n\nEarly TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki\n\n3860031\n\nsystemd[1]:\n\nStarting Coldplug All udev Devices. ..\n\n3978751\n\nsystemd- journaldl[124]1: Collecting audit messages is disabled.\n\n4110921\n\nsystemd[1]: Finished Copy secrets into place.\n\n4205691\n\nsystemd[1]: Finished Create List of Static Device Nodes.\n\n4232501\n\nsystemd[1]: modprobeBconfigfs.service: Deactivated successfully.\n\n4321871\n\ndevice-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.\n\n4370691\n\nsystemd[1]: Finished Load Kernel Module configfs.\n\n4409651\n\ndevice-mapper:\n\nioctl]:\n\n4.50.0-10ctl (2025-04-28)\n\ninitialised: dm—-devel@lists.linux.devu\n\n450540 ]\n\nsystemd[1]\n\nKernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel /config\n\n1462541 1]\n\nsystemd[1]\n\nStarting Create Static Device Nodes in sdeuv gracefully...\n\n4840751\n\nsystemd[1]\n\nFinished Load Kernel Modules.\n\n4941711\n\nsystemd[1]\n\nStarting Apply Kernel Variables. ..\n\n5099341\n\nsystemd[1]\n\nFinished Create Static Device Nodes in sdeuv gracefully.\n\n5211441\n\nsystemd[1]\n\nStarting Create Static Device Nodes in sdev. ..\n\n5339601\n\nStarted Journal Service.\n\nsystemd[1]\n\n8520971\n\n1804Z2: PNP\n\nPS/Z2 Controller [PNPO303:KBD,PNPOf13:MOU] at Ox60,0x64 irq 1,12\n\n8674351\n\nserio:\n\n18042 KBD port at Ox60,0x64 irq 1\n\n8798071\n\nserio:\n\n18042 AUX port at Ox60,0x64 irq 12\n\n9069281\n\nSCSI subsystem initialized\n\n9082121\n\nvirtio_blk virtiol: 1,00 default/read/poll queues\n\n9168331\n\nvirtio_blk virtiol:\n\n[uda]l 8388608 51Z2-byte logical blocks (4.29 GB/4.00 GiB)\n\n9205531\n\nnetfs:\n\nFS—-Cache loaded\n\n9443991\n\nvda:\n\nvdal vdald\n\n9527571\n\nvirtio_blk virtioZ: 1,00 default/read/poll queues\n\n9612001\n\nIpnet:\n\nInstalling 9P2000 support\n\n968664 ]\n\nvirtio blk virtioZ:\n\n[udb] 8388608 512-byte logical blocks (4.29 GB/4.00 GiB)\n\n9764021\n\ninput: AT Translated Set 2 keyboard as rsdevicess/platform/i804Z2/serioB/input/inputO\n\n0128151\n\nudb:\n\nudbl\n\n0151731\n\nvirtio blk virtio3:\n\n1,00 default/read/poll queues\n\n0284891\n\nvirtio blk virtio3:\n\n[udc] 8388608 5S51Z2-byte logical blocks (4.29 GB/4.00 GiB)\n\n0348401\n\nlibata version 3.00\n\nloaded.\n\n0378421\n\nvdc:\n\nvdc1l\n\n0385661\n\nvirtio4:\n\nvirtio blk\n\n1/0,0 default/read poll queues\n\n0406331\n\nvirtio blk\n\nvirtio4:\n\n[udd] 8388608 51Z2-byte logical blocks (4.29 GB/4.00 GiB)\n\n0449321\n\nscsi hostO\n\nata_piix\n\n0468321\n\nscsi hostil\n\nata_piix\n\n0474071\n\natal\n\nPATA\n\nmax MWDMAZ cmd Ox1f0 ctl Ox3f6 bmdma Oxcle® irq 14 lpm-pol O\n\n0501621\n\natal\n\nPATA\n\nmax MWDMAZ cmd Ox170 ctl Ox37?6 bmdma Oxcle8 irq 15 lpm-pol O\n\n0525191\n\nudd\n\nvdd1\n\n2041311\n\nataz\n\nfound unknouwn device (class 0)\n\n2076371\n\natal\n\n.00: ATAPI: QEMU DUD-ROM, 2.5+, max UDMA/100\n\n2120761\n\nscsi 1:0:0:0: CD-ROM\n\nQEMU\n\nQEMU DUD-ROM\n\n2.5+ PQ: 0 ANSI: 5\n\n2971471\n\nsr 1:0:0:0:\n\n[sr0] scsi3—-mmc drive: 4x/4x cd/rw xas/formé tray\n\n3108081\n\ncdrom:\n\nUniform CD-ROM driver Reuvision:\n\n3.20\n\n3218301\n\nsr 1:0:0:0: Attached scsi CD-ROM sr0\n\nenter passphrase for /mix esesecccecss\n\nenter passphrase for / (press TAB for no echo)\n\x0c'] > !!! Traceback (most recent call last): > !!! File "", line 77, in > !!! machine.wait_for_text("enter passphrase for /home"); > !!! > !!! RequestedAssertionFailed: action timed out after 906.51 seconds (timeout=900) > cleanup > kill QemuMachine (pid 71) > booted_machine # qemu-system-x86_64: terminating on signal 15 from pid 6 (/nix/store/60m4rxhg2fldqaak400c0lry96ijrzqn-python3-3.13.13/bin/python3.13) > (finished: cleanup, in 0.08 seconds) For full logs, run: nix log /nix/store/i2gh8k7a5k8hj2s2lhk5n9qjq2zha6ir-vm-test-run-disko-bcachefs.drv