Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 4.66s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 879ms warning: Failed to hardlink files; falling back to full copy. This may lead to degraded performance. If the cache and target directories are on different filesystems, hardlinking may not be supported. If this is intentional, set `export UV_LINK_MODE=copy` or use `--link-mode=copy` to suppress this warning. Installed 32 packages in 989ms + annotated-types==0.7.0 + anyio==4.14.1 + authlib==1.7.2 + bcrypt==5.0.0 + certifi==2026.6.17 + cffi==2.1.0 + cryptography==49.0.0 + dnspython==2.8.0 + h11==0.16.0 + httpcore==1.0.9 + httpx==0.28.1 + httpx-oauth==0.17.0 + idna==3.18 + invoke==3.0.3 + joserfc==1.7.3 + msgspec==0.21.1 + packaging==26.2 + paramiko==4.0.0 + pycparser==3.0 + pydantic==2.13.4 + pydantic-core==2.46.4 + pyjwt==2.13.0 + pynacl==1.6.2 + pytz==2026.2 + pyyaml==6.0.3 + slices-clientlib-bi==5.1.2 + slices-clientlib-core==5.6.0 + slices-monitor-test-runner==0.1.dev179+g419876b58 (from file:///app) + tomli-w==1.2.0 + tomlkit==0.15.0 + typing-extensions==4.16.0 + typing-inspection==0.4.2 Run Test: slices-bi-singlenode-login 2026-07-08 16:01:28.761232 UTC - Installing Slices CLI (latest stable version). 2026-07-08 16:01:28.761673 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-08 16:01:37.550719 UTC - Slices CLI installed. 2026-07-08 16:01:37.550929 UTC - Slices CLI exe: 'slices' 2026-07-08 16:01:37.550953 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-08 16:01:37.551093 UTC - Run: slices --version 2026-07-08 16:01:43.946952 UTC - version: Slices CLI v2026.1.2 Slices CLI core v1.2.4 Slices CLI ai v1.1.0 Slices CLI bi v2.2.0 Slices clientlib bi v6.1.1 Slices clientlib ai v1.0.0 Slices clientlib core v5.5.1 2026-07-08 16:01:43.948276 UTC - Run: slices pubkey list --format text 2026-07-08 16:01:45.025021 UTC - Pubkey already registered 2026-07-08 16:01:45.025877 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-08 16:01:45.691225 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-08 16:01:45.691318 UTC - Check List Flavors 2026-07-08 16:01:45.691457 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-07-08 16:01:46.812375 UTC - Check List DiskImages 2026-07-08 16:01:46.812543 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-07-08 16:01:47.633264 UTC - Requesting resources 2026-07-08 16:01:47.633929 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian11-min --flavor taurus --duration 2h --experiment tst-89ab9c4e 2026-07-08 16:01:50.255095 UTC - Resource ID: r_fr-lyon1-bi-baremetal1_01kx17dkcmezsv7mmsq2fbm5gm 2026-07-08 16:01:50.255274 UTC - Waiting until resource ready 2026-07-08 16:01:52.255644 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-89ab9c4e tst 2026-07-08 16:01:53.021143 UTC - Status: IMAGING 2026-07-08 16:01:55.737855 UTC - Status: STARTING 2026-07-08 16:01:58.453919 UTC - Status: STARTING 2026-07-08 16:02:01.321104 UTC - Status: STARTING 2026-07-08 16:02:04.087296 UTC - Status: STARTING 2026-07-08 16:02:06.853571 UTC - Status: STARTING 2026-07-08 16:02:09.619727 UTC - Status: STARTING 2026-07-08 16:02:12.385818 UTC - Status: STARTING 2026-07-08 16:02:15.152783 UTC - Status: STARTING 2026-07-08 16:02:18.019830 UTC - Status: STARTING 2026-07-08 16:02:20.786215 UTC - Status: STARTING 2026-07-08 16:02:23.502057 UTC - Status: STARTING 2026-07-08 16:02:26.268217 UTC - Status: STARTING 2026-07-08 16:02:29.135310 UTC - Status: STARTING 2026-07-08 16:02:31.901492 UTC - Status: STARTING 2026-07-08 16:02:34.668451 UTC - Status: STARTING 2026-07-08 16:02:37.435324 UTC - Status: STARTING 2026-07-08 16:02:40.302268 UTC - Status: STARTING 2026-07-08 16:02:43.069283 UTC - Status: STARTING 2026-07-08 16:02:45.785459 UTC - Status: STARTING 2026-07-08 16:02:48.501409 UTC - Status: STARTING 2026-07-08 16:02:51.269755 UTC - Status: STARTING 2026-07-08 16:02:53.985644 UTC - Status: STARTING 2026-07-08 16:02:56.752086 UTC - Status: STARTING 2026-07-08 16:02:59.468051 UTC - Status: STARTING 2026-07-08 16:03:02.184153 UTC - Status: STARTING 2026-07-08 16:03:05.000554 UTC - Status: STARTING 2026-07-08 16:03:07.817809 UTC - Status: STARTING 2026-07-08 16:03:10.584340 UTC - Status: STARTING 2026-07-08 16:03:13.300174 UTC - Status: STARTING 2026-07-08 16:03:16.166978 UTC - Status: STARTING 2026-07-08 16:03:18.933087 UTC - Status: STARTING 2026-07-08 16:03:21.699507 UTC - Status: STARTING 2026-07-08 16:03:24.466128 UTC - Status: STARTING 2026-07-08 16:03:27.232572 UTC - Status: STARTING 2026-07-08 16:03:29.998955 UTC - Status: STARTING 2026-07-08 16:03:32.767224 UTC - Status: STARTING 2026-07-08 16:03:35.533628 UTC - Status: STARTING 2026-07-08 16:03:38.350824 UTC - Status: STARTING 2026-07-08 16:03:41.219126 UTC - Status: STARTING 2026-07-08 16:03:43.985431 UTC - Status: STARTING 2026-07-08 16:03:46.751669 UTC - Status: STARTING 2026-07-08 16:03:49.518054 UTC - Status: STARTING 2026-07-08 16:03:52.336352 UTC - Status: STARTING 2026-07-08 16:03:55.102673 UTC - Status: STARTING 2026-07-08 16:03:57.868914 UTC - Status: STARTING 2026-07-08 16:04:00.635279 UTC - Status: STARTING 2026-07-08 16:04:03.351148 UTC - Status: STARTING 2026-07-08 16:04:06.068042 UTC - Status: STARTING 2026-07-08 16:04:08.784316 UTC - Status: STARTING 2026-07-08 16:04:11.650948 UTC - Status: STARTING 2026-07-08 16:04:14.417133 UTC - Status: STARTING 2026-07-08 16:04:17.183315 UTC - Status: STARTING 2026-07-08 16:04:19.899410 UTC - Status: STARTING 2026-07-08 16:04:22.666026 UTC - Status: STARTING 2026-07-08 16:04:25.482318 UTC - Status: STARTING 2026-07-08 16:04:28.298767 UTC - Status: UP 2026-07-08 16:04:28.298844 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kx17djmef4s90w0rjv9wh8aa 2026-07-08 16:04:28.298901 UTC - Validate resources 2026-07-08 16:04:29.014859 UTC - The fields of the created resource were validated. 2026-07-08 16:04:29.014955 UTC - Check if resources are registered in experiment 2026-07-08 16:04:29.015122 UTC - Run: slices experiment list-resources --format json tst-89ab9c4e 2026-07-08 16:04:29.630428 UTC - Status (on expauth): UP 2026-07-08 16:04:29.630563 UTC - Testing extend expires_at (all resources in experiment) 2026-07-08 16:04:29.630708 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-89ab9c4e 2026-07-08 16:04:34.055265 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-89ab9c4e tst 2026-07-08 16:04:34.821506 UTC - Run: slices experiment list-resources --format json tst-89ab9c4e 2026-07-08 16:04:35.487103 UTC - expires_at (on expauth): 2026-07-08T19:04:00Z (correctly extended) 2026-07-08 16:04:35.487197 UTC - Testing extend expires_at (single resource in experiment) 2026-07-08 16:04:35.487337 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend tst --duration 4h --experiment tst-89ab9c4e 2026-07-08 16:04:39.812864 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-89ab9c4e tst 2026-07-08 16:04:40.579055 UTC - Run: slices experiment list-resources --format json tst-89ab9c4e 2026-07-08 16:04:41.244666 UTC - expires_at (on expauth): 2026-07-08T20:04:00Z (correctly extended) 2026-07-08 16:04:41.244809 UTC - Testing ssh login 2026-07-08 16:04:41.258605 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-89ab9c4e tst 2026-07-08 16:04:42.024259 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-89ab9c4e tst 2026-07-08 16:04:42.792199 UTC - Content of log file '/test_dir/step_CheckSSHpubkeyresource_command_1.txt': slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-89ab9c4e tst 2026-07-08 16:04:42.792281 UTC - Content of log file '/test_dir/bi_ssh_serverkey_STDERR.txt': No hostkeys in SSH info 2026-07-08 16:04:42.792306 UTC - Error in test step 'Check SSH pubkey (resource)': [Errno 2] No such file or directory: '/test_dir/bi_ssh_serverkey.txt' 2026-07-08 16:04:42.799159 UTC - Destroying tst-89ab9c4e tst ERROR:slices_monitor_test_runner.main:Test Failed with exception Traceback (most recent call last): File "/app/src/slices_monitor_test_runner/main.py", line 76, in run_test return _get_test_by_test_spec(steps, test_dir, test_spec).run() ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^^ File "/app/src/slices_monitor_test_runner/test_runners/slices_singlenode_login.py", line 1604, in run self._ssh_login(test_privkey_pem, ssh_agent_env_vars) ~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/app/src/slices_monitor_test_runner/test_runners/slices_singlenode_login.py", line 1185, in _ssh_login server_openssh_pubkeys = self._ssh_login_pubkey(proxy_key=False) File "/app/src/slices_monitor_test_runner/test_runners/slices_singlenode_login.py", line 1115, in _ssh_login_pubkey return server_openssh_pubkeys ^^^^^^^^^^^^^^^^^^^^^^ UnboundLocalError: cannot access local variable 'server_openssh_pubkeys' where it is not associated with a value 2026-07-08 16:04:42.799347 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-89ab9c4e tst