Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 8.03s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 878ms 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 1.77s + 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:07:24.427470 UTC - Installing Slices CLI (latest stable version). 2026-07-11 04:07:24.427710 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-11 04:07:53.613531 UTC - Slices CLI installed. 2026-07-11 04:07:53.619115 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:07:53.620855 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:07:53.621970 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-11 04:07:53.622099 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:07:53.622126 UTC - Slices CLI exe: 'slices' 2026-07-11 04:07:53.622143 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-11 04:07:53.622426 UTC - Run: slices --version 2026-07-11 04:07:58.719366 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:07:58.719707 UTC - Run: slices pubkey list --format text 2026-07-11 04:08:00.825448 UTC - Pubkey already registered 2026-07-11 04:08:00.825729 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-11 04:08:02.673221 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-11 04:08:02.673335 UTC - Check List Flavors 2026-07-11 04:08:02.673501 UTC - Run: slices bi --infra ch-geneva-bi-vm1 flavor list -f json 2026-07-11 04:08:05.144104 UTC - Check List DiskImages 2026-07-11 04:08:05.144309 UTC - Run: slices bi --infra ch-geneva-bi-vm1 diskimage list -f json 2026-07-11 04:08:06.365213 UTC - Requesting resources 2026-07-11 04:08:06.366103 UTC - Run: slices bi --infra ch-geneva-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-9a52f5db 2026-07-11 04:08:10.546011 UTC - Resource ID: r_ch-geneva-bi-vm1_01kx7ns06tf40swxeqsjpx15ky 2026-07-11 04:08:10.546244 UTC - Waiting until resource ready 2026-07-11 04:08:12.546685 UTC - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-9a52f5db tst 2026-07-11 04:08:14.668281 UTC - Status: IMAGING 2026-07-11 04:08:18.714412 UTC - Status: IMAGING 2026-07-11 04:08:22.531206 UTC - Status: IMAGING 2026-07-11 04:08:25.498963 UTC - Status: IMAGING 2026-07-11 04:08:29.323234 UTC - Status: IMAGING 2026-07-11 04:08:32.318012 UTC - Status: IMAGING 2026-07-11 04:08:36.009139 UTC - Status: IMAGING 2026-07-11 04:08:39.360766 UTC - Status: IMAGING 2026-07-11 04:08:42.765391 UTC - Status: IMAGING 2026-07-11 04:08:46.511568 UTC - Status: IMAGING 2026-07-11 04:08:50.098817 UTC - Status: IMAGING 2026-07-11 04:08:53.135211 UTC - Status: IMAGING 2026-07-11 04:08:56.426275 UTC - Status: IMAGING 2026-07-11 04:09:00.151232 UTC - Status: IMAGING 2026-07-11 04:09:03.118190 UTC - Status: IMAGING 2026-07-11 04:09:06.489232 UTC - Status: IMAGING 2026-07-11 04:09:10.055232 UTC - Status: IMAGING 2026-07-11 04:09:12.821641 UTC - Status: IMAGING 2026-07-11 04:09:15.843864 UTC - Status: IMAGING 2026-07-11 04:09:19.362398 UTC - Status: IMAGING 2026-07-11 04:09:22.129184 UTC - Status: IMAGING 2026-07-11 04:09:24.945223 UTC - Status: IMAGING 2026-07-11 04:09:27.761927 UTC - Status: IMAGING 2026-07-11 04:09:30.911208 UTC - Status: IMAGING 2026-07-11 04:09:34.030787 UTC - Status: IMAGING 2026-07-11 04:09:37.297133 UTC - Status: IMAGING 2026-07-11 04:09:40.527852 UTC - Status: IMAGING 2026-07-11 04:09:43.973371 UTC - Status: IMAGING 2026-07-11 04:09:47.723218 UTC - Status: IMAGING 2026-07-11 04:09:50.540387 UTC - Status: IMAGING 2026-07-11 04:09:53.608787 UTC - Status: IMAGING 2026-07-11 04:09:56.475596 UTC - Status: IMAGING 2026-07-11 04:09:59.657213 UTC - Status: IMAGING 2026-07-11 04:10:02.524841 UTC - Status: UP 2026-07-11 04:10:02.524939 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kx7nryz5evwbr47ar3qxb4qn 2026-07-11 04:10:02.524987 UTC - Validate resources 2026-07-11 04:10:03.391487 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-11 04:10:03.391565 UTC - The fields of the created resource were validated. 2026-07-11 04:10:03.391604 UTC - Check if resources are registered in experiment 2026-07-11 04:10:03.391756 UTC - Run: slices experiment list-resources --format json tst-9a52f5db 2026-07-11 04:10:04.058064 UTC - Status (on expauth): UP 2026-07-11 04:10:04.058266 UTC - Testing extend expires_at (all resources in experiment) 2026-07-11 04:10:04.058435 UTC - Run: slices bi --infra ch-geneva-bi-vm1 extend --duration 3h --experiment tst-9a52f5db 2026-07-11 04:10:07.138320 UTC - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-9a52f5db tst 2026-07-11 04:10:08.310803 UTC - Run: slices experiment list-resources --format json tst-9a52f5db 2026-07-11 04:10:09.401453 UTC - expires_at (on expauth): 2026-07-11T07:10:00Z (correctly extended) 2026-07-11 04:10:09.401559 UTC - Testing extend expires_at (single resource in experiment) 2026-07-11 04:10:09.401707 UTC - Run: slices bi --infra ch-geneva-bi-vm1 extend tst --duration 4h --experiment tst-9a52f5db 2026-07-11 04:10:12.553763 UTC - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-9a52f5db tst 2026-07-11 04:10:13.419790 UTC - Run: slices experiment list-resources --format json tst-9a52f5db 2026-07-11 04:10:14.185619 UTC - expires_at (on expauth): 2026-07-11T08:10:00Z (correctly extended) 2026-07-11 04:10:14.185762 UTC - Testing ssh login 2026-07-11 04:10:14.199907 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-9a52f5db tst 2026-07-11 04:10:15.066150 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-9a52f5db tst 2026-07-11 04:10:15.982776 UTC - Logging in using 'slices bi ssh' 2026-07-11 04:10:15.982860 UTC - Forcing IPv4 only. 2026-07-11 04:10:15.983026 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --show nothing --experiment tst-9a52f5db tst -- -4 uname -a 2026-07-11 04:10:19.154813 UTC - Forcing IPv4 only. 2026-07-11 04:10:19.155033 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --show nothing --experiment tst-9a52f5db tst -- -4 uptime 2026-07-11 04:10:20.421978 UTC - CLI SSH Test passed. 2026-07-11 04:10:20.422088 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-11 04:10:20.422117 UTC - Uptime: 04:10:20 up 1 min, 1 user, load average: 0.19, 0.06, 0.02 2026-07-11 04:10:20.422172 UTC - Logging in using SSH (no SSH proxy in Resource) 2026-07-11 04:10:20.422873 UTC - Added paramiko HostKeyEntry for 5.53.108.35 2026-07-11 04:10:20.423045 UTC - Added paramiko HostKeyEntry for 5.53.108.35 2026-07-11 04:10:20.423213 UTC - Added paramiko HostKeyEntry for 5.53.108.35 2026-07-11 04:10:20.423424 UTC - Connecting to 5.53.108.35:22 2026-07-11 04:10:20.979543 UTC - SSH Test output: 2026-07-11 04:10:20.979625 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-11 04:10:20.979648 UTC - Uptime: 04:10:20 up 1 min, 1 user, load average: 0.19, 0.06, 0.02 2026-07-11 04:10:21.077879 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-07-11 04:10:21.077989 UTC - lsb_release matches expected value 2026-07-11 04:10:21.078012 UTC - SSH Test passed. 2026-07-11 04:10:21.078124 UTC - Skip SSH proxy test because no jump proxy 2026-07-11 04:10:21.086004 UTC - Destroying tst-9a52f5db tst 2026-07-11 04:10:21.086211 UTC - Run: slices bi --infra ch-geneva-bi-vm1 destroy --experiment tst-9a52f5db tst