01JJA2YXH9BT0M8KBRNE93120X: 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: 01JJA2Z8RJKYZ3DQ0H50P0DSPV

Tags:

Artefacts:

Output:

SEQ GLOBAL TIME DETAILS
12025-01-23T17:40:35.969Zjob dependencies complete; ready to run (waiting for 18 m 18 s)
22025-01-23T17:41:32.181Zjob assigned to worker 01JJA410MYM4XEXB2NESATTQFS [factory aws, i-08de9ee897f494062] (queued for 56 s)
32025-01-23T17:41:40.330Zdownloading input: /input/rbuild/out/crucible-dtrace.sha256.txt
42025-01-23T17:41:40.367Zdownloaded input: /input/rbuild/out/crucible-dtrace.sha256.txt
52025-01-23T17:41:40.367Zdownloading input: /input/rbuild/out/crucible-dtrace.tar
62025-01-23T17:41:40.435Zdownloaded input: /input/rbuild/out/crucible-dtrace.tar
72025-01-23T17:41:40.435Zdownloading input: /input/rbuild/out/crucible-nightly.sha256.txt
82025-01-23T17:41:40.449Zdownloaded input: /input/rbuild/out/crucible-nightly.sha256.txt
92025-01-23T17:41:40.449Zdownloading input: /input/rbuild/out/crucible-nightly.tar.gz
102025-01-23T17:41:41.446Zdownloaded input: /input/rbuild/out/crucible-nightly.tar.gz
112025-01-23T17:41:41.447Zdownloading input: /input/rbuild/out/crucible-pantry.sha256.txt
122025-01-23T17:41:41.460Zdownloaded input: /input/rbuild/out/crucible-pantry.sha256.txt
132025-01-23T17:41:41.460Zdownloading input: /input/rbuild/out/crucible-pantry.tar.gz
142025-01-23T17:41:41.693Zdownloaded input: /input/rbuild/out/crucible-pantry.tar.gz
152025-01-23T17:41:41.693Zdownloading input: /input/rbuild/out/crucible.sha256.txt
162025-01-23T17:41:41.707Zdownloaded input: /input/rbuild/out/crucible.sha256.txt
172025-01-23T17:41:41.707Zdownloading input: /input/rbuild/out/crucible.tar.gz
182025-01-23T17:41:41.982Zdownloaded input: /input/rbuild/out/crucible.tar.gz
192025-01-23T17:41:41.985Zdownloading input: /input/rbuild/work/rbins/crucible-downstairs.gz
202025-01-23T17:41:42.155Zdownloaded input: /input/rbuild/work/rbins/crucible-downstairs.gz
212025-01-23T17:41:42.155Zdownloading input: /input/rbuild/work/rbins/crucible-hammer.gz
222025-01-23T17:41:42.309Zdownloaded input: /input/rbuild/work/rbins/crucible-hammer.gz
232025-01-23T17:41:42.309Zdownloading input: /input/rbuild/work/rbins/crudd.gz
242025-01-23T17:41:42.487Zdownloaded input: /input/rbuild/work/rbins/crudd.gz
252025-01-23T17:41:42.490Zdownloading input: /input/rbuild/work/rbins/crutest.gz
262025-01-23T17:41:42.752Zdownloaded input: /input/rbuild/work/rbins/crutest.gz
272025-01-23T17:41:42.752Zdownloading input: /input/rbuild/work/rbins/dsc.gz
282025-01-23T17:41:42.912Zdownloaded input: /input/rbuild/work/rbins/dsc.gz
292025-01-23T17:41:42.915Zdownloading input: /input/rbuild/work/scripts/crudd-speed-battery.sh
302025-01-23T17:41:42.931Zdownloaded input: /input/rbuild/work/scripts/crudd-speed-battery.sh
312025-01-23T17:41:42.931Zdownloading input: /input/rbuild/work/scripts/perf-downstairs-tick.d
322025-01-23T17:41:42.948Zdownloaded input: /input/rbuild/work/scripts/perf-downstairs-tick.d
332025-01-23T17:41:42.948Zdownloading input: /input/rbuild/work/scripts/test_mem.sh
342025-01-23T17:41:42.963Zdownloaded input: /input/rbuild/work/scripts/test_mem.sh
352025-01-23T17:41:42.963Zdownloading input: /input/rbuild/work/scripts/upstairs_info.d
362025-01-23T17:41:42.980Zdownloaded input: /input/rbuild/work/scripts/upstairs_info.d
372025-01-23T17:41:42.982Zdownloading input: /input/rbuild/tmp/cargo-test-out.log
382025-01-23T17:41:43.704Zdownloaded input: /input/rbuild/tmp/cargo-test-out.log
 
392025-01-23T17:41:43.704Zstarting task 0: "setup"
402025-01-23T17:41:43.713Z++ uname -s
412025-01-23T17:41:43.717Z+ kern=SunOS
422025-01-23T17:41:43.717Z+ case "$kern" in
432025-01-23T17:41:43.717Z+ groupadd -g 12345 build
442025-01-23T17:41:43.720Z+ useradd -u 12345 -g build -d /home/build -s /bin/bash -c build -P 'Primary Administrator' build
452025-01-23T17:41:45.725Z+ zfs create -o mountpoint=/work rpool/work
462025-01-23T17:41:45.818Z++ awk '$2 == "/home" { print $3 }' /etc/mnttab
472025-01-23T17:41:45.821Z+ home_fs=zfs
482025-01-23T17:41:45.821Z+ [[ zfs == autofs ]]
492025-01-23T17:41:45.822Z+ mkdir -p /home/build
502025-01-23T17:41:45.822Z+ chown build:build /home/build /work
512025-01-23T17:41:47.824Z+ chmod 0700 /home/build /work
522025-01-23T17:41:47.826Zprocess exited: duration 4123 ms, exit code 0
 
532025-01-23T17:41:47.835Zstarting task 1: "authentication"
542025-01-23T17:41:47.850Zprocess exited: duration 17 ms, exit code 0
 
552025-01-23T17:41:47.856Zstarting task 2: "build"
562025-01-23T17:41:47.861Z+ banner cores
572025-01-23T17:41:47.880Z
582025-01-23T17:41:47.880Z #### #### ##### ###### ####
592025-01-23T17:41:47.880Z # # # # # # # #
602025-01-23T17:41:47.880Z # # # # # ##### ####
612025-01-23T17:41:47.880Z # # # ##### # #
622025-01-23T17:41:47.880Z # # # # # # # # #
632025-01-23T17:41:47.880Z #### #### # # ###### ####
642025-01-23T17:41:47.881Z
652025-01-23T17:41:47.884Z+ pfexec coreadm -i /tmp/core.%f.%p -g /tmp/core.%f.%p -e global -e log -e proc-setid -e global-setid
662025-01-23T17:41:47.888Z+ banner unpack
672025-01-23T17:41:47.891Z
682025-01-23T17:41:47.891Z # # # # ##### ## #### # #
692025-01-23T17:41:47.891Z # # ## # # # # # # # # #
702025-01-23T17:41:47.891Z # # # # # # # # # # ####
712025-01-23T17:41:47.891Z # # # # # ##### ###### # # #
722025-01-23T17:41:47.891Z # # # ## # # # # # # #
732025-01-23T17:41:47.891Z #### # # # # # #### # #
742025-01-23T17:41:47.891Z
752025-01-23T17:41:47.891Z+ mkdir -p /var/tmp/bins
762025-01-23T17:41:47.894Z+ for t in "$input/rbins/"*.gz
772025-01-23T17:41:47.894Z++ basename /input/rbuild/work/rbins/crucible-downstairs.gz
782025-01-23T17:41:47.897Z+ b=crucible-downstairs.gz
792025-01-23T17:41:47.897Z+ b=crucible-downstairs
802025-01-23T17:41:47.897Z+ gunzip
812025-01-23T17:41:48.177Z+ chmod +x /var/tmp/bins/crucible-downstairs
822025-01-23T17:41:48.180Z+ for t in "$input/rbins/"*.gz
832025-01-23T17:41:48.180Z++ basename /input/rbuild/work/rbins/crucible-hammer.gz
842025-01-23T17:41:48.182Z+ b=crucible-hammer.gz
852025-01-23T17:41:48.182Z+ b=crucible-hammer
862025-01-23T17:41:48.182Z+ gunzip
872025-01-23T17:41:48.445Z+ chmod +x /var/tmp/bins/crucible-hammer
882025-01-23T17:41:48.448Z+ for t in "$input/rbins/"*.gz
892025-01-23T17:41:48.451Z++ basename /input/rbuild/work/rbins/crudd.gz
902025-01-23T17:41:48.451Z+ b=crudd.gz
912025-01-23T17:41:48.451Z+ b=crudd
922025-01-23T17:41:48.451Z+ gunzip
932025-01-23T17:41:48.705Z+ chmod +x /var/tmp/bins/crudd
942025-01-23T17:41:48.708Z+ for t in "$input/rbins/"*.gz
952025-01-23T17:41:48.708Z++ basename /input/rbuild/work/rbins/crutest.gz
962025-01-23T17:41:48.711Z+ b=crutest.gz
972025-01-23T17:41:48.711Z+ b=crutest
982025-01-23T17:41:48.711Z+ gunzip
992025-01-23T17:41:48.998Z+ chmod +x /var/tmp/bins/crutest
1002025-01-23T17:41:49.001Z+ for t in "$input/rbins/"*.gz
1012025-01-23T17:41:49.004Z++ basename /input/rbuild/work/rbins/dsc.gz
1022025-01-23T17:41:49.004Z+ b=dsc.gz
1032025-01-23T17:41:49.004Z+ b=dsc
1042025-01-23T17:41:49.004Z+ gunzip
1052025-01-23T17:41:49.148Z+ chmod +x /var/tmp/bins/dsc
1062025-01-23T17:41:49.151Z+ export BINDIR=/var/tmp/bins
1072025-01-23T17:41:49.151Z+ BINDIR=/var/tmp/bins
1082025-01-23T17:41:49.151Z+ export RUST_BACKTRACE=1
1092025-01-23T17:41:49.151Z+ RUST_BACKTRACE=1
1102025-01-23T17:41:49.151Z+ banner setup
1112025-01-23T17:41:49.154Z
1122025-01-23T17:41:49.154Z #### ###### ##### # # #####
1132025-01-23T17:41:49.154Z # # # # # # #
1142025-01-23T17:41:49.154Z #### ##### # # # # #
1152025-01-23T17:41:49.154Z # # # # # #####
1162025-01-23T17:41:49.154Z # # # # # # #
1172025-01-23T17:41:49.154Z #### ###### # #### #
1182025-01-23T17:41:49.154Z
1192025-01-23T17:41:49.154Z+ pfexec plimit -n 9123456 1139
1202025-01-23T17:41:49.157Z+ echo 'Setup self timeout'
1212025-01-23T17:41:49.157ZSetup self timeout
1222025-01-23T17:41:49.157Z+ jobpid=1139
1232025-01-23T17:41:49.160Z+ echo 'Setup debug logging'
1242025-01-23T17:41:49.160ZSetup debug logging
1252025-01-23T17:41:49.160Z+ mkdir /tmp/debug
1262025-01-23T17:41:49.160Z+ sleep 3600
1272025-01-23T17:41:49.160Z+ psrinfo -v
1282025-01-23T17:41:49.163Z+ df -h
1292025-01-23T17:41:49.191Z+ prstat -d d -mLc 1
1302025-01-23T17:41:49.193Z+ iostat -T d -xn 1
1312025-01-23T17:41:49.193Z+ mpstat -T d 1
1322025-01-23T17:41:49.193Z+ vmstat -T d -p 1
1332025-01-23T17:41:49.196Z+ pfexec dtrace -Z -s /input/rbuild/work/scripts/perf-downstairs-tick.d
1342025-01-23T17:41:49.196Z+ banner memtest
1352025-01-23T17:41:49.196Z+ pfexec dtrace -Z -s /input/rbuild/work/scripts/upstairs_info.d
1362025-01-23T17:41:49.199Z
1372025-01-23T17:41:49.199Z # # ###### # # ##### ###### #### #####
1382025-01-23T17:41:49.199Z ## ## # ## ## # # # #
1392025-01-23T17:41:49.199Z # ## # ##### # ## # # ##### #### #
1402025-01-23T17:41:49.199Z # # # # # # # # #
1412025-01-23T17:41:49.199Z # # # # # # # # # #
1422025-01-23T17:41:49.199Z # # ###### # # # ###### #### #
1432025-01-23T17:41:49.199Z
1442025-01-23T17:41:49.199Z+ ptime -m bash /input/rbuild/work/scripts/test_mem.sh
1452025-01-23T17:41:49.210Z/input/rbuild/work
1462025-01-23T17:41:49.238ZMemory usage test begins at January 23, 2025 at 05:41:48 PM UTC
1472025-01-23T17:41:49.241ZMemory usage values in kilobytes unless specified otherwise
1482025-01-23T17:41:49.267ZRegion with ES:16384 EC:16 BS:4096 Size: 1 GiB Extent Size: 64 MiB
1492025-01-23T17:41:59.925Z PID RSS RSS/EC VSZ VSZ/EC HEAP HEAP/EC TOTAL TOTAL/EC EC
1502025-01-23T17:42:00.027Z 1210 92260 5766 120480 7530 72212 4513 120480 7530 16
1512025-01-23T17:42:00.134Z 1208 100544 6284 128764 8047 80500 5031 128764 8047 16
1522025-01-23T17:42:00.235Z 1209 98504 6156 126764 7922 78508 4906 126764 7922 16
1532025-01-23T17:42:00.241ZRegion:1 GiB Extent:64 MiB Total downstairs (pmap -x): 367 MiB
1542025-01-23T17:42:00.251ZSize on disk of all region dirs: 3.07G or 3296823584
1552025-01-23T17:42:01.302Z
1562025-01-23T17:42:01.330ZRegion with ES:16384 EC:160 BS:4096 Size: 10 GiB Extent Size: 64 MiB
1572025-01-23T17:42:20.300Z PID RSS RSS/EC VSZ VSZ/EC HEAP HEAP/EC TOTAL TOTAL/EC EC
1582025-01-23T17:42:20.391Z 1353 41624 260 70984 443 22712 141 70984 443 160
1592025-01-23T17:42:20.478Z 1355 35668 222 65832 411 17580 109 65832 411 160
1602025-01-23T17:42:20.574Z 1354 53380 333 83452 521 35192 219 83452 521 160
1612025-01-23T17:42:20.580ZRegion:10 GiB Extent:64 MiB Total downstairs (pmap -x): 215 MiB
1622025-01-23T17:42:20.591ZSize on disk of all region dirs: 30.7G or 32968229075
1632025-01-23T17:42:21.641Z
1642025-01-23T17:42:21.670ZRegion with ES:16384 EC:1600 BS:4096 Size: 100 GiB Extent Size: 64 MiB
1652025-01-23T17:44:04.649Z PID RSS RSS/EC VSZ VSZ/EC HEAP HEAP/EC TOTAL TOTAL/EC EC
1662025-01-23T17:44:04.838Z 1498 97880 61 138800 86 90500 56 138800 86 1600
1672025-01-23T17:44:05.028Z 1499 98896 61 139828 87 91528 57 139828 87 1600
1682025-01-23T17:44:05.218Z 1500 107036 66 148940 93 100652 62 148940 93 1600
1692025-01-23T17:44:05.224ZRegion:100 GiB Extent:64 MiB Total downstairs (pmap -x): 417 MiB
1702025-01-23T17:44:05.257ZSize on disk of all region dirs: 307G or 329682283958
1712025-01-23T17:44:06.307Z
1722025-01-23T17:44:06.310ZMemory usage test finished on January 23, 2025 at 05:44:05 PM UTC
1732025-01-23T17:44:06.317Z
1742025-01-23T17:44:06.317Zreal 2:17.103264958
1752025-01-23T17:44:06.317Zuser 3:26.158079211
1762025-01-23T17:44:06.317Zsys 4:33.260770413
1772025-01-23T17:44:06.317Ztrap 1.451771180
1782025-01-23T17:44:06.317Ztflt 0.003793639
1792025-01-23T17:44:06.317Zdflt 0.060896476
1802025-01-23T17:44:06.318Zkflt 0.000993695
1812025-01-23T17:44:06.318Zlock 4:04:25.507286763
1822025-01-23T17:44:06.318Zslp 8:16.571918169
1832025-01-23T17:44:06.318Zlat 3:10.491658852
1842025-01-23T17:44:06.318Zstop 0.180224036
1852025-01-23T17:44:11.316Zprocess exited: duration 138448 ms, exit code 0
1862025-01-23T17:44:11.316Zexec warning: : stdio descriptors remain open after task exit; waiting 60 seconds for them to close
1872025-01-23T17:45:11.366Zexec warning: : stdout descriptor may be held open by a background process; giving up!
1882025-01-23T17:45:11.366Zexec warning: : stderr descriptor may be held open by a background process; giving up!
 
1892025-01-23T17:45:11.377Zfound 12 output files
1902025-01-23T17:45:11.377Zuploading: /tmp/test_mem_log.txt (67344 bytes)
1912025-01-23T17:45:12.394Zuploaded: /tmp/test_mem_log.txt
1922025-01-23T17:45:12.395Zuploading: /tmp/debug/df.txt (1270 bytes)
1932025-01-23T17:45:13.406Zuploaded: /tmp/debug/df.txt
1942025-01-23T17:45:13.406Zuploading: /tmp/debug/iostat.txt (61214 bytes)
1952025-01-23T17:45:13.413Zupload warning: file "/tmp/debug/iostat.txt" changed size mid upload: 61214 -> 61814
1962025-01-23T17:45:14.422Zuploaded: /tmp/debug/iostat.txt
1972025-01-23T17:45:14.425Zuploading: /tmp/debug/mpstat.txt (149395 bytes)
1982025-01-23T17:45:14.439Zupload warning: file "/tmp/debug/mpstat.txt" changed size mid upload: 149395 -> 151582
1992025-01-23T17:45:15.447Zuploaded: /tmp/debug/mpstat.txt
2002025-01-23T17:45:15.450Zuploading: /tmp/debug/paging.txt (26663 bytes)
2012025-01-23T17:45:15.453Zupload warning: file "/tmp/debug/paging.txt" changed size mid upload: 26663 -> 27123
2022025-01-23T17:45:16.461Zuploaded: /tmp/debug/paging.txt
2032025-01-23T17:45:16.464Zuploading: /tmp/debug/perf.txt (90276 bytes)
2042025-01-23T17:45:17.473Zuploaded: /tmp/debug/perf.txt
2052025-01-23T17:45:17.476Zuploading: /tmp/debug/prstat.txt (298809 bytes)
2062025-01-23T17:45:17.485Zupload warning: file "/tmp/debug/prstat.txt" changed size mid upload: 298809 -> 306629
2072025-01-23T17:45:18.492Zuploaded: /tmp/debug/prstat.txt
2082025-01-23T17:45:18.494Zuploading: /tmp/debug/psrinfo.txt (1528 bytes)
2092025-01-23T17:45:19.501Zuploaded: /tmp/debug/psrinfo.txt
2102025-01-23T17:45:19.501Zuploading: /tmp/debug/upinfo.txt (13200 bytes)
2112025-01-23T17:45:20.511Zuploaded: /tmp/debug/upinfo.txt
2122025-01-23T17:45:20.511Zuploading: /tmp/dsc/downstairs-8810.txt (5680 bytes)
2132025-01-23T17:45:21.518Zuploaded: /tmp/dsc/downstairs-8810.txt
2142025-01-23T17:45:21.521Zuploading: /tmp/dsc/downstairs-8820.txt (5089 bytes)
2152025-01-23T17:45:22.527Zuploaded: /tmp/dsc/downstairs-8820.txt
2162025-01-23T17:45:22.530Zuploading: /tmp/dsc/downstairs-8830.txt (5084 bytes)
2172025-01-23T17:45:23.537Zuploaded: /tmp/dsc/downstairs-8830.txt