01JEW0KXE1JF8EQEPB0K155G3A: 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: 01JEW0M68K2F1EM53BYA4VPCEP

Tags:

Artefacts:

Output:

SEQ GLOBAL TIME DETAILS
12024-12-11T23:41:51.351Zjob dependencies complete; ready to run (waiting for 17 m 1 s)
22024-12-11T23:42:14.417Zjob assigned to worker 01JEW1KCEQK6FB5CAM0CBS78Y5 [factory gimlet-EVT22200007-propolis, EVT22200007/20359] (queued for 23 s)
32024-12-11T23:42:22.734Zdownloading input: /input/rbuild/out/crucible-dtrace.sha256.txt
42024-12-11T23:42:22.758Zdownloaded input: /input/rbuild/out/crucible-dtrace.sha256.txt
52024-12-11T23:42:22.758Zdownloading input: /input/rbuild/out/crucible-dtrace.tar
62024-12-11T23:42:22.855Zdownloaded input: /input/rbuild/out/crucible-dtrace.tar
72024-12-11T23:42:22.879Zdownloading input: /input/rbuild/out/crucible-nightly.sha256.txt
82024-12-11T23:42:22.903Zdownloaded input: /input/rbuild/out/crucible-nightly.sha256.txt
92024-12-11T23:42:22.903Zdownloading input: /input/rbuild/out/crucible-nightly.tar.gz
102024-12-11T23:42:27.547Zdownloaded input: /input/rbuild/out/crucible-nightly.tar.gz
112024-12-11T23:42:27.547Zdownloading input: /input/rbuild/out/crucible-pantry.sha256.txt
122024-12-11T23:42:27.582Zdownloaded input: /input/rbuild/out/crucible-pantry.sha256.txt
132024-12-11T23:42:27.582Zdownloading input: /input/rbuild/out/crucible-pantry.tar.gz
142024-12-11T23:42:28.475Zdownloaded input: /input/rbuild/out/crucible-pantry.tar.gz
152024-12-11T23:42:28.475Zdownloading input: /input/rbuild/out/crucible.sha256.txt
162024-12-11T23:42:28.509Zdownloaded input: /input/rbuild/out/crucible.sha256.txt
172024-12-11T23:42:28.510Zdownloading input: /input/rbuild/out/crucible.tar.gz
182024-12-11T23:42:29.739Zdownloaded input: /input/rbuild/out/crucible.tar.gz
192024-12-11T23:42:29.763Zdownloading input: /input/rbuild/work/rbins/crucible-downstairs.gz
202024-12-11T23:42:30.588Zdownloaded input: /input/rbuild/work/rbins/crucible-downstairs.gz
212024-12-11T23:42:30.588Zdownloading input: /input/rbuild/work/rbins/crucible-hammer.gz
222024-12-11T23:42:31.321Zdownloaded input: /input/rbuild/work/rbins/crucible-hammer.gz
232024-12-11T23:42:31.321Zdownloading input: /input/rbuild/work/rbins/crudd.gz
242024-12-11T23:42:32.029Zdownloaded input: /input/rbuild/work/rbins/crudd.gz
252024-12-11T23:42:32.029Zdownloading input: /input/rbuild/work/rbins/crutest.gz
262024-12-11T23:42:32.816Zdownloaded input: /input/rbuild/work/rbins/crutest.gz
272024-12-11T23:42:32.816Zdownloading input: /input/rbuild/work/rbins/dsc.gz
282024-12-11T23:42:33.215Zdownloaded input: /input/rbuild/work/rbins/dsc.gz
292024-12-11T23:42:33.239Zdownloading input: /input/rbuild/work/scripts/crudd-speed-battery.sh
302024-12-11T23:42:33.263Zdownloaded input: /input/rbuild/work/scripts/crudd-speed-battery.sh
312024-12-11T23:42:33.263Zdownloading input: /input/rbuild/work/scripts/perf-downstairs-tick.d
322024-12-11T23:42:33.292Zdownloaded input: /input/rbuild/work/scripts/perf-downstairs-tick.d
332024-12-11T23:42:33.315Zdownloading input: /input/rbuild/work/scripts/test_mem.sh
342024-12-11T23:42:33.339Zdownloaded input: /input/rbuild/work/scripts/test_mem.sh
352024-12-11T23:42:33.339Zdownloading input: /input/rbuild/work/scripts/upstairs_info.d
362024-12-11T23:42:33.387Zdownloaded input: /input/rbuild/work/scripts/upstairs_info.d
372024-12-11T23:42:33.411Zdownloading input: /input/rbuild/tmp/cargo-test-out.log
382024-12-11T23:42:36.576Zdownloaded input: /input/rbuild/tmp/cargo-test-out.log
 
392024-12-11T23:42:36.576Zstarting task 0: "setup"
402024-12-11T23:42:36.600Z++ uname -s
412024-12-11T23:42:36.602Z+ kern=SunOS
422024-12-11T23:42:36.602Z+ case "$kern" in
432024-12-11T23:42:36.602Z+ groupadd -g 12345 build
442024-12-11T23:42:36.602Z+ useradd -u 12345 -g build -d /home/build -s /bin/bash -c build -P 'Primary Administrator' build
452024-12-11T23:42:38.603Z+ zfs create -o mountpoint=/work rpool/work
462024-12-11T23:42:38.641Z++ awk '$2 == "/home" { print $3 }' /etc/mnttab
472024-12-11T23:42:38.664Z+ home_fs=zfs
482024-12-11T23:42:38.664Z+ [[ zfs == autofs ]]
492024-12-11T23:42:38.664Z+ mkdir -p /home/build
502024-12-11T23:42:38.664Z+ chown build:build /home/build /work
512024-12-11T23:42:40.651Z+ chmod 0700 /home/build /work
522024-12-11T23:42:40.675Zprocess exited: duration 4078 ms, exit code 0
 
532024-12-11T23:42:40.726Zstarting task 1: "authentication"
542024-12-11T23:42:40.774Zprocess exited: duration 51 ms, exit code 0
 
552024-12-11T23:42:40.823Zstarting task 2: "build"
562024-12-11T23:42:40.848Z+ banner cores
572024-12-11T23:42:40.848Z
582024-12-11T23:42:40.848Z #### #### ##### ###### ####
592024-12-11T23:42:40.848Z # # # # # # # #
602024-12-11T23:42:40.848Z # # # # # ##### ####
612024-12-11T23:42:40.848Z # # # ##### # #
622024-12-11T23:42:40.848Z # # # # # # # # #
632024-12-11T23:42:40.848Z #### #### # # ###### ####
642024-12-11T23:42:40.848Z
652024-12-11T23:42:40.848Z+ pfexec coreadm -i /tmp/core.%f.%p -g /tmp/core.%f.%p -e global -e log -e proc-setid -e global-setid
662024-12-11T23:42:40.848Z+ banner unpack
672024-12-11T23:42:40.872Z
682024-12-11T23:42:40.872Z # # # # ##### ## #### # #
692024-12-11T23:42:40.873Z # # ## # # # # # # # # #
702024-12-11T23:42:40.873Z # # # # # # # # # # ####
712024-12-11T23:42:40.873Z # # # # # ##### ###### # # #
722024-12-11T23:42:40.873Z # # # ## # # # # # # #
732024-12-11T23:42:40.873Z #### # # # # # #### # #
742024-12-11T23:42:40.873Z
752024-12-11T23:42:40.873Z+ mkdir -p /var/tmp/bins
762024-12-11T23:42:40.873Z+ for t in "$input/rbins/"*.gz
772024-12-11T23:42:40.873Z++ basename /input/rbuild/work/rbins/crucible-downstairs.gz
782024-12-11T23:42:40.873Z+ b=crucible-downstairs.gz
792024-12-11T23:42:40.873Z+ b=crucible-downstairs
802024-12-11T23:42:40.873Z+ gunzip
812024-12-11T23:42:41.220Z+ chmod +x /var/tmp/bins/crucible-downstairs
822024-12-11T23:42:41.243Z+ for t in "$input/rbins/"*.gz
832024-12-11T23:42:41.244Z++ basename /input/rbuild/work/rbins/crucible-hammer.gz
842024-12-11T23:42:41.244Z+ b=crucible-hammer.gz
852024-12-11T23:42:41.244Z+ b=crucible-hammer
862024-12-11T23:42:41.244Z+ gunzip
872024-12-11T23:42:41.570Z+ chmod +x /var/tmp/bins/crucible-hammer
882024-12-11T23:42:41.595Z+ for t in "$input/rbins/"*.gz
892024-12-11T23:42:41.595Z++ basename /input/rbuild/work/rbins/crudd.gz
902024-12-11T23:42:41.595Z+ b=crudd.gz
912024-12-11T23:42:41.595Z+ b=crudd
922024-12-11T23:42:41.595Z+ gunzip
932024-12-11T23:42:41.912Z+ chmod +x /var/tmp/bins/crudd
942024-12-11T23:42:41.936Z+ for t in "$input/rbins/"*.gz
952024-12-11T23:42:41.936Z++ basename /input/rbuild/work/rbins/crutest.gz
962024-12-11T23:42:41.936Z+ b=crutest.gz
972024-12-11T23:42:41.936Z+ b=crutest
982024-12-11T23:42:41.936Z+ gunzip
992024-12-11T23:42:42.295Z+ chmod +x /var/tmp/bins/crutest
1002024-12-11T23:42:42.319Z+ for t in "$input/rbins/"*.gz
1012024-12-11T23:42:42.319Z++ basename /input/rbuild/work/rbins/dsc.gz
1022024-12-11T23:42:42.319Z+ b=dsc.gz
1032024-12-11T23:42:42.319Z+ b=dsc
1042024-12-11T23:42:42.319Z+ gunzip
1052024-12-11T23:42:42.494Z+ chmod +x /var/tmp/bins/dsc
1062024-12-11T23:42:42.519Z+ export BINDIR=/var/tmp/bins
1072024-12-11T23:42:42.519Z+ BINDIR=/var/tmp/bins
1082024-12-11T23:42:42.519Z+ banner setup
1092024-12-11T23:42:42.519Z
1102024-12-11T23:42:42.519Z #### ###### ##### # # #####
1112024-12-11T23:42:42.519Z # # # # # # #
1122024-12-11T23:42:42.519Z #### ##### # # # # #
1132024-12-11T23:42:42.519Z # # # # # #####
1142024-12-11T23:42:42.519Z # # # # # # #
1152024-12-11T23:42:42.519Z #### ###### # #### #
1162024-12-11T23:42:42.519Z
1172024-12-11T23:42:42.519Z+ pfexec plimit -n 9123456 1142
1182024-12-11T23:42:42.519Z+ echo 'Setup self timeout'
1192024-12-11T23:42:42.519Z+ jobpid=1142
1202024-12-11T23:42:42.519ZSetup self timeout
1212024-12-11T23:42:42.519Z+ echo 'Setup debug logging'
1222024-12-11T23:42:42.519ZSetup debug logging
1232024-12-11T23:42:42.519Z+ mkdir /tmp/debug
1242024-12-11T23:42:42.519Z+ sleep 3600
1252024-12-11T23:42:42.519Z+ psrinfo -v
1262024-12-11T23:42:42.520Z+ df -h
1272024-12-11T23:42:42.544Zdf: cannot statvfs /var/metadata/iso: Permission denied
1282024-12-11T23:42:42.544Z+ true
1292024-12-11T23:42:42.544Z+ prstat -d d -mLc 1
1302024-12-11T23:42:42.544Z+ iostat -T d -xn 1
1312024-12-11T23:42:42.544Z+ mpstat -T d 1
1322024-12-11T23:42:42.544Z+ vmstat -T d -p 1
1332024-12-11T23:42:42.544Z+ pfexec dtrace -Z -s /input/rbuild/work/scripts/perf-downstairs-tick.d
1342024-12-11T23:42:42.544Z+ banner memtest
1352024-12-11T23:42:42.544Z+ pfexec dtrace -Z -s /input/rbuild/work/scripts/upstairs_info.d
1362024-12-11T23:42:42.544Z
1372024-12-11T23:42:42.544Z # # ###### # # ##### ###### #### #####
1382024-12-11T23:42:42.544Z ## ## # ## ## # # # #
1392024-12-11T23:42:42.544Z # ## # ##### # ## # # ##### #### #
1402024-12-11T23:42:42.544Z # # # # # # # # #
1412024-12-11T23:42:42.544Z # # # # # # # # # #
1422024-12-11T23:42:42.544Z # # ###### # # # ###### #### #
1432024-12-11T23:42:42.544Z
1442024-12-11T23:42:42.544Z+ ptime -m bash /input/rbuild/work/scripts/test_mem.sh
1452024-12-11T23:42:42.570Z/input/rbuild/work
1462024-12-11T23:42:42.570ZMemory usage test begins at December 11, 2024 at 11:42:42 PM UTC
1472024-12-11T23:42:42.570ZMemory usage values in kilobytes unless specified otherwise
1482024-12-11T23:42:42.606ZRegion with ES:16384 EC:16 BS:4096 Size: 1 GiB Extent Size: 64 MiB
1492024-12-11T23:42:54.312Z PID RSS RSS/EC VSZ VSZ/EC HEAP HEAP/EC TOTAL TOTAL/EC EC
1502024-12-11T23:42:54.464Z 1211 101612 6350 128988 8061 81528 5095 128988 8061 16
1512024-12-11T23:42:54.620Z 1212 102596 6412 130968 8185 83520 5220 130968 8185 16
1522024-12-11T23:42:54.811Z 1213 101720 6357 129112 8069 81656 5103 129112 8069 16
1532024-12-11T23:42:54.834ZRegion:1 GiB Extent:64 MiB Total downstairs (pmap -x): 379 MiB
1542024-12-11T23:42:54.834ZSize on disk of all region dirs: 3.07G or 3296823584
1552024-12-11T23:42:55.888Z
1562024-12-11T23:42:55.921ZRegion with ES:16384 EC:160 BS:4096 Size: 10 GiB Extent Size: 64 MiB
1572024-12-11T23:43:13.440Z PID RSS RSS/EC VSZ VSZ/EC HEAP HEAP/EC TOTAL TOTAL/EC EC
1582024-12-11T23:43:13.621Z 1356 110284 689 139056 869 91588 572 139056 869 160
1592024-12-11T23:43:13.832Z 1357 110648 691 139140 869 91668 572 139140 869 160
1602024-12-11T23:43:14.023Z 1358 109848 686 138344 864 90888 568 138344 864 160
1612024-12-11T23:43:14.046ZRegion:10 GiB Extent:64 MiB Total downstairs (pmap -x): 406 MiB
1622024-12-11T23:43:14.046ZSize on disk of all region dirs: 30.7G or 32968229075
1632024-12-11T23:43:15.105Z
1642024-12-11T23:43:15.140ZRegion with ES:16384 EC:1600 BS:4096 Size: 100 GiB Extent Size: 64 MiB
1652024-12-11T23:44:42.516Z PID RSS RSS/EC VSZ VSZ/EC HEAP HEAP/EC TOTAL TOTAL/EC EC
1662024-12-11T23:44:43.028Z 1503 174292 108 214340 133 166852 104 214340 133 1600
1672024-12-11T23:44:43.617Z 1501 171972 107 212016 132 164524 102 212016 132 1600
1682024-12-11T23:44:44.098Z 1502 172992 108 213048 133 165560 103 213048 133 1600
1692024-12-11T23:44:44.122ZRegion:100 GiB Extent:64 MiB Total downstairs (pmap -x): 624 MiB
1702024-12-11T23:44:44.151ZSize on disk of all region dirs: 307G or 329682283958
1712024-12-11T23:44:45.219Z
1722024-12-11T23:44:45.243ZMemory usage test finished on December 11, 2024 at 11:44:44 PM UTC
1732024-12-11T23:44:45.243Z
1742024-12-11T23:44:45.243Zreal 2:02.684495767
1752024-12-11T23:44:45.243Zuser 2:43.623273693
1762024-12-11T23:44:45.243Zsys 4:35.191430126
1772024-12-11T23:44:45.243Ztrap 2.404966461
1782024-12-11T23:44:45.243Ztflt 0.005836619
1792024-12-11T23:44:45.243Zdflt 0.102571211
1802024-12-11T23:44:45.243Zkflt 0.021563618
1812024-12-11T23:44:45.243Zlock 3:34:08.925044318
1822024-12-11T23:44:45.243Zslp 8:32.878831584
1832024-12-11T23:44:45.243Zlat 6:56.110634423
1842024-12-11T23:44:45.243Zstop 0.179164133
1852024-12-11T23:44:50.232Zprocess exited: duration 124405 ms, exit code 0
1862024-12-11T23:44:50.232Zexec warning: : stdio descriptors remain open after task exit; waiting 60 seconds for them to close
1872024-12-11T23:45:50.243Zexec warning: : stdout descriptor may be held open by a background process; giving up!
1882024-12-11T23:45:50.243Zexec warning: : stderr descriptor may be held open by a background process; giving up!
 
1892024-12-11T23:45:50.324Zfound 12 output files
1902024-12-11T23:45:50.324Zuploading: /tmp/test_mem_log.txt (75613 bytes)
1912024-12-11T23:45:51.485Zuploaded: /tmp/test_mem_log.txt
1922024-12-11T23:45:51.485Zuploading: /tmp/debug/df.txt (1270 bytes)
1932024-12-11T23:45:52.586Zuploaded: /tmp/debug/df.txt
1942024-12-11T23:45:52.609Zuploading: /tmp/debug/iostat.txt (69724 bytes)
1952024-12-11T23:45:52.720Zupload warning: file "/tmp/debug/iostat.txt" changed size mid upload: 69724 -> 70831
1962024-12-11T23:45:53.789Zuploaded: /tmp/debug/iostat.txt
1972024-12-11T23:45:53.789Zuploading: /tmp/debug/mpstat.txt (137978 bytes)
1982024-12-11T23:45:53.946Zupload warning: file "/tmp/debug/mpstat.txt" changed size mid upload: 137978 -> 140898
1992024-12-11T23:45:55.016Zuploaded: /tmp/debug/mpstat.txt
2002024-12-11T23:45:55.039Zuploading: /tmp/debug/paging.txt (24810 bytes)
2012024-12-11T23:45:55.128Zupload warning: file "/tmp/debug/paging.txt" changed size mid upload: 24810 -> 25548
2022024-12-11T23:45:56.197Zuploaded: /tmp/debug/paging.txt
2032024-12-11T23:45:56.197Zuploading: /tmp/debug/perf.txt (98571 bytes)
2042024-12-11T23:45:57.378Zuploaded: /tmp/debug/perf.txt
2052024-12-11T23:45:57.401Zuploading: /tmp/debug/prstat.txt (270958 bytes)
2062024-12-11T23:45:57.556Zupload warning: file "/tmp/debug/prstat.txt" changed size mid upload: 270958 -> 280048
2072024-12-11T23:45:58.624Zuploaded: /tmp/debug/prstat.txt
2082024-12-11T23:45:58.624Zuploading: /tmp/debug/psrinfo.txt (1528 bytes)
2092024-12-11T23:45:59.716Zuploaded: /tmp/debug/psrinfo.txt
2102024-12-11T23:45:59.716Zuploading: /tmp/debug/upinfo.txt (15504 bytes)
2112024-12-11T23:46:00.851Zuploaded: /tmp/debug/upinfo.txt
2122024-12-11T23:46:00.851Zuploading: /tmp/dsc/downstairs-8810.txt (5601 bytes)
2132024-12-11T23:46:01.965Zuploaded: /tmp/dsc/downstairs-8810.txt
2142024-12-11T23:46:01.965Zuploading: /tmp/dsc/downstairs-8820.txt (5015 bytes)
2152024-12-11T23:46:03.083Zuploaded: /tmp/dsc/downstairs-8820.txt
2162024-12-11T23:46:03.083Zuploading: /tmp/dsc/downstairs-8830.txt (5014 bytes)
2172024-12-11T23:46:04.194Zuploaded: /tmp/dsc/downstairs-8830.txt