Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 12.08s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 721ms 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 760ms + 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 04:02:24.180028 UTC - Installing Slices CLI (latest stable version). 2026-07-11 04:02:24.180977 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-11 04:02:53.246800 UTC - Slices CLI installed. 2026-07-11 04:02:53.251266 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 04:02:53.252690 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 04:02:53.253869 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-11 04:02:53.254035 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 04:02:53.254066 UTC - Slices CLI exe: 'slices' 2026-07-11 04:02:53.254086 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-11 04:02:53.254224 UTC - Run: slices --version 2026-07-11 04:03:04.224469 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 04:03:04.228857 UTC - Run: slices pubkey list --format text 2026-07-11 04:03:06.467049 UTC - Pubkey already registered 2026-07-11 04:03:06.467317 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-11 04:03:08.011888 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-11 04:03:08.012933 UTC - Check List Flavors 2026-07-11 04:03:08.013145 UTC - Run: slices bi --infra fr-sophia2-bi-vm1 flavor list -f json 2026-07-11 04:03:10.348678 UTC - Check List DiskImages 2026-07-11 04:03:10.349107 UTC - Run: slices bi --infra fr-sophia2-bi-vm1 diskimage list -f json 2026-07-11 04:03:11.217484 UTC - Requesting resources 2026-07-11 04:03:11.218436 UTC - Run: slices bi --infra fr-sophia2-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-0e9ee498 2026-07-11 04:03:14.954780 UTC - Resource ID: r_fr-sophia2-bi-vm1_01kx7nfzghfp9a5kcjc5pvb1ft 2026-07-11 04:03:14.954952 UTC - Waiting until resource ready 2026-07-11 04:03:16.955299 UTC - Run: slices bi --infra fr-sophia2-bi-vm1 list-resources --format json --experiment tst-0e9ee498 tst 2026-07-11 04:03:20.104160 UTC - Status: BOOTING 2026-07-11 04:03:25.247621 UTC - Status: BOOTING 2026-07-11 04:03:28.617333 UTC - Status: BOOTING 2026-07-11 04:03:32.631174 UTC - Status: BOOTING 2026-07-11 04:03:37.247779 UTC - Status: UP 2026-07-11 04:03:37.247871 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kx7nfybgfj199hd87qvcb0q4 2026-07-11 04:03:37.247923 UTC - Validate resources 2026-07-11 04:03:39.207522 UTC - The fields of the created resource were validated. 2026-07-11 04:03:39.207633 UTC - Check if resources are registered in experiment 2026-07-11 04:03:39.207806 UTC - Run: slices experiment list-resources --format json tst-0e9ee498 2026-07-11 04:03:40.762378 UTC - Status (on expauth): UP 2026-07-11 04:03:40.762544 UTC - Testing extend expires_at (all resources in experiment) 2026-07-11 04:03:40.762685 UTC - Run: slices bi --infra fr-sophia2-bi-vm1 extend --duration 3h --experiment tst-0e9ee498 2026-07-11 04:03:43.901098 UTC - Run: slices bi --infra fr-sophia2-bi-vm1 list-resources --format json --experiment tst-0e9ee498 tst 2026-07-11 04:03:45.197179 UTC - Run: slices experiment list-resources --format json tst-0e9ee498 2026-07-11 04:03:46.674318 UTC - expires_at (on expauth): 2026-07-11T07:03:00Z (correctly extended) 2026-07-11 04:03:46.674420 UTC - Testing extend expires_at (single resource in experiment) 2026-07-11 04:03:46.674552 UTC - Run: slices bi --infra fr-sophia2-bi-vm1 extend tst --duration 4h --experiment tst-0e9ee498 2026-07-11 04:03:49.883124 UTC - Run: slices bi --infra fr-sophia2-bi-vm1 list-resources --format json --experiment tst-0e9ee498 tst 2026-07-11 04:03:52.006833 UTC - Run: slices experiment list-resources --format json tst-0e9ee498 2026-07-11 04:03:53.638559 UTC - expires_at (on expauth): 2026-07-11T08:03:00Z (correctly extended) 2026-07-11 04:03:53.646098 UTC - Testing ssh login 2026-07-11 04:03:53.686345 UTC - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-0e9ee498 tst 2026-07-11 04:03:55.678475 UTC - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-0e9ee498 tst 2026-07-11 04:03:57.820356 UTC - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-0e9ee498 tst 2026-07-11 04:04:00.139548 UTC - Logging in using 'slices bi ssh' 2026-07-11 04:04:00.139877 UTC - Forcing IPv4 only. 2026-07-11 04:04:00.140063 UTC - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --show nothing --experiment tst-0e9ee498 tst -- -4 uname -a 2026-07-11 04:04:03.912472 UTC - Forcing IPv4 only. 2026-07-11 04:04:03.912684 UTC - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --show nothing --experiment tst-0e9ee498 tst -- -4 uptime 2026-07-11 04:04:06.211680 UTC - CLI SSH Test passed. 2026-07-11 04:04:06.211760 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 04:04:06.211780 UTC - Uptime: 04:04:06 up 0 min, 1 user, load average: 0.12, 0.03, 0.01 2026-07-11 04:04:06.211816 UTC - Logging in using SSH over SSH proxy 2026-07-11 04:04:06.211967 UTC - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-0e9ee498 tst 2026-07-11 04:04:07.897055 UTC - Added paramiko HostKeyEntry for 10.123.158.56 2026-07-11 04:04:07.897286 UTC - Added paramiko HostKeyEntry for 10.123.158.56 2026-07-11 04:04:07.897354 UTC - Added paramiko HostKeyEntry for 10.123.158.56 2026-07-11 04:04:07.898926 UTC - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-07-11 04:04:07.899050 UTC - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-07-11 04:04:07.899097 UTC - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-07-11 04:04:07.899114 UTC - Connecting to proxy bastion1.theblueprintfactory.org:22 2026-07-11 04:04:08.287873 UTC - Connecting to 10.123.158.56:22 over proxy 2026-07-11 04:04:08.953116 UTC - SSH Test output: 2026-07-11 04:04:08.953190 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 04:04:08.953213 UTC - Uptime: 04:04:08 up 0 min, 1 user, load average: 0.11, 0.03, 0.01 2026-07-11 04:04:09.088440 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-07-11 04:04:09.088525 UTC - lsb_release matches expected value 2026-07-11 04:04:09.088545 UTC - SSH Test passed. 2026-07-11 04:04:09.109280 UTC - Destroying tst-0e9ee498 tst 2026-07-11 04:04:09.109815 UTC - Run: slices bi --infra fr-sophia2-bi-vm1 destroy --experiment tst-0e9ee498 tst