Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 10.05s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 923ms 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 967ms + 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.0 + typing-extensions==4.16.0 + typing-inspection==0.4.2 Run Test: slices-bi-singlenode-login 2026-07-15 14:01:55.990721 UTC - Installing Slices CLI (latest stable version). 2026-07-15 14:01:55.991157 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-15 14:02:13.579135 UTC - Slices CLI installed. 2026-07-15 14:02:13.593074 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-15 14:02:13.610550 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-15 14:02:13.614973 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-15 14:02:13.615168 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-15 14:02:13.615515 UTC - Slices CLI exe: 'slices' 2026-07-15 14:02:13.615535 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-15 14:02:13.615694 UTC - Run: slices --version 2026-07-15 14:02:17.659135 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-15 14:02:17.659442 UTC - Run: slices pubkey list --format text 2026-07-15 14:02:18.725561 UTC - Pubkey already registered 2026-07-15 14:02:18.725801 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-15 14:02:19.592884 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-15 14:02:19.593013 UTC - Check List Flavors 2026-07-15 14:02:19.593262 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-07-15 14:02:21.425173 UTC - Check List DiskImages 2026-07-15 14:02:21.425367 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-07-15 14:02:22.191743 UTC - Requesting resources 2026-07-15 14:02:22.192275 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian11-min --flavor taurus --duration 2h --experiment tst-019f9477 2026-07-15 14:02:27.041363 UTC - Resource ID: r_fr-lyon1-bi-baremetal1_01kxk1c153fv9b1a1qgr8b9bn8 2026-07-15 14:02:27.041730 UTC - Waiting until resource ready 2026-07-15 14:02:29.042301 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-019f9477 tst 2026-07-15 14:02:29.959663 UTC - Status: IMAGING 2026-07-15 14:02:32.776075 UTC - Status: IMAGING 2026-07-15 14:02:35.692557 UTC - Status: IMAGING 2026-07-15 14:02:38.458757 UTC - Status: IMAGING 2026-07-15 14:02:41.329236 UTC - Status: IMAGING 2026-07-15 14:02:44.145833 UTC - Status: STARTING 2026-07-15 14:02:46.912252 UTC - Status: STARTING 2026-07-15 14:02:49.678300 UTC - Status: STARTING 2026-07-15 14:02:52.444537 UTC - Status: STARTING 2026-07-15 14:02:55.160487 UTC - Status: STARTING 2026-07-15 14:02:57.926680 UTC - Status: STARTING 2026-07-15 14:03:00.743227 UTC - Status: STARTING 2026-07-15 14:03:03.509564 UTC - Status: STARTING 2026-07-15 14:03:06.275644 UTC - Status: STARTING 2026-07-15 14:03:09.041762 UTC - Status: STARTING 2026-07-15 14:03:11.757739 UTC - Status: STARTING 2026-07-15 14:03:14.523858 UTC - Status: STARTING 2026-07-15 14:03:17.239986 UTC - Status: STARTING 2026-07-15 14:03:19.956031 UTC - Status: STARTING 2026-07-15 14:03:22.722106 UTC - Status: STARTING 2026-07-15 14:03:25.438050 UTC - Status: STARTING 2026-07-15 14:03:28.204358 UTC - Status: STARTING 2026-07-15 14:03:30.920593 UTC - Status: STARTING 2026-07-15 14:03:33.637103 UTC - Status: STARTING 2026-07-15 14:03:36.403639 UTC - Status: STARTING 2026-07-15 14:03:39.169875 UTC - Status: STARTING 2026-07-15 14:03:41.936196 UTC - Status: STARTING 2026-07-15 14:03:44.702217 UTC - Status: STARTING 2026-07-15 14:03:47.418180 UTC - Status: STARTING 2026-07-15 14:03:50.134384 UTC - Status: STARTING 2026-07-15 14:03:52.850547 UTC - Status: STARTING 2026-07-15 14:03:55.616882 UTC - Status: STARTING 2026-07-15 14:03:58.332801 UTC - Status: STARTING 2026-07-15 14:04:01.098987 UTC - Status: STARTING 2026-07-15 14:04:03.814941 UTC - Status: STARTING 2026-07-15 14:04:06.581251 UTC - Status: STARTING 2026-07-15 14:04:09.347423 UTC - Status: STARTING 2026-07-15 14:04:12.063279 UTC - Status: STARTING 2026-07-15 14:04:14.830145 UTC - Status: STARTING 2026-07-15 14:04:17.597238 UTC - Status: STARTING 2026-07-15 14:04:20.414071 UTC - Status: STARTING 2026-07-15 14:04:23.180275 UTC - Status: STARTING 2026-07-15 14:04:25.896316 UTC - Status: STARTING 2026-07-15 14:04:28.712878 UTC - Status: STARTING 2026-07-15 14:04:31.429231 UTC - Status: STARTING 2026-07-15 14:04:34.145270 UTC - Status: STARTING 2026-07-15 14:04:36.861183 UTC - Status: STARTING 2026-07-15 14:04:39.577382 UTC - Status: STARTING 2026-07-15 14:04:42.343410 UTC - Status: STARTING 2026-07-15 14:04:45.059479 UTC - Status: STARTING 2026-07-15 14:04:47.825543 UTC - Status: STARTING 2026-07-15 14:04:50.591791 UTC - Status: STARTING 2026-07-15 14:04:53.307780 UTC - Status: STARTING 2026-07-15 14:04:56.023689 UTC - Status: STARTING 2026-07-15 14:04:58.790106 UTC - Status: STARTING 2026-07-15 14:05:01.556333 UTC - Status: STARTING 2026-07-15 14:05:04.272175 UTC - Status: STARTING 2026-07-15 14:05:07.088468 UTC - Status: STARTING 2026-07-15 14:05:09.854687 UTC - Status: STARTING 2026-07-15 14:05:12.621090 UTC - Status: STARTING 2026-07-15 14:05:15.337106 UTC - Status: STARTING 2026-07-15 14:05:18.052966 UTC - Status: STARTING 2026-07-15 14:05:20.819064 UTC - Status: UP 2026-07-15 14:05:20.819190 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kxk1bzg7f6sbzyjjgg5sehf5 2026-07-15 14:05:20.819251 UTC - Validate resources 2026-07-15 14:05:21.635568 UTC - The fields of the created resource were validated. 2026-07-15 14:05:21.635661 UTC - Check if resources are registered in experiment 2026-07-15 14:05:21.635823 UTC - Run: slices experiment list-resources --format json tst-019f9477 2026-07-15 14:05:22.301279 UTC - Status (on expauth): UP 2026-07-15 14:05:22.301421 UTC - Testing extend expires_at (all resources in experiment) 2026-07-15 14:05:22.301553 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-019f9477 2026-07-15 14:05:29.110922 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-019f9477 tst 2026-07-15 14:05:30.044080 UTC - Run: slices experiment list-resources --format json tst-019f9477 2026-07-15 14:05:31.073680 UTC - expires_at (on expauth): 2026-07-15T17:05:00Z (correctly extended) 2026-07-15 14:05:31.074307 UTC - Testing extend expires_at (single resource in experiment) 2026-07-15 14:05:31.074477 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend tst --duration 4h --experiment tst-019f9477 2026-07-15 14:05:37.474801 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-019f9477 tst 2026-07-15 14:05:39.111369 UTC - Run: slices experiment list-resources --format json tst-019f9477 2026-07-15 14:05:39.939154 UTC - expires_at (on expauth): 2026-07-15T18:05:00Z (correctly extended) 2026-07-15 14:05:39.942652 UTC - Testing ssh login 2026-07-15 14:05:39.957374 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-019f9477 tst 2026-07-15 14:05:41.441741 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-019f9477 tst 2026-07-15 14:05:43.111661 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-019f9477 tst 2026-07-15 14:05:43.112340 UTC - Content of log file '/test_dir/bi_ssh_serverkey_STDERR.txt': No hostkeys in SSH info 2026-07-15 14:05:43.112391 UTC - Error in test step 'Check SSH pubkey (resource)': [Errno 2] No such file or directory: '/test_dir/bi_ssh_serverkey.txt' 2026-07-15 14:05:43.123989 UTC - Destroying tst-019f9477 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-15 14:05:43.124167 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-019f9477 tst