__step=000169
__cmd_run=LD_PRELOAD=../../setbench/lib/libjemalloc.so timeout 180 numactl -i all /usr/bin/time -f "[time_cmd_output] time_elapsed_sec=%e, faults_major=%F, faults_minor=%R, mem_maxresident_kb=%M, user_cputime=%U, sys_cputime=%S, percent_cpu=%P" ./sigouin_int_bst_kcas_validate.debra -nwork 64 -nprefill 64 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 2000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000169.txt
__path_data=data/data000169.txt
__hostname=nasus
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x55d06271f3c0
addrof(kcasDescriptors[1])=0x55d06271fcc0
addrof(rdcssDescriptors[0])=0x55d06283f3c0
addrof(rdcssDescriptors[1])=0x55d06283f480
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=221930.196459246
binary=./sigouin_int_bst_kcas_validate.debra
parsed custom binding: 0-63,128-191,64-127,192-255
DS_TYPENAME=sigouin_int_bst_kcas_validate
FIND_FUNC=FIND_FUNC
INSERT_FUNC=insertIfAbsent
ERASE_FUNC=ERASE_FUNC
RQ_FUNC=RQ_FUNC
RECLAIM=reclaimer_debra
ALLOC=allocator_new
POOL=pool_none
MAX_THREADS_POW2=512
CPU_FREQ_GHZ=2.1
MILLIS_TO_RUN=10000
INS_FRAC=5
DEL_FRAC=5
RQ=0
RQSIZE=0
MAXKEY=2000000
PREFILL_THREADS=64
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=64
WORK_THREADS=64
RQ_THREADS=0
distribution=0
INS_DEL_FRAC=5.0 5.0
PREFILL_TYPE=PREFILL_HYBRID
PREFILL_HYBRID_MIN_MS=1000
PREFILL_HYBRID_MAX_MS=5000
sizes: node=56
ACTUAL_THREAD_BINDINGS=0,1,2,3,4,5,6,7,8,9,10,11,12,13,14,15,16,17,18,19,20,21,22,23,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,48,49,50,51,52,53,54,55,56,57,58,59,60,61,62,63


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.016s
prefilling_size=1000501 prefilling_elapsed_millis=1s
finished prefilling to size 1000499 for expected size 1000000 keysum=1000049933739, performing 40445391 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=1000499
pref_millis=1101
prefill_elapsed_ms=1109
main thread: starting timer...

###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################

REALTIME_START_PERF_FORMAT=221931.344313122
REALTIME_END_PERF_FORMAT=221941.344414742

###############################################################################
################################## TIME IS UP #################################
###############################################################################

joining threads...
###############################################################################
################################# END RUNNING #################################
###############################################################################

10s
PRODUCING OUTPUT
computing tree_stats in PARALLEL...
bounded depth BFS to partition into subtrees for parallel computation (256 threads)...
partitioned into 1911 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...

tree_stats_computeWalltime=0.112s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 510 982 1832 3261 5545 8929 13474 19486 26749 34865 43071 50494 56094 58989 59302 56271 50623 43086 34691 26734 19527 13539 9220 6137 4054 2642 1697 1068 649 326 148 74 35 16 4 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 1 23 79 225 526 1187 2428 4023 6590 9963 14384 19132 23796 28286 30966 32999 32550 30627 26950 22185 17616 13210 9282 6380 4272 2802 1843 1199 770 501 259 121 59 31 16 3 1
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 511 1005 1911 3486 6071 10116 15902 23509 33339 44828 57455 69626 79890 87275 90268 89270 83173 73713 61641 48919 37143 26749 18502 12517 8326 5444 3540 2267 1419 827 407 195 94 47 20 4 1
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 511 1005 1911 3486 6071 10116 15902 23509 33339 44828 57455 69626 79890 87275 90268 89270 83173 73713 61641 48919 37143 26749 18502 12517 8326 5444 3540 2267 1419 827 407 195 94 47 20 4 1
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 1.99609 1.96869 1.92438 1.86552 1.80608 1.75292 1.6893 1.63105 1.58926 1.54228 1.50393 1.46219 1.4222 1.3903 1.3584 1.33199 1.30136 1.27761 1.25172 1.23082 1.21278 1.19444 1.18554 1.1782 1.17488 1.16695 1.16495 1.16102 1.15483 1.12544 1.09794 1.11548 1.10256 1.12766 1.08511 1 1 1

tree_stats_height=46
tree_stats_numInternals=654636
tree_stats_numLeaves=345285
tree_stats_numNodes=999921
tree_stats_numKeys=999921

tree_stats_avgDegreeInternal=1.52745
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34531
tree_stats_avgKeyDepth=23.2559


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:3 2:82 4:9203 8:341002 16:289088 32:140 64:234 128:120
    [2^00, 2^01]: 3
    (2^01, 2^02]: 82
    (2^02, 2^03]: 9203
    (2^03, 2^04]: 341002
    (2^04, 2^05]: 289088
    (2^05, 2^06]: 140
    (2^06, 2^07]: 234
    (2^07, 2^08]: 120
sum_limbo_reclamation_event_size_total=9757610
count_limbo_reclamation_event_size_by_thread=9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998
count_limbo_reclamation_event_size_total=639872
sum_limbo_reclamation_event_count_total=896576
first_thread_announced_epoch_by_thread=30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190 30190
sum_num_inserts_by_thread=430501 431373 431214 425694 427909 431467 430894 430458 434320 429710 433249 433045 426355 426788 424496 424076 422513 422481 420155 427090 427554 426215 428509 424411 427255 428970 424771 423490 422050 424046 422488 421645 425221 431262 430760 430570 429106 431971 429130 429138 426049 424857 424347 423516 425417 424592 424972 424157 430809 427738 427244 426344 428710 426881 424454 422065 421172 423114 421820 423035 425732 428613 431517 432245
sum_num_inserts_total=27321750
sum_num_deletes_by_thread=430680 431660 430341 427153 428045 430289 429882 430371 435893 431381 433576 433328 426238 427459 424256 425020 423740 421624 421483 428673 429012 425687 426823 425746 427568 428492 424886 423412 421398 422794 423833 421364 425013 431570 430118 429816 429325 431544 427842 429022 427051 425839 423820 423224 426899 424533 424911 424127 429926 428159 427544 426673 428908 426746 425704 421373 420761 421925 422266 423154 426611 428026 431379 432362
sum_num_deletes_total=27328278
sum_num_searches_by_thread=7747074 7763746 7747352 7689040 7725927 7750776 7749373 7745760 7825056 7758817 7797534 7794715 7677955 7672770 7638813 7643606 7615656 7613548 7581896 7705976 7709347 7673688 7691376 7663919 7692254 7720141 7652806 7630231 7604396 7631808 7623580 7576729 7655690 7754181 7753556 7741907 7724614 7760724 7727075 7726720 7693541 7662900 7618207 7622946 7659706 7653788 7654799 7617040 7728815 7717048 7692859 7677425 7716475 7697180 7659725 7602539 7581755 7603808 7587586 7607977 7674771 7705002 7778042 7782916
sum_num_searches_total=491956982
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=8608255 8626779 8608907 8541887 8581881 8612532 8610149 8606589 8695269 8619908 8664359 8661088 8530548 8527017 8487565 8492702 8461909 8457653 8423534 8561739 8565913 8525590 8546708 8514076 8547077 8577603 8502463 8477133 8447844 8478648 8469901 8419738 8505924 8617013 8614434 8602293 8583045 8624239 8584047 8584880 8546641 8513596 8466374 8469686 8512022 8502913 8504682 8465324 8589550 8572945 8547647 8530442 8574093 8550807 8509883 8445977 8423688 8448847 8431672 8454166 8527114 8561641 8640938 8647523
average_num_operations_total=8540734
stdev_num_operations_total=8601
sum_num_operations_total=546607010
min_num_operations_total=8419738
max_num_operations_total=8695269
first_time_thread_terminate_by_thread=10000101 10000102 10000101 10000102 10000104 10000104 10000104 10000104 10000103 10000103 10000103 10000103 10000103 10000103 10000103 10000103 10000102 10000102 10000102 10000102 10000102 10000102 10000103 10000102 10000102 10000102 10000102 10000102 10000101 10000101 10000101 10000101 10000104 10000104 10000104 10000104 10000104 10000104 10000104 10000104 10000103 10000102 10000103 10000103 10000103 10000103 10000103 10000103 10000104 10000104 10000104 10000104 10000100 10000100 10000100 10000100 10000100 10000100 10000100 10000103 10000104 10000104 10000104 10000104
min_time_thread_terminate_total=10000100
max_time_thread_terminate_total=10000104
first_time_thread_start_by_thread=10 10 10 10 9 9 9 9 12 12 12 12 10 10 10 10 11 11 11 11 13 13 13 13 10 10 10 10 8 7 8 8 11 11 11 11 13 13 13 12 10 10 10 10 13 13 13 13 12 12 12 12 11 12 12 12 12 12 12 12 11 11 11 11
min_time_thread_start_total=7
max_time_thread_start_total=13
sum_duration_all_ops_total=

threads_final_keysum=999849586019
threads_final_size=999921
final_keysum=999849586019
final_size=999921
validate_result=success
Validation OK.
Structural validation OK.

total_find=491956982
total_rq=0
total_inserts=27321750
total_deletes=27328278
total_updates=54650028
total_queries=491956982
total_ops=546607010
find_throughput=49195698
rq_throughput=0
update_throughput=5465002
query_throughput=49195698
total_throughput=54660701


total find                    : 491956982
total rq                      : 0
total inserts                 : 27321750
total deletes                 : 27328278
total updates                 : 54650028
total queries                 : 491956982
total ops                     : 546607010
find throughput               : 49195698
rq throughput                 : 0
update throughput             : 5465002
query throughput              : 49195698
total throughput              : 54660701

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

garbage=92178037668309
total_execution_walltime=11.352s
REALTIME_MAIN_END_PERF_FORMAT=221941.549755141
[time_cmd_output] time_elapsed_sec=11.45, faults_major=0, faults_minor=91973, mem_maxresident_kb=368972, user_cputime=742.06, sys_cputime=5.83, percent_cpu=6526%
timeout=false
algorithm=sigouin_int_bst_kcas_validate.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1