Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 5.26s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 441ms 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 543ms + 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-14 14:01:28.246019 UTC - Installing Slices CLI (latest stable version). 2026-07-14 14:01:28.246271 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-14 14:01:36.577968 UTC - Slices CLI installed. 2026-07-14 14:01:36.578594 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-14 14:01:36.581882 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-14 14:01:36.582937 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-14 14:01:36.583073 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-14 14:01:36.583101 UTC - Slices CLI exe: 'slices' 2026-07-14 14:01:36.583118 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-14 14:01:36.583236 UTC - Run: slices --version 2026-07-14 14:01:41.022897 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-14 14:01:41.023183 UTC - Run: slices pubkey list --format text 2026-07-14 14:01:42.443675 UTC - Pubkey already registered 2026-07-14 14:01:42.444005 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-14 14:01:43.363610 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-14 14:01:43.363743 UTC - Check List Flavors 2026-07-14 14:01:43.363894 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-07-14 14:01:45.341275 UTC - Check List DiskImages 2026-07-14 14:01:45.341448 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-07-14 14:01:46.420996 UTC - Requesting resources 2026-07-14 14:01:46.421729 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian11-min --flavor taurus --duration 2h --experiment tst-d1e18260 2026-07-14 14:01:53.001913 UTC - Resource ID: r_fr-lyon1-bi-baremetal1_01kxgey8jpev98jw9h0vy6beer 2026-07-14 14:01:53.002077 UTC - Waiting until resource ready 2026-07-14 14:01:55.002524 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-d1e18260 tst 2026-07-14 14:01:56.571448 UTC - Status: IMAGING 2026-07-14 14:01:59.442416 UTC - Status: IMAGING 2026-07-14 14:02:02.208513 UTC - Status: IMAGING 2026-07-14 14:02:05.002530 UTC - Status: STARTING 2026-07-14 14:02:07.768544 UTC - Status: STARTING 2026-07-14 14:02:10.484543 UTC - Status: STARTING 2026-07-14 14:02:13.250869 UTC - Status: STARTING 2026-07-14 14:02:15.967213 UTC - Status: STARTING 2026-07-14 14:02:18.733553 UTC - Status: STARTING 2026-07-14 14:02:21.499493 UTC - Status: STARTING 2026-07-14 14:02:24.265861 UTC - Status: STARTING 2026-07-14 14:02:27.032020 UTC - Status: STARTING 2026-07-14 14:02:29.748115 UTC - Status: STARTING 2026-07-14 14:02:32.464065 UTC - Status: STARTING 2026-07-14 14:02:35.230247 UTC - Status: STARTING 2026-07-14 14:02:37.996592 UTC - Status: STARTING 2026-07-14 14:02:40.812977 UTC - Status: STARTING 2026-07-14 14:02:43.581374 UTC - Status: STARTING 2026-07-14 14:02:46.347535 UTC - Status: STARTING 2026-07-14 14:02:49.063427 UTC - Status: STARTING 2026-07-14 14:02:51.929863 UTC - Status: STARTING 2026-07-14 14:02:54.695878 UTC - Status: STARTING 2026-07-14 14:02:57.411757 UTC - Status: STARTING 2026-07-14 14:03:00.127785 UTC - Status: STARTING 2026-07-14 14:03:02.893982 UTC - Status: STARTING 2026-07-14 14:03:05.660658 UTC - Status: STARTING 2026-07-14 14:03:08.376576 UTC - Status: STARTING 2026-07-14 14:03:11.092692 UTC - Status: STARTING 2026-07-14 14:03:13.860699 UTC - Status: STARTING 2026-07-14 14:03:16.576884 UTC - Status: STARTING 2026-07-14 14:03:19.293356 UTC - Status: STARTING 2026-07-14 14:03:22.059688 UTC - Status: STARTING 2026-07-14 14:03:24.775709 UTC - Status: STARTING 2026-07-14 14:03:27.542193 UTC - Status: STARTING 2026-07-14 14:03:30.309184 UTC - Status: STARTING 2026-07-14 14:03:33.025135 UTC - Status: STARTING 2026-07-14 14:03:35.791250 UTC - Status: STARTING 2026-07-14 14:03:38.507322 UTC - Status: STARTING 2026-07-14 14:03:41.323944 UTC - Status: STARTING 2026-07-14 14:03:44.091752 UTC - Status: STARTING 2026-07-14 14:03:46.807732 UTC - Status: STARTING 2026-07-14 14:03:49.573843 UTC - Status: STARTING 2026-07-14 14:03:52.290295 UTC - Status: STARTING 2026-07-14 14:03:55.006313 UTC - Status: STARTING 2026-07-14 14:03:57.722264 UTC - Status: STARTING 2026-07-14 14:04:00.538589 UTC - Status: STARTING 2026-07-14 14:04:03.254596 UTC - Status: STARTING 2026-07-14 14:04:05.970363 UTC - Status: STARTING 2026-07-14 14:04:08.736678 UTC - Status: STARTING 2026-07-14 14:04:11.452550 UTC - Status: STARTING 2026-07-14 14:04:14.168502 UTC - Status: STARTING 2026-07-14 14:04:16.884531 UTC - Status: STARTING 2026-07-14 14:04:19.650744 UTC - Status: STARTING 2026-07-14 14:04:22.366779 UTC - Status: STARTING 2026-07-14 14:04:25.132869 UTC - Status: STARTING 2026-07-14 14:04:27.848804 UTC - Status: STARTING 2026-07-14 14:04:30.564856 UTC - Status: STARTING 2026-07-14 14:04:33.280802 UTC - Status: STARTING 2026-07-14 14:04:35.996699 UTC - Status: STARTING 2026-07-14 14:04:38.712731 UTC - Status: STARTING 2026-07-14 14:04:41.428588 UTC - Status: STARTING 2026-07-14 14:04:44.144519 UTC - Status: UP 2026-07-14 14:04:44.144622 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kxgey5pvf5yt9aervkwzajbk 2026-07-14 14:04:44.144664 UTC - Validate resources 2026-07-14 14:04:44.860530 UTC - The fields of the created resource were validated. 2026-07-14 14:04:44.860649 UTC - Check if resources are registered in experiment 2026-07-14 14:04:44.860846 UTC - Run: slices experiment list-resources --format json tst-d1e18260 2026-07-14 14:04:45.526272 UTC - Status (on expauth): UP 2026-07-14 14:04:45.526411 UTC - Testing extend expires_at (all resources in experiment) 2026-07-14 14:04:45.526534 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-d1e18260 2026-07-14 14:04:54.060762 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-d1e18260 tst 2026-07-14 14:04:54.876592 UTC - Run: slices experiment list-resources --format json tst-d1e18260 2026-07-14 14:04:55.542183 UTC - expires_at (on expauth): 2026-07-14T17:04:00Z (correctly extended) 2026-07-14 14:04:55.542288 UTC - Testing extend expires_at (single resource in experiment) 2026-07-14 14:04:55.542425 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend tst --duration 4h --experiment tst-d1e18260 2026-07-14 14:05:00.969639 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-d1e18260 tst 2026-07-14 14:05:01.735736 UTC - Run: slices experiment list-resources --format json tst-d1e18260 2026-07-14 14:05:02.401183 UTC - expires_at (on expauth): 2026-07-14T18:04:00Z (correctly extended) 2026-07-14 14:05:02.401326 UTC - Testing ssh login 2026-07-14 14:05:02.414174 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-d1e18260 tst 2026-07-14 14:05:03.180265 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-d1e18260 tst 2026-07-14 14:05:03.948462 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-d1e18260 tst 2026-07-14 14:05:03.948539 UTC - Content of log file '/test_dir/bi_ssh_serverkey_STDERR.txt': No hostkeys in SSH info 2026-07-14 14:05:03.948563 UTC - Error in test step 'Check SSH pubkey (resource)': [Errno 2] No such file or directory: '/test_dir/bi_ssh_serverkey.txt' 2026-07-14 14:05:03.955284 UTC - Destroying tst-d1e18260 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-14 14:05:03.955482 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-d1e18260 tst