Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 5.13s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 399ms 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 916ms + 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-18 14:01:52.430495 UTC - Installing Slices CLI (latest stable version). 2026-07-18 14:01:52.430903 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-18 14:01:59.096227 UTC - Slices CLI installed. 2026-07-18 14:01:59.097360 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-18 14:01:59.100672 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-18 14:01:59.101732 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-18 14:01:59.101870 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-18 14:01:59.101899 UTC - Slices CLI exe: 'slices' 2026-07-18 14:01:59.101915 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-18 14:01:59.102030 UTC - Run: slices --version 2026-07-18 14:02:02.629055 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-18 14:02:02.629480 UTC - Run: slices pubkey list --format text 2026-07-18 14:02:04.231080 UTC - Pubkey already registered 2026-07-18 14:02:04.231530 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-18 14:02:05.817530 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-18 14:02:05.817635 UTC - Check List Flavors 2026-07-18 14:02:05.817789 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-07-18 14:02:07.602649 UTC - Check List DiskImages 2026-07-18 14:02:07.602861 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-07-18 14:02:08.319184 UTC - Requesting resources 2026-07-18 14:02:08.319739 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian11-min --flavor taurus --duration 2h --experiment tst-20f3d486 2026-07-18 14:02:12.271493 UTC - Resource ID: r_fr-lyon1-bi-baremetal1_01kxtrhqnwekrvk173atjxtb4w 2026-07-18 14:02:12.272179 UTC - Waiting until resource ready 2026-07-18 14:02:14.272566 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-20f3d486 tst 2026-07-18 14:02:15.898773 UTC - Status: IMAGING 2026-07-18 14:02:18.743307 UTC - Status: STARTING 2026-07-18 14:02:21.885209 UTC - Status: STARTING 2026-07-18 14:02:24.959362 UTC - Status: STARTING 2026-07-18 14:02:27.955842 UTC - Status: STARTING 2026-07-18 14:02:30.872612 UTC - Status: STARTING 2026-07-18 14:02:33.998307 UTC - Status: STARTING 2026-07-18 14:02:36.764172 UTC - Status: STARTING 2026-07-18 14:02:39.530287 UTC - Status: STARTING 2026-07-18 14:02:42.246188 UTC - Status: STARTING 2026-07-18 14:02:44.962285 UTC - Status: STARTING 2026-07-18 14:02:47.728464 UTC - Status: STARTING 2026-07-18 14:02:50.444487 UTC - Status: STARTING 2026-07-18 14:02:53.161081 UTC - Status: STARTING 2026-07-18 14:02:55.878048 UTC - Status: STARTING 2026-07-18 14:02:58.644082 UTC - Status: STARTING 2026-07-18 14:03:01.360027 UTC - Status: STARTING 2026-07-18 14:03:04.076060 UTC - Status: STARTING 2026-07-18 14:03:06.842272 UTC - Status: STARTING 2026-07-18 14:03:09.558264 UTC - Status: STARTING 2026-07-18 14:03:12.274585 UTC - Status: STARTING 2026-07-18 14:03:15.040874 UTC - Status: STARTING 2026-07-18 14:03:17.857713 UTC - Status: STARTING 2026-07-18 14:03:20.574128 UTC - Status: STARTING 2026-07-18 14:03:23.290051 UTC - Status: STARTING 2026-07-18 14:03:26.005959 UTC - Status: STARTING 2026-07-18 14:03:28.721845 UTC - Status: STARTING 2026-07-18 14:03:31.437713 UTC - Status: STARTING 2026-07-18 14:03:34.203893 UTC - Status: STARTING 2026-07-18 14:03:36.970495 UTC - Status: STARTING 2026-07-18 14:03:39.687111 UTC - Status: STARTING 2026-07-18 14:03:42.453690 UTC - Status: STARTING 2026-07-18 14:03:45.169683 UTC - Status: STARTING 2026-07-18 14:03:47.935757 UTC - Status: STARTING 2026-07-18 14:03:50.751991 UTC - Status: STARTING 2026-07-18 14:03:53.518583 UTC - Status: STARTING 2026-07-18 14:03:56.234442 UTC - Status: STARTING 2026-07-18 14:03:59.000553 UTC - Status: STARTING 2026-07-18 14:04:01.716654 UTC - Status: STARTING 2026-07-18 14:04:04.433196 UTC - Status: STARTING 2026-07-18 14:04:07.299740 UTC - Status: STARTING 2026-07-18 14:04:10.015859 UTC - Status: STARTING 2026-07-18 14:04:12.731716 UTC - Status: STARTING 2026-07-18 14:04:15.549499 UTC - Status: STARTING 2026-07-18 14:04:18.315828 UTC - Status: STARTING 2026-07-18 14:04:21.082480 UTC - Status: STARTING 2026-07-18 14:04:23.798996 UTC - Status: STARTING 2026-07-18 14:04:26.565242 UTC - Status: STARTING 2026-07-18 14:04:29.281166 UTC - Status: STARTING 2026-07-18 14:04:31.996987 UTC - Status: STARTING 2026-07-18 14:04:34.712945 UTC - Status: STARTING 2026-07-18 14:04:37.479801 UTC - Status: STARTING 2026-07-18 14:04:40.195706 UTC - Status: STARTING 2026-07-18 14:04:42.911899 UTC - Status: STARTING 2026-07-18 14:04:45.678305 UTC - Status: STARTING 2026-07-18 14:04:48.494880 UTC - Status: STARTING 2026-07-18 14:04:51.210962 UTC - Status: STARTING 2026-07-18 14:04:53.976970 UTC - Status: STARTING 2026-07-18 14:04:56.693628 UTC - Status: STARTING 2026-07-18 14:04:59.409911 UTC - Status: STARTING 2026-07-18 14:05:02.125803 UTC - Status: STARTING 2026-07-18 14:05:04.841664 UTC - Status: UP 2026-07-18 14:05:04.841770 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kxtrhpdqe9r9pvbhym6db431 2026-07-18 14:05:04.841825 UTC - Validate resources 2026-07-18 14:05:05.559289 UTC - The fields of the created resource were validated. 2026-07-18 14:05:05.559434 UTC - Check if resources are registered in experiment 2026-07-18 14:05:05.559690 UTC - Run: slices experiment list-resources --format json tst-20f3d486 2026-07-18 14:05:06.175456 UTC - Status (on expauth): UP 2026-07-18 14:05:06.175647 UTC - Testing extend expires_at (all resources in experiment) 2026-07-18 14:05:06.175790 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-20f3d486 2026-07-18 14:05:11.453261 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-20f3d486 tst 2026-07-18 14:05:12.168964 UTC - Run: slices experiment list-resources --format json tst-20f3d486 2026-07-18 14:05:12.784665 UTC - expires_at (on expauth): 2026-07-18T17:05:00Z (correctly extended) 2026-07-18 14:05:12.784829 UTC - Testing extend expires_at (single resource in experiment) 2026-07-18 14:05:12.784999 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend tst --duration 4h --experiment tst-20f3d486 2026-07-18 14:05:18.112827 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-20f3d486 tst 2026-07-18 14:05:18.879036 UTC - Run: slices experiment list-resources --format json tst-20f3d486 2026-07-18 14:05:19.595043 UTC - expires_at (on expauth): 2026-07-18T18:05:00Z (correctly extended) 2026-07-18 14:05:19.595191 UTC - Testing ssh login 2026-07-18 14:05:19.611630 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-20f3d486 tst 2026-07-18 14:05:20.427694 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-20f3d486 tst 2026-07-18 14:05:21.296954 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-20f3d486 tst 2026-07-18 14:05:21.297057 UTC - Content of log file '/test_dir/bi_ssh_serverkey_STDERR.txt': No hostkeys in SSH info 2026-07-18 14:05:21.297093 UTC - Error in test step 'Check SSH pubkey (resource)': [Errno 2] No such file or directory: '/test_dir/bi_ssh_serverkey.txt' 2026-07-18 14:05:21.307222 UTC - Destroying tst-20f3d486 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-18 14:05:21.307495 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-20f3d486 tst