Run Test: slices-bi-singlenode-login 2026-04-01 00:12:59.633192 CEST - Run: /usr/local/bin/uv pip install --pre --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-04-01 00:13:02.791973 CEST - Run: slices --version 2026-04-01 00:13:03.007920 CEST - version: Slices CLI v2026.0.0b5 Slices CLI core v1.1.15 Slices CLI bi v2.1.0b19 Slices clientlib bi v6.1.1 Slices clientlib core v5.5.0 2026-04-01 00:13:03.008248 CEST - Run: slices pubkey list --format text 2026-04-01 00:13:03.739491 CEST - Pubkey already registered 2026-04-01 00:13:03.739736 CEST - Run: slices bi infrastructure list --format csv --all --refresh 2026-04-01 00:13:04.329306 CEST - Refreshed infrastructure list. Total: 22 entries. 2026-04-01 00:13:04.329409 CEST - Check List Flavors 2026-04-01 00:13:04.329582 CEST - Run: slices bi --infra be-gent1-bi-vm1 flavor list -f json 2026-04-01 00:13:05.118493 CEST - Check List DiskImages 2026-04-01 00:13:05.118678 CEST - Run: slices bi --infra be-gent1-bi-vm1 diskimage list -f json 2026-04-01 00:13:05.702412 CEST - Requesting resources 2026-04-01 00:13:05.703028 CEST - Run: slices bi --infra be-gent1-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-c59b54a0 2026-04-01 00:13:07.511490 CEST - Resource ID: r_be-gent1-bi-vm1_01kn2za9n4ed6amr8m9a1frpjm 2026-04-01 00:13:07.511611 CEST - Waiting until resource ready 2026-04-01 00:13:09.512074 CEST - Run: slices bi --infra be-gent1-bi-vm1 list-resources --format json --experiment tst-c59b54a0 tst 2026-04-01 00:13:10.218757 CEST - Status: IMAGING 2026-04-01 00:13:12.923191 CEST - Status: IMAGING 2026-04-01 00:13:15.633415 CEST - Status: IMAGING 2026-04-01 00:13:18.337794 CEST - Status: BOOTING 2026-04-01 00:13:20.987619 CEST - Status: BOOTING 2026-04-01 00:13:23.632530 CEST - Status: BOOTING 2026-04-01 00:13:26.262553 CEST - Status: BOOTING 2026-04-01 00:13:28.924313 CEST - Status: BOOTING 2026-04-01 00:13:31.570545 CEST - Status: INITIALIZING 2026-04-01 00:13:34.217493 CEST - Status: UP 2026-04-01 00:13:34.217537 CEST - Experiment ID: exp_expauth.ilabt.imec.be_01kn2za943fsm9xh5v64fq7w7j 2026-04-01 00:13:34.217570 CEST - Validate resources 2026-04-01 00:13:34.855993 CEST - The fields of the created resource were validated. 2026-04-01 00:13:34.856054 CEST - Check if resources are registered in experiment 2026-04-01 00:13:34.856215 CEST - Run: slices experiment list-resources --format json tst-c59b54a0 2026-04-01 00:13:35.500563 CEST - Status (on expauth): UP 2026-04-01 00:13:35.500697 CEST - Testing extend expires_at (all resources in experiment) 2026-04-01 00:13:35.500897 CEST - Run: slices bi --infra be-gent1-bi-vm1 extend --duration 3h --experiment tst-c59b54a0 2026-04-01 00:13:37.364547 CEST - Run: slices bi --infra be-gent1-bi-vm1 list-resources --format json --experiment tst-c59b54a0 tst 2026-04-01 00:13:38.004959 CEST - Testing extend expires_at (single resource in experiment) 2026-04-01 00:13:38.005138 CEST - Run: slices bi --infra be-gent1-bi-vm1 extend tst --duration 4h --experiment tst-c59b54a0 2026-04-01 00:13:39.882314 CEST - Run: slices bi --infra be-gent1-bi-vm1 list-resources --format json --experiment tst-c59b54a0 tst 2026-04-01 00:13:40.532487 CEST - Testing ssh login 2026-04-01 00:13:40.542439 CEST - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-c59b54a0 tst 2026-04-01 00:13:41.231683 CEST - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-c59b54a0 tst 2026-04-01 00:13:41.910530 CEST - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-c59b54a0 tst 2026-04-01 00:13:42.589971 CEST - Logging in using 'slices bi ssh' 2026-04-01 00:13:42.590024 CEST - Forcing IPv4 only. 2026-04-01 00:13:42.590162 CEST - Run: slices bi --infra be-gent1-bi-vm1 ssh --show nothing --experiment tst-c59b54a0 tst -- -4 uname -a 2026-04-01 00:13:43.899342 CEST - Forcing IPv4 only. 2026-04-01 00:13:43.899503 CEST - Run: slices bi --infra be-gent1-bi-vm1 ssh --show nothing --experiment tst-c59b54a0 tst -- -4 uptime 2026-04-01 00:13:44.642318 CEST - CLI SSH Test passed. 2026-04-01 00:13:44.642360 CEST - Uname: Linux tst 6.8.0-85-generic #85-Ubuntu SMP PREEMPT_DYNAMIC Thu Sep 18 15:26:59 UTC 2025 x86_64 x86_64 x86_64 GNU/Linux 2026-04-01 00:13:44.642370 CEST - Uptime: 00:13:44 up 0 min, 1 user, load average: 0.20, 0.05, 0.02 2026-04-01 00:13:44.642399 CEST - Logging in using SSH (extra test: ignore SSH proxy) 2026-04-01 00:13:44.643635 CEST - Added paramiko HostKeyEntry for 10.10.212.130 2026-04-01 00:13:44.643826 CEST - Added paramiko HostKeyEntry for 10.10.212.130 2026-04-01 00:13:44.643890 CEST - Added paramiko HostKeyEntry for 10.10.212.130 2026-04-01 00:13:44.644086 CEST - Connecting to 10.10.212.130:22 2026-04-01 00:13:44.878198 CEST - SSH Test output: 2026-04-01 00:13:44.878242 CEST - Uname: Linux tst 6.8.0-85-generic #85-Ubuntu SMP PREEMPT_DYNAMIC Thu Sep 18 15:26:59 UTC 2025 x86_64 x86_64 x86_64 GNU/Linux 2026-04-01 00:13:44.878253 CEST - Uptime: 00:13:44 up 0 min, 1 user, load average: 0.20, 0.05, 0.02 2026-04-01 00:13:44.926082 CEST - lsb_release: Ubuntu 24.04.3 LTS 2026-04-01 00:13:44.926129 CEST - lsb_release matches expected value 2026-04-01 00:13:44.926139 CEST - SSH Test passed. 2026-04-01 00:13:44.926213 CEST - Logging in using SSH over SSH proxy 2026-04-01 00:13:44.926356 CEST - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-c59b54a0 tst 2026-04-01 00:13:45.603917 CEST - Added paramiko HostKeyEntry for 10.10.212.130 2026-04-01 00:13:45.604047 CEST - Added paramiko HostKeyEntry for 10.10.212.130 2026-04-01 00:13:45.604085 CEST - Added paramiko HostKeyEntry for 10.10.212.130 2026-04-01 00:13:45.604303 CEST - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-04-01 00:13:45.604345 CEST - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-04-01 00:13:45.604432 CEST - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-04-01 00:13:45.604444 CEST - Connecting to proxy bastion2.slices-be.eu:22 2026-04-01 00:13:45.761262 CEST - Connecting to 10.10.212.130:22 over proxy 2026-04-01 00:13:45.997623 CEST - SSH Test output: 2026-04-01 00:13:45.997666 CEST - Uname: Linux tst 6.8.0-85-generic #85-Ubuntu SMP PREEMPT_DYNAMIC Thu Sep 18 15:26:59 UTC 2025 x86_64 x86_64 x86_64 GNU/Linux 2026-04-01 00:13:45.997676 CEST - Uptime: 00:13:45 up 0 min, 2 users, load average: 0.20, 0.05, 0.02 2026-04-01 00:13:46.050362 CEST - lsb_release: Ubuntu 24.04.3 LTS 2026-04-01 00:13:46.050411 CEST - lsb_release matches expected value 2026-04-01 00:13:46.050426 CEST - SSH Test passed. 2026-04-01 00:13:46.056667 CEST - Destroying tst-c59b54a0 tst 2026-04-01 00:13:46.056831 CEST - Run: slices bi --infra be-gent1-bi-vm1 destroy --experiment tst-c59b54a0 tst 2026-04-01 00:13:46.864509 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/c2fe3d0c-2eb3-4624-8a72-ddaafe0640b2/step_Destroy_command_1.txt': /opt/slices-monitor-worker/slices-cli-pre-venv/bin/slices bi --infra be-gent1-bi-vm1 destroy --experiment tst-c59b54a0 tst 2026-04-01 00:13:46.864594 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/c2fe3d0c-2eb3-4624-8a72-ddaafe0640b2/destroy.txt': ╭───────────────────── Traceback (most recent call last) ──────────────────────╮ │ /opt/slices-monitor-worker/slices-cli-pre-venv/lib/python3.14/site-packages/ │ │ slices_cli_bi/commands/bi_helpers.py:83 in wrapper_handle_some_exceptions │ │ │ │ 80 │ def wrapper_handle_some_exceptions(*args, **kwargs): │ │ 81 │ │ """Function wrapper for handle_some_exceptions.""" # noqa: D4 │ │ 82 │ │ try: │ │ ❱ 83 │ │ │ return func(*args, **kwargs) │ │ 84 │ │ except ApiResponseError as e: │ │ 85 │ │ │ if e._httpx_status_error.response.status_code in ( │ │ 86 │ │ │ │ 502, │ │ │ │ /opt/slices-monitor-worker/slices-cli-pre-venv/lib/python3.14/site-packages/ │ │ slices_cli_bi/commands/bi.py:1348 in destroy_resource │ │ │ │ 1345 │ │ │ │ skip_confirmation = True │ │ 1346 │ │ │ │ 1347 │ │ delete_task = ctx.obj.get_bi_resources_api_by_experiment(exp) │ │ ❱ 1348 │ │ delete_task_info.append((f"Deleting {resource.friendly_name}" │ │ 1349 │ │ try: │ │ 1350 │ │ │ SSHKnownHostsManager().cleanup(resource.id) │ │ 1351 │ │ except Exception: │ ╰──────────────────────────────────────────────────────────────────────────────╯ AttributeError: 'list' object has no attribute 'id' 2026-04-01 00:13:46.864636 CEST - Error in test step 'Destroy': "slices bi destroy" failed (return value is 1) 2026-04-01 00:13:46.864661 CEST - Wait 2s before retry 2026-04-01 00:13:49.719366 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/c2fe3d0c-2eb3-4624-8a72-ddaafe0640b2/step_DestroyRetry1_retry1_command_1.txt': /opt/slices-monitor-worker/slices-cli-pre-venv/bin/slices bi --infra be-gent1-bi-vm1 destroy --experiment tst-c59b54a0 tst 2026-04-01 00:13:49.719459 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/c2fe3d0c-2eb3-4624-8a72-ddaafe0640b2/destroy_retry1.txt': ╭───────────────────── Traceback (most recent call last) ──────────────────────╮ │ /opt/slices-monitor-worker/slices-cli-pre-venv/lib/python3.14/site-packages/ │ │ slices_cli_bi/commands/bi_helpers.py:83 in wrapper_handle_some_exceptions │ │ │ │ 80 │ def wrapper_handle_some_exceptions(*args, **kwargs): │ │ 81 │ │ """Function wrapper for handle_some_exceptions.""" # noqa: D4 │ │ 82 │ │ try: │ │ ❱ 83 │ │ │ return func(*args, **kwargs) │ │ 84 │ │ except ApiResponseError as e: │ │ 85 │ │ │ if e._httpx_status_error.response.status_code in ( │ │ 86 │ │ │ │ 502, │ │ │ │ /opt/slices-monitor-worker/slices-cli-pre-venv/lib/python3.14/site-packages/ │ │ slices_cli_bi/commands/bi.py:1348 in destroy_resource │ │ │ │ 1345 │ │ │ │ skip_confirmation = True │ │ 1346 │ │ │ │ 1347 │ │ delete_task = ctx.obj.get_bi_resources_api_by_experiment(exp) │ │ ❱ 1348 │ │ delete_task_info.append((f"Deleting {resource.friendly_name}" │ │ 1349 │ │ try: │ │ 1350 │ │ │ SSHKnownHostsManager().cleanup(resource.id) │ │ 1351 │ │ except Exception: │ ╰──────────────────────────────────────────────────────────────────────────────╯ AttributeError: 'list' object has no attribute 'id' 2026-04-01 00:13:49.719483 CEST - Error in test step 'Destroy (Retry 1)': "slices bi destroy" failed (return value is 1) 2026-04-01 00:13:49.719506 CEST - Wait 2s before retry 2026-04-01 00:13:52.543554 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/c2fe3d0c-2eb3-4624-8a72-ddaafe0640b2/step_DestroyRetry2_retry2_command_1.txt': /opt/slices-monitor-worker/slices-cli-pre-venv/bin/slices bi --infra be-gent1-bi-vm1 destroy --experiment tst-c59b54a0 tst 2026-04-01 00:13:52.543645 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/c2fe3d0c-2eb3-4624-8a72-ddaafe0640b2/destroy_retry2.txt': ╭───────────────────── Traceback (most recent call last) ──────────────────────╮ │ /opt/slices-monitor-worker/slices-cli-pre-venv/lib/python3.14/site-packages/ │ │ slices_cli_bi/commands/bi_helpers.py:83 in wrapper_handle_some_exceptions │ │ │ │ 80 │ def wrapper_handle_some_exceptions(*args, **kwargs): │ │ 81 │ │ """Function wrapper for handle_some_exceptions.""" # noqa: D4 │ │ 82 │ │ try: │ │ ❱ 83 │ │ │ return func(*args, **kwargs) │ │ 84 │ │ except ApiResponseError as e: │ │ 85 │ │ │ if e._httpx_status_error.response.status_code in ( │ │ 86 │ │ │ │ 502, │ │ │ │ /opt/slices-monitor-worker/slices-cli-pre-venv/lib/python3.14/site-packages/ │ │ slices_cli_bi/commands/bi.py:1348 in destroy_resource │ │ │ │ 1345 │ │ │ │ skip_confirmation = True │ │ 1346 │ │ │ │ 1347 │ │ delete_task = ctx.obj.get_bi_resources_api_by_experiment(exp) │ │ ❱ 1348 │ │ delete_task_info.append((f"Deleting {resource.friendly_name}" │ │ 1349 │ │ try: │ │ 1350 │ │ │ SSHKnownHostsManager().cleanup(resource.id) │ │ 1351 │ │ except Exception: │ ╰──────────────────────────────────────────────────────────────────────────────╯ AttributeError: 'list' object has no attribute 'id' 2026-04-01 00:13:52.543666 CEST - Error in test step 'Destroy (Retry 2)': "slices bi destroy" failed (return value is 1) 2026-04-01 00:13:52.543692 CEST - Wait 2s before retry 2026-04-01 00:13:55.359632 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/c2fe3d0c-2eb3-4624-8a72-ddaafe0640b2/step_DestroyRetry3_retry3_command_1.txt': /opt/slices-monitor-worker/slices-cli-pre-venv/bin/slices bi --infra be-gent1-bi-vm1 destroy --experiment tst-c59b54a0 tst 2026-04-01 00:13:55.359711 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/c2fe3d0c-2eb3-4624-8a72-ddaafe0640b2/destroy_retry3.txt': ╭───────────────────── Traceback (most recent call last) ──────────────────────╮ │ /opt/slices-monitor-worker/slices-cli-pre-venv/lib/python3.14/site-packages/ │ │ slices_cli_bi/commands/bi_helpers.py:83 in wrapper_handle_some_exceptions │ │ │ │ 80 │ def wrapper_handle_some_exceptions(*args, **kwargs): │ │ 81 │ │ """Function wrapper for handle_some_exceptions.""" # noqa: D4 │ │ 82 │ │ try: │ │ ❱ 83 │ │ │ return func(*args, **kwargs) │ │ 84 │ │ except ApiResponseError as e: │ │ 85 │ │ │ if e._httpx_status_error.response.status_code in ( │ │ 86 │ │ │ │ 502, │ │ │ │ /opt/slices-monitor-worker/slices-cli-pre-venv/lib/python3.14/site-packages/ │ │ slices_cli_bi/commands/bi.py:1348 in destroy_resource │ │ │ │ 1345 │ │ │ │ skip_confirmation = True │ │ 1346 │ │ │ │ 1347 │ │ delete_task = ctx.obj.get_bi_resources_api_by_experiment(exp) │ │ ❱ 1348 │ │ delete_task_info.append((f"Deleting {resource.friendly_name}" │ │ 1349 │ │ try: │ │ 1350 │ │ │ SSHKnownHostsManager().cleanup(resource.id) │ │ 1351 │ │ except Exception: │ ╰──────────────────────────────────────────────────────────────────────────────╯ AttributeError: 'list' object has no attribute 'id' 2026-04-01 00:13:55.359742 CEST - Error in test step 'Destroy (Retry 3)': "slices bi destroy" failed (return value is 1)