Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 4.68s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 276ms 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 564ms + 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.3.post1 + 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-27 05:02:53.695334 UTC - Installing Slices CLI (latest stable version). 2026-07-27 05:02:53.695695 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-27 05:03:00.184377 UTC - Slices CLI installed. 2026-07-27 05:03:00.185516 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-27 05:03:00.188209 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-27 05:03:00.190132 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-27 05:03:00.190336 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-27 05:03:00.190371 UTC - Slices CLI exe: 'slices' 2026-07-27 05:03:00.190390 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-27 05:03:00.190538 UTC - Run: slices --version 2026-07-27 05:03:03.420524 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-27 05:03:03.420852 UTC - Run: slices pubkey list --format text 2026-07-27 05:03:04.501342 UTC - Pubkey already registered 2026-07-27 05:03:04.501580 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-27 05:03:05.473755 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-27 05:03:05.473860 UTC - Check List Flavors 2026-07-27 05:03:05.474004 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-07-27 05:03:06.780771 UTC - Check List DiskImages 2026-07-27 05:03:06.781737 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-07-27 05:03:08.029812 UTC - Requesting resources 2026-07-27 05:03:08.032123 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian11-min --flavor taurus --duration 2h --experiment tst-8dfcb63a 2026-07-27 05:03:09.966062 UTC - Resource ID: r_fr-lyon1-bi-baremetal1_01kygz96c0fzrv4qkp6xc62367 2026-07-27 05:03:09.966218 UTC - Waiting until resource ready 2026-07-27 05:03:11.966602 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-8dfcb63a tst 2026-07-27 05:03:12.732679 UTC - Status: IMAGING 2026-07-27 05:03:15.901284 UTC - Status: IMAGING 2026-07-27 05:03:18.867900 UTC - Status: IMAGING 2026-07-27 05:03:21.684564 UTC - Status: STARTING 2026-07-27 05:03:24.601667 UTC - Status: STARTING 2026-07-27 05:03:27.417851 UTC - Status: STARTING 2026-07-27 05:03:30.664060 UTC - Status: STARTING 2026-07-27 05:03:33.639663 UTC - Status: STARTING 2026-07-27 05:03:36.442954 UTC - Status: STARTING 2026-07-27 05:03:39.488696 UTC - Status: STARTING 2026-07-27 05:03:42.407019 UTC - Status: STARTING 2026-07-27 05:03:45.755119 UTC - Status: STARTING 2026-07-27 05:03:48.875087 UTC - Status: STARTING 2026-07-27 05:03:51.642322 UTC - Status: STARTING 2026-07-27 05:03:54.358004 UTC - Status: STARTING 2026-07-27 05:03:57.124045 UTC - Status: STARTING 2026-07-27 05:03:59.840412 UTC - Status: STARTING 2026-07-27 05:04:02.556825 UTC - Status: STARTING 2026-07-27 05:04:05.272984 UTC - Status: STARTING 2026-07-27 05:04:08.089516 UTC - Status: STARTING 2026-07-27 05:04:10.855836 UTC - Status: STARTING 2026-07-27 05:04:13.571761 UTC - Status: STARTING 2026-07-27 05:04:16.288069 UTC - Status: STARTING 2026-07-27 05:04:19.004022 UTC - Status: STARTING 2026-07-27 05:04:21.720131 UTC - Status: STARTING 2026-07-27 05:04:24.436231 UTC - Status: STARTING 2026-07-27 05:04:27.202413 UTC - Status: STARTING 2026-07-27 05:04:29.918234 UTC - Status: STARTING 2026-07-27 05:04:32.684258 UTC - Status: STARTING 2026-07-27 05:04:35.400223 UTC - Status: STARTING 2026-07-27 05:04:38.216834 UTC - Status: STARTING 2026-07-27 05:04:40.933348 UTC - Status: STARTING 2026-07-27 05:04:43.700099 UTC - Status: STARTING 2026-07-27 05:04:46.466617 UTC - Status: STARTING 2026-07-27 05:04:49.233148 UTC - Status: STARTING 2026-07-27 05:04:52.002106 UTC - Status: STARTING 2026-07-27 05:04:54.718345 UTC - Status: STARTING 2026-07-27 05:04:57.434801 UTC - Status: STARTING 2026-07-27 05:05:00.150959 UTC - Status: STARTING 2026-07-27 05:05:02.867140 UTC - Status: STARTING 2026-07-27 05:05:05.633335 UTC - Status: STARTING 2026-07-27 05:05:08.349022 UTC - Status: STARTING 2026-07-27 05:05:11.115368 UTC - Status: STARTING 2026-07-27 05:05:13.881874 UTC - Status: STARTING 2026-07-27 05:05:16.597884 UTC - Status: STARTING 2026-07-27 05:05:19.314312 UTC - Status: STARTING 2026-07-27 05:05:22.131165 UTC - Status: STARTING 2026-07-27 05:05:24.998202 UTC - Status: STARTING 2026-07-27 05:05:27.969798 UTC - Status: STARTING 2026-07-27 05:05:30.840443 UTC - Status: STARTING 2026-07-27 05:05:33.761552 UTC - Status: STARTING 2026-07-27 05:05:36.942488 UTC - Status: STARTING 2026-07-27 05:05:39.859298 UTC - Status: STARTING 2026-07-27 05:05:43.141279 UTC - Status: STARTING 2026-07-27 05:05:46.596947 UTC - Status: STARTING 2026-07-27 05:05:49.466546 UTC - Status: STARTING 2026-07-27 05:05:52.484668 UTC - Status: STARTING 2026-07-27 05:05:55.401290 UTC - Status: STARTING 2026-07-27 05:05:58.289942 UTC - Status: STARTING 2026-07-27 05:06:01.215961 UTC - Status: STARTING 2026-07-27 05:06:04.140788 UTC - Status: STARTING 2026-07-27 05:06:07.113526 UTC - Status: STARTING 2026-07-27 05:06:10.754199 UTC - Status: STARTING 2026-07-27 05:06:14.056267 UTC - Status: UP 2026-07-27 05:06:14.056567 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kygz95wneastsyzkv81chfbh 2026-07-27 05:06:14.056892 UTC - Validate resources 2026-07-27 05:06:15.322725 UTC - The fields of the created resource were validated. 2026-07-27 05:06:15.322969 UTC - Check if resources are registered in experiment 2026-07-27 05:06:15.323133 UTC - Run: slices experiment list-resources --format json tst-8dfcb63a 2026-07-27 05:06:16.089583 UTC - Status (on expauth): UP 2026-07-27 05:06:16.089769 UTC - Testing extend expires_at (all resources in experiment) 2026-07-27 05:06:16.089920 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-8dfcb63a 2026-07-27 05:06:20.084941 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-8dfcb63a tst 2026-07-27 05:06:21.220334 UTC - Run: slices experiment list-resources --format json tst-8dfcb63a 2026-07-27 05:06:22.177242 UTC - expires_at (on expauth): 2026-07-27T08:06:00Z (correctly extended) 2026-07-27 05:06:22.177516 UTC - Testing extend expires_at (single resource in experiment) 2026-07-27 05:06:22.177682 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend tst --duration 4h --experiment tst-8dfcb63a 2026-07-27 05:06:26.066812 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-8dfcb63a tst 2026-07-27 05:06:26.883098 UTC - Run: slices experiment list-resources --format json tst-8dfcb63a 2026-07-27 05:06:27.551416 UTC - expires_at (on expauth): 2026-07-27T09:06:00Z (correctly extended) 2026-07-27 05:06:27.551753 UTC - Testing ssh login 2026-07-27 05:06:27.656996 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-8dfcb63a tst 2026-07-27 05:06:28.624582 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-8dfcb63a tst 2026-07-27 05:06:29.649934 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-8dfcb63a tst 2026-07-27 05:06:29.650287 UTC - Content of log file '/test_dir/bi_ssh_serverkey_STDERR.txt': No hostkeys in SSH info 2026-07-27 05:06:29.650334 UTC - Error in test step 'Check SSH pubkey (resource)': [Errno 2] No such file or directory: '/test_dir/bi_ssh_serverkey.txt' 2026-07-27 05:06:29.660967 UTC - Destroying tst-8dfcb63a 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-27 05:06:29.661195 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-8dfcb63a tst