Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 7.47s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 613ms 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 659ms + 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.0 + typing-extensions==4.16.0 + typing-inspection==0.4.2 Run Test: slices-bi-singlenode-login 2026-07-15 21:01:51.723634 UTC - Installing Slices CLI (latest stable version). 2026-07-15 21:01:51.725536 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-15 21:02:03.972396 UTC - Slices CLI installed. 2026-07-15 21:02:03.975532 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-15 21:02:03.978153 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-15 21:02:03.979182 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-15 21:02:03.979323 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-15 21:02:03.979353 UTC - Slices CLI exe: 'slices' 2026-07-15 21:02:03.979370 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-15 21:02:03.979489 UTC - Run: slices --version 2026-07-15 21:02:09.054263 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-15 21:02:09.055341 UTC - Run: slices pubkey list --format text 2026-07-15 21:02:10.998347 UTC - Pubkey already registered 2026-07-15 21:02:10.998598 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-15 21:02:12.122566 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-15 21:02:12.122674 UTC - Check List Flavors 2026-07-15 21:02:12.122848 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-07-15 21:02:13.828862 UTC - Check List DiskImages 2026-07-15 21:02:13.829351 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-07-15 21:02:14.803827 UTC - Requesting resources 2026-07-15 21:02:14.804682 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian11-min --flavor taurus --duration 2h --experiment tst-bd0c5ac0 2026-07-15 21:02:18.841134 UTC - Resource ID: r_fr-lyon1-bi-baremetal1_01kxksctdwe80ss31y0meea4gr 2026-07-15 21:02:18.841319 UTC - Waiting until resource ready 2026-07-15 21:02:20.841706 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-bd0c5ac0 tst 2026-07-15 21:02:21.707531 UTC - Status: IMAGING 2026-07-15 21:02:24.523579 UTC - Status: STARTING 2026-07-15 21:02:27.247546 UTC - Status: STARTING 2026-07-15 21:02:29.963380 UTC - Status: STARTING 2026-07-15 21:02:32.679431 UTC - Status: STARTING 2026-07-15 21:02:35.395938 UTC - Status: STARTING 2026-07-15 21:02:38.112369 UTC - Status: STARTING 2026-07-15 21:02:40.828321 UTC - Status: STARTING 2026-07-15 21:02:43.544244 UTC - Status: STARTING 2026-07-15 21:02:46.260481 UTC - Status: STARTING 2026-07-15 21:02:49.076804 UTC - Status: STARTING 2026-07-15 21:02:51.792814 UTC - Status: STARTING 2026-07-15 21:02:54.508503 UTC - Status: STARTING 2026-07-15 21:02:57.224561 UTC - Status: STARTING 2026-07-15 21:02:59.940499 UTC - Status: STARTING 2026-07-15 21:03:02.656470 UTC - Status: STARTING 2026-07-15 21:03:05.372234 UTC - Status: STARTING 2026-07-15 21:03:08.138631 UTC - Status: STARTING 2026-07-15 21:03:10.854758 UTC - Status: STARTING 2026-07-15 21:03:13.570870 UTC - Status: STARTING 2026-07-15 21:03:16.286937 UTC - Status: STARTING 2026-07-15 21:03:19.053577 UTC - Status: STARTING 2026-07-15 21:03:21.769425 UTC - Status: STARTING 2026-07-15 21:03:24.485361 UTC - Status: STARTING 2026-07-15 21:03:27.201257 UTC - Status: STARTING 2026-07-15 21:03:29.917113 UTC - Status: STARTING 2026-07-15 21:03:32.683647 UTC - Status: STARTING 2026-07-15 21:03:35.399757 UTC - Status: STARTING 2026-07-15 21:03:38.115672 UTC - Status: STARTING 2026-07-15 21:03:40.831615 UTC - Status: STARTING 2026-07-15 21:03:43.547657 UTC - Status: STARTING 2026-07-15 21:03:46.263595 UTC - Status: STARTING 2026-07-15 21:03:48.979706 UTC - Status: STARTING 2026-07-15 21:03:51.695764 UTC - Status: STARTING 2026-07-15 21:03:54.411852 UTC - Status: STARTING 2026-07-15 21:03:57.128048 UTC - Status: STARTING 2026-07-15 21:03:59.844040 UTC - Status: STARTING 2026-07-15 21:04:02.610214 UTC - Status: STARTING 2026-07-15 21:04:05.326624 UTC - Status: STARTING 2026-07-15 21:04:08.042778 UTC - Status: STARTING 2026-07-15 21:04:10.759314 UTC - Status: STARTING 2026-07-15 21:04:13.475417 UTC - Status: STARTING 2026-07-15 21:04:16.193584 UTC - Status: STARTING 2026-07-15 21:04:18.909881 UTC - Status: STARTING 2026-07-15 21:04:21.626257 UTC - Status: STARTING 2026-07-15 21:04:24.342458 UTC - Status: STARTING 2026-07-15 21:04:27.109110 UTC - Status: STARTING 2026-07-15 21:04:29.825080 UTC - Status: STARTING 2026-07-15 21:04:32.541029 UTC - Status: STARTING 2026-07-15 21:04:35.256863 UTC - Status: STARTING 2026-07-15 21:04:38.023378 UTC - Status: STARTING 2026-07-15 21:04:40.739672 UTC - Status: STARTING 2026-07-15 21:04:43.456058 UTC - Status: STARTING 2026-07-15 21:04:46.222415 UTC - Status: STARTING 2026-07-15 21:04:48.988924 UTC - Status: STARTING 2026-07-15 21:04:51.704935 UTC - Status: STARTING 2026-07-15 21:04:54.420710 UTC - Status: STARTING 2026-07-15 21:04:57.136841 UTC - Status: STARTING 2026-07-15 21:04:59.902974 UTC - Status: STARTING 2026-07-15 21:05:02.719560 UTC - Status: STARTING 2026-07-15 21:05:05.435443 UTC - Status: UP 2026-07-15 21:05:05.435527 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kxkscsbmfbta82cb7e73gtp6 2026-07-15 21:05:05.435576 UTC - Validate resources 2026-07-15 21:05:06.151383 UTC - The fields of the created resource were validated. 2026-07-15 21:05:06.151475 UTC - Check if resources are registered in experiment 2026-07-15 21:05:06.151629 UTC - Run: slices experiment list-resources --format json tst-bd0c5ac0 2026-07-15 21:05:06.766885 UTC - Status (on expauth): UP 2026-07-15 21:05:06.767024 UTC - Testing extend expires_at (all resources in experiment) 2026-07-15 21:05:06.767159 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-bd0c5ac0 2026-07-15 21:05:12.545351 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-bd0c5ac0 tst 2026-07-15 21:05:13.311058 UTC - Run: slices experiment list-resources --format json tst-bd0c5ac0 2026-07-15 21:05:13.926283 UTC - expires_at (on expauth): 2026-07-16T00:05:00Z (correctly extended) 2026-07-15 21:05:13.926390 UTC - Testing extend expires_at (single resource in experiment) 2026-07-15 21:05:13.926533 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend tst --duration 4h --experiment tst-bd0c5ac0 2026-07-15 21:05:19.152624 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-bd0c5ac0 tst 2026-07-15 21:05:19.868248 UTC - Run: slices experiment list-resources --format json tst-bd0c5ac0 2026-07-15 21:05:20.483564 UTC - expires_at (on expauth): 2026-07-16T01:05:00Z (correctly extended) 2026-07-15 21:05:20.483701 UTC - Testing ssh login 2026-07-15 21:05:20.496782 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-bd0c5ac0 tst 2026-07-15 21:05:21.212258 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-bd0c5ac0 tst 2026-07-15 21:05:21.929758 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-bd0c5ac0 tst 2026-07-15 21:05:21.929850 UTC - Content of log file '/test_dir/bi_ssh_serverkey_STDERR.txt': No hostkeys in SSH info 2026-07-15 21:05:21.929876 UTC - Error in test step 'Check SSH pubkey (resource)': [Errno 2] No such file or directory: '/test_dir/bi_ssh_serverkey.txt' 2026-07-15 21:05:21.936613 UTC - Destroying tst-bd0c5ac0 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-15 21:05:21.936806 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-bd0c5ac0 tst