01JHJRD01QJKCJB05X3ZNEBWMD: test-memory

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

Buildomat Job: 01JHJRD9TAN01MXY7C8A24WW8C

Tags:

Artefacts:

Output:

SEQ GLOBAL TIME DETAILS
12025-01-14T16:12:52.202Zjob dependencies complete; ready to run (waiting for 17 m 41 s)
22025-01-14T16:13:40.365Zjob assigned to worker 01JHJSDRE2V8DRKWFF8RATQF34 [factory aws, i-06cf7845a5329660d] (queued for 48 s)
32025-01-14T16:13:47.984Zdownloading input: /input/rbuild/out/crucible-dtrace.sha256.txt
42025-01-14T16:13:48.021Zdownloaded input: /input/rbuild/out/crucible-dtrace.sha256.txt
52025-01-14T16:13:48.021Zdownloading input: /input/rbuild/out/crucible-dtrace.tar
62025-01-14T16:13:48.085Zdownloaded input: /input/rbuild/out/crucible-dtrace.tar
72025-01-14T16:13:48.085Zdownloading input: /input/rbuild/out/crucible-nightly.sha256.txt
82025-01-14T16:13:48.099Zdownloaded input: /input/rbuild/out/crucible-nightly.sha256.txt
92025-01-14T16:13:48.099Zdownloading input: /input/rbuild/out/crucible-nightly.tar.gz
102025-01-14T16:13:49.078Zdownloaded input: /input/rbuild/out/crucible-nightly.tar.gz
112025-01-14T16:13:49.078Zdownloading input: /input/rbuild/out/crucible-pantry.sha256.txt
122025-01-14T16:13:49.092Zdownloaded input: /input/rbuild/out/crucible-pantry.sha256.txt
132025-01-14T16:13:49.092Zdownloading input: /input/rbuild/out/crucible-pantry.tar.gz
142025-01-14T16:13:49.371Zdownloaded input: /input/rbuild/out/crucible-pantry.tar.gz
152025-01-14T16:13:49.371Zdownloading input: /input/rbuild/out/crucible.sha256.txt
162025-01-14T16:13:49.385Zdownloaded input: /input/rbuild/out/crucible.sha256.txt
172025-01-14T16:13:49.385Zdownloading input: /input/rbuild/out/crucible.tar.gz
182025-01-14T16:13:49.751Zdownloaded input: /input/rbuild/out/crucible.tar.gz
192025-01-14T16:13:49.754Zdownloading input: /input/rbuild/work/rbins/crucible-downstairs.gz
202025-01-14T16:13:49.955Zdownloaded input: /input/rbuild/work/rbins/crucible-downstairs.gz
212025-01-14T16:13:49.955Zdownloading input: /input/rbuild/work/rbins/crucible-hammer.gz
222025-01-14T16:13:50.143Zdownloaded input: /input/rbuild/work/rbins/crucible-hammer.gz
232025-01-14T16:13:50.143Zdownloading input: /input/rbuild/work/rbins/crudd.gz
242025-01-14T16:13:50.318Zdownloaded input: /input/rbuild/work/rbins/crudd.gz
252025-01-14T16:13:50.322Zdownloading input: /input/rbuild/work/rbins/crutest.gz
262025-01-14T16:13:50.650Zdownloaded input: /input/rbuild/work/rbins/crutest.gz
272025-01-14T16:13:50.650Zdownloading input: /input/rbuild/work/rbins/dsc.gz
282025-01-14T16:13:50.834Zdownloaded input: /input/rbuild/work/rbins/dsc.gz
292025-01-14T16:13:50.837Zdownloading input: /input/rbuild/work/scripts/crudd-speed-battery.sh
302025-01-14T16:13:50.852Zdownloaded input: /input/rbuild/work/scripts/crudd-speed-battery.sh
312025-01-14T16:13:50.852Zdownloading input: /input/rbuild/work/scripts/perf-downstairs-tick.d
322025-01-14T16:13:50.956Zdownloaded input: /input/rbuild/work/scripts/perf-downstairs-tick.d
332025-01-14T16:13:50.957Zdownloading input: /input/rbuild/work/scripts/test_mem.sh
342025-01-14T16:13:50.976Zdownloaded input: /input/rbuild/work/scripts/test_mem.sh
352025-01-14T16:13:50.976Zdownloading input: /input/rbuild/work/scripts/upstairs_info.d
362025-01-14T16:13:51.055Zdownloaded input: /input/rbuild/work/scripts/upstairs_info.d
372025-01-14T16:13:51.058Zdownloading input: /input/rbuild/tmp/cargo-test-out.log
382025-01-14T16:13:52.006Zdownloaded input: /input/rbuild/tmp/cargo-test-out.log
 
392025-01-14T16:13:52.006Zstarting task 0: "setup"
402025-01-14T16:13:52.019Z++ uname -s
412025-01-14T16:13:52.022Z+ kern=SunOS
422025-01-14T16:13:52.022Z+ case "$kern" in
432025-01-14T16:13:52.022Z+ groupadd -g 12345 build
442025-01-14T16:13:52.024Z+ useradd -u 12345 -g build -d /home/build -s /bin/bash -c build -P 'Primary Administrator' build
452025-01-14T16:13:54.034Z+ zfs create -o mountpoint=/work rpool/work
462025-01-14T16:13:54.207Z++ awk '$2 == "/home" { print $3 }' /etc/mnttab
472025-01-14T16:13:54.209Z+ home_fs=zfs
482025-01-14T16:13:54.209Z+ [[ zfs == autofs ]]
492025-01-14T16:13:54.209Z+ mkdir -p /home/build
502025-01-14T16:13:54.212Z+ chown build:build /home/build /work
512025-01-14T16:13:56.214Z+ chmod 0700 /home/build /work
522025-01-14T16:13:56.217Zprocess exited: duration 4210 ms, exit code 0
 
532025-01-14T16:13:56.222Zstarting task 1: "authentication"
542025-01-14T16:13:56.241Zprocess exited: duration 18 ms, exit code 0
 
552025-01-14T16:13:56.246Zstarting task 2: "build"
562025-01-14T16:13:56.252Z+ banner cores
572025-01-14T16:13:56.255Z
582025-01-14T16:13:56.255Z #### #### ##### ###### ####
592025-01-14T16:13:56.257Z # # # # # # # #
602025-01-14T16:13:56.257Z # # # # # ##### ####
612025-01-14T16:13:56.257Z # # # ##### # #
622025-01-14T16:13:56.257Z # # # # # # # # #
632025-01-14T16:13:56.257Z #### #### # # ###### ####
642025-01-14T16:13:56.257Z
652025-01-14T16:13:56.257Z+ pfexec coreadm -i /tmp/core.%f.%p -g /tmp/core.%f.%p -e global -e log -e proc-setid -e global-setid
662025-01-14T16:13:56.263Z+ banner unpack
672025-01-14T16:13:56.266Z
682025-01-14T16:13:56.266Z # # # # ##### ## #### # #
692025-01-14T16:13:56.266Z # # ## # # # # # # # # #
702025-01-14T16:13:56.266Z # # # # # # # # # # ####
712025-01-14T16:13:56.266Z # # # # # ##### ###### # # #
722025-01-14T16:13:56.266Z # # # ## # # # # # # #
732025-01-14T16:13:56.266Z #### # # # # # #### # #
742025-01-14T16:13:56.267Z
752025-01-14T16:13:56.267Z+ mkdir -p /var/tmp/bins
762025-01-14T16:13:56.269Z+ for t in "$input/rbins/"*.gz
772025-01-14T16:13:56.269Z++ basename /input/rbuild/work/rbins/crucible-downstairs.gz
782025-01-14T16:13:56.272Z+ b=crucible-downstairs.gz
792025-01-14T16:13:56.272Z+ b=crucible-downstairs
802025-01-14T16:13:56.272Z+ gunzip
812025-01-14T16:13:56.559Z+ chmod +x /var/tmp/bins/crucible-downstairs
822025-01-14T16:13:56.561Z+ for t in "$input/rbins/"*.gz
832025-01-14T16:13:56.565Z++ basename /input/rbuild/work/rbins/crucible-hammer.gz
842025-01-14T16:13:56.565Z+ b=crucible-hammer.gz
852025-01-14T16:13:56.565Z+ b=crucible-hammer
862025-01-14T16:13:56.565Z+ gunzip
872025-01-14T16:13:56.831Z+ chmod +x /var/tmp/bins/crucible-hammer
882025-01-14T16:13:56.834Z+ for t in "$input/rbins/"*.gz
892025-01-14T16:13:56.837Z++ basename /input/rbuild/work/rbins/crudd.gz
902025-01-14T16:13:56.837Z+ b=crudd.gz
912025-01-14T16:13:56.837Z+ b=crudd
922025-01-14T16:13:56.837Z+ gunzip
932025-01-14T16:13:57.092Z+ chmod +x /var/tmp/bins/crudd
942025-01-14T16:13:57.095Z+ for t in "$input/rbins/"*.gz
952025-01-14T16:13:57.097Z++ basename /input/rbuild/work/rbins/crutest.gz
962025-01-14T16:13:57.098Z+ b=crutest.gz
972025-01-14T16:13:57.098Z+ b=crutest
982025-01-14T16:13:57.098Z+ gunzip
992025-01-14T16:13:57.387Z+ chmod +x /var/tmp/bins/crutest
1002025-01-14T16:13:57.389Z+ for t in "$input/rbins/"*.gz
1012025-01-14T16:13:57.392Z++ basename /input/rbuild/work/rbins/dsc.gz
1022025-01-14T16:13:57.392Z+ b=dsc.gz
1032025-01-14T16:13:57.392Z+ b=dsc
1042025-01-14T16:13:57.392Z+ gunzip
1052025-01-14T16:13:57.538Z+ chmod +x /var/tmp/bins/dsc
1062025-01-14T16:13:57.544Z+ export BINDIR=/var/tmp/bins
1072025-01-14T16:13:57.545Z+ BINDIR=/var/tmp/bins
1082025-01-14T16:13:57.545Z+ export RUST_BACKTRACE=1
1092025-01-14T16:13:57.545Z+ RUST_BACKTRACE=1
1102025-01-14T16:13:57.545Z+ banner setup
1112025-01-14T16:13:57.548Z
1122025-01-14T16:13:57.548Z #### ###### ##### # # #####
1132025-01-14T16:13:57.548Z # # # # # # #
1142025-01-14T16:13:57.548Z #### ##### # # # # #
1152025-01-14T16:13:57.548Z # # # # # #####
1162025-01-14T16:13:57.548Z # # # # # # #
1172025-01-14T16:13:57.548Z #### ###### # #### #
1182025-01-14T16:13:57.548Z
1192025-01-14T16:13:57.548Z+ pfexec plimit -n 9123456 1141
1202025-01-14T16:13:57.548Z+ echo 'Setup self timeout'
1212025-01-14T16:13:57.548ZSetup self timeout
1222025-01-14T16:13:57.549Z+ jobpid=1141
1232025-01-14T16:13:57.562Z+ echo 'Setup debug logging'
1242025-01-14T16:13:57.562ZSetup debug logging
1252025-01-14T16:13:57.562Z+ mkdir /tmp/debug
1262025-01-14T16:13:57.562Z+ sleep 3600
1272025-01-14T16:13:57.562Z+ psrinfo -v
1282025-01-14T16:13:57.562Z+ df -h
1292025-01-14T16:13:57.562Z+ prstat -d d -mLc 1
1302025-01-14T16:13:57.562Z+ iostat -T d -xn 1
1312025-01-14T16:13:57.566Z+ mpstat -T d 1
1322025-01-14T16:13:57.566Z+ vmstat -T d -p 1
1332025-01-14T16:13:57.566Z+ pfexec dtrace -Z -s /input/rbuild/work/scripts/perf-downstairs-tick.d
1342025-01-14T16:13:57.566Z+ banner memtest
1352025-01-14T16:13:57.566Z+ pfexec dtrace -Z -s /input/rbuild/work/scripts/upstairs_info.d
1362025-01-14T16:13:57.568Z
1372025-01-14T16:13:57.568Z # # ###### # # ##### ###### #### #####
1382025-01-14T16:13:57.568Z ## ## # ## ## # # # #
1392025-01-14T16:13:57.568Z # ## # ##### # ## # # ##### #### #
1402025-01-14T16:13:57.568Z # # # # # # # # #
1412025-01-14T16:13:57.569Z # # # # # # # # # #
1422025-01-14T16:13:57.569Z # # ###### # # # ###### #### #
1432025-01-14T16:13:57.569Z
1442025-01-14T16:13:57.569Z+ ptime -m bash /input/rbuild/work/scripts/test_mem.sh
1452025-01-14T16:13:57.584Z/input/rbuild/work
1462025-01-14T16:13:57.590ZMemory usage test begins at January 14, 2025 at 04:13:56 PM UTC
1472025-01-14T16:13:57.593ZMemory usage values in kilobytes unless specified otherwise
1482025-01-14T16:13:57.621ZRegion with ES:16384 EC:16 BS:4096 Size: 1 GiB Extent Size: 64 MiB
1492025-01-14T16:14:08.223Z PID RSS RSS/EC VSZ VSZ/EC HEAP HEAP/EC TOTAL TOTAL/EC EC
1502025-01-14T16:14:08.328Z 1212 87868 5491 116404 7275 68164 4260 116404 7275 16
1512025-01-14T16:14:08.428Z 1210 93088 5818 121484 7592 73240 4577 121484 7592 16
1522025-01-14T16:14:08.529Z 1211 88056 5503 116408 7275 68164 4260 116408 7275 16
1532025-01-14T16:14:08.534ZRegion:1 GiB Extent:64 MiB Total downstairs (pmap -x): 345 MiB
1542025-01-14T16:14:08.545ZSize on disk of all region dirs: 3.07G or 3296823584
1552025-01-14T16:14:09.593Z
1562025-01-14T16:14:09.621ZRegion with ES:16384 EC:160 BS:4096 Size: 10 GiB Extent Size: 64 MiB
1572025-01-14T16:14:27.818Z PID RSS RSS/EC VSZ VSZ/EC HEAP HEAP/EC TOTAL TOTAL/EC EC
1582025-01-14T16:14:27.915Z 1355 45912 286 75420 471 27144 169 75420 471 160
1592025-01-14T16:14:28.010Z 1357 36416 227 65924 412 17636 110 65924 412 160
1602025-01-14T16:14:28.109Z 1356 51980 324 82508 515 34220 213 82508 515 160
1612025-01-14T16:14:28.114ZRegion:10 GiB Extent:64 MiB Total downstairs (pmap -x): 218 MiB
1622025-01-14T16:14:28.126ZSize on disk of all region dirs: 30.7G or 32968229075
1632025-01-14T16:14:29.175Z
1642025-01-14T16:14:29.204ZRegion with ES:16384 EC:1600 BS:4096 Size: 100 GiB Extent Size: 64 MiB
1652025-01-14T16:16:08.424Z PID RSS RSS/EC VSZ VSZ/EC HEAP HEAP/EC TOTAL TOTAL/EC EC
1662025-01-14T16:16:08.637Z 1500 109000 68 150060 93 101752 63 150060 93 1600
1672025-01-14T16:16:08.829Z 1502 96776 60 137856 86 89544 55 137856 86 1600
1682025-01-14T16:16:09.036Z 1501 108088 67 149148 93 100852 63 149148 93 1600
1692025-01-14T16:16:09.042ZRegion:100 GiB Extent:64 MiB Total downstairs (pmap -x): 426 MiB
1702025-01-14T16:16:09.076ZSize on disk of all region dirs: 307G or 329682283958
1712025-01-14T16:16:10.126Z
1722025-01-14T16:16:10.131ZMemory usage test finished on January 14, 2025 at 04:16:08 PM UTC
1732025-01-14T16:16:10.131Z
1742025-01-14T16:16:10.131Zreal 2:12.549968773
1752025-01-14T16:16:10.131Zuser 3:11.036213196
1762025-01-14T16:16:10.131Zsys 4:31.290402329
1772025-01-14T16:16:10.131Ztrap 1.514901446
1782025-01-14T16:16:10.131Ztflt 0.003470076
1792025-01-14T16:16:10.131Zdflt 0.069071485
1802025-01-14T16:16:10.131Zkflt 0.001218410
1812025-01-14T16:16:10.131Zlock 3:55:54.915062107
1822025-01-14T16:16:10.131Zslp 8:01.741311238
1832025-01-14T16:16:10.131Zlat 3:11.580394044
1842025-01-14T16:16:10.131Zstop 0.197156104
1852025-01-14T16:16:15.136Zprocess exited: duration 133875 ms, exit code 0
1862025-01-14T16:16:15.136Zexec warning: : stdio descriptors remain open after task exit; waiting 60 seconds for them to close
1872025-01-14T16:17:15.183Zexec warning: : stdout descriptor may be held open by a background process; giving up!
1882025-01-14T16:17:15.183Zexec warning: : stderr descriptor may be held open by a background process; giving up!
 
1892025-01-14T16:17:15.193Zfound 12 output files
1902025-01-14T16:17:15.193Zuploading: /tmp/test_mem_log.txt (63142 bytes)
1912025-01-14T16:17:16.205Zuploaded: /tmp/test_mem_log.txt
1922025-01-14T16:17:16.205Zuploading: /tmp/debug/df.txt (1270 bytes)
1932025-01-14T16:17:17.217Zuploaded: /tmp/debug/df.txt
1942025-01-14T16:17:17.219Zuploading: /tmp/debug/iostat.txt (59698 bytes)
1952025-01-14T16:17:17.224Zupload warning: file "/tmp/debug/iostat.txt" changed size mid upload: 59698 -> 60298
1962025-01-14T16:17:18.230Zuploaded: /tmp/debug/iostat.txt
1972025-01-14T16:17:18.233Zuploading: /tmp/debug/mpstat.txt (145941 bytes)
1982025-01-14T16:17:18.239Zupload warning: file "/tmp/debug/mpstat.txt" changed size mid upload: 145941 -> 148128
1992025-01-14T16:17:19.246Zuploaded: /tmp/debug/mpstat.txt
2002025-01-14T16:17:19.247Zuploading: /tmp/debug/paging.txt (25930 bytes)
2012025-01-14T16:17:19.253Zupload warning: file "/tmp/debug/paging.txt" changed size mid upload: 25930 -> 26548
2022025-01-14T16:17:20.259Zuploaded: /tmp/debug/paging.txt
2032025-01-14T16:17:20.262Zuploading: /tmp/debug/perf.txt (90276 bytes)
2042025-01-14T16:17:21.273Zuploaded: /tmp/debug/perf.txt
2052025-01-14T16:17:21.276Zuploading: /tmp/debug/prstat.txt (287544 bytes)
2062025-01-14T16:17:21.286Zupload warning: file "/tmp/debug/prstat.txt" changed size mid upload: 287544 -> 295309
2072025-01-14T16:17:22.293Zuploaded: /tmp/debug/prstat.txt
2082025-01-14T16:17:22.295Zuploading: /tmp/debug/psrinfo.txt (1528 bytes)
2092025-01-14T16:17:23.302Zuploaded: /tmp/debug/psrinfo.txt
2102025-01-14T16:17:23.302Zuploading: /tmp/debug/upinfo.txt (17632 bytes)
2112025-01-14T16:17:24.311Zuploaded: /tmp/debug/upinfo.txt
2122025-01-14T16:17:24.314Zuploading: /tmp/dsc/downstairs-8810.txt (5675 bytes)
2132025-01-14T16:17:25.319Zuploaded: /tmp/dsc/downstairs-8810.txt
2142025-01-14T16:17:25.322Zuploading: /tmp/dsc/downstairs-8820.txt (5084 bytes)
2152025-01-14T16:17:26.328Zuploaded: /tmp/dsc/downstairs-8820.txt
2162025-01-14T16:17:26.328Zuploading: /tmp/dsc/downstairs-8830.txt (5080 bytes)
2172025-01-14T16:17:27.336Zuploaded: /tmp/dsc/downstairs-8830.txt