Run Test: slices-bi-singlenode-login 2026-05-05 00:01:35.257525 CEST - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-05-05 00:01:38.579312 CEST - Run: slices --version 2026-05-05 00:01:38.794020 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-05 00:01:38.794327 CEST - Run: slices pubkey list --format text 2026-05-05 00:01:39.509976 CEST - Pubkey already registered 2026-05-05 00:01:39.510210 CEST - Run: slices bi infrastructure list --format csv --all --refresh 2026-05-05 00:01:40.075492 CEST - Refreshed infrastructure list. Total: 22 entries. 2026-05-05 00:01:40.075621 CEST - Check List Flavors 2026-05-05 00:01:40.075804 CEST - Run: slices bi --infra de-munich-bi-vm flavor list -f json 2026-05-05 00:01:45.201589 CEST - Step 'List Flavors' took 5.13 seconds, which is longer than the warning threshold of 5 seconds 2026-05-05 00:01:45.201663 CEST - Check List DiskImages 2026-05-05 00:01:45.201835 CEST - Run: slices bi --infra de-munich-bi-vm diskimage list -f json 2026-05-05 00:01:45.867386 CEST - Requesting resources 2026-05-05 00:01:45.867874 CEST - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-05-05 00:01:45.867971 CEST - Run: slices bi --infra de-munich-bi-vm create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-0a30f1b7 --user-data /tmp/tmpcolxqui5 2026-05-05 00:01:53.651163 CEST - Resource ID: r_de-munich-bi-vm_01kqtg65hnft8ranan5hyjvdnn 2026-05-05 00:01:53.651323 CEST - Waiting until resource ready 2026-05-05 00:01:55.651743 CEST - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-0a30f1b7 tst 2026-05-05 00:01:56.417565 CEST - Status: IMAGING 2026-05-05 00:01:59.183781 CEST - Status: IMAGING 2026-05-05 00:02:01.949816 CEST - Status: IMAGING 2026-05-05 00:02:04.715837 CEST - Status: IMAGING 2026-05-05 00:02:07.482317 CEST - Status: IMAGING 2026-05-05 00:02:10.248341 CEST - Status: BOOTING 2026-05-05 00:02:12.964558 CEST - Status: BOOTING 2026-05-05 00:02:15.680745 CEST - Status: BOOTING 2026-05-05 00:02:18.447024 CEST - Status: BOOTING 2026-05-05 00:02:21.163064 CEST - Status: BOOTING 2026-05-05 00:02:23.879054 CEST - Status: BOOTING 2026-05-05 00:02:26.645270 CEST - Status: BOOTING 2026-05-05 00:02:29.361404 CEST - Status: BOOTING 2026-05-05 00:02:32.127546 CEST - Status: BOOTING 2026-05-05 00:02:34.893701 CEST - Status: BOOTING 2026-05-05 00:02:37.609842 CEST - Status: BOOTING 2026-05-05 00:02:40.326029 CEST - Status: BOOTING 2026-05-05 00:02:43.042078 CEST - Status: BOOTING 2026-05-05 00:02:45.758167 CEST - Status: BOOTING 2026-05-05 00:02:48.474367 CEST - Status: BOOTING 2026-05-05 00:02:51.190370 CEST - Status: BOOTING 2026-05-05 00:02:53.956464 CEST - Status: BOOTING 2026-05-05 00:02:56.722750 CEST - Status: BOOTING 2026-05-05 00:02:59.488968 CEST - Status: BOOTING 2026-05-05 00:03:02.255055 CEST - Status: BOOTING 2026-05-05 00:03:05.072026 CEST - Status: BOOTING 2026-05-05 00:03:07.788085 CEST - Status: BOOTING 2026-05-05 00:03:10.554352 CEST - Status: BOOTING 2026-05-05 00:03:13.270174 CEST - Status: BOOTING 2026-05-05 00:03:16.086685 CEST - Status: BOOTING 2026-05-05 00:03:18.853934 CEST - Status: BOOTING 2026-05-05 00:03:21.569769 CEST - Status: BOOTING 2026-05-05 00:03:24.338506 CEST - Status: BOOTING 2026-05-05 00:03:27.154888 CEST - Status: BOOTING 2026-05-05 00:03:29.921379 CEST - Status: BOOTING 2026-05-05 00:03:32.688612 CEST - Status: BOOTING 2026-05-05 00:03:35.404401 CEST - Status: BOOTING 2026-05-05 00:03:38.120426 CEST - Status: BOOTING 2026-05-05 00:03:40.836358 CEST - Status: BOOTING 2026-05-05 00:03:43.552259 CEST - Status: BOOTING 2026-05-05 00:03:46.268106 CEST - Status: BOOTING 2026-05-05 00:03:48.984001 CEST - Status: BOOTING 2026-05-05 00:03:51.750583 CEST - Status: BOOTING 2026-05-05 00:03:54.466591 CEST - Status: BOOTING 2026-05-05 00:03:57.182773 CEST - Status: BOOTING 2026-05-05 00:03:59.899029 CEST - Status: BOOTING 2026-05-05 00:04:02.665291 CEST - Status: BOOTING 2026-05-05 00:04:05.431606 CEST - Status: BOOTING 2026-05-05 00:04:08.147525 CEST - Status: BOOTING 2026-05-05 00:04:10.863571 CEST - Status: BOOTING 2026-05-05 00:04:10.864791 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/445b43d2-ccee-46e7-9d86-b345b16f8379/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-0a30f1b7 tst 2026-05-05 00:04:10.864862 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/445b43d2-ccee-46e7-9d86-b345b16f8379/list-resources_json.txt': [ { "cluster_id": "default", "created_at": "2026-05-04T22:01:53.452404Z", "disk_image_id": "image_de-munich-bi-vm_01kjceghcff5gbwgxyt40nkj7a", "experiment_id": "exp_expauth.ilabt.imec.be_01kqtg5zfpfw08sbkvwxgy4nqn", "expires_at": "2026-05-05T00:01:00Z", "flavor_id": "flavor_de-munich-bi-vm_01kjceghd0fh1vh08ygdp4hrn9", "friendly_name": "tst", "id": "r_de-munich-bi-vm_01kqtg65hnft8ranan5hyjvdnn", "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-05-05 00:04:10.864885 CEST - Error in test step 'Wait for UP': experiment did not become ready before timeout 2026-05-05 00:04:10.864913 CEST - Destroying tst-0a30f1b7 tst 2026-05-05 00:04:10.865045 CEST - Run: slices bi --infra de-munich-bi-vm destroy --experiment tst-0a30f1b7 tst 2026-05-05 00:04:11.831354 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/445b43d2-ccee-46e7-9d86-b345b16f8379/step_Destroy_command_1.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices bi --infra de-munich-bi-vm destroy --experiment tst-0a30f1b7 tst 2026-05-05 00:04:11.831443 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/445b43d2-ccee-46e7-9d86-b345b16f8379/destroy.txt': Deleting tst: task starting # task_id='38f54979ee06493aba7100e54e1207df' tas… 1… Destroy failure ❌ ❌ Failed to destroy tst with ID r_de-munich-bi-vm_01kqtg65hnft8ranan5hyjvdnn Failure: INTERNAL_ERROR task_id='38f54979ee06493aba7100e54e1207df' task_name='slices_bi_refimpl_backend.tasks.compute_resource:delete_compute_resou rce' labels={} labels_types={} args=[UUID('019df503-1635-7e91-8555-552c7d2db6b5'), 'status_change:api_initiated:delete'] kwargs={'initiator': 'user_account.ilabt.imec.be_1c3x2sxhmv8dqtmkxh9392sa0g'} Details stored at: /root/.slices/cli_error_details/err_2026-05-04T22:04:11+00:00.txt 2026-05-05 00:04:11.831469 CEST - Error in test step 'Destroy': "slices bi destroy" failed (return value is 1) 2026-05-05 00:04:11.831495 CEST - Wait 2s before retry 2026-05-05 00:04:15.299481 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/445b43d2-ccee-46e7-9d86-b345b16f8379/step_DestroyRetry1_retry1_command_1.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices bi --infra de-munich-bi-vm destroy --experiment tst-0a30f1b7 tst 2026-05-05 00:04:15.299572 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/445b43d2-ccee-46e7-9d86-b345b16f8379/destroy_retry1.txt': 0.0% / waiting for task start Deleting tst: task starting # task_id='e6c0b4b158f44228935dc71f668dafab' tas… 1… Destroy failure ❌ ❌ Failed to destroy tst with ID r_de-munich-bi-vm_01kqtg65hnft8ranan5hyjvdnn Failure: INTERNAL_ERROR task_id='e6c0b4b158f44228935dc71f668dafab' task_name='slices_bi_refimpl_backend.tasks.compute_resource:delete_compute_resou rce' labels={} labels_types={} args=[UUID('019df503-1635-7e91-8555-552c7d2db6b5'), 'status_change:api_initiated:delete'] kwargs={'initiator': 'user_account.ilabt.imec.be_1c3x2sxhmv8dqtmkxh9392sa0g'} Details stored at: /root/.slices/cli_error_details/err_2026-05-04T22:04:15+00:00.txt 2026-05-05 00:04:15.299595 CEST - Error in test step 'Destroy (Retry 1)': "slices bi destroy" failed (return value is 1) 2026-05-05 00:04:15.299621 CEST - Wait 2s before retry 2026-05-05 00:04:18.266498 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/445b43d2-ccee-46e7-9d86-b345b16f8379/step_DestroyRetry2_retry2_command_1.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices bi --infra de-munich-bi-vm destroy --experiment tst-0a30f1b7 tst 2026-05-05 00:04:18.266602 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/445b43d2-ccee-46e7-9d86-b345b16f8379/destroy_retry2.txt': Deleting tst: task starting # task_id='af0fd0e48ea9420e8fb2a17ffd5916fa' tas… 1… Destroy failure ❌ ❌ Failed to destroy tst with ID r_de-munich-bi-vm_01kqtg65hnft8ranan5hyjvdnn Failure: INTERNAL_ERROR task_id='af0fd0e48ea9420e8fb2a17ffd5916fa' task_name='slices_bi_refimpl_backend.tasks.compute_resource:delete_compute_resou rce' labels={} labels_types={} args=[UUID('019df503-1635-7e91-8555-552c7d2db6b5'), 'status_change:api_initiated:delete'] kwargs={'initiator': 'user_account.ilabt.imec.be_1c3x2sxhmv8dqtmkxh9392sa0g'} Details stored at: /root/.slices/cli_error_details/err_2026-05-04T22:04:18+00:00.txt 2026-05-05 00:04:18.266642 CEST - Error in test step 'Destroy (Retry 2)': "slices bi destroy" failed (return value is 1) 2026-05-05 00:04:18.266670 CEST - Wait 2s before retry 2026-05-05 00:04:23.338621 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/445b43d2-ccee-46e7-9d86-b345b16f8379/step_DestroyRetry3_retry3_command_1.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices bi --infra de-munich-bi-vm destroy --experiment tst-0a30f1b7 tst 2026-05-05 00:04:23.338713 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/445b43d2-ccee-46e7-9d86-b345b16f8379/destroy_retry3.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 Deleting tst: task starting # task_id='a60d573741b648eab7d4f83c04a4f340' tas… 1… Destroy failure ❌ ❌ Failed to destroy tst with ID r_de-munich-bi-vm_01kqtg65hnft8ranan5hyjvdnn Failure: INTERNAL_ERROR task_id='a60d573741b648eab7d4f83c04a4f340' task_name='slices_bi_refimpl_backend.tasks.compute_resource:delete_compute_resou rce' labels={} labels_types={} args=[UUID('019df503-1635-7e91-8555-552c7d2db6b5'), 'status_change:api_initiated:delete'] kwargs={'initiator': 'user_account.ilabt.imec.be_1c3x2sxhmv8dqtmkxh9392sa0g'} Details stored at: /root/.slices/cli_error_details/err_2026-05-04T22:04:23+00:00.txt 2026-05-05 00:04:23.338737 CEST - Error in test step 'Destroy (Retry 3)': "slices bi destroy" failed (return value is 1)