Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 4.75s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 248ms 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 982ms + annotated-types==0.8.0 + anyio==4.14.2 + authlib==1.7.2 + bcrypt==5.0.0 + certifi==2026.7.22 + 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.3.post1 + 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-26 05:02:33.833601 UTC - Installing Slices CLI (latest stable version). 2026-07-26 05:02:33.833852 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-26 05:02:39.484514 UTC - Slices CLI installed. 2026-07-26 05:02:39.485268 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-26 05:02:39.489720 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-26 05:02:39.490752 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-26 05:02:39.490890 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-26 05:02:39.490918 UTC - Slices CLI exe: 'slices' 2026-07-26 05:02:39.490936 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-26 05:02:39.491053 UTC - Run: slices --version 2026-07-26 05:02:43.147897 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-26 05:02:43.148166 UTC - Run: slices pubkey list --format text 2026-07-26 05:02:44.583310 UTC - Pubkey already registered 2026-07-26 05:02:44.583549 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-26 05:02:45.489661 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-26 05:02:45.489750 UTC - Check List Flavors 2026-07-26 05:02:45.489886 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-07-26 05:02:46.895575 UTC - Check List DiskImages 2026-07-26 05:02:46.895753 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-07-26 05:02:47.996792 UTC - Requesting resources 2026-07-26 05:02:47.997553 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian11-min --flavor taurus --duration 2h --experiment tst-e3d95f03 2026-07-26 05:02:49.576469 UTC - Resource ID: r_fr-lyon1-bi-baremetal1_01kyecvvh0e8srxdryapvry4dh 2026-07-26 05:02:49.576620 UTC - Waiting until resource ready 2026-07-26 05:02:51.576970 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-e3d95f03 tst 2026-07-26 05:02:52.885004 UTC - Status: IMAGING 2026-07-26 05:02:55.856533 UTC - Status: IMAGING 2026-07-26 05:02:58.673394 UTC - Status: STARTING 2026-07-26 05:03:01.702286 UTC - Status: STARTING 2026-07-26 05:03:04.779204 UTC - Status: STARTING 2026-07-26 05:03:07.855839 UTC - Status: STARTING 2026-07-26 05:03:11.314150 UTC - Status: STARTING 2026-07-26 05:03:14.233456 UTC - Status: STARTING 2026-07-26 05:03:17.314062 UTC - Status: STARTING 2026-07-26 05:03:20.244887 UTC - Status: STARTING 2026-07-26 05:03:23.011031 UTC - Status: STARTING 2026-07-26 05:03:25.776853 UTC - Status: STARTING 2026-07-26 05:03:28.492491 UTC - Status: STARTING 2026-07-26 05:03:31.359494 UTC - Status: STARTING 2026-07-26 05:03:34.176001 UTC - Status: STARTING 2026-07-26 05:03:36.942311 UTC - Status: STARTING 2026-07-26 05:03:39.658323 UTC - Status: STARTING 2026-07-26 05:03:42.424370 UTC - Status: STARTING 2026-07-26 05:03:45.140452 UTC - Status: STARTING 2026-07-26 05:03:47.906615 UTC - Status: STARTING 2026-07-26 05:03:50.622378 UTC - Status: STARTING 2026-07-26 05:03:53.338477 UTC - Status: STARTING 2026-07-26 05:03:56.104515 UTC - Status: STARTING 2026-07-26 05:03:58.820593 UTC - Status: STARTING 2026-07-26 05:04:01.536596 UTC - Status: STARTING 2026-07-26 05:04:04.252360 UTC - Status: STARTING 2026-07-26 05:04:06.968302 UTC - Status: STARTING 2026-07-26 05:04:09.684390 UTC - Status: STARTING 2026-07-26 05:04:12.400377 UTC - Status: STARTING 2026-07-26 05:04:15.166875 UTC - Status: STARTING 2026-07-26 05:04:17.882863 UTC - Status: STARTING 2026-07-26 05:04:20.598581 UTC - Status: STARTING 2026-07-26 05:04:23.314492 UTC - Status: STARTING 2026-07-26 05:04:26.080549 UTC - Status: STARTING 2026-07-26 05:04:28.846801 UTC - Status: STARTING 2026-07-26 05:04:31.562714 UTC - Status: STARTING 2026-07-26 05:04:34.278611 UTC - Status: STARTING 2026-07-26 05:04:36.994734 UTC - Status: STARTING 2026-07-26 05:04:39.710694 UTC - Status: STARTING 2026-07-26 05:04:42.426577 UTC - Status: STARTING 2026-07-26 05:04:45.142554 UTC - Status: STARTING 2026-07-26 05:04:47.908854 UTC - Status: STARTING 2026-07-26 05:04:50.624908 UTC - Status: STARTING 2026-07-26 05:04:53.340949 UTC - Status: STARTING 2026-07-26 05:04:56.056953 UTC - Status: STARTING 2026-07-26 05:04:58.772874 UTC - Status: STARTING 2026-07-26 05:05:01.539112 UTC - Status: STARTING 2026-07-26 05:05:04.255439 UTC - Status: STARTING 2026-07-26 05:05:07.121963 UTC - Status: STARTING 2026-07-26 05:05:09.888035 UTC - Status: STARTING 2026-07-26 05:05:12.704917 UTC - Status: STARTING 2026-07-26 05:05:15.521966 UTC - Status: STARTING 2026-07-26 05:05:18.238025 UTC - Status: STARTING 2026-07-26 05:05:20.953937 UTC - Status: STARTING 2026-07-26 05:05:23.821681 UTC - Status: STARTING 2026-07-26 05:05:26.900839 UTC - Status: STARTING 2026-07-26 05:05:30.300848 UTC - Status: STARTING 2026-07-26 05:05:33.271348 UTC - Status: STARTING 2026-07-26 05:05:36.410250 UTC - Status: STARTING 2026-07-26 05:05:40.146869 UTC - Status: STARTING 2026-07-26 05:05:43.377736 UTC - Status: UP 2026-07-26 05:05:43.377828 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kyecvv40frv9va0dbtaq1ngk 2026-07-26 05:05:43.377865 UTC - Validate resources 2026-07-26 05:05:44.296416 UTC - The fields of the created resource were validated. 2026-07-26 05:05:44.296512 UTC - Check if resources are registered in experiment 2026-07-26 05:05:44.296664 UTC - Run: slices experiment list-resources --format json tst-e3d95f03 2026-07-26 05:05:44.961842 UTC - Status (on expauth): UP 2026-07-26 05:05:44.961974 UTC - Testing extend expires_at (all resources in experiment) 2026-07-26 05:05:44.962094 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-e3d95f03 2026-07-26 05:05:48.633626 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-e3d95f03 tst 2026-07-26 05:05:49.349212 UTC - Run: slices experiment list-resources --format json tst-e3d95f03 2026-07-26 05:05:50.114877 UTC - expires_at (on expauth): 2026-07-26T08:05:00Z (correctly extended) 2026-07-26 05:05:50.114979 UTC - Testing extend expires_at (single resource in experiment) 2026-07-26 05:05:50.115113 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend tst --duration 4h --experiment tst-e3d95f03 2026-07-26 05:05:53.848310 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-e3d95f03 tst 2026-07-26 05:05:54.972401 UTC - Run: slices experiment list-resources --format json tst-e3d95f03 2026-07-26 05:05:55.701359 UTC - expires_at (on expauth): 2026-07-26T09:05:00Z (correctly extended) 2026-07-26 05:05:55.701500 UTC - Testing ssh login 2026-07-26 05:05:55.715711 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-e3d95f03 tst 2026-07-26 05:05:56.581981 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-e3d95f03 tst 2026-07-26 05:05:57.450897 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-e3d95f03 tst 2026-07-26 05:05:57.450979 UTC - Content of log file '/test_dir/bi_ssh_serverkey_STDERR.txt': No hostkeys in SSH info 2026-07-26 05:05:57.451003 UTC - Error in test step 'Check SSH pubkey (resource)': [Errno 2] No such file or directory: '/test_dir/bi_ssh_serverkey.txt' 2026-07-26 05:05:57.458746 UTC - Destroying tst-e3d95f03 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-26 05:05:57.458930 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-e3d95f03 tst