__step=000443
__cmd_run=LD_PRELOAD=../../setbench/lib/libjemalloc.so timeout 60 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=data000443.txt
__path_data=data/data000443.txt
__hostname=jax
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x55c29f31e400
addrof(kcasDescriptors[1])=0x55c29f31ed00
addrof(rdcssDescriptors[0])=0x55c29f43e400
addrof(rdcssDescriptors[1])=0x55c29f43e4c0
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=6984249.294994029
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.041s
prefilling_size=8306889 prefilling_elapsed_millis=1s
prefilling_size=8563373 prefilling_elapsed_millis=1.1s
prefilling_size=8779522 prefilling_elapsed_millis=1.201s
prefilling_size=8963382 prefilling_elapsed_millis=1.301s
prefilling_size=9117590 prefilling_elapsed_millis=1.401s
prefilling_size=9250967 prefilling_elapsed_millis=1.501s
prefilling_size=9360671 prefilling_elapsed_millis=1.601s
prefilling_size=9455251 prefilling_elapsed_millis=1.701s
prefilling_size=9534693 prefilling_elapsed_millis=1.802s
prefilling_size=9602555 prefilling_elapsed_millis=1.902s
prefilling_size=9660365 prefilling_elapsed_millis=2.002s
prefilling_size=9707691 prefilling_elapsed_millis=2.102s
prefilling_size=9750151 prefilling_elapsed_millis=2.202s
prefilling_size=9786858 prefilling_elapsed_millis=2.302s
prefilling_size=9820016 prefilling_elapsed_millis=2.403s
finished prefilling to size 9820126 for expected size 10000000 keysum=98197133106590, performing 80164395 updates; total_prefilling_elapsed_ms=2504 ms)
pref_size=9820126
pref_millis=2504
prefill_elapsed_ms=2528
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6984252.56155483
REALTIME_END_PERF_FORMAT=6984262.56239997

###############################################################################
################################## 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.039s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131071 262059 519858 967543 1448562 1401456 711058 150851 9120 29 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1 80 3880 62228 399033 1161717 1537029 884181 192515 11469 34
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262139 523738 1029771 1847595 2563173 2248087 1035032 201635 11498 34
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262139 523738 1029771 1847595 2563173 2248087 1035032 201635 11498 34
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99997 1.99825 1.9736 1.85461 1.60328 1.33031 1.14411 1.04907 1.01179 1.00043 1

tree_stats_height=28
tree_stats_numInternals=5732678
tree_stats_numLeaves=4252167
tree_stats_numNodes=9984845
tree_stats_numKeys=9984845

tree_stats_avgDegreeInternal=1.74174
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.42586
tree_stats_avgKeyDepth=21.6865


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:2 4:32 8:27345 16:530037 32:21368
    (2^01, 2^02]: 2
    (2^02, 2^03]: 32
    (2^03, 2^04]: 27345
    (2^04, 2^05]: 530037
    (2^05, 2^06]: 21368
sum_limbo_reclamation_event_size_total=13283211
count_limbo_reclamation_event_size_by_thread=6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029 6029
count_limbo_reclamation_event_size_total=578784
sum_limbo_reclamation_event_count_total=578976
first_thread_announced_epoch_by_thread=13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950 13950
sum_num_inserts_by_thread=276500 277661 280925 279587 277979 274948 277269 277308 281104 281394 277984 275526 277057 278572 279560 280517 279523 277278 276334 278187 278905 279685 275742 276194 277646 277981 279784 280597 278641 276407 277878 278402 280958 280960 277236 276078 276093 277925 281450 280744 277710 276747 275335 276326 277473 279378 277256 274688 278088 278883 280192 280185 278401 277707 277317 277969 281531 281182 279822 278196 277884 279892 282529 282410 279166 276042 275468 277426 280056 279562 278792 276036 277886 277650 281102 279413 277521 276064 277950 278748 281423 281558 279514 277302 278646 279241 281376 280993 279182 276890 275990 277473 280408 280251 279372 276351
sum_num_inserts_total=26736472
sum_num_deletes_by_thread=277723 277896 280320 280412 279314 276452 276151 277541 281339 280475 277874 275119 277855 277910 280266 280840 278712 277573 275949 277328 278886 279641 277313 275756 276843 278338 279168 279768 278537 276198 277336 277190 280125 280819 278480 274760 276616 278056 279636 280047 278557 277184 276093 276991 278477 279695 278069 274606 277645 278635 281170 280093 278271 277012 278221 278599 280793 281982 278937 276859 278926 279213 282091 281603 280767 275780 275853 276398 280342 280284 278398 276665 276967 278498 281112 280428 277392 276344 277611 278373 281483 281609 279114 277383 278305 279595 281670 280279 279852 276267 276004 277374 281322 279665 279621 277356
sum_num_deletes_total=26738395
sum_num_searches_by_thread=4986185 5003905 5040221 5037054 5008516 4962467 4984675 5006898 5059107 5058824 5010324 4964310 4987924 5018086 5041255 5050672 5024525 4986179 4970067 4998273 5027004 5041867 4990474 4949958 4987648 5009040 5044317 5040940 5016239 4969952 4991044 5006834 5054617 5058607 5005629 4962859 4995182 5006828 5053327 5042006 5019252 4981878 4960030 4978428 5017105 5035841 4990085 4946740 4995020 5011104 5051423 5041388 5009418 4983748 5001284 5017676 5062136 5070773 5025985 4998450 5017643 5037621 5073511 5068801 5032689 4973774 4962023 4985265 5039143 5047279 5016338 4968680 4991730 5003206 5049293 5039802 5004107 4979908 4992847 5011479 5070270 5069896 5026112 4993956 5011974 5030995 5068889 5056403 5031430 4970885 4969633 4991076 5059732 5055530 5025578 4986855
sum_num_searches_total=481365956
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=5540408 5559462 5601466 5597053 5565809 5513867 5538095 5561747 5621550 5620693 5566182 5514955 5542836 5574568 5601081 5612029 5582760 5541030 5522350 5553788 5584795 5601193 5543529 5501908 5542137 5565359 5603269 5601305 5573417 5522557 5546258 5562426 5615700 5620386 5561345 5513697 5547891 5562809 5614413 5602797 5575519 5535809 5511458 5531745 5573055 5594914 5545410 5496034 5550753 5568622 5612785 5601666 5566090 5538467 5556822 5574244 5624460 5633937 5584744 5553505 5574453 5596726 5638131 5632814 5592622 5525596 5513344 5539089 5599541 5607125 5573528 5521381 5546583 5559354 5611507 5599643 5559020 5532316 5548408 5568600 5633176 5633063 5584740 5548641 5568925 5589831 5631935 5617675 5590464 5524042 5521627 5545923 5621462 5615446 5584571 5540562
average_num_operations_total=5571258
stdev_num_operations_total=3689
sum_num_operations_total=534840823
min_num_operations_total=5496034
max_num_operations_total=5638131
first_time_thread_terminate_by_thread=10000086 10000084 10000085 10000084 10000084 10000085 10000084 10000085 10000084 10000085 10000086 10000085 10000084 10000084 10000084 10000085 10000084 10000087 10000085 10000085 10000084 10000085 10000085 10000084 10000086 10000084 10000085 10000084 10000085 10000085 10000084 10000085 10000084 10000085 10000084 10000085 10000084 10000084 10000084 10000085 10000084 10000087 10000085 10000085 10000086 10000085 10000085 10000084 10000083 10000086 10000084 10000084 10000085 10000085 10000084 10000083 10000088 10000086 10000083 10000083 10000086 10000086 10000084 10000083 10000084 10000086 10000083 10000083 10000086 10000084 10000085 10000084 10000083 10000086 10000084 10000084 10000085 10000085 10000084 10000086 10000083 10000102 10000083 10000086 10000086 10000139 10000084 10000084 10000084 10000086 10000085 10000084 10000086 10000084 10000083 10000084
min_time_thread_terminate_total=10000083
max_time_thread_terminate_total=10000139
first_time_thread_start_by_thread=6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 5 6 6 5 6 6 5 6 5 6 6 6 5 6 5 6 5 6 5 5 5 6 5 6 5 6 6 5 6 6 5 6 5 6 6 6 10 6 5 6 5 6 5 5 5 6 5
min_time_thread_start_total=5
max_time_thread_start_total=10
sum_duration_all_ops_total=

threads_final_keysum=99848635358304
threads_final_size=9984845
final_keysum=99848635358304
final_size=9984845
validate_result=success
Validation OK.
Structural validation OK.

total_find=481365956
total_rq=0
total_inserts=26736472
total_deletes=26738395
total_updates=53474867
total_queries=481365956
total_ops=534840823
find_throughput=48136595
rq_throughput=0
update_throughput=5347486
query_throughput=48136595
total_throughput=53484082


total find                    : 481365956
total rq                      : 0
total inserts                 : 26736472
total deletes                 : 26738395
total updates                 : 53474867
total queries                 : 481365956
total ops                     : 534840823
find throughput               : 48136595
rq throughput                 : 0
update throughput             : 5347486
query throughput              : 48136595
total throughput              : 53484082

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

PAPI_L2_TCM=27.7395
PAPI_L3_TCM=10.1662
PAPI_TOT_CYC=4999.76
PAPI_TOT_INS=1380.79
garbage=2366322491277193
total_execution_walltime=12.981s
REALTIME_MAIN_END_PERF_FORMAT=6984262.276978739
[time_cmd_output] time_elapsed_sec=13.15, faults_major=0, faults_minor=238113, mem_maxresident_kb=950076, user_cputime=1230.68, sys_cputime=3.98, percent_cpu=9387%
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=1