4.20

Stacktrace
tests/storage/hotplug.go:1395 Timed out after 360.001s. Unexpected error: <*errors.errorString | 0xc002c87660>: waiting on volume statuses for hotplug disks to be ready { s: "waiting on volume statuses for hotplug disks to be ready", } occurred tests/storage/hotplug.go:291

Standard Output
W1101 18:34:11.307961 3501 warnings.go:70] metadata.finalizers: "foregroundDeleteVirtualMachine": prefer a domain-qualified finalizer name to avoid accidental conflicts with other finalizer writers W1101 18:41:40.362556 3501 warnings.go:70] v1 Endpoints is deprecated in v1.33+; use discovery.k8s.io/v1 EndpointSlice skipping pod virt-launcher-testvmi-zpft2-lcqnw, phase is not Running skipping pod virt-launcher-testvmi-zpft2-lcqnw, phase is not Running failed to execute command [/bin/bash -c pgrep -f "monitor.*uid ef4b2af8-17e5-4a45-bb23-37872b1a76c0"] on virt-handler-gkkgh, stdout: , stderr: , error: command terminated with exit code 1 {"[namespace kubevirt-test-default1 name testvmi-zpft2 kind VirtualMachineInstance uid ef4b2af8-17e5-4a45-bb23-37872b1a76c0]":"(MISSING)","component":"tests","level":"info","msg":"Event(v1.ObjectReference
{Kind:\"VirtualMachineInstance\", Namespace:\"kubevirt-test-default1\", Name:\"testvmi-zpft2\", UID:\"ef4b2af8-17e5-4a45-bb23-37872b1a76c0\", APIVersion:\"kubevirt.io/v1\", ResourceVersion:\"133395\", FieldPath:\"\"}
): type: 'Normal' reason: 'SuccessfulCreate' Created virtual machine pod virt-launcher-testvmi-zpft2-lcqnw","pos":"watcher.go:150","timestamp":"2025-11-01T18:34:11.351340Z"} {"[namespace kubevirt-test-default1 name testvmi-zpft2 kind VirtualMachineInstance uid ef4b2af8-17e5-4a45-bb23-37872b1a76c0]":"(MISSING)","component":"tests","level":"info","msg":"Event(v1.ObjectReference
{Kind:\"VirtualMachineInstance\", Namespace:\"kubevirt-test-default1\", Name:\"testvmi-zpft2\", UID:\"ef4b2af8-17e5-4a45-bb23-37872b1a76c0\", APIVersion:\"kubevirt.io/v1\", ResourceVersion:\"134247\", FieldPath:\"\"}
): type: 'Normal' reason: 'Created' VirtualMachineInstance defined.","pos":"watcher.go:150","timestamp":"2025-11-01T18:34:26.398004Z"} {"[namespace kubevirt-test-default1 name testvmi-zpft2 kind VirtualMachineInstance uid ef4b2af8-17e5-4a45-bb23-37872b1a76c0]":"(MISSING)","component":"tests","level":"info","msg":"Event(v1.ObjectReference
{Kind:\"VirtualMachineInstance\", Namespace:\"kubevirt-test-default1\", Name:\"testvmi-zpft2\", UID:\"ef4b2af8-17e5-4a45-bb23-37872b1a76c0\", APIVersion:\"kubevirt.io/v1\", ResourceVersion:\"134343\", FieldPath:\"\"}
): type: 'Normal' reason: 'Started' VirtualMachineInstance started.","pos":"watcher.go:150","timestamp":"2025-11-01T18:34:26.520438Z"} {"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:34:36.805883Z"} {"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:34:36.805908Z"} {"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Bound, reason: PVCNotReady","pos":"hotplug.go:271","timestamp":"2025-11-01T18:34:36.805916Z"} {"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:34:37.818565Z"} {"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:34:37.818591Z"} {"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:AttachedToNode, reason: SuccessfulCreate","pos":"hotplug.go:271","timestamp":"2025-11-01T18:34:37.818601Z"} {"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:34:38.830852Z"} {"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:34:38.830895Z"} {"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:AttachedToNode, reason: SuccessfulCreate","pos":"hotplug.go:271","timestamp":"2025-11-01T18:34:38.830904Z"} {"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:34:39.843374Z"} {"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:34:39.843405Z"} {"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:AttachedToNode, reason: SuccessfulCreate","pos":"hotplug.go:271","timestamp":"2025-11-01T18:34:39.843413Z"} {"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:34:40.856024Z"} {"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:34:40.856052Z"} {"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:AttachedToNode, reason: SuccessfulCreate","pos":"hotplug.go:271","timestamp":"2025-11-01T18:34:40.856060Z"} {"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:34:41.869055Z"} {"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:34:41.869087Z"} {"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:AttachedToNode, reason: SuccessfulCreate","pos":"hotplug.go:271","timestamp":"2025-11-01T18:34:41.869098Z"} {"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:34:42.882422Z"} {"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:34:42.882446Z"} {"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:AttachedToNode, reason: SuccessfulCreate","pos":"hotplug.go:271","timestamp":"2025-11-01T18:34:42.882454Z"} {"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:34:43.902045Z"} {"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:34:43.902073Z"} {"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:AttachedToNode, reason: SuccessfulCreate","pos":"hotplug.go:271","timestamp":"2025-11-01T18:34:43.902082Z"} {"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:34:44.915271Z"} {"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:34:44.915317Z"} {"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:AttachedToNode, reason: SuccessfulCreate","pos":"hotplug.go:271","timestamp":"2025-11-01T18:34:44.915334Z"} {"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:34:45.928409Z"} {"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:34:45.928450Z"} {"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:AttachedToNode, reason: SuccessfulCreate","pos":"hotplug.go:271","timestamp":"2025-11-01T18:34:45.928459Z"} {"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:34:46.946736Z"} {"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:34:46.946772Z"} {"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [sda], phase:Ready, reason: VolumeReady","pos":"hotplug.go:271","timestamp":"2025-11-01T18:34:46.946780Z"} �[34mSent:�[39m "\n" {"component":"tests","level":"info","msg":"Sent: \"\\n\"","pos":"stdlib.go:105","timestamp":"2025-11-01T18:34:47.077108Z","ts":"2025/11/01 18:34:47"} �[34mSent:�[39m "\n" {"component":"tests","level":"info","msg":"Sent: \"\\n\"","pos":"stdlib.go:105","timestamp":"2025-11-01T18:34:52.078167Z","ts":"2025/11/01 18:34:52"} �[32mMatch for RE:�[39m "login as 'cirros' user. default password: 'gocubsgo'. use 'sudo' for root." found: ["login as 'cirros' user. default password: 'gocubsgo'. use 'sudo' for root."] Buffer: login as 'cirros' user. default password: 'gocubsgo'. use 'sudo' for root. �[34mSent:�[39m "\n" {"component":"tests","level":"info","msg":"Sent: \"\\n\"","pos":"stdlib.go:105","timestamp":"2025-11-01T18:34:52.097326Z","ts":"2025/11/01 18:34:52"} �[32mMatch for RE:�[39m "testvmi-zpft2 login:" found: ["testvmi-zpft2 login:"] Buffer: testvmi-zpft2 login: �[34mSent:�[39m "cirros\n" {"component":"tests","level":"info","msg":"Sent: \"cirros\\n\"","pos":"stdlib.go:105","timestamp":"2025-11-01T18:34:52.097401Z","ts":"2025/11/01 18:34:52"} �[32mMatch for RE:�[39m "Password:" found: ["Password:"] Buffer: login as 'cirros' user. default password: 'gocubsgo'. use 'sudo' for root. testvmi-zpft2 login: cirros Password: �[34mSent:�[39m "gocubsgo\n" {"component":"tests","level":"info","msg":"Sent: \"gocubsgo\\n\"","pos":"stdlib.go:105","timestamp":"2025-11-01T18:34:52.115695Z","ts":"2025/11/01 18:34:52"} �[32mMatch for RE:�[39m "(
$ |
# )" found: ["$ " "$ "] Buffer: $ �[34mSent:�[39m "stty cols 500 rows 500\n" {"component":"tests","level":"info","msg":"Sent: \"stty cols 500 rows 500\\n\"","pos":"stdlib.go:105","timestamp":"2025-11-01T18:34:52.128617Z","ts":"2025/11/01 18:34:52"} �[32mMatch for RE:�[39m "(
$ |
# )" found: ["$ " "$ "] Buffer: stty cols 500 rows 500 $ �[34mSent:�[39m "echo $?\n" {"component":"tests","level":"info","msg":"Sent: \"echo $?\\n\"","pos":"stdlib.go:105","timestamp":"2025-11-01T18:34:52.141231Z","ts":"2025/11/01 18:34:52"} �[32mMatch for RE:�[39m "\n0\r\n.(
$ |
# )" found: ["\n0\r\n$ " "$ "] Buffer: echo $? 0 $ �[34mSent:�[39m "sudo dmesg -n 1\n" {"component":"tests","level":"info","msg":"Sent: \"sudo dmesg -n 1\\n\"","pos":"stdlib.go:105","timestamp":"2025-11-01T18:34:52.151555Z","ts":"2025/11/01 18:34:52"} �[32mMatch for RE:�[39m "(
$ |
# )" found: ["$ " "$ "] Buffer: sudo dmesg -n 1 $ �[34mSent:�[39m "echo $?\n" {"component":"tests","level":"info","msg":"Sent: \"echo $?\\n\"","pos":"stdlib.go:105","timestamp":"2025-11-01T18:34:52.165400Z","ts":"2025/11/01 18:34:52"} �[32mMatch for RE:�[39m "\n0\r\n.(
$ |
# )" found: ["\n0\r\n$ " "$ "] Buffer: echo $? 0 $ {"component":"tests","level":"info","msg":"read closing down: EOF","pos":"stdlib.go:105","timestamp":"2025-11-01T18:34:52.175417Z","ts":"2025/11/01 18:34:52"} �[34mSent:�[39m "sudo ls /dev/sda\n" {"component":"tests","level":"info","msg":"Sent: \"sudo ls /dev/sda\\n\"","pos":"stdlib.go:105","timestamp":"2025-11-01T18:34:52.286859Z","ts":"2025/11/01 18:34:52"} �[32mMatch for RE:�[39m "sudo ls /dev/sda((?s).)/dev/sda" found: ["sudo ls /dev/sda\r\n\x1b[1;35m/dev/sda" "\r\n\x1b[1;35m"] Buffer: sudo ls /dev/sda �[1;35m/dev/sda�[m �[34mSent:�[39m "echo $?\n" {"component":"tests","level":"info","msg":"Sent: \"echo $?\\n\"","pos":"stdlib.go:105","timestamp":"2025-11-01T18:34:52.304807Z","ts":"2025/11/01 18:34:52"} �[32mMatch for RE:�[39m "echo \\$\\?((?s).)\n0\r\n.(
$ |
# )" found: ["echo $?\r\n0\r\n$ " "\r" "$ "] Buffer: $ echo $? 0 $ {"component":"tests","level":"info","msg":"read closing down: EOF","pos":"stdlib.go:105","timestamp":"2025-11-01T18:34:52.314938Z","ts":"2025/11/01 18:34:52"} �[34mSent:�[39m "sudo mkfs.ext4 -F /dev/sda\n" {"component":"tests","level":"info","msg":"Sent: \"sudo mkfs.ext4 -F /dev/sda\\n\"","pos":"stdlib.go:105","timestamp":"2025-11-01T18:34:52.411445Z","ts":"2025/11/01 18:34:52"} �[32mMatch for RE:�[39m "sudo mkfs
.ext4 -F /dev/sda((?s).)(
$ |
# )" found: ["sudo mkfs.ext4 -F /dev/sda\r\nmke2fs 1.44.5 (15-Dec-2018)\r\nDiscarding device blocks: 1024/16384\b\b\b\b\b\b\b\b\b\b\b \b\b\b\b\b\b\b\b\b\b\bdone \r\nCreating filesystem with 16384 1k blocks and 4096 inodes\r\nFilesystem UUID: e5563753-fd00-405e-a50d-460390ba2466\r\nSuperblock backups stored on blocks: \r\n\t8193\r\n\r\nAllocating group tables: 0/2\b\b\b \b\b\bdone \r\nWriting inode tables: 0/2\b\b\b \b\b\bdone \r\nCreating journal (1024 blocks): done\r\nWriting superblocks and filesystem accounting information: 0/2\b\b\b \b\b\bdone\r\n\r\n$ " "\r\nmke2fs 1.44.5 (15-Dec-2018)\r\nDiscarding device blocks: 1024/16384\b\b\b\b\b\b\b\b\b\b\b \b\b\b\b\b\b\b\b\b\b\bdone \r\nCreating filesystem with 16384 1k blocks and 4096 inodes\r\nFilesystem UUID: e5563753-fd00-405e-a50d-460390ba2466\r\nSuperblock backups stored on blocks: \r\n\t8193\r\n\r\nAllocating group tables: 0/2\b\b\b \b\b\bdone \r\nWriting inode tables: 0/2\b\b\b \b\b\bdone \r\nCreating journal (1024 blocks): done\r\nWriting superblocks and filesystem accounting information: 0/2\b\b\b \b\b\bdone\r\n\r\n" "$ "] Buffer: sudo mkfs.ext4 -F /dev/sda mke2fs 1.44.5 (15-Dec-2018) Discarding device blocks: 1024/16384����������� �����������done Creating filesystem with 16384 1k blocks and 4096 inodes Filesystem UUID: e5563753-fd00-405e-a50d-460390ba2466 Superblock backups stored on blocks: 8193 Allocating group tables: 0/2��� ���done Writing inode tables: 0/2��� ���done Creating journal (1024 blocks): done Writing superblocks and filesystem accounting information: 0/2��� ���done $ �[34mSent:�[39m "echo $?\n" {"component":"tests","level":"info","msg":"Sent: \"echo $?\\n\"","pos":"stdlib.go:105","timestamp":"2025-11-01T18:34:54.412542Z","ts":"2025/11/01 18:34:54"} �[32mMatch for RE:�[39m "echo \\$\\?((?s).)\n0\r\n.(
$ |
# )" found: ["echo $?\r\n0\r\n$ " "\r" "$ "] Buffer: echo $? 0 $ �[34mSent:�[39m "sudo mkdir -p /test/sda\n" {"component":"tests","level":"info","msg":"Sent: \"sudo mkdir -p /test/sda\\n\"","pos":"stdlib.go:105","timestamp":"2025-11-01T18:34:54.423232Z","ts":"2025/11/01 18:34:54"} �[32mMatch for RE:�[39m "sudo mkdir -p /test/sda((?s).)(
$ |
# )" found: ["sudo mkdir -p /test/sda\r\n$ " "\r\n" "$ "] Buffer: sudo mkdir -p /test/sda $ �[34mSent:�[39m "sudo mount /dev/sda /test/sda\n" {"component":"tests","level":"info","msg":"Sent: \"sudo mount /dev/sda /test/sda\\n\"","pos":"stdlib.go:105","timestamp":"2025-11-01T18:34:56.424411Z","ts":"2025/11/01 18:34:56"} �[32mMatch for RE:�[39m "sudo mount /dev/sda /test/sda((?s).)(
$ |
# )" found: ["sudo mount /dev/sda /test/sda\r\n$ " "\r\n" "$ "] Buffer: sudo mount /dev/sda /test/sda $ �[34mSent:�[39m "echo $?\n" {"component":"tests","level":"info","msg":"Sent: \"echo $?\\n\"","pos":"stdlib.go:105","timestamp":"2025-11-01T18:34:56.458734Z","ts":"2025/11/01 18:34:56"} �[32mMatch for RE:�[39m "echo \\$\\?((?s).)\n0\r\n.(
$ |
# )" found: ["echo $?\r\n0\r\n$ " "\r" "$ "] Buffer: echo $? 0 $ �[34mSent:�[39m "sudo mkdir -p /test/sda/data\n" {"component":"tests","level":"info","msg":"Sent: \"sudo mkdir -p /test/sda/data\\n\"","pos":"stdlib.go:105","timestamp":"2025-11-01T18:34:56.468813Z","ts":"2025/11/01 18:34:56"} �[32mMatch for RE:�[39m "sudo mkdir -p /test/sda/data((?s).)(
$ |
# )" found: ["sudo mkdir -p /test/sda/data\r\n$ " "\r\n" "$ "] Buffer: sudo mkdir -p /test/sda/data $ �[34mSent:�[39m "echo $?\n" {"component":"tests","level":"info","msg":"Sent: \"echo $?\\n\"","pos":"stdlib.go:105","timestamp":"2025-11-01T18:34:56.488903Z","ts":"2025/11/01 18:34:56"} �[32mMatch for RE:�[39m "echo \\$\\?((?s).)\n0\r\n.(
$ |
# )" found: ["echo $?\r\n0\r\n$ " "\r" "$ "] Buffer: echo $? 0 $ �[34mSent:�[39m "sudo chmod a+w /test/sda/data\n" {"component":"tests","level":"info","msg":"Sent: \"sudo chmod a+w /test/sda/data\\n\"","pos":"stdlib.go:105","timestamp":"2025-11-01T18:34:56.499556Z","ts":"2025/11/01 18:34:56"} �[32mMatch for RE:�[39m "sudo chmod a
+w /test/sda/data((?s).)(
$ |
# )" found: ["sudo chmod a+w /test/sda/data\r\n$ " "\r\n" "$ "] Buffer: sudo chmod a+w /test/sda/data $ �[34mSent:�[39m "echo $?\n" {"component":"tests","level":"info","msg":"Sent: \"echo $?\\n\"","pos":"stdlib.go:105","timestamp":"2025-11-01T18:34:56.512981Z","ts":"2025/11/01 18:34:56"} �[32mMatch for RE:�[39m "echo \\$\\?((?s).)\n0\r\n.(
$ |
# )" found: ["echo $?\r\n0\r\n$ " "\r" "$ "] Buffer: echo $? 0 $ �[34mSent:�[39m "echo 'ef4b2af8-17e5-4a45-bb23-37872b1a76c0' > /test/sda/data/message\n" {"component":"tests","level":"info","msg":"Sent: \"echo 'ef4b2af8-17e5-4a45-bb23-37872b1a76c0' > /test/sda/data/message\\n\"","pos":"stdlib.go:105","timestamp":"2025-11-01T18:34:56.522830Z","ts":"2025/11/01 18:34:56"} �[32mMatch for RE:�[39m "echo 'ef4b2af8-17e5-4a45-bb23-37872b1a76c0' > /test/sda/data/message((?s).*)(
$ |
# )" found: ["echo 'ef4b2af8-17e5-4a45-bb23-37872b1a76c0' > /test/sda/data/message\r\n$ " "\r\n" "$ "] Buffer: echo 'ef4b2af8-17e5-4a45-bb23-37872b1a76c0' > /test/sda/data/message $

...

{"component":"tests","level":"info","msg":"read closing down: EOF","pos":"stdlib.go:105","timestamp":"2025-11-01T18:35:32.818084Z","ts":"2025/11/01 18:35:32"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:32.889399Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:32.889415Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:32.889424Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:33.901997Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:33.902017Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:33.902028Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:34.916048Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:34.916074Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:34.916083Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:35.929660Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:35.929686Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:35.929694Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:36.947481Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:36.947516Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:36.947544Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:37.962023Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:37.962048Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:37.962056Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:38.974484Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:38.974511Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:38.974521Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:39.987519Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:39.987544Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:39.987552Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:40.999640Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:40.999667Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:40.999679Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:42.012908Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:42.012934Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:42.012942Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:43.025431Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:43.025454Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:43.025462Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:44.039459Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:44.039487Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:44.039495Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:45.052270Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:45.052301Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:45.052308Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:46.066181Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:46.066212Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:46.066219Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:47.079325Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:47.079351Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:47.079359Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:48.093460Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:48.093486Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:48.093496Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:49.105837Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:49.105862Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:49.105881Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:50.118598Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:50.118624Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:50.118636Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:51.132856Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:51.132889Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:51.132897Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:52.145609Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:52.145632Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:52.145640Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:53.242812Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:53.242836Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:53.242845Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:54.255929Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:54.255955Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:54.255967Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:55.270370Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:55.270398Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:55.270408Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:56.284492Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:56.284520Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:56.284530Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:57.297708Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:57.297729Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:57.297736Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:58.316676Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:58.316703Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:58.316710Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:59.328956Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:59.328984Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:35:59.328993Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:00.341987Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:00.342020Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:00.342028Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:01.354347Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:01.354374Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:01.354384Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:02.368331Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:02.368358Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:02.368366Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:03.382601Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:03.382626Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:03.382635Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:04.396225Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:04.396250Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:04.396259Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:05.410085Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:05.410111Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:05.410121Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:06.424390Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:06.424415Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:06.424423Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:07.437303Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:07.437328Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:07.437336Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:08.450848Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:08.450897Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:08.450905Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:09.463431Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:09.463460Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:09.463469Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:10.477798Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:10.477826Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:10.477838Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:11.490242Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:11.490272Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:11.490280Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:12.504224Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:12.504256Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:12.504265Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:13.518586Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:13.518618Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:13.518626Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:14.531929Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:14.531956Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:14.531963Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:15.544486Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:15.544514Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:15.544522Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:16.556515Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:16.556546Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:16.556554Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:17.569758Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:17.569784Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:17.569792Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:18.582506Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:18.582537Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:18.582546Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:19.596377Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:19.596402Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:19.596410Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:20.609725Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:20.609750Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:20.609759Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:21.623061Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:21.623087Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:21.623095Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:22.637761Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: disk0, target [vda], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:22.637789Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: testvolume, target [], phase:Detaching, reason: SuccessfulDelete","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:22.637797Z"}
{"component":"tests","level":"info","msg":"Volume Status, name: cloudinitdisk, target [vdb], phase:, reason: ","pos":"hotplug.go:271","timestamp":"2025-11-01T18:36:23.6523