Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 5.45s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 413ms 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 929ms + 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-13 05:01:39.780680 UTC - Installing Slices CLI (latest stable version). 2026-07-13 05:01:39.780956 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-13 05:01:45.992036 UTC - Slices CLI installed. 2026-07-13 05:01:45.992599 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-13 05:01:45.995167 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-13 05:01:45.996858 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-13 05:01:45.997015 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-13 05:01:45.997043 UTC - Slices CLI exe: 'slices' 2026-07-13 05:01:45.997061 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-13 05:01:45.997213 UTC - Run: slices --version 2026-07-13 05:01:50.441567 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-13 05:01:50.441930 UTC - Run: slices pubkey list --format text 2026-07-13 05:01:51.565596 UTC - Pubkey already registered 2026-07-13 05:01:51.565867 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-13 05:01:52.181111 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-13 05:01:52.181207 UTC - Check List Flavors 2026-07-13 05:01:52.181372 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-07-13 05:01:53.911203 UTC - Check List DiskImages 2026-07-13 05:01:53.911393 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-07-13 05:01:55.587234 UTC - Requesting resources 2026-07-13 05:01:55.588087 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian11-min --flavor taurus --duration 2h --experiment tst-fe8d6515 2026-07-13 05:02:00.404218 UTC - Resource ID: r_fr-lyon1-bi-baremetal1_01kxcxn0dwev98vvtdmnn1fd5m 2026-07-13 05:02:00.404447 UTC - Waiting until resource ready 2026-07-13 05:02:02.404820 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-fe8d6515 tst 2026-07-13 05:02:03.330440 UTC - Status: IMAGING 2026-07-13 05:02:06.397010 UTC - Status: STARTING 2026-07-13 05:02:09.263911 UTC - Status: STARTING 2026-07-13 05:02:12.080225 UTC - Status: STARTING 2026-07-13 05:02:14.846618 UTC - Status: STARTING 2026-07-13 05:02:17.613031 UTC - Status: STARTING 2026-07-13 05:02:20.429833 UTC - Status: STARTING 2026-07-13 05:02:23.196439 UTC - Status: STARTING 2026-07-13 05:02:25.962719 UTC - Status: STARTING 2026-07-13 05:02:28.729040 UTC - Status: STARTING 2026-07-13 05:02:31.495314 UTC - Status: STARTING 2026-07-13 05:02:34.261808 UTC - Status: STARTING 2026-07-13 05:02:37.028301 UTC - Status: STARTING 2026-07-13 05:02:39.794898 UTC - Status: STARTING 2026-07-13 05:02:42.561227 UTC - Status: STARTING 2026-07-13 05:02:45.277567 UTC - Status: STARTING 2026-07-13 05:02:48.043978 UTC - Status: STARTING 2026-07-13 05:02:50.810503 UTC - Status: STARTING 2026-07-13 05:02:53.576966 UTC - Status: STARTING 2026-07-13 05:02:56.343370 UTC - Status: STARTING 2026-07-13 05:02:59.109964 UTC - Status: STARTING 2026-07-13 05:03:01.876422 UTC - Status: STARTING 2026-07-13 05:03:04.592520 UTC - Status: STARTING 2026-07-13 05:03:07.358743 UTC - Status: STARTING 2026-07-13 05:03:10.124891 UTC - Status: STARTING 2026-07-13 05:03:12.841150 UTC - Status: STARTING 2026-07-13 05:03:15.607336 UTC - Status: STARTING 2026-07-13 05:03:18.373568 UTC - Status: STARTING 2026-07-13 05:03:21.139845 UTC - Status: STARTING 2026-07-13 05:03:23.858300 UTC - Status: STARTING 2026-07-13 05:03:26.574151 UTC - Status: STARTING 2026-07-13 05:03:29.290271 UTC - Status: STARTING 2026-07-13 05:03:32.006380 UTC - Status: STARTING 2026-07-13 05:03:34.772541 UTC - Status: STARTING 2026-07-13 05:03:37.488548 UTC - Status: STARTING 2026-07-13 05:03:40.254839 UTC - Status: STARTING 2026-07-13 05:03:43.071235 UTC - Status: STARTING 2026-07-13 05:03:45.837497 UTC - Status: STARTING 2026-07-13 05:03:48.603841 UTC - Status: STARTING 2026-07-13 05:03:51.370256 UTC - Status: STARTING 2026-07-13 05:03:54.086414 UTC - Status: STARTING 2026-07-13 05:03:56.802422 UTC - Status: STARTING 2026-07-13 05:03:59.569154 UTC - Status: STARTING 2026-07-13 05:04:02.285097 UTC - Status: STARTING 2026-07-13 05:04:05.051258 UTC - Status: STARTING 2026-07-13 05:04:07.817521 UTC - Status: STARTING 2026-07-13 05:04:10.584041 UTC - Status: STARTING 2026-07-13 05:04:13.350475 UTC - Status: STARTING 2026-07-13 05:04:16.066686 UTC - Status: STARTING 2026-07-13 05:04:18.782844 UTC - Status: STARTING 2026-07-13 05:04:21.499034 UTC - Status: STARTING 2026-07-13 05:04:24.265448 UTC - Status: STARTING 2026-07-13 05:04:27.031655 UTC - Status: STARTING 2026-07-13 05:04:29.747872 UTC - Status: STARTING 2026-07-13 05:04:32.514442 UTC - Status: STARTING 2026-07-13 05:04:35.230795 UTC - Status: STARTING 2026-07-13 05:04:37.997569 UTC - Status: STARTING 2026-07-13 05:04:40.713726 UTC - Status: STARTING 2026-07-13 05:04:43.480046 UTC - Status: STARTING 2026-07-13 05:04:46.246288 UTC - Status: STARTING 2026-07-13 05:04:48.962227 UTC - Status: STARTING 2026-07-13 05:04:51.728587 UTC - Status: STARTING 2026-07-13 05:04:54.494979 UTC - Status: UP 2026-07-13 05:04:54.495080 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kxcxmz3vfd3se6chmpg5gy88 2026-07-13 05:04:54.495122 UTC - Validate resources 2026-07-13 05:04:55.262594 UTC - The fields of the created resource were validated. 2026-07-13 05:04:55.262707 UTC - Check if resources are registered in experiment 2026-07-13 05:04:55.262873 UTC - Run: slices experiment list-resources --format json tst-fe8d6515 2026-07-13 05:04:55.928817 UTC - Status (on expauth): UP 2026-07-13 05:04:55.929003 UTC - Testing extend expires_at (all resources in experiment) 2026-07-13 05:04:55.929194 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-fe8d6515 2026-07-13 05:05:01.156623 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-fe8d6515 tst 2026-07-13 05:05:01.872698 UTC - Run: slices experiment list-resources --format json tst-fe8d6515 2026-07-13 05:05:02.538315 UTC - expires_at (on expauth): 2026-07-13T08:04:00Z (correctly extended) 2026-07-13 05:05:02.538425 UTC - Testing extend expires_at (single resource in experiment) 2026-07-13 05:05:02.538566 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend tst --duration 4h --experiment tst-fe8d6515 2026-07-13 05:05:07.815888 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-fe8d6515 tst 2026-07-13 05:05:08.531856 UTC - Run: slices experiment list-resources --format json tst-fe8d6515 2026-07-13 05:05:09.197429 UTC - expires_at (on expauth): 2026-07-13T09:05:00Z (correctly extended) 2026-07-13 05:05:09.197570 UTC - Testing ssh login 2026-07-13 05:05:09.211720 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-fe8d6515 tst 2026-07-13 05:05:09.977543 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-fe8d6515 tst 2026-07-13 05:05:10.745808 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-fe8d6515 tst 2026-07-13 05:05:10.745892 UTC - Content of log file '/test_dir/bi_ssh_serverkey_STDERR.txt': No hostkeys in SSH info 2026-07-13 05:05:10.745918 UTC - Error in test step 'Check SSH pubkey (resource)': [Errno 2] No such file or directory: '/test_dir/bi_ssh_serverkey.txt' 2026-07-13 05:05:10.752538 UTC - Destroying tst-fe8d6515 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-13 05:05:10.752744 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-fe8d6515 tst