Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 5.13s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 464ms 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.23s + 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-19 14:01:55.138890 UTC - Installing Slices CLI (latest stable version). 2026-07-19 14:01:55.139248 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-19 14:02:02.116888 UTC - Slices CLI installed. 2026-07-19 14:02:02.118035 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-19 14:02:02.120668 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-19 14:02:02.122047 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-19 14:02:02.122184 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-19 14:02:02.122211 UTC - Slices CLI exe: 'slices' 2026-07-19 14:02:02.122228 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-19 14:02:02.122347 UTC - Run: slices --version 2026-07-19 14:02:05.966978 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-19 14:02:05.967292 UTC - Run: slices pubkey list --format text 2026-07-19 14:02:06.782820 UTC - Pubkey already registered 2026-07-19 14:02:06.783059 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-19 14:02:07.552674 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-19 14:02:07.553043 UTC - Check List Flavors 2026-07-19 14:02:07.553206 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-07-19 14:02:09.795543 UTC - Check List DiskImages 2026-07-19 14:02:09.796042 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-07-19 14:02:11.211653 UTC - Requesting resources 2026-07-19 14:02:11.212395 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian11-min --flavor taurus --duration 2h --experiment tst-10f883e1 2026-07-19 14:02:15.853474 UTC - Resource ID: r_fr-lyon1-bi-baremetal1_01kxxayj3sf2ga8x00gq50wv32 2026-07-19 14:02:15.855022 UTC - Waiting until resource ready 2026-07-19 14:02:17.855470 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-10f883e1 tst 2026-07-19 14:02:19.033215 UTC - Status: IMAGING 2026-07-19 14:02:22.622042 UTC - Status: STARTING 2026-07-19 14:02:25.490617 UTC - Status: STARTING 2026-07-19 14:02:28.379113 UTC - Status: STARTING 2026-07-19 14:02:31.146294 UTC - Status: STARTING 2026-07-19 14:02:33.964397 UTC - Status: STARTING 2026-07-19 14:02:36.730522 UTC - Status: STARTING 2026-07-19 14:02:39.446324 UTC - Status: STARTING 2026-07-19 14:02:42.162111 UTC - Status: STARTING 2026-07-19 14:02:44.878724 UTC - Status: STARTING 2026-07-19 14:02:47.595250 UTC - Status: STARTING 2026-07-19 14:02:50.311441 UTC - Status: STARTING 2026-07-19 14:02:53.027279 UTC - Status: STARTING 2026-07-19 14:02:55.793494 UTC - Status: STARTING 2026-07-19 14:02:58.509403 UTC - Status: STARTING 2026-07-19 14:03:01.225691 UTC - Status: STARTING 2026-07-19 14:03:03.941965 UTC - Status: STARTING 2026-07-19 14:03:06.708013 UTC - Status: STARTING 2026-07-19 14:03:09.424009 UTC - Status: STARTING 2026-07-19 14:03:12.190091 UTC - Status: STARTING 2026-07-19 14:03:14.958070 UTC - Status: STARTING 2026-07-19 14:03:17.724183 UTC - Status: STARTING 2026-07-19 14:03:20.440669 UTC - Status: STARTING 2026-07-19 14:03:23.156658 UTC - Status: STARTING 2026-07-19 14:03:25.873161 UTC - Status: STARTING 2026-07-19 14:03:28.589719 UTC - Status: STARTING 2026-07-19 14:03:31.406752 UTC - Status: STARTING 2026-07-19 14:03:34.123432 UTC - Status: STARTING 2026-07-19 14:03:36.940122 UTC - Status: STARTING 2026-07-19 14:03:39.656416 UTC - Status: STARTING 2026-07-19 14:03:42.372470 UTC - Status: STARTING 2026-07-19 14:03:45.088485 UTC - Status: STARTING 2026-07-19 14:03:47.804823 UTC - Status: STARTING 2026-07-19 14:03:50.520548 UTC - Status: STARTING 2026-07-19 14:03:53.286757 UTC - Status: STARTING 2026-07-19 14:03:56.003210 UTC - Status: STARTING 2026-07-19 14:03:58.719162 UTC - Status: STARTING 2026-07-19 14:04:01.485579 UTC - Status: STARTING 2026-07-19 14:04:04.251659 UTC - Status: STARTING 2026-07-19 14:04:06.967879 UTC - Status: STARTING 2026-07-19 14:04:09.734272 UTC - Status: STARTING 2026-07-19 14:04:12.450135 UTC - Status: STARTING 2026-07-19 14:04:15.166066 UTC - Status: STARTING 2026-07-19 14:04:17.932248 UTC - Status: STARTING 2026-07-19 14:04:20.648089 UTC - Status: STARTING 2026-07-19 14:04:23.364261 UTC - Status: STARTING 2026-07-19 14:04:26.130949 UTC - Status: STARTING 2026-07-19 14:04:28.897848 UTC - Status: STARTING 2026-07-19 14:04:31.663900 UTC - Status: STARTING 2026-07-19 14:04:34.379839 UTC - Status: STARTING 2026-07-19 14:04:37.095977 UTC - Status: STARTING 2026-07-19 14:04:39.812539 UTC - Status: STARTING 2026-07-19 14:04:42.528388 UTC - Status: STARTING 2026-07-19 14:04:45.395276 UTC - Status: STARTING 2026-07-19 14:04:48.161709 UTC - Status: STARTING 2026-07-19 14:04:50.877540 UTC - Status: STARTING 2026-07-19 14:04:53.644120 UTC - Status: STARTING 2026-07-19 14:04:56.360749 UTC - Status: STARTING 2026-07-19 14:04:59.076604 UTC - Status: STARTING 2026-07-19 14:05:01.843137 UTC - Status: UP 2026-07-19 14:05:01.843255 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kxxaygjteyvsfzvd19kxk201 2026-07-19 14:05:01.843316 UTC - Validate resources 2026-07-19 14:05:02.611227 UTC - The fields of the created resource were validated. 2026-07-19 14:05:02.611355 UTC - Check if resources are registered in experiment 2026-07-19 14:05:02.611562 UTC - Run: slices experiment list-resources --format json tst-10f883e1 2026-07-19 14:05:03.227285 UTC - Status (on expauth): UP 2026-07-19 14:05:03.227469 UTC - Testing extend expires_at (all resources in experiment) 2026-07-19 14:05:03.227629 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-10f883e1 2026-07-19 14:05:08.805196 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-10f883e1 tst 2026-07-19 14:05:09.520674 UTC - Run: slices experiment list-resources --format json tst-10f883e1 2026-07-19 14:05:10.185997 UTC - expires_at (on expauth): 2026-07-19T17:05:00Z (correctly extended) 2026-07-19 14:05:10.186116 UTC - Testing extend expires_at (single resource in experiment) 2026-07-19 14:05:10.186268 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend tst --duration 4h --experiment tst-10f883e1 2026-07-19 14:05:16.214270 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-10f883e1 tst 2026-07-19 14:05:16.930498 UTC - Run: slices experiment list-resources --format json tst-10f883e1 2026-07-19 14:05:17.546432 UTC - expires_at (on expauth): 2026-07-19T18:05:00Z (correctly extended) 2026-07-19 14:05:17.546607 UTC - Testing ssh login 2026-07-19 14:05:17.561966 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-10f883e1 tst 2026-07-19 14:05:18.278077 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-10f883e1 tst 2026-07-19 14:05:19.046401 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-10f883e1 tst 2026-07-19 14:05:19.046482 UTC - Content of log file '/test_dir/bi_ssh_serverkey_STDERR.txt': No hostkeys in SSH info 2026-07-19 14:05:19.046506 UTC - Error in test step 'Check SSH pubkey (resource)': [Errno 2] No such file or directory: '/test_dir/bi_ssh_serverkey.txt' 2026-07-19 14:05:19.054628 UTC - Destroying tst-10f883e1 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-19 14:05:19.054831 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-10f883e1 tst