Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 6.76s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 205ms 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.37s + 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-16 14:01:35.688523 UTC - Installing Slices CLI (latest stable version). 2026-07-16 14:01:35.688778 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-16 14:01:43.253046 UTC - Slices CLI installed. 2026-07-16 14:01:43.253534 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-16 14:01:43.256394 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-16 14:01:43.257432 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-16 14:01:43.257557 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-16 14:01:43.257585 UTC - Slices CLI exe: 'slices' 2026-07-16 14:01:43.257601 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-16 14:01:43.257727 UTC - Run: slices --version 2026-07-16 14:01:49.103380 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-16 14:01:49.103679 UTC - Run: slices pubkey list --format text 2026-07-16 14:01:51.325521 UTC - Pubkey already registered 2026-07-16 14:01:51.325800 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-16 14:01:52.573536 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-16 14:01:52.573627 UTC - Check List Flavors 2026-07-16 14:01:52.573767 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-07-16 14:01:54.294655 UTC - Check List DiskImages 2026-07-16 14:01:54.294842 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-07-16 14:01:55.380649 UTC - Requesting resources 2026-07-16 14:01:55.381167 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian11-min --flavor taurus --duration 2h --experiment tst-59fb8534 2026-07-16 14:02:00.860989 UTC - Resource ID: r_fr-lyon1-bi-baremetal1_01kxnkqyknf98bxvatssvgxbnx 2026-07-16 14:02:00.861187 UTC - Waiting until resource ready 2026-07-16 14:02:02.861585 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-59fb8534 tst 2026-07-16 14:02:03.627049 UTC - Status: IMAGING 2026-07-16 14:02:06.597763 UTC - Status: STARTING 2026-07-16 14:02:09.313444 UTC - Status: STARTING 2026-07-16 14:02:12.079291 UTC - Status: STARTING 2026-07-16 14:02:14.796135 UTC - Status: STARTING 2026-07-16 14:02:17.612014 UTC - Status: STARTING 2026-07-16 14:02:20.327793 UTC - Status: STARTING 2026-07-16 14:02:23.043778 UTC - Status: STARTING 2026-07-16 14:02:25.759838 UTC - Status: STARTING 2026-07-16 14:02:28.475687 UTC - Status: STARTING 2026-07-16 14:02:31.191641 UTC - Status: STARTING 2026-07-16 14:02:33.907583 UTC - Status: STARTING 2026-07-16 14:02:36.623496 UTC - Status: STARTING 2026-07-16 14:02:39.339210 UTC - Status: STARTING 2026-07-16 14:02:42.055189 UTC - Status: STARTING 2026-07-16 14:02:44.821593 UTC - Status: STARTING 2026-07-16 14:02:47.537630 UTC - Status: STARTING 2026-07-16 14:02:50.253705 UTC - Status: STARTING 2026-07-16 14:02:52.969488 UTC - Status: STARTING 2026-07-16 14:02:55.685294 UTC - Status: STARTING 2026-07-16 14:02:58.451522 UTC - Status: STARTING 2026-07-16 14:03:01.167448 UTC - Status: STARTING 2026-07-16 14:03:03.883301 UTC - Status: STARTING 2026-07-16 14:03:06.649185 UTC - Status: STARTING 2026-07-16 14:03:09.365251 UTC - Status: STARTING 2026-07-16 14:03:12.081109 UTC - Status: STARTING 2026-07-16 14:03:14.796974 UTC - Status: STARTING 2026-07-16 14:03:17.512911 UTC - Status: STARTING 2026-07-16 14:03:20.228854 UTC - Status: STARTING 2026-07-16 14:03:22.944682 UTC - Status: STARTING 2026-07-16 14:03:25.660546 UTC - Status: STARTING 2026-07-16 14:03:28.476682 UTC - Status: STARTING 2026-07-16 14:03:31.343973 UTC - Status: STARTING 2026-07-16 14:03:34.059792 UTC - Status: STARTING 2026-07-16 14:03:37.878302 UTC - Status: STARTING 2026-07-16 14:03:40.594372 UTC - Status: STARTING 2026-07-16 14:03:43.811699 UTC - Status: STARTING 2026-07-16 14:03:46.577950 UTC - Status: STARTING 2026-07-16 14:03:49.294160 UTC - Status: STARTING 2026-07-16 14:03:52.010401 UTC - Status: STARTING 2026-07-16 14:03:54.826738 UTC - Status: STARTING 2026-07-16 14:03:57.642892 UTC - Status: STARTING 2026-07-16 14:04:00.412814 UTC - Status: STARTING 2026-07-16 14:04:03.178828 UTC - Status: STARTING 2026-07-16 14:04:05.894759 UTC - Status: STARTING 2026-07-16 14:04:08.610590 UTC - Status: STARTING 2026-07-16 14:04:11.326469 UTC - Status: STARTING 2026-07-16 14:04:14.092852 UTC - Status: STARTING 2026-07-16 14:04:16.809576 UTC - Status: STARTING 2026-07-16 14:04:19.525533 UTC - Status: STARTING 2026-07-16 14:04:22.292110 UTC - Status: STARTING 2026-07-16 14:04:25.059032 UTC - Status: STARTING 2026-07-16 14:04:27.775246 UTC - Status: STARTING 2026-07-16 14:04:30.491276 UTC - Status: STARTING 2026-07-16 14:04:33.207514 UTC - Status: STARTING 2026-07-16 14:04:35.973595 UTC - Status: STARTING 2026-07-16 14:04:38.689539 UTC - Status: STARTING 2026-07-16 14:04:41.405401 UTC - Status: STARTING 2026-07-16 14:04:44.171583 UTC - Status: STARTING 2026-07-16 14:04:46.887410 UTC - Status: STARTING 2026-07-16 14:04:49.603363 UTC - Status: UP 2026-07-16 14:04:49.603454 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kxnkqwmtf7vsd46vxs6zhrcy 2026-07-16 14:04:49.603495 UTC - Validate resources 2026-07-16 14:04:50.319239 UTC - The fields of the created resource were validated. 2026-07-16 14:04:50.319337 UTC - Check if resources are registered in experiment 2026-07-16 14:04:50.319546 UTC - Run: slices experiment list-resources --format json tst-59fb8534 2026-07-16 14:04:50.934764 UTC - Status (on expauth): UP 2026-07-16 14:04:50.934903 UTC - Testing extend expires_at (all resources in experiment) 2026-07-16 14:04:50.935031 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-59fb8534 2026-07-16 14:04:56.211156 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-59fb8534 tst 2026-07-16 14:04:56.926718 UTC - Run: slices experiment list-resources --format json tst-59fb8534 2026-07-16 14:04:57.541866 UTC - expires_at (on expauth): 2026-07-16T17:04:00Z (correctly extended) 2026-07-16 14:04:57.541977 UTC - Testing extend expires_at (single resource in experiment) 2026-07-16 14:04:57.542117 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend tst --duration 4h --experiment tst-59fb8534 2026-07-16 14:05:03.420398 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-59fb8534 tst 2026-07-16 14:05:04.136216 UTC - Run: slices experiment list-resources --format json tst-59fb8534 2026-07-16 14:05:04.751491 UTC - expires_at (on expauth): 2026-07-16T18:04:00Z (correctly extended) 2026-07-16 14:05:04.751613 UTC - Testing ssh login 2026-07-16 14:05:04.764494 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-59fb8534 tst 2026-07-16 14:05:05.480337 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-59fb8534 tst 2026-07-16 14:05:06.197783 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-59fb8534 tst 2026-07-16 14:05:06.197862 UTC - Content of log file '/test_dir/bi_ssh_serverkey_STDERR.txt': No hostkeys in SSH info 2026-07-16 14:05:06.197886 UTC - Error in test step 'Check SSH pubkey (resource)': [Errno 2] No such file or directory: '/test_dir/bi_ssh_serverkey.txt' 2026-07-16 14:05:06.204424 UTC - Destroying tst-59fb8534 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-16 14:05:06.204596 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-59fb8534 tst