ScylladDB open source NoSQL DB compatible with Apache Cassandra. Tested with three workloads. Number of runnable processes is frequently more than the number of logical cores.
Topdown profile shows frontend stalls as dominating.
AMD metrics show little floating point, with some L2 usage. Frontend stalls are latency based.
elapsed 1694.100
on_cpu 0.706 # 11.30 / 16 cores
utime 12676.156
stime 6465.991
nvcsw 212212284 # 62.33%
nivcsw 128271257 # 37.67%
inblock 182352 # 107.64/sec
onblock 150337912 # 88742.03/sec
cpu-clock 18273317721074 # 18273.318 seconds
task-clock 18378211893345 # 18378.212 seconds
page faults 3583900 # 195.008/sec
context switches 340491438 # 18526.908/sec
cpu migrations 50288807 # 2736.328/sec
major page faults 540 # 0.029/sec
minor page faults 3576715 # 194.617/sec
alignment faults 0 # 0.000/sec
emulation faults 0 # 0.000/sec
branches 11636616280657 # 163.317 branches per 1000 inst
branch misses 319551371486 # 2.75% branch miss
conditional 6530320883898 # 91.652 conditional branches per 1000 inst
indirect 523984592743 # 7.354 indirect branches per 1000 inst
cpu-cycles 68408839496957 # 2.55 GHz
instructions 72114167774101 # 1.05 IPC
slots 135005657739174 #
retiring 26237637782058 # 19.4% (23.0%)
-- ucode 129781603162 # 0.1%
-- fastpath 26107856178896 # 19.3%
frontend 57564151706986 # 42.6% (50.6%) high
-- latency 50067380633946 # 37.1%
-- bandwidth 7496771073040 # 5.6%
backend 28684605264128 # 21.2% (25.2%)
-- cpu 2703316341728 # 2.0%
-- memory 25981288922400 # 19.2%
speculation 1300722224732 # 1.0% ( 1.1%)
-- branch mispredict 1260147294137 # 0.9%
-- pipeline restart 40574930595 # 0.0%
smt-contention 21172383372113 # 15.7% ( 0.0%)
cpu-cycles 70437568065065 # 2.57 GHz
instructions 74202073628189 # 1.05 IPC
instructions 24420521971707 # 91.403 l2 access per 1000 inst
l2 hit from l1 1540095135733 # 37.21% l2 miss
l2 miss from l1 450108085134 #
l2 hit from l2 pf 311577423106 #
l3 hit from l2 pf 370326054750 #
l3 miss from l2 pf 10105241469 #
instructions 24405105520058 # 9.005 float per 1000 inst
float 512 150 # 0.000 AVX-512 per 1000 inst
float 256 1660 # 0.000 AVX-256 per 1000 inst
float 128 219778225999 # 9.005 AVX-128 per 1000 inst
float MMX 0 # 0.000 MMX per 1000 inst
float scalar 4907 # 0.000 scalar per 1000 inst
instructions 72112578261538 #
opcache 13754611532886 # 190.738 opcache per 1000 inst
opcache miss 3606490621743 # 26.2% opcache miss rate
l1 dTLB miss 165260023029 # 2.292 L1 dTLB per 1000 inst
l2 dTLB miss 45599207352 # 0.632 L2 dTLB per 1000 inst
instructions 74160692511870 #
icache 6490741776395 # 87.523 icache per 1000 inst
icache miss 2195763203080 # 33.8% icache miss rate
l1 iTLB miss 71751779126 # 0.968 L1 iTLB per 1000 inst
l2 iTLB miss 0 # 0.000 L2 iTLB per 1000 inst
tlb flush 853851 # 0.000 TLB flush per 1000 instIntel metrics
elapsed 2007.141
on_cpu 0.754 # 12.06 / 16 cores
utime 18239.201
stime 5969.687
nvcsw 237491138 # 65.11%
nivcsw 127280059 # 34.89%
inblock 24180568 # 12047.27/sec
onblock 172900464 # 86142.66/sec
cpu-clock 23542596123952 # 23542.596 seconds
task-clock 23623187999792 # 23623.188 seconds
page faults 3482620 # 147.424/sec
context switches 364780670 # 15441.636/sec
cpu migrations 72270905 # 3059.321/sec
major page faults 2178 # 0.092/sec
minor page faults 3469450 # 146.866/sec
alignment faults 0 # 0.000/sec
emulation faults 0 # 0.000/sec
branches 14317293488627 # 160.573 branches per 1000 inst
branch misses 73859936712 # 0.52% branch miss
conditional 14317293594579 # 160.573 conditional branches per 1000 inst
indirect 3822925888376 # 42.875 indirect branches per 1000 inst
slots 116896604298938 #
retiring 31377352560659 # 26.8% (26.8%)
-- ucode 5281214510679 # 4.5%
-- fastpath 26096138049980 # 22.3%
frontend 34563899421102 # 29.6% (29.6%)
-- latency 19582310389903 # 16.8%
-- bandwidth 14981589031199 # 12.8%
backend 41154609101187 # 35.2% (35.2%)
-- cpu 17188075502098 # 14.7%
-- memory 23966533599089 # 20.5%
speculation 8352463961496 # 7.1% ( 7.1%)
-- branch mispredict 6989686313816 # 6.0%
-- pipeline restart 1362777647680 # 1.2%
smt-contention 0 # 0.0% ( 0.0%)
cpu-cycles 57186380640876 # 1.63 GHz
instructions 82885849354422 # 1.45 IPC
l2 access 3327703911676 # 57.071 l2 access per 1000 inst
l2 miss 692348158023 # 20.81% l2 miss
cpu-cycles 38656418202945 # 26.4% memory latency
load stalls 9404889202907 # 0.8% l1 bound
l1 miss 9091340864219 # 15.6% l2 bound
l2 miss 3045483126586 # 6.9% l3 bound
l3 miss 371844966072 # 1.0% dram bound
store_stalls 802883916659 # 2.1% store bound
Process overview
3396 processes
480 cluster1-nio-wo 97942.39 97812.78
9 reactor-1 10361.46 2457.35
9 reactor-10 10361.46 2457.35
9 reactor-11 10361.46 2457.35
9 reactor-12 10361.46 2457.35
9 reactor-13 10361.46 2457.35
9 reactor-14 10361.46 2457.35
9 reactor-15 10361.46 2457.35
9 reactor-2 10361.46 2457.35
9 reactor-3 10361.46 2457.35
9 reactor-4 10361.46 2457.35
9 reactor-5 10361.46 2457.35
9 reactor-6 10361.46 2457.35
9 reactor-7 10361.46 2457.35
9 reactor-8 10361.46 2457.35
9 reactor-9 10361.46 2457.35
9 scylla 10361.46 2457.35
9 syscall-0 10361.46 2457.35
9 syscall-1 10361.46 2457.35
9 syscall-10 10361.46 2457.35
9 syscall-11 10361.46 2457.35
9 syscall-12 10361.46 2457.35
9 syscall-13 10361.46 2457.35
9 syscall-14 10361.46 2457.35
9 syscall-15 10361.46 2457.35
9 syscall-2 10361.46 2457.35
9 syscall-3 10361.46 2457.35
9 syscall-4 10361.46 2457.35
9 syscall-5 10361.46 2457.35
9 syscall-6 10361.46 2457.35
9 syscall-7 10361.46 2457.35
9 syscall-8 10361.46 2457.35
9 syscall-9 10361.46 2457.35
33 globalEventExec 6736.66 6723.54
62 java 6122.36 6113.90
75 cluster1-worker 5624.21 5170.37
36 StressMetrics 3315.12 3109.88
31 Finalizer 3061.18 3056.95
15 Common-Cleaner 3060.77 3056.72
15 ObjectCleanerTh 3060.77 3056.72
15 Logging-Cleaner 3060.76 3056.70
15 Thread-0 3060.76 3056.68
15 Shutdown-checke 3060.74 3056.67
15 cluster1-connec 3060.74 3056.67
15 cluster1-timeou 3060.74 3056.67
15 cluster1-schedu 3058.97 3056.34
15 Thread-20 1576.59 1517.87
15 Thread-21 1576.59 1517.87
15 Thread-23 1576.59 1517.87
15 Thread-24 1576.59 1517.87
15 Thread-25 1576.59 1517.87
15 Thread-26 1576.59 1517.87
15 Thread-27 1576.59 1517.87
15 Thread-28 1576.59 1517.87
15 Thread-30 1576.59 1517.87
15 Thread-22 1576.58 1517.87
15 Thread-29 1576.58 1517.87
15 Thread-31 1576.58 1517.87
15 Thread-32 1576.58 1517.87
15 Thread-33 1576.58 1517.87
15 Thread-34 1576.57 1517.87
15 Thread-35 1576.56 1517.87
6 Thread-37 1569.14 1560.13
6 Thread-38 1569.14 1560.13
6 Thread-39 1569.14 1560.13
6 Thread-40 1569.14 1560.13
6 Thread-41 1569.14 1560.13
6 Thread-42 1569.14 1560.13
6 Thread-43 1569.14 1560.13
6 Thread-44 1569.14 1560.13
6 Thread-45 1569.14 1560.13
6 Thread-46 1569.14 1560.13
6 Thread-47 1569.14 1560.13
6 Thread-48 1569.14 1560.13
6 Thread-50 1569.14 1560.13
6 Thread-51 1569.14 1560.13
6 Thread-52 1569.14 1560.13
6 Thread-49 1569.14 1560.12
15 Thread-6 168.99 31.82
15 Thread-3 168.99 31.81
15 Thread-4 168.99 31.81
15 Thread-5 168.99 31.81
15 Thread-12 168.98 31.82
15 Thread-10 168.98 31.81
15 Thread-13 168.98 31.81
15 Thread-14 168.98 31.81
15 Thread-18 168.98 31.81
15 Thread-7 168.98 31.81
15 Thread-8 168.98 31.81
15 Thread-9 168.98 31.81
15 Thread-15 168.98 31.80
15 Thread-16 168.98 31.80
15 Thread-17 168.98 31.80
15 Thread-11 168.97 31.81
68 clinfo 20.18 5.99
38 vulkaninfo 1.33 1.71
6 glxinfo:gdrv0 0.16 0.06
6 glxinfo:gl0 0.16 0.06
4 vulkani:disk$0 0.14 0.18
6 php 0.08 0.34
2 glxinfo 0.08 0.02
2 glxinfo:cs0 0.08 0.02
2 glxinfo:disk$0 0.08 0.02
2 glxinfo:sh0 0.08 0.02
2 glxinfo:shlo0 0.08 0.02
2 llvmpipe-0 0.07 0.09
2 llvmpipe-1 0.07 0.09
2 llvmpipe-10 0.07 0.09
2 llvmpipe-11 0.07 0.09
2 llvmpipe-12 0.07 0.09
2 llvmpipe-13 0.07 0.09
2 llvmpipe-14 0.07 0.09
2 llvmpipe-15 0.07 0.09
2 llvmpipe-2 0.07 0.09
2 llvmpipe-3 0.07 0.09
2 llvmpipe-4 0.07 0.09
2 llvmpipe-5 0.07 0.09
2 llvmpipe-6 0.07 0.09
2 llvmpipe-7 0.07 0.09
2 llvmpipe-8 0.07 0.09
2 llvmpipe-9 0.07 0.09
6 clang 0.07 0.05
3 rocminfo 0.03 0.00
269 C2 CompilerThre 0.00 14607.40
131 C1 CompilerThre 0.00 3985.10
31 G1 Conc#0 0.00 3061.18
31 GC Thread#0 0.00 3061.18
31 Reference Handl 0.00 3061.18
31 Service Thread 0.00 3061.18
31 Signal Dispatch 0.00 3061.18
31 Sweeper thread 0.00 3061.18
31 VM Thread 0.00 3061.18
31 G1 Refine#0 0.00 3061.17
15 G1 Conc#1 0.00 3060.77
15 G1 Conc#2 0.00 3060.77
15 GC Thread#1 0.00 3060.77
15 GC Thread#10 0.00 3060.77
15 GC Thread#2 0.00 3060.77
15 GC Thread#3 0.00 3060.77
15 GC Thread#4 0.00 3060.77
15 GC Thread#5 0.00 3060.77
15 GC Thread#6 0.00 3060.77
15 GC Thread#7 0.00 3060.77
15 GC Thread#8 0.00 3060.77
15 GC Thread#9 0.00 3060.77
15 GC Thread#11 0.00 3060.76
15 GC Thread#12 0.00 3060.76
14 G1 Refine#1 0.00 2977.78
10 G1 Refine#2 0.00 2139.52
18 rm 0.00 0.09
1 lspci 0.00 0.03
1 ps 0.00 0.01
120 cassandra-stres 0.00 0.00
88 sh 0.00 0.00
70 grep 0.00 0.00
45 awk 0.00 0.00
42 sleep 0.00 0.00
31 G1 Main Marker 0.00 0.00
31 G1 Young RemSet 0.00 0.00
31 VM Periodic Tas 0.00 0.00
31 dirname 0.00 0.00
18 scylladb 0.00 0.00
15 cut 0.00 0.00
13 gsettings 0.00 0.00
12 gcc 0.00 0.00
9 tail 0.00 0.00
8 stat 0.00 0.00
8 systemd-detect- 0.00 0.00
6 llvm-link 0.00 0.00
5 phoronix-test-s 0.00 0.00
2 gmain 0.00 0.00
2 lscpu 0.00 0.00
2 uname 0.00 0.00
2 which 0.00 0.00
2 xset 0.00 0.00
1 cc 0.00 0.00
1 date 0.00 0.00
1 dconf worker 0.00 0.00
1 dmesg 0.00 0.00
1 dmidecode 0.00 0.00
1 ifconfig 0.00 0.00
1 ip 0.00 0.00
1 lsmod 0.00 0.00
1 mktemp 0.00 0.00
1 python 0.00 0.00
1 python3 0.00 0.00
1 qdbus 0.00 0.00
1 readlink 0.00 0.00
1 realpath 0.00 0.00
1 sed 0.00 0.00
1 sort 0.00 0.00
1 stty 0.00 0.00
1 systemctl 0.00 0.00
1 template.sh 0.00 0.00
1 wc 0.00 0.00
1 xrandr 0.00 0.00
0 processes running
121 maximum processes
Sample computation block
53145) scylladb cpu=9 start=5.74 finish=165.84
53146) rm cpu=11 start=5.74 finish=5.74
53147) scylla cpu=0 start=5.74 finish=163.82
53149) reactor-1 cpu=8 start=5.93 finish=163.82
53165) syscall-1 cpu=8 start=5.95 finish=163.82
53150) reactor-2 cpu=1 start=5.93 finish=163.82
53169) syscall-2 cpu=1 start=5.96 finish=163.82
53151) reactor-3 cpu=9 start=5.93 finish=163.82
53168) syscall-3 cpu=9 start=5.96 finish=163.82
53152) reactor-4 cpu=2 start=5.93 finish=163.82
53166) syscall-4 cpu=2 start=5.95 finish=163.82
53153) reactor-5 cpu=10 start=5.93 finish=163.82
53167) syscall-5 cpu=10 start=5.95 finish=163.82
53154) reactor-6 cpu=3 start=5.93 finish=163.82
53173) syscall-6 cpu=3 start=5.96 finish=163.82
53155) reactor-7 cpu=11 start=5.94 finish=163.82
53170) syscall-7 cpu=11 start=5.96 finish=163.82
53156) reactor-8 cpu=4 start=5.94 finish=163.82
53172) syscall-8 cpu=4 start=5.96 finish=163.82
53157) reactor-9 cpu=12 start=5.94 finish=163.82
53175) syscall-9 cpu=12 start=5.96 finish=163.82
53158) reactor-10 cpu=5 start=5.94 finish=163.82
53174) syscall-10 cpu=5 start=5.96 finish=163.82
53159) reactor-11 cpu=13 start=5.94 finish=163.82
53171) syscall-11 cpu=13 start=5.96 finish=163.82
53160) reactor-12 cpu=6 start=5.94 finish=163.82
53177) syscall-12 cpu=6 start=5.96 finish=163.82
53161) reactor-13 cpu=14 start=5.94 finish=163.82
53176) syscall-13 cpu=14 start=5.96 finish=163.82
53162) reactor-14 cpu=7 start=5.95 finish=163.82
53179) syscall-14 cpu=7 start=5.96 finish=163.82
53163) reactor-15 cpu=15 start=5.95 finish=163.82
53178) syscall-15 cpu=15 start=5.96 finish=163.82
53164) syscall-0 cpu=0 start=5.95 finish=163.82
53148) sleep cpu=2 start=5.74 finish=10.74
53180) scylladb cpu=11 start=10.75 finish=31.50
53182) tail cpu=0 start=10.75 finish=31.50
53181) grep cpu=15 start=10.75 finish=31.50
53197) sleep cpu=3 start=31.50 finish=32.50
53199) cassandra-stres cpu=9 start=32.50 finish=160.81
53200) dirname cpu=4 start=32.51 finish=32.51
53201) dirname cpu=7 start=32.51 finish=32.51
53202) cassandra-stres cpu=13 start=32.51 finish=32.51
53203) java cpu=10 start=32.51 finish=32.55
53204) java cpu=12 start=32.52 finish=32.55
53205) GC Thread#0 cpu=-1 start=32.52 finish=32.55
53206) G1 Main Marker cpu=0 start=32.52 finish=32.55
53207) G1 Conc#0 cpu=-1 start=32.52 finish=32.55
53208) G1 Refine#0 cpu=-1 start=32.52 finish=32.55
53209) G1 Young RemSet cpu=0 start=32.52 finish=32.55
53210) VM Thread cpu=-1 start=32.53 finish=32.55
53211) Reference Handl cpu=-1 start=32.53 finish=32.55
53212) Finalizer cpu=3 start=32.53 finish=32.55
53213) Signal Dispatch cpu=-1 start=32.53 finish=32.55
53214) Service Thread cpu=-1 start=32.53 finish=32.55
53215) C2 CompilerThre cpu=-1 start=32.53 finish=32.55
53218) C1 CompilerThre cpu=-1 start=32.54 finish=32.55
53216) C1 CompilerThre cpu=-1 start=32.53 finish=32.55
53217) Sweeper thread cpu=-1 start=32.53 finish=32.55
53219) VM Periodic Tas cpu=0 start=32.54 finish=32.55
53220) cassandra-stres cpu=14 start=32.55 finish=32.55
53221) cassandra-stres cpu=0 start=32.55 finish=32.55
53222) grep cpu=3 start=32.55 finish=32.55
53223) awk cpu=9 start=32.55 finish=32.55
53224) cut cpu=7 start=32.55 finish=32.55
53225) cassandra-stres cpu=0 start=32.55 finish=32.56
53226) cassandra-stres cpu=4 start=32.55 finish=32.55
53227) grep cpu=7 start=32.55 finish=32.56
53228) awk cpu=2 start=32.55 finish=32.56
53229) cassandra-stres cpu=10 start=32.56 finish=32.56
53230) cassandra-stres cpu=14 start=32.56 finish=32.56
53231) awk cpu=9 start=32.56 finish=32.56
53232) grep cpu=3 start=32.56 finish=32.56
53233) grep cpu=6 start=32.56 finish=32.56
53234) java cpu=13 start=32.56 finish=160.76
53235) java cpu=2 start=32.57 finish=160.76
53236) GC Thread#0 cpu=-1 start=32.57 finish=160.76
53237) G1 Main Marker cpu=0 start=32.57 finish=160.75
53267) G1 Conc#1 cpu=-1 start=33.37 finish=160.75
53268) G1 Conc#2 cpu=-1 start=33.37 finish=160.75
53238) G1 Conc#0 cpu=-1 start=32.57 finish=160.76
53239) G1 Refine#0 cpu=-1 start=32.58 finish=160.75
53320) G1 Refine#1 cpu=-1 start=38.52 finish=160.75
53321) G1 Refine#2 cpu=-1 start=38.52 finish=160.75
53240) G1 Young RemSet cpu=0 start=32.58 finish=160.75
53241) VM Thread cpu=-1 start=32.58 finish=160.76
53256) GC Thread#1 cpu=-1 start=32.85 finish=160.76
53257) GC Thread#2 cpu=-1 start=32.86 finish=160.76
53258) GC Thread#3 cpu=-1 start=32.86 finish=160.76
53259) GC Thread#4 cpu=-1 start=32.86 finish=160.75
53260) GC Thread#5 cpu=-1 start=32.86 finish=160.75
53261) GC Thread#6 cpu=-1 start=32.86 finish=160.75
53262) GC Thread#7 cpu=-1 start=32.86 finish=160.75
53263) GC Thread#8 cpu=-1 start=32.86 finish=160.75
53264) GC Thread#9 cpu=-1 start=32.86 finish=160.75
53315) GC Thread#10 cpu=-1 start=36.96 finish=160.75
53316) GC Thread#11 cpu=-1 start=36.96 finish=160.75
53317) GC Thread#12 cpu=-1 start=36.96 finish=160.75
53242) Reference Handl cpu=-1 start=32.59 finish=160.76
53243) Finalizer cpu=3 start=32.59 finish=160.76
53244) Signal Dispatch cpu=-1 start=32.59 finish=160.76
53245) Service Thread cpu=-1 start=32.59 finish=160.76
53246) C2 CompilerThre cpu=-1 start=32.59 finish=160.76
53249) C1 CompilerThre cpu=-1 start=32.60 finish=34.60
53250) C1 CompilerThre cpu=-1 start=32.60 finish=34.60
53253) C2 CompilerThre cpu=-1 start=32.63 finish=34.90
53273) C2 CompilerThre cpu=-1 start=33.50 finish=34.60
53339) C2 CompilerThre cpu=-1 start=47.36 finish=47.65
53340) C2 CompilerThre cpu=-1 start=153.71 finish=158.54
53341) C2 CompilerThre cpu=-1 start=153.72 finish=158.54
53342) C2 CompilerThre cpu=-1 start=153.72 finish=158.54
53343) C2 CompilerThre cpu=-1 start=153.72 finish=158.54
53344) C2 CompilerThre cpu=-1 start=153.72 finish=158.54
53345) C2 CompilerThre cpu=-1 start=153.72 finish=158.54
53247) C1 CompilerThre cpu=-1 start=32.59 finish=160.76
53254) C1 CompilerThre cpu=-1 start=32.70 finish=34.60
53255) C2 CompilerThre cpu=-1 start=32.85 finish=34.90
53288) C2 CompilerThre cpu=-1 start=36.66 finish=39.60
53289) C1 CompilerThre cpu=-1 start=36.66 finish=40.43
53290) C1 CompilerThre cpu=-1 start=36.66 finish=39.36
53313) C2 CompilerThre cpu=-1 start=36.77 finish=38.24
53314) C2 CompilerThre cpu=-1 start=36.86 finish=37.92
53291) C2 CompilerThre cpu=-1 start=36.66 finish=38.92
53318) C2 CompilerThre cpu=-1 start=37.02 finish=37.89
53310) C1 CompilerThre cpu=-1 start=36.72 finish=39.36
53311) C2 CompilerThre cpu=-1 start=36.73 finish=38.92
53312) C2 CompilerThre cpu=-1 start=36.74 finish=38.49
53371) C2 CompilerThre cpu=-1 start=158.55 finish=159.65
53248) Sweeper thread cpu=-1 start=32.59 finish=160.76
53251) Common-Cleaner cpu=0 start=32.60 finish=160.76
53252) VM Periodic Tas cpu=0 start=32.61 finish=160.75
53265) cluster1-connec cpu=6 start=33.26 finish=160.75
53266) cluster1-schedu cpu=7 start=33.33 finish=158.54
53283) cluster1-worker cpu=7 start=33.58 finish=63.59
53285) cluster1-worker cpu=0 start=33.60 finish=63.61
53287) cluster1-worker cpu=13 start=33.62 finish=63.63
53270) ObjectCleanerTh cpu=0 start=33.38 finish=160.75
53271) cluster1-nio-wo cpu=7 start=33.38 finish=160.75
53272) cluster1-timeou cpu=3 start=33.40 finish=160.75
53274) cluster1-nio-wo cpu=12 start=33.52 finish=160.75
53282) cluster1-worker cpu=15 start=33.58 finish=63.58
53284) cluster1-worker cpu=11 start=33.60 finish=63.60
53286) cluster1-worker cpu=12 start=33.62 finish=63.62
53309) cluster1-worker cpu=9 start=36.71 finish=66.72
53275) cluster1-nio-wo cpu=8 start=33.52 finish=160.75
53276) cluster1-nio-wo cpu=13 start=33.52 finish=160.75
53277) cluster1-nio-wo cpu=1 start=33.52 finish=160.75
53278) cluster1-nio-wo cpu=6 start=33.52 finish=160.75
53279) cluster1-nio-wo cpu=7 start=33.52 finish=160.75
53280) cluster1-nio-wo cpu=1 start=33.53 finish=160.75
53281) cluster1-nio-wo cpu=9 start=33.54 finish=160.75
53292) Thread-3 cpu=8 start=36.70 finish=38.52
53293) Thread-4 cpu=8 start=36.70 finish=38.52
53294) Thread-5 cpu=3 start=36.70 finish=38.52
53295) Thread-6 cpu=1 start=36.70 finish=38.52
53296) Thread-7 cpu=5 start=36.70 finish=38.52
53297) Thread-8 cpu=15 start=36.70 finish=38.52
53298) Thread-9 cpu=0 start=36.70 finish=38.52
53299) Thread-10 cpu=9 start=36.70 finish=38.52
53300) Thread-11 cpu=6 start=36.70 finish=38.52
53301) Thread-12 cpu=10 start=36.70 finish=38.51
53302) Thread-13 cpu=1 start=36.70 finish=38.52
53303) Thread-14 cpu=9 start=36.70 finish=38.52
53304) Thread-15 cpu=13 start=36.70 finish=38.52
53305) Thread-16 cpu=15 start=36.70 finish=38.52
53306) Thread-17 cpu=11 start=36.70 finish=38.52
53307) Thread-18 cpu=2 start=36.70 finish=38.52
53308) StressMetrics cpu=15 start=36.71 finish=38.52
53322) Thread-20 cpu=11 start=38.53 finish=158.54
53323) Thread-21 cpu=7 start=38.53 finish=158.54
53324) Thread-22 cpu=13 start=38.53 finish=158.54
53325) Thread-23 cpu=12 start=38.53 finish=158.54
53326) Thread-24 cpu=3 start=38.53 finish=158.54
53327) Thread-25 cpu=14 start=38.53 finish=158.54
53328) Thread-26 cpu=6 start=38.53 finish=158.54
53329) Thread-27 cpu=15 start=38.53 finish=158.54
53330) Thread-28 cpu=4 start=38.53 finish=158.54
53331) Thread-29 cpu=1 start=38.53 finish=158.54
53332) Thread-30 cpu=2 start=38.53 finish=158.54
53333) Thread-31 cpu=9 start=38.53 finish=158.54
53334) Thread-32 cpu=12 start=38.53 finish=158.54
53335) Thread-33 cpu=7 start=38.53 finish=158.54
53336) Thread-34 cpu=5 start=38.53 finish=158.54
53337) Thread-35 cpu=8 start=38.53 finish=158.54
53338) StressMetrics cpu=14 start=38.53 finish=158.54
53346) Shutdown-checke cpu=1 start=158.54 finish=160.75
53347) globalEventExec cpu=9 start=158.54 finish=158.55
53348) cluster1-nio-wo cpu=14 start=158.54 finish=160.75
53349) cluster1-nio-wo cpu=6 start=158.54 finish=160.75
53350) cluster1-nio-wo cpu=2 start=158.54 finish=160.75
53372) globalEventExec cpu=2 start=160.75 finish=160.75
53351) cluster1-nio-wo cpu=2 start=158.54 finish=160.75
53352) cluster1-nio-wo cpu=0 start=158.54 finish=160.75
53353) cluster1-nio-wo cpu=1 start=158.54 finish=160.75
53354) cluster1-nio-wo cpu=14 start=158.54 finish=160.75
53355) cluster1-nio-wo cpu=10 start=158.55 finish=160.75
53356) cluster1-nio-wo cpu=4 start=158.55 finish=160.75
53357) cluster1-nio-wo cpu=8 start=158.55 finish=160.75
53358) cluster1-nio-wo cpu=3 start=158.55 finish=160.75
53359) cluster1-nio-wo cpu=12 start=158.55 finish=160.75
53360) cluster1-nio-wo cpu=14 start=158.55 finish=160.75
53361) cluster1-nio-wo cpu=14 start=158.55 finish=160.75
53362) cluster1-nio-wo cpu=2 start=158.55 finish=160.75
53363) cluster1-nio-wo cpu=0 start=158.55 finish=160.75
53364) cluster1-nio-wo cpu=4 start=158.55 finish=160.75
53365) cluster1-nio-wo cpu=6 start=158.55 finish=160.75
53366) cluster1-nio-wo cpu=13 start=158.55 finish=160.75
53367) cluster1-nio-wo cpu=15 start=158.55 finish=160.75
53368) cluster1-nio-wo cpu=8 start=158.55 finish=160.75
53369) cluster1-nio-wo cpu=11 start=158.55 finish=160.75
53370) cluster1-nio-wo cpu=15 start=158.55 finish=160.75
53373) Logging-Cleaner cpu=3 start=160.75 finish=160.75
53374) Thread-0 cpu=6 start=160.75 finish=160.75
53375) sleep cpu=10 start=160.81 finish=163.81
53376) sleep cpu=13 start=163.82 finish=165.82
53377) rm cpu=3 start=165.82 finish=165.84