Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 6.98s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 496ms 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.59s + annotated-types==0.7.0 + anyio==4.14.1 + 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-12 14:01:27.078934 UTC - Installing Slices CLI (latest stable version). 2026-07-12 14:01:27.079219 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-12 14:01:38.212316 UTC - Slices CLI installed. 2026-07-12 14:01:38.216038 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-12 14:01:38.223279 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-12 14:01:38.226514 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-12 14:01:38.226773 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-12 14:01:38.226820 UTC - Slices CLI exe: 'slices' 2026-07-12 14:01:38.226838 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-12 14:01:38.228961 UTC - Run: slices --version 2026-07-12 14:01:45.018068 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-12 14:01:45.019511 UTC - Run: slices pubkey list --format text 2026-07-12 14:01:46.659059 UTC - Pubkey already registered 2026-07-12 14:01:46.659367 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-12 14:01:47.375040 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-12 14:01:47.375242 UTC - Check List Flavors 2026-07-12 14:01:47.375471 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-07-12 14:01:49.047595 UTC - Check List DiskImages 2026-07-12 14:01:49.047881 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-07-12 14:01:50.117338 UTC - Requesting resources 2026-07-12 14:01:50.117855 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian11-min --flavor taurus --duration 2h --experiment tst-745a2bb0 2026-07-12 14:01:54.447780 UTC - Resource ID: r_fr-lyon1-bi-baremetal1_01kxba4wbefr0spydjh2rncrp4 2026-07-12 14:01:54.447979 UTC - Waiting until resource ready 2026-07-12 14:01:56.448357 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-745a2bb0 tst 2026-07-12 14:01:57.164107 UTC - Status: IMAGING 2026-07-12 14:01:59.880287 UTC - Status: IMAGING 2026-07-12 14:02:02.697021 UTC - Status: STARTING 2026-07-12 14:02:05.413460 UTC - Status: STARTING 2026-07-12 14:02:08.129631 UTC - Status: STARTING 2026-07-12 14:02:10.946530 UTC - Status: STARTING 2026-07-12 14:02:13.713661 UTC - Status: STARTING 2026-07-12 14:02:16.480083 UTC - Status: STARTING 2026-07-12 14:02:19.196208 UTC - Status: STARTING 2026-07-12 14:02:21.962591 UTC - Status: STARTING 2026-07-12 14:02:24.678644 UTC - Status: STARTING 2026-07-12 14:02:27.445142 UTC - Status: STARTING 2026-07-12 14:02:30.211856 UTC - Status: STARTING 2026-07-12 14:02:33.030126 UTC - Status: STARTING 2026-07-12 14:02:35.746656 UTC - Status: STARTING 2026-07-12 14:02:38.513193 UTC - Status: STARTING 2026-07-12 14:02:41.229240 UTC - Status: STARTING 2026-07-12 14:02:43.945367 UTC - Status: STARTING 2026-07-12 14:02:46.661636 UTC - Status: STARTING 2026-07-12 14:02:49.427901 UTC - Status: STARTING 2026-07-12 14:02:52.144102 UTC - Status: STARTING 2026-07-12 14:02:54.960936 UTC - Status: STARTING 2026-07-12 14:02:57.727483 UTC - Status: STARTING 2026-07-12 14:03:00.493941 UTC - Status: STARTING 2026-07-12 14:03:03.209914 UTC - Status: STARTING 2026-07-12 14:03:05.926053 UTC - Status: STARTING 2026-07-12 14:03:08.642269 UTC - Status: STARTING 2026-07-12 14:03:11.408612 UTC - Status: STARTING 2026-07-12 14:03:14.175206 UTC - Status: STARTING 2026-07-12 14:03:16.942494 UTC - Status: STARTING 2026-07-12 14:03:19.709006 UTC - Status: STARTING 2026-07-12 14:03:22.475500 UTC - Status: STARTING 2026-07-12 14:03:25.191722 UTC - Status: STARTING 2026-07-12 14:03:27.958392 UTC - Status: STARTING 2026-07-12 14:03:30.724879 UTC - Status: STARTING 2026-07-12 14:03:33.440981 UTC - Status: STARTING 2026-07-12 14:03:36.156852 UTC - Status: STARTING 2026-07-12 14:03:38.872752 UTC - Status: STARTING 2026-07-12 14:03:41.588772 UTC - Status: STARTING 2026-07-12 14:03:44.305018 UTC - Status: STARTING 2026-07-12 14:03:47.021425 UTC - Status: STARTING 2026-07-12 14:03:49.737730 UTC - Status: STARTING 2026-07-12 14:03:52.453883 UTC - Status: STARTING 2026-07-12 14:03:55.170036 UTC - Status: STARTING 2026-07-12 14:03:57.936209 UTC - Status: STARTING 2026-07-12 14:04:00.652303 UTC - Status: STARTING 2026-07-12 14:04:03.418839 UTC - Status: STARTING 2026-07-12 14:04:06.135065 UTC - Status: STARTING 2026-07-12 14:04:08.901220 UTC - Status: STARTING 2026-07-12 14:04:11.617280 UTC - Status: STARTING 2026-07-12 14:04:14.335970 UTC - Status: STARTING 2026-07-12 14:04:17.052048 UTC - Status: STARTING 2026-07-12 14:04:19.818879 UTC - Status: STARTING 2026-07-12 14:04:22.585266 UTC - Status: STARTING 2026-07-12 14:04:25.351369 UTC - Status: STARTING 2026-07-12 14:04:28.067847 UTC - Status: STARTING 2026-07-12 14:04:30.834059 UTC - Status: STARTING 2026-07-12 14:04:33.549936 UTC - Status: STARTING 2026-07-12 14:04:36.265823 UTC - Status: STARTING 2026-07-12 14:04:38.982300 UTC - Status: STARTING 2026-07-12 14:04:41.698706 UTC - Status: STARTING 2026-07-12 14:04:44.465206 UTC - Status: UP 2026-07-12 14:04:44.465326 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kxba4tzpergaxsdysq0cvsc0 2026-07-12 14:04:44.465393 UTC - Validate resources 2026-07-12 14:04:45.231794 UTC - The fields of the created resource were validated. 2026-07-12 14:04:45.231895 UTC - Check if resources are registered in experiment 2026-07-12 14:04:45.232053 UTC - Run: slices experiment list-resources --format json tst-745a2bb0 2026-07-12 14:04:45.897563 UTC - Status (on expauth): UP 2026-07-12 14:04:45.897710 UTC - Testing extend expires_at (all resources in experiment) 2026-07-12 14:04:45.897862 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-745a2bb0 2026-07-12 14:04:50.874947 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-745a2bb0 tst 2026-07-12 14:04:51.591300 UTC - Run: slices experiment list-resources --format json tst-745a2bb0 2026-07-12 14:04:52.207069 UTC - expires_at (on expauth): 2026-07-12T17:04:00Z (correctly extended) 2026-07-12 14:04:52.207224 UTC - Testing extend expires_at (single resource in experiment) 2026-07-12 14:04:52.207386 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend tst --duration 4h --experiment tst-745a2bb0 2026-07-12 14:04:57.134064 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-745a2bb0 tst 2026-07-12 14:04:57.849837 UTC - Run: slices experiment list-resources --format json tst-745a2bb0 2026-07-12 14:04:58.465162 UTC - expires_at (on expauth): 2026-07-12T18:04:00Z (correctly extended) 2026-07-12 14:04:58.465285 UTC - Testing ssh login 2026-07-12 14:04:58.478099 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-745a2bb0 tst 2026-07-12 14:04:59.193761 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-745a2bb0 tst 2026-07-12 14:04:59.961972 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-745a2bb0 tst 2026-07-12 14:04:59.962056 UTC - Content of log file '/test_dir/bi_ssh_serverkey_STDERR.txt': No hostkeys in SSH info 2026-07-12 14:04:59.962081 UTC - Error in test step 'Check SSH pubkey (resource)': [Errno 2] No such file or directory: '/test_dir/bi_ssh_serverkey.txt' 2026-07-12 14:04:59.968907 UTC - Destroying tst-745a2bb0 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-12 14:04:59.969079 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-745a2bb0 tst