Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 28.44s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 410ms 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 703ms + 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.dev179+g419876b58 (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-09 06:03:06.791399 UTC - Installing Slices CLI (latest stable version). 2026-07-09 06:03:06.791656 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-09 06:03:14.306977 UTC - Slices CLI installed. 2026-07-09 06:03:14.307805 UTC - Slices CLI exe: 'slices' 2026-07-09 06:03:14.307848 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-09 06:03:14.307992 UTC - Run: slices --version 2026-07-09 06:03:22.159566 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-09 06:03:22.159889 UTC - Run: slices pubkey list --format text 2026-07-09 06:03:24.112528 UTC - Pubkey already registered 2026-07-09 06:03:24.112851 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-09 06:03:26.113528 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-09 06:03:26.113661 UTC - Check List Flavors 2026-07-09 06:03:26.113815 UTC - Run: slices bi --infra ch-geneva-bi-vm1 flavor list -f json 2026-07-09 06:03:28.756558 UTC - Check List DiskImages 2026-07-09 06:03:28.757108 UTC - Run: slices bi --infra ch-geneva-bi-vm1 diskimage list -f json 2026-07-09 06:03:31.408931 UTC - Requesting resources 2026-07-09 06:03:31.409476 UTC - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-07-09 06:03:31.409598 UTC - Run: slices bi --infra ch-geneva-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-4890c440 --user-data /tmp/tmpwwgnrwew 2026-07-09 06:03:35.434330 UTC - Resource ID: r_ch-geneva-bi-vm1_01kx2qjwzfe90sxkbsya4sj67r 2026-07-09 06:03:35.435363 UTC - Waiting until resource ready 2026-07-09 06:03:37.435726 UTC - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-4890c440 tst 2026-07-09 06:03:39.650873 UTC - Status: IMAGING 2026-07-09 06:03:44.920026 UTC - Status: IMAGING 2026-07-09 06:03:49.231114 UTC - Status: IMAGING 2026-07-09 06:03:53.231297 UTC - Status: IMAGING 2026-07-09 06:03:57.411438 UTC - Status: IMAGING 2026-07-09 06:04:01.217422 UTC - Status: IMAGING 2026-07-09 06:04:04.442153 UTC - Status: IMAGING 2026-07-09 06:04:07.820436 UTC - Status: IMAGING 2026-07-09 06:04:11.295875 UTC - Status: IMAGING 2026-07-09 06:04:15.099693 UTC - Status: IMAGING 2026-07-09 06:04:18.177388 UTC - Status: IMAGING 2026-07-09 06:04:21.104957 UTC - Status: IMAGING 2026-07-09 06:04:23.872236 UTC - Status: IMAGING 2026-07-09 06:04:26.738399 UTC - Status: IMAGING 2026-07-09 06:04:29.505317 UTC - Status: IMAGING 2026-07-09 06:04:32.271323 UTC - Status: IMAGING 2026-07-09 06:04:35.037380 UTC - Status: IMAGING 2026-07-09 06:04:37.803682 UTC - Status: IMAGING 2026-07-09 06:04:40.619972 UTC - Status: IMAGING 2026-07-09 06:04:43.387884 UTC - Status: IMAGING 2026-07-09 06:04:46.153814 UTC - Status: IMAGING 2026-07-09 06:04:48.969982 UTC - Status: IMAGING 2026-07-09 06:04:51.735805 UTC - Status: IMAGING 2026-07-09 06:04:54.502148 UTC - Status: IMAGING 2026-07-09 06:04:57.269517 UTC - Status: IMAGING 2026-07-09 06:04:59.985170 UTC - Status: IMAGING 2026-07-09 06:05:02.751488 UTC - Status: IMAGING 2026-07-09 06:05:05.517497 UTC - Status: IMAGING 2026-07-09 06:05:08.333869 UTC - Status: IMAGING 2026-07-09 06:05:11.150191 UTC - Status: IMAGING 2026-07-09 06:05:13.967765 UTC - Status: IMAGING 2026-07-09 06:05:16.734282 UTC - Status: IMAGING 2026-07-09 06:05:19.500283 UTC - Status: IMAGING 2026-07-09 06:05:22.316758 UTC - Status: IMAGING 2026-07-09 06:05:25.083727 UTC - Status: IMAGING 2026-07-09 06:05:27.850233 UTC - Status: UP 2026-07-09 06:05:27.850344 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kx2qjw6bfhetzra4ksszzwv5 2026-07-09 06:05:27.850393 UTC - Validate resources 2026-07-09 06:05:28.618438 UTC - "slices bi list-resources" returned resource without private IPv4 address, but with a public IPv4 address. As test_allow_public_ipv4_instead_of_private is set, that is acceptable. 2026-07-09 06:05:28.618510 UTC - The fields of the created resource were validated. 2026-07-09 06:05:28.618546 UTC - Check if resources are registered in experiment 2026-07-09 06:05:28.618695 UTC - Run: slices experiment list-resources --format json tst-4890c440 2026-07-09 06:05:29.283956 UTC - Status (on expauth): UP 2026-07-09 06:05:29.284112 UTC - Testing extend expires_at (all resources in experiment) 2026-07-09 06:05:29.284272 UTC - Run: slices bi --infra ch-geneva-bi-vm1 extend --duration 3h --experiment tst-4890c440 2026-07-09 06:05:31.938789 UTC - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-4890c440 tst 2026-07-09 06:05:33.153519 UTC - Run: slices experiment list-resources --format json tst-4890c440 2026-07-09 06:05:33.929365 UTC - expires_at (on expauth): 2026-07-09T09:05:00Z (correctly extended) 2026-07-09 06:05:33.929480 UTC - Testing extend expires_at (single resource in experiment) 2026-07-09 06:05:33.929682 UTC - Run: slices bi --infra ch-geneva-bi-vm1 extend tst --duration 4h --experiment tst-4890c440 2026-07-09 06:05:36.672205 UTC - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-4890c440 tst 2026-07-09 06:05:37.799395 UTC - Run: slices experiment list-resources --format json tst-4890c440 2026-07-09 06:05:38.622273 UTC - expires_at (on expauth): 2026-07-09T10:05:00Z (correctly extended) 2026-07-09 06:05:38.622478 UTC - Testing ssh login 2026-07-09 06:05:38.662933 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-4890c440 tst 2026-07-09 06:05:39.530537 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-4890c440 tst 2026-07-09 06:05:40.927242 UTC - Logging in using 'slices bi ssh' 2026-07-09 06:05:40.927332 UTC - Forcing IPv4 only. 2026-07-09 06:05:40.927471 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --show nothing --experiment tst-4890c440 tst -- -4 uname -a 2026-07-09 06:05:45.221917 UTC - Forcing IPv4 only. 2026-07-09 06:05:45.222289 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --show nothing --experiment tst-4890c440 tst -- -4 uptime 2026-07-09 06:05:47.315838 UTC - CLI SSH Test passed. 2026-07-09 06:05:47.320093 UTC - Uname: Linux 2c1f459e-c69b-436f-aa4f-b148d22ca810-b6fa97cc-9ea7-4f9b-9541-f0 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-09 06:05:47.320208 UTC - Uptime: 06:05:47 up 1 min, 1 user, load average: 0.10, 0.04, 0.01 2026-07-09 06:05:47.320275 UTC - Logging in using SSH (no SSH proxy in Resource) 2026-07-09 06:05:47.320898 UTC - Added paramiko HostKeyEntry for 5.53.108.185 2026-07-09 06:05:47.321033 UTC - Added paramiko HostKeyEntry for 5.53.108.185 2026-07-09 06:05:47.321228 UTC - Added paramiko HostKeyEntry for 5.53.108.185 2026-07-09 06:05:47.321467 UTC - Connecting to 5.53.108.185:22 2026-07-09 06:05:47.876859 UTC - SSH Test output: 2026-07-09 06:05:47.876948 UTC - Uname: Linux 2c1f459e-c69b-436f-aa4f-b148d22ca810-b6fa97cc-9ea7-4f9b-9541-f0 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-09 06:05:47.876973 UTC - Uptime: 06:05:47 up 1 min, 1 user, load average: 0.10, 0.04, 0.01 2026-07-09 06:05:47.977749 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-07-09 06:05:47.977834 UTC - lsb_release matches expected value 2026-07-09 06:05:47.977856 UTC - SSH Test passed. 2026-07-09 06:05:48.072148 UTC - Cloud-init user-data: Hello World. The time is now Thu, 09 Jul 2026 06:05:10 +0000! 2026-07-09 06:05:48.072306 UTC - Skip SSH proxy test because no jump proxy 2026-07-09 06:05:48.080899 UTC - Destroying tst-4890c440 tst 2026-07-09 06:05:48.081078 UTC - Run: slices bi --infra ch-geneva-bi-vm1 destroy --experiment tst-4890c440 tst