Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 4.31s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 528ms 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 912ms + 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-10 21:01:23.078286 UTC - Installing Slices CLI (latest stable version). 2026-07-10 21:01:23.078509 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-10 21:01:30.478183 UTC - Slices CLI installed. 2026-07-10 21:01:30.486415 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-10 21:01:30.489877 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-10 21:01:30.491941 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-10 21:01:30.492418 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-10 21:01:30.492497 UTC - Slices CLI exe: 'slices' 2026-07-10 21:01:30.492533 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-10 21:01:30.492809 UTC - Run: slices --version 2026-07-10 21:01:36.823131 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-10 21:01:36.823441 UTC - Run: slices pubkey list --format text 2026-07-10 21:01:38.051444 UTC - Pubkey already registered 2026-07-10 21:01:38.051687 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-10 21:01:38.773336 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-10 21:01:38.773429 UTC - Check List Flavors 2026-07-10 21:01:38.773577 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-07-10 21:01:40.600464 UTC - Check List DiskImages 2026-07-10 21:01:40.600662 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-07-10 21:01:41.467355 UTC - Requesting resources 2026-07-10 21:01:41.468079 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian11-min --flavor taurus --duration 2h --experiment tst-bdbd7cd5 2026-07-10 21:01:45.395962 UTC - Resource ID: r_fr-lyon1-bi-baremetal1_01kx6xc6v8fp8vq1agrje46stv 2026-07-10 21:01:45.396162 UTC - Waiting until resource ready 2026-07-10 21:01:47.396496 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-bdbd7cd5 tst 2026-07-10 21:01:48.362584 UTC - Status: IMAGING 2026-07-10 21:01:51.128444 UTC - Status: STARTING 2026-07-10 21:01:53.844333 UTC - Status: STARTING 2026-07-10 21:01:56.610554 UTC - Status: STARTING 2026-07-10 21:01:59.427077 UTC - Status: STARTING 2026-07-10 21:02:02.244070 UTC - Status: STARTING 2026-07-10 21:02:05.010175 UTC - Status: STARTING 2026-07-10 21:02:07.776604 UTC - Status: STARTING 2026-07-10 21:02:10.492692 UTC - Status: STARTING 2026-07-10 21:02:13.258767 UTC - Status: STARTING 2026-07-10 21:02:16.025475 UTC - Status: STARTING 2026-07-10 21:02:18.892438 UTC - Status: STARTING 2026-07-10 21:02:21.608555 UTC - Status: STARTING 2026-07-10 21:02:24.324623 UTC - Status: STARTING 2026-07-10 21:02:27.091003 UTC - Status: STARTING 2026-07-10 21:02:30.008273 UTC - Status: STARTING 2026-07-10 21:02:32.774597 UTC - Status: STARTING 2026-07-10 21:02:35.540692 UTC - Status: STARTING 2026-07-10 21:02:38.306949 UTC - Status: STARTING 2026-07-10 21:02:41.073120 UTC - Status: STARTING 2026-07-10 21:02:43.789071 UTC - Status: STARTING 2026-07-10 21:02:46.555560 UTC - Status: STARTING 2026-07-10 21:02:49.375314 UTC - Status: STARTING 2026-07-10 21:02:52.191797 UTC - Status: STARTING 2026-07-10 21:02:54.908193 UTC - Status: STARTING 2026-07-10 21:02:57.674934 UTC - Status: STARTING 2026-07-10 21:03:00.391057 UTC - Status: STARTING 2026-07-10 21:03:03.157369 UTC - Status: STARTING 2026-07-10 21:03:05.923458 UTC - Status: STARTING 2026-07-10 21:03:08.639485 UTC - Status: STARTING 2026-07-10 21:03:11.456119 UTC - Status: STARTING 2026-07-10 21:03:14.172558 UTC - Status: STARTING 2026-07-10 21:03:16.938867 UTC - Status: STARTING 2026-07-10 21:03:19.755427 UTC - Status: STARTING 2026-07-10 21:03:22.722299 UTC - Status: STARTING 2026-07-10 21:03:25.438261 UTC - Status: STARTING 2026-07-10 21:03:28.204590 UTC - Status: STARTING 2026-07-10 21:03:30.970626 UTC - Status: STARTING 2026-07-10 21:03:33.736971 UTC - Status: STARTING 2026-07-10 21:03:36.452794 UTC - Status: STARTING 2026-07-10 21:03:39.219753 UTC - Status: STARTING 2026-07-10 21:03:42.086366 UTC - Status: STARTING 2026-07-10 21:03:44.852610 UTC - Status: STARTING 2026-07-10 21:03:47.618800 UTC - Status: STARTING 2026-07-10 21:03:50.334872 UTC - Status: STARTING 2026-07-10 21:03:53.050698 UTC - Status: STARTING 2026-07-10 21:03:55.766634 UTC - Status: STARTING 2026-07-10 21:03:58.583559 UTC - Status: STARTING 2026-07-10 21:04:01.450390 UTC - Status: STARTING 2026-07-10 21:04:04.216887 UTC - Status: STARTING 2026-07-10 21:04:06.932900 UTC - Status: STARTING 2026-07-10 21:04:09.698970 UTC - Status: STARTING 2026-07-10 21:04:12.515485 UTC - Status: STARTING 2026-07-10 21:04:15.281767 UTC - Status: STARTING 2026-07-10 21:04:18.148314 UTC - Status: STARTING 2026-07-10 21:04:20.864349 UTC - Status: STARTING 2026-07-10 21:04:23.580234 UTC - Status: STARTING 2026-07-10 21:04:26.346767 UTC - Status: STARTING 2026-07-10 21:04:29.113695 UTC - Status: STARTING 2026-07-10 21:04:31.879946 UTC - Status: UP 2026-07-10 21:04:31.880060 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kx6xc5gwfza9fwbwm3vd1v6p 2026-07-10 21:04:31.880105 UTC - Validate resources 2026-07-10 21:04:32.595997 UTC - The fields of the created resource were validated. 2026-07-10 21:04:32.596092 UTC - Check if resources are registered in experiment 2026-07-10 21:04:32.596266 UTC - Run: slices experiment list-resources --format json tst-bdbd7cd5 2026-07-10 21:04:33.261618 UTC - Status (on expauth): UP 2026-07-10 21:04:33.261759 UTC - Testing extend expires_at (all resources in experiment) 2026-07-10 21:04:33.261888 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-bdbd7cd5 2026-07-10 21:04:45.507432 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-bdbd7cd5 tst 2026-07-10 21:04:46.273879 UTC - Run: slices experiment list-resources --format json tst-bdbd7cd5 2026-07-10 21:04:46.889302 UTC - expires_at (on expauth): 2026-07-11T00:04:00Z (correctly extended) 2026-07-10 21:04:46.889414 UTC - Testing extend expires_at (single resource in experiment) 2026-07-10 21:04:46.889564 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend tst --duration 4h --experiment tst-bdbd7cd5 2026-07-10 21:04:51.765028 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-bdbd7cd5 tst 2026-07-10 21:04:52.530894 UTC - Run: slices experiment list-resources --format json tst-bdbd7cd5 2026-07-10 21:04:53.146167 UTC - expires_at (on expauth): 2026-07-11T01:04:00Z (correctly extended) 2026-07-10 21:04:53.146289 UTC - Testing ssh login 2026-07-10 21:04:53.159246 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-bdbd7cd5 tst 2026-07-10 21:04:53.924906 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-bdbd7cd5 tst 2026-07-10 21:04:54.692427 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-bdbd7cd5 tst 2026-07-10 21:04:54.692507 UTC - Content of log file '/test_dir/bi_ssh_serverkey_STDERR.txt': No hostkeys in SSH info 2026-07-10 21:04:54.692532 UTC - Error in test step 'Check SSH pubkey (resource)': [Errno 2] No such file or directory: '/test_dir/bi_ssh_serverkey.txt' 2026-07-10 21:04:54.699042 UTC - Destroying tst-bdbd7cd5 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-10 21:04:54.699218 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-bdbd7cd5 tst