Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 3.46s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 178ms 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 224ms + 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 20:00:38.340319 UTC - Installing Slices CLI (latest stable version). 2026-07-16 20:00:38.340528 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-16 20:00:44.181648 UTC - Slices CLI installed. 2026-07-16 20:00:44.182125 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 20:00:44.185043 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 20:00:44.186130 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-16 20:00:44.186465 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 20:00:44.186520 UTC - Slices CLI exe: 'slices' 2026-07-16 20:00:44.186549 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-16 20:00:44.186697 UTC - Run: slices --version 2026-07-16 20:00:46.808456 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 20:00:46.808786 UTC - Run: slices pubkey list --format text 2026-07-16 20:00:47.674206 UTC - Pubkey already registered 2026-07-16 20:00:47.674443 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-16 20:00:48.239457 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-16 20:00:48.239548 UTC - Check List Flavors 2026-07-16 20:00:48.239686 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 flavor list -f json 2026-07-16 20:00:49.908595 UTC - Check List DiskImages 2026-07-16 20:00:49.908824 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 diskimage list -f json 2026-07-16 20:00:50.574313 UTC - Requesting resources 2026-07-16 20:00:50.574845 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-225e53df 2026-07-16 20:00:55.250717 UTC - Resource ID: r_fr-sophia2-bi-vm2_01kxp89485fr9bge1ve7jgkqc6 2026-07-16 20:00:55.250874 UTC - Waiting until resource ready 2026-07-16 20:00:57.251243 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 list-resources --format json --experiment tst-225e53df tst 2026-07-16 20:00:58.016689 UTC - Status: IMAGING 2026-07-16 20:01:00.782557 UTC - Status: BOOTING 2026-07-16 20:01:03.548691 UTC - Status: BOOTING 2026-07-16 20:01:06.315273 UTC - Status: BOOTING 2026-07-16 20:01:09.081192 UTC - Status: BOOTING 2026-07-16 20:01:11.847149 UTC - Status: BOOTING 2026-07-16 20:01:14.613006 UTC - Status: BOOTING 2026-07-16 20:01:17.379064 UTC - Status: BOOTING 2026-07-16 20:01:20.094902 UTC - Status: BOOTING 2026-07-16 20:01:22.861043 UTC - Status: UP 2026-07-16 20:01:22.861124 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kxp892n1eqqbyw25fc4synnd 2026-07-16 20:01:22.861168 UTC - Validate resources 2026-07-16 20:01:23.626940 UTC - The fields of the created resource were validated. 2026-07-16 20:01:23.627030 UTC - Check if resources are registered in experiment 2026-07-16 20:01:23.627180 UTC - Run: slices experiment list-resources --format json tst-225e53df 2026-07-16 20:01:24.242421 UTC - Status (on expauth): UP 2026-07-16 20:01:24.242557 UTC - Testing extend expires_at (all resources in experiment) 2026-07-16 20:01:24.242682 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 extend --duration 3h --experiment tst-225e53df 2026-07-16 20:01:27.062652 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 list-resources --format json --experiment tst-225e53df tst 2026-07-16 20:01:27.828552 UTC - Run: slices experiment list-resources --format json tst-225e53df 2026-07-16 20:01:28.443915 UTC - expires_at (on expauth): 2026-07-16T23:01:00Z (correctly extended) 2026-07-16 20:01:28.444011 UTC - Testing extend expires_at (single resource in experiment) 2026-07-16 20:01:28.444178 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 extend tst --duration 4h --experiment tst-225e53df 2026-07-16 20:01:31.471292 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 list-resources --format json --experiment tst-225e53df tst 2026-07-16 20:01:32.287205 UTC - Run: slices experiment list-resources --format json tst-225e53df 2026-07-16 20:01:32.902340 UTC - expires_at (on expauth): 2026-07-17T00:01:00Z (correctly extended) 2026-07-16 20:01:32.902461 UTC - Testing ssh login 2026-07-16 20:01:32.914923 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --no-exec --proxy on --show ssh_config --experiment tst-225e53df tst 2026-07-16 20:01:33.780759 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-225e53df tst 2026-07-16 20:01:34.706072 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-225e53df tst 2026-07-16 20:01:35.571796 UTC - Logging in using 'slices bi ssh' 2026-07-16 20:01:35.571878 UTC - Forcing IPv4 only. 2026-07-16 20:01:35.572005 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --show nothing --experiment tst-225e53df tst -- -4 uname -a 2026-07-16 20:01:37.941234 UTC - Forcing IPv4 only. 2026-07-16 20:01:37.941479 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --show nothing --experiment tst-225e53df tst -- -4 uptime 2026-07-16 20:01:39.658853 UTC - CLI SSH Test passed. 2026-07-16 20:01:39.658923 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-16 20:01:39.658942 UTC - Uptime: 20:01:39 up 0 min, 1 user, load average: 0.53, 0.15, 0.05 2026-07-16 20:01:39.658975 UTC - Logging in using SSH over SSH proxy 2026-07-16 20:01:39.659121 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-225e53df tst 2026-07-16 20:01:40.525166 UTC - Added paramiko HostKeyEntry for 172.28.9.225 2026-07-16 20:01:40.525358 UTC - Added paramiko HostKeyEntry for 172.28.9.225 2026-07-16 20:01:40.525415 UTC - Added paramiko HostKeyEntry for 172.28.9.225 2026-07-16 20:01:40.525681 UTC - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-07-16 20:01:40.525762 UTC - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-07-16 20:01:40.525822 UTC - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-07-16 20:01:40.525841 UTC - Connecting to proxy bastion1.theblueprintfactory.org:22 2026-07-16 20:01:40.912600 UTC - Connecting to 172.28.9.225:22 over proxy 2026-07-16 20:01:41.599844 UTC - SSH Test output: 2026-07-16 20:01:41.599930 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-16 20:01:41.599958 UTC - Uptime: 20:01:40 up 0 min, 1 user, load average: 0.48, 0.15, 0.05 2026-07-16 20:01:41.737680 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-07-16 20:01:41.737776 UTC - lsb_release matches expected value 2026-07-16 20:01:41.737799 UTC - SSH Test passed. 2026-07-16 20:01:41.745492 UTC - Destroying tst-225e53df tst 2026-07-16 20:01:41.745711 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 destroy --experiment tst-225e53df tst