Run Test: slices-bi-singlenode-login 2026-04-16 08:01:32.628693 CEST - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-04-16 08:01:35.851823 CEST - Run: slices --version 2026-04-16 08:01:36.116789 CEST - version: Slices CLI v2025.1.5 Slices CLI core v1.1.2 Slices CLI bi v2.0.2 Slices clientlib core v5.5.0 Slices clientlib bi v5.1.2 2026-04-16 08:01:36.117092 CEST - Run: slices pubkey list --format text 2026-04-16 08:01:36.983073 CEST - Pubkey already registered 2026-04-16 08:01:36.983365 CEST - Run: slices bi infrastructure list --format csv --all --refresh 2026-04-16 08:01:37.598926 CEST - Refreshed infrastructure list. Total: 22 entries. 2026-04-16 08:01:37.599043 CEST - Check List Flavors 2026-04-16 08:01:37.599216 CEST - Run: slices bi --infra de-munich-bi-vm flavor list -f json 2026-04-16 08:01:38.515675 CEST - Check List DiskImages 2026-04-16 08:01:38.515884 CEST - Run: slices bi --infra de-munich-bi-vm diskimage list -f json 2026-04-16 08:01:39.231733 CEST - Requesting resources 2026-04-16 08:01:39.232203 CEST - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-04-16 08:01:39.232299 CEST - Run: slices bi --infra de-munich-bi-vm create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-9e8438a3 --user-data /tmp/tmp5979rz10 2026-04-16 08:01:46.415990 CEST - Resource ID: r_de-munich-bi-vm_01kpae36fmegs83c6snmhwvemm 2026-04-16 08:01:46.416124 CEST - Waiting until resource ready 2026-04-16 08:01:48.416586 CEST - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-9e8438a3 tst 2026-04-16 08:01:49.233087 CEST - Status: IMAGING 2026-04-16 08:01:52.049622 CEST - Status: IMAGING 2026-04-16 08:01:54.866238 CEST - Status: IMAGING 2026-04-16 08:01:57.632151 CEST - Status: IMAGING 2026-04-16 08:02:00.398089 CEST - Status: IMAGING 2026-04-16 08:02:03.113950 CEST - Status: BOOTING 2026-04-16 08:02:05.980447 CEST - Status: BOOTING 2026-04-16 08:02:08.696316 CEST - Status: BOOTING 2026-04-16 08:02:11.412149 CEST - Status: BOOTING 2026-04-16 08:02:14.127971 CEST - Status: BOOTING 2026-04-16 08:02:16.843690 CEST - Status: BOOTING 2026-04-16 08:02:19.609796 CEST - Status: BOOTING 2026-04-16 08:02:22.325533 CEST - Status: BOOTING 2026-04-16 08:02:25.041331 CEST - Status: BOOTING 2026-04-16 08:02:27.807537 CEST - Status: BOOTING 2026-04-16 08:02:30.624042 CEST - Status: BOOTING 2026-04-16 08:02:33.390115 CEST - Status: BOOTING 2026-04-16 08:02:36.156249 CEST - Status: BOOTING 2026-04-16 08:02:38.922311 CEST - Status: BOOTING 2026-04-16 08:02:41.688514 CEST - Status: BOOTING 2026-04-16 08:02:44.404305 CEST - Status: BOOTING 2026-04-16 08:02:47.120137 CEST - Status: BOOTING 2026-04-16 08:02:49.836040 CEST - Status: BOOTING 2026-04-16 08:02:52.551923 CEST - Status: BOOTING 2026-04-16 08:02:55.267673 CEST - Status: BOOTING 2026-04-16 08:02:58.033711 CEST - Status: BOOTING 2026-04-16 08:03:00.799813 CEST - Status: BOOTING 2026-04-16 08:03:03.566075 CEST - Status: BOOTING 2026-04-16 08:03:06.337921 CEST - Status: BOOTING 2026-04-16 08:03:09.104290 CEST - Status: BOOTING 2026-04-16 08:03:11.870801 CEST - Status: BOOTING 2026-04-16 08:03:14.636931 CEST - Status: BOOTING 2026-04-16 08:03:17.453200 CEST - Status: BOOTING 2026-04-16 08:03:20.269568 CEST - Status: BOOTING 2026-04-16 08:03:23.086096 CEST - Status: BOOTING 2026-04-16 08:03:25.902480 CEST - Status: BOOTING 2026-04-16 08:03:28.719715 CEST - Status: BOOTING 2026-04-16 08:03:31.536546 CEST - Status: BOOTING 2026-04-16 08:03:34.353450 CEST - Status: BOOTING 2026-04-16 08:03:37.170139 CEST - Status: BOOTING 2026-04-16 08:03:39.986709 CEST - Status: BOOTING 2026-04-16 08:03:42.805061 CEST - Status: BOOTING 2026-04-16 08:03:45.621433 CEST - Status: BOOTING 2026-04-16 08:03:48.438143 CEST - Status: BOOTING 2026-04-16 08:03:51.254445 CEST - Status: BOOTING 2026-04-16 08:03:54.070702 CEST - Status: BOOTING 2026-04-16 08:03:56.836967 CEST - Status: BOOTING 2026-04-16 08:03:59.653222 CEST - Status: BOOTING 2026-04-16 08:04:02.469774 CEST - Status: BOOTING 2026-04-16 08:04:05.286433 CEST - Status: BOOTING 2026-04-16 08:04:05.287829 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/056934c9-1afc-4dc5-b526-41e5035c9936/step_WaitforUP_command_1.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-9e8438a3 tst 2026-04-16 08:04:05.287929 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/056934c9-1afc-4dc5-b526-41e5035c9936/list-resources_json.txt': [ { "cluster_id": "default", "created_at": "2026-04-16T06:01:46.219494Z", "disk_image_id": "image_de-munich-bi-vm_01kjceghcff5gbwgxyt40nkj7a", "experiment_id": "exp_expauth.ilabt.imec.be_01kpae30nteq2a6pjba0aqnz4n", "expires_at": "2026-04-16T08:01:00Z", "flavor_id": "flavor_de-munich-bi-vm_01kjceghd0fh1vh08ygdp4hrn9", "friendly_name": "tst", "id": "r_de-munich-bi-vm_01kpae36fmegs83c6snmhwvemm", "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": "de-munich-bi-vm", "machine_name": null } ] 2026-04-16 08:04:05.287963 CEST - Error in test step 'Wait for UP': experiment did not become ready before timeout 2026-04-16 08:04:05.288005 CEST - Destroying tst-9e8438a3 tst 2026-04-16 08:04:05.288215 CEST - Run: slices bi --infra de-munich-bi-vm destroy --experiment tst-9e8438a3 tst 2026-04-16 08:04:06.456208 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/056934c9-1afc-4dc5-b526-41e5035c9936/step_Destroy_command_1.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices bi --infra de-munich-bi-vm destroy --experiment tst-9e8438a3 tst 2026-04-16 08:04:06.456313 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/056934c9-1afc-4dc5-b526-41e5035c9936/destroy.txt': Deleting tst: task starting # task_id='4e2c5f902ddf408fa79c127b491e0835' tas… 1… Destroy failure ❌ ❌ Failed to destroy tst with ID r_de-munich-bi-vm_01kpae36fmegs83c6snmhwvemm Failure: INTERNAL_ERROR task_id='4e2c5f902ddf408fa79c127b491e0835' task_name='slices_bi_refimpl_backend.tasks.compute_resource:delete_compute_resou rce' labels={} labels_types={} args=[UUID('019d94e1-99f4-7432-81b0-d9ad23cdba94'), 'status_change:api_initiated:delete'] kwargs={'initiator': 'user_account.ilabt.imec.be_1c3x2sxhmv8dqtmkxh9392sa0g'} Details stored at: /root/.slices/cli_error_details/err_2026-04-16T06:04:06+00:00.txt 2026-04-16 08:04:06.456339 CEST - Error in test step 'Destroy': "slices bi destroy" failed (return value is 1) 2026-04-16 08:04:06.456369 CEST - Wait 2s before retry 2026-04-16 08:04:12.131383 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/056934c9-1afc-4dc5-b526-41e5035c9936/step_DestroyRetry1_retry1_command_1.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices bi --infra de-munich-bi-vm destroy --experiment tst-9e8438a3 tst 2026-04-16 08:04:12.131479 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/056934c9-1afc-4dc5-b526-41e5035c9936/destroy_retry1.txt': 0.0% / waiting for task start 0.0% - waiting for task start 0.0% \ waiting for task start 0.0% | waiting for task start 0.0% / waiting for task start Deleting tst: task starting # task_id='4a484c8a5fdf47c4b36abb0a3dcf9b98' tas… 1… Destroy failure ❌ ❌ Failed to destroy tst with ID r_de-munich-bi-vm_01kpae36fmegs83c6snmhwvemm Failure: INTERNAL_ERROR task_id='4a484c8a5fdf47c4b36abb0a3dcf9b98' task_name='slices_bi_refimpl_backend.tasks.compute_resource:delete_compute_resou rce' labels={} labels_types={} args=[UUID('019d94e1-99f4-7432-81b0-d9ad23cdba94'), 'status_change:api_initiated:delete'] kwargs={'initiator': 'user_account.ilabt.imec.be_1c3x2sxhmv8dqtmkxh9392sa0g'} Details stored at: /root/.slices/cli_error_details/err_2026-04-16T06:04:11+00:00.txt 2026-04-16 08:04:12.131507 CEST - Error in test step 'Destroy (Retry 1)': "slices bi destroy" failed (return value is 1) 2026-04-16 08:04:12.131534 CEST - Wait 2s before retry 2026-04-16 08:04:15.199225 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/056934c9-1afc-4dc5-b526-41e5035c9936/step_DestroyRetry2_retry2_command_1.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices bi --infra de-munich-bi-vm destroy --experiment tst-9e8438a3 tst 2026-04-16 08:04:15.199351 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/056934c9-1afc-4dc5-b526-41e5035c9936/destroy_retry2.txt': Deleting tst: task starting # task_id='305f2213e6344236905dc46d389c3729' tas… 1… Destroy failure ❌ ❌ Failed to destroy tst with ID r_de-munich-bi-vm_01kpae36fmegs83c6snmhwvemm Failure: INTERNAL_ERROR task_id='305f2213e6344236905dc46d389c3729' task_name='slices_bi_refimpl_backend.tasks.compute_resource:delete_compute_resou rce' labels={} labels_types={} args=[UUID('019d94e1-99f4-7432-81b0-d9ad23cdba94'), 'status_change:api_initiated:delete'] kwargs={'initiator': 'user_account.ilabt.imec.be_1c3x2sxhmv8dqtmkxh9392sa0g'} Details stored at: /root/.slices/cli_error_details/err_2026-04-16T06:04:15+00:00.txt 2026-04-16 08:04:15.199389 CEST - Error in test step 'Destroy (Retry 2)': "slices bi destroy" failed (return value is 1) 2026-04-16 08:04:15.199423 CEST - Wait 2s before retry 2026-04-16 08:04:19.821637 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/056934c9-1afc-4dc5-b526-41e5035c9936/step_DestroyRetry3_retry3_command_1.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices bi --infra de-munich-bi-vm destroy --experiment tst-9e8438a3 tst 2026-04-16 08:04:19.821773 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/056934c9-1afc-4dc5-b526-41e5035c9936/destroy_retry3.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='033ea8dadfef4aebaf805dc1c0356480' tas… 1… Destroy failure ❌ ❌ Failed to destroy tst with ID r_de-munich-bi-vm_01kpae36fmegs83c6snmhwvemm Failure: INTERNAL_ERROR task_id='033ea8dadfef4aebaf805dc1c0356480' task_name='slices_bi_refimpl_backend.tasks.compute_resource:delete_compute_resou rce' labels={} labels_types={} args=[UUID('019d94e1-99f4-7432-81b0-d9ad23cdba94'), 'status_change:api_initiated:delete'] kwargs={'initiator': 'user_account.ilabt.imec.be_1c3x2sxhmv8dqtmkxh9392sa0g'} Details stored at: /root/.slices/cli_error_details/err_2026-04-16T06:04:19+00:00.txt 2026-04-16 08:04:19.821810 CEST - Error in test step 'Destroy (Retry 3)': "slices bi destroy" failed (return value is 1)