Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 4.69s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 221ms 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 748ms + annotated-types==0.7.0 + anyio==4.14.2 + 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.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-17 14:02:04.056152 UTC - Installing Slices CLI (latest stable version). 2026-07-17 14:02:04.056523 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-17 14:02:10.211485 UTC - Slices CLI installed. 2026-07-17 14:02:10.213447 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-17 14:02:10.217134 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-17 14:02:10.218080 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-17 14:02:10.218213 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-17 14:02:10.218240 UTC - Slices CLI exe: 'slices' 2026-07-17 14:02:10.218258 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-17 14:02:10.218368 UTC - Run: slices --version 2026-07-17 14:02:15.122596 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-17 14:02:15.122916 UTC - Run: slices pubkey list --format text 2026-07-17 14:02:17.547200 UTC - Pubkey already registered 2026-07-17 14:02:17.547433 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-17 14:02:18.212797 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-17 14:02:18.212890 UTC - Check List Flavors 2026-07-17 14:02:18.213029 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-07-17 14:02:19.709350 UTC - Check List DiskImages 2026-07-17 14:02:19.709545 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-07-17 14:02:20.582555 UTC - Requesting resources 2026-07-17 14:02:20.583547 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian11-min --flavor taurus --duration 2h --experiment tst-d5e63b93 2026-07-17 14:02:25.016243 UTC - Resource ID: r_fr-lyon1-bi-baremetal1_01kxr65d34fd9skyrzgdm5tyb1 2026-07-17 14:02:25.016410 UTC - Waiting until resource ready 2026-07-17 14:02:27.016737 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-d5e63b93 tst 2026-07-17 14:02:27.838648 UTC - Status: IMAGING 2026-07-17 14:02:30.814082 UTC - Status: STARTING 2026-07-17 14:02:34.291055 UTC - Status: STARTING 2026-07-17 14:02:37.112650 UTC - Status: STARTING 2026-07-17 14:02:40.487279 UTC - Status: STARTING 2026-07-17 14:02:43.606207 UTC - Status: STARTING 2026-07-17 14:02:46.322207 UTC - Status: STARTING 2026-07-17 14:02:49.138423 UTC - Status: STARTING 2026-07-17 14:02:51.854164 UTC - Status: STARTING 2026-07-17 14:02:54.620687 UTC - Status: STARTING 2026-07-17 14:02:57.336564 UTC - Status: STARTING 2026-07-17 14:03:00.105271 UTC - Status: STARTING 2026-07-17 14:03:02.871695 UTC - Status: STARTING 2026-07-17 14:03:05.588552 UTC - Status: STARTING 2026-07-17 14:03:08.354942 UTC - Status: STARTING 2026-07-17 14:03:11.070916 UTC - Status: STARTING 2026-07-17 14:03:13.786862 UTC - Status: STARTING 2026-07-17 14:03:16.552835 UTC - Status: STARTING 2026-07-17 14:03:19.268578 UTC - Status: STARTING 2026-07-17 14:03:21.984674 UTC - Status: STARTING 2026-07-17 14:03:24.700625 UTC - Status: STARTING 2026-07-17 14:03:27.416515 UTC - Status: STARTING 2026-07-17 14:03:30.186004 UTC - Status: STARTING 2026-07-17 14:03:32.952015 UTC - Status: STARTING 2026-07-17 14:03:35.667778 UTC - Status: STARTING 2026-07-17 14:03:38.383931 UTC - Status: STARTING 2026-07-17 14:03:41.099599 UTC - Status: STARTING 2026-07-17 14:03:43.816178 UTC - Status: STARTING 2026-07-17 14:03:46.532087 UTC - Status: STARTING 2026-07-17 14:03:49.247805 UTC - Status: STARTING 2026-07-17 14:03:51.963697 UTC - Status: STARTING 2026-07-17 14:03:54.680118 UTC - Status: STARTING 2026-07-17 14:03:57.446284 UTC - Status: STARTING 2026-07-17 14:04:00.162396 UTC - Status: STARTING 2026-07-17 14:04:03.029388 UTC - Status: STARTING 2026-07-17 14:04:05.747524 UTC - Status: STARTING 2026-07-17 14:04:08.513800 UTC - Status: STARTING 2026-07-17 14:04:11.229939 UTC - Status: STARTING 2026-07-17 14:04:13.946340 UTC - Status: STARTING 2026-07-17 14:04:16.712656 UTC - Status: STARTING 2026-07-17 14:04:19.479004 UTC - Status: STARTING 2026-07-17 14:04:22.195046 UTC - Status: STARTING 2026-07-17 14:04:24.911130 UTC - Status: STARTING 2026-07-17 14:04:27.627207 UTC - Status: STARTING 2026-07-17 14:04:30.343100 UTC - Status: STARTING 2026-07-17 14:04:33.060115 UTC - Status: STARTING 2026-07-17 14:04:35.775998 UTC - Status: STARTING 2026-07-17 14:04:38.491926 UTC - Status: STARTING 2026-07-17 14:04:41.259774 UTC - Status: STARTING 2026-07-17 14:04:44.076549 UTC - Status: STARTING 2026-07-17 14:04:46.792661 UTC - Status: STARTING 2026-07-17 14:04:49.508773 UTC - Status: STARTING 2026-07-17 14:04:52.225081 UTC - Status: STARTING 2026-07-17 14:04:54.941209 UTC - Status: STARTING 2026-07-17 14:04:57.657124 UTC - Status: STARTING 2026-07-17 14:05:00.373000 UTC - Status: STARTING 2026-07-17 14:05:03.088901 UTC - Status: STARTING 2026-07-17 14:05:05.905074 UTC - Status: STARTING 2026-07-17 14:05:08.671119 UTC - Status: STARTING 2026-07-17 14:05:11.387128 UTC - Status: STARTING 2026-07-17 14:05:14.102927 UTC - Status: UP 2026-07-17 14:05:14.103019 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kxr65bjheme8smvjync8b24e 2026-07-17 14:05:14.103061 UTC - Validate resources 2026-07-17 14:05:14.819723 UTC - The fields of the created resource were validated. 2026-07-17 14:05:14.819812 UTC - Check if resources are registered in experiment 2026-07-17 14:05:14.819976 UTC - Run: slices experiment list-resources --format json tst-d5e63b93 2026-07-17 14:05:15.535506 UTC - Status (on expauth): UP 2026-07-17 14:05:15.535638 UTC - Testing extend expires_at (all resources in experiment) 2026-07-17 14:05:15.535760 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-d5e63b93 2026-07-17 14:05:22.514962 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-d5e63b93 tst 2026-07-17 14:05:23.332696 UTC - Run: slices experiment list-resources --format json tst-d5e63b93 2026-07-17 14:05:23.948057 UTC - expires_at (on expauth): 2026-07-17T17:05:00Z (correctly extended) 2026-07-17 14:05:23.948183 UTC - Testing extend expires_at (single resource in experiment) 2026-07-17 14:05:23.948378 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend tst --duration 4h --experiment tst-d5e63b93 2026-07-17 14:05:32.139822 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-d5e63b93 tst 2026-07-17 14:05:33.666592 UTC - Run: slices experiment list-resources --format json tst-d5e63b93 2026-07-17 14:05:34.334762 UTC - expires_at (on expauth): 2026-07-17T18:05:00Z (correctly extended) 2026-07-17 14:05:34.335720 UTC - Testing ssh login 2026-07-17 14:05:34.350521 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-d5e63b93 tst 2026-07-17 14:05:35.166721 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-d5e63b93 tst 2026-07-17 14:05:36.277289 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-d5e63b93 tst 2026-07-17 14:05:36.277527 UTC - Content of log file '/test_dir/bi_ssh_serverkey_STDERR.txt': No hostkeys in SSH info 2026-07-17 14:05:36.277563 UTC - Error in test step 'Check SSH pubkey (resource)': [Errno 2] No such file or directory: '/test_dir/bi_ssh_serverkey.txt' 2026-07-17 14:05:36.285579 UTC - Destroying tst-d5e63b93 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-17 14:05:36.285744 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-d5e63b93 tst