Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 3.88s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 420ms 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.33s + 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.4 + 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-20 21:01:50.440050 UTC - Installing Slices CLI (latest stable version). 2026-07-20 21:01:50.440309 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-20 21:01:58.024032 UTC - Slices CLI installed. 2026-07-20 21:01:58.029617 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-20 21:01:58.047613 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-20 21:01:58.058486 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-20 21:01:58.058670 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-20 21:01:58.058701 UTC - Slices CLI exe: 'slices' 2026-07-20 21:01:58.058719 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-20 21:01:58.058863 UTC - Run: slices --version 2026-07-20 21:02:03.202891 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-20 21:02:03.204056 UTC - Run: slices pubkey list --format text 2026-07-20 21:02:05.081452 UTC - Pubkey already registered 2026-07-20 21:02:05.081716 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-20 21:02:06.581630 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-20 21:02:06.581724 UTC - Check List Flavors 2026-07-20 21:02:06.581866 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-07-20 21:02:08.583943 UTC - Check List DiskImages 2026-07-20 21:02:08.584213 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-07-20 21:02:09.783289 UTC - Requesting resources 2026-07-20 21:02:09.784237 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian11-min --flavor taurus --duration 2h --experiment tst-16046c18 2026-07-20 21:02:14.205993 UTC - Resource ID: r_fr-lyon1-bi-baremetal1_01ky0nc8z6fc9vm0w4vqt2zvsx 2026-07-20 21:02:14.206195 UTC - Waiting until resource ready 2026-07-20 21:02:16.206572 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-16046c18 tst 2026-07-20 21:02:16.972229 UTC - Status: IMAGING 2026-07-20 21:02:19.790522 UTC - Status: IMAGING 2026-07-20 21:02:22.706527 UTC - Status: STARTING 2026-07-20 21:02:26.183236 UTC - Status: STARTING 2026-07-20 21:02:29.158403 UTC - Status: STARTING 2026-07-20 21:02:32.025210 UTC - Status: STARTING 2026-07-20 21:02:34.791453 UTC - Status: STARTING 2026-07-20 21:02:37.567259 UTC - Status: STARTING 2026-07-20 21:02:40.285682 UTC - Status: STARTING 2026-07-20 21:02:43.051486 UTC - Status: STARTING 2026-07-20 21:02:45.868284 UTC - Status: STARTING 2026-07-20 21:02:48.634921 UTC - Status: STARTING 2026-07-20 21:02:51.401041 UTC - Status: STARTING 2026-07-20 21:02:54.217407 UTC - Status: STARTING 2026-07-20 21:02:56.983565 UTC - Status: STARTING 2026-07-20 21:02:59.699497 UTC - Status: STARTING 2026-07-20 21:03:02.415681 UTC - Status: STARTING 2026-07-20 21:03:05.131979 UTC - Status: STARTING 2026-07-20 21:03:07.898554 UTC - Status: STARTING 2026-07-20 21:03:10.614588 UTC - Status: STARTING 2026-07-20 21:03:13.330708 UTC - Status: STARTING 2026-07-20 21:03:16.147485 UTC - Status: STARTING 2026-07-20 21:03:18.914007 UTC - Status: STARTING 2026-07-20 21:03:21.630480 UTC - Status: STARTING 2026-07-20 21:03:24.346494 UTC - Status: STARTING 2026-07-20 21:03:27.112846 UTC - Status: STARTING 2026-07-20 21:03:29.879238 UTC - Status: STARTING 2026-07-20 21:03:32.595362 UTC - Status: STARTING 2026-07-20 21:03:35.361571 UTC - Status: STARTING 2026-07-20 21:03:38.178349 UTC - Status: STARTING 2026-07-20 21:03:40.894391 UTC - Status: STARTING 2026-07-20 21:03:43.610316 UTC - Status: STARTING 2026-07-20 21:03:46.376544 UTC - Status: STARTING 2026-07-20 21:03:49.193155 UTC - Status: STARTING 2026-07-20 21:03:51.908989 UTC - Status: STARTING 2026-07-20 21:03:54.675061 UTC - Status: STARTING 2026-07-20 21:03:57.391055 UTC - Status: STARTING 2026-07-20 21:04:00.107594 UTC - Status: STARTING 2026-07-20 21:04:02.924183 UTC - Status: STARTING 2026-07-20 21:04:05.640310 UTC - Status: STARTING 2026-07-20 21:04:08.356136 UTC - Status: STARTING 2026-07-20 21:04:11.072241 UTC - Status: STARTING 2026-07-20 21:04:13.788455 UTC - Status: STARTING 2026-07-20 21:04:16.504468 UTC - Status: STARTING 2026-07-20 21:04:19.220554 UTC - Status: STARTING 2026-07-20 21:04:21.936909 UTC - Status: STARTING 2026-07-20 21:04:24.753501 UTC - Status: STARTING 2026-07-20 21:04:27.469305 UTC - Status: STARTING 2026-07-20 21:04:30.185378 UTC - Status: STARTING 2026-07-20 21:04:32.901316 UTC - Status: STARTING 2026-07-20 21:04:35.617261 UTC - Status: STARTING 2026-07-20 21:04:38.383606 UTC - Status: STARTING 2026-07-20 21:04:41.149615 UTC - Status: STARTING 2026-07-20 21:04:43.966316 UTC - Status: STARTING 2026-07-20 21:04:46.782749 UTC - Status: STARTING 2026-07-20 21:04:49.498633 UTC - Status: STARTING 2026-07-20 21:04:52.265020 UTC - Status: STARTING 2026-07-20 21:04:54.981011 UTC - Status: STARTING 2026-07-20 21:04:57.747253 UTC - Status: STARTING 2026-07-20 21:05:00.513375 UTC - Status: UP 2026-07-20 21:05:00.513459 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01ky0nc7qveb6vffwjdw2yth50 2026-07-20 21:05:00.513502 UTC - Validate resources 2026-07-20 21:05:01.330990 UTC - The fields of the created resource were validated. 2026-07-20 21:05:01.331104 UTC - Check if resources are registered in experiment 2026-07-20 21:05:01.331265 UTC - Run: slices experiment list-resources --format json tst-16046c18 2026-07-20 21:05:01.996899 UTC - Status (on expauth): UP 2026-07-20 21:05:01.997052 UTC - Testing extend expires_at (all resources in experiment) 2026-07-20 21:05:01.997187 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-16046c18 2026-07-20 21:05:08.075501 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-16046c18 tst 2026-07-20 21:05:08.791960 UTC - Run: slices experiment list-resources --format json tst-16046c18 2026-07-20 21:05:09.457804 UTC - expires_at (on expauth): 2026-07-21T00:05:00Z (correctly extended) 2026-07-20 21:05:09.457960 UTC - Testing extend expires_at (single resource in experiment) 2026-07-20 21:05:09.458143 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend tst --duration 4h --experiment tst-16046c18 2026-07-20 21:05:15.085888 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-16046c18 tst 2026-07-20 21:05:15.852021 UTC - Run: slices experiment list-resources --format json tst-16046c18 2026-07-20 21:05:16.467419 UTC - expires_at (on expauth): 2026-07-21T01:05:00Z (correctly extended) 2026-07-20 21:05:16.467559 UTC - Testing ssh login 2026-07-20 21:05:16.482239 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-16046c18 tst 2026-07-20 21:05:17.247962 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-16046c18 tst 2026-07-20 21:05:17.966077 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-16046c18 tst 2026-07-20 21:05:17.966159 UTC - Content of log file '/test_dir/bi_ssh_serverkey_STDERR.txt': No hostkeys in SSH info 2026-07-20 21:05:17.966184 UTC - Error in test step 'Check SSH pubkey (resource)': [Errno 2] No such file or directory: '/test_dir/bi_ssh_serverkey.txt' 2026-07-20 21:05:17.972950 UTC - Destroying tst-16046c18 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-20 21:05:17.973128 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-16046c18 tst