01J8T6EDZ5YHYH8N9PT2CJHRVT: test-crudd-benchmark

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

Buildomat Job: 01J8T6EWXKKAW0V3Y30F62QY83

Tags:

Artefacts:

Output:

SEQ GLOBAL TIME DETAILS
12024-09-27T17:12:42.128Zjob dependencies complete; ready to run (waiting for 18 m 34 s)
22024-09-27T17:13:18.302Zjob assigned to worker 01J8T7GXM7VY7Y1N0VWB1XGPEY (queued for 36 s)
32024-09-27T17:13:18.976Zdownloading input: /input/rbuild/out/crucible-dtrace.sha256.txt
42024-09-27T17:13:19.000Zdownloaded input: /input/rbuild/out/crucible-dtrace.sha256.txt
52024-09-27T17:13:19.000Zdownloading input: /input/rbuild/out/crucible-dtrace.tar
62024-09-27T17:13:19.136Zdownloaded input: /input/rbuild/out/crucible-dtrace.tar
72024-09-27T17:13:19.136Zdownloading input: /input/rbuild/out/crucible-nightly.sha256.txt
82024-09-27T17:13:19.172Zdownloaded input: /input/rbuild/out/crucible-nightly.sha256.txt
92024-09-27T17:13:19.172Zdownloading input: /input/rbuild/out/crucible-nightly.tar.gz
102024-09-27T17:13:23.025Zdownloaded input: /input/rbuild/out/crucible-nightly.tar.gz
112024-09-27T17:13:23.025Zdownloading input: /input/rbuild/out/crucible-pantry.sha256.txt
122024-09-27T17:13:23.061Zdownloaded input: /input/rbuild/out/crucible-pantry.sha256.txt
132024-09-27T17:13:23.061Zdownloading input: /input/rbuild/out/crucible-pantry.tar.gz
142024-09-27T17:13:23.906Zdownloaded input: /input/rbuild/out/crucible-pantry.tar.gz
152024-09-27T17:13:23.906Zdownloading input: /input/rbuild/out/crucible.sha256.txt
162024-09-27T17:13:23.955Zdownloaded input: /input/rbuild/out/crucible.sha256.txt
172024-09-27T17:13:23.955Zdownloading input: /input/rbuild/out/crucible.tar.gz
182024-09-27T17:13:25.139Zdownloaded input: /input/rbuild/out/crucible.tar.gz
192024-09-27T17:13:25.162Zdownloading input: /input/rbuild/work/rbins/crucible-downstairs.gz
202024-09-27T17:13:25.962Zdownloaded input: /input/rbuild/work/rbins/crucible-downstairs.gz
212024-09-27T17:13:25.962Zdownloading input: /input/rbuild/work/rbins/crucible-hammer.gz
222024-09-27T17:13:26.666Zdownloaded input: /input/rbuild/work/rbins/crucible-hammer.gz
232024-09-27T17:13:26.667Zdownloading input: /input/rbuild/work/rbins/crudd.gz
242024-09-27T17:13:27.334Zdownloaded input: /input/rbuild/work/rbins/crudd.gz
252024-09-27T17:13:27.357Zdownloading input: /input/rbuild/work/rbins/crutest.gz
262024-09-27T17:13:28.138Zdownloaded input: /input/rbuild/work/rbins/crutest.gz
272024-09-27T17:13:28.138Zdownloading input: /input/rbuild/work/rbins/dsc.gz
282024-09-27T17:13:28.623Zdownloaded input: /input/rbuild/work/rbins/dsc.gz
292024-09-27T17:13:28.648Zdownloading input: /input/rbuild/work/scripts/crudd-speed-battery.sh
302024-09-27T17:13:28.672Zdownloaded input: /input/rbuild/work/scripts/crudd-speed-battery.sh
312024-09-27T17:13:28.672Zdownloading input: /input/rbuild/work/scripts/perf-downstairs-tick.d
322024-09-27T17:13:28.706Zdownloaded input: /input/rbuild/work/scripts/perf-downstairs-tick.d
332024-09-27T17:13:28.730Zdownloading input: /input/rbuild/work/scripts/test_mem.sh
342024-09-27T17:13:28.757Zdownloaded input: /input/rbuild/work/scripts/test_mem.sh
352024-09-27T17:13:28.758Zdownloading input: /input/rbuild/work/scripts/test_perf.sh
362024-09-27T17:13:28.799Zdownloaded input: /input/rbuild/work/scripts/test_perf.sh
372024-09-27T17:13:28.800Zdownloading input: /input/rbuild/work/scripts/upstairs_info.d
382024-09-27T17:13:28.836Zdownloaded input: /input/rbuild/work/scripts/upstairs_info.d
392024-09-27T17:13:28.859Zdownloading input: /input/rbuild/tmp/cargo-test-out.log
402024-09-27T17:13:32.220Zdownloaded input: /input/rbuild/tmp/cargo-test-out.log
 
412024-09-27T17:13:32.220Zstarting task 0: "setup"
422024-09-27T17:13:32.244Z++ uname -s
432024-09-27T17:13:32.244Z+ kern=SunOS
442024-09-27T17:13:32.244Z+ case "$kern" in
452024-09-27T17:13:32.244Z+ groupadd -g 12345 build
462024-09-27T17:13:32.244Z+ useradd -u 12345 -g build -d /home/build -s /bin/bash -c build -P 'Primary Administrator' build
472024-09-27T17:13:34.252Z+ zfs create -o mountpoint=/work rpool/work
482024-09-27T17:13:34.286Z++ awk '$2 == "/home" { print $3 }' /etc/mnttab
492024-09-27T17:13:34.310Z+ home_fs=zfs
502024-09-27T17:13:34.310Z+ [[ zfs == autofs ]]
512024-09-27T17:13:34.310Z+ mkdir -p /home/build
522024-09-27T17:13:34.310Z+ chown build:build /home/build /work
532024-09-27T17:13:36.296Z+ chmod 0700 /home/build /work
542024-09-27T17:13:36.322Zprocess exited: duration 4079 ms, exit code 0
 
552024-09-27T17:13:36.371Zstarting task 1: "authentication"
562024-09-27T17:13:36.422Zprocess exited: duration 49 ms, exit code 0
 
572024-09-27T17:13:36.473Zstarting task 2: "build"
582024-09-27T17:13:36.498Z+ banner cores
592024-09-27T17:13:36.498Z
602024-09-27T17:13:36.498Z #### #### ##### ###### ####
612024-09-27T17:13:36.498Z # # # # # # # #
622024-09-27T17:13:36.498Z # # # # # ##### ####
632024-09-27T17:13:36.498Z # # # ##### # #
642024-09-27T17:13:36.498Z # # # # # # # # #
652024-09-27T17:13:36.498Z #### #### # # ###### ####
662024-09-27T17:13:36.498Z
672024-09-27T17:13:36.498Z+ pfexec coreadm -i /tmp/core.%f.%p -g /tmp/core.%f.%p -e global -e log -e proc-setid -e global-setid
682024-09-27T17:13:36.498Z+ echo 'input rbins dir contains:'
692024-09-27T17:13:36.498Zinput rbins dir contains:
702024-09-27T17:13:36.498Z+ ls -ltr /input/rbuild/work/rbins
712024-09-27T17:13:36.498Ztotal 132973
722024-09-27T17:13:36.499Z-rw-r--r-- 1 root root 15731517 Sep 27 17:13 crucible-downstairs.gz
732024-09-27T17:13:36.499Z-rw-r--r-- 1 root root 14474658 Sep 27 17:13 crucible-hammer.gz
742024-09-27T17:13:36.499Z-rw-r--r-- 1 root root 13829064 Sep 27 17:13 crudd.gz
752024-09-27T17:13:36.499Z-rw-r--r-- 1 root root 15769154 Sep 27 17:13 crutest.gz
762024-09-27T17:13:36.499Z-rw-r--r-- 1 root root 8188079 Sep 27 17:13 dsc.gz
772024-09-27T17:13:36.499Z+ echo 'input scripts dir contains:'
782024-09-27T17:13:36.499Zinput scripts dir contains:
792024-09-27T17:13:36.499Z+ ls -ltr /input/rbuild/work/scripts
802024-09-27T17:13:36.523Ztotal 45
812024-09-27T17:13:36.523Z-rw-r--r-- 1 root root 7480 Sep 27 17:13 crudd-speed-battery.sh
822024-09-27T17:13:36.523Z-rw-r--r-- 1 root root 3056 Sep 27 17:13 perf-downstairs-tick.d
832024-09-27T17:13:36.523Z-rw-r--r-- 1 root root 5934 Sep 27 17:13 test_mem.sh
842024-09-27T17:13:36.523Z-rw-r--r-- 1 root root 5257 Sep 27 17:13 test_perf.sh
852024-09-27T17:13:36.523Z-rw-r--r-- 1 root root 2407 Sep 27 17:13 upstairs_info.d
862024-09-27T17:13:36.523Z+ banner unpack
872024-09-27T17:13:36.523Z
882024-09-27T17:13:36.523Z # # # # ##### ## #### # #
892024-09-27T17:13:36.523Z # # ## # # # # # # # # #
902024-09-27T17:13:36.523Z # # # # # # # # # # ####
912024-09-27T17:13:36.523Z # # # # # ##### ###### # # #
922024-09-27T17:13:36.523Z # # # ## # # # # # # #
932024-09-27T17:13:36.523Z #### # # # # # #### # #
942024-09-27T17:13:36.523Z
952024-09-27T17:13:36.523Z+ mkdir -p /var/tmp/bins
962024-09-27T17:13:36.523Z+ for t in "$input/rbins/"*.gz
972024-09-27T17:13:36.523Z++ basename /input/rbuild/work/rbins/crucible-downstairs.gz
982024-09-27T17:13:36.523Z+ b=crucible-downstairs.gz
992024-09-27T17:13:36.523Z+ b=crucible-downstairs
1002024-09-27T17:13:36.523Z+ gunzip
1012024-09-27T17:13:36.880Z+ chmod +x /var/tmp/bins/crucible-downstairs
1022024-09-27T17:13:36.903Z+ for t in "$input/rbins/"*.gz
1032024-09-27T17:13:36.903Z++ basename /input/rbuild/work/rbins/crucible-hammer.gz
1042024-09-27T17:13:36.903Z+ b=crucible-hammer.gz
1052024-09-27T17:13:36.903Z+ b=crucible-hammer
1062024-09-27T17:13:36.903Z+ gunzip
1072024-09-27T17:13:37.233Z+ chmod +x /var/tmp/bins/crucible-hammer
1082024-09-27T17:13:37.257Z+ for t in "$input/rbins/"*.gz
1092024-09-27T17:13:37.257Z++ basename /input/rbuild/work/rbins/crudd.gz
1102024-09-27T17:13:37.257Z+ b=crudd.gz
1112024-09-27T17:13:37.257Z+ b=crudd
1122024-09-27T17:13:37.257Z+ gunzip
1132024-09-27T17:13:37.578Z+ chmod +x /var/tmp/bins/crudd
1142024-09-27T17:13:37.602Z+ for t in "$input/rbins/"*.gz
1152024-09-27T17:13:37.602Z++ basename /input/rbuild/work/rbins/crutest.gz
1162024-09-27T17:13:37.602Z+ b=crutest.gz
1172024-09-27T17:13:37.602Z+ b=crutest
1182024-09-27T17:13:37.602Z+ gunzip
1192024-09-27T17:13:37.962Z+ chmod +x /var/tmp/bins/crutest
1202024-09-27T17:13:37.986Z+ for t in "$input/rbins/"*.gz
1212024-09-27T17:13:37.986Z++ basename /input/rbuild/work/rbins/dsc.gz
1222024-09-27T17:13:37.987Z+ b=dsc.gz
1232024-09-27T17:13:37.987Z+ b=dsc
1242024-09-27T17:13:37.987Z+ gunzip
1252024-09-27T17:13:38.167Z+ chmod +x /var/tmp/bins/dsc
1262024-09-27T17:13:38.191Z+ export BINDIR=/var/tmp/bins
1272024-09-27T17:13:38.191Z+ BINDIR=/var/tmp/bins
1282024-09-27T17:13:38.191Z+ banner setup
1292024-09-27T17:13:38.191Z
1302024-09-27T17:13:38.191Z #### ###### ##### # # #####
1312024-09-27T17:13:38.191Z # # # # # # #
1322024-09-27T17:13:38.191Z #### ##### # # # # #
1332024-09-27T17:13:38.191Z # # # # # #####
1342024-09-27T17:13:38.192Z # # # # # # #
1352024-09-27T17:13:38.192Z #### ###### # #### #
1362024-09-27T17:13:38.192Z
1372024-09-27T17:13:38.192Z+ pfexec plimit -n 9123456 1106
1382024-09-27T17:13:38.192Z+ echo 'Setup self timeout'
1392024-09-27T17:13:38.192ZSetup self timeout
1402024-09-27T17:13:38.192Z+ jobpid=1106
1412024-09-27T17:13:38.192Z+ echo 'Setup debug logging'
1422024-09-27T17:13:38.192ZSetup debug logging
1432024-09-27T17:13:38.192Z+ mkdir /tmp/debug
1442024-09-27T17:13:38.192Z+ sleep 7200
1452024-09-27T17:13:38.192Z+ psrinfo -v
1462024-09-27T17:13:38.192Z+ df -h
1472024-09-27T17:13:38.217Zdf: cannot statvfs /var/metadata/iso: Permission denied
1482024-09-27T17:13:38.217Z+ true
1492024-09-27T17:13:38.217Z+ prstat -d d -mLc 1
1502024-09-27T17:13:38.217Z+ iostat -T d -xn 1
1512024-09-27T17:13:38.217Z+ mpstat -T d 1
1522024-09-27T17:13:38.217Z+ vmstat -T d -p 1
1532024-09-27T17:13:38.217Z+ banner 'crudd bench'
1542024-09-27T17:13:38.217Z+ pfexec dtrace -Z -s /input/rbuild/work/scripts/perf-downstairs-tick.d
1552024-09-27T17:13:38.217Z
1562024-09-27T17:13:38.217Z #### ##### # # ##### ##### ##### ###### # # ####
1572024-09-27T17:13:38.217Z # # # # # # # # # # # # # ## # # #
1582024-09-27T17:13:38.217Z # # # # # # # # # ##### ##### # # # #
1592024-09-27T17:13:38.217Z # ##### # # # # # # # # # # # # #
1602024-09-27T17:13:38.217Z # # # # # # # # # # # # # # ## # #
1612024-09-27T17:13:38.217Z #### # # #### ##### ##### ##### ###### # # ####
1622024-09-27T17:13:38.217Z
1632024-09-27T17:13:38.217Z+ pfexec plimit -n 9123456 1106
1642024-09-27T17:13:38.217Z+ ptime -m bash /input/rbuild/work/scripts/crudd-speed-battery.sh
1652024-09-27T17:13:38.241Zrun single test
1662024-09-27T17:13:38.265ZCreating region directory at: /var/tmp/dsc/region
1672024-09-27T17:13:38.265ZCreating dsc directory at: /tmp/dsc
1682024-09-27T17:13:38.677ZDownstairs region 0 created at /var/tmp/dsc/region/8810 in 0.42356807
1692024-09-27T17:13:38.771ZDownstairs region 1 created at /var/tmp/dsc/region/8820 in 0.09438507
1702024-09-27T17:13:38.868ZDownstairs region 2 created at /var/tmp/dsc/region/8830 in 0.09653143
1712024-09-27T17:13:38.868ZCreated 3 regions
1722024-09-27T17:13:38.892ZUsing existing output directory "/tmp/dsc"
1732024-09-27T17:13:38.892ZUpdate our region info with: Some(RegionExtentInfo { block_size: 512, blocks_per_extent: 262144, extent_count: 32 })
1742024-09-27T17:13:38.892Zstart ds: 8810
1752024-09-27T17:13:38.892Zstart ds: 8820
1762024-09-27T17:13:38.892Zstart ds: 8830
1772024-09-27T17:13:38.892Zstart access at:127.0.0.1:9998
1782024-09-27T17:13:38.892ZStarting downstairs at port 8820
1792024-09-27T17:13:38.892ZMake output file at "/tmp/dsc/downstairs-8820.txt"
1802024-09-27T17:13:38.892Z[8820][1] initial start wait reports Starting
1812024-09-27T17:13:38.892ZStarting downstairs at port 8830
1822024-09-27T17:13:38.892ZMake output file at "/tmp/dsc/downstairs-8830.txt"
1832024-09-27T17:13:38.892ZStarting downstairs at port 8810
1842024-09-27T17:13:38.892Z[8830][2] initial start wait reports Starting
1852024-09-27T17:13:38.892Z[8810][0] initial start wait reports Starting
1862024-09-27T17:13:38.892ZMake output file at "/tmp/dsc/downstairs-8810.txt"
1872024-09-27T17:13:38.892ZDownstairs /var/tmp/dsc/region/8820 port 8820 PID:Some(1157)
1882024-09-27T17:13:38.892Z[8820][1] initial start wait reports Running
1892024-09-27T17:13:38.916ZDownstairs /var/tmp/dsc/region/8830 port 8830 PID:Some(1158)
1902024-09-27T17:13:38.916Z[8830][2] initial start wait reports Running
1912024-09-27T17:13:38.916ZDownstairs /var/tmp/dsc/region/8810 port 8810 PID:Some(1159)
1922024-09-27T17:13:38.916Z[8810][0] initial start wait reports Running
1932024-09-27T17:13:38.916ZAll downstairs are running
1942024-09-27T17:13:38.916ZSep 27 17:13:38.540 INFO listening, local_addr: 127.0.0.1:9998
1952024-09-27T17:13:38.916ZControl access at:127.0.0.1:9998
1962024-09-27T17:13:41.883ZStarted DSC 1155
1972024-09-27T17:13:41.910Zraw options: Opt { target: [127.0.0.1:8810, 127.0.0.1:8820, 127.0.0.1:8830], key: None, gen: 1, cert_pem: None, key_pem: None, root_cert_pem: None, control: None, num_bytes: Some(4294967296), byte_offset: 0, iocmd_block_count: 4096, pipeline_length: 8, benchmarking_mode: Some("/tmp/crudd-benchmark-num-bytes-processed.txt"), subcommand: Read }
1982024-09-27T17:13:41.935Z{"msg":"Upstairs starts","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.559761272Z","hostname":"bmat-EVT22200007-0000448d","pid":1164}
1992024-09-27T17:13:41.935Z{"msg":"Crucible Version: BuildInfo {\n version: \"0.0.1\",\n git_sha: \"93b12f70ee7c1993c73ac4256d99ff80ccbe4bac\",\n git_commit_timestamp: \"2024-09-27T16:52:31.000000000Z\",\n git_branch: \"update-omicron-common\",\n rustc_semver: \"1.80.0\",\n rustc_channel: \"stable\",\n rustc_host_triple: \"x86_64-unknown-illumos\",\n rustc_commit_sha: \"051478957371ee0084a7c0913941d2a8c4757bb9\",\n cargo_triple: \"x86_64-unknown-illumos\",\n debug: false,\n opt_level: 3,\n}","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.560255588Z","hostname":"bmat-EVT22200007-0000448d","pid":1164}
2002024-09-27T17:13:41.935Z{"msg":"Upstairs <-> Downstairs Message Version: 11","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.56028703Z","hostname":"bmat-EVT22200007-0000448d","pid":1164}
2012024-09-27T17:13:41.935Z{"msg":"Crucible 00000000-0000-0000-0000-000000000000 has session id: 328162c9-15cb-4e0e-8191-ad1362eb6c11","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.561224219Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2022024-09-27T17:13:41.935Z{"msg":"Upstairs opts: Upstairs UUID: 00000000-0000-0000-0000-000000000000, Targets: [127.0.0.1:8810, 127.0.0.1:8820, 127.0.0.1:8830], lossy: false, flush_timeout: None, key populated: false, cert_pem populated: false, key_pem populated: false, root_cert_pem populated: false, Control: None, read_only: false","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.561372855Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2032024-09-27T17:13:41.935Z{"msg":"Crucible stats registered with UUID: 00000000-0000-0000-0000-000000000000","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.561384208Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2042024-09-27T17:13:41.969ZCrucible runtime is spawned
2052024-09-27T17:13:42.018Z{"msg":"The guest has requested activation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.613730997Z","hostname":"bmat-EVT22200007-0000448d","pid":1164}
2062024-09-27T17:13:42.018Z{"msg":"00000000-0000-0000-0000-000000000000 active request set","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.613785456Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2072024-09-27T17:13:42.018Z{"msg":"sending connect oneshot to client","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.613796327Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"0","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2082024-09-27T17:13:42.018Z{"msg":"client set_active_request while in New; waiting...","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.613970464Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"0","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2092024-09-27T17:13:42.018Z{"msg":"sending connect oneshot to client","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.613984192Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"1","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2102024-09-27T17:13:42.018Z{"msg":"client set_active_request while in New; waiting...","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.613995855Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"1","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2112024-09-27T17:13:42.018Z{"msg":"sending connect oneshot to client","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.614007077Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"2","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2122024-09-27T17:13:42.018Z{"msg":"client set_active_request while in New; waiting...","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.61401843Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"2","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2132024-09-27T17:13:42.018Z{"msg":"connecting to 127.0.0.1:8830","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.614415822Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"io task","client":"2","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2142024-09-27T17:13:42.018Z{"msg":"connecting to 127.0.0.1:8810","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.614465141Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"io task","client":"0","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2152024-09-27T17:13:42.018Z{"msg":"connecting to 127.0.0.1:8820","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.614476784Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"io task","client":"1","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2162024-09-27T17:13:42.018Z{"msg":"ds_connection connected from Ok(127.0.0.1:40498)","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.614758255Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"io task","client":"1","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2172024-09-27T17:13:42.018Z{"msg":"ds_connection connected from Ok(127.0.0.1:48414)","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.614815399Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"io task","client":"0","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2182024-09-27T17:13:42.018Z{"msg":"ds_connection connected from Ok(127.0.0.1:61538)","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.614828325Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"io task","client":"2","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2192024-09-27T17:13:42.018Z{"msg":"ds_transition from New to WaitActive","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.616213447Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"0","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2202024-09-27T17:13:42.018Z{"msg":"[0] Transition from New to WaitActive","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.616386001Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"0","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2212024-09-27T17:13:42.018Z{"msg":"ds_transition from New to WaitActive","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.61643085Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"2","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2222024-09-27T17:13:42.018Z{"msg":"[2] Transition from New to WaitActive","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.61644106Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"2","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2232024-09-27T17:13:42.018Z{"msg":"ds_transition from New to WaitActive","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.616449507Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"1","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2242024-09-27T17:13:42.018Z{"msg":"[1] Transition from New to WaitActive","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.616457383Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"1","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2252024-09-27T17:13:42.018Z{"msg":"downstairs client at Some(127.0.0.1:8820) has region UUID 12345678-0000-0000-0000-000000008820","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.616913863Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"1","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2262024-09-27T17:13:42.018Z{"msg":"downstairs client at Some(127.0.0.1:8830) has region UUID 12345678-0000-0000-0000-000000008830","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.616945075Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"2","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2272024-09-27T17:13:42.018Z{"msg":"downstairs client at Some(127.0.0.1:8810) has region UUID 12345678-0000-0000-0000-000000008810","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.616956167Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"0","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2282024-09-27T17:13:42.019Z{"msg":"ds_transition from WaitActive to WaitQuorum","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.61741392Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"1","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2292024-09-27T17:13:42.019Z{"msg":"[1] Transition from WaitActive to WaitQuorum","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.617486705Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"1","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2302024-09-27T17:13:42.019Z{"msg":"Waiting for more clients to be ready","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.617500272Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2312024-09-27T17:13:42.019Z{"msg":"ds_transition from WaitActive to WaitQuorum","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.617507066Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"2","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2322024-09-27T17:13:42.019Z{"msg":"[2] Transition from WaitActive to WaitQuorum","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.617516825Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"2","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2332024-09-27T17:13:42.019Z{"msg":"Waiting for more clients to be ready","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.61752402Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2342024-09-27T17:13:42.019Z{"msg":"ds_transition from WaitActive to WaitQuorum","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.617530122Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"0","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2352024-09-27T17:13:42.019Z{"msg":"[0] Transition from WaitActive to WaitQuorum","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.617537767Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"0","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2362024-09-27T17:13:42.019Z{"msg":"[0]R flush_numbers[0..12]: [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.61774002Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"downstairs","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2372024-09-27T17:13:42.019Z{"msg":"[0]R generation[0..12]: [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.617764489Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"downstairs","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2382024-09-27T17:13:42.019Z{"msg":"[0]R dirty[0..12]: [false, false, false, false, false, false, false, false, false, false, false, false]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.617772655Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"downstairs","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2392024-09-27T17:13:42.019Z{"msg":"[1]R flush_numbers[0..12]: [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.617780651Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"downstairs","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2402024-09-27T17:13:42.019Z{"msg":"[1]R generation[0..12]: [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.617788036Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"downstairs","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2412024-09-27T17:13:42.019Z{"msg":"[1]R dirty[0..12]: [false, false, false, false, false, false, false, false, false, false, false, false]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.617795801Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"downstairs","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2422024-09-27T17:13:42.019Z{"msg":"[2]R flush_numbers[0..12]: [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.617803086Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"downstairs","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2432024-09-27T17:13:42.019Z{"msg":"[2]R generation[0..12]: [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.617809889Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"downstairs","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2442024-09-27T17:13:42.019Z{"msg":"[2]R dirty[0..12]: [false, false, false, false, false, false, false, false, false, false, false, false]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.617817425Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"downstairs","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2452024-09-27T17:13:42.019Z{"msg":"Max found gen is 1","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.617824789Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"downstairs","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2462024-09-27T17:13:42.019Z{"msg":"Generation requested: 1 >= found:1","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.617834729Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"downstairs","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2472024-09-27T17:13:42.019Z{"msg":"Next flush: 1","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.617842755Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"downstairs","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2482024-09-27T17:13:42.019Z{"msg":"All extents match","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.61785005Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"downstairs","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2492024-09-27T17:13:42.019Z{"msg":"No downstairs reconciliation required","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.617857334Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2502024-09-27T17:13:42.019Z{"msg":"Transition from WaitQuorum to Active","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.617866392Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"0","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2512024-09-27T17:13:42.019Z{"msg":"Transition from WaitQuorum to Active","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.617889749Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"1","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2522024-09-27T17:13:42.019Z{"msg":"Transition from WaitQuorum to Active","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.617897123Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"2","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2532024-09-27T17:13:42.019Z{"msg":"All required reconciliation work is completed","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.617905149Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2542024-09-27T17:13:42.019Z{"msg":"Set Downstairs and Upstairs active after reconciliation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.617911252Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2552024-09-27T17:13:42.019Z{"msg":"00000000-0000-0000-0000-000000000000 is now active with session: 328162c9-15cb-4e0e-8191-ad1362eb6c11","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.617917594Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2562024-09-27T17:13:42.019Z{"msg":"Set Active after no reconciliation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.617923536Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2572024-09-27T17:13:42.019Z{"msg":"The guest has finished waiting for activation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:41.617932143Z","hostname":"bmat-EVT22200007-0000448d","pid":1164}
2582024-09-27T17:13:48.413Z{"msg":"Request to deactivate this guest","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.057713649Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2592024-09-27T17:13:48.507Z{"msg":"checking for deactivation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.057936614Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2602024-09-27T17:13:48.507Z{"msg":"[0] cannot deactivate, job 5108 in state InProgress","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.057973157Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"downstairs","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2612024-09-27T17:13:48.507Z{"msg":"not ready to deactivate client 0","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.057983137Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2622024-09-27T17:13:48.507Z{"msg":"[1] cannot deactivate, job 5107 in state InProgress","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.05798963Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"downstairs","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2632024-09-27T17:13:48.507Z{"msg":"not ready to deactivate client 1","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058036333Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2642024-09-27T17:13:48.508Z{"msg":"[2] cannot deactivate, job 5107 in state InProgress","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058042846Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"downstairs","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2652024-09-27T17:13:48.508Z{"msg":"not ready to deactivate client 2","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058049279Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2662024-09-27T17:13:48.508Z{"msg":"not ready to deactivate due to state Active","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.05805489Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"0","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2672024-09-27T17:13:48.508Z{"msg":"checking for deactivation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058061894Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2682024-09-27T17:13:48.508Z{"msg":"[0] cannot deactivate, job 5108 in state InProgress","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058067335Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"downstairs","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2692024-09-27T17:13:48.508Z{"msg":"not ready to deactivate client 0","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058076473Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2702024-09-27T17:13:48.508Z{"msg":"[1] cannot deactivate, job 5108 in state InProgress","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058082845Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"downstairs","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2712024-09-27T17:13:48.508Z{"msg":"not ready to deactivate client 1","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058104449Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2722024-09-27T17:13:48.508Z{"msg":"[2] cannot deactivate, job 5107 in state InProgress","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058110761Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"downstairs","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2732024-09-27T17:13:48.508Z{"msg":"not ready to deactivate client 2","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058117104Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2742024-09-27T17:13:48.508Z{"msg":"not ready to deactivate due to state Active","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058123096Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"0","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2752024-09-27T17:13:48.508Z{"msg":"checking for deactivation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058315459Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2762024-09-27T17:13:48.508Z{"msg":"[0] cannot deactivate, job 5108 in state InProgress","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058338635Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"downstairs","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2772024-09-27T17:13:48.508Z{"msg":"not ready to deactivate client 0","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058346371Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2782024-09-27T17:13:48.508Z{"msg":"[1] cannot deactivate, job 5108 in state InProgress","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058352062Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"downstairs","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2792024-09-27T17:13:48.508Z{"msg":"not ready to deactivate client 1","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058358836Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2802024-09-27T17:13:48.508Z{"msg":"[2] cannot deactivate, job 5107 in state InProgress","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058364537Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"downstairs","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2812024-09-27T17:13:48.508Z{"msg":"not ready to deactivate client 2","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058375168Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2822024-09-27T17:13:48.508Z{"msg":"not ready to deactivate due to state Active","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058381381Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"0","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2832024-09-27T17:13:48.508Z{"msg":"checking for deactivation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058388224Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2842024-09-27T17:13:48.508Z{"msg":"[0] cannot deactivate, job 5108 in state InProgress","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058393745Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"downstairs","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2852024-09-27T17:13:48.508Z{"msg":"not ready to deactivate client 0","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058400579Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2862024-09-27T17:13:48.508Z{"msg":"[1] cannot deactivate, job 5108 in state InProgress","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.05840634Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"downstairs","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2872024-09-27T17:13:48.508Z{"msg":"not ready to deactivate client 1","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058412984Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2882024-09-27T17:13:48.508Z{"msg":"[2] cannot deactivate, job 5107 in state InProgress","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058418625Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"downstairs","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2892024-09-27T17:13:48.508Z{"msg":"not ready to deactivate client 2","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058425058Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2902024-09-27T17:13:48.508Z{"msg":"not ready to deactivate due to state Active","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.05843127Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"0","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2912024-09-27T17:13:48.508Z{"msg":"checking for deactivation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058438465Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2922024-09-27T17:13:48.508Z{"msg":"[0] cannot deactivate, job 5108 in state InProgress","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058444366Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"downstairs","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2932024-09-27T17:13:48.509Z{"msg":"not ready to deactivate client 0","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058452813Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2942024-09-27T17:13:48.509Z{"msg":"[1] cannot deactivate, job 5108 in state InProgress","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058458895Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"downstairs","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2952024-09-27T17:13:48.509Z{"msg":"not ready to deactivate client 1","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058465338Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2962024-09-27T17:13:48.509Z{"msg":"[2] cannot deactivate, job 5107 in state InProgress","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058470979Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"downstairs","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2972024-09-27T17:13:48.509Z{"msg":"not ready to deactivate client 2","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058478494Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2982024-09-27T17:13:48.509Z{"msg":"not ready to deactivate due to state Active","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058486681Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"0","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
2992024-09-27T17:13:48.509Z{"msg":"checking for deactivation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058555037Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3002024-09-27T17:13:48.509Z{"msg":"[0] cannot deactivate, job 5108 in state InProgress","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058562923Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"downstairs","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3012024-09-27T17:13:48.509Z{"msg":"not ready to deactivate client 0","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058584035Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3022024-09-27T17:13:48.509Z{"msg":"[1] cannot deactivate, job 5108 in state InProgress","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058590518Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"downstairs","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3032024-09-27T17:13:48.509Z{"msg":"not ready to deactivate client 1","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058597482Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3042024-09-27T17:13:48.509Z{"msg":"[2] cannot deactivate, job 5108 in state InProgress","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058603584Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"downstairs","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3052024-09-27T17:13:48.509Z{"msg":"not ready to deactivate client 2","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058609956Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3062024-09-27T17:13:48.509Z{"msg":"not ready to deactivate due to state Active","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058615878Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"0","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3072024-09-27T17:13:48.509Z{"msg":"checking for deactivation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058622672Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3082024-09-27T17:13:48.509Z{"msg":"[0] check deactivate YES","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058628413Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"downstairs","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3092024-09-27T17:13:48.509Z{"msg":"ds_transition from Active to Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058649415Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"0","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3102024-09-27T17:13:48.509Z{"msg":"[0] Transition from Active to Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058656229Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"0","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3112024-09-27T17:13:48.509Z{"msg":"deactivated client 0","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058663754Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3122024-09-27T17:13:48.509Z{"msg":"[1] cannot deactivate, job 5108 in state InProgress","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058669716Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"downstairs","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3132024-09-27T17:13:48.509Z{"msg":"not ready to deactivate client 1","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058676629Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3142024-09-27T17:13:48.509Z{"msg":"[2] cannot deactivate, job 5108 in state InProgress","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058682231Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"downstairs","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3152024-09-27T17:13:48.509Z{"msg":"not ready to deactivate client 2","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058688814Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3162024-09-27T17:13:48.509Z{"msg":"not ready to deactivate due to state Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.0586968Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"0","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3172024-09-27T17:13:48.509Z{"msg":"checking for deactivation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058703783Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3182024-09-27T17:13:48.509Z{"msg":"[1] check deactivate YES","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058709735Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"downstairs","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3192024-09-27T17:13:48.509Z{"msg":"ds_transition from Active to Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058716369Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"1","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3202024-09-27T17:13:48.509Z{"msg":"[1] Transition from Active to Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058725457Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"1","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3212024-09-27T17:13:48.510Z{"msg":"deactivated client 1","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.05873227Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3222024-09-27T17:13:48.510Z{"msg":"[2] cannot deactivate, job 5108 in state InProgress","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058737972Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"downstairs","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3232024-09-27T17:13:48.510Z{"msg":"not ready to deactivate client 2","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058744655Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3242024-09-27T17:13:48.510Z{"msg":"not ready to deactivate due to state Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.058752651Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"0","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3252024-09-27T17:13:48.510Z{"msg":"client task is sending Done(RequestedStop(Deactivated))","v":0,"name":"crucible","level":40,"time":"2024-09-27T17:13:48.058759825Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"io task","client":"0","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3262024-09-27T17:13:48.510Z{"msg":"downstairs disconnected","v":0,"name":"crucible","level":40,"time":"2024-09-27T17:13:48.059071306Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"io task","client":"0","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3272024-09-27T17:13:48.510Z{"msg":"checking for deactivation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.059475552Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3282024-09-27T17:13:48.510Z{"msg":"[2] deactivate, no work so YES","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.059497957Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"downstairs","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3292024-09-27T17:13:48.510Z{"msg":"ds_transition from Active to Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.059505352Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"2","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3302024-09-27T17:13:48.510Z{"msg":"[2] Transition from Active to Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.059513087Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"2","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3312024-09-27T17:13:48.510Z{"msg":"deactivated client 2","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.059519821Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3322024-09-27T17:13:48.510Z{"msg":"not ready to deactivate due to state Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.059526033Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"0","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3332024-09-27T17:13:48.510Z{"msg":"checking for deactivation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.059534901Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3342024-09-27T17:13:48.510Z{"msg":"not ready to deactivate due to state Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.059543438Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"0","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3352024-09-27T17:13:48.510Z{"msg":"downstairs task for 0 stopped due to RequestedStop(Deactivated)","v":0,"name":"crucible","level":40,"time":"2024-09-27T17:13:48.059552075Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3362024-09-27T17:13:48.510Z{"msg":"Gone missing, transition from Deactivated to Disconnected","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.059558137Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"0","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3372024-09-27T17:13:48.510Z{"msg":"Disconnected -> New","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.059567656Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"0","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3382024-09-27T17:13:48.510Z{"msg":"checking for deactivation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.059577646Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3392024-09-27T17:13:48.510Z{"msg":"ready to deactivate from state New","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.059585722Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"0","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3402024-09-27T17:13:48.510Z{"msg":"not ready to deactivate due to state Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.05959498Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"1","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3412024-09-27T17:13:48.510Z{"msg":"client task is exiting","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.059607044Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"io task","client":"0","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3422024-09-27T17:13:48.510Z{"msg":"client task is sending Done(RequestedStop(Deactivated))","v":0,"name":"crucible","level":40,"time":"2024-09-27T17:13:48.059615812Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"io task","client":"1","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3432024-09-27T17:13:48.510Z{"msg":"client task is sending Done(RequestedStop(Deactivated))","v":0,"name":"crucible","level":40,"time":"2024-09-27T17:13:48.059625271Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"io task","client":"2","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3442024-09-27T17:13:48.510Z{"msg":"downstairs task for 1 stopped due to RequestedStop(Deactivated)","v":0,"name":"crucible","level":40,"time":"2024-09-27T17:13:48.059753186Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3452024-09-27T17:13:48.510Z{"msg":"downstairs disconnected","v":0,"name":"crucible","level":40,"time":"2024-09-27T17:13:48.059801382Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"io task","client":"1","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3462024-09-27T17:13:48.510Z{"msg":"downstairs disconnected","v":0,"name":"crucible","level":40,"time":"2024-09-27T17:13:48.059892023Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"io task","client":"2","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3472024-09-27T17:13:48.510Z{"msg":"Gone missing, transition from Deactivated to Disconnected","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.059914658Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"1","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3482024-09-27T17:13:48.511Z{"msg":"Disconnected -> New","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.06040707Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"1","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3492024-09-27T17:13:48.511Z{"msg":"checking for deactivation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.060580435Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3502024-09-27T17:13:48.511Z{"msg":"ready to deactivate from state New","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.060725695Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"0","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3512024-09-27T17:13:48.511Z{"msg":"ready to deactivate from state New","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.06074858Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"1","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3522024-09-27T17:13:48.511Z{"msg":"not ready to deactivate due to state Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.060755564Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"2","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3532024-09-27T17:13:48.511Z{"msg":"downstairs task for 2 stopped due to RequestedStop(Deactivated)","v":0,"name":"crucible","level":40,"time":"2024-09-27T17:13:48.060763981Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3542024-09-27T17:13:48.511Z{"msg":"Gone missing, transition from Deactivated to Disconnected","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.060770224Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"2","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3552024-09-27T17:13:48.511Z{"msg":"Disconnected -> New","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.060777187Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"2","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3562024-09-27T17:13:48.511Z{"msg":"client task is exiting","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.060821556Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"io task","client":"1","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3572024-09-27T17:13:48.511Z{"msg":"checking for deactivation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.060844902Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3582024-09-27T17:13:48.511Z{"msg":"ready to deactivate from state New","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.060851425Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"0","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3592024-09-27T17:13:48.536Z{"msg":"ready to deactivate from state New","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.060859752Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"1","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3602024-09-27T17:13:48.536Z{"msg":"ready to deactivate from state New","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.060866265Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"client":"2","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3612024-09-27T17:13:48.536Z{"msg":"All DS in the proper state! -> INIT","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.060873129Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3622024-09-27T17:13:48.536Z{"msg":"client task is exiting","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.060893569Z","hostname":"bmat-EVT22200007-0000448d","pid":1164,"":"io task","client":"2","":"downstairs","session_id":"328162c9-15cb-4e0e-8191-ad1362eb6c11"}
3632024-09-27T17:13:48.537Z{"msg":"Guest handle has been dropped","v":0,"name":"crucible","level":40,"time":"2024-09-27T17:13:48.060914361Z","hostname":"bmat-EVT22200007-0000448d","pid":1164}
3642024-09-27T17:13:48.537Zraw options: Opt { target: [127.0.0.1:8810, 127.0.0.1:8820, 127.0.0.1:8830], key: None, gen: 2, cert_pem: None, key_pem: None, root_cert_pem: None, control: None, num_bytes: Some(4294967296), byte_offset: 0, iocmd_block_count: 4096, pipeline_length: 8, benchmarking_mode: Some("/tmp/crudd-benchmark-num-bytes-processed.txt"), subcommand: Write }
3652024-09-27T17:13:48.537Z{"msg":"Upstairs starts","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.105857849Z","hostname":"bmat-EVT22200007-0000448d","pid":1170}
3662024-09-27T17:13:48.537Z{"msg":"Crucible Version: BuildInfo {\n version: \"0.0.1\",\n git_sha: \"93b12f70ee7c1993c73ac4256d99ff80ccbe4bac\",\n git_commit_timestamp: \"2024-09-27T16:52:31.000000000Z\",\n git_branch: \"update-omicron-common\",\n rustc_semver: \"1.80.0\",\n rustc_channel: \"stable\",\n rustc_host_triple: \"x86_64-unknown-illumos\",\n rustc_commit_sha: \"051478957371ee0084a7c0913941d2a8c4757bb9\",\n cargo_triple: \"x86_64-unknown-illumos\",\n debug: false,\n opt_level: 3,\n}","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.106503477Z","hostname":"bmat-EVT22200007-0000448d","pid":1170}
3672024-09-27T17:13:48.537Z{"msg":"Upstairs <-> Downstairs Message Version: 11","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.106542564Z","hostname":"bmat-EVT22200007-0000448d","pid":1170}
3682024-09-27T17:13:48.537Z{"msg":"Crucible 00000000-0000-0000-0000-000000000000 has session id: c8af7f7a-9b6c-43b1-9663-18ebf161576f","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.106596532Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
3692024-09-27T17:13:48.537Z{"msg":"Upstairs opts: Upstairs UUID: 00000000-0000-0000-0000-000000000000, Targets: [127.0.0.1:8810, 127.0.0.1:8820, 127.0.0.1:8830], lossy: false, flush_timeout: None, key populated: false, cert_pem populated: false, key_pem populated: false, root_cert_pem populated: false, Control: None, read_only: false","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.106645901Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
3702024-09-27T17:13:48.537Z{"msg":"Crucible stats registered with UUID: 00000000-0000-0000-0000-000000000000","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.106655019Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
3712024-09-27T17:13:48.537ZCrucible runtime is spawned
3722024-09-27T17:13:48.537Z{"msg":"The guest has requested activation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.163809052Z","hostname":"bmat-EVT22200007-0000448d","pid":1170}
3732024-09-27T17:13:48.537Z{"msg":"00000000-0000-0000-0000-000000000000 active request set","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.163875014Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
3742024-09-27T17:13:48.537Z{"msg":"sending connect oneshot to client","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.163885755Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"0","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
3752024-09-27T17:13:48.537Z{"msg":"client set_active_request while in New; waiting...","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.163915334Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"0","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
3762024-09-27T17:13:48.537Z{"msg":"sending connect oneshot to client","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.163932539Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"1","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
3772024-09-27T17:13:48.537Z{"msg":"client set_active_request while in New; waiting...","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.163952017Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"1","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
3782024-09-27T17:13:48.537Z{"msg":"sending connect oneshot to client","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.163959422Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"2","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
3792024-09-27T17:13:48.537Z{"msg":"client set_active_request while in New; waiting...","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.163996857Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"2","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
3802024-09-27T17:13:48.537Z{"msg":"connecting to 127.0.0.1:8830","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.164082287Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"":"io task","client":"2","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
3812024-09-27T17:13:48.537Z{"msg":"connecting to 127.0.0.1:8810","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.164109Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"":"io task","client":"0","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
3822024-09-27T17:13:48.537Z{"msg":"connecting to 127.0.0.1:8820","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.164267396Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"":"io task","client":"1","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
3832024-09-27T17:13:48.537Z{"msg":"ds_connection connected from Ok(127.0.0.1:49122)","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.164301775Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"":"io task","client":"0","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
3842024-09-27T17:13:48.537Z{"msg":"ds_connection connected from Ok(127.0.0.1:39122)","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.164418127Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"":"io task","client":"2","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
3852024-09-27T17:13:48.537Z{"msg":"ds_connection connected from Ok(127.0.0.1:54868)","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.164563266Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"":"io task","client":"1","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
3862024-09-27T17:13:48.537Z{"msg":"ds_transition from New to WaitActive","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.164876541Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"0","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
3872024-09-27T17:13:48.537Z{"msg":"[0] Transition from New to WaitActive","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.164908525Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"0","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
3882024-09-27T17:13:48.537Z{"msg":"ds_transition from New to WaitActive","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.165085828Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"1","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
3892024-09-27T17:13:48.537Z{"msg":"[1] Transition from New to WaitActive","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.165111018Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"1","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
3902024-09-27T17:13:48.537Z{"msg":"ds_transition from New to WaitActive","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.165551847Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"2","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
3912024-09-27T17:13:48.537Z{"msg":"[2] Transition from New to WaitActive","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.165575054Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"2","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
3922024-09-27T17:13:48.537Z{"msg":"downstairs client at Some(127.0.0.1:8820) has region UUID 12345678-0000-0000-0000-000000008820","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.165744762Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"1","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
3932024-09-27T17:13:48.538Z{"msg":"downstairs client at Some(127.0.0.1:8810) has region UUID 12345678-0000-0000-0000-000000008810","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.165768309Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"0","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
3942024-09-27T17:13:48.538Z{"msg":"downstairs client at Some(127.0.0.1:8830) has region UUID 12345678-0000-0000-0000-000000008830","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.166080281Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"2","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
3952024-09-27T17:13:48.538Z{"msg":"ds_transition from WaitActive to WaitQuorum","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.166245941Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"1","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
3962024-09-27T17:13:48.538Z{"msg":"[1] Transition from WaitActive to WaitQuorum","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.166273035Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"1","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
3972024-09-27T17:13:48.538Z{"msg":"Waiting for more clients to be ready","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.166283686Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
3982024-09-27T17:13:48.538Z{"msg":"ds_transition from WaitActive to WaitQuorum","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.166507833Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"0","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
3992024-09-27T17:13:48.538Z{"msg":"[0] Transition from WaitActive to WaitQuorum","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.166529937Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"0","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4002024-09-27T17:13:48.538Z{"msg":"Waiting for more clients to be ready","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.166537743Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4012024-09-27T17:13:48.538Z{"msg":"ds_transition from WaitActive to WaitQuorum","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.166746098Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"2","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4022024-09-27T17:13:48.538Z{"msg":"[2] Transition from WaitActive to WaitQuorum","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.166767862Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"2","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4032024-09-27T17:13:48.538Z{"msg":"[0]R flush_numbers[0..12]: [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.166776078Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"":"downstairs","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4042024-09-27T17:13:48.538Z{"msg":"[0]R generation[0..12]: [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.166784154Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"":"downstairs","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4052024-09-27T17:13:48.538Z{"msg":"[0]R dirty[0..12]: [false, false, false, false, false, false, false, false, false, false, false, false]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.16679208Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"":"downstairs","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4062024-09-27T17:13:48.538Z{"msg":"[1]R flush_numbers[0..12]: [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.166799755Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"":"downstairs","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4072024-09-27T17:13:48.538Z{"msg":"[1]R generation[0..12]: [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.166806579Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"":"downstairs","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4082024-09-27T17:13:48.538Z{"msg":"[1]R dirty[0..12]: [false, false, false, false, false, false, false, false, false, false, false, false]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.166813563Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"":"downstairs","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4092024-09-27T17:13:48.538Z{"msg":"[2]R flush_numbers[0..12]: [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.166820437Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"":"downstairs","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4102024-09-27T17:13:48.538Z{"msg":"[2]R generation[0..12]: [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.166828162Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"":"downstairs","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4112024-09-27T17:13:48.538Z{"msg":"[2]R dirty[0..12]: [false, false, false, false, false, false, false, false, false, false, false, false]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.166835146Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"":"downstairs","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4122024-09-27T17:13:48.538Z{"msg":"Max found gen is 1","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.166842491Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"":"downstairs","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4132024-09-27T17:13:48.538Z{"msg":"Generation requested: 2 >= found:1","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.166851659Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"":"downstairs","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4142024-09-27T17:13:48.538Z{"msg":"Next flush: 1","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.166858943Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"":"downstairs","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4152024-09-27T17:13:48.538Z{"msg":"All extents match","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.166957891Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"":"downstairs","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4162024-09-27T17:13:48.538Z{"msg":"No downstairs reconciliation required","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.166985285Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4172024-09-27T17:13:48.538Z{"msg":"Transition from WaitQuorum to Active","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.166993932Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"0","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4182024-09-27T17:13:48.538Z{"msg":"Transition from WaitQuorum to Active","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.167004684Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"1","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4192024-09-27T17:13:48.538Z{"msg":"Transition from WaitQuorum to Active","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.167014834Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"2","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4202024-09-27T17:13:48.538Z{"msg":"All required reconciliation work is completed","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.167043491Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4212024-09-27T17:13:48.538Z{"msg":"Set Downstairs and Upstairs active after reconciliation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.167055355Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4222024-09-27T17:13:48.538Z{"msg":"00000000-0000-0000-0000-000000000000 is now active with session: c8af7f7a-9b6c-43b1-9663-18ebf161576f","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.167063992Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4232024-09-27T17:13:48.538Z{"msg":"Set Active after no reconciliation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.167073571Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4242024-09-27T17:13:48.538Z{"msg":"The guest has finished waiting for activation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:48.1670932Z","hostname":"bmat-EVT22200007-0000448d","pid":1170}
4252024-09-27T17:13:53.598Z{"msg":"Request to deactivate this guest","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.221101613Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4262024-09-27T17:13:53.598Z{"msg":"checking for deactivation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.221144999Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4272024-09-27T17:13:53.598Z{"msg":"[0] deactivate, no work so YES","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.221152414Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"":"downstairs","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4282024-09-27T17:13:53.598Z{"msg":"ds_transition from Active to Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.22116036Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"0","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4292024-09-27T17:13:53.598Z{"msg":"[0] Transition from Active to Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.221169428Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"0","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4302024-09-27T17:13:53.598Z{"msg":"deactivated client 0","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.221177845Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4312024-09-27T17:13:53.598Z{"msg":"[1] deactivate, no work so YES","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.221186111Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"":"downstairs","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4322024-09-27T17:13:53.598Z{"msg":"ds_transition from Active to Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.221195069Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"1","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4332024-09-27T17:13:53.598Z{"msg":"[1] Transition from Active to Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.221206883Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"1","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4342024-09-27T17:13:53.598Z{"msg":"deactivated client 1","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.221213306Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4352024-09-27T17:13:53.598Z{"msg":"[2] deactivate, no work so YES","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.221218696Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"":"downstairs","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4362024-09-27T17:13:53.598Z{"msg":"ds_transition from Active to Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.221225029Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"2","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4372024-09-27T17:13:53.598Z{"msg":"[2] Transition from Active to Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.221231582Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"2","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4382024-09-27T17:13:53.598Z{"msg":"deactivated client 2","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.221238125Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4392024-09-27T17:13:53.645Z{"msg":"not ready to deactivate due to state Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.221243977Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"0","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4402024-09-27T17:13:53.645Z{"msg":"client task is sending Done(RequestedStop(Deactivated))","v":0,"name":"crucible","level":40,"time":"2024-09-27T17:13:53.221264989Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"":"io task","client":"2","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4412024-09-27T17:13:53.645Z{"msg":"downstairs task for 2 stopped due to RequestedStop(Deactivated)","v":0,"name":"crucible","level":40,"time":"2024-09-27T17:13:53.221274137Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4422024-09-27T17:13:53.645Z{"msg":"client task is sending Done(RequestedStop(Deactivated))","v":0,"name":"crucible","level":40,"time":"2024-09-27T17:13:53.221279758Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"":"io task","client":"0","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4432024-09-27T17:13:53.645Z{"msg":"Gone missing, transition from Deactivated to Disconnected","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.221286361Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"2","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4442024-09-27T17:13:53.645Z{"msg":"Disconnected -> New","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.221292493Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"2","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4452024-09-27T17:13:53.645Z{"msg":"checking for deactivation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.221298445Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4462024-09-27T17:13:53.645Z{"msg":"not ready to deactivate due to state Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.221304938Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"0","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4472024-09-27T17:13:53.645Z{"msg":"downstairs task for 0 stopped due to RequestedStop(Deactivated)","v":0,"name":"crucible","level":40,"time":"2024-09-27T17:13:53.221311471Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4482024-09-27T17:13:53.645Z{"msg":"Gone missing, transition from Deactivated to Disconnected","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.221316912Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"0","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4492024-09-27T17:13:53.645Z{"msg":"Disconnected -> New","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.221322583Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"0","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4502024-09-27T17:13:53.645Z{"msg":"checking for deactivation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.221328676Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4512024-09-27T17:13:53.645Z{"msg":"ready to deactivate from state New","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.221333666Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"0","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4522024-09-27T17:13:53.646Z{"msg":"not ready to deactivate due to state Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.221339828Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"1","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4532024-09-27T17:13:53.646Z{"msg":"client task is sending Done(RequestedStop(Deactivated))","v":0,"name":"crucible","level":40,"time":"2024-09-27T17:13:53.22134605Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"":"io task","client":"1","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4542024-09-27T17:13:53.646Z{"msg":"client task is exiting","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.221368405Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"":"io task","client":"0","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4552024-09-27T17:13:53.646Z{"msg":"client task is exiting","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.221377533Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"":"io task","client":"2","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4562024-09-27T17:13:53.646Z{"msg":"downstairs disconnected","v":0,"name":"crucible","level":40,"time":"2024-09-27T17:13:53.221396882Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"":"io task","client":"1","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4572024-09-27T17:13:53.646Z{"msg":"downstairs task for 1 stopped due to RequestedStop(Deactivated)","v":0,"name":"crucible","level":40,"time":"2024-09-27T17:13:53.221433154Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4582024-09-27T17:13:53.646Z{"msg":"Gone missing, transition from Deactivated to Disconnected","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.221612812Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"1","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4592024-09-27T17:13:53.646Z{"msg":"Disconnected -> New","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.221647902Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"1","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4602024-09-27T17:13:53.646Z{"msg":"checking for deactivation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.221654505Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4612024-09-27T17:13:53.646Z{"msg":"ready to deactivate from state New","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.221660457Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"0","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4622024-09-27T17:13:53.646Z{"msg":"ready to deactivate from state New","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.221666359Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"1","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4632024-09-27T17:13:53.646Z{"msg":"ready to deactivate from state New","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.221672251Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"client":"2","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4642024-09-27T17:13:53.646Z{"msg":"All DS in the proper state! -> INIT","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.221679305Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4652024-09-27T17:13:53.646Z{"msg":"client task is exiting","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.221720898Z","hostname":"bmat-EVT22200007-0000448d","pid":1170,"":"io task","client":"1","":"downstairs","session_id":"c8af7f7a-9b6c-43b1-9663-18ebf161576f"}
4662024-09-27T17:13:53.710Zraw options: Opt { target: [127.0.0.1:8810, 127.0.0.1:8820, 127.0.0.1:8830], key: None, gen: 3, cert_pem: None, key_pem: None, root_cert_pem: None, control: None, num_bytes: Some(4294967296), byte_offset: 0, iocmd_block_count: 32768, pipeline_length: 4, benchmarking_mode: None, subcommand: Write }
4672024-09-27T17:13:53.735Z{"msg":"Upstairs starts","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.357539884Z","hostname":"bmat-EVT22200007-0000448d","pid":1173}
4682024-09-27T17:13:53.735Z{"msg":"Crucible Version: BuildInfo {\n version: \"0.0.1\",\n git_sha: \"93b12f70ee7c1993c73ac4256d99ff80ccbe4bac\",\n git_commit_timestamp: \"2024-09-27T16:52:31.000000000Z\",\n git_branch: \"update-omicron-common\",\n rustc_semver: \"1.80.0\",\n rustc_channel: \"stable\",\n rustc_host_triple: \"x86_64-unknown-illumos\",\n rustc_commit_sha: \"051478957371ee0084a7c0913941d2a8c4757bb9\",\n cargo_triple: \"x86_64-unknown-illumos\",\n debug: false,\n opt_level: 3,\n}","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.357847377Z","hostname":"bmat-EVT22200007-0000448d","pid":1173}
4692024-09-27T17:13:53.735Z{"msg":"Upstairs <-> Downstairs Message Version: 11","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.357941244Z","hostname":"bmat-EVT22200007-0000448d","pid":1173}
4702024-09-27T17:13:53.735Z{"msg":"Crucible 00000000-0000-0000-0000-000000000000 has session id: 99ff54c4-031c-42fc-ab5f-5da4f0481c76","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.358482273Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
4712024-09-27T17:13:53.735Z{"msg":"Upstairs opts: Upstairs UUID: 00000000-0000-0000-0000-000000000000, Targets: [127.0.0.1:8810, 127.0.0.1:8820, 127.0.0.1:8830], lossy: false, flush_timeout: None, key populated: false, cert_pem populated: false, key_pem populated: false, root_cert_pem populated: false, Control: None, read_only: false","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.358562943Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
4722024-09-27T17:13:53.735Z{"msg":"Crucible stats registered with UUID: 00000000-0000-0000-0000-000000000000","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.358619105Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
4732024-09-27T17:13:53.765ZCrucible runtime is spawned
4742024-09-27T17:13:53.765Z{"msg":"The guest has requested activation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.409773918Z","hostname":"bmat-EVT22200007-0000448d","pid":1173}
4752024-09-27T17:13:53.790Z{"msg":"00000000-0000-0000-0000-000000000000 active request set","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.40990039Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
4762024-09-27T17:13:53.790Z{"msg":"sending connect oneshot to client","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.410096972Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"0","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
4772024-09-27T17:13:53.790Z{"msg":"client set_active_request while in New; waiting...","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.410158655Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"0","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
4782024-09-27T17:13:53.790Z{"msg":"sending connect oneshot to client","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.41017114Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"1","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
4792024-09-27T17:13:53.790Z{"msg":"client set_active_request while in New; waiting...","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.410181811Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"1","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
4802024-09-27T17:13:53.790Z{"msg":"sending connect oneshot to client","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.410191591Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"2","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
4812024-09-27T17:13:53.790Z{"msg":"client set_active_request while in New; waiting...","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.41020118Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"2","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
4822024-09-27T17:13:53.790Z{"msg":"connecting to 127.0.0.1:8810","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.410210498Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"":"io task","client":"0","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
4832024-09-27T17:13:53.790Z{"msg":"connecting to 127.0.0.1:8830","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.410229135Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"":"io task","client":"2","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
4842024-09-27T17:13:53.790Z{"msg":"connecting to 127.0.0.1:8820","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.410239356Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"":"io task","client":"1","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
4852024-09-27T17:13:53.790Z{"msg":"ds_connection connected from Ok(127.0.0.1:59300)","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.410625907Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"":"io task","client":"0","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
4862024-09-27T17:13:53.790Z{"msg":"ds_connection connected from Ok(127.0.0.1:46304)","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.410644163Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"":"io task","client":"1","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
4872024-09-27T17:13:53.790Z{"msg":"ds_connection connected from Ok(127.0.0.1:38543)","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.410656057Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"":"io task","client":"2","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
4882024-09-27T17:13:53.790Z{"msg":"ds_transition from New to WaitActive","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.411166054Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"0","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
4892024-09-27T17:13:53.790Z{"msg":"[0] Transition from New to WaitActive","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.411176945Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"0","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
4902024-09-27T17:13:53.790Z{"msg":"ds_transition from New to WaitActive","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.41118456Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"1","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
4912024-09-27T17:13:53.790Z{"msg":"[1] Transition from New to WaitActive","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.411191685Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"1","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
4922024-09-27T17:13:53.790Z{"msg":"ds_transition from New to WaitActive","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.411198889Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"2","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
4932024-09-27T17:13:53.790Z{"msg":"[2] Transition from New to WaitActive","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.411230622Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"2","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
4942024-09-27T17:13:53.790Z{"msg":"downstairs client at Some(127.0.0.1:8830) has region UUID 12345678-0000-0000-0000-000000008830","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.411559027Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"2","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
4952024-09-27T17:13:53.791Z{"msg":"downstairs client at Some(127.0.0.1:8820) has region UUID 12345678-0000-0000-0000-000000008820","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.411590891Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"1","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
4962024-09-27T17:13:53.791Z{"msg":"downstairs client at Some(127.0.0.1:8810) has region UUID 12345678-0000-0000-0000-000000008810","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.411614608Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"0","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
4972024-09-27T17:13:53.791Z{"msg":"ds_transition from WaitActive to WaitQuorum","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.413814023Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"1","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
4982024-09-27T17:13:53.791Z{"msg":"[1] Transition from WaitActive to WaitQuorum","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.413840897Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"1","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
4992024-09-27T17:13:53.791Z{"msg":"Waiting for more clients to be ready","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.4138475Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5002024-09-27T17:13:53.791Z{"msg":"ds_transition from WaitActive to WaitQuorum","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.41385239Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"2","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5012024-09-27T17:13:53.791Z{"msg":"[2] Transition from WaitActive to WaitQuorum","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.413858001Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"2","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5022024-09-27T17:13:53.791Z{"msg":"Waiting for more clients to be ready","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.413863291Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5032024-09-27T17:13:53.791Z{"msg":"ds_transition from WaitActive to WaitQuorum","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.413996908Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"0","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5042024-09-27T17:13:53.791Z{"msg":"[0] Transition from WaitActive to WaitQuorum","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.414016867Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"0","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5052024-09-27T17:13:53.791Z{"msg":"[0]R flush_numbers[0..12]: [1, 2, 2, 3, 3, 3, 4, 4, 4, 5, 5, 5]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.414023511Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"":"downstairs","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5062024-09-27T17:13:53.791Z{"msg":"[0]R generation[0..12]: [2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.414029433Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"":"downstairs","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5072024-09-27T17:13:53.791Z{"msg":"[0]R dirty[0..12]: [false, false, false, false, false, false, false, false, false, false, false, false]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.414037709Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"":"downstairs","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5082024-09-27T17:13:53.791Z{"msg":"[1]R flush_numbers[0..12]: [1, 2, 2, 3, 3, 3, 4, 4, 4, 5, 5, 5]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.414046426Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"":"downstairs","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5092024-09-27T17:13:53.791Z{"msg":"[1]R generation[0..12]: [2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.414052238Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"":"downstairs","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5102024-09-27T17:13:53.791Z{"msg":"[1]R dirty[0..12]: [false, false, false, false, false, false, false, false, false, false, false, false]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.414057769Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"":"downstairs","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5112024-09-27T17:13:53.791Z{"msg":"[2]R flush_numbers[0..12]: [1, 2, 2, 3, 3, 3, 4, 4, 4, 5, 5, 5]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.414063561Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"":"downstairs","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5122024-09-27T17:13:53.791Z{"msg":"[2]R generation[0..12]: [2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.414069352Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"":"downstairs","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5132024-09-27T17:13:53.791Z{"msg":"[2]R dirty[0..12]: [false, false, false, false, false, false, false, false, false, false, false, false]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.414075114Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"":"downstairs","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5142024-09-27T17:13:53.791Z{"msg":"Max found gen is 3","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.414080695Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"":"downstairs","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5152024-09-27T17:13:53.791Z{"msg":"Generation requested: 3 >= found:3","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.414087128Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"":"downstairs","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5162024-09-27T17:13:53.791Z{"msg":"Next flush: 11","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.414092468Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"":"downstairs","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5172024-09-27T17:13:53.791Z{"msg":"All extents match","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.414097679Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"":"downstairs","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5182024-09-27T17:13:53.791Z{"msg":"No downstairs reconciliation required","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.41410325Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5192024-09-27T17:13:53.791Z{"msg":"Transition from WaitQuorum to Active","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.414107779Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"0","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5202024-09-27T17:13:53.791Z{"msg":"Transition from WaitQuorum to Active","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.41411338Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"1","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5212024-09-27T17:13:53.791Z{"msg":"Transition from WaitQuorum to Active","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.41411862Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"2","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5222024-09-27T17:13:53.791Z{"msg":"All required reconciliation work is completed","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.414123881Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5232024-09-27T17:13:53.791Z{"msg":"Set Downstairs and Upstairs active after reconciliation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.41412861Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5242024-09-27T17:13:53.791Z{"msg":"00000000-0000-0000-0000-000000000000 is now active with session: 99ff54c4-031c-42fc-ab5f-5da4f0481c76","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.41413337Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5252024-09-27T17:13:53.791Z{"msg":"Set Active after no reconciliation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.414138079Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5262024-09-27T17:13:53.791Z{"msg":"The guest has finished waiting for activation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:53.414146506Z","hostname":"bmat-EVT22200007-0000448d","pid":1173}
5272024-09-27T17:13:58.039Z{"msg":"Request to deactivate this guest","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.662413242Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5282024-09-27T17:13:58.040Z{"msg":"checking for deactivation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.662461748Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5292024-09-27T17:13:58.040Z{"msg":"[0] deactivate, no work so YES","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.662470025Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"":"downstairs","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5302024-09-27T17:13:58.040Z{"msg":"ds_transition from Active to Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.662480556Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"0","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5312024-09-27T17:13:58.040Z{"msg":"[0] Transition from Active to Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.662489504Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"0","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5322024-09-27T17:13:58.040Z{"msg":"deactivated client 0","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.662500616Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5332024-09-27T17:13:58.040Z{"msg":"[1] deactivate, no work so YES","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.662508271Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"":"downstairs","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5342024-09-27T17:13:58.040Z{"msg":"ds_transition from Active to Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.662516187Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"1","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5352024-09-27T17:13:58.040Z{"msg":"[1] Transition from Active to Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.662524393Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"1","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5362024-09-27T17:13:58.040Z{"msg":"deactivated client 1","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.662532349Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5372024-09-27T17:13:58.040Z{"msg":"[2] deactivate, no work so YES","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.662539383Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"":"downstairs","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5382024-09-27T17:13:58.040Z{"msg":"ds_transition from Active to Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.662547169Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"2","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5392024-09-27T17:13:58.040Z{"msg":"[2] Transition from Active to Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.662559283Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"2","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5402024-09-27T17:13:58.040Z{"msg":"deactivated client 2","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.662567599Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5412024-09-27T17:13:58.040Z{"msg":"not ready to deactivate due to state Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.662574784Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"0","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5422024-09-27T17:13:58.040Z{"msg":"client task is sending Done(RequestedStop(Deactivated))","v":0,"name":"crucible","level":40,"time":"2024-09-27T17:13:57.662583251Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"":"io task","client":"2","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5432024-09-27T17:13:58.040Z{"msg":"downstairs task for 2 stopped due to RequestedStop(Deactivated)","v":0,"name":"crucible","level":40,"time":"2024-09-27T17:13:57.662593681Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5442024-09-27T17:13:58.040Z{"msg":"Gone missing, transition from Deactivated to Disconnected","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.662601106Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"2","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5452024-09-27T17:13:58.040Z{"msg":"Disconnected -> New","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.662610004Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"2","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5462024-09-27T17:13:58.040Z{"msg":"checking for deactivation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.662620044Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5472024-09-27T17:13:58.040Z{"msg":"not ready to deactivate due to state Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.662627128Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"0","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5482024-09-27T17:13:58.064Z{"msg":"client task is exiting","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.662635174Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"":"io task","client":"2","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5492024-09-27T17:13:58.064Z{"msg":"client task is sending Done(RequestedStop(Deactivated))","v":0,"name":"crucible","level":40,"time":"2024-09-27T17:13:57.662646707Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"":"io task","client":"1","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5502024-09-27T17:13:58.064Z{"msg":"downstairs task for 1 stopped due to RequestedStop(Deactivated)","v":0,"name":"crucible","level":40,"time":"2024-09-27T17:13:57.662656066Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5512024-09-27T17:13:58.064Z{"msg":"client task is sending Done(RequestedStop(Deactivated))","v":0,"name":"crucible","level":40,"time":"2024-09-27T17:13:57.66266311Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"":"io task","client":"0","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5522024-09-27T17:13:58.064Z{"msg":"Gone missing, transition from Deactivated to Disconnected","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.662671807Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"1","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5532024-09-27T17:13:58.065Z{"msg":"Disconnected -> New","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.662679603Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"1","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5542024-09-27T17:13:58.065Z{"msg":"checking for deactivation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.662687488Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5552024-09-27T17:13:58.065Z{"msg":"not ready to deactivate due to state Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.662694502Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"0","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5562024-09-27T17:13:58.065Z{"msg":"downstairs task for 0 stopped due to RequestedStop(Deactivated)","v":0,"name":"crucible","level":40,"time":"2024-09-27T17:13:57.66270349Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5572024-09-27T17:13:58.065Z{"msg":"Gone missing, transition from Deactivated to Disconnected","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.662710414Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"0","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5582024-09-27T17:13:58.065Z{"msg":"Disconnected -> New","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.662718069Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"0","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5592024-09-27T17:13:58.065Z{"msg":"checking for deactivation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.662725795Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5602024-09-27T17:13:58.065Z{"msg":"ready to deactivate from state New","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.662732618Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"0","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5612024-09-27T17:13:58.065Z{"msg":"ready to deactivate from state New","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.662740344Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"1","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5622024-09-27T17:13:58.065Z{"msg":"ready to deactivate from state New","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.662748099Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"client":"2","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5632024-09-27T17:13:58.065Z{"msg":"All DS in the proper state! -> INIT","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.662756386Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5642024-09-27T17:13:58.065Z{"msg":"client task is exiting","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.662763059Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"":"io task","client":"1","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5652024-09-27T17:13:58.065Z{"msg":"client task is exiting","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.662773309Z","hostname":"bmat-EVT22200007-0000448d","pid":1173,"":"io task","client":"0","":"downstairs","session_id":"99ff54c4-031c-42fc-ab5f-5da4f0481c76"}
5662024-09-27T17:13:58.065Z{"msg":"Guest handle has been dropped","v":0,"name":"crucible","level":40,"time":"2024-09-27T17:13:57.663022927Z","hostname":"bmat-EVT22200007-0000448d","pid":1173}
5672024-09-27T17:13:58.176Zraw options: Opt { target: [127.0.0.1:8810, 127.0.0.1:8820, 127.0.0.1:8830], key: None, gen: 4, cert_pem: None, key_pem: None, root_cert_pem: None, control: None, num_bytes: Some(4294967296), byte_offset: 0, iocmd_block_count: 4096, pipeline_length: 8, benchmarking_mode: Some("/tmp/crudd-benchmark-num-bytes-processed.txt"), subcommand: Read }
5682024-09-27T17:13:58.200Z{"msg":"Upstairs starts","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.82274441Z","hostname":"bmat-EVT22200007-0000448d","pid":1177}
5692024-09-27T17:13:58.200Z{"msg":"Crucible Version: BuildInfo {\n version: \"0.0.1\",\n git_sha: \"93b12f70ee7c1993c73ac4256d99ff80ccbe4bac\",\n git_commit_timestamp: \"2024-09-27T16:52:31.000000000Z\",\n git_branch: \"update-omicron-common\",\n rustc_semver: \"1.80.0\",\n rustc_channel: \"stable\",\n rustc_host_triple: \"x86_64-unknown-illumos\",\n rustc_commit_sha: \"051478957371ee0084a7c0913941d2a8c4757bb9\",\n cargo_triple: \"x86_64-unknown-illumos\",\n debug: false,\n opt_level: 3,\n}","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.823345819Z","hostname":"bmat-EVT22200007-0000448d","pid":1177}
5702024-09-27T17:13:58.200Z{"msg":"Upstairs <-> Downstairs Message Version: 11","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.823412802Z","hostname":"bmat-EVT22200007-0000448d","pid":1177}
5712024-09-27T17:13:58.200Z{"msg":"Crucible 00000000-0000-0000-0000-000000000000 has session id: 984ff189-dfe4-449d-adf5-d1654bcc984b","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.82366712Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
5722024-09-27T17:13:58.200Z{"msg":"Upstairs opts: Upstairs UUID: 00000000-0000-0000-0000-000000000000, Targets: [127.0.0.1:8810, 127.0.0.1:8820, 127.0.0.1:8830], lossy: false, flush_timeout: None, key populated: false, cert_pem populated: false, key_pem populated: false, root_cert_pem populated: false, Control: None, read_only: false","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.823750215Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
5732024-09-27T17:13:58.200Z{"msg":"Crucible stats registered with UUID: 00000000-0000-0000-0000-000000000000","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.823787029Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
5742024-09-27T17:13:58.227ZCrucible runtime is spawned
5752024-09-27T17:13:58.227Z{"msg":"The guest has requested activation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.872118993Z","hostname":"bmat-EVT22200007-0000448d","pid":1177}
5762024-09-27T17:13:58.255Z{"msg":"00000000-0000-0000-0000-000000000000 active request set","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.872286196Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
5772024-09-27T17:13:58.255Z{"msg":"sending connect oneshot to client","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.872311467Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"0","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
5782024-09-27T17:13:58.255Z{"msg":"client set_active_request while in New; waiting...","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.872339092Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"0","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
5792024-09-27T17:13:58.255Z{"msg":"sending connect oneshot to client","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.872347699Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"1","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
5802024-09-27T17:13:58.255Z{"msg":"client set_active_request while in New; waiting...","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.87235805Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"1","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
5812024-09-27T17:13:58.255Z{"msg":"sending connect oneshot to client","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.872367629Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"2","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
5822024-09-27T17:13:58.255Z{"msg":"client set_active_request while in New; waiting...","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.872375214Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"2","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
5832024-09-27T17:13:58.256Z{"msg":"connecting to 127.0.0.1:8830","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.872502097Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"io task","client":"2","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
5842024-09-27T17:13:58.256Z{"msg":"connecting to 127.0.0.1:8810","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.872539Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"io task","client":"0","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
5852024-09-27T17:13:58.256Z{"msg":"connecting to 127.0.0.1:8820","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.872612677Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"io task","client":"1","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
5862024-09-27T17:13:58.256Z{"msg":"ds_connection connected from Ok(127.0.0.1:37914)","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.872734961Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"io task","client":"2","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
5872024-09-27T17:13:58.256Z{"msg":"ds_connection connected from Ok(127.0.0.1:65458)","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.872825652Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"io task","client":"0","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
5882024-09-27T17:13:58.256Z{"msg":"ds_connection connected from Ok(127.0.0.1:34511)","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.873046973Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"io task","client":"1","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
5892024-09-27T17:13:58.256Z{"msg":"ds_transition from New to WaitActive","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.873184928Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"0","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
5902024-09-27T17:13:58.256Z{"msg":"[0] Transition from New to WaitActive","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.873213225Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"0","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
5912024-09-27T17:13:58.256Z{"msg":"ds_transition from New to WaitActive","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.873221521Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"2","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
5922024-09-27T17:13:58.256Z{"msg":"[2] Transition from New to WaitActive","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.873228876Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"2","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
5932024-09-27T17:13:58.256Z{"msg":"ds_transition from New to WaitActive","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.873347693Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"1","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
5942024-09-27T17:13:58.256Z{"msg":"[1] Transition from New to WaitActive","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.873422702Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"1","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
5952024-09-27T17:13:58.256Z{"msg":"downstairs client at Some(127.0.0.1:8830) has region UUID 12345678-0000-0000-0000-000000008830","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.873697991Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"2","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
5962024-09-27T17:13:58.256Z{"msg":"downstairs client at Some(127.0.0.1:8810) has region UUID 12345678-0000-0000-0000-000000008810","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.873880645Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"0","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
5972024-09-27T17:13:58.256Z{"msg":"downstairs client at Some(127.0.0.1:8820) has region UUID 12345678-0000-0000-0000-000000008820","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.873964733Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"1","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
5982024-09-27T17:13:58.256Z{"msg":"ds_transition from WaitActive to WaitQuorum","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.874261084Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"2","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
5992024-09-27T17:13:58.256Z{"msg":"[2] Transition from WaitActive to WaitQuorum","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.87427406Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"2","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6002024-09-27T17:13:58.256Z{"msg":"Waiting for more clients to be ready","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.874281204Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6012024-09-27T17:13:58.256Z{"msg":"ds_transition from WaitActive to WaitQuorum","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.874495892Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"0","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6022024-09-27T17:13:58.256Z{"msg":"[0] Transition from WaitActive to WaitQuorum","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.874519579Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"0","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6032024-09-27T17:13:58.256Z{"msg":"Waiting for more clients to be ready","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.874526293Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6042024-09-27T17:13:58.256Z{"msg":"ds_transition from WaitActive to WaitQuorum","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.874727504Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"1","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6052024-09-27T17:13:58.256Z{"msg":"[1] Transition from WaitActive to WaitQuorum","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.874779227Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"1","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6062024-09-27T17:13:58.256Z{"msg":"[0]R flush_numbers[0..12]: [11, 12, 12, 13, 13, 13, 13, 14, 14, 14, 14, 15]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.874788596Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"downstairs","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6072024-09-27T17:13:58.256Z{"msg":"[0]R generation[0..12]: [3, 3, 3, 3, 3, 3, 3, 3, 3, 3, 3, 3]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.874798014Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"downstairs","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6082024-09-27T17:13:58.256Z{"msg":"[0]R dirty[0..12]: [false, false, false, false, false, false, false, false, false, false, false, false]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.874806982Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"downstairs","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6092024-09-27T17:13:58.256Z{"msg":"[1]R flush_numbers[0..12]: [11, 12, 12, 13, 13, 13, 13, 14, 14, 14, 14, 15]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.874814106Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"downstairs","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6102024-09-27T17:13:58.256Z{"msg":"[1]R generation[0..12]: [3, 3, 3, 3, 3, 3, 3, 3, 3, 3, 3, 3]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.874820629Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"downstairs","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6112024-09-27T17:13:58.256Z{"msg":"[1]R dirty[0..12]: [false, false, false, false, false, false, false, false, false, false, false, false]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.874829297Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"downstairs","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6122024-09-27T17:13:58.256Z{"msg":"[2]R flush_numbers[0..12]: [11, 12, 12, 13, 13, 13, 13, 14, 14, 14, 14, 15]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.874955929Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"downstairs","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6132024-09-27T17:13:58.256Z{"msg":"[2]R generation[0..12]: [3, 3, 3, 3, 3, 3, 3, 3, 3, 3, 3, 3]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.87498163Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"downstairs","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6142024-09-27T17:13:58.256Z{"msg":"[2]R dirty[0..12]: [false, false, false, false, false, false, false, false, false, false, false, false]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.874989276Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"downstairs","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6152024-09-27T17:13:58.256Z{"msg":"Max found gen is 4","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.874996831Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"downstairs","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6162024-09-27T17:13:58.256Z{"msg":"Generation requested: 4 >= found:4","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.875005809Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"downstairs","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6172024-09-27T17:13:58.256Z{"msg":"Next flush: 20","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.875013113Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"downstairs","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6182024-09-27T17:13:58.256Z{"msg":"All extents match","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.875093403Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"downstairs","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6192024-09-27T17:13:58.256Z{"msg":"No downstairs reconciliation required","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.875117221Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6202024-09-27T17:13:58.256Z{"msg":"Transition from WaitQuorum to Active","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.875124916Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"0","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6212024-09-27T17:13:58.257Z{"msg":"Transition from WaitQuorum to Active","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.87513197Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"1","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6222024-09-27T17:13:58.257Z{"msg":"Transition from WaitQuorum to Active","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.875140577Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"2","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6232024-09-27T17:13:58.257Z{"msg":"All required reconciliation work is completed","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.875148213Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6242024-09-27T17:13:58.257Z{"msg":"Set Downstairs and Upstairs active after reconciliation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.875236268Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6252024-09-27T17:13:58.257Z{"msg":"00000000-0000-0000-0000-000000000000 is now active with session: 984ff189-dfe4-449d-adf5-d1654bcc984b","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.875258803Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6262024-09-27T17:13:58.257Z{"msg":"Set Active after no reconciliation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.875265416Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6272024-09-27T17:13:58.257Z{"msg":"The guest has finished waiting for activation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:13:57.875271488Z","hostname":"bmat-EVT22200007-0000448d","pid":1177}
6282024-09-27T17:14:04.607Z{"msg":"Request to deactivate this guest","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252152646Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6292024-09-27T17:14:04.697Z{"msg":"checking for deactivation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252306924Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6302024-09-27T17:14:04.697Z{"msg":"[0] cannot deactivate, job 5107 in state InProgress","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252392053Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"downstairs","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6312024-09-27T17:14:04.697Z{"msg":"not ready to deactivate client 0","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252406392Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6322024-09-27T17:14:04.697Z{"msg":"[1] cannot deactivate, job 5107 in state InProgress","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252418697Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"downstairs","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6332024-09-27T17:14:04.697Z{"msg":"not ready to deactivate client 1","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252429218Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6342024-09-27T17:14:04.697Z{"msg":"[2] cannot deactivate, job 5108 in state InProgress","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252439057Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"downstairs","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6352024-09-27T17:14:04.697Z{"msg":"not ready to deactivate client 2","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252449618Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6362024-09-27T17:14:04.697Z{"msg":"not ready to deactivate due to state Active","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252458927Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"0","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6372024-09-27T17:14:04.698Z{"msg":"checking for deactivation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252471281Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6382024-09-27T17:14:04.698Z{"msg":"[0] cannot deactivate, job 5108 in state InProgress","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252516802Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"downstairs","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6392024-09-27T17:14:04.698Z{"msg":"not ready to deactivate client 0","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252528445Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6402024-09-27T17:14:04.698Z{"msg":"[1] cannot deactivate, job 5107 in state InProgress","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252538666Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"downstairs","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6412024-09-27T17:14:04.698Z{"msg":"not ready to deactivate client 1","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252547974Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6422024-09-27T17:14:04.698Z{"msg":"[2] cannot deactivate, job 5108 in state InProgress","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252556491Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"downstairs","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6432024-09-27T17:14:04.698Z{"msg":"not ready to deactivate client 2","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252567724Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6442024-09-27T17:14:04.698Z{"msg":"not ready to deactivate due to state Active","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252576261Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"0","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6452024-09-27T17:14:04.698Z{"msg":"checking for deactivation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252586661Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6462024-09-27T17:14:04.698Z{"msg":"[0] cannot deactivate, job 5108 in state InProgress","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252595369Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"downstairs","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6472024-09-27T17:14:04.698Z{"msg":"not ready to deactivate client 0","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252607142Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6482024-09-27T17:14:04.698Z{"msg":"[1] cannot deactivate, job 5108 in state InProgress","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252653164Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"downstairs","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6492024-09-27T17:14:04.698Z{"msg":"not ready to deactivate client 1","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252664557Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6502024-09-27T17:14:04.698Z{"msg":"[2] cannot deactivate, job 5108 in state InProgress","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252673655Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"downstairs","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6512024-09-27T17:14:04.698Z{"msg":"not ready to deactivate client 2","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252683444Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6522024-09-27T17:14:04.698Z{"msg":"not ready to deactivate due to state Active","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252692322Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"0","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6532024-09-27T17:14:04.698Z{"msg":"checking for deactivation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252701841Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6542024-09-27T17:14:04.698Z{"msg":"[0] cannot deactivate, job 5108 in state InProgress","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252710829Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"downstairs","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6552024-09-27T17:14:04.698Z{"msg":"not ready to deactivate client 0","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252721039Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6562024-09-27T17:14:04.698Z{"msg":"[1] cannot deactivate, job 5108 in state InProgress","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252730168Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"downstairs","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6572024-09-27T17:14:04.698Z{"msg":"not ready to deactivate client 1","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252739757Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6582024-09-27T17:14:04.698Z{"msg":"[2] cannot deactivate, job 5108 in state InProgress","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252748274Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"downstairs","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6592024-09-27T17:14:04.698Z{"msg":"not ready to deactivate client 2","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252759065Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6602024-09-27T17:14:04.698Z{"msg":"not ready to deactivate due to state Active","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.25280176Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"0","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6612024-09-27T17:14:04.698Z{"msg":"checking for deactivation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252812031Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6622024-09-27T17:14:04.699Z{"msg":"[0] cannot deactivate, job 5108 in state InProgress","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252820838Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"downstairs","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6632024-09-27T17:14:04.699Z{"msg":"not ready to deactivate client 0","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252830257Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6642024-09-27T17:14:04.699Z{"msg":"[1] check deactivate YES","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252839305Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"downstairs","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6652024-09-27T17:14:04.699Z{"msg":"ds_transition from Active to Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252849536Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"1","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6662024-09-27T17:14:04.699Z{"msg":"[1] Transition from Active to Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252859065Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"1","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6672024-09-27T17:14:04.699Z{"msg":"deactivated client 1","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252901229Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6682024-09-27T17:14:04.699Z{"msg":"[2] cannot deactivate, job 5108 in state InProgress","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252910748Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"downstairs","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6692024-09-27T17:14:04.699Z{"msg":"not ready to deactivate client 2","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252920437Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6702024-09-27T17:14:04.699Z{"msg":"not ready to deactivate due to state Active","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252944094Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"0","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6712024-09-27T17:14:04.699Z{"msg":"checking for deactivation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252953312Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6722024-09-27T17:14:04.699Z{"msg":"[0] cannot deactivate, job 5108 in state InProgress","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252962461Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"downstairs","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6732024-09-27T17:14:04.699Z{"msg":"not ready to deactivate client 0","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252972651Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6742024-09-27T17:14:04.699Z{"msg":"[2] check deactivate YES","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.252981879Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"downstairs","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6752024-09-27T17:14:04.699Z{"msg":"ds_transition from Active to Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.253009094Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"2","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6762024-09-27T17:14:04.699Z{"msg":"[2] Transition from Active to Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.253019955Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"2","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6772024-09-27T17:14:04.699Z{"msg":"deactivated client 2","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.253030526Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6782024-09-27T17:14:04.699Z{"msg":"not ready to deactivate due to state Active","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.253055957Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"0","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6792024-09-27T17:14:04.699Z{"msg":"client task is sending Done(RequestedStop(Deactivated))","v":0,"name":"crucible","level":40,"time":"2024-09-27T17:14:04.253066218Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"io task","client":"2","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6802024-09-27T17:14:04.699Z{"msg":"downstairs task for 2 stopped due to RequestedStop(Deactivated)","v":0,"name":"crucible","level":40,"time":"2024-09-27T17:14:04.25307731Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6812024-09-27T17:14:04.699Z{"msg":"client task is sending Done(RequestedStop(Deactivated))","v":0,"name":"crucible","level":40,"time":"2024-09-27T17:14:04.253120015Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"io task","client":"1","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6822024-09-27T17:14:04.699Z{"msg":"Gone missing, transition from Deactivated to Disconnected","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.253131939Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"2","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6832024-09-27T17:14:04.699Z{"msg":"Disconnected -> New","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.253141678Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"2","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6842024-09-27T17:14:04.699Z{"msg":"checking for deactivation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.253151748Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6852024-09-27T17:14:04.699Z{"msg":"[0] cannot deactivate, job 5108 in state InProgress","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.253160045Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"downstairs","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6862024-09-27T17:14:04.699Z{"msg":"not ready to deactivate client 0","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.253169654Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6872024-09-27T17:14:04.700Z{"msg":"not ready to deactivate due to state Active","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.253178882Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"0","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6882024-09-27T17:14:04.700Z{"msg":"downstairs task for 1 stopped due to RequestedStop(Deactivated)","v":0,"name":"crucible","level":40,"time":"2024-09-27T17:14:04.253224734Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6892024-09-27T17:14:04.700Z{"msg":"Gone missing, transition from Deactivated to Disconnected","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.253234844Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"1","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6902024-09-27T17:14:04.700Z{"msg":"Disconnected -> New","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.253245234Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"1","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6912024-09-27T17:14:04.700Z{"msg":"checking for deactivation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.253255695Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6922024-09-27T17:14:04.700Z{"msg":"[0] cannot deactivate, job 5108 in state InProgress","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.253264894Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"downstairs","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6932024-09-27T17:14:04.700Z{"msg":"not ready to deactivate client 0","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.253274333Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6942024-09-27T17:14:04.700Z{"msg":"not ready to deactivate due to state Active","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.253283701Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"0","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6952024-09-27T17:14:04.700Z{"msg":"client task is exiting","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.253325705Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"io task","client":"1","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6962024-09-27T17:14:04.700Z{"msg":"client task is exiting","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.253337378Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"io task","client":"2","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6972024-09-27T17:14:04.700Z{"msg":"checking for deactivation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.254289887Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6982024-09-27T17:14:04.700Z{"msg":"[0] deactivate, no work so YES","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.254322653Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"downstairs","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
6992024-09-27T17:14:04.700Z{"msg":"ds_transition from Active to Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.254332001Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"0","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
7002024-09-27T17:14:04.700Z{"msg":"[0] Transition from Active to Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.254340017Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"0","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
7012024-09-27T17:14:04.700Z{"msg":"deactivated client 0","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.254347562Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
7022024-09-27T17:14:04.700Z{"msg":"not ready to deactivate due to state Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.254354536Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"0","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
7032024-09-27T17:14:04.700Z{"msg":"client task is sending Done(RequestedStop(Deactivated))","v":0,"name":"crucible","level":40,"time":"2024-09-27T17:14:04.254362121Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"io task","client":"0","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
7042024-09-27T17:14:04.700Z{"msg":"downstairs task for 0 stopped due to RequestedStop(Deactivated)","v":0,"name":"crucible","level":40,"time":"2024-09-27T17:14:04.254370047Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
7052024-09-27T17:14:04.700Z{"msg":"Gone missing, transition from Deactivated to Disconnected","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.25437641Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"0","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
7062024-09-27T17:14:04.700Z{"msg":"Disconnected -> New","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.254386921Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"0","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
7072024-09-27T17:14:04.700Z{"msg":"checking for deactivation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.254394446Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
7082024-09-27T17:14:04.700Z{"msg":"ready to deactivate from state New","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.25440156Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"0","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
7092024-09-27T17:14:04.700Z{"msg":"ready to deactivate from state New","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.254408564Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"1","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
7102024-09-27T17:14:04.700Z{"msg":"ready to deactivate from state New","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.254415838Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"client":"2","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
7112024-09-27T17:14:04.701Z{"msg":"All DS in the proper state! -> INIT","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.254424626Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
7122024-09-27T17:14:04.701Z{"msg":"client task is exiting","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.254432923Z","hostname":"bmat-EVT22200007-0000448d","pid":1177,"":"io task","client":"0","":"downstairs","session_id":"984ff189-dfe4-449d-adf5-d1654bcc984b"}
7132024-09-27T17:14:04.701Z{"msg":"Guest handle has been dropped","v":0,"name":"crucible","level":40,"time":"2024-09-27T17:14:04.254555898Z","hostname":"bmat-EVT22200007-0000448d","pid":1177}
7142024-09-27T17:14:04.726Zraw options: Opt { target: [127.0.0.1:8810, 127.0.0.1:8820, 127.0.0.1:8830], key: None, gen: 5, cert_pem: None, key_pem: None, root_cert_pem: None, control: None, num_bytes: Some(4294967296), byte_offset: 0, iocmd_block_count: 4096, pipeline_length: 8, benchmarking_mode: Some("/tmp/crudd-benchmark-num-bytes-processed.txt"), subcommand: Write }
7152024-09-27T17:14:04.726Z{"msg":"Upstairs starts","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.297647584Z","hostname":"bmat-EVT22200007-0000448d","pid":1183}
7162024-09-27T17:14:04.726Z{"msg":"Crucible Version: BuildInfo {\n version: \"0.0.1\",\n git_sha: \"93b12f70ee7c1993c73ac4256d99ff80ccbe4bac\",\n git_commit_timestamp: \"2024-09-27T16:52:31.000000000Z\",\n git_branch: \"update-omicron-common\",\n rustc_semver: \"1.80.0\",\n rustc_channel: \"stable\",\n rustc_host_triple: \"x86_64-unknown-illumos\",\n rustc_commit_sha: \"051478957371ee0084a7c0913941d2a8c4757bb9\",\n cargo_triple: \"x86_64-unknown-illumos\",\n debug: false,\n opt_level: 3,\n}","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.298083022Z","hostname":"bmat-EVT22200007-0000448d","pid":1183}
7172024-09-27T17:14:04.726Z{"msg":"Upstairs <-> Downstairs Message Version: 11","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.29812233Z","hostname":"bmat-EVT22200007-0000448d","pid":1183}
7182024-09-27T17:14:04.726Z{"msg":"Crucible 00000000-0000-0000-0000-000000000000 has session id: 5d755798-3a4c-46f4-962e-a105369b6cc5","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.298302059Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7192024-09-27T17:14:04.726Z{"msg":"Upstairs opts: Upstairs UUID: 00000000-0000-0000-0000-000000000000, Targets: [127.0.0.1:8810, 127.0.0.1:8820, 127.0.0.1:8830], lossy: false, flush_timeout: None, key populated: false, cert_pem populated: false, key_pem populated: false, root_cert_pem populated: false, Control: None, read_only: false","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.29837781Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7202024-09-27T17:14:04.726Z{"msg":"Crucible stats registered with UUID: 00000000-0000-0000-0000-000000000000","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.29838789Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7212024-09-27T17:14:04.726ZCrucible runtime is spawned
7222024-09-27T17:14:04.726Z{"msg":"The guest has requested activation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.348468641Z","hostname":"bmat-EVT22200007-0000448d","pid":1183}
7232024-09-27T17:14:04.726Z{"msg":"00000000-0000-0000-0000-000000000000 active request set","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.348646015Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7242024-09-27T17:14:04.726Z{"msg":"sending connect oneshot to client","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.348669702Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"0","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7252024-09-27T17:14:04.726Z{"msg":"client set_active_request while in New; waiting...","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.348691816Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"0","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7262024-09-27T17:14:04.726Z{"msg":"sending connect oneshot to client","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.348700764Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"1","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7272024-09-27T17:14:04.726Z{"msg":"client set_active_request while in New; waiting...","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.348716736Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"1","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7282024-09-27T17:14:04.726Z{"msg":"sending connect oneshot to client","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.348738509Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"2","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7292024-09-27T17:14:04.726Z{"msg":"client set_active_request while in New; waiting...","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.348746154Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"2","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7302024-09-27T17:14:04.726Z{"msg":"connecting to 127.0.0.1:8830","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.348891684Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"":"io task","client":"2","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7312024-09-27T17:14:04.726Z{"msg":"connecting to 127.0.0.1:8810","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.348915111Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"":"io task","client":"0","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7322024-09-27T17:14:04.726Z{"msg":"connecting to 127.0.0.1:8820","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.348923428Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"":"io task","client":"1","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7332024-09-27T17:14:04.726Z{"msg":"ds_connection connected from Ok(127.0.0.1:49113)","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.349093407Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"":"io task","client":"1","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7342024-09-27T17:14:04.726Z{"msg":"ds_connection connected from Ok(127.0.0.1:51081)","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.349115992Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"":"io task","client":"2","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7352024-09-27T17:14:04.726Z{"msg":"ds_connection connected from Ok(127.0.0.1:60248)","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.34912494Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"":"io task","client":"0","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7362024-09-27T17:14:04.726Z{"msg":"ds_transition from New to WaitActive","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.34957658Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"1","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7372024-09-27T17:14:04.726Z{"msg":"[1] Transition from New to WaitActive","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.349614616Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"1","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7382024-09-27T17:14:04.726Z{"msg":"ds_transition from New to WaitActive","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.349626109Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"0","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7392024-09-27T17:14:04.726Z{"msg":"[0] Transition from New to WaitActive","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.349634485Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"0","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7402024-09-27T17:14:04.727Z{"msg":"ds_transition from New to WaitActive","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.349725457Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"2","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7412024-09-27T17:14:04.727Z{"msg":"[2] Transition from New to WaitActive","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.349745457Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"2","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7422024-09-27T17:14:04.727Z{"msg":"downstairs client at Some(127.0.0.1:8830) has region UUID 12345678-0000-0000-0000-000000008830","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.350106577Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"2","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7432024-09-27T17:14:04.727Z{"msg":"downstairs client at Some(127.0.0.1:8820) has region UUID 12345678-0000-0000-0000-000000008820","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.35012327Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"1","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7442024-09-27T17:14:04.727Z{"msg":"downstairs client at Some(127.0.0.1:8810) has region UUID 12345678-0000-0000-0000-000000008810","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.350305273Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"0","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7452024-09-27T17:14:04.727Z{"msg":"ds_transition from WaitActive to WaitQuorum","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.351896596Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"1","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7462024-09-27T17:14:04.727Z{"msg":"[1] Transition from WaitActive to WaitQuorum","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.351954551Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"1","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7472024-09-27T17:14:04.727Z{"msg":"Waiting for more clients to be ready","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.351963329Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7482024-09-27T17:14:04.727Z{"msg":"ds_transition from WaitActive to WaitQuorum","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.351969721Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"2","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7492024-09-27T17:14:04.727Z{"msg":"[2] Transition from WaitActive to WaitQuorum","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.351976655Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"2","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7502024-09-27T17:14:04.727Z{"msg":"Waiting for more clients to be ready","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.351983689Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7512024-09-27T17:14:04.727Z{"msg":"ds_transition from WaitActive to WaitQuorum","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.351989902Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"0","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7522024-09-27T17:14:04.727Z{"msg":"[0] Transition from WaitActive to WaitQuorum","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.351997597Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"0","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7532024-09-27T17:14:04.727Z{"msg":"[0]R flush_numbers[0..12]: [11, 12, 12, 13, 13, 13, 13, 14, 14, 14, 14, 15]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.352005182Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"":"downstairs","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7542024-09-27T17:14:04.727Z{"msg":"[0]R generation[0..12]: [3, 3, 3, 3, 3, 3, 3, 3, 3, 3, 3, 3]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.352024811Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"":"downstairs","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7552024-09-27T17:14:04.727Z{"msg":"[0]R dirty[0..12]: [false, false, false, false, false, false, false, false, false, false, false, false]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.352032226Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"":"downstairs","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7562024-09-27T17:14:04.727Z{"msg":"[1]R flush_numbers[0..12]: [11, 12, 12, 13, 13, 13, 13, 14, 14, 14, 14, 15]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.35203913Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"":"downstairs","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7572024-09-27T17:14:04.727Z{"msg":"[1]R generation[0..12]: [3, 3, 3, 3, 3, 3, 3, 3, 3, 3, 3, 3]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.352045843Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"":"downstairs","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7582024-09-27T17:14:04.727Z{"msg":"[1]R dirty[0..12]: [false, false, false, false, false, false, false, false, false, false, false, false]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.352053148Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"":"downstairs","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7592024-09-27T17:14:04.727Z{"msg":"[2]R flush_numbers[0..12]: [11, 12, 12, 13, 13, 13, 13, 14, 14, 14, 14, 15]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.352059661Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"":"downstairs","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7602024-09-27T17:14:04.727Z{"msg":"[2]R generation[0..12]: [3, 3, 3, 3, 3, 3, 3, 3, 3, 3, 3, 3]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.352078468Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"":"downstairs","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7612024-09-27T17:14:04.727Z{"msg":"[2]R dirty[0..12]: [false, false, false, false, false, false, false, false, false, false, false, false]","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.352085152Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"":"downstairs","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7622024-09-27T17:14:04.727Z{"msg":"Max found gen is 4","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.352091354Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"":"downstairs","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7632024-09-27T17:14:04.727Z{"msg":"Generation requested: 5 >= found:4","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.352097917Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"":"downstairs","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7642024-09-27T17:14:04.727Z{"msg":"Next flush: 20","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.3521043Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"":"downstairs","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7652024-09-27T17:14:04.727Z{"msg":"All extents match","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.352110933Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"":"downstairs","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7662024-09-27T17:14:04.727Z{"msg":"No downstairs reconciliation required","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.352117216Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7672024-09-27T17:14:04.727Z{"msg":"Transition from WaitQuorum to Active","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.352122827Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"0","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7682024-09-27T17:14:04.727Z{"msg":"Transition from WaitQuorum to Active","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.352129209Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"1","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7692024-09-27T17:14:04.727Z{"msg":"Transition from WaitQuorum to Active","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.352135272Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"2","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7702024-09-27T17:14:04.727Z{"msg":"All required reconciliation work is completed","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.352141684Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7712024-09-27T17:14:04.727Z{"msg":"Set Downstairs and Upstairs active after reconciliation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.352147245Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7722024-09-27T17:14:04.727Z{"msg":"00000000-0000-0000-0000-000000000000 is now active with session: 5d755798-3a4c-46f4-962e-a105369b6cc5","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.352153578Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7732024-09-27T17:14:04.727Z{"msg":"Set Active after no reconciliation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.352159289Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7742024-09-27T17:14:04.727Z{"msg":"The guest has finished waiting for activation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:04.352175642Z","hostname":"bmat-EVT22200007-0000448d","pid":1183}
7752024-09-27T17:14:09.061Z{"msg":"Request to deactivate this guest","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:08.706743811Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7762024-09-27T17:14:09.061Z{"msg":"checking for deactivation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:08.706800424Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7772024-09-27T17:14:09.061Z{"msg":"[0] deactivate, no work so YES","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:08.706812648Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"":"downstairs","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7782024-09-27T17:14:09.062Z{"msg":"ds_transition from Active to Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:08.706825985Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"0","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7792024-09-27T17:14:09.062Z{"msg":"[0] Transition from Active to Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:08.7068387Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"0","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7802024-09-27T17:14:09.062Z{"msg":"deactivated client 0","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:08.706849942Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7812024-09-27T17:14:09.062Z{"msg":"[1] deactivate, no work so YES","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:08.706859972Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"":"downstairs","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7822024-09-27T17:14:09.108Z{"msg":"ds_transition from Active to Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:08.706874191Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"1","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7832024-09-27T17:14:09.108Z{"msg":"[1] Transition from Active to Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:08.706888289Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"1","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7842024-09-27T17:14:09.108Z{"msg":"deactivated client 1","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:08.706899321Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7852024-09-27T17:14:09.108Z{"msg":"[2] deactivate, no work so YES","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:08.70690896Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"":"downstairs","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7862024-09-27T17:14:09.108Z{"msg":"ds_transition from Active to Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:08.706920062Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"2","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7872024-09-27T17:14:09.108Z{"msg":"[2] Transition from Active to Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:08.706931054Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"2","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7882024-09-27T17:14:09.108Z{"msg":"deactivated client 2","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:08.706941856Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7892024-09-27T17:14:09.108Z{"msg":"not ready to deactivate due to state Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:08.706952236Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"0","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7902024-09-27T17:14:09.108Z{"msg":"client task is sending Done(RequestedStop(Deactivated))","v":0,"name":"crucible","level":40,"time":"2024-09-27T17:14:08.706964681Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"":"io task","client":"2","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7912024-09-27T17:14:09.108Z{"msg":"downstairs task for 2 stopped due to RequestedStop(Deactivated)","v":0,"name":"crucible","level":40,"time":"2024-09-27T17:14:08.706977156Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7922024-09-27T17:14:09.108Z{"msg":"Gone missing, transition from Deactivated to Disconnected","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:08.706986735Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"2","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7932024-09-27T17:14:09.108Z{"msg":"Disconnected -> New","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:08.706998038Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"2","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7942024-09-27T17:14:09.108Z{"msg":"client task is sending Done(RequestedStop(Deactivated))","v":0,"name":"crucible","level":40,"time":"2024-09-27T17:14:08.707009581Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"":"io task","client":"1","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7952024-09-27T17:14:09.108Z{"msg":"client task is sending Done(RequestedStop(Deactivated))","v":0,"name":"crucible","level":40,"time":"2024-09-27T17:14:08.707022416Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"":"io task","client":"0","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7962024-09-27T17:14:09.108Z{"msg":"checking for deactivation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:08.707038288Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7972024-09-27T17:14:09.108Z{"msg":"client task is exiting","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:08.707048338Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"":"io task","client":"2","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7982024-09-27T17:14:09.108Z{"msg":"not ready to deactivate due to state Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:08.707061224Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"0","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
7992024-09-27T17:14:09.108Z{"msg":"downstairs task for 0 stopped due to RequestedStop(Deactivated)","v":0,"name":"crucible","level":40,"time":"2024-09-27T17:14:08.70707471Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
8002024-09-27T17:14:09.108Z{"msg":"Gone missing, transition from Deactivated to Disconnected","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:08.707085041Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"0","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
8012024-09-27T17:14:09.108Z{"msg":"Disconnected -> New","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:08.707096694Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"0","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
8022024-09-27T17:14:09.109Z{"msg":"checking for deactivation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:08.707110091Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
8032024-09-27T17:14:09.109Z{"msg":"ready to deactivate from state New","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:08.707120051Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"0","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
8042024-09-27T17:14:09.109Z{"msg":"not ready to deactivate due to state Deactivated","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:08.707131053Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"1","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
8052024-09-27T17:14:09.109Z{"msg":"downstairs task for 1 stopped due to RequestedStop(Deactivated)","v":0,"name":"crucible","level":40,"time":"2024-09-27T17:14:08.707142145Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
8062024-09-27T17:14:09.109Z{"msg":"Gone missing, transition from Deactivated to Disconnected","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:08.707153798Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"1","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
8072024-09-27T17:14:09.109Z{"msg":"Disconnected -> New","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:08.707165842Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"1","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
8082024-09-27T17:14:09.109Z{"msg":"checking for deactivation","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:08.707177014Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
8092024-09-27T17:14:09.109Z{"msg":"ready to deactivate from state New","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:08.707186894Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"0","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
8102024-09-27T17:14:09.109Z{"msg":"ready to deactivate from state New","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:08.707197946Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"1","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
8112024-09-27T17:14:09.109Z{"msg":"ready to deactivate from state New","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:08.707209048Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"client":"2","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
8122024-09-27T17:14:09.109Z{"msg":"All DS in the proper state! -> INIT","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:08.707220742Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
8132024-09-27T17:14:09.109Z{"msg":"client task is exiting","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:08.707232395Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"":"io task","client":"0","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
8142024-09-27T17:14:09.109Z{"msg":"downstairs disconnected","v":0,"name":"crucible","level":40,"time":"2024-09-27T17:14:08.707244439Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"":"io task","client":"1","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
8152024-09-27T17:14:09.109Z{"msg":"client task is exiting","v":0,"name":"crucible","level":30,"time":"2024-09-27T17:14:08.707258517Z","hostname":"bmat-EVT22200007-0000448d","pid":1183,"":"io task","client":"1","":"downstairs","session_id":"5d755798-3a4c-46f4-962e-a105369b6cc5"}
8162024-09-27T17:14:09.193ZShutdown 1155
8172024-09-27T17:14:09.255ZSep 27 17:14:08.900 INFO accepted connection, remote_addr: 127.0.0.1:34210, local_addr: 127.0.0.1:9998
8182024-09-27T17:14:09.279ZMain task has work to do, go find it
8192024-09-27T17:14:09.279Zgot dsc Shutdown
8202024-09-27T17:14:09.279ZShutdown
8212024-09-27T17:14:09.279ZShut it down
8222024-09-27T17:14:09.279ZSep 27 17:14:08.902 INFO request completed, latency_us: 641, response_code: 204, uri: /shutdown, method: POST, [8810] Disable keep_running
8232024-09-27T17:14:09.279Z[8810] Got stop action so:false kr:false
8242024-09-27T17:14:09.279Zreq_id: 96593cf8-cf67-4598-8450-be46e88db181, remote_addr: 127.0.[8820] Disable keep_running
8252024-09-27T17:14:09.279Z0.1:34210[8830] Disable keep_running
8262024-09-27T17:14:09.279Z[8820] Got stop action so:false kr:false
8272024-09-27T17:14:09.279Z[8830] Got stop action so:false kr:false
8282024-09-27T17:14:09.279Z, local_addr: 127.0.0.1:9998
8292024-09-27T17:14:09.279ZWait on pid 1155
8302024-09-27T17:14:09.314Z[8820] Exited with: ExitStatus(unix_wait_status(9))
8312024-09-27T17:14:09.314Z[8820][1] reports Exit
8322024-09-27T17:14:09.340Z[8810] Exited with: ExitStatus(unix_wait_status(9))
8332024-09-27T17:14:09.340Z[8810][0] reports Exit
8342024-09-27T17:14:09.340Z[8830] Exited with: ExitStatus(unix_wait_status(9))
8352024-09-27T17:14:09.340Z[8830][2] reports Exit
8362024-09-27T17:14:10.263Z1155 dead
8372024-09-27T17:14:10.288Z{ "request_size": 4096, "pipeline_length": 8, "read_speed_uninit": 613566756, "write_speed_uninit": 858993459, "read_speed_init": 613566756, "write_speed_init": 1073741824 }
8382024-09-27T17:14:10.288Z
8392024-09-27T17:14:10.288Zreal 32.046462242
8402024-09-27T17:14:10.288Zuser 55.338976809
8412024-09-27T17:14:10.288Zsys 1:31.524156043
8422024-09-27T17:14:10.288Ztrap 0.507846802
8432024-09-27T17:14:10.288Ztflt 0.002531687
8442024-09-27T17:14:10.288Zdflt 0.029046765
8452024-09-27T17:14:10.288Zkflt 0.002978372
8462024-09-27T17:14:10.288Zlock 54:33.198344993
8472024-09-27T17:14:10.288Zslp 5:02.886651809
8482024-09-27T17:14:10.288Zlat 1:06.311838503
8492024-09-27T17:14:10.288Zstop 0.073381884
8502024-09-27T17:14:15.277Zprocess exited: duration 33800 ms, exit code 0
8512024-09-27T17:14:15.277Zexec warning: : stdio descriptors remain open after task exit; waiting 60 seconds for them to close
8522024-09-27T17:15:15.324Zexec warning: : stdout descriptor may be held open by a background process; giving up!
8532024-09-27T17:15:15.324Zexec warning: : stderr descriptor may be held open by a background process; giving up!
 
8542024-09-27T17:15:15.402Zfound 11 output files
8552024-09-27T17:15:15.402Zuploading: /tmp/crudd-speed-battery-results.json (174 bytes)
8562024-09-27T17:15:16.499Zuploaded: /tmp/crudd-speed-battery-results.json
8572024-09-27T17:15:16.523Zuploading: /tmp/debug/df.txt (1270 bytes)
8582024-09-27T17:15:17.598Zuploaded: /tmp/debug/df.txt
8592024-09-27T17:15:17.598Zuploading: /tmp/debug/dtrace.txt (23151 bytes)
8602024-09-27T17:15:18.764Zuploaded: /tmp/debug/dtrace.txt
8612024-09-27T17:15:18.764Zuploading: /tmp/debug/iostat.txt (36308 bytes)
8622024-09-27T17:15:18.879Zupload warning: file "/tmp/debug/iostat.txt" changed size mid upload: 36308 -> 37418
8632024-09-27T17:15:19.953Zuploaded: /tmp/debug/iostat.txt
8642024-09-27T17:15:19.977Zuploading: /tmp/debug/mpstat.txt (71819 bytes)
8652024-09-27T17:15:20.090Zupload warning: file "/tmp/debug/mpstat.txt" changed size mid upload: 71819 -> 74743
8662024-09-27T17:15:21.159Zuploaded: /tmp/debug/mpstat.txt
8672024-09-27T17:15:21.159Zuploading: /tmp/debug/paging.txt (13046 bytes)
8682024-09-27T17:15:21.273Zupload warning: file "/tmp/debug/paging.txt" changed size mid upload: 13046 -> 13906
8692024-09-27T17:15:22.344Zuploaded: /tmp/debug/paging.txt
8702024-09-27T17:15:22.344Zuploading: /tmp/debug/prstat.txt (136562 bytes)
8712024-09-27T17:15:22.505Zupload warning: file "/tmp/debug/prstat.txt" changed size mid upload: 136562 -> 145709
8722024-09-27T17:15:23.576Zuploaded: /tmp/debug/prstat.txt
8732024-09-27T17:15:23.576Zuploading: /tmp/debug/psrinfo.txt (1528 bytes)
8742024-09-27T17:15:24.671Zuploaded: /tmp/debug/psrinfo.txt
8752024-09-27T17:15:24.671Zuploading: /tmp/dsc/downstairs-8810.txt (15294 bytes)
8762024-09-27T17:15:25.815Zuploaded: /tmp/dsc/downstairs-8810.txt
8772024-09-27T17:15:25.815Zuploading: /tmp/dsc/downstairs-8820.txt (15288 bytes)
8782024-09-27T17:15:26.953Zuploaded: /tmp/dsc/downstairs-8820.txt
8792024-09-27T17:15:26.953Zuploading: /tmp/dsc/downstairs-8830.txt (15294 bytes)
8802024-09-27T17:15:28.090Zuploaded: /tmp/dsc/downstairs-8830.txt