Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 4.65s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 360ms 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 630ms + annotated-types==0.7.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.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-22 21:02:29.068783 UTC - Installing Slices CLI (latest stable version). 2026-07-22 21:02:29.069652 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-22 21:02:36.943467 UTC - Slices CLI installed. 2026-07-22 21:02:36.944059 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-22 21:02:36.946856 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-22 21:02:36.948008 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-22 21:02:36.948164 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-22 21:02:36.948193 UTC - Slices CLI exe: 'slices' 2026-07-22 21:02:36.948210 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-22 21:02:36.948333 UTC - Run: slices --version 2026-07-22 21:02:41.514877 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-22 21:02:41.515348 UTC - Run: slices pubkey list --format text 2026-07-22 21:02:42.781679 UTC - Pubkey already registered 2026-07-22 21:02:42.781901 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-22 21:02:43.715291 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-22 21:02:43.715407 UTC - Check List Flavors 2026-07-22 21:02:43.715560 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-07-22 21:02:45.137804 UTC - Check List DiskImages 2026-07-22 21:02:45.139350 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-07-22 21:02:46.411294 UTC - Requesting resources 2026-07-22 21:02:46.411972 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian11-min --flavor taurus --duration 2h --experiment tst-00fe62d4 2026-07-22 21:02:48.480250 UTC - Resource ID: r_fr-lyon1-bi-baremetal1_01ky5t6rgneegs4pnt4nphs98e 2026-07-22 21:02:48.480409 UTC - Waiting until resource ready 2026-07-22 21:02:50.480752 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-00fe62d4 tst 2026-07-22 21:02:51.296508 UTC - Status: IMAGING 2026-07-22 21:02:54.065778 UTC - Status: IMAGING 2026-07-22 21:02:57.170939 UTC - Status: STARTING 2026-07-22 21:03:00.194790 UTC - Status: STARTING 2026-07-22 21:03:02.961012 UTC - Status: STARTING 2026-07-22 21:03:06.036905 UTC - Status: STARTING 2026-07-22 21:03:09.321208 UTC - Status: STARTING 2026-07-22 21:03:12.297217 UTC - Status: STARTING 2026-07-22 21:03:15.014182 UTC - Status: STARTING 2026-07-22 21:03:17.930210 UTC - Status: STARTING 2026-07-22 21:03:20.796274 UTC - Status: STARTING 2026-07-22 21:03:23.512711 UTC - Status: STARTING 2026-07-22 21:03:26.228767 UTC - Status: STARTING 2026-07-22 21:03:28.945255 UTC - Status: STARTING 2026-07-22 21:03:31.661526 UTC - Status: STARTING 2026-07-22 21:03:34.377648 UTC - Status: STARTING 2026-07-22 21:03:37.194510 UTC - Status: STARTING 2026-07-22 21:03:39.963140 UTC - Status: STARTING 2026-07-22 21:03:42.681043 UTC - Status: STARTING 2026-07-22 21:03:45.397650 UTC - Status: STARTING 2026-07-22 21:03:48.164696 UTC - Status: STARTING 2026-07-22 21:03:50.880687 UTC - Status: STARTING 2026-07-22 21:03:53.596747 UTC - Status: STARTING 2026-07-22 21:03:56.312665 UTC - Status: STARTING 2026-07-22 21:03:59.079021 UTC - Status: STARTING 2026-07-22 21:04:01.795123 UTC - Status: STARTING 2026-07-22 21:04:04.612126 UTC - Status: STARTING 2026-07-22 21:04:07.328380 UTC - Status: STARTING 2026-07-22 21:04:10.044407 UTC - Status: STARTING 2026-07-22 21:04:12.761085 UTC - Status: STARTING 2026-07-22 21:04:15.527522 UTC - Status: STARTING 2026-07-22 21:04:18.343999 UTC - Status: STARTING 2026-07-22 21:04:21.060083 UTC - Status: STARTING 2026-07-22 21:04:23.776489 UTC - Status: STARTING 2026-07-22 21:04:26.542781 UTC - Status: STARTING 2026-07-22 21:04:29.259387 UTC - Status: STARTING 2026-07-22 21:04:32.026023 UTC - Status: STARTING 2026-07-22 21:04:34.792861 UTC - Status: STARTING 2026-07-22 21:04:37.559487 UTC - Status: STARTING 2026-07-22 21:04:40.427242 UTC - Status: STARTING 2026-07-22 21:04:43.143361 UTC - Status: STARTING 2026-07-22 21:04:45.960249 UTC - Status: STARTING 2026-07-22 21:04:48.727656 UTC - Status: STARTING 2026-07-22 21:04:51.544627 UTC - Status: STARTING 2026-07-22 21:04:54.260652 UTC - Status: STARTING 2026-07-22 21:04:57.027259 UTC - Status: STARTING 2026-07-22 21:04:59.794073 UTC - Status: STARTING 2026-07-22 21:05:02.611373 UTC - Status: STARTING 2026-07-22 21:05:05.327817 UTC - Status: STARTING 2026-07-22 21:05:08.044525 UTC - Status: STARTING 2026-07-22 21:05:10.760964 UTC - Status: STARTING 2026-07-22 21:05:13.476987 UTC - Status: STARTING 2026-07-22 21:05:16.193103 UTC - Status: STARTING 2026-07-22 21:05:18.909080 UTC - Status: STARTING 2026-07-22 21:05:21.624971 UTC - Status: STARTING 2026-07-22 21:05:24.391651 UTC - Status: STARTING 2026-07-22 21:05:27.283297 UTC - Status: STARTING 2026-07-22 21:05:30.604445 UTC - Status: STARTING 2026-07-22 21:05:33.581230 UTC - Status: STARTING 2026-07-22 21:05:37.209926 UTC - Status: UP 2026-07-22 21:05:37.210022 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01ky5t6qt4e1wb6dp53pnka2z1 2026-07-22 21:05:37.210064 UTC - Validate resources 2026-07-22 21:05:38.585668 UTC - The fields of the created resource were validated. 2026-07-22 21:05:38.585780 UTC - Check if resources are registered in experiment 2026-07-22 21:05:38.585936 UTC - Run: slices experiment list-resources --format json tst-00fe62d4 2026-07-22 21:05:39.820640 UTC - Status (on expauth): UP 2026-07-22 21:05:39.820813 UTC - Testing extend expires_at (all resources in experiment) 2026-07-22 21:05:39.820931 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-00fe62d4 2026-07-22 21:05:44.401644 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-00fe62d4 tst 2026-07-22 21:05:45.680934 UTC - Run: slices experiment list-resources --format json tst-00fe62d4 2026-07-22 21:05:46.815770 UTC - expires_at (on expauth): 2026-07-23T00:05:00Z (correctly extended) 2026-07-22 21:05:46.815940 UTC - Testing extend expires_at (single resource in experiment) 2026-07-22 21:05:46.816130 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend tst --duration 4h --experiment tst-00fe62d4 2026-07-22 21:05:51.561065 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-00fe62d4 tst 2026-07-22 21:05:52.780744 UTC - Run: slices experiment list-resources --format json tst-00fe62d4 2026-07-22 21:05:53.532285 UTC - expires_at (on expauth): 2026-07-23T01:05:00Z (correctly extended) 2026-07-22 21:05:53.534988 UTC - Testing ssh login 2026-07-22 21:05:53.568614 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-00fe62d4 tst 2026-07-22 21:05:54.702433 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-00fe62d4 tst 2026-07-22 21:05:55.988545 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-00fe62d4 tst 2026-07-22 21:05:55.988806 UTC - Content of log file '/test_dir/bi_ssh_serverkey_STDERR.txt': No hostkeys in SSH info 2026-07-22 21:05:55.988842 UTC - Error in test step 'Check SSH pubkey (resource)': [Errno 2] No such file or directory: '/test_dir/bi_ssh_serverkey.txt' 2026-07-22 21:05:55.996974 UTC - Destroying tst-00fe62d4 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-22 21:05:55.997156 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-00fe62d4 tst