__step=000641
__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_avl_kcas_validate_htm.debra -nwork 48 -nprefill 48 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000641.txt
__path_data=data/data000641.txt
__hostname=jax
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x563d1ff4f400
addrof(kcasDescriptors[1])=0x563d1ff4fd00
addrof(rdcssDescriptors[0])=0x563d2006f400
addrof(rdcssDescriptors[1])=0x563d2006f4c0
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=7002513.640132348
binary=./sigouin_int_avl_kcas_validate_htm.debra
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
DS_TYPENAME=sigouin_int_avl_kcas_validate_htm
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=200000
PREFILL_THREADS=48
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=48
WORK_THREADS=48
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,96,97,98,99,100,101,102,103,104,105,106,107,108,109,110,111,112,113,114,115,116,117,118,119


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.005s
prefilling_size=100040 prefilling_elapsed_millis=1.001s
finished prefilling to size 100041 for expected size 100000 keysum=10004637456, performing 46646340 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=100041
pref_millis=1102
prefill_elapsed_ms=1122
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=7002514.945950554
REALTIME_END_PERF_FORMAT=7002524.946088718

###############################################################################
################################## 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 (192 threads)...
partitioned into 1024 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...

tree_stats_computeWalltime=0.033s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8138 14636 17122 8305 1042 21 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 49 1452 9893 19308 10598 1316 27
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8187 16088 27015 27613 11640 1337 27
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8187 16088 27015 27613 11640 1337 27
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 1.99878 1.97105 1.76946 1.38834 1.12078 1.02534 1.00449 1

tree_stats_height=20
tree_stats_numInternals=57455
tree_stats_numLeaves=42643
tree_stats_numNodes=100098
tree_stats_numKeys=100098

tree_stats_avgDegreeInternal=1.7422
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.42601
tree_stats_avgKeyDepth=14.8981


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:61 2:1546 4:53315 8:375753 16:49214 32:4
    [2^00, 2^01]: 61
    (2^01, 2^02]: 1546
    (2^02, 2^03]: 53315
    (2^03, 2^04]: 375753
    (2^04, 2^05]: 49214
    (2^05, 2^06]: 4
sum_limbo_reclamation_event_size_total=5436537
count_limbo_reclamation_event_size_by_thread=9997 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9997 9998 9995 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9997 9998 9998 9997 9998 9998 9997 9998 9998 9998 9998
count_limbo_reclamation_event_size_total=479893
sum_limbo_reclamation_event_count_total=1812288
first_thread_announced_epoch_by_thread=79938 79938 79938 79938 79938 79938 79938 79938 79938 79938 79938 79938 79938 79938 79938 79938 79938 79938 79938 79938 79938 79938 79938 79938 79938 79938 79938 79938 79938 79938 79938 79938 79938 79938 79938 79938 79938 79938 79938 79938 79938 79938 79938 79938 79938 79938 79938 79938
sum_num_inserts_by_thread=840409 856838 857437 854850 860514 843231 842638 849537 859659 862869 862470 848329 857908 853351 861125 867336 862937 861039 846071 851260 868540 864812 862268 843245 841279 847114 858182 857585 861391 841127 844389 850156 861060 866741 851970 857320 854249 858714 857621 863099 857731 850890 850810 848487 863361 870211 855743 855441
sum_num_inserts_total=41063344
sum_num_deletes_by_thread=842190 857445 855821 853950 858860 843876 843984 849934 859403 863409 863430 848263 857346 852654 860671 868218 861122 860024 847206 851912 868749 865804 863447 843082 840565 845663 858408 856903 861833 842372 844154 851351 858895 867768 852446 857124 853081 860064 859800 863989 853996 851544 848872 847813 862711 869926 857324 856254
sum_num_deletes_total=41063656
sum_num_searches_by_thread=15143327 15418480 15415484 15373135 15491741 15172323 15191575 15299040 15472647 15528775 15527473 15281031 15442086 15357735 15498259 15620000 15521889 15483860 15236187 15330304 15635068 15568141 15519553 15169841 15117991 15235728 15443258 15428215 15509872 15130508 15194230 15303502 15487626 15601495 15356043 15420985 15367773 15473017 15450811 15517512 15399573 15326456 15310125 15278112 15554149 15681036 15432810 15424550
sum_num_searches_total=739143331
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=16825926 17132763 17128742 17081935 17211115 16859430 16878197 16998511 17191709 17255053 17253373 16977623 17157340 17063740 17220055 17355554 17245948 17204923 16929464 17033476 17372357 17298757 17245268 16856168 16799835 16928505 17159848 17142703 17233096 16814007 16882773 17005009 17207581 17336004 17060459 17135429 17075103 17191795 17168232 17244600 17111300 17028890 17009807 16974412 17280221 17421173 17145877 17136245
average_num_operations_total=17109798
stdev_num_operations_total=23026
sum_num_operations_total=821270331
min_num_operations_total=16799835
max_num_operations_total=17421173
first_time_thread_terminate_by_thread=10000138 10000138 10000138 10000138 10000138 10000138 10000137 10000138 10000138 10000137 10000138 10000137 10000138 10000137 10000137 10000137 10000137 10000138 10000138 10000138 10000138 10000138 10000137 10000138 10000138 10000138 10000137 10000138 10000138 10000138 10000137 10000138 10000138 10000137 10000138 10000137 10000138 10000137 10000137 10000137 10000137 10000138 10000138 10000138 10000138 10000138 10000137 10000138
min_time_thread_terminate_total=10000137
max_time_thread_terminate_total=10000138
first_time_thread_start_by_thread=3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 4 3 3 4 3 4 3 3 3 3 3 3 3 3 3 3 3 3 3 4 3 3 3 3 4 3 3 4 3 4
min_time_thread_start_total=3
max_time_thread_start_total=4
sum_duration_all_ops_total=

threads_final_keysum=10000661971
threads_final_size=100098
final_keysum=10000661971
final_size=100098
validate_result=success
Validation OK.
Structural validation OK.

total_find=739143331
total_rq=0
total_inserts=41063344
total_deletes=41063656
total_updates=82127000
total_queries=739143331
total_ops=821270331
find_throughput=73914333
rq_throughput=0
update_throughput=8212700
query_throughput=73914333
total_throughput=82127033


total find                    : 739143331
total rq                      : 0
total inserts                 : 41063344
total deletes                 : 41063656
total updates                 : 82127000
total queries                 : 739143331
total ops                     : 821270331
find throughput               : 73914333
rq throughput                 : 0
update throughput             : 8212700
query throughput              : 73914333
total throughput              : 82127033

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=6.28575
PAPI_L3_TCM=0.000182059
PAPI_TOT_CYC=1590.05
PAPI_TOT_INS=1010.06
garbage=36957674908835
total_execution_walltime=11.448s
REALTIME_MAIN_END_PERF_FORMAT=7002525.88967225
[time_cmd_output] time_elapsed_sec=11.57, faults_major=0, faults_minor=76904, mem_maxresident_kb=309384, user_cputime=559.61, sys_cputime=2.12, percent_cpu=4853%
timeout=false
algorithm=sigouin_int_avl_kcas_validate_htm.debra
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=1