Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 6.34s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 257ms 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 742ms + 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.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-24 21:02:35.707540 UTC - Installing Slices CLI (latest stable version). 2026-07-24 21:02:35.707768 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-24 21:02:41.844621 UTC - Slices CLI installed. 2026-07-24 21:02:41.845054 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-24 21:02:41.847295 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-24 21:02:41.848360 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-24 21:02:41.848495 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-24 21:02:41.848523 UTC - Slices CLI exe: 'slices' 2026-07-24 21:02:41.848540 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-24 21:02:41.848657 UTC - Run: slices --version 2026-07-24 21:02:45.261703 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-24 21:02:45.262043 UTC - Run: slices pubkey list --format text 2026-07-24 21:02:46.909148 UTC - Pubkey already registered 2026-07-24 21:02:46.909404 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-24 21:02:47.930680 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-24 21:02:47.930776 UTC - Check List Flavors 2026-07-24 21:02:47.930936 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-07-24 21:02:49.367173 UTC - Check List DiskImages 2026-07-24 21:02:49.367351 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-07-24 21:02:50.459697 UTC - Requesting resources 2026-07-24 21:02:50.460212 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian11-min --flavor taurus --duration 2h --experiment tst-fafee87e 2026-07-24 21:02:51.932799 UTC - Resource ID: r_fr-lyon1-bi-baremetal1_01kyaz09tjf78sn9rdchax77nh 2026-07-24 21:02:51.932973 UTC - Waiting until resource ready 2026-07-24 21:02:53.933445 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-fafee87e tst 2026-07-24 21:02:55.419350 UTC - Status: IMAGING 2026-07-24 21:02:58.185269 UTC - Status: IMAGING 2026-07-24 21:03:01.052375 UTC - Status: STARTING 2026-07-24 21:03:04.445796 UTC - Status: STARTING 2026-07-24 21:03:07.567054 UTC - Status: STARTING 2026-07-24 21:03:10.334676 UTC - Status: STARTING 2026-07-24 21:03:13.549491 UTC - Status: STARTING 2026-07-24 21:03:16.681583 UTC - Status: STARTING 2026-07-24 21:03:19.709323 UTC - Status: STARTING 2026-07-24 21:03:22.735312 UTC - Status: STARTING 2026-07-24 21:03:25.503689 UTC - Status: STARTING 2026-07-24 21:03:28.219609 UTC - Status: STARTING 2026-07-24 21:03:30.985660 UTC - Status: STARTING 2026-07-24 21:03:33.701439 UTC - Status: STARTING 2026-07-24 21:03:36.417393 UTC - Status: STARTING 2026-07-24 21:03:39.133525 UTC - Status: STARTING 2026-07-24 21:03:41.899719 UTC - Status: STARTING 2026-07-24 21:03:44.666174 UTC - Status: STARTING 2026-07-24 21:03:47.388799 UTC - Status: STARTING 2026-07-24 21:03:50.104837 UTC - Status: STARTING 2026-07-24 21:03:52.870836 UTC - Status: STARTING 2026-07-24 21:03:55.593024 UTC - Status: STARTING 2026-07-24 21:03:58.409446 UTC - Status: STARTING 2026-07-24 21:04:01.175428 UTC - Status: STARTING 2026-07-24 21:04:03.941450 UTC - Status: STARTING 2026-07-24 21:04:06.657300 UTC - Status: STARTING 2026-07-24 21:04:09.373384 UTC - Status: STARTING 2026-07-24 21:04:12.142747 UTC - Status: STARTING 2026-07-24 21:04:14.858571 UTC - Status: STARTING 2026-07-24 21:04:17.574636 UTC - Status: STARTING 2026-07-24 21:04:20.340592 UTC - Status: STARTING 2026-07-24 21:04:23.056569 UTC - Status: STARTING 2026-07-24 21:04:25.772562 UTC - Status: STARTING 2026-07-24 21:04:28.541675 UTC - Status: STARTING 2026-07-24 21:04:31.307593 UTC - Status: STARTING 2026-07-24 21:04:34.073511 UTC - Status: STARTING 2026-07-24 21:04:36.790145 UTC - Status: STARTING 2026-07-24 21:04:39.560111 UTC - Status: STARTING 2026-07-24 21:04:42.276497 UTC - Status: STARTING 2026-07-24 21:04:45.042426 UTC - Status: STARTING 2026-07-24 21:04:47.758572 UTC - Status: STARTING 2026-07-24 21:04:50.624681 UTC - Status: STARTING 2026-07-24 21:04:53.342250 UTC - Status: STARTING 2026-07-24 21:04:56.108320 UTC - Status: STARTING 2026-07-24 21:04:58.980132 UTC - Status: STARTING 2026-07-24 21:05:01.846648 UTC - Status: STARTING 2026-07-24 21:05:04.562974 UTC - Status: STARTING 2026-07-24 21:05:07.337097 UTC - Status: STARTING 2026-07-24 21:05:10.203394 UTC - Status: STARTING 2026-07-24 21:05:12.919829 UTC - Status: STARTING 2026-07-24 21:05:15.636047 UTC - Status: STARTING 2026-07-24 21:05:18.351948 UTC - Status: STARTING 2026-07-24 21:05:21.068214 UTC - Status: STARTING 2026-07-24 21:05:24.061132 UTC - Status: STARTING 2026-07-24 21:05:26.978991 UTC - Status: STARTING 2026-07-24 21:05:30.009378 UTC - Status: STARTING 2026-07-24 21:05:33.241641 UTC - Status: STARTING 2026-07-24 21:05:36.947148 UTC - Status: STARTING 2026-07-24 21:05:40.401863 UTC - Status: STARTING 2026-07-24 21:05:43.578559 UTC - Status: STARTING 2026-07-24 21:05:47.259221 UTC - Status: UP 2026-07-24 21:05:47.316397 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kyaz09d2ftk9b3x6rgk7c3n3 2026-07-24 21:05:47.316568 UTC - Validate resources 2026-07-24 21:05:48.487618 UTC - The fields of the created resource were validated. 2026-07-24 21:05:48.487720 UTC - Check if resources are registered in experiment 2026-07-24 21:05:48.487895 UTC - Run: slices experiment list-resources --format json tst-fafee87e 2026-07-24 21:05:49.835173 UTC - Status (on expauth): UP 2026-07-24 21:05:49.835337 UTC - Testing extend expires_at (all resources in experiment) 2026-07-24 21:05:49.835475 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-fafee87e 2026-07-24 21:05:53.742352 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-fafee87e tst 2026-07-24 21:05:54.458031 UTC - Run: slices experiment list-resources --format json tst-fafee87e 2026-07-24 21:05:55.223358 UTC - expires_at (on expauth): 2026-07-25T00:05:00Z (correctly extended) 2026-07-24 21:05:55.223472 UTC - Testing extend expires_at (single resource in experiment) 2026-07-24 21:05:55.223625 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend tst --duration 4h --experiment tst-fafee87e 2026-07-24 21:05:58.945754 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-fafee87e tst 2026-07-24 21:05:59.762395 UTC - Run: slices experiment list-resources --format json tst-fafee87e 2026-07-24 21:06:00.582032 UTC - expires_at (on expauth): 2026-07-25T01:05:00Z (correctly extended) 2026-07-24 21:06:00.582398 UTC - Testing ssh login 2026-07-24 21:06:00.609039 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-fafee87e tst 2026-07-24 21:06:01.801385 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-fafee87e tst 2026-07-24 21:06:02.986995 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-fafee87e tst 2026-07-24 21:06:02.987078 UTC - Content of log file '/test_dir/bi_ssh_serverkey_STDERR.txt': No hostkeys in SSH info 2026-07-24 21:06:02.987102 UTC - Error in test step 'Check SSH pubkey (resource)': [Errno 2] No such file or directory: '/test_dir/bi_ssh_serverkey.txt' 2026-07-24 21:06:02.995384 UTC - Destroying tst-fafee87e 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-24 21:06:02.995564 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-fafee87e tst