Test run: - Start at Mon Oct 19 14:00:26 UTC 2026 - Docker image: "monitor-test-runner:scli-manual-manual" - Container name: "test-run-df2e2b25-cb27-4a4f-9fef-9598f2831e98" - Runner git commit: 3d31de04c823a30705ff3eab5a5f3c3f420ec99c 2026-09-25T10:35:24+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-10-19 14:00:29.089392 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-10-19 14:00:29.093922 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-10-19 14:00:29.094008 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-10-19 14:00:29.094128 UTC - which slices: /usr/local/bin/slices 2026-10-19 14:00:29.094151 UTC - Slices CLI exe: 'slices' 2026-10-19 14:00:29.094371 UTC - Run: slices --version 2026-10-19 14:00:32.471263 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-10-19 14:00:32.471734 UTC - Run: slices pubkey list --format text 2026-10-19 14:00:33.242170 UTC - Pubkey already registered 2026-10-19 14:00:33.242404 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-10-19 14:00:33.857431 UTC - Refreshed infrastructure list. Total: 25 entries. 2026-10-19 14:00:33.857519 UTC - Check List Flavors 2026-10-19 14:00:33.857662 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-10-19 14:00:34.573238 UTC - Check List DiskImages 2026-10-19 14:00:34.573466 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-10-19 14:00:35.340872 UTC - Requesting resources 2026-10-19 14:00:35.341388 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian13-min --flavor nova --duration 2h --experiment tst-3b656855 2026-10-19 14:00:37.063110 UTC - Resource ID: r_fr-lyon1-bi-baremetal1_01m5a7dnqje4rafdqhnf67c5a3 2026-10-19 14:00:37.063288 UTC - Waiting until resource ready 2026-10-19 14:00:39.063639 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-3b656855 tst 2026-10-19 14:00:39.929439 UTC - Status: IMAGING 2026-10-19 14:00:42.796011 UTC - Status: IMAGING 2026-10-19 14:00:45.612297 UTC - Status: IMAGING 2026-10-19 14:00:48.430541 UTC - Status: IMAGING 2026-10-19 14:00:51.247066 UTC - Status: IMAGING 2026-10-19 14:00:54.014144 UTC - Status: STARTING 2026-10-19 14:00:56.780034 UTC - Status: STARTING 2026-10-19 14:00:59.545902 UTC - Status: STARTING 2026-10-19 14:01:02.362079 UTC - Status: STARTING 2026-10-19 14:01:05.128207 UTC - Status: STARTING 2026-10-19 14:01:07.944381 UTC - Status: STARTING 2026-10-19 14:01:10.710257 UTC - Status: STARTING 2026-10-19 14:01:13.526795 UTC - Status: STARTING 2026-10-19 14:01:16.292995 UTC - Status: STARTING 2026-10-19 14:01:19.059342 UTC - Status: STARTING 2026-10-19 14:01:21.875663 UTC - Status: STARTING 2026-10-19 14:01:24.641924 UTC - Status: STARTING 2026-10-19 14:01:27.408220 UTC - Status: STARTING 2026-10-19 14:01:30.175164 UTC - Status: STARTING 2026-10-19 14:01:32.991846 UTC - Status: STARTING 2026-10-19 14:01:35.758108 UTC - Status: STARTING 2026-10-19 14:01:38.524272 UTC - Status: STARTING 2026-10-19 14:01:41.340704 UTC - Status: STARTING 2026-10-19 14:01:44.106987 UTC - Status: STARTING 2026-10-19 14:01:46.873250 UTC - Status: STARTING 2026-10-19 14:01:49.639586 UTC - Status: STARTING 2026-10-19 14:01:52.405789 UTC - Status: STARTING 2026-10-19 14:01:55.172068 UTC - Status: STARTING 2026-10-19 14:01:58.038825 UTC - Status: STARTING 2026-10-19 14:02:00.805183 UTC - Status: STARTING 2026-10-19 14:02:03.572623 UTC - Status: STARTING 2026-10-19 14:02:06.339057 UTC - Status: STARTING 2026-10-19 14:02:09.105722 UTC - Status: STARTING 2026-10-19 14:02:11.871900 UTC - Status: STARTING 2026-10-19 14:02:14.638151 UTC - Status: STARTING 2026-10-19 14:02:17.454533 UTC - Status: STARTING 2026-10-19 14:02:20.220582 UTC - Status: STARTING 2026-10-19 14:02:23.037119 UTC - Status: STARTING 2026-10-19 14:02:25.803403 UTC - Status: STARTING 2026-10-19 14:02:28.570201 UTC - Status: STARTING 2026-10-19 14:02:31.386765 UTC - Status: STARTING 2026-10-19 14:02:34.203062 UTC - Status: STARTING 2026-10-19 14:02:36.969377 UTC - Status: STARTING 2026-10-19 14:02:39.735628 UTC - Status: STARTING 2026-10-19 14:02:42.501808 UTC - Status: STARTING 2026-10-19 14:02:45.268096 UTC - Status: STARTING 2026-10-19 14:02:48.034378 UTC - Status: STARTING 2026-10-19 14:02:50.800561 UTC - Status: STARTING 2026-10-19 14:02:53.567088 UTC - Status: STARTING 2026-10-19 14:02:56.333353 UTC - Status: STARTING 2026-10-19 14:02:59.099842 UTC - Status: STARTING 2026-10-19 14:03:01.966684 UTC - Status: STARTING 2026-10-19 14:03:04.783294 UTC - Status: STARTING 2026-10-19 14:03:07.599805 UTC - Status: STARTING 2026-10-19 14:03:10.366417 UTC - Status: STARTING 2026-10-19 14:03:13.183206 UTC - Status: STARTING 2026-10-19 14:03:15.999505 UTC - Status: STARTING 2026-10-19 14:03:18.866590 UTC - Status: STARTING 2026-10-19 14:03:21.683255 UTC - Status: UP 2026-10-19 14:03:21.683332 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01m5a7dn00f7nrkt19d032v41y 2026-10-19 14:03:21.683375 UTC - Validate resources 2026-10-19 14:03:22.499739 UTC - The fields of the created resource were validated. 2026-10-19 14:03:22.499894 UTC - Check if resources are registered in experiment 2026-10-19 14:03:22.500122 UTC - Run: slices experiment list-resources --format json tst-3b656855 2026-10-19 14:03:23.216063 UTC - Status (on expauth): UP 2026-10-19 14:03:23.216201 UTC - Testing extend expires_at (all resources in experiment) 2026-10-19 14:03:23.216349 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-3b656855 2026-10-19 14:03:27.040752 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-3b656855 tst 2026-10-19 14:03:27.907244 UTC - Run: slices experiment list-resources --format json tst-3b656855 2026-10-19 14:03:28.572918 UTC - expires_at (on expauth): 2026-10-19T17:03:00Z (correctly extended) 2026-10-19 14:03:28.573014 UTC - Testing extend expires_at (single resource in experiment) 2026-10-19 14:03:28.573176 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend tst --duration 4h --experiment tst-3b656855 2026-10-19 14:03:32.347594 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-3b656855 tst 2026-10-19 14:03:33.264542 UTC - Run: slices experiment list-resources --format json tst-3b656855 2026-10-19 14:03:33.980648 UTC - expires_at (on expauth): 2026-10-19T18:03:00Z (correctly extended) 2026-10-19 14:03:33.980807 UTC - Testing ssh login 2026-10-19 14:03:33.993701 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-3b656855 tst 2026-10-19 14:03:34.809811 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-3b656855 tst 2026-10-19 14:03:35.626293 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-3b656855 tst 2026-10-19 14:03:36.442303 UTC - Logging in using 'slices bi ssh' 2026-10-19 14:03:36.442382 UTC - Forcing IPv4 only. 2026-10-19 14:03:36.442511 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-3b656855 tst -- -4 uname -a 2026-10-19 14:03:38.862477 UTC - Forcing IPv4 only. 2026-10-19 14:03:38.862732 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-3b656855 tst -- -4 uptime 2026-10-19 14:03:40.230028 UTC - CLI SSH Test passed. 2026-10-19 14:03:40.230108 UTC - Uname: Linux nova-11 6.12.111+deb13-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.12.111-1 (2026-09-28) x86_64 GNU/Linux 2026-10-19 14:03:40.230128 UTC - Uptime: 16:03:40 up 0 min, 1 user, load average: 0.58, 0.21, 0.08 2026-10-19 14:03:40.230164 UTC - Logging in using 'slices bi ssh' 2026-10-19 14:03:40.230214 UTC - Forcing IPv6 only. 2026-10-19 14:03:40.230336 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-3b656855 tst -- -6 uname -a 2026-10-19 14:03:41.547459 UTC - Forcing IPv6 only. 2026-10-19 14:03:41.547652 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-3b656855 tst -- -6 uptime 2026-10-19 14:03:43.015158 UTC - CLI SSH Test passed. 2026-10-19 14:03:43.015230 UTC - Uname: Linux nova-11 6.12.111+deb13-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.12.111-1 (2026-09-28) x86_64 GNU/Linux 2026-10-19 14:03:43.015250 UTC - Uptime: 16:03:43 up 1 min, 1 user, load average: 0.53, 0.21, 0.08 2026-10-19 14:03:43.015288 UTC - Logging in using SSH over SSH proxy 2026-10-19 14:03:43.015439 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-3b656855 tst 2026-10-19 14:03:43.831765 UTC - Added paramiko HostKeyEntry for nova-11.lyon 2026-10-19 14:03:43.831980 UTC - Added paramiko HostKeyEntry for nova-11.lyon 2026-10-19 14:03:43.832045 UTC - Added paramiko HostKeyEntry for nova-11.lyon 2026-10-19 14:03:43.832321 UTC - Added paramiko HostKeyEntry for access.grid5000.fr 2026-10-19 14:03:43.832403 UTC - Added paramiko HostKeyEntry for access.grid5000.fr 2026-10-19 14:03:43.832446 UTC - Added paramiko HostKeyEntry for access.grid5000.fr 2026-10-19 14:03:43.832463 UTC - Connecting to proxy access.grid5000.fr:22 2026-10-19 14:03:44.295826 UTC - Connecting to nova-11.lyon:22 over proxy 2026-10-19 14:03:44.784546 UTC - SSH Test output: 2026-10-19 14:03:44.784616 UTC - Uname: Linux nova-11 6.12.111+deb13-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.12.111-1 (2026-09-28) x86_64 GNU/Linux 2026-10-19 14:03:44.784635 UTC - Uptime: 16:03:44 up 1 min, 1 user, load average: 0.53, 0.21, 0.08 2026-10-19 14:03:44.884141 UTC - lsb_release: Debian GNU/Linux 13 (trixie) 2026-10-19 14:03:44.983428 UTC - /etc/debian_version: 13.7 2026-10-19 14:03:44.983503 UTC - lsb_release matches expected value 2026-10-19 14:03:44.983529 UTC - /etc/debian_version matches expected value 2026-10-19 14:03:44.983560 UTC - SSH Test passed. 2026-10-19 14:03:44.990262 UTC - Destroying tst-3b656855 tst 2026-10-19 14:03:44.990436 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-3b656855 tst