Run Test: slices-bi-singlenode-login 2026-05-01 08:03:57.981958 CEST - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-05-01 08:04:01.302991 CEST - Run: slices --version 2026-05-01 08:04:01.517482 CEST - version: Slices CLI v2025.1.5 Slices CLI core v1.1.2 Slices CLI bi v2.0.2 Slices clientlib core v5.5.1 Slices clientlib bi v5.1.2 2026-05-01 08:04:01.517749 CEST - Run: slices pubkey list --format text 2026-05-01 08:04:02.082710 CEST - Pubkey already registered 2026-05-01 08:04:02.082960 CEST - Run: slices bi infrastructure list --format csv --all --refresh 2026-05-01 08:04:02.597805 CEST - Refreshed infrastructure list. Total: 22 entries. 2026-05-01 08:04:02.597915 CEST - Check List Flavors 2026-05-01 08:04:02.598076 CEST - Run: slices bi --infra gr-volos-bi-vm1 flavor list -f json 2026-05-01 08:04:03.614201 CEST - Check List DiskImages 2026-05-01 08:04:03.614410 CEST - Run: slices bi --infra gr-volos-bi-vm1 diskimage list -f json 2026-05-01 08:04:04.379911 CEST - Requesting resources 2026-05-01 08:04:04.380378 CEST - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-05-01 08:04:04.380484 CEST - Run: slices bi --infra gr-volos-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-0991ce62 --user-data /tmp/tmpnoyioi31 2026-05-01 08:04:06.949738 CEST - Resource ID: r_gr-volos-bi-vm1_01kqh268pnfa0tkwgng3mycdwq 2026-05-01 08:04:06.949862 CEST - Waiting until resource ready 2026-05-01 08:04:08.950247 CEST - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-0991ce62 tst 2026-05-01 08:04:09.765863 CEST - Status: IMAGING 2026-05-01 08:04:12.632229 CEST - Status: IMAGING 2026-05-01 08:04:15.448244 CEST - Status: IMAGING 2026-05-01 08:04:18.264316 CEST - Status: BOOTING 2026-05-01 08:04:21.080333 CEST - Status: BOOTING 2026-05-01 08:04:23.946609 CEST - Status: BOOTING 2026-05-01 08:04:26.762558 CEST - Status: BOOTING 2026-05-01 08:04:29.578489 CEST - Status: BOOTING 2026-05-01 08:04:32.394417 CEST - Status: BOOTING 2026-05-01 08:04:35.210472 CEST - Status: BOOTING 2026-05-01 08:04:38.026522 CEST - Status: BOOTING 2026-05-01 08:04:40.842562 CEST - Status: BOOTING 2026-05-01 08:04:43.658549 CEST - Status: BOOTING 2026-05-01 08:04:46.474624 CEST - Status: BOOTING 2026-05-01 08:04:49.290717 CEST - Status: BOOTING 2026-05-01 08:04:52.157103 CEST - Status: BOOTING 2026-05-01 08:04:54.972981 CEST - Status: BOOTING 2026-05-01 08:04:57.889559 CEST - Status: BOOTING 2026-05-01 08:05:00.755928 CEST - Status: BOOTING 2026-05-01 08:05:03.572176 CEST - Status: BOOTING 2026-05-01 08:05:06.388299 CEST - Status: BOOTING 2026-05-01 08:05:09.204362 CEST - Status: BOOTING 2026-05-01 08:05:12.020304 CEST - Status: BOOTING 2026-05-01 08:05:14.886568 CEST - Status: BOOTING 2026-05-01 08:05:17.752602 CEST - Status: BOOTING 2026-05-01 08:05:20.618819 CEST - Status: BOOTING 2026-05-01 08:05:23.434847 CEST - Status: BOOTING 2026-05-01 08:05:26.250959 CEST - Status: BOOTING 2026-05-01 08:05:29.066871 CEST - Status: BOOTING 2026-05-01 08:05:31.882839 CEST - Status: BOOTING 2026-05-01 08:05:34.698763 CEST - Status: BOOTING 2026-05-01 08:05:37.615385 CEST - Status: BOOTING 2026-05-01 08:05:40.431628 CEST - Status: BOOTING 2026-05-01 08:05:43.298184 CEST - Status: BOOTING 2026-05-01 08:05:46.164555 CEST - Status: BOOTING 2026-05-01 08:05:49.030696 CEST - Status: BOOTING 2026-05-01 08:05:51.846673 CEST - Status: BOOTING 2026-05-01 08:05:54.713325 CEST - Status: BOOTING 2026-05-01 08:05:57.579685 CEST - Status: BOOTING 2026-05-01 08:06:00.446170 CEST - Status: BOOTING 2026-05-01 08:06:03.312293 CEST - Status: BOOTING 2026-05-01 08:06:06.178520 CEST - Status: BOOTING 2026-05-01 08:06:08.994678 CEST - Status: BOOTING 2026-05-01 08:06:11.860799 CEST - Status: BOOTING 2026-05-01 08:06:14.726962 CEST - Status: BOOTING 2026-05-01 08:06:17.543139 CEST - Status: BOOTING 2026-05-01 08:06:20.359005 CEST - Status: BOOTING 2026-05-01 08:06:20.360156 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/00ef308c-689d-4fef-a56c-b020933d04ed/step_WaitforUP_command_1.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-0991ce62 tst 2026-05-01 08:06:20.360238 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/00ef308c-689d-4fef-a56c-b020933d04ed/list-resources_json.txt': [ { "cluster_id": "default", "created_at": "2026-05-01T06:04:06.731547Z", "disk_image_id": "image_gr-volos-bi-vm1_01khr9qbapec8v4evhvyyzr9ax", "experiment_id": "exp_expauth.ilabt.imec.be_01kqh2679hejt91mb4hq78gwtc", "expires_at": "2026-05-01T08:04:00Z", "flavor_id": "flavor_gr-volos-bi-vm1_01khr9qbayfkgvs2thxhage6fv", "friendly_name": "tst", "id": "r_gr-volos-bi-vm1_01kqh268pnfa0tkwgng3mycdwq", "network_interfaces": [], "private_ipv4": null, "private_ipv6": null, "public_ipv4": null, "public_ipv6": null, "ssh_authorized_keys": [ "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAINNiZPtQkfCEsc1x2QSwNWekfhWwWZbOvpE8hE0dH253 Wim (ftester) Van de Meerssche" ], "ssh_logins": [], "status": "booting", "terminated_at": null, "userdata": "#!/bin/sh\necho \"Hello World. The time is now $(date -R)!\" | tee '/user_data_output.txt'", "console_url": null, "machine_id": null, "failure_reason": null, "infra_id": "gr-volos-bi-vm1", "machine_name": null } ] 2026-05-01 08:06:20.360261 CEST - Error in test step 'Wait for UP': experiment did not become ready before timeout 2026-05-01 08:06:20.360291 CEST - Destroying tst-0991ce62 tst 2026-05-01 08:06:20.360420 CEST - Run: slices bi --infra gr-volos-bi-vm1 destroy --experiment tst-0991ce62 tst 2026-05-01 08:06:23.631576 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/00ef308c-689d-4fef-a56c-b020933d04ed/step_Destroy_command_1.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices bi --infra gr-volos-bi-vm1 destroy --experiment tst-0991ce62 tst 2026-05-01 08:06:23.631667 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/00ef308c-689d-4fef-a56c-b020933d04ed/destroy.txt': 0.0% / waiting for task start 0.0% - waiting for task start 0.0% \ waiting for task start Deleting tst: task starting # task_id='8631cf3eaa0546229e7cd72a6e386906' tas… 1… Destroy failure ❌ ❌ Failed to destroy tst with ID r_gr-volos-bi-vm1_01kqh268pnfa0tkwgng3mycdwq Failure: INTERNAL_ERROR task_id='8631cf3eaa0546229e7cd72a6e386906' task_name='slices_bi_refimpl_backend.tasks.compute_resource:delete_compute_resou rce' labels={} labels_types={} args=[UUID('019de223-22d5-7a81-a9f2-1580e9e63797'), 'status_change:api_initiated:delete'] kwargs={'initiator': 'user_account.ilabt.imec.be_1c3x2sxhmv8dqtmkxh9392sa0g'} Details stored at: /root/.slices/cli_error_details/err_2026-05-01T06:06:23+00:00.txt 2026-05-01 08:06:23.631696 CEST - Error in test step 'Destroy': "slices bi destroy" failed (return value is 1) 2026-05-01 08:06:23.631724 CEST - Wait 2s before retry 2026-05-01 08:06:27.049472 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/00ef308c-689d-4fef-a56c-b020933d04ed/step_DestroyRetry1_retry1_command_1.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices bi --infra gr-volos-bi-vm1 destroy --experiment tst-0991ce62 tst 2026-05-01 08:06:27.049566 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/00ef308c-689d-4fef-a56c-b020933d04ed/destroy_retry1.txt': Deleting tst: task starting # task_id='82652a38b0c743cbba8a5ae6c0afb7a8' tas… 1… Destroy failure ❌ ❌ Failed to destroy tst with ID r_gr-volos-bi-vm1_01kqh268pnfa0tkwgng3mycdwq Failure: INTERNAL_ERROR task_id='82652a38b0c743cbba8a5ae6c0afb7a8' task_name='slices_bi_refimpl_backend.tasks.compute_resource:delete_compute_resou rce' labels={} labels_types={} args=[UUID('019de223-22d5-7a81-a9f2-1580e9e63797'), 'status_change:api_initiated:delete'] kwargs={'initiator': 'user_account.ilabt.imec.be_1c3x2sxhmv8dqtmkxh9392sa0g'} Details stored at: /root/.slices/cli_error_details/err_2026-05-01T06:06:26+00:00.txt 2026-05-01 08:06:27.049603 CEST - Error in test step 'Destroy (Retry 1)': "slices bi destroy" failed (return value is 1) 2026-05-01 08:06:27.049638 CEST - Wait 2s before retry 2026-05-01 08:06:31.620261 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/00ef308c-689d-4fef-a56c-b020933d04ed/step_DestroyRetry2_retry2_command_1.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices bi --infra gr-volos-bi-vm1 destroy --experiment tst-0991ce62 tst 2026-05-01 08:06:31.620374 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/00ef308c-689d-4fef-a56c-b020933d04ed/destroy_retry2.txt': 0.0% / waiting for task start 0.0% - waiting for task start Deleting tst: task starting # task_id='2fba7db5abab400fb6255cb09a7b7eb9' tas… 1… Destroy failure ❌ ❌ Failed to destroy tst with ID r_gr-volos-bi-vm1_01kqh268pnfa0tkwgng3mycdwq Failure: INTERNAL_ERROR task_id='2fba7db5abab400fb6255cb09a7b7eb9' task_name='slices_bi_refimpl_backend.tasks.compute_resource:delete_compute_resou rce' labels={} labels_types={} args=[UUID('019de223-22d5-7a81-a9f2-1580e9e63797'), 'status_change:api_initiated:delete'] kwargs={'initiator': 'user_account.ilabt.imec.be_1c3x2sxhmv8dqtmkxh9392sa0g'} Details stored at: /root/.slices/cli_error_details/err_2026-05-01T06:06:31+00:00.txt 2026-05-01 08:06:31.620403 CEST - Error in test step 'Destroy (Retry 2)': "slices bi destroy" failed (return value is 1) 2026-05-01 08:06:31.620431 CEST - Wait 2s before retry 2026-05-01 08:06:35.038277 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/00ef308c-689d-4fef-a56c-b020933d04ed/step_DestroyRetry3_retry3_command_1.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices bi --infra gr-volos-bi-vm1 destroy --experiment tst-0991ce62 tst 2026-05-01 08:06:35.038371 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/00ef308c-689d-4fef-a56c-b020933d04ed/destroy_retry3.txt': Deleting tst: task starting # task_id='3848462c10a64c64a52abd325b79b378' tas… 1… Destroy failure ❌ ❌ Failed to destroy tst with ID r_gr-volos-bi-vm1_01kqh268pnfa0tkwgng3mycdwq Failure: INTERNAL_ERROR task_id='3848462c10a64c64a52abd325b79b378' task_name='slices_bi_refimpl_backend.tasks.compute_resource:delete_compute_resou rce' labels={} labels_types={} args=[UUID('019de223-22d5-7a81-a9f2-1580e9e63797'), 'status_change:api_initiated:delete'] kwargs={'initiator': 'user_account.ilabt.imec.be_1c3x2sxhmv8dqtmkxh9392sa0g'} Details stored at: /root/.slices/cli_error_details/err_2026-05-01T06:06:34+00:00.txt 2026-05-01 08:06:35.038394 CEST - Error in test step 'Destroy (Retry 3)': "slices bi destroy" failed (return value is 1)