Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 5.98s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 183ms 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 334ms + annotated-types==0.7.0 + anyio==4.14.1 + 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-11 20:00:52.876590 UTC - Installing Slices CLI (latest stable version). 2026-07-11 20:00:52.876882 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-11 20:01:02.815410 UTC - Slices CLI installed. 2026-07-11 20:01:02.815599 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-11 20:01:02.818367 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-11 20:01:02.819412 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-11 20:01:02.819558 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-11 20:01:02.819596 UTC - Slices CLI exe: 'slices' 2026-07-11 20:01:02.819614 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-11 20:01:02.819768 UTC - Run: slices --version 2026-07-11 20:01:05.639739 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-11 20:01:05.640000 UTC - Run: slices pubkey list --format text 2026-07-11 20:01:06.405164 UTC - Pubkey already registered 2026-07-11 20:01:06.405391 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-11 20:01:07.070515 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-11 20:01:07.070635 UTC - Check List Flavors 2026-07-11 20:01:07.070775 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 flavor list -f json 2026-07-11 20:01:08.437424 UTC - Check List DiskImages 2026-07-11 20:01:08.437629 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 diskimage list -f json 2026-07-11 20:01:09.153013 UTC - Requesting resources 2026-07-11 20:01:09.153528 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-7d8b5f78 2026-07-11 20:01:12.724396 UTC - Resource ID: r_fr-sophia2-bi-vm2_01kx9ca2awfcssafmczwphm30m 2026-07-11 20:01:12.724565 UTC - Waiting until resource ready 2026-07-11 20:01:14.725031 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 list-resources --format json --experiment tst-7d8b5f78 tst 2026-07-11 20:01:15.490876 UTC - Status: IMAGING 2026-07-11 20:01:18.256828 UTC - Status: BOOTING 2026-07-11 20:01:21.072887 UTC - Status: BOOTING 2026-07-11 20:01:23.897058 UTC - Status: BOOTING 2026-07-11 20:01:26.763258 UTC - Status: BOOTING 2026-07-11 20:01:29.629186 UTC - Status: BOOTING 2026-07-11 20:01:32.395136 UTC - Status: BOOTING 2026-07-11 20:01:35.164301 UTC - Status: BOOTING 2026-07-11 20:01:37.930471 UTC - Status: UP 2026-07-11 20:01:37.930560 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kx9ca0zdfe0sc880t4d29hxk 2026-07-11 20:01:37.930601 UTC - Validate resources 2026-07-11 20:01:38.698881 UTC - The fields of the created resource were validated. 2026-07-11 20:01:38.698977 UTC - Check if resources are registered in experiment 2026-07-11 20:01:38.699136 UTC - Run: slices experiment list-resources --format json tst-7d8b5f78 2026-07-11 20:01:39.314474 UTC - Status (on expauth): UP 2026-07-11 20:01:39.314631 UTC - Testing extend expires_at (all resources in experiment) 2026-07-11 20:01:39.314761 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 extend --duration 3h --experiment tst-7d8b5f78 2026-07-11 20:01:41.934940 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 list-resources --format json --experiment tst-7d8b5f78 tst 2026-07-11 20:01:42.700825 UTC - Run: slices experiment list-resources --format json tst-7d8b5f78 2026-07-11 20:01:43.316024 UTC - expires_at (on expauth): 2026-07-11T23:01:00Z (correctly extended) 2026-07-11 20:01:43.316115 UTC - Testing extend expires_at (single resource in experiment) 2026-07-11 20:01:43.316250 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 extend tst --duration 4h --experiment tst-7d8b5f78 2026-07-11 20:01:45.835722 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 list-resources --format json --experiment tst-7d8b5f78 tst 2026-07-11 20:01:46.651539 UTC - Run: slices experiment list-resources --format json tst-7d8b5f78 2026-07-11 20:01:47.266751 UTC - expires_at (on expauth): 2026-07-12T00:01:00Z (correctly extended) 2026-07-11 20:01:47.266908 UTC - Testing ssh login 2026-07-11 20:01:47.279509 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --no-exec --proxy on --show ssh_config --experiment tst-7d8b5f78 tst 2026-07-11 20:01:48.195422 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-7d8b5f78 tst 2026-07-11 20:01:49.061161 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-7d8b5f78 tst 2026-07-11 20:01:49.927080 UTC - Logging in using 'slices bi ssh' 2026-07-11 20:01:49.927157 UTC - Forcing IPv4 only. 2026-07-11 20:01:49.927293 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --show nothing --experiment tst-7d8b5f78 tst -- -4 uname -a 2026-07-11 20:01:52.354740 UTC - Forcing IPv4 only. 2026-07-11 20:01:52.354969 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --show nothing --experiment tst-7d8b5f78 tst -- -4 uptime 2026-07-11 20:01:54.072573 UTC - CLI SSH Test passed. 2026-07-11 20:01:54.072650 UTC - Uname: Linux tst 6.8.0-85-generic #85-Ubuntu SMP PREEMPT_DYNAMIC Thu Sep 18 15:26:59 UTC 2025 x86_64 x86_64 x86_64 GNU/Linux 2026-07-11 20:01:54.072670 UTC - Uptime: 20:01:53 up 0 min, 1 user, load average: 0.64, 0.16, 0.05 2026-07-11 20:01:54.072704 UTC - Logging in using SSH over SSH proxy 2026-07-11 20:01:54.072874 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-7d8b5f78 tst 2026-07-11 20:01:54.939035 UTC - Added paramiko HostKeyEntry for 172.28.10.150 2026-07-11 20:01:54.939231 UTC - Added paramiko HostKeyEntry for 172.28.10.150 2026-07-11 20:01:54.939290 UTC - Added paramiko HostKeyEntry for 172.28.10.150 2026-07-11 20:01:54.939584 UTC - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-07-11 20:01:54.939692 UTC - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-07-11 20:01:54.939750 UTC - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-07-11 20:01:54.939780 UTC - Connecting to proxy bastion1.theblueprintfactory.org:22 2026-07-11 20:01:55.315817 UTC - Connecting to 172.28.10.150:22 over proxy 2026-07-11 20:01:55.985244 UTC - SSH Test output: 2026-07-11 20:01:55.985336 UTC - Uname: Linux tst 6.8.0-85-generic #85-Ubuntu SMP PREEMPT_DYNAMIC Thu Sep 18 15:26:59 UTC 2025 x86_64 x86_64 x86_64 GNU/Linux 2026-07-11 20:01:55.985363 UTC - Uptime: 20:01:54 up 0 min, 1 user, load average: 0.64, 0.16, 0.05 2026-07-11 20:01:56.120931 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-07-11 20:01:56.121053 UTC - lsb_release matches expected value 2026-07-11 20:01:56.121086 UTC - SSH Test passed. 2026-07-11 20:01:56.131959 UTC - Destroying tst-7d8b5f78 tst 2026-07-11 20:01:56.132211 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 destroy --experiment tst-7d8b5f78 tst