Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 5.09s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 324ms 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 1.68s + annotated-types==0.7.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-22 14:02:04.607171 UTC - Installing Slices CLI (latest stable version). 2026-07-22 14:02:04.607403 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-22 14:02:14.213526 UTC - Slices CLI installed. 2026-07-22 14:02:14.213753 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-22 14:02:14.216622 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-22 14:02:14.217866 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-22 14:02:14.218008 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-22 14:02:14.218035 UTC - Slices CLI exe: 'slices' 2026-07-22 14:02:14.218052 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-22 14:02:14.218175 UTC - Run: slices --version 2026-07-22 14:02:17.686686 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-22 14:02:17.686997 UTC - Run: slices pubkey list --format text 2026-07-22 14:02:18.504194 UTC - Pubkey already registered 2026-07-22 14:02:18.504430 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-22 14:02:19.169944 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-22 14:02:19.170043 UTC - Check List Flavors 2026-07-22 14:02:19.170192 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-07-22 14:02:20.388245 UTC - Check List DiskImages 2026-07-22 14:02:20.388430 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-07-22 14:02:21.449731 UTC - Requesting resources 2026-07-22 14:02:21.450255 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian11-min --flavor taurus --duration 2h --experiment tst-70d38295 2026-07-22 14:02:24.409391 UTC - Resource ID: r_fr-lyon1-bi-baremetal1_01ky524zhyf61vzyhnp4269bnj 2026-07-22 14:02:24.409567 UTC - Waiting until resource ready 2026-07-22 14:02:26.409916 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-70d38295 tst 2026-07-22 14:02:27.326366 UTC - Status: IMAGING 2026-07-22 14:02:30.042466 UTC - Status: IMAGING 2026-07-22 14:02:32.809720 UTC - Status: STARTING 2026-07-22 14:02:35.577170 UTC - Status: STARTING 2026-07-22 14:02:38.344446 UTC - Status: STARTING 2026-07-22 14:02:41.060563 UTC - Status: STARTING 2026-07-22 14:02:43.776872 UTC - Status: STARTING 2026-07-22 14:02:46.543910 UTC - Status: STARTING 2026-07-22 14:02:49.311354 UTC - Status: STARTING 2026-07-22 14:02:52.027398 UTC - Status: STARTING 2026-07-22 14:02:54.743463 UTC - Status: STARTING 2026-07-22 14:02:57.509927 UTC - Status: STARTING 2026-07-22 14:03:00.376878 UTC - Status: STARTING 2026-07-22 14:03:03.092802 UTC - Status: STARTING 2026-07-22 14:03:05.808888 UTC - Status: STARTING 2026-07-22 14:03:08.575020 UTC - Status: STARTING 2026-07-22 14:03:11.342318 UTC - Status: STARTING 2026-07-22 14:03:14.058604 UTC - Status: STARTING 2026-07-22 14:03:16.774860 UTC - Status: STARTING 2026-07-22 14:03:19.542111 UTC - Status: STARTING 2026-07-22 14:03:22.359029 UTC - Status: STARTING 2026-07-22 14:03:25.075008 UTC - Status: STARTING 2026-07-22 14:03:27.790996 UTC - Status: STARTING 2026-07-22 14:03:30.557916 UTC - Status: STARTING 2026-07-22 14:03:33.325135 UTC - Status: STARTING 2026-07-22 14:03:36.041495 UTC - Status: STARTING 2026-07-22 14:03:38.808816 UTC - Status: STARTING 2026-07-22 14:03:41.575360 UTC - Status: STARTING 2026-07-22 14:03:44.342317 UTC - Status: STARTING 2026-07-22 14:03:47.108759 UTC - Status: STARTING 2026-07-22 14:03:49.825121 UTC - Status: STARTING 2026-07-22 14:03:52.592075 UTC - Status: STARTING 2026-07-22 14:03:55.358979 UTC - Status: STARTING 2026-07-22 14:03:58.075180 UTC - Status: STARTING 2026-07-22 14:04:00.841847 UTC - Status: STARTING 2026-07-22 14:04:03.558515 UTC - Status: STARTING 2026-07-22 14:04:06.375493 UTC - Status: STARTING 2026-07-22 14:04:09.292273 UTC - Status: STARTING 2026-07-22 14:04:12.010119 UTC - Status: STARTING 2026-07-22 14:04:14.777368 UTC - Status: STARTING 2026-07-22 14:04:17.544985 UTC - Status: STARTING 2026-07-22 14:04:20.313587 UTC - Status: STARTING 2026-07-22 14:04:23.080532 UTC - Status: STARTING 2026-07-22 14:04:25.846750 UTC - Status: STARTING 2026-07-22 14:04:28.663966 UTC - Status: STARTING 2026-07-22 14:04:31.480998 UTC - Status: STARTING 2026-07-22 14:04:34.197793 UTC - Status: STARTING 2026-07-22 14:04:37.165300 UTC - Status: STARTING 2026-07-22 14:04:39.932089 UTC - Status: STARTING 2026-07-22 14:04:42.749513 UTC - Status: STARTING 2026-07-22 14:04:45.465551 UTC - Status: STARTING 2026-07-22 14:04:48.181575 UTC - Status: STARTING 2026-07-22 14:04:50.947898 UTC - Status: STARTING 2026-07-22 14:04:53.715463 UTC - Status: STARTING 2026-07-22 14:04:56.532919 UTC - Status: STARTING 2026-07-22 14:04:59.248609 UTC - Status: STARTING 2026-07-22 14:05:01.964844 UTC - Status: STARTING 2026-07-22 14:05:04.681773 UTC - Status: STARTING 2026-07-22 14:05:07.398121 UTC - Status: STARTING 2026-07-22 14:05:10.114186 UTC - Status: UP 2026-07-22 14:05:10.114266 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01ky524yske6htn26tyzwhvzej 2026-07-22 14:05:10.114308 UTC - Validate resources 2026-07-22 14:05:10.830372 UTC - The fields of the created resource were validated. 2026-07-22 14:05:10.830508 UTC - Check if resources are registered in experiment 2026-07-22 14:05:10.830709 UTC - Run: slices experiment list-resources --format json tst-70d38295 2026-07-22 14:05:11.446520 UTC - Status (on expauth): UP 2026-07-22 14:05:11.446708 UTC - Testing extend expires_at (all resources in experiment) 2026-07-22 14:05:11.446875 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-70d38295 2026-07-22 14:05:15.722231 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-70d38295 tst 2026-07-22 14:05:16.438049 UTC - Run: slices experiment list-resources --format json tst-70d38295 2026-07-22 14:05:17.103408 UTC - expires_at (on expauth): 2026-07-22T17:05:00Z (correctly extended) 2026-07-22 14:05:17.103518 UTC - Testing extend expires_at (single resource in experiment) 2026-07-22 14:05:17.103669 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend tst --duration 4h --experiment tst-70d38295 2026-07-22 14:05:21.328408 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-70d38295 tst 2026-07-22 14:05:22.157197 UTC - Run: slices experiment list-resources --format json tst-70d38295 2026-07-22 14:05:22.937059 UTC - expires_at (on expauth): 2026-07-22T18:05:00Z (correctly extended) 2026-07-22 14:05:22.937187 UTC - Testing ssh login 2026-07-22 14:05:22.953847 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-70d38295 tst 2026-07-22 14:05:23.834803 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-70d38295 tst 2026-07-22 14:05:24.855769 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-70d38295 tst 2026-07-22 14:05:24.855858 UTC - Content of log file '/test_dir/bi_ssh_serverkey_STDERR.txt': No hostkeys in SSH info 2026-07-22 14:05:24.855885 UTC - Error in test step 'Check SSH pubkey (resource)': [Errno 2] No such file or directory: '/test_dir/bi_ssh_serverkey.txt' 2026-07-22 14:05:24.875225 UTC - Destroying tst-70d38295 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-22 14:05:24.875418 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-70d38295 tst