01K86WXEW1Q14K6BEJ83YWA33H: test-repair

BasicConfig {
    output_rules: [
        "%/tmp/*.txt",
        "%/tmp/debug/*",
        "/tmp/core.*",
    ],
    rust_toolchain: None,
    target: Some(
        "helios-2.0",
    ),
    access_repos: [],
    publish: [],
    skip_clone: true,
}

Buildomat Job: 01K86WXY6PD8Y284BTXSRQJAHB

Tags:

Artefacts:

Output:

SEQ GLOBAL TIME DETAILS
12025-10-22T21:42:44.119Zjob dependencies complete; ready to run (waiting for 18 m 24 s)
22025-10-22T21:43:14.275Zjob assigned to worker 01K86XZR3V8F448Z2R6TE3CW0K [factory gimlet-EVT22200007-propolis, EVT22200007/46146] (queued for 30 s)
32025-10-22T21:43:23.627Zdownloading input: /input/build/work/bins/crucible-downstairs.gz
42025-10-22T21:43:30.628Zdownloaded input: /input/build/work/bins/crucible-downstairs.gz
52025-10-22T21:43:30.628Zdownloading input: /input/build/work/bins/crucible-hammer.gz
62025-10-22T21:43:38.007Zdownloaded input: /input/build/work/bins/crucible-hammer.gz
72025-10-22T21:43:38.007Zdownloading input: /input/build/work/bins/crutest.gz
82025-10-22T21:43:46.901Zdownloaded input: /input/build/work/bins/crutest.gz
92025-10-22T21:43:46.901Zdownloading input: /input/build/work/bins/dsc.gz
102025-10-22T21:43:50.153Zdownloaded input: /input/build/work/bins/dsc.gz
112025-10-22T21:43:50.179Zdownloading input: /input/build/work/scripts/perf-downstairs-tick.d
122025-10-22T21:43:50.205Zdownloaded input: /input/build/work/scripts/perf-downstairs-tick.d
132025-10-22T21:43:50.205Zdownloading input: /input/build/work/scripts/test_ds.sh
142025-10-22T21:43:50.241Zdownloaded input: /input/build/work/scripts/test_ds.sh
152025-10-22T21:43:50.242Zdownloading input: /input/build/work/scripts/test_live_repair.sh
162025-10-22T21:43:50.298Zdownloaded input: /input/build/work/scripts/test_live_repair.sh
172025-10-22T21:43:50.298Zdownloading input: /input/build/work/scripts/test_repair.sh
182025-10-22T21:43:50.343Zdownloaded input: /input/build/work/scripts/test_repair.sh
192025-10-22T21:43:50.368Zdownloading input: /input/build/work/scripts/test_replay.sh
202025-10-22T21:43:50.406Zdownloaded input: /input/build/work/scripts/test_replay.sh
212025-10-22T21:43:50.406Zdownloading input: /input/build/work/scripts/test_up.sh
222025-10-22T21:43:50.452Zdownloaded input: /input/build/work/scripts/test_up.sh
232025-10-22T21:43:50.452Zdownloading input: /input/build/work/scripts/upstairs_info.d
242025-10-22T21:43:50.494Zdownloaded input: /input/build/work/scripts/upstairs_info.d
252025-10-22T21:43:50.524Zdownloading input: /input/build/tmp/cargo-test-out.log
262025-10-22T21:43:53.640Zdownloaded input: /input/build/tmp/cargo-test-out.log
 
272025-10-22T21:43:53.640Zstarting task 0: "setup"
282025-10-22T21:43:53.665Z++ uname -s
292025-10-22T21:43:53.665Z+ kern=SunOS
302025-10-22T21:43:53.665Z+ build_user=build
312025-10-22T21:43:53.665Z+ build_uid=12345
322025-10-22T21:43:53.665Z+ work_dir=/work
332025-10-22T21:43:53.665Z+ input_dir=/input
342025-10-22T21:43:53.665Z+ [[ 0 == 12345 ]]
352025-10-22T21:43:53.665Z+ case "$kern" in
362025-10-22T21:43:53.665Z+ groupadd -g 12345 build
372025-10-22T21:43:53.665Z+ useradd -u 12345 -g build -d /home/build -s /bin/bash -c build -P 'Primary Administrator' build
382025-10-22T21:43:55.668Z+ zfs create -o mountpoint=/work rpool/work
392025-10-22T21:43:55.709Z++ awk '$2 == "/home" { print $3 }' /etc/mnttab
402025-10-22T21:43:55.733Z+ home_fs=zfs
412025-10-22T21:43:55.734Z+ [[ zfs == autofs ]]
422025-10-22T21:43:55.734Z+ mkdir -p /home/build
432025-10-22T21:43:55.734Z+ chown build:build /home/build /work
442025-10-22T21:43:57.720Z+ chmod 0700 /home/build /work
452025-10-22T21:43:57.746Zprocess exited: duration 4084 ms, exit code 0
 
462025-10-22T21:43:57.796Zstarting task 1: "authentication"
472025-10-22T21:43:57.857Zprocess exited: duration 56 ms, exit code 0
 
482025-10-22T21:43:57.912Zstarting task 2: "build"
492025-10-22T21:43:57.939Z+ banner cores
502025-10-22T21:43:57.939Z
512025-10-22T21:43:57.939Z #### #### ##### ###### ####
522025-10-22T21:43:57.939Z # # # # # # # #
532025-10-22T21:43:57.939Z # # # # # ##### ####
542025-10-22T21:43:57.939Z # # # ##### # #
552025-10-22T21:43:57.939Z # # # # # # # # #
562025-10-22T21:43:57.939Z #### #### # # ###### ####
572025-10-22T21:43:57.939Z
582025-10-22T21:43:57.940Z+ pfexec coreadm -i /tmp/core.%f.%p -g /tmp/core.%f.%p -e global -e log -e proc-setid -e global-setid
592025-10-22T21:43:57.940Z+ echo 'input bins dir contains:'
602025-10-22T21:43:57.940Zinput bins dir contains:
612025-10-22T21:43:57.940Z+ ls -ltr /input/build/work/bins
622025-10-22T21:43:57.940Ztotal 944324
632025-10-22T21:43:57.940Z-rw-r--r-- 1 root root 141185826 Oct 22 21:43 crucible-downstairs.gz
642025-10-22T21:43:57.940Z-rw-r--r-- 1 root root 134081527 Oct 22 21:43 crucible-hammer.gz
652025-10-22T21:43:57.940Z-rw-r--r-- 1 root root 139138487 Oct 22 21:43 crutest.gz
662025-10-22T21:43:57.940Z-rw-r--r-- 1 root root 68719800 Oct 22 21:43 dsc.gz
672025-10-22T21:43:57.940Zinput script dir contains:
682025-10-22T21:43:57.940Z+ echo 'input script dir contains:'
692025-10-22T21:43:57.940Z+ ls -ltr /input/build/work/scripts
702025-10-22T21:43:57.940Ztotal 71
712025-10-22T21:43:57.940Z-rw-r--r-- 1 root root 3056 Oct 22 21:43 perf-downstairs-tick.d
722025-10-22T21:43:57.940Z-rw-r--r-- 1 root root 2127 Oct 22 21:43 test_ds.sh
732025-10-22T21:43:57.940Z-rw-r--r-- 1 root root 4923 Oct 22 21:43 test_live_repair.sh
742025-10-22T21:43:57.940Z-rw-r--r-- 1 root root 7419 Oct 22 21:43 test_repair.sh
752025-10-22T21:43:57.940Z-rw-r--r-- 1 root root 4282 Oct 22 21:43 test_replay.sh
762025-10-22T21:43:57.940Z-rw-r--r-- 1 root root 13887 Oct 22 21:43 test_up.sh
772025-10-22T21:43:57.940Z-rw-r--r-- 1 root root 3241 Oct 22 21:43 upstairs_info.d
782025-10-22T21:43:57.968Z+ pfexec chmod +x /input/build/work/scripts/perf-downstairs-tick.d /input/build/work/scripts/test_ds.sh /input/build/work/scripts/test_live_repair.sh /input/build/work/scripts/test_repair.sh /input/build/work/scripts/test_replay.sh /input/build/work/scripts/test_up.sh /input/build/work/scripts/upstairs_info.d
792025-10-22T21:43:57.968Z+ echo ' chmod input script dir contains:'
802025-10-22T21:43:57.968Z chmod input script dir contains:
812025-10-22T21:43:57.968Z+ ls -ltr /input/build/work/scripts
822025-10-22T21:43:57.968Ztotal 71
832025-10-22T21:43:57.968Z-rwxr-xr-x 1 root root 3056 Oct 22 21:43 perf-downstairs-tick.d
842025-10-22T21:43:57.968Z-rwxr-xr-x 1 root root 2127 Oct 22 21:43 test_ds.sh
852025-10-22T21:43:57.968Z-rwxr-xr-x 1 root root 4923 Oct 22 21:43 test_live_repair.sh
862025-10-22T21:43:57.968Z-rwxr-xr-x 1 root root 7419 Oct 22 21:43 test_repair.sh
872025-10-22T21:43:57.968Z-rwxr-xr-x 1 root root 4282 Oct 22 21:43 test_replay.sh
882025-10-22T21:43:57.968Z-rwxr-xr-x 1 root root 13887 Oct 22 21:43 test_up.sh
892025-10-22T21:43:57.968Z-rwxr-xr-x 1 root root 3241 Oct 22 21:43 upstairs_info.d
902025-10-22T21:43:57.968Z+ banner unpack
912025-10-22T21:43:57.968Z
922025-10-22T21:43:57.968Z # # # # ##### ## #### # #
932025-10-22T21:43:57.968Z # # ## # # # # # # # # #
942025-10-22T21:43:57.968Z # # # # # # # # # # ####
952025-10-22T21:43:57.968Z # # # # # ##### ###### # # #
962025-10-22T21:43:57.968Z # # # ## # # # # # # #
972025-10-22T21:43:57.968Z #### # # # # # #### # #
982025-10-22T21:43:57.968Z
992025-10-22T21:43:57.968Z+ mkdir -p /var/tmp/bins
1002025-10-22T21:43:57.968Z+ for t in "$input/bins/"*.gz
1012025-10-22T21:43:57.969Z++ basename /input/build/work/bins/crucible-downstairs.gz
1022025-10-22T21:43:57.969Z+ b=crucible-downstairs.gz
1032025-10-22T21:43:57.969Z+ b=crucible-downstairs
1042025-10-22T21:43:57.969Z+ gunzip
1052025-10-22T21:44:01.779Z+ chmod +x /var/tmp/bins/crucible-downstairs
1062025-10-22T21:44:01.807Z+ for t in "$input/bins/"*.gz
1072025-10-22T21:44:01.807Z++ basename /input/build/work/bins/crucible-hammer.gz
1082025-10-22T21:44:01.807Z+ b=crucible-hammer.gz
1092025-10-22T21:44:01.807Z+ b=crucible-hammer
1102025-10-22T21:44:01.807Z+ gunzip
1112025-10-22T21:44:05.667Z+ chmod +x /var/tmp/bins/crucible-hammer
1122025-10-22T21:44:05.692Z+ for t in "$input/bins/"*.gz
1132025-10-22T21:44:05.693Z++ basename /input/build/work/bins/crutest.gz
1142025-10-22T21:44:05.693Z+ b=crutest.gz
1152025-10-22T21:44:05.693Z+ b=crutest
1162025-10-22T21:44:05.693Z+ gunzip
1172025-10-22T21:44:09.163Z+ chmod +x /var/tmp/bins/crutest
1182025-10-22T21:44:09.187Z+ for t in "$input/bins/"*.gz
1192025-10-22T21:44:09.188Z++ basename /input/build/work/bins/dsc.gz
1202025-10-22T21:44:09.188Z+ b=dsc.gz
1212025-10-22T21:44:09.188Z+ b=dsc
1222025-10-22T21:44:09.188Z+ gunzip
1232025-10-22T21:44:10.950Z+ chmod +x /var/tmp/bins/dsc
1242025-10-22T21:44:10.975Z+ export BINDIR=/var/tmp/bins
1252025-10-22T21:44:10.975Z+ BINDIR=/var/tmp/bins
1262025-10-22T21:44:10.975Z+ export RUST_BACKTRACE=1
1272025-10-22T21:44:10.975Z+ RUST_BACKTRACE=1
1282025-10-22T21:44:10.975Z+ echo 'Setup self timeout'
1292025-10-22T21:44:10.975Z+ jobpid=1147
1302025-10-22T21:44:10.975ZSetup self timeout
1312025-10-22T21:44:10.975Z+ echo 'Setup debug logging'
1322025-10-22T21:44:10.975Z+ mkdir /tmp/debug
1332025-10-22T21:44:10.975ZSetup debug logging
1342025-10-22T21:44:10.975Z+ sleep 7200
1352025-10-22T21:44:10.976Z+ psrinfo -v
1362025-10-22T21:44:10.976Z+ df -h
1372025-10-22T21:44:11.001Zdf: cannot statvfs /var/metadata/iso: Permission denied
1382025-10-22T21:44:11.001Z+ true
1392025-10-22T21:44:11.001Z+ prstat -d d -mLc 1
1402025-10-22T21:44:11.001Z+ iostat -T d -xn 1
1412025-10-22T21:44:11.001Z+ mpstat -T d 1
1422025-10-22T21:44:11.001Z+ vmstat -T d -p 1
1432025-10-22T21:44:11.001Z+ pfexec dtrace -Z -s /input/build/work/scripts/perf-downstairs-tick.d
1442025-10-22T21:44:11.001Z+ banner repair
1452025-10-22T21:44:11.001Z+ pfexec dtrace -Z -s /input/build/work/scripts/upstairs_info.d
1462025-10-22T21:44:11.001Z
1472025-10-22T21:44:11.001Z ##### ###### ##### ## # #####
1482025-10-22T21:44:11.001Z # # # # # # # # # #
1492025-10-22T21:44:11.001Z # # ##### # # # # # # #
1502025-10-22T21:44:11.001Z ##### # ##### ###### # #####
1512025-10-22T21:44:11.002Z # # # # # # # # #
1522025-10-22T21:44:11.002Z # # ###### # # # # # #
1532025-10-22T21:44:11.002Z
1542025-10-22T21:44:11.002Z+ ptime -m bash /input/build/work/scripts/test_repair.sh -N
1552025-10-22T22:01:05.392Z+ echo 'Test repair finished with 0'
1562025-10-22T22:01:05.392ZTest repair finished with 0
1572025-10-22T22:01:10.400Zprocess exited: duration 1027546 ms, exit code 0
1582025-10-22T22:01:10.400Zexec warning: : stdio descriptors remain open after task exit; waiting 60 seconds for them to close
1592025-10-22T22:02:10.438Zexec warning: : stdout descriptor may be held open by a background process; giving up!
1602025-10-22T22:02:10.439Zexec warning: : stderr descriptor may be held open by a background process; giving up!
 
1612025-10-22T22:02:10.520Zfound 9 output files
1622025-10-22T22:02:10.520Zuploading: /tmp/test-repair-out.txt (2313645 bytes)
1632025-10-22T22:02:11.821Zuploaded: /tmp/test-repair-out.txt
1642025-10-22T22:02:11.821Zuploading: /tmp/debug/df.txt (1270 bytes)
1652025-10-22T22:02:12.917Zuploaded: /tmp/debug/df.txt
1662025-10-22T22:02:12.917Zuploading: /tmp/debug/dtrace.txt (5282297 bytes)
1672025-10-22T22:02:14.139Zupload warning: file "/tmp/debug/dtrace.txt" changed size mid upload: 5282297 -> 5870339
1682025-10-22T22:02:15.212Zuploaded: /tmp/debug/dtrace.txt
1692025-10-22T22:02:15.212Zuploading: /tmp/debug/iostat.txt (397444 bytes)
1702025-10-22T22:02:15.424Zupload warning: file "/tmp/debug/iostat.txt" changed size mid upload: 397444 -> 399284
1712025-10-22T22:02:16.496Zuploaded: /tmp/debug/iostat.txt
1722025-10-22T22:02:16.496Zuploading: /tmp/debug/mpstat.txt (787492 bytes)
1732025-10-22T22:02:16.711Zupload warning: file "/tmp/debug/mpstat.txt" changed size mid upload: 787492 -> 791866
1742025-10-22T22:02:17.783Zuploaded: /tmp/debug/mpstat.txt
1752025-10-22T22:02:17.783Zuploading: /tmp/debug/paging.txt (141264 bytes)
1762025-10-22T22:02:17.967Zupload warning: file "/tmp/debug/paging.txt" changed size mid upload: 141264 -> 142342
1772025-10-22T22:02:19.039Zuploaded: /tmp/debug/paging.txt
1782025-10-22T22:02:19.040Zuploading: /tmp/debug/prstat.txt (1491620 bytes)
1792025-10-22T22:02:19.337Zupload warning: file "/tmp/debug/prstat.txt" changed size mid upload: 1491620 -> 1503276
1802025-10-22T22:02:20.408Zuploaded: /tmp/debug/prstat.txt
1812025-10-22T22:02:20.408Zuploading: /tmp/debug/psrinfo.txt (1528 bytes)
1822025-10-22T22:02:21.504Zuploaded: /tmp/debug/psrinfo.txt
1832025-10-22T22:02:21.504Zuploading: /tmp/debug/upstairs-info.txt (113526 bytes)
1842025-10-22T22:02:22.712Zuploaded: /tmp/debug/upstairs-info.txt