Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 6.15s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 411ms 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.09s + 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-14 05:01:33.004396 UTC - Installing Slices CLI (latest stable version). 2026-07-14 05:01:33.005478 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-14 05:01:43.274359 UTC - Slices CLI installed. 2026-07-14 05:01:43.275389 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-14 05:01:43.280158 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-14 05:01:43.284858 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-14 05:01:43.285019 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-14 05:01:43.285047 UTC - Slices CLI exe: 'slices' 2026-07-14 05:01:43.285064 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-14 05:01:43.285189 UTC - Run: slices --version 2026-07-14 05:01:49.158641 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-14 05:01:49.158980 UTC - Run: slices pubkey list --format text 2026-07-14 05:01:50.124873 UTC - Pubkey already registered 2026-07-14 05:01:50.125213 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-14 05:01:50.740383 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-14 05:01:50.740470 UTC - Check List Flavors 2026-07-14 05:01:50.740606 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-07-14 05:01:52.644574 UTC - Check List DiskImages 2026-07-14 05:01:52.644932 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-07-14 05:01:53.868568 UTC - Requesting resources 2026-07-14 05:01:53.869241 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian11-min --flavor taurus --duration 2h --experiment tst-0b95566c 2026-07-14 05:01:57.791954 UTC - Resource ID: r_fr-lyon1-bi-baremetal1_01kxfg1n02eehabywrnw48j3p3 2026-07-14 05:01:57.792115 UTC - Waiting until resource ready 2026-07-14 05:01:59.796946 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-0b95566c tst 2026-07-14 05:02:00.574090 UTC - Status: IMAGING 2026-07-14 05:02:03.290107 UTC - Status: IMAGING 2026-07-14 05:02:06.006117 UTC - Status: STARTING 2026-07-14 05:02:08.722022 UTC - Status: STARTING 2026-07-14 05:02:11.437924 UTC - Status: STARTING 2026-07-14 05:02:14.153828 UTC - Status: STARTING 2026-07-14 05:02:16.869658 UTC - Status: STARTING 2026-07-14 05:02:19.587261 UTC - Status: STARTING 2026-07-14 05:02:22.303250 UTC - Status: STARTING 2026-07-14 05:02:25.019104 UTC - Status: STARTING 2026-07-14 05:02:27.734972 UTC - Status: STARTING 2026-07-14 05:02:30.450856 UTC - Status: STARTING 2026-07-14 05:02:33.166786 UTC - Status: STARTING 2026-07-14 05:02:35.882672 UTC - Status: STARTING 2026-07-14 05:02:38.598582 UTC - Status: STARTING 2026-07-14 05:02:41.314537 UTC - Status: STARTING 2026-07-14 05:02:44.030692 UTC - Status: STARTING 2026-07-14 05:02:46.746685 UTC - Status: STARTING 2026-07-14 05:02:49.462432 UTC - Status: STARTING 2026-07-14 05:02:52.178339 UTC - Status: STARTING 2026-07-14 05:02:54.894262 UTC - Status: STARTING 2026-07-14 05:02:57.610274 UTC - Status: STARTING 2026-07-14 05:03:00.326214 UTC - Status: STARTING 2026-07-14 05:03:03.042278 UTC - Status: STARTING 2026-07-14 05:03:05.758251 UTC - Status: STARTING 2026-07-14 05:03:08.524834 UTC - Status: STARTING 2026-07-14 05:03:11.241192 UTC - Status: STARTING 2026-07-14 05:03:13.957187 UTC - Status: STARTING 2026-07-14 05:03:16.673037 UTC - Status: STARTING 2026-07-14 05:03:19.388984 UTC - Status: STARTING 2026-07-14 05:03:22.155619 UTC - Status: STARTING 2026-07-14 05:03:24.922149 UTC - Status: STARTING 2026-07-14 05:03:27.638201 UTC - Status: STARTING 2026-07-14 05:03:30.354153 UTC - Status: STARTING 2026-07-14 05:03:33.070819 UTC - Status: STARTING 2026-07-14 05:03:35.786658 UTC - Status: STARTING 2026-07-14 05:03:38.502621 UTC - Status: STARTING 2026-07-14 05:03:41.219298 UTC - Status: STARTING 2026-07-14 05:03:43.935658 UTC - Status: STARTING 2026-07-14 05:03:46.651449 UTC - Status: STARTING 2026-07-14 05:03:49.417737 UTC - Status: STARTING 2026-07-14 05:03:52.133657 UTC - Status: STARTING 2026-07-14 05:03:54.849409 UTC - Status: STARTING 2026-07-14 05:03:57.565284 UTC - Status: STARTING 2026-07-14 05:04:00.381648 UTC - Status: STARTING 2026-07-14 05:04:03.097704 UTC - Status: STARTING 2026-07-14 05:04:05.813765 UTC - Status: STARTING 2026-07-14 05:04:08.529763 UTC - Status: STARTING 2026-07-14 05:04:11.245707 UTC - Status: STARTING 2026-07-14 05:04:13.961818 UTC - Status: STARTING 2026-07-14 05:04:16.677686 UTC - Status: STARTING 2026-07-14 05:04:19.393870 UTC - Status: STARTING 2026-07-14 05:04:22.109868 UTC - Status: STARTING 2026-07-14 05:04:24.825983 UTC - Status: STARTING 2026-07-14 05:04:27.541905 UTC - Status: STARTING 2026-07-14 05:04:30.257972 UTC - Status: STARTING 2026-07-14 05:04:33.024171 UTC - Status: STARTING 2026-07-14 05:04:35.790548 UTC - Status: STARTING 2026-07-14 05:04:38.506553 UTC - Status: STARTING 2026-07-14 05:04:41.222457 UTC - Status: STARTING 2026-07-14 05:04:43.988558 UTC - Status: STARTING 2026-07-14 05:04:46.704565 UTC - Status: STARTING 2026-07-14 05:04:49.420590 UTC - Status: UP 2026-07-14 05:04:49.420665 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kxfg1kpcfnr80y38gf4w3jmg 2026-07-14 05:04:49.420737 UTC - Validate resources 2026-07-14 05:04:50.136520 UTC - The fields of the created resource were validated. 2026-07-14 05:04:50.136611 UTC - Check if resources are registered in experiment 2026-07-14 05:04:50.136812 UTC - Run: slices experiment list-resources --format json tst-0b95566c 2026-07-14 05:04:50.751942 UTC - Status (on expauth): UP 2026-07-14 05:04:50.752075 UTC - Testing extend expires_at (all resources in experiment) 2026-07-14 05:04:50.752226 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-0b95566c 2026-07-14 05:04:55.877350 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-0b95566c tst 2026-07-14 05:04:56.592989 UTC - Run: slices experiment list-resources --format json tst-0b95566c 2026-07-14 05:04:57.208324 UTC - expires_at (on expauth): 2026-07-14T08:04:00Z (correctly extended) 2026-07-14 05:04:57.208433 UTC - Testing extend expires_at (single resource in experiment) 2026-07-14 05:04:57.208573 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend tst --duration 4h --experiment tst-0b95566c 2026-07-14 05:05:02.785431 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-0b95566c tst 2026-07-14 05:05:03.551378 UTC - Run: slices experiment list-resources --format json tst-0b95566c 2026-07-14 05:05:04.166669 UTC - expires_at (on expauth): 2026-07-14T09:04:00Z (correctly extended) 2026-07-14 05:05:04.166788 UTC - Testing ssh login 2026-07-14 05:05:04.179868 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-0b95566c tst 2026-07-14 05:05:04.945712 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-0b95566c tst 2026-07-14 05:05:05.663337 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-0b95566c tst 2026-07-14 05:05:05.663417 UTC - Content of log file '/test_dir/bi_ssh_serverkey_STDERR.txt': No hostkeys in SSH info 2026-07-14 05:05:05.663442 UTC - Error in test step 'Check SSH pubkey (resource)': [Errno 2] No such file or directory: '/test_dir/bi_ssh_serverkey.txt' 2026-07-14 05:05:05.669799 UTC - Destroying tst-0b95566c 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-14 05:05:05.669958 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-0b95566c tst