__step=000204
__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.debra -nwork 96 -nprefill 96 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000204.txt
__path_data=data/data000204.txt
__hostname=jax
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x563ec490a400
addrof(kcasDescriptors[1])=0x563ec490ad00
addrof(rdcssDescriptors[0])=0x563ec4a2a400
addrof(rdcssDescriptors[1])=0x563ec4a2a4c0
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=6996889.20853697
binary=./sigouin_int_avl_kcas_validate.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
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=20000000
PREFILL_THREADS=96
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=96
WORK_THREADS=96
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,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,120,121,122,123,124,125,126,127,128,129,130,131,132,133,134,135,136,137,138,139,140,141,142,143


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.013s
prefilling_size=8335073 prefilling_elapsed_millis=1.001s
prefilling_size=8586469 prefilling_elapsed_millis=1.101s
prefilling_size=8799907 prefilling_elapsed_millis=1.201s
prefilling_size=8978897 prefilling_elapsed_millis=1.301s
prefilling_size=9131451 prefilling_elapsed_millis=1.402s
prefilling_size=9259429 prefilling_elapsed_millis=1.502s
prefilling_size=9367682 prefilling_elapsed_millis=1.602s
prefilling_size=9460141 prefilling_elapsed_millis=1.702s
prefilling_size=9540112 prefilling_elapsed_millis=1.803s
prefilling_size=9605721 prefilling_elapsed_millis=1.903s
prefilling_size=9663134 prefilling_elapsed_millis=2.003s
prefilling_size=9713597 prefilling_elapsed_millis=2.103s
prefilling_size=9753302 prefilling_elapsed_millis=2.203s
prefilling_size=9788000 prefilling_elapsed_millis=2.304s
prefilling_size=9817811 prefilling_elapsed_millis=2.404s
finished prefilling to size 9817878 for expected size 10000000 keysum=98171532618833, performing 80637779 updates; total_prefilling_elapsed_ms=2506 ms)
pref_size=9817878
pref_millis=2506
prefill_elapsed_ms=2540
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6996891.804159669
REALTIME_END_PERF_FORMAT=6996901.804249714

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

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

10.1s
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.046s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262110 521342 981186 1485138 1413110 673831 129322 6767 2 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 34 2639 53688 394273 1211502 1576175 841623 165071 8376 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262144 523981 1034874 1879411 2624612 2250006 970945 171838 8378 2
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262144 523981 1034874 1879411 2624612 2250006 970945 171838 8378 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99896 1.98006 1.86796 1.60629 1.31886 1.13205 1.04379 1.00938 1 1

tree_stats_height=28
tree_stats_numInternals=5734951
tree_stats_numLeaves=4253383
tree_stats_numNodes=9988334
tree_stats_numKeys=9988334

tree_stats_avgDegreeInternal=1.74166
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.42584
tree_stats_avgKeyDepth=21.6594


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:0 4:39 8:27287 16:528023 32:21612 64:0 128:95
    (2^02, 2^03]: 39
    (2^03, 2^04]: 27287
    (2^04, 2^05]: 528023
    (2^05, 2^06]: 21612
    (2^06, 2^07]: 0
    (2^07, 2^08]: 95
sum_limbo_reclamation_event_size_total=13264549
count_limbo_reclamation_event_size_by_thread=6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011 6011
count_limbo_reclamation_event_size_total=577056
sum_limbo_reclamation_event_count_total=577248
first_thread_announced_epoch_by_thread=13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916 13916
sum_num_inserts_by_thread=276598 278829 279982 279101 277791 275653 276605 277859 280157 281183 277011 276883 276526 279044 280601 280097 279038 276244 275111 277519 279612 280467 275950 275081 276557 278253 280103 280140 278112 275040 276652 277771 281362 281017 277745 276734 277164 278746 280342 281961 279634 275896 276237 276458 278607 279558 276655 274539 276690 278990 278860 279918 278044 276375 275691 278132 281089 280947 278633 276703 277017 280115 281453 279696 278142 276135 274462 277557 280593 280056 276725 276947 276337 278212 280296 280293 278291 277112 277140 278823 280199 280476 278854 276277 277304 279483 280317 279617 279633 276596 274922 277018 279233 281419 278056 275823
sum_num_inserts_total=26708926
sum_num_deletes_by_thread=275971 279008 279930 279647 278457 274595 276744 277553 281123 280709 278080 276591 277943 279023 280260 280617 278863 277241 275205 277491 279617 279730 276546 274762 276647 277333 279764 279913 278063 275250 276220 277735 281726 280096 277973 276369 277294 279263 280417 281425 279022 276395 274540 276085 279020 280296 275869 273903 277898 279764 280633 280139 278688 276560 276779 277862 281908 280487 277791 276779 276389 279119 280174 280185 279205 276106 275703 276648 280504 279577 277954 275916 277374 278690 280348 280581 277464 276978 276054 278965 281011 281831 278368 277026 276448 280052 279900 280671 277729 275467 275843 276781 280855 279924 278185 277117
sum_num_deletes_total=26712754
sum_num_searches_by_thread=4977264 5005721 5038913 5032501 5007285 4962645 4980670 4998050 5048549 5055959 4989569 4984235 4995916 5026920 5049195 5044607 5021570 4974935 4966448 4996532 5024873 5048073 4972379 4945331 4982275 5002673 5036389 5031362 5005900 4957999 4985795 5005493 5054626 5052679 5001040 4968395 4988387 5013668 5041092 5059097 5018867 4980617 4957543 4983072 5014188 5032945 4986257 4944867 4992494 5019007 5051137 5039254 5009646 4975878 4980989 5009003 5052742 5051877 5018920 4974536 4994026 5022099 5052869 5042205 5017540 4972146 4954858 4976735 5046399 5035830 4996726 4977879 4984663 5009418 5043804 5049667 5008297 4979742 4981462 5014431 5066452 5060289 5014628 4979050 4995034 5022658 5051086 5042015 5001604 4962973 4959538 4982117 5048259 5047871 5006822 4990898
sum_num_searches_total=480820939
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=5529833 5563558 5598825 5591249 5563533 5512893 5534019 5553462 5609829 5617851 5544660 5537709 5550385 5584987 5610056 5605321 5579471 5528420 5516764 5551542 5584102 5608270 5524875 5495174 5535479 5558259 5596256 5591415 5562075 5508289 5538667 5560999 5617714 5613792 5556758 5521498 5542845 5571677 5601851 5622483 5577523 5532908 5508320 5535615 5571815 5592799 5538781 5493309 5547082 5577761 5610630 5599311 5566378 5528813 5533459 5564997 5615739 5613311 5575344 5528018 5547432 5581333 5614496 5602086 5574887 5524387 5505023 5530940 5607496 5595463 5551405 5530742 5538374 5566320 5604448 5610541 5564052 5533832 5534656 5572219 5627662 5622596 5571850 5532353 5548786 5582193 5611303 5602303 5558966 5515036 5510303 5535916 5608347 5609214 5563063 5543838
average_num_operations_total=5565027
stdev_num_operations_total=3607
sum_num_operations_total=534242619
min_num_operations_total=5493309
max_num_operations_total=5627662
first_time_thread_terminate_by_thread=10000090 10000089 10000091 10000091 10000090 10000090 10000090 10000091 10000090 10000089 10000089 10000089 10000090 10000090 10000090 10000090 10000089 10000090 10000092 10000089 10000089 10000090 10000090 10000090 10000090 10000089 10000091 10000090 10000090 10000089 10000090 10000090 10000090 10000089 10000090 10000089 10000089 10000090 10000093 10000090 10000089 10000090 10000092 10000089 10000089 10000090 10000090 10000090 10000092 10000091 10000092 10000090 10000092 10000092 10000089 10000090 10000089 10000090 10000091 10000092 10000092 10000090 10000089 10000090 10000092 10000089 10000089 10000091 10000089 10000089 10000092 10000092 10000115 10000091 10000092 10000090 10000092 10000092 10000089 10000092 10000089 10000090 10000091 10000092 10000091 10000090 10000089 10000153 10000092 10000089 10000089 10000091 10000089 10000089 10000092 10000092
min_time_thread_terminate_total=10000089
max_time_thread_terminate_total=10000153
first_time_thread_start_by_thread=6 6 6 6 6 6 6 6 6 7 6 6 6 6 6 6 6 6 6 6 7 6 6 6 6 6 6 6 6 6 6 6 6 7 6 6 6 6 6 6 6 6 6 6 7 6 6 6 5 6 6 6 6 6 6 6 6 6 6 6 5 6 6 5 6 5 6 6 6 5 6 6 5 6 6 6 6 6 6 6 6 6 6 6 5 6 6 10 6 5 6 6 6 5 6 6
min_time_thread_start_total=5
max_time_thread_start_total=10
sum_duration_all_ops_total=

threads_final_keysum=99888031349899
threads_final_size=9988334
final_keysum=99888031349899
final_size=9988334
validate_result=success
Validation OK.
Structural validation OK.

total_find=480820939
total_rq=0
total_inserts=26708926
total_deletes=26712754
total_updates=53421680
total_queries=480820939
total_ops=534242619
find_throughput=48082093
rq_throughput=0
update_throughput=5342168
query_throughput=48082093
total_throughput=53424261


total find                    : 480820939
total rq                      : 0
total inserts                 : 26708926
total deletes                 : 26712754
total updates                 : 53421680
total queries                 : 480820939
total ops                     : 534242619
find throughput               : 48082093
rq throughput                 : 0
update throughput             : 5342168
query throughput              : 48082093
total throughput              : 53424261

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

PAPI_L2_TCM=27.7916
PAPI_L3_TCM=10.1658
PAPI_TOT_CYC=5005.15
PAPI_TOT_INS=1379.55
garbage=2388712608593989
total_execution_walltime=12.982s
REALTIME_MAIN_END_PERF_FORMAT=6996902.24937147
[time_cmd_output] time_elapsed_sec=13.17, faults_major=0, faults_minor=238201, mem_maxresident_kb=950268, user_cputime=1227.87, sys_cputime=2.92, percent_cpu=9339%
timeout=false
algorithm=sigouin_int_avl_kcas_validate.debra
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=2