Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 4.32s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 621ms 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.05s + 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-17 05:01:35.236613 UTC - Installing Slices CLI (latest stable version). 2026-07-17 05:01:35.245120 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-17 05:01:42.914559 UTC - Slices CLI installed. 2026-07-17 05:01:42.915428 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-17 05:01:42.917854 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-17 05:01:42.918903 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-17 05:01:42.919029 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-17 05:01:42.919056 UTC - Slices CLI exe: 'slices' 2026-07-17 05:01:42.919076 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-17 05:01:42.919195 UTC - Run: slices --version 2026-07-17 05:01:47.593910 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-17 05:01:47.594221 UTC - Run: slices pubkey list --format text 2026-07-17 05:01:48.362068 UTC - Pubkey already registered 2026-07-17 05:01:48.362299 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-17 05:01:49.182012 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-17 05:01:49.182111 UTC - Check List Flavors 2026-07-17 05:01:49.182312 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-07-17 05:01:51.322248 UTC - Check List DiskImages 2026-07-17 05:01:51.322466 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-07-17 05:01:52.969287 UTC - Requesting resources 2026-07-17 05:01:52.973499 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian11-min --flavor taurus --duration 2h --experiment tst-bbae6e2f 2026-07-17 05:01:57.658053 UTC - Resource ID: r_fr-lyon1-bi-baremetal1_01kxq77ss2frrtnk0z5t04sssn 2026-07-17 05:01:57.658226 UTC - Waiting until resource ready 2026-07-17 05:01:59.658641 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-bbae6e2f tst 2026-07-17 05:02:00.581775 UTC - Status: IMAGING 2026-07-17 05:02:03.397825 UTC - Status: STARTING 2026-07-17 05:02:06.164250 UTC - Status: STARTING 2026-07-17 05:02:08.880495 UTC - Status: STARTING 2026-07-17 05:02:11.596371 UTC - Status: STARTING 2026-07-17 05:02:14.362590 UTC - Status: STARTING 2026-07-17 05:02:17.078419 UTC - Status: STARTING 2026-07-17 05:02:19.795472 UTC - Status: STARTING 2026-07-17 05:02:22.511460 UTC - Status: STARTING 2026-07-17 05:02:25.277501 UTC - Status: STARTING 2026-07-17 05:02:27.993378 UTC - Status: STARTING 2026-07-17 05:02:30.759487 UTC - Status: STARTING 2026-07-17 05:02:33.475563 UTC - Status: STARTING 2026-07-17 05:02:36.241869 UTC - Status: STARTING 2026-07-17 05:02:39.007932 UTC - Status: STARTING 2026-07-17 05:02:41.723999 UTC - Status: STARTING 2026-07-17 05:02:44.490087 UTC - Status: STARTING 2026-07-17 05:02:47.256475 UTC - Status: STARTING 2026-07-17 05:02:49.972299 UTC - Status: STARTING 2026-07-17 05:02:52.738540 UTC - Status: STARTING 2026-07-17 05:02:55.454423 UTC - Status: STARTING 2026-07-17 05:02:58.170317 UTC - Status: STARTING 2026-07-17 05:03:00.886378 UTC - Status: STARTING 2026-07-17 05:03:03.652624 UTC - Status: STARTING 2026-07-17 05:03:06.368618 UTC - Status: STARTING 2026-07-17 05:03:09.084649 UTC - Status: STARTING 2026-07-17 05:03:11.800527 UTC - Status: STARTING 2026-07-17 05:03:14.516571 UTC - Status: STARTING 2026-07-17 05:03:17.232565 UTC - Status: STARTING 2026-07-17 05:03:19.998702 UTC - Status: STARTING 2026-07-17 05:03:22.715254 UTC - Status: STARTING 2026-07-17 05:03:25.431265 UTC - Status: STARTING 2026-07-17 05:03:28.147180 UTC - Status: STARTING 2026-07-17 05:03:30.863161 UTC - Status: STARTING 2026-07-17 05:03:33.579376 UTC - Status: STARTING 2026-07-17 05:03:36.295394 UTC - Status: STARTING 2026-07-17 05:03:39.011625 UTC - Status: STARTING 2026-07-17 05:03:41.727668 UTC - Status: STARTING 2026-07-17 05:03:44.443658 UTC - Status: STARTING 2026-07-17 05:03:47.159821 UTC - Status: STARTING 2026-07-17 05:03:49.926193 UTC - Status: STARTING 2026-07-17 05:03:52.642195 UTC - Status: STARTING 2026-07-17 05:03:55.358139 UTC - Status: STARTING 2026-07-17 05:03:58.074096 UTC - Status: STARTING 2026-07-17 05:04:00.840249 UTC - Status: STARTING 2026-07-17 05:04:03.556209 UTC - Status: STARTING 2026-07-17 05:04:06.322333 UTC - Status: STARTING 2026-07-17 05:04:09.038247 UTC - Status: STARTING 2026-07-17 05:04:11.754150 UTC - Status: STARTING 2026-07-17 05:04:14.470155 UTC - Status: STARTING 2026-07-17 05:04:17.186160 UTC - Status: STARTING 2026-07-17 05:04:19.901920 UTC - Status: STARTING 2026-07-17 05:04:22.618540 UTC - Status: STARTING 2026-07-17 05:04:25.334417 UTC - Status: STARTING 2026-07-17 05:04:28.050516 UTC - Status: STARTING 2026-07-17 05:04:30.816550 UTC - Status: STARTING 2026-07-17 05:04:33.583049 UTC - Status: STARTING 2026-07-17 05:04:36.349367 UTC - Status: STARTING 2026-07-17 05:04:39.065348 UTC - Status: STARTING 2026-07-17 05:04:41.781433 UTC - Status: STARTING 2026-07-17 05:04:44.497276 UTC - Status: STARTING 2026-07-17 05:04:47.263476 UTC - Status: STARTING 2026-07-17 05:04:49.979471 UTC - Status: UP 2026-07-17 05:04:49.979572 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kxq77r73f4rb3s1st2myyw2r 2026-07-17 05:04:49.979613 UTC - Validate resources 2026-07-17 05:04:50.695720 UTC - The fields of the created resource were validated. 2026-07-17 05:04:50.695839 UTC - Check if resources are registered in experiment 2026-07-17 05:04:50.696037 UTC - Run: slices experiment list-resources --format json tst-bbae6e2f 2026-07-17 05:04:51.412250 UTC - Status (on expauth): UP 2026-07-17 05:04:51.412453 UTC - Testing extend expires_at (all resources in experiment) 2026-07-17 05:04:51.412603 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-bbae6e2f 2026-07-17 05:04:56.489081 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-bbae6e2f tst 2026-07-17 05:04:57.254881 UTC - Run: slices experiment list-resources --format json tst-bbae6e2f 2026-07-17 05:04:57.870091 UTC - expires_at (on expauth): 2026-07-17T08:04:00Z (correctly extended) 2026-07-17 05:04:57.870196 UTC - Testing extend expires_at (single resource in experiment) 2026-07-17 05:04:57.870350 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend tst --duration 4h --experiment tst-bbae6e2f 2026-07-17 05:05:03.598576 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-bbae6e2f tst 2026-07-17 05:05:04.314194 UTC - Run: slices experiment list-resources --format json tst-bbae6e2f 2026-07-17 05:05:04.979591 UTC - expires_at (on expauth): 2026-07-17T09:04:00Z (correctly extended) 2026-07-17 05:05:04.979713 UTC - Testing ssh login 2026-07-17 05:05:04.994094 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-bbae6e2f tst 2026-07-17 05:05:05.709803 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-bbae6e2f tst 2026-07-17 05:05:06.427729 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-bbae6e2f tst 2026-07-17 05:05:06.427806 UTC - Content of log file '/test_dir/bi_ssh_serverkey_STDERR.txt': No hostkeys in SSH info 2026-07-17 05:05:06.427830 UTC - Error in test step 'Check SSH pubkey (resource)': [Errno 2] No such file or directory: '/test_dir/bi_ssh_serverkey.txt' 2026-07-17 05:05:06.434386 UTC - Destroying tst-bbae6e2f 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-17 05:05:06.434571 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-bbae6e2f tst