Test run: - Start at Tue Sep 22 20:09:40 UTC 2026 - Docker image: "monitor-test-runner:scli-manual-manual" - Container name: "test-run-c0b392c0-5e2b-429c-9a2c-964f7baad18f" - Runner git commit: b81e403a61c53e380fb69905a7df6b5141039e8a 2026-08-11T11:59:29+02:00 Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Uninstalled 1 package in 0.79ms Installed 1 package in 1ms Run Test: slices-bi-singlenode-login 2026-09-22 20:09:44.486331 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-09-22 20:09:44.488657 UTC - ls -a /root/ /scripts/: '/root/:\n.\n..\n.bashrc\n.cache\n.local\n.profile\n.slices\n.wget-hsts\n\n/scripts/:\n.\n..\n.slices\nrun_test_runner.sh\n' 2026-09-22 20:09:44.488789 UTC - env: {'PATH': '/app/.venv/bin:/usr/local/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/root/.local/bin/', 'COLUMNS': '200'} 2026-09-22 20:09:44.488912 UTC - which slices: /usr/local/bin/slices 2026-09-22 20:09:44.488937 UTC - Slices CLI exe: 'slices' 2026-09-22 20:09:44.489186 UTC - Run: slices --version 2026-09-22 20:09:47.863872 UTC - version: Slices CLI v2026.1.3 Slices CLI core v1.2.6 Slices CLI ai v1.1.0 Slices CLI bi v2.2.1 Slices clientlib bi v6.1.1 Slices clientlib core v5.6.0 Slices clientlib ai v1.0.0 2026-09-22 20:09:47.864624 UTC - Run: slices pubkey list --format text 2026-09-22 20:09:48.680313 UTC - Pubkey already registered 2026-09-22 20:09:48.680576 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-09-22 20:09:49.345941 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-09-22 20:09:49.346047 UTC - Check List Flavors 2026-09-22 20:09:49.346243 UTC - Run: slices bi --infra ch-geneva-bi-vm1 flavor list -f json 2026-09-22 20:09:50.111804 UTC - Check List DiskImages 2026-09-22 20:09:50.112011 UTC - Run: slices bi --infra ch-geneva-bi-vm1 diskimage list -f json 2026-09-22 20:09:50.827688 UTC - Requesting resources 2026-09-22 20:09:50.828191 UTC - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-09-22 20:09:50.828305 UTC - Run: slices bi --infra ch-geneva-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-297564c8 --user-data /tmp/tmpug14oyit 2026-09-22 20:09:52.249509 UTC - Resource ID: r_ch-geneva-bi-vm1_01m35btcmmfsgtny4rpqadmndc 2026-09-22 20:09:52.249671 UTC - Waiting until resource ready 2026-09-22 20:09:54.249979 UTC - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-297564c8 tst 2026-09-22 20:09:55.321241 UTC - Status: IMAGING 2026-09-22 20:09:58.477439 UTC - Status: IMAGING 2026-09-22 20:10:01.897400 UTC - Status: IMAGING 2026-09-22 20:10:05.379214 UTC - Status: IMAGING 2026-09-22 20:10:08.451903 UTC - Status: IMAGING 2026-09-22 20:10:11.268897 UTC - Status: IMAGING 2026-09-22 20:10:14.343978 UTC - Status: IMAGING 2026-09-22 20:10:17.617607 UTC - Status: IMAGING 2026-09-22 20:10:21.359258 UTC - Status: IMAGING 2026-09-22 20:10:25.391390 UTC - Status: IMAGING 2026-09-22 20:10:28.958234 UTC - Status: IMAGING 2026-09-22 20:10:32.567194 UTC - Status: IMAGING 2026-09-22 20:10:35.901348 UTC - Status: IMAGING 2026-09-22 20:10:39.797065 UTC - Status: IMAGING 2026-09-22 20:10:43.593154 UTC - Status: IMAGING 2026-09-22 20:10:47.204170 UTC - Status: IMAGING 2026-09-22 20:10:50.701403 UTC - Status: IMAGING 2026-09-22 20:10:53.953913 UTC - Status: IMAGING 2026-09-22 20:10:57.033933 UTC - Status: IMAGING 2026-09-22 20:11:00.024673 UTC - Status: IMAGING 2026-09-22 20:11:03.046583 UTC - Status: IMAGING 2026-09-22 20:11:06.369185 UTC - Status: IMAGING 2026-09-22 20:11:09.404133 UTC - Status: IMAGING 2026-09-22 20:11:12.326244 UTC - Status: IMAGING 2026-09-22 20:11:15.315227 UTC - Status: IMAGING 2026-09-22 20:11:18.358539 UTC - Status: IMAGING 2026-09-22 20:11:21.174975 UTC - Status: IMAGING 2026-09-22 20:11:24.041313 UTC - Status: IMAGING 2026-09-22 20:11:26.908035 UTC - Status: IMAGING 2026-09-22 20:11:29.774466 UTC - Status: IMAGING 2026-09-22 20:11:32.640889 UTC - Status: IMAGING 2026-09-22 20:11:35.668132 UTC - Status: IMAGING 2026-09-22 20:11:38.859201 UTC - Status: UP 2026-09-22 20:11:38.859279 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01m35btc8zfw8v9pc84pgghj4j 2026-09-22 20:11:38.859321 UTC - Validate resources 2026-09-22 20:11:40.179740 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-09-22 20:11:40.179807 UTC - The fields of the created resource were validated. 2026-09-22 20:11:40.179842 UTC - Check if resources are registered in experiment 2026-09-22 20:11:40.179977 UTC - Run: slices experiment list-resources --format json tst-297564c8 2026-09-22 20:11:41.008214 UTC - Status (on expauth): UP 2026-09-22 20:11:41.008347 UTC - Testing extend expires_at (all resources in experiment) 2026-09-22 20:11:41.008462 UTC - Run: slices bi --infra ch-geneva-bi-vm1 extend --duration 3h --experiment tst-297564c8 2026-09-22 20:11:42.329527 UTC - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-297564c8 tst 2026-09-22 20:11:43.145347 UTC - Run: slices experiment list-resources --format json tst-297564c8 2026-09-22 20:11:43.863100 UTC - expires_at (on expauth): 2026-09-22T23:11:00Z (correctly extended) 2026-09-22 20:11:43.863188 UTC - Testing extend expires_at (single resource in experiment) 2026-09-22 20:11:43.863334 UTC - Run: slices bi --infra ch-geneva-bi-vm1 extend tst --duration 4h --experiment tst-297564c8 2026-09-22 20:11:45.191979 UTC - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-297564c8 tst 2026-09-22 20:11:46.164101 UTC - Run: slices experiment list-resources --format json tst-297564c8 2026-09-22 20:11:47.030329 UTC - expires_at (on expauth): 2026-09-23T00:11:00Z (correctly extended) 2026-09-22 20:11:47.030441 UTC - Testing ssh login 2026-09-22 20:11:47.070066 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-297564c8 tst 2026-09-22 20:11:47.955924 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-297564c8 tst 2026-09-22 20:11:48.822305 UTC - Logging in using 'slices bi ssh' 2026-09-22 20:11:48.822377 UTC - Forcing IPv4 only. 2026-09-22 20:11:48.822505 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --show nothing --experiment tst-297564c8 tst -- -4 uname -a 2026-09-22 20:11:51.743797 UTC - Forcing IPv4 only. 2026-09-22 20:11:51.744021 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --show nothing --experiment tst-297564c8 tst -- -4 uptime 2026-09-22 20:11:52.971258 UTC - CLI SSH Test passed. 2026-09-22 20:11:52.971326 UTC - Uname: Linux 9524f874-af0c-4a76-a2a6-5351b52bb50f-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-09-22 20:11:52.971344 UTC - Uptime: 20:11:52 up 1 min, 1 user, load average: 0.12, 0.04, 0.01 2026-09-22 20:11:52.971376 UTC - Logging in using SSH (no SSH proxy in Resource) 2026-09-22 20:11:52.971786 UTC - Added paramiko HostKeyEntry for 5.53.108.51 2026-09-22 20:11:52.971869 UTC - Added paramiko HostKeyEntry for 5.53.108.51 2026-09-22 20:11:52.972005 UTC - Added paramiko HostKeyEntry for 5.53.108.51 2026-09-22 20:11:52.972195 UTC - Connecting to 5.53.108.51:22 2026-09-22 20:11:53.529491 UTC - SSH Test output: 2026-09-22 20:11:53.529592 UTC - Uname: Linux 9524f874-af0c-4a76-a2a6-5351b52bb50f-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-09-22 20:11:53.529623 UTC - Uptime: 20:11:53 up 1 min, 1 user, load average: 0.11, 0.04, 0.01 2026-09-22 20:11:53.628619 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-09-22 20:11:53.628707 UTC - lsb_release matches expected value 2026-09-22 20:11:53.628795 UTC - SSH Test passed. 2026-09-22 20:11:53.713858 UTC - Cloud-init user-data: Hello World. The time is now Tue, 22 Sep 2026 20:11:19 +0000! 2026-09-22 20:11:53.714012 UTC - Skip SSH proxy test because no jump proxy 2026-09-22 20:11:53.721233 UTC - Destroying tst-297564c8 tst 2026-09-22 20:11:53.721418 UTC - Run: slices bi --infra ch-geneva-bi-vm1 destroy --experiment tst-297564c8 tst