Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 4.50s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 595ms 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 968ms + annotated-types==0.8.0 + anyio==4.14.2 + authlib==1.7.2 + bcrypt==5.0.0 + certifi==2026.7.22 + 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.4 + 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.dev187+g005dd054e (from file:///app) + tomli-w==1.2.0 + tomlkit==0.15.1 + typing-extensions==4.16.0 + typing-inspection==0.4.2 Run Test: slices-bi-singlenode-login 2026-07-24 05:02:08.515055 UTC - Installing Slices CLI (latest stable version). 2026-07-24 05:02:08.515280 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-24 05:02:14.185788 UTC - Slices CLI installed. 2026-07-24 05:02:14.186946 UTC - PATH: {'PATH': '/app/.venv/bin:/usr/local/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/root/.local/bin/:/root/slices-cli-venv/bin', 'COLUMNS': '200'} 2026-07-24 05:02:14.192293 UTC - ls -a /root/ /scripts/ (error 2): None b"ls: cannot access '/scripts/': No such file or directory\n/root/:\n.\n..\n.cache\n.local\n.slices\nrun_test_runner.sh\nslices-cli-venv\n" 2026-07-24 05:02:14.193925 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-24 05:02:14.194155 UTC - OS release: PRETTY_NAME="Debian GNU/Linux 13 (trixie)" NAME="Debian GNU/Linux" VERSION_ID="13" VERSION="13 (trixie)" VERSION_CODENAME=trixie DEBIAN_VERSION_FULL=13.5 ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" 2026-07-24 05:02:14.194188 UTC - Slices CLI exe: 'slices' 2026-07-24 05:02:14.194207 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-24 05:02:14.194332 UTC - Run: slices --version 2026-07-24 05:02:18.884364 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-24 05:02:18.884784 UTC - Run: slices pubkey list --format text 2026-07-24 05:02:20.339448 UTC - Pubkey already registered 2026-07-24 05:02:20.340399 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-24 05:02:21.635548 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-24 05:02:21.635659 UTC - Check List Flavors 2026-07-24 05:02:21.635869 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-07-24 05:02:23.326615 UTC - Check List DiskImages 2026-07-24 05:02:23.326819 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-07-24 05:02:24.350362 UTC - Requesting resources 2026-07-24 05:02:24.359338 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian11-min --flavor taurus --duration 2h --experiment tst-081b6164 2026-07-24 05:02:28.686471 UTC - Resource ID: r_fr-lyon1-bi-baremetal1_01ky981s3ve81vxrptt08m49bp 2026-07-24 05:02:28.686681 UTC - Waiting until resource ready 2026-07-24 05:02:30.687418 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-081b6164 tst 2026-07-24 05:02:31.925052 UTC - Status: IMAGING 2026-07-24 05:02:35.005100 UTC - Status: STARTING 2026-07-24 05:02:37.822356 UTC - Status: STARTING 2026-07-24 05:02:40.638791 UTC - Status: STARTING 2026-07-24 05:02:43.486332 UTC - Status: STARTING 2026-07-24 05:02:46.252504 UTC - Status: STARTING 2026-07-24 05:02:49.769744 UTC - Status: STARTING 2026-07-24 05:02:52.595456 UTC - Status: STARTING 2026-07-24 05:02:55.361431 UTC - Status: STARTING 2026-07-24 05:02:58.127627 UTC - Status: STARTING 2026-07-24 05:03:00.894505 UTC - Status: STARTING 2026-07-24 05:03:03.772506 UTC - Status: STARTING 2026-07-24 05:03:06.589544 UTC - Status: STARTING 2026-07-24 05:03:09.406486 UTC - Status: STARTING 2026-07-24 05:03:12.122527 UTC - Status: STARTING 2026-07-24 05:03:14.888637 UTC - Status: STARTING 2026-07-24 05:03:17.654813 UTC - Status: STARTING 2026-07-24 05:03:20.421167 UTC - Status: STARTING 2026-07-24 05:03:23.137262 UTC - Status: STARTING 2026-07-24 05:03:25.853240 UTC - Status: STARTING 2026-07-24 05:03:28.619508 UTC - Status: STARTING 2026-07-24 05:03:31.385703 UTC - Status: STARTING 2026-07-24 05:03:34.101691 UTC - Status: STARTING 2026-07-24 05:03:36.867995 UTC - Status: STARTING 2026-07-24 05:03:39.634279 UTC - Status: STARTING 2026-07-24 05:03:42.350321 UTC - Status: STARTING 2026-07-24 05:03:45.116583 UTC - Status: STARTING 2026-07-24 05:03:47.832751 UTC - Status: STARTING 2026-07-24 05:03:50.548795 UTC - Status: STARTING 2026-07-24 05:03:53.264761 UTC - Status: STARTING 2026-07-24 05:03:55.980844 UTC - Status: STARTING 2026-07-24 05:03:58.747087 UTC - Status: STARTING 2026-07-24 05:04:01.513361 UTC - Status: STARTING 2026-07-24 05:04:04.229603 UTC - Status: STARTING 2026-07-24 05:04:06.995939 UTC - Status: STARTING 2026-07-24 05:04:09.712200 UTC - Status: STARTING 2026-07-24 05:04:12.528767 UTC - Status: STARTING 2026-07-24 05:04:15.295256 UTC - Status: STARTING 2026-07-24 05:04:18.061821 UTC - Status: STARTING 2026-07-24 05:04:20.777934 UTC - Status: STARTING 2026-07-24 05:04:23.544229 UTC - Status: STARTING 2026-07-24 05:04:26.260287 UTC - Status: STARTING 2026-07-24 05:04:29.026448 UTC - Status: STARTING 2026-07-24 05:04:31.742490 UTC - Status: STARTING 2026-07-24 05:04:34.458664 UTC - Status: STARTING 2026-07-24 05:04:37.225060 UTC - Status: STARTING 2026-07-24 05:04:39.941111 UTC - Status: STARTING 2026-07-24 05:04:42.707293 UTC - Status: STARTING 2026-07-24 05:04:45.423260 UTC - Status: STARTING 2026-07-24 05:04:48.189481 UTC - Status: STARTING 2026-07-24 05:04:50.955724 UTC - Status: STARTING 2026-07-24 05:04:53.672000 UTC - Status: STARTING 2026-07-24 05:04:56.388166 UTC - Status: STARTING 2026-07-24 05:04:59.154305 UTC - Status: STARTING 2026-07-24 05:05:01.971288 UTC - Status: STARTING 2026-07-24 05:05:04.738020 UTC - Status: STARTING 2026-07-24 05:05:07.504846 UTC - Status: STARTING 2026-07-24 05:05:10.221068 UTC - Status: STARTING 2026-07-24 05:05:12.937131 UTC - Status: STARTING 2026-07-24 05:05:15.653147 UTC - Status: UP 2026-07-24 05:05:15.653228 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01ky981qwdfaysy6f410cn3cqh 2026-07-24 05:05:15.653286 UTC - Validate resources 2026-07-24 05:05:16.420771 UTC - The fields of the created resource were validated. 2026-07-24 05:05:16.420867 UTC - Check if resources are registered in experiment 2026-07-24 05:05:16.421038 UTC - Run: slices experiment list-resources --format json tst-081b6164 2026-07-24 05:05:17.086616 UTC - Status (on expauth): UP 2026-07-24 05:05:17.086760 UTC - Testing extend expires_at (all resources in experiment) 2026-07-24 05:05:17.086892 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-081b6164 2026-07-24 05:05:22.364073 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-081b6164 tst 2026-07-24 05:05:23.080040 UTC - Run: slices experiment list-resources --format json tst-081b6164 2026-07-24 05:05:23.695550 UTC - expires_at (on expauth): 2026-07-24T08:05:00Z (correctly extended) 2026-07-24 05:05:23.695678 UTC - Testing extend expires_at (single resource in experiment) 2026-07-24 05:05:23.695840 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend tst --duration 4h --experiment tst-081b6164 2026-07-24 05:05:29.035602 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-081b6164 tst 2026-07-24 05:05:30.667141 UTC - Run: slices experiment list-resources --format json tst-081b6164 2026-07-24 05:05:31.912904 UTC - expires_at (on expauth): 2026-07-24T09:05:00Z (correctly extended) 2026-07-24 05:05:31.913425 UTC - Testing ssh login 2026-07-24 05:05:31.945150 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-081b6164 tst 2026-07-24 05:05:33.002061 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-081b6164 tst 2026-07-24 05:05:34.039137 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-081b6164 tst 2026-07-24 05:05:34.039217 UTC - Content of log file '/test_dir/bi_ssh_serverkey_STDERR.txt': No hostkeys in SSH info 2026-07-24 05:05:34.039241 UTC - Error in test step 'Check SSH pubkey (resource)': [Errno 2] No such file or directory: '/test_dir/bi_ssh_serverkey.txt' 2026-07-24 05:05:34.055370 UTC - Destroying tst-081b6164 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 1630, 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 1211, 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 1141, 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-24 05:05:34.055552 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-081b6164 tst