01J2EK6TAF5BNGSRPG0472VEFZ: test-live-repair

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

Buildomat Job: 01J2EK74VC6J17C961M8D89GY5

Tags:

Artefacts:

Output:

SEQ GLOBAL TIME DETAILS
12024-07-10T15:25:09.867Zjob dependencies complete; ready to run (waiting for 13 m 8 s)
22024-07-10T15:26:00.139Zjob assigned to worker 01J2EKZCNW6P2PWMQ65D0J9PDM (queued for 50 s)
32024-07-10T15:26:07.776Zdownloading input: /input/build/work/bins/crucible-downstairs.gz
42024-07-10T15:26:08.824Zdownloaded input: /input/build/work/bins/crucible-downstairs.gz
52024-07-10T15:26:08.824Zdownloading input: /input/build/work/bins/crucible-hammer.gz
62024-07-10T15:26:09.648Zdownloaded input: /input/build/work/bins/crucible-hammer.gz
72024-07-10T15:26:09.648Zdownloading input: /input/build/work/bins/crutest.gz
82024-07-10T15:26:10.666Zdownloaded input: /input/build/work/bins/crutest.gz
92024-07-10T15:26:10.666Zdownloading input: /input/build/work/bins/dsc.gz
102024-07-10T15:26:11.322Zdownloaded input: /input/build/work/bins/dsc.gz
112024-07-10T15:26:11.330Zdownloading input: /input/build/work/scripts/perf-downstairs-tick.d
122024-07-10T15:26:11.340Zdownloaded input: /input/build/work/scripts/perf-downstairs-tick.d
132024-07-10T15:26:11.341Zdownloading input: /input/build/work/scripts/test_ds.sh
142024-07-10T15:26:11.366Zdownloaded input: /input/build/work/scripts/test_ds.sh
152024-07-10T15:26:11.366Zdownloading input: /input/build/work/scripts/test_live_repair.sh
162024-07-10T15:26:11.387Zdownloaded input: /input/build/work/scripts/test_live_repair.sh
172024-07-10T15:26:11.387Zdownloading input: /input/build/work/scripts/test_repair.sh
182024-07-10T15:26:11.407Zdownloaded input: /input/build/work/scripts/test_repair.sh
192024-07-10T15:26:11.407Zdownloading input: /input/build/work/scripts/test_replay.sh
202024-07-10T15:26:11.426Zdownloaded input: /input/build/work/scripts/test_replay.sh
212024-07-10T15:26:11.426Zdownloading input: /input/build/work/scripts/test_up.sh
222024-07-10T15:26:11.442Zdownloaded input: /input/build/work/scripts/test_up.sh
232024-07-10T15:26:11.443Zdownloading input: /input/build/work/scripts/upstairs_info.d
242024-07-10T15:26:11.464Zdownloaded input: /input/build/work/scripts/upstairs_info.d
252024-07-10T15:26:11.467Zdownloading input: /input/build/tmp/cargo-test-out.log
262024-07-10T15:26:12.214Zdownloaded input: /input/build/tmp/cargo-test-out.log
 
272024-07-10T15:26:12.214Zstarting task 0: "setup"
282024-07-10T15:26:12.225Z++ uname -s
292024-07-10T15:26:12.228Z+ kern=SunOS
302024-07-10T15:26:12.228Z+ case "$kern" in
312024-07-10T15:26:12.228Z+ groupadd -g 12345 build
322024-07-10T15:26:12.231Z+ useradd -u 12345 -g build -d /home/build -s /bin/bash -c build -P 'Primary Administrator' build
332024-07-10T15:26:14.240Z+ zfs create -o mountpoint=/work rpool/work
342024-07-10T15:26:14.397Z++ awk '$2 == "/home" { print $3 }' /etc/mnttab
352024-07-10T15:26:14.400Z+ home_fs=zfs
362024-07-10T15:26:14.400Z+ [[ zfs == autofs ]]
372024-07-10T15:26:14.400Z+ mkdir -p /home/build
382024-07-10T15:26:14.402Z+ chown build:build /home/build /work
392024-07-10T15:26:16.404Z+ chmod 0700 /home/build /work
402024-07-10T15:26:16.407Zprocess exited: duration 4192 ms, exit code 0
 
412024-07-10T15:26:16.415Zstarting task 1: "authentication"
422024-07-10T15:26:16.432Zprocess exited: duration 18 ms, exit code 0
 
432024-07-10T15:26:16.438Zstarting task 2: "build"
442024-07-10T15:26:16.444Z+ banner cores
452024-07-10T15:26:16.447Z
462024-07-10T15:26:16.447Z #### #### ##### ###### ####
472024-07-10T15:26:16.447Z # # # # # # # #
482024-07-10T15:26:16.447Z # # # # # ##### ####
492024-07-10T15:26:16.447Z # # # ##### # #
502024-07-10T15:26:16.447Z # # # # # # # # #
512024-07-10T15:26:16.447Z #### #### # # ###### ####
522024-07-10T15:26:16.447Z
532024-07-10T15:26:16.447Z+ pfexec coreadm -i /tmp/core.%f.%p -g /tmp/core.%f.%p -e global -e log -e proc-setid -e global-setid
542024-07-10T15:26:16.458Z+ 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
552024-07-10T15:26:16.461Z+ echo 'input bins dir contains:'
562024-07-10T15:26:16.461Zinput bins dir contains:
572024-07-10T15:26:16.461Z+ ls -ltr /input/build/work/bins
582024-07-10T15:26:16.464Ztotal 687211
592024-07-10T15:26:16.464Z-rw-r--r-- 1 root root 104011619 Jul 10 15:26 crucible-downstairs.gz
602024-07-10T15:26:16.464Z-rw-r--r-- 1 root root 81939727 Jul 10 15:26 crucible-hammer.gz
612024-07-10T15:26:16.464Z-rw-r--r-- 1 root root 101309809 Jul 10 15:26 crutest.gz
622024-07-10T15:26:16.464Z-rw-r--r-- 1 root root 64339917 Jul 10 15:26 dsc.gz
632024-07-10T15:26:16.464Z+ echo 'input script dir contains:'
642024-07-10T15:26:16.464Zinput script dir contains:
652024-07-10T15:26:16.464Z+ ls -ltr /input/build/work/scripts
662024-07-10T15:26:16.464Ztotal 39
672024-07-10T15:26:16.464Z-rwxr-xr-x 1 root root 3056 Jul 10 15:26 perf-downstairs-tick.d
682024-07-10T15:26:16.464Z-rwxr-xr-x 1 root root 2102 Jul 10 15:26 test_ds.sh
692024-07-10T15:26:16.464Z-rwxr-xr-x 1 root root 4103 Jul 10 15:26 test_live_repair.sh
702024-07-10T15:26:16.464Z-rwxr-xr-x 1 root root 6671 Jul 10 15:26 test_repair.sh
712024-07-10T15:26:16.464Z-rwxr-xr-x 1 root root 3029 Jul 10 15:26 test_replay.sh
722024-07-10T15:26:16.464Z-rwxr-xr-x 1 root root 9465 Jul 10 15:26 test_up.sh
732024-07-10T15:26:16.464Z-rwxr-xr-x 1 root root 2750 Jul 10 15:26 upstairs_info.d
742024-07-10T15:26:16.467Z+ banner Unpack
752024-07-10T15:26:16.467Z# #
762024-07-10T15:26:16.467Z# # # # ##### ## #### # #
772024-07-10T15:26:16.467Z# # ## # # # # # # # # #
782024-07-10T15:26:16.467Z# # # # # # # # # # ####
792024-07-10T15:26:16.467Z# # # # # ##### ###### # # #
802024-07-10T15:26:16.467Z# # # ## # # # # # # #
812024-07-10T15:26:16.467Z ##### # # # # # #### # #
822024-07-10T15:26:16.467Z
832024-07-10T15:26:16.467Z+ mkdir -p /var/tmp/bins
842024-07-10T15:26:16.470Z+ for t in "$input/bins/"*.gz
852024-07-10T15:26:16.470Z++ basename /input/build/work/bins/crucible-downstairs.gz
862024-07-10T15:26:16.470Z+ b=crucible-downstairs.gz
872024-07-10T15:26:16.470Z+ b=crucible-downstairs
882024-07-10T15:26:16.470Z+ gunzip
892024-07-10T15:26:18.649Z+ chmod +x /var/tmp/bins/crucible-downstairs
902024-07-10T15:26:18.652Z+ for t in "$input/bins/"*.gz
912024-07-10T15:26:18.655Z++ basename /input/build/work/bins/crucible-hammer.gz
922024-07-10T15:26:18.655Z+ b=crucible-hammer.gz
932024-07-10T15:26:18.655Z+ b=crucible-hammer
942024-07-10T15:26:18.655Z+ gunzip
952024-07-10T15:26:20.366Z+ chmod +x /var/tmp/bins/crucible-hammer
962024-07-10T15:26:20.373Z+ for t in "$input/bins/"*.gz
972024-07-10T15:26:20.373Z++ basename /input/build/work/bins/crutest.gz
982024-07-10T15:26:20.373Z+ b=crutest.gz
992024-07-10T15:26:20.373Z+ b=crutest
1002024-07-10T15:26:20.373Z+ gunzip
1012024-07-10T15:26:22.492Z+ chmod +x /var/tmp/bins/crutest
1022024-07-10T15:26:22.498Z+ for t in "$input/bins/"*.gz
1032024-07-10T15:26:22.498Z++ basename /input/build/work/bins/dsc.gz
1042024-07-10T15:26:22.498Z+ b=dsc.gz
1052024-07-10T15:26:22.498Z+ b=dsc
1062024-07-10T15:26:22.498Z+ gunzip
1072024-07-10T15:26:23.897Z+ chmod +x /var/tmp/bins/dsc
1082024-07-10T15:26:23.911Z+ export BINDIR=/var/tmp/bins
1092024-07-10T15:26:23.912Z+ BINDIR=/var/tmp/bins
1102024-07-10T15:26:23.912Z+ echo 'BINDIR is /var/tmp/bins'
1112024-07-10T15:26:23.912ZBINDIR is /var/tmp/bins
1122024-07-10T15:26:23.912Z+ echo 'bindir contains:'
1132024-07-10T15:26:23.912Zbindir contains:
1142024-07-10T15:26:23.912Z+ ls -ltr /var/tmp/bins
1152024-07-10T15:26:23.912Ztotal 741277
1162024-07-10T15:26:23.912Z-rwxr-xr-x 1 build build 395098296 Jul 10 15:26 crucible-downstairs
1172024-07-10T15:26:23.912Z-rwxr-xr-x 1 build build 306632936 Jul 10 15:26 crucible-hammer
1182024-07-10T15:26:23.912Z-rwxr-xr-x 1 build build 382235536 Jul 10 15:26 crutest
1192024-07-10T15:26:23.912Z-rwxr-xr-x 1 build build 240511288 Jul 10 15:26 dsc
1202024-07-10T15:26:23.913Z+ banner CreateDS
1212024-07-10T15:26:23.917Z ##### ###### #####
1222024-07-10T15:26:23.917Z# # ##### ###### ## ##### ###### # # # #
1232024-07-10T15:26:23.917Z# # # # # # # # # # #
1242024-07-10T15:26:23.917Z# # # ##### # # # ##### # # #####
1252024-07-10T15:26:23.917Z# ##### # ###### # # # # #
1262024-07-10T15:26:23.917Z# # # # # # # # # # # # #
1272024-07-10T15:26:23.917Z ##### # # ###### # # # ###### ###### #####
1282024-07-10T15:26:23.917Z
1292024-07-10T15:26:23.917Z+ echo /var/tmp/bins/dsc create --ds-bin /var/tmp/bins/crucible-downstairs --extent-size 4000 --extent-count 200 --region-count 4 --cleanup
1302024-07-10T15:26:23.917Z/var/tmp/bins/dsc create --ds-bin /var/tmp/bins/crucible-downstairs --extent-size 4000 --extent-count 200 --region-count 4 --cleanup
1312024-07-10T15:26:23.917Z+ /var/tmp/bins/dsc create --ds-bin /var/tmp/bins/crucible-downstairs --extent-size 4000 --extent-count 200 --region-count 4 --cleanup
1322024-07-10T15:26:23.921ZCreating region directory at: /var/tmp/dsc/region
1332024-07-10T15:26:23.921ZCreating dsc directory at: /tmp/dsc
1342024-07-10T15:26:24.210ZDownstairs region 0 created at /var/tmp/dsc/region/8810 in 0.28950515
1352024-07-10T15:26:24.455ZDownstairs region 1 created at /var/tmp/dsc/region/8820 in 0.24383174
1362024-07-10T15:26:24.699ZDownstairs region 2 created at /var/tmp/dsc/region/8830 in 0.24437319
1372024-07-10T15:26:24.941ZDownstairs region 3 created at /var/tmp/dsc/region/8840 in 0.24418709
1382024-07-10T15:26:24.941ZRegion set with 4 regions was created
1392024-07-10T15:26:24.945Z+ banner StartDS
1402024-07-10T15:26:24.948Z ##### ###### #####
1412024-07-10T15:26:24.949Z# # ##### ## ##### ##### # # # #
1422024-07-10T15:26:24.949Z# # # # # # # # # #
1432024-07-10T15:26:24.949Z ##### # # # # # # # # #####
1442024-07-10T15:26:24.949Z # # ###### ##### # # # #
1452024-07-10T15:26:24.949Z# # # # # # # # # # # #
1462024-07-10T15:26:24.949Z ##### # # # # # # ###### #####
1472024-07-10T15:26:24.949Z
1482024-07-10T15:26:24.949Z+ sleep 5
1492024-07-10T15:26:24.949Z+ /var/tmp/bins/dsc start --ds-bin /var/tmp/bins/crucible-downstairs --region-count 4
1502024-07-10T15:26:29.954Z++ pgrep dsc
1512024-07-10T15:26:29.958Z+ dsc_pid=1168
1522024-07-10T15:26:29.958Z+ [[ 1168 -eq 0 ]]
1532024-07-10T15:26:29.958Z+ ps -p 1168
1542024-07-10T15:26:29.961Z PID TTY TIME CMD
1552024-07-10T15:26:29.961Z 1168 ? 0:00 dsc
1562024-07-10T15:26:29.962ZFound dsc running, continue tests
1572024-07-10T15:26:29.962ZSetup self timeout
1582024-07-10T15:26:29.962Z+ echo 'Found dsc running, continue tests'
1592024-07-10T15:26:29.962Z+ echo 'Setup self timeout'
1602024-07-10T15:26:29.962Z+ jobpid=1139
1612024-07-10T15:26:29.962Z+ echo 'Setup debug logging'
1622024-07-10T15:26:29.962ZSetup debug logging
1632024-07-10T15:26:29.962Z+ mkdir /tmp/debug
1642024-07-10T15:26:29.962Z+ sleep 7200
1652024-07-10T15:26:29.965Z+ psrinfo -v
1662024-07-10T15:26:29.968Z+ df -h
1672024-07-10T15:26:29.974Z+ prstat -d d -mLc 1
1682024-07-10T15:26:29.976Z+ iostat -T d -xn 1
1692024-07-10T15:26:29.977Z+ mpstat -T d 1
1702024-07-10T15:26:29.977Z+ vmstat -T d -p 1
1712024-07-10T15:26:29.977Z+ pfexec dtrace -Z -s /input/build/work/scripts/perf-downstairs-tick.d
1722024-07-10T15:26:29.977Z+ banner LR
1732024-07-10T15:26:29.977Z+ pfexec dtrace -Z -s /input/build/work/scripts/upstairs_info.d
1742024-07-10T15:26:29.980Z# ######
1752024-07-10T15:26:29.980Z# # #
1762024-07-10T15:26:29.980Z# # #
1772024-07-10T15:26:29.980Z# ######
1782024-07-10T15:26:29.980Z# # #
1792024-07-10T15:26:29.980Z# # #
1802024-07-10T15:26:29.980Z####### # #
1812024-07-10T15:26:29.980Z
1822024-07-10T15:26:29.980Z+ ptime -m /var/tmp/bins/crutest replace -t 127.0.0.1:8810 -t 127.0.0.1:8820 -t 127.0.0.1:8830 --replacement 127.0.0.1:8840 -g 1 -c 10 --stable
1832024-07-10T15:36:26.594Z+ banner StopDSC
1842024-07-10T15:36:26.597Z ##### ###### ##### #####
1852024-07-10T15:36:26.597Z# # ##### #### ##### # # # # # #
1862024-07-10T15:36:26.597Z# # # # # # # # # #
1872024-07-10T15:36:26.597Z ##### # # # # # # # ##### #
1882024-07-10T15:36:26.597Z # # # # ##### # # # #
1892024-07-10T15:36:26.597Z# # # # # # # # # # # #
1902024-07-10T15:36:26.597Z ##### # #### # ###### ##### #####
1912024-07-10T15:36:26.597Z
1922024-07-10T15:36:26.597Z+ /var/tmp/bins/dsc cmd shutdown
1932024-07-10T15:36:26.673Z+ banner WaitStop
1942024-07-10T15:36:26.676Z# # #####
1952024-07-10T15:36:26.676Z# # # ## # ##### # # ##### #### #####
1962024-07-10T15:36:26.676Z# # # # # # # # # # # # #
1972024-07-10T15:36:26.676Z# # # # # # # ##### # # # # #
1982024-07-10T15:36:26.676Z# # # ###### # # # # # # #####
1992024-07-10T15:36:26.676Z# # # # # # # # # # # # #
2002024-07-10T15:36:26.676Z ## ## # # # # ##### # #### #
2012024-07-10T15:36:26.676Z
2022024-07-10T15:36:26.676Z+ wait 1168
2032024-07-10T15:36:27.672Z+ _exit_trap
2042024-07-10T15:36:27.672Z+ local status=0
2052024-07-10T15:36:27.672Z+ [[ 0 -eq 0 ]]
2062024-07-10T15:36:27.672Z+ exit 0
2072024-07-10T15:36:32.678Zprocess exited: duration 611153 ms, exit code 0
2082024-07-10T15:36:32.678Zexec warning: : stdio descriptors remain open after task exit; waiting 60 seconds for them to close
2092024-07-10T15:37:32.695Zexec warning: : stdout descriptor may be held open by a background process; giving up!
2102024-07-10T15:37:32.695Zexec warning: : stderr descriptor may be held open by a background process; giving up!
 
2112024-07-10T15:37:32.707Zfound 14 output files
2122024-07-10T15:37:32.763Zuploading: /tmp/crutest-replace.log (16516955 bytes)
2132024-07-10T15:37:33.981Zuploaded: /tmp/crutest-replace.log
2142024-07-10T15:37:33.981Zuploading: /tmp/dsc.log (1991 bytes)
2152024-07-10T15:37:35.001Zuploaded: /tmp/dsc.log
2162024-07-10T15:37:35.001Zuploading: /tmp/debug/df.txt (1270 bytes)
2172024-07-10T15:37:36.012Zuploaded: /tmp/debug/df.txt
2182024-07-10T15:37:36.012Zuploading: /tmp/debug/dtrace.txt (383102 bytes)
2192024-07-10T15:37:37.049Zuploaded: /tmp/debug/dtrace.txt
2202024-07-10T15:37:37.049Zuploading: /tmp/debug/iostat.txt (199027 bytes)
2212024-07-10T15:37:37.065Zupload warning: file "/tmp/debug/iostat.txt" changed size mid upload: 199027 -> 200215
2222024-07-10T15:37:38.072Zuploaded: /tmp/debug/iostat.txt
2232024-07-10T15:37:38.072Zuploading: /tmp/debug/mpstat.txt (482755 bytes)
2242024-07-10T15:37:38.098Zupload warning: file "/tmp/debug/mpstat.txt" changed size mid upload: 482755 -> 487111
2252024-07-10T15:37:39.106Zuploaded: /tmp/debug/mpstat.txt
2262024-07-10T15:37:39.106Zuploading: /tmp/debug/paging.txt (84842 bytes)
2272024-07-10T15:37:39.118Zupload warning: file "/tmp/debug/paging.txt" changed size mid upload: 84842 -> 85626
2282024-07-10T15:37:40.130Zuploaded: /tmp/debug/paging.txt
2292024-07-10T15:37:40.130Zuploading: /tmp/debug/prstat.txt (1074091 bytes)
2302024-07-10T15:37:40.170Zupload warning: file "/tmp/debug/prstat.txt" changed size mid upload: 1074091 -> 1083127
2312024-07-10T15:37:41.183Zuploaded: /tmp/debug/prstat.txt
2322024-07-10T15:37:41.183Zuploading: /tmp/debug/psrinfo.txt (1528 bytes)
2332024-07-10T15:37:42.192Zuploaded: /tmp/debug/psrinfo.txt
2342024-07-10T15:37:42.192Zuploading: /tmp/debug/upstairs-info.txt (110448 bytes)
2352024-07-10T15:37:43.211Zuploaded: /tmp/debug/upstairs-info.txt
2362024-07-10T15:37:43.211Zuploading: /tmp/dsc/downstairs-8810.txt (1461627 bytes)
2372024-07-10T15:37:44.274Zuploaded: /tmp/dsc/downstairs-8810.txt
2382024-07-10T15:37:44.274Zuploading: /tmp/dsc/downstairs-8820.txt (976122 bytes)
2392024-07-10T15:37:45.319Zuploaded: /tmp/dsc/downstairs-8820.txt
2402024-07-10T15:37:45.319Zuploading: /tmp/dsc/downstairs-8830.txt (1194407 bytes)
2412024-07-10T15:37:46.381Zuploaded: /tmp/dsc/downstairs-8830.txt
2422024-07-10T15:37:46.381Zuploading: /tmp/dsc/downstairs-8840.txt (1240775 bytes)
2432024-07-10T15:37:47.429Zuploaded: /tmp/dsc/downstairs-8840.txt