Test run: - Start at Tue Oct 13 21:00:26 UTC 2026 - Docker image: "monitor-test-runner:scli-manual-manual" - Container name: "test-run-f386b0d3-2ba2-46a2-b521-03e6ada563b4" - 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.83ms Installed 1 package in 1ms Run Test: slices-bi-singlenode-login 2026-10-13 21:00:30.194944 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-13 21:00:30.197280 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-13 21:00:30.197343 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-13 21:00:30.197450 UTC - which slices: /usr/local/bin/slices 2026-10-13 21:00:30.197472 UTC - Slices CLI exe: 'slices' 2026-10-13 21:00:30.197661 UTC - Run: slices --version 2026-10-13 21:00:33.922600 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-13 21:00:33.923258 UTC - Run: slices pubkey list --format text 2026-10-13 21:00:34.738860 UTC - Pubkey already registered 2026-10-13 21:00:34.739123 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-10-13 21:00:35.408603 UTC - Refreshed infrastructure list. Total: 25 entries. 2026-10-13 21:00:35.408692 UTC - Check List Flavors 2026-10-13 21:00:35.408852 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-10-13 21:00:36.174636 UTC - Check List DiskImages 2026-10-13 21:00:36.174834 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-10-13 21:00:36.891443 UTC - Requesting resources 2026-10-13 21:00:36.892000 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian13-min --flavor nova --duration 2h --experiment tst-21e473c7 2026-10-13 21:00:38.311337 UTC - Resource ID: r_fr-lyon1-bi-baremetal1_01m4vh2eacecssrafr0bpq210y 2026-10-13 21:00:38.311643 UTC - Waiting until resource ready 2026-10-13 21:00:40.311994 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-21e473c7 tst 2026-10-13 21:00:41.127675 UTC - Status: IMAGING 2026-10-13 21:00:44.144874 UTC - Status: STARTING 2026-10-13 21:00:46.961034 UTC - Status: STARTING 2026-10-13 21:00:49.827918 UTC - Status: STARTING 2026-10-13 21:00:52.644041 UTC - Status: STARTING 2026-10-13 21:00:55.460365 UTC - Status: STARTING 2026-10-13 21:00:58.276785 UTC - Status: STARTING 2026-10-13 21:01:01.244189 UTC - Status: STARTING 2026-10-13 21:01:04.060832 UTC - Status: STARTING 2026-10-13 21:01:06.977460 UTC - Status: STARTING 2026-10-13 21:01:09.850383 UTC - Status: STARTING 2026-10-13 21:01:12.666812 UTC - Status: STARTING 2026-10-13 21:01:15.483656 UTC - Status: STARTING 2026-10-13 21:01:18.250160 UTC - Status: STARTING 2026-10-13 21:01:21.066671 UTC - Status: STARTING 2026-10-13 21:01:23.883300 UTC - Status: STARTING 2026-10-13 21:01:26.699868 UTC - Status: STARTING 2026-10-13 21:01:29.516963 UTC - Status: STARTING 2026-10-13 21:01:32.333857 UTC - Status: STARTING 2026-10-13 21:01:35.200590 UTC - Status: STARTING 2026-10-13 21:01:38.117855 UTC - Status: STARTING 2026-10-13 21:01:40.985090 UTC - Status: STARTING 2026-10-13 21:01:43.805220 UTC - Status: STARTING 2026-10-13 21:01:46.571504 UTC - Status: STARTING 2026-10-13 21:01:49.339124 UTC - Status: STARTING 2026-10-13 21:01:52.206142 UTC - Status: STARTING 2026-10-13 21:01:55.023579 UTC - Status: STARTING 2026-10-13 21:01:57.840746 UTC - Status: STARTING 2026-10-13 21:02:00.808649 UTC - Status: STARTING 2026-10-13 21:02:03.675940 UTC - Status: STARTING 2026-10-13 21:02:06.543854 UTC - Status: STARTING 2026-10-13 21:02:09.310258 UTC - Status: STARTING 2026-10-13 21:02:12.127013 UTC - Status: STARTING 2026-10-13 21:02:14.943964 UTC - Status: STARTING 2026-10-13 21:02:17.760840 UTC - Status: STARTING 2026-10-13 21:02:20.527398 UTC - Status: STARTING 2026-10-13 21:02:23.294076 UTC - Status: STARTING 2026-10-13 21:02:26.211642 UTC - Status: STARTING 2026-10-13 21:02:29.129345 UTC - Status: STARTING 2026-10-13 21:02:32.146869 UTC - Status: STARTING 2026-10-13 21:02:35.013925 UTC - Status: STARTING 2026-10-13 21:02:37.830679 UTC - Status: STARTING 2026-10-13 21:02:40.647534 UTC - Status: STARTING 2026-10-13 21:02:43.565435 UTC - Status: STARTING 2026-10-13 21:02:46.382300 UTC - Status: STARTING 2026-10-13 21:02:49.199107 UTC - Status: STARTING 2026-10-13 21:02:52.016544 UTC - Status: STARTING 2026-10-13 21:02:54.833081 UTC - Status: STARTING 2026-10-13 21:02:57.850146 UTC - Status: STARTING 2026-10-13 21:03:00.818102 UTC - Status: STARTING 2026-10-13 21:03:03.634756 UTC - Status: STARTING 2026-10-13 21:03:06.451244 UTC - Status: STARTING 2026-10-13 21:03:09.519694 UTC - Status: STARTING 2026-10-13 21:03:12.437409 UTC - Status: STARTING 2026-10-13 21:03:15.354864 UTC - Status: STARTING 2026-10-13 21:03:18.121152 UTC - Status: STARTING 2026-10-13 21:03:20.937870 UTC - Status: STARTING 2026-10-13 21:03:23.754919 UTC - Status: STARTING 2026-10-13 21:03:26.571385 UTC - Status: STARTING 2026-10-13 21:03:29.539324 UTC - Status: STARTING 2026-10-13 21:03:32.356161 UTC - Status: STARTING 2026-10-13 21:03:35.172942 UTC - Status: STARTING 2026-10-13 21:03:37.989507 UTC - Status: STARTING 2026-10-13 21:03:40.856226 UTC - Status: STARTING 2026-10-13 21:03:43.773322 UTC - Status: STARTING 2026-10-13 21:03:46.740522 UTC - Status: STARTING 2026-10-13 21:03:49.607596 UTC - Status: STARTING 2026-10-13 21:03:52.424816 UTC - Status: STARTING 2026-10-13 21:03:55.241587 UTC - Status: STARTING 2026-10-13 21:03:58.058687 UTC - Status: STARTING 2026-10-13 21:04:01.077278 UTC - Status: STARTING 2026-10-13 21:04:03.995035 UTC - Status: STARTING 2026-10-13 21:04:06.811843 UTC - Status: STARTING 2026-10-13 21:04:09.729258 UTC - Status: STARTING 2026-10-13 21:04:12.546212 UTC - Status: STARTING 2026-10-13 21:04:15.413425 UTC - Status: STARTING 2026-10-13 21:04:18.230087 UTC - Status: STARTING 2026-10-13 21:04:21.048252 UTC - Status: STARTING 2026-10-13 21:04:23.864805 UTC - Status: STARTING 2026-10-13 21:04:26.681313 UTC - Status: STARTING 2026-10-13 21:04:29.497847 UTC - Status: STARTING 2026-10-13 21:04:32.314487 UTC - Status: STARTING 2026-10-13 21:04:35.131879 UTC - Status: STARTING 2026-10-13 21:04:37.948559 UTC - Status: STARTING 2026-10-13 21:04:40.765782 UTC - Status: STARTING 2026-10-13 21:04:43.582728 UTC - Status: STARTING 2026-10-13 21:04:46.449517 UTC - Status: STARTING 2026-10-13 21:04:49.266052 UTC - Status: STARTING 2026-10-13 21:04:52.082728 UTC - Status: STARTING 2026-10-13 21:04:54.899438 UTC - Status: STARTING 2026-10-13 21:04:57.766671 UTC - Status: STARTING 2026-10-13 21:05:00.734364 UTC - Status: STARTING 2026-10-13 21:05:03.601480 UTC - Status: STARTING 2026-10-13 21:05:06.418056 UTC - Status: STARTING 2026-10-13 21:05:09.234770 UTC - Status: STARTING 2026-10-13 21:05:12.152385 UTC - Status: STARTING 2026-10-13 21:05:15.070052 UTC - Status: STARTING 2026-10-13 21:05:17.886877 UTC - Status: STARTING 2026-10-13 21:05:20.703700 UTC - Status: STARTING 2026-10-13 21:05:23.621260 UTC - Status: STARTING 2026-10-13 21:05:26.437938 UTC - Status: STARTING 2026-10-13 21:05:29.255034 UTC - Status: STARTING 2026-10-13 21:05:32.071702 UTC - Status: STARTING 2026-10-13 21:05:34.888660 UTC - Status: STARTING 2026-10-13 21:05:37.806069 UTC - Status: STARTING 2026-10-13 21:05:40.773542 UTC - Status: STARTING 2026-10-13 21:05:43.641470 UTC - Status: STARTING 2026-10-13 21:05:46.458460 UTC - Status: STARTING 2026-10-13 21:05:49.275782 UTC - Status: STARTING 2026-10-13 21:05:52.092957 UTC - Status: STARTING 2026-10-13 21:05:55.010802 UTC - Status: STARTING 2026-10-13 21:05:57.877578 UTC - Status: STARTING 2026-10-13 21:06:00.694913 UTC - Status: STARTING 2026-10-13 21:06:03.561858 UTC - Status: STARTING 2026-10-13 21:06:06.378676 UTC - Status: STARTING 2026-10-13 21:06:09.346261 UTC - Status: STARTING 2026-10-13 21:06:12.264288 UTC - Status: STARTING 2026-10-13 21:06:15.081890 UTC - Status: STARTING 2026-10-13 21:06:17.899257 UTC - Status: STARTING 2026-10-13 21:06:20.817170 UTC - Status: STARTING 2026-10-13 21:06:23.634635 UTC - Status: STARTING 2026-10-13 21:06:26.452036 UTC - Status: STARTING 2026-10-13 21:06:29.269111 UTC - Status: STARTING 2026-10-13 21:06:32.086181 UTC - Status: STARTING 2026-10-13 21:06:34.902875 UTC - Status: STARTING 2026-10-13 21:06:37.769740 UTC - Status: STARTING 2026-10-13 21:06:40.686939 UTC - Status: STARTING 2026-10-13 21:06:43.553746 UTC - Status: STARTING 2026-10-13 21:06:46.420535 UTC - Status: UP 2026-10-13 21:06:46.420678 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01m4vh2dvwe6z9cw05aw2mtads 2026-10-13 21:06:46.420776 UTC - Validate resources 2026-10-13 21:06:47.287852 UTC - The fields of the created resource were validated. 2026-10-13 21:06:47.287976 UTC - Check if resources are registered in experiment 2026-10-13 21:06:47.288160 UTC - Run: slices experiment list-resources --format json tst-21e473c7 2026-10-13 21:06:48.054879 UTC - Status (on expauth): UP 2026-10-13 21:06:48.055029 UTC - Testing extend expires_at (all resources in experiment) 2026-10-13 21:06:48.055161 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-21e473c7 2026-10-13 21:06:51.879326 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-21e473c7 tst 2026-10-13 21:06:52.697345 UTC - Run: slices experiment list-resources --format json tst-21e473c7 2026-10-13 21:06:53.413420 UTC - expires_at (on expauth): 2026-10-14T00:06:00Z (correctly extended) 2026-10-13 21:06:53.413529 UTC - Testing extend expires_at (single resource in experiment) 2026-10-13 21:06:53.413779 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend tst --duration 4h --experiment tst-21e473c7 2026-10-13 21:06:57.188842 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-21e473c7 tst 2026-10-13 21:06:58.055681 UTC - Run: slices experiment list-resources --format json tst-21e473c7 2026-10-13 21:06:58.921995 UTC - expires_at (on expauth): 2026-10-14T01:06:00Z (correctly extended) 2026-10-13 21:06:58.922112 UTC - Testing ssh login 2026-10-13 21:06:58.943229 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-21e473c7 tst 2026-10-13 21:07:00.060919 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-21e473c7 tst 2026-10-13 21:07:01.078266 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-21e473c7 tst 2026-10-13 21:07:02.146208 UTC - Logging in using 'slices bi ssh' 2026-10-13 21:07:02.146317 UTC - Forcing IPv4 only. 2026-10-13 21:07:02.146517 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-21e473c7 tst -- -4 uname -a 2026-10-13 21:07:04.567636 UTC - Forcing IPv4 only. 2026-10-13 21:07:04.567830 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-21e473c7 tst -- -4 uptime 2026-10-13 21:07:06.086083 UTC - CLI SSH Test passed. 2026-10-13 21:07:06.086157 UTC - Uname: Linux nova-7 6.12.111+deb13-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.12.111-1 (2026-09-28) x86_64 GNU/Linux 2026-10-13 21:07:06.086178 UTC - Uptime: 23:07:06 up 0 min, 1 user, load average: 1.03, 0.37, 0.13 2026-10-13 21:07:06.086212 UTC - Logging in using 'slices bi ssh' 2026-10-13 21:07:06.086264 UTC - Forcing IPv6 only. 2026-10-13 21:07:06.086411 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-21e473c7 tst -- -6 uname -a 2026-10-13 21:07:07.554367 UTC - Forcing IPv6 only. 2026-10-13 21:07:07.554620 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-21e473c7 tst -- -6 uptime 2026-10-13 21:07:08.972755 UTC - CLI SSH Test passed. 2026-10-13 21:07:08.972847 UTC - Uname: Linux nova-7 6.12.111+deb13-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.12.111-1 (2026-09-28) x86_64 GNU/Linux 2026-10-13 21:07:08.972875 UTC - Uptime: 23:07:09 up 1 min, 1 user, load average: 0.95, 0.37, 0.13 2026-10-13 21:07:08.972914 UTC - Logging in using SSH over SSH proxy 2026-10-13 21:07:08.973125 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-21e473c7 tst 2026-10-13 21:07:09.890583 UTC - Added paramiko HostKeyEntry for nova-7.lyon 2026-10-13 21:07:09.890893 UTC - Added paramiko HostKeyEntry for nova-7.lyon 2026-10-13 21:07:09.891042 UTC - Added paramiko HostKeyEntry for nova-7.lyon 2026-10-13 21:07:09.891465 UTC - Added paramiko HostKeyEntry for access.grid5000.fr 2026-10-13 21:07:09.891625 UTC - Added paramiko HostKeyEntry for access.grid5000.fr 2026-10-13 21:07:09.891713 UTC - Added paramiko HostKeyEntry for access.grid5000.fr 2026-10-13 21:07:09.891743 UTC - Connecting to proxy access.grid5000.fr:22 2026-10-13 21:07:10.234239 UTC - Connecting to nova-7.lyon:22 over proxy 2026-10-13 21:07:10.715870 UTC - SSH Test output: 2026-10-13 21:07:10.715963 UTC - Uname: Linux nova-7 6.12.111+deb13-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.12.111-1 (2026-09-28) x86_64 GNU/Linux 2026-10-13 21:07:10.715998 UTC - Uptime: 23:07:10 up 1 min, 1 user, load average: 0.95, 0.37, 0.13 2026-10-13 21:07:10.830009 UTC - lsb_release: Debian GNU/Linux 13 (trixie) 2026-10-13 21:07:10.924713 UTC - /etc/debian_version: 13.7 2026-10-13 21:07:10.924828 UTC - lsb_release matches expected value 2026-10-13 21:07:10.924851 UTC - /etc/debian_version matches expected value 2026-10-13 21:07:10.924868 UTC - SSH Test passed. 2026-10-13 21:07:10.932080 UTC - Destroying tst-21e473c7 tst 2026-10-13 21:07:10.932279 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-21e473c7 tst