Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 6.50s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 662ms 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.72s + 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-11 21:01:27.390018 UTC - Installing Slices CLI (latest stable version). 2026-07-11 21:01:27.390304 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-11 21:01:35.860843 UTC - Slices CLI installed. 2026-07-11 21:01:35.861550 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-11 21:01:35.865193 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-11 21:01:35.866684 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-11 21:01:35.866825 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-11 21:01:35.866853 UTC - Slices CLI exe: 'slices' 2026-07-11 21:01:35.866870 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-11 21:01:35.867007 UTC - Run: slices --version 2026-07-11 21:01:40.973538 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-11 21:01:40.977248 UTC - Run: slices pubkey list --format text 2026-07-11 21:01:42.485977 UTC - Pubkey already registered 2026-07-11 21:01:42.486261 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-11 21:01:43.835169 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-11 21:01:43.835271 UTC - Check List Flavors 2026-07-11 21:01:43.835444 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-07-11 21:01:45.931142 UTC - Check List DiskImages 2026-07-11 21:01:45.931344 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-07-11 21:01:46.865265 UTC - Requesting resources 2026-07-11 21:01:46.865870 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian11-min --flavor taurus --duration 2h --experiment tst-4863d665 2026-07-11 21:01:50.594106 UTC - Resource ID: r_fr-lyon1-bi-baremetal1_01kx9fs2w8f7hshvdz7r1sjf7w 2026-07-11 21:01:50.594357 UTC - Waiting until resource ready 2026-07-11 21:01:52.600838 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-4863d665 tst 2026-07-11 21:01:53.523094 UTC - Status: IMAGING 2026-07-11 21:01:56.238949 UTC - Status: STARTING 2026-07-11 21:01:58.954845 UTC - Status: STARTING 2026-07-11 21:02:01.670786 UTC - Status: STARTING 2026-07-11 21:02:04.487436 UTC - Status: STARTING 2026-07-11 21:02:07.203430 UTC - Status: STARTING 2026-07-11 21:02:09.919780 UTC - Status: STARTING 2026-07-11 21:02:12.686006 UTC - Status: STARTING 2026-07-11 21:02:15.401801 UTC - Status: STARTING 2026-07-11 21:02:18.117784 UTC - Status: STARTING 2026-07-11 21:02:20.834008 UTC - Status: STARTING 2026-07-11 21:02:23.549867 UTC - Status: STARTING 2026-07-11 21:02:26.265731 UTC - Status: STARTING 2026-07-11 21:02:28.981583 UTC - Status: STARTING 2026-07-11 21:02:31.798214 UTC - Status: STARTING 2026-07-11 21:02:34.514235 UTC - Status: STARTING 2026-07-11 21:02:37.280833 UTC - Status: STARTING 2026-07-11 21:02:39.997467 UTC - Status: STARTING 2026-07-11 21:02:42.713341 UTC - Status: STARTING 2026-07-11 21:02:45.479842 UTC - Status: STARTING 2026-07-11 21:02:48.245782 UTC - Status: STARTING 2026-07-11 21:02:52.014686 UTC - Status: STARTING 2026-07-11 21:02:54.781048 UTC - Status: STARTING 2026-07-11 21:02:57.597514 UTC - Status: STARTING 2026-07-11 21:03:00.313542 UTC - Status: STARTING 2026-07-11 21:03:03.029455 UTC - Status: STARTING 2026-07-11 21:03:05.745587 UTC - Status: STARTING 2026-07-11 21:03:08.463589 UTC - Status: STARTING 2026-07-11 21:03:11.179495 UTC - Status: STARTING 2026-07-11 21:03:13.895693 UTC - Status: STARTING 2026-07-11 21:03:16.611771 UTC - Status: STARTING 2026-07-11 21:03:19.327744 UTC - Status: STARTING 2026-07-11 21:03:22.043794 UTC - Status: STARTING 2026-07-11 21:03:24.759723 UTC - Status: STARTING 2026-07-11 21:03:27.576550 UTC - Status: STARTING 2026-07-11 21:03:30.293451 UTC - Status: STARTING 2026-07-11 21:03:33.009539 UTC - Status: STARTING 2026-07-11 21:03:35.725468 UTC - Status: STARTING 2026-07-11 21:03:38.441999 UTC - Status: STARTING 2026-07-11 21:03:41.158151 UTC - Status: STARTING 2026-07-11 21:03:43.874010 UTC - Status: STARTING 2026-07-11 21:03:46.589968 UTC - Status: STARTING 2026-07-11 21:03:49.306011 UTC - Status: STARTING 2026-07-11 21:03:52.022018 UTC - Status: STARTING 2026-07-11 21:03:54.741076 UTC - Status: STARTING 2026-07-11 21:03:57.457135 UTC - Status: STARTING 2026-07-11 21:04:00.173045 UTC - Status: STARTING 2026-07-11 21:04:02.939315 UTC - Status: STARTING 2026-07-11 21:04:05.655205 UTC - Status: STARTING 2026-07-11 21:04:08.371129 UTC - Status: STARTING 2026-07-11 21:04:11.087034 UTC - Status: STARTING 2026-07-11 21:04:13.853051 UTC - Status: STARTING 2026-07-11 21:04:16.569201 UTC - Status: STARTING 2026-07-11 21:04:19.285326 UTC - Status: STARTING 2026-07-11 21:04:22.001160 UTC - Status: STARTING 2026-07-11 21:04:24.717667 UTC - Status: STARTING 2026-07-11 21:04:27.483892 UTC - Status: STARTING 2026-07-11 21:04:30.250052 UTC - Status: STARTING 2026-07-11 21:04:32.965966 UTC - Status: UP 2026-07-11 21:04:32.966063 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kx9fs1jjery8qdtsq4gmdekc 2026-07-11 21:04:32.966115 UTC - Validate resources 2026-07-11 21:04:33.681937 UTC - The fields of the created resource were validated. 2026-07-11 21:04:33.682029 UTC - Check if resources are registered in experiment 2026-07-11 21:04:33.682198 UTC - Run: slices experiment list-resources --format json tst-4863d665 2026-07-11 21:04:34.297786 UTC - Status (on expauth): UP 2026-07-11 21:04:34.297973 UTC - Testing extend expires_at (all resources in experiment) 2026-07-11 21:04:34.298131 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-4863d665 2026-07-11 21:04:39.173816 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-4863d665 tst 2026-07-11 21:04:39.889473 UTC - Run: slices experiment list-resources --format json tst-4863d665 2026-07-11 21:04:40.504749 UTC - expires_at (on expauth): 2026-07-12T00:04:00Z (correctly extended) 2026-07-11 21:04:40.504863 UTC - Testing extend expires_at (single resource in experiment) 2026-07-11 21:04:40.505014 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend tst --duration 4h --experiment tst-4863d665 2026-07-11 21:04:45.380231 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-4863d665 tst 2026-07-11 21:04:46.095962 UTC - Run: slices experiment list-resources --format json tst-4863d665 2026-07-11 21:04:46.711305 UTC - expires_at (on expauth): 2026-07-12T01:04:00Z (correctly extended) 2026-07-11 21:04:46.711442 UTC - Testing ssh login 2026-07-11 21:04:46.724647 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-4863d665 tst 2026-07-11 21:04:47.440285 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-4863d665 tst 2026-07-11 21:04:48.207431 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-4863d665 tst 2026-07-11 21:04:48.207512 UTC - Content of log file '/test_dir/bi_ssh_serverkey_STDERR.txt': No hostkeys in SSH info 2026-07-11 21:04:48.207537 UTC - Error in test step 'Check SSH pubkey (resource)': [Errno 2] No such file or directory: '/test_dir/bi_ssh_serverkey.txt' 2026-07-11 21:04:48.214027 UTC - Destroying tst-4863d665 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-11 21:04:48.214193 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-4863d665 tst