01HPJ5CAVKXXNWF2V370W023BF: test-ds

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

Buildomat Job: 01HPJ5CQHDB9V7009HAKMG3XJ4

Tags:

Output:

SEQ GLOBAL TIME DETAILS
12024-02-13T21:35:54.434Zjob dependencies complete; ready to run (waiting for 16 m 54 s)
22024-02-13T21:36:55.087Zjob assigned to worker 01HPJ6BXWYZTKTYC2Q7BB5TBQS (queued for 1 m 0 s)
32024-02-13T21:36:55.416Zdownloading input: /input/build/work/bins/crucible-downstairs.gz
42024-02-13T21:37:20.144Zdownloaded input: /input/build/work/bins/crucible-downstairs.gz
52024-02-13T21:37:20.144Zdownloading input: /input/build/work/bins/crucible-hammer.gz
62024-02-13T21:37:40.248Zdownloaded input: /input/build/work/bins/crucible-hammer.gz
72024-02-13T21:37:40.249Zdownloading input: /input/build/work/bins/crutest.gz
82024-02-13T21:37:53.787Zdownloaded input: /input/build/work/bins/crutest.gz
92024-02-13T21:37:53.788Zdownloading input: /input/build/work/bins/dsc.gz
102024-02-13T21:38:30.391Zdownloaded input: /input/build/work/bins/dsc.gz
112024-02-13T21:38:30.411Zdownloading input: /input/build/work/scripts/perf-downstairs-tick.d
122024-02-13T21:38:30.555Zdownloaded input: /input/build/work/scripts/perf-downstairs-tick.d
132024-02-13T21:38:30.556Zdownloading input: /input/build/work/scripts/test_ds.sh
142024-02-13T21:38:30.853Zdownloaded input: /input/build/work/scripts/test_ds.sh
152024-02-13T21:38:30.853Zdownloading input: /input/build/work/scripts/test_live_repair.sh
162024-02-13T21:38:30.853Zdownloaded input: /input/build/work/scripts/test_live_repair.sh
172024-02-13T21:38:30.853Zdownloading input: /input/build/work/scripts/test_repair.sh
182024-02-13T21:38:30.853Zdownloaded input: /input/build/work/scripts/test_repair.sh
192024-02-13T21:38:30.853Zdownloading input: /input/build/work/scripts/test_replay.sh
202024-02-13T21:38:30.853Zdownloaded input: /input/build/work/scripts/test_replay.sh
212024-02-13T21:38:30.853Zdownloading input: /input/build/work/scripts/test_up.sh
222024-02-13T21:38:31.095Zdownloaded input: /input/build/work/scripts/test_up.sh
232024-02-13T21:38:31.095Zdownloading input: /input/build/work/scripts/upstairs_info.d
242024-02-13T21:38:31.100Zdownloaded input: /input/build/work/scripts/upstairs_info.d
252024-02-13T21:38:31.100Zdownloading input: /input/build/tmp/cargo-test-out.log
262024-02-13T21:38:59.729Zdownloaded input: /input/build/tmp/cargo-test-out.log
 
272024-02-13T21:38:59.729Zstarting task 0: "setup"
282024-02-13T21:39:00.042Z++ uname -s
292024-02-13T21:39:00.057Z+ kern=SunOS
302024-02-13T21:39:00.057Z+ case "$kern" in
312024-02-13T21:39:00.057Z+ groupadd -g 12345 build
322024-02-13T21:39:00.057Z+ useradd -u 12345 -g build -d /home/build -s /bin/bash -c build -P 'Primary Administrator' build
332024-02-13T21:39:02.070Z+ zfs create -o mountpoint=/work rpool/work
342024-02-13T21:39:02.211Z++ awk '$2 == "/home" { print $3 }' /etc/mnttab
352024-02-13T21:39:02.222Z+ home_fs=zfs
362024-02-13T21:39:02.222Z+ [[ zfs == autofs ]]
372024-02-13T21:39:02.222Z+ mkdir -p /home/build
382024-02-13T21:39:02.222Z+ chown build:build /home/build /work
392024-02-13T21:39:03.218Z+ chmod 0700 /home/build /work
402024-02-13T21:39:03.229Zprocess exited: duration 3536 ms, exit code 0
 
412024-02-13T21:39:03.242Zstarting task 1: "authentication"
422024-02-13T21:39:03.269Zprocess exited: duration 26 ms, exit code 0
 
432024-02-13T21:39:03.290Zstarting task 2: "build"
442024-02-13T21:39:03.294Z+ banner cores
452024-02-13T21:39:03.374Z
462024-02-13T21:39:03.375Z #### #### ##### ###### ####
472024-02-13T21:39:03.375Z # # # # # # # #
482024-02-13T21:39:03.375Z # # # # # ##### ####
492024-02-13T21:39:03.375Z # # # ##### # #
502024-02-13T21:39:03.375Z # # # # # # # # #
512024-02-13T21:39:03.375Z #### #### # # ###### ####
522024-02-13T21:39:03.375Z
532024-02-13T21:39:03.379Z+ pfexec coreadm -i /tmp/core.%f.%p -g /tmp/core.%f.%p -e global -e log -e proc-setid -e global-setid
542024-02-13T21:39:03.384Z+ echo 'input bins dir contains:'
552024-02-13T21:39:03.384Zinput bins dir contains:
562024-02-13T21:39:03.388Z+ ls -ltr /input/build/work/bins
572024-02-13T21:39:03.388Ztotal 761137
582024-02-13T21:39:03.388Z-rw-r--r-- 1 root root 121565893 Feb 13 21:37 crucible-downstairs.gz
592024-02-13T21:39:03.388Z-rw-r--r-- 1 root root 91138074 Feb 13 21:37 crucible-hammer.gz
602024-02-13T21:39:03.388Z-rw-r--r-- 1 root root 104804038 Feb 13 21:37 crutest.gz
612024-02-13T21:39:03.388Z-rw-r--r-- 1 root root 71941606 Feb 13 21:38 dsc.gz
622024-02-13T21:39:03.388Z+ banner unpack
632024-02-13T21:39:03.388Z
642024-02-13T21:39:03.388Z # # # # ##### ## #### # #
652024-02-13T21:39:03.388Z # # ## # # # # # # # # #
662024-02-13T21:39:03.388Z # # # # # # # # # # ####
672024-02-13T21:39:03.389Z # # # # # ##### ###### # # #
682024-02-13T21:39:03.389Z # # # ## # # # # # # #
692024-02-13T21:39:03.389Z #### # # # # # #### # #
702024-02-13T21:39:03.389Z
712024-02-13T21:39:03.389Z+ mkdir -p /var/tmp/bins
722024-02-13T21:39:03.392Z+ for t in "$input/bins/"*.gz
732024-02-13T21:39:03.392Z++ basename /input/build/work/bins/crucible-downstairs.gz
742024-02-13T21:39:03.392Z+ b=crucible-downstairs.gz
752024-02-13T21:39:03.393Z+ b=crucible-downstairs
762024-02-13T21:39:03.393Z+ gunzip
772024-02-13T21:39:06.311Z+ chmod +x /var/tmp/bins/crucible-downstairs
782024-02-13T21:39:06.319Z+ for t in "$input/bins/"*.gz
792024-02-13T21:39:06.319Z++ basename /input/build/work/bins/crucible-hammer.gz
802024-02-13T21:39:06.319Z+ b=crucible-hammer.gz
812024-02-13T21:39:06.319Z+ b=crucible-hammer
822024-02-13T21:39:06.319Z+ gunzip
832024-02-13T21:39:08.402Z+ chmod +x /var/tmp/bins/crucible-hammer
842024-02-13T21:39:08.418Z+ for t in "$input/bins/"*.gz
852024-02-13T21:39:08.418Z++ basename /input/build/work/bins/crutest.gz
862024-02-13T21:39:08.418Z+ b=crutest.gz
872024-02-13T21:39:08.418Z+ b=crutest
882024-02-13T21:39:08.418Z+ gunzip
892024-02-13T21:39:10.823Z+ chmod +x /var/tmp/bins/crutest
902024-02-13T21:39:10.830Z+ for t in "$input/bins/"*.gz
912024-02-13T21:39:10.830Z++ basename /input/build/work/bins/dsc.gz
922024-02-13T21:39:10.830Z+ b=dsc.gz
932024-02-13T21:39:10.830Z+ b=dsc
942024-02-13T21:39:10.830Z+ gunzip
952024-02-13T21:39:12.438Z+ chmod +x /var/tmp/bins/dsc
962024-02-13T21:39:12.453Z+ export BINDIR=/var/tmp/bins
972024-02-13T21:39:12.453Z+ BINDIR=/var/tmp/bins
982024-02-13T21:39:12.453Z+ banner test_ds
992024-02-13T21:39:12.453Z
1002024-02-13T21:39:12.453Z ##### ###### #### ##### ##### ####
1012024-02-13T21:39:12.453Z # # # # # # #
1022024-02-13T21:39:12.453Z # ##### #### # # # ####
1032024-02-13T21:39:12.453Z # # # # # # #
1042024-02-13T21:39:12.453Z # # # # # # # # #
1052024-02-13T21:39:12.454Z # ###### #### # ####### ##### ####
1062024-02-13T21:39:12.454Z
1072024-02-13T21:39:12.454Z+ ptime -m bash /input/build/work/scripts/test_ds.sh
1082024-02-13T21:39:12.707Z/input/build/work
1092024-02-13T21:39:12.713ZCreate file for import
1102024-02-13T21:39:13.158Z300+0 records in
1112024-02-13T21:39:13.158Z300+0 records out
1122024-02-13T21:39:13.175Z153600 bytes (150 KiB) transferred in 0.002361 secs (62 MiB/sec)
1132024-02-13T21:39:13.175ZImport region
1142024-02-13T21:39:13.176Z{"msg":"Created new region file \"/tmp/ds_test/region/region.json\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:11.742443576Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1131}
1152024-02-13T21:39:13.176ZImport file_size: 153600 Extent size: 51200 Needed extents: 3
1162024-02-13T21:39:13.176ZRegion already large enough for image
1172024-02-13T21:39:13.176ZImporting "/tmp/ds_test/import" to region
1182024-02-13T21:39:13.177ZPopulated 3 extents by copying 153600 bytes (300 blocks)
1192024-02-13T21:39:13.177Z{"msg":"UUID: 12345678-1234-1234-1234-000000000001","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:11.773942833Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1131}
1202024-02-13T21:39:13.177Z{"msg":"Blocks per extent:100 Total Extents: 15","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:11.773980368Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1131}
1212024-02-13T21:39:13.177ZExport region
1222024-02-13T21:39:13.177Z{"msg":"Opened existing region file \"/tmp/ds_test/region/region.json\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:11.792286459Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1132}
1232024-02-13T21:39:13.178Z{"msg":"Database read version 1","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:11.792534931Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1132}
1242024-02-13T21:39:13.178Z{"msg":"Database write version 1","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:11.792554858Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1132}
1252024-02-13T21:39:13.178ZExport total_size: 768000 Extent size:51200 Total Extents:15
1262024-02-13T21:39:13.178ZExporting from start_block: 0 count:300
1272024-02-13T21:39:13.178ZRead and wrote out 300 blocks
1282024-02-13T21:39:13.178ZImport Export test passed
1292024-02-13T21:39:13.179ZTest clone
1302024-02-13T21:39:13.179ZStarting downstairs
1312024-02-13T21:39:13.885Z PID TTY TIME CMD
1322024-02-13T21:39:13.885Z 1134 ? 0:00 crucible
1332024-02-13T21:39:13.904ZDownstairs running
1342024-02-13T21:39:13.905ZCreating new downstairs
1352024-02-13T21:39:14.023Z{"msg":"Created new region file \"/tmp/ds_test/clone/region.json\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:12.947189923Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1138}
1362024-02-13T21:39:14.034Z{"msg":"UUID: 5be921be-f42d-48e1-b0b2-0a01c679b730","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:12.947872804Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1138}
1372024-02-13T21:39:14.034Z{"msg":"Blocks per extent:100 Total Extents: 15","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:12.94790811Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1138}
1382024-02-13T21:39:14.035ZCloning existing downstairs
1392024-02-13T21:39:14.035Z{"msg":"Opened existing region file \"/tmp/ds_test/clone/region.json\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:12.96037241Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1402024-02-13T21:39:14.035Z{"msg":"Database read version 1","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:12.960599344Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1412024-02-13T21:39:14.035Z{"msg":"Database write version 1","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:12.960618372Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1422024-02-13T21:39:14.051Z{"msg":"UUID: 5be921be-f42d-48e1-b0b2-0a01c679b730","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:12.96089483Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1432024-02-13T21:39:14.051Z{"msg":"Blocks per extent:100 Total Extents: 15","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:12.960924726Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1442024-02-13T21:39:14.051Z{"msg":"Crucible Version: Crucible Version: 0.0.1\nCommit SHA: 29185f5538632a13039785e911d1aaa0146bfa14\nCommit timestamp: 2024-02-13T21:13:12.000000000Z branch: main\nrustc: 1.75.0 stable x86_64-unknown-illumos\nCargo: x86_64-unknown-illumos Debug: true Opt level: 0","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:12.961090447Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139,"task":"clone"}
1452024-02-13T21:39:14.052Z{"msg":"Upstairs <-> Downstairs Message Version: 5","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:12.961133582Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139,"task":"clone"}
1462024-02-13T21:39:14.052Z{"msg":"Connecting to 127.0.0.1:12810 to obtain our extent files.","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:12.96115109Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139,"task":"clone"}
1472024-02-13T21:39:14.081Z{"msg":"The source RegionDefinition is: RegionDefinition { block_size: 512, extent_size: Block { value: 100, shift: 9 }, extent_count: 15, uuid: 12345678-1234-1234-1234-000000000001, encrypted: false, database_read_version: 1, database_write_version: 1 }","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.011804619Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139,"task":"clone"}
1482024-02-13T21:39:14.086Z{"msg":"The source mode is: true","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.012360435Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139,"task":"clone"}
1492024-02-13T21:39:14.086Z{"msg":"my def is RegionDefinition { block_size: 512, extent_size: Block { value: 100, shift: 9 }, extent_count: 15, uuid: 5be921be-f42d-48e1-b0b2-0a01c679b730, encrypted: false, database_read_version: 1, database_write_version: 1 }","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.012394011Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139,"task":"clone"}
1502024-02-13T21:39:14.086Z{"msg":"Repair extent 0","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.01257663Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139,"task":"clone"}
1512024-02-13T21:39:14.086Z{"msg":"Created copy dir \"/tmp/ds_test/clone/00/000/000.copy\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.012624664Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1522024-02-13T21:39:14.122Z{"msg":"eid:0 Found repair files: [\"000\"]","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.045656263Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1532024-02-13T21:39:14.564Z{"msg":"1 repair files downloaded, move directory \"/tmp/ds_test/clone/00/000/000.copy\" to \"/tmp/ds_test/clone/00/000/000.replace\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.048074891Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1542024-02-13T21:39:14.564Z{"msg":"Copy files from \"/tmp/ds_test/clone/00/000/000.replace\" in \"/tmp/ds_test/clone/00/000\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.048498512Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1552024-02-13T21:39:14.564Z{"msg":"Move directory \"/tmp/ds_test/clone/00/000/000.replace\" to \"/tmp/ds_test/clone/00/000/000.completed\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.048614289Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1562024-02-13T21:39:14.564Z{"msg":"Repair extent 1","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.048683591Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139,"task":"clone"}
1572024-02-13T21:39:14.564Z{"msg":"Created copy dir \"/tmp/ds_test/clone/00/000/001.copy\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.048729765Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1582024-02-13T21:39:14.582Z{"msg":"eid:1 Found repair files: [\"001\"]","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.078683962Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1592024-02-13T21:39:14.583Z{"msg":"1 repair files downloaded, move directory \"/tmp/ds_test/clone/00/000/001.copy\" to \"/tmp/ds_test/clone/00/000/001.replace\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.080211494Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1602024-02-13T21:39:14.583Z{"msg":"Copy files from \"/tmp/ds_test/clone/00/000/001.replace\" in \"/tmp/ds_test/clone/00/000\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.080620197Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1612024-02-13T21:39:14.583Z{"msg":"Move directory \"/tmp/ds_test/clone/00/000/001.replace\" to \"/tmp/ds_test/clone/00/000/001.completed\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.080707136Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1622024-02-13T21:39:14.583Z{"msg":"Repair extent 2","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.080741313Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139,"task":"clone"}
1632024-02-13T21:39:14.583Z{"msg":"Created copy dir \"/tmp/ds_test/clone/00/000/002.copy\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.080759521Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1642024-02-13T21:39:14.583Z{"msg":"eid:2 Found repair files: [\"002\"]","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.11129429Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1652024-02-13T21:39:14.583Z{"msg":"1 repair files downloaded, move directory \"/tmp/ds_test/clone/00/000/002.copy\" to \"/tmp/ds_test/clone/00/000/002.replace\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.112695637Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1662024-02-13T21:39:14.584Z{"msg":"Copy files from \"/tmp/ds_test/clone/00/000/002.replace\" in \"/tmp/ds_test/clone/00/000\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.11309731Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1672024-02-13T21:39:14.584Z{"msg":"Move directory \"/tmp/ds_test/clone/00/000/002.replace\" to \"/tmp/ds_test/clone/00/000/002.completed\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.113151723Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1682024-02-13T21:39:14.584Z{"msg":"Repair extent 3","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.1131806Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139,"task":"clone"}
1692024-02-13T21:39:14.585Z{"msg":"Created copy dir \"/tmp/ds_test/clone/00/000/003.copy\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.113195378Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1702024-02-13T21:39:14.585Z{"msg":"eid:3 Found repair files: [\"003\"]","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.143667485Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1712024-02-13T21:39:14.585Z{"msg":"1 repair files downloaded, move directory \"/tmp/ds_test/clone/00/000/003.copy\" to \"/tmp/ds_test/clone/00/000/003.replace\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.145243322Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1722024-02-13T21:39:14.585Z{"msg":"Copy files from \"/tmp/ds_test/clone/00/000/003.replace\" in \"/tmp/ds_test/clone/00/000\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.145694289Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1732024-02-13T21:39:14.585Z{"msg":"Move directory \"/tmp/ds_test/clone/00/000/003.replace\" to \"/tmp/ds_test/clone/00/000/003.completed\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.145782939Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1742024-02-13T21:39:14.585Z{"msg":"Repair extent 4","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.145815485Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139,"task":"clone"}
1752024-02-13T21:39:14.586Z{"msg":"Created copy dir \"/tmp/ds_test/clone/00/000/004.copy\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.145832353Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1762024-02-13T21:39:14.586Z{"msg":"eid:4 Found repair files: [\"004\"]","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.176408627Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1772024-02-13T21:39:14.586Z{"msg":"1 repair files downloaded, move directory \"/tmp/ds_test/clone/00/000/004.copy\" to \"/tmp/ds_test/clone/00/000/004.replace\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.177858829Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1782024-02-13T21:39:14.586Z{"msg":"Copy files from \"/tmp/ds_test/clone/00/000/004.replace\" in \"/tmp/ds_test/clone/00/000\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.178258342Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1792024-02-13T21:39:14.586Z{"msg":"Move directory \"/tmp/ds_test/clone/00/000/004.replace\" to \"/tmp/ds_test/clone/00/000/004.completed\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.178328904Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1802024-02-13T21:39:14.586Z{"msg":"Repair extent 5","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.178358371Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139,"task":"clone"}
1812024-02-13T21:39:14.587Z{"msg":"Created copy dir \"/tmp/ds_test/clone/00/000/005.copy\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.178372949Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1822024-02-13T21:39:14.587Z{"msg":"eid:5 Found repair files: [\"005\"]","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.208194491Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1832024-02-13T21:39:14.587Z{"msg":"1 repair files downloaded, move directory \"/tmp/ds_test/clone/00/000/005.copy\" to \"/tmp/ds_test/clone/00/000/005.replace\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.209616656Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1842024-02-13T21:39:14.587Z{"msg":"Copy files from \"/tmp/ds_test/clone/00/000/005.replace\" in \"/tmp/ds_test/clone/00/000\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.210054865Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1852024-02-13T21:39:14.587Z{"msg":"Move directory \"/tmp/ds_test/clone/00/000/005.replace\" to \"/tmp/ds_test/clone/00/000/005.completed\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.210126176Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1862024-02-13T21:39:14.587Z{"msg":"Repair extent 6","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.210167812Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139,"task":"clone"}
1872024-02-13T21:39:14.588Z{"msg":"Created copy dir \"/tmp/ds_test/clone/00/000/006.copy\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.210207447Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1882024-02-13T21:39:14.588Z{"msg":"eid:6 Found repair files: [\"006\"]","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.240766503Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1892024-02-13T21:39:14.588Z{"msg":"1 repair files downloaded, move directory \"/tmp/ds_test/clone/00/000/006.copy\" to \"/tmp/ds_test/clone/00/000/006.replace\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.242268288Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1902024-02-13T21:39:14.588Z{"msg":"Copy files from \"/tmp/ds_test/clone/00/000/006.replace\" in \"/tmp/ds_test/clone/00/000\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.242660873Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1912024-02-13T21:39:14.588Z{"msg":"Move directory \"/tmp/ds_test/clone/00/000/006.replace\" to \"/tmp/ds_test/clone/00/000/006.completed\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.242751662Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1922024-02-13T21:39:14.588Z{"msg":"Repair extent 7","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.242781349Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139,"task":"clone"}
1932024-02-13T21:39:14.588Z{"msg":"Created copy dir \"/tmp/ds_test/clone/00/000/007.copy\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.242803966Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1942024-02-13T21:39:14.588Z{"msg":"eid:7 Found repair files: [\"007\"]","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.272548537Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1952024-02-13T21:39:14.588Z{"msg":"1 repair files downloaded, move directory \"/tmp/ds_test/clone/00/000/007.copy\" to \"/tmp/ds_test/clone/00/000/007.replace\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.273964222Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1962024-02-13T21:39:14.589Z{"msg":"Copy files from \"/tmp/ds_test/clone/00/000/007.replace\" in \"/tmp/ds_test/clone/00/000\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.274402642Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1972024-02-13T21:39:14.589Z{"msg":"Move directory \"/tmp/ds_test/clone/00/000/007.replace\" to \"/tmp/ds_test/clone/00/000/007.completed\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.274454176Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
1982024-02-13T21:39:14.589Z{"msg":"Repair extent 8","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.274484322Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139,"task":"clone"}
1992024-02-13T21:39:14.589Z{"msg":"Created copy dir \"/tmp/ds_test/clone/00/000/008.copy\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.274518178Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
2002024-02-13T21:39:14.589Z{"msg":"eid:8 Found repair files: [\"008\"]","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.304325892Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
2012024-02-13T21:39:14.589Z{"msg":"1 repair files downloaded, move directory \"/tmp/ds_test/clone/00/000/008.copy\" to \"/tmp/ds_test/clone/00/000/008.replace\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.305813519Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
2022024-02-13T21:39:14.589Z{"msg":"Copy files from \"/tmp/ds_test/clone/00/000/008.replace\" in \"/tmp/ds_test/clone/00/000\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.306228621Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
2032024-02-13T21:39:14.589Z{"msg":"Move directory \"/tmp/ds_test/clone/00/000/008.replace\" to \"/tmp/ds_test/clone/00/000/008.completed\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.306332349Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
2042024-02-13T21:39:14.589Z{"msg":"Repair extent 9","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.306365154Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139,"task":"clone"}
2052024-02-13T21:39:14.590Z{"msg":"Created copy dir \"/tmp/ds_test/clone/00/000/009.copy\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.306380923Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
2062024-02-13T21:39:14.590Z{"msg":"eid:9 Found repair files: [\"009\"]","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.336999952Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
2072024-02-13T21:39:14.590Z{"msg":"1 repair files downloaded, move directory \"/tmp/ds_test/clone/00/000/009.copy\" to \"/tmp/ds_test/clone/00/000/009.replace\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.338453073Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
2082024-02-13T21:39:14.590Z{"msg":"Copy files from \"/tmp/ds_test/clone/00/000/009.replace\" in \"/tmp/ds_test/clone/00/000\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.338863135Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
2092024-02-13T21:39:14.590Z{"msg":"Move directory \"/tmp/ds_test/clone/00/000/009.replace\" to \"/tmp/ds_test/clone/00/000/009.completed\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.33891131Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
2102024-02-13T21:39:14.590Z{"msg":"Repair extent 10","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.33899723Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139,"task":"clone"}
2112024-02-13T21:39:14.590Z{"msg":"Created copy dir \"/tmp/ds_test/clone/00/000/00A.copy\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.339036235Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
2122024-02-13T21:39:14.590Z{"msg":"eid:10 Found repair files: [\"00A\"]","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.368704335Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
2132024-02-13T21:39:14.590Z{"msg":"1 repair files downloaded, move directory \"/tmp/ds_test/clone/00/000/00A.copy\" to \"/tmp/ds_test/clone/00/000/00A.replace\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.370220949Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
2142024-02-13T21:39:14.591Z{"msg":"Copy files from \"/tmp/ds_test/clone/00/000/00A.replace\" in \"/tmp/ds_test/clone/00/000\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.370651519Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
2152024-02-13T21:39:14.591Z{"msg":"Move directory \"/tmp/ds_test/clone/00/000/00A.replace\" to \"/tmp/ds_test/clone/00/000/00A.completed\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.370734319Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
2162024-02-13T21:39:14.591Z{"msg":"Repair extent 11","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.370759646Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139,"task":"clone"}
2172024-02-13T21:39:14.591Z{"msg":"Created copy dir \"/tmp/ds_test/clone/00/000/00B.copy\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.370778614Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
2182024-02-13T21:39:14.591Z{"msg":"eid:11 Found repair files: [\"00B\"]","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.401537017Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
2192024-02-13T21:39:14.591Z{"msg":"1 repair files downloaded, move directory \"/tmp/ds_test/clone/00/000/00B.copy\" to \"/tmp/ds_test/clone/00/000/00B.replace\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.403013435Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
2202024-02-13T21:39:14.591Z{"msg":"Copy files from \"/tmp/ds_test/clone/00/000/00B.replace\" in \"/tmp/ds_test/clone/00/000\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.403426337Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
2212024-02-13T21:39:14.591Z{"msg":"Move directory \"/tmp/ds_test/clone/00/000/00B.replace\" to \"/tmp/ds_test/clone/00/000/00B.completed\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.40349155Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
2222024-02-13T21:39:14.591Z{"msg":"Repair extent 12","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.403533555Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139,"task":"clone"}
2232024-02-13T21:39:14.591Z{"msg":"Created copy dir \"/tmp/ds_test/clone/00/000/00C.copy\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.403550373Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
2242024-02-13T21:39:14.591Z{"msg":"eid:12 Found repair files: [\"00C\"]","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.433322701Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
2252024-02-13T21:39:14.592Z{"msg":"1 repair files downloaded, move directory \"/tmp/ds_test/clone/00/000/00C.copy\" to \"/tmp/ds_test/clone/00/000/00C.replace\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.434923714Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
2262024-02-13T21:39:14.592Z{"msg":"Copy files from \"/tmp/ds_test/clone/00/000/00C.replace\" in \"/tmp/ds_test/clone/00/000\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.435350135Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
2272024-02-13T21:39:14.592Z{"msg":"Move directory \"/tmp/ds_test/clone/00/000/00C.replace\" to \"/tmp/ds_test/clone/00/000/00C.completed\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.435411008Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
2282024-02-13T21:39:14.592Z{"msg":"Repair extent 13","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.435440214Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139,"task":"clone"}
2292024-02-13T21:39:14.592Z{"msg":"Created copy dir \"/tmp/ds_test/clone/00/000/00D.copy\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.435454683Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
2302024-02-13T21:39:14.592Z{"msg":"eid:13 Found repair files: [\"00D\"]","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.465343697Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
2312024-02-13T21:39:14.592Z{"msg":"1 repair files downloaded, move directory \"/tmp/ds_test/clone/00/000/00D.copy\" to \"/tmp/ds_test/clone/00/000/00D.replace\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.466806347Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
2322024-02-13T21:39:14.592Z{"msg":"Copy files from \"/tmp/ds_test/clone/00/000/00D.replace\" in \"/tmp/ds_test/clone/00/000\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.467195191Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
2332024-02-13T21:39:14.593Z{"msg":"Move directory \"/tmp/ds_test/clone/00/000/00D.replace\" to \"/tmp/ds_test/clone/00/000/00D.completed\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.467268043Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
2342024-02-13T21:39:14.593Z{"msg":"Repair extent 14","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.467303319Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139,"task":"clone"}
2352024-02-13T21:39:14.593Z{"msg":"Created copy dir \"/tmp/ds_test/clone/00/000/00E.copy\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.467322657Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
2362024-02-13T21:39:14.593Z{"msg":"eid:14 Found repair files: [\"00E\"]","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.497380431Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
2372024-02-13T21:39:14.593Z{"msg":"1 repair files downloaded, move directory \"/tmp/ds_test/clone/00/000/00E.copy\" to \"/tmp/ds_test/clone/00/000/00E.replace\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.498797836Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
2382024-02-13T21:39:14.593Z{"msg":"Copy files from \"/tmp/ds_test/clone/00/000/00E.replace\" in \"/tmp/ds_test/clone/00/000\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.499202319Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
2392024-02-13T21:39:14.593Z{"msg":"Move directory \"/tmp/ds_test/clone/00/000/00E.replace\" to \"/tmp/ds_test/clone/00/000/00E.completed\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.499255833Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139}
2402024-02-13T21:39:14.593Z{"msg":"Region has been cloned","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.499296518Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1139,"task":"clone"}
2412024-02-13T21:39:14.604ZVerify clone using export
2422024-02-13T21:39:14.604Z{"msg":"Opened existing region file \"/tmp/ds_test/clone/region.json\"","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.517053153Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1140}
2432024-02-13T21:39:14.604Z{"msg":"Database read version 1","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.517293416Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1140}
2442024-02-13T21:39:14.605Z{"msg":"Database write version 1","v":0,"name":"crucible","level":30,"time":"2024-02-13T21:39:13.517312823Z","hostname":"ip-10-150-1-50.us-west-2.compute.internal","pid":1140}
2452024-02-13T21:39:14.605ZExport total_size: 768000 Extent size:51200 Total Extents:15
2462024-02-13T21:39:14.605ZExporting from start_block: 0 count:300
2472024-02-13T21:39:14.605ZRead and wrote out 300 blocks
2482024-02-13T21:39:14.605ZStopping downstairs
2492024-02-13T21:39:14.606ZClone test passed
2502024-02-13T21:39:14.606Z
2512024-02-13T21:39:14.606Zreal 1.988893508
2522024-02-13T21:39:14.606Zuser 0.571211949
2532024-02-13T21:39:14.606Zsys 0.175728648
2542024-02-13T21:39:14.606Ztrap 0.000324935
2552024-02-13T21:39:14.607Ztflt 0.000607537
2562024-02-13T21:39:14.607Zdflt 0.003309567
2572024-02-13T21:39:14.607Zkflt 0.000948419
2582024-02-13T21:39:14.607Zlock 4.906453637
2592024-02-13T21:39:14.607Zslp 3.912689828
2602024-02-13T21:39:14.607Zlat 0.018962129
2612024-02-13T21:39:14.608Zstop 0.000392648
2622024-02-13T21:39:14.608Zprocess exited: duration 11308 ms, exit code 0
 
2632024-02-13T21:39:14.628Zfound 0 output files