__step=000210
__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 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000210.txt
__path_data=data/data000210.txt
__hostname=jax
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x55c0b1758400
addrof(kcasDescriptors[1])=0x55c0b1758d00
addrof(rdcssDescriptors[0])=0x55c0b1878400
addrof(rdcssDescriptors[1])=0x55c0b18784c0
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=6996966.733408500
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=20000000
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.004s
prefilling_size=6706917 prefilling_elapsed_millis=1.001s
prefilling_size=7014808 prefilling_elapsed_millis=1.101s
prefilling_size=7291470 prefilling_elapsed_millis=1.201s
prefilling_size=7540274 prefilling_elapsed_millis=1.301s
prefilling_size=7764770 prefilling_elapsed_millis=1.402s
prefilling_size=7969669 prefilling_elapsed_millis=1.502s
prefilling_size=8154886 prefilling_elapsed_millis=1.602s
prefilling_size=8322421 prefilling_elapsed_millis=1.702s
prefilling_size=8474382 prefilling_elapsed_millis=1.802s
prefilling_size=8612565 prefilling_elapsed_millis=1.903s
prefilling_size=8739017 prefilling_elapsed_millis=2.003s
prefilling_size=8852677 prefilling_elapsed_millis=2.103s
prefilling_size=8955054 prefilling_elapsed_millis=2.203s
prefilling_size=9047441 prefilling_elapsed_millis=2.303s
prefilling_size=9133352 prefilling_elapsed_millis=2.404s
prefilling_size=9209855 prefilling_elapsed_millis=2.504s
prefilling_size=9280505 prefilling_elapsed_millis=2.604s
prefilling_size=9345823 prefilling_elapsed_millis=2.704s
prefilling_size=9403822 prefilling_elapsed_millis=2.805s
prefilling_size=9455557 prefilling_elapsed_millis=2.905s
prefilling_size=9503987 prefilling_elapsed_millis=3.005s
prefilling_size=9546677 prefilling_elapsed_millis=3.105s
prefilling_size=9588382 prefilling_elapsed_millis=3.205s
prefilling_size=9623751 prefilling_elapsed_millis=3.306s
prefilling_size=9656800 prefilling_elapsed_millis=3.406s
prefilling_size=9687404 prefilling_elapsed_millis=3.506s
prefilling_size=9716163 prefilling_elapsed_millis=3.606s
prefilling_size=9742170 prefilling_elapsed_millis=3.706s
prefilling_size=9764777 prefilling_elapsed_millis=3.807s
prefilling_size=9785526 prefilling_elapsed_millis=3.907s
prefilling_size=9804833 prefilling_elapsed_millis=4.007s
finished prefilling to size 9804825 for expected size 10000000 keysum=98036735199310, performing 78983084 updates; total_prefilling_elapsed_ms=4108 ms)
pref_size=9804825
pref_millis=4108
prefill_elapsed_ms=4132
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6996971.58223011
REALTIME_END_PERF_FORMAT=6996981.58359550

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

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262048 519611 963894 1420326 1360648 723560 181024 16997 374 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 91 4082 65023 414941 1144795 1468041 885692 230204 21432 451
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262139 523693 1028917 1835267 2505443 2191601 1066716 247201 21806 451
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262139 523693 1028917 1835267 2505443 2191601 1066716 247201 21806 451
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99996 1.99812 1.97253 1.84688 1.59126 1.33166 1.15658 1.06204 1.01945 1.00353 1

tree_stats_height=28
tree_stats_numInternals=5710625
tree_stats_numLeaves=4234752
tree_stats_numNodes=9945377
tree_stats_numKeys=9945377

tree_stats_avgDegreeInternal=1.74156
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.4258
tree_stats_avgKeyDepth=21.7054


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:53 2:1512 4:54990 8:373169 16:50176 32:1
    [2^00, 2^01]: 53
    (2^01, 2^02]: 1512
    (2^02, 2^03]: 54990
    (2^03, 2^04]: 373169
    (2^04, 2^05]: 50176
    (2^05, 2^06]: 1
sum_limbo_reclamation_event_size_total=5431914
count_limbo_reclamation_event_size_by_thread=9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998
count_limbo_reclamation_event_size_total=479901
sum_limbo_reclamation_event_count_total=551376
first_thread_announced_epoch_by_thread=30242 30242 30242 30242 30242 30242 30242 30242 30242 30242 30242 30242 30242 30242 30242 30242 30242 30242 30242 30242 30242 30242 30242 30242 30242 30242 30242 30242 30242 30242 30242 30242 30242 30242 30242 30242 30242 30242 30242 30242 30242 30242 30242 30242 30242 30242 30242 30242
sum_num_inserts_by_thread=261142 263086 264322 264418 263128 260766 261754 262165 266301 265425 263712 262285 263149 264565 264774 266068 264575 263268 262250 262093 264358 266393 262886 260683 262205 263673 265472 264357 263606 261648 262992 263303 265211 266389 262778 261586 262583 263451 265808 265576 263725 262600 260681 262488 264130 265825 261307 260686
sum_num_inserts_total=12645646
sum_num_deletes_by_thread=262015 263790 265527 264334 263095 260240 261561 263236 264584 266144 262692 261971 262785 263285 264774 265621 264136 262143 261829 262320 264036 265095 261681 260994 262467 262311 265573 263590 263416 261888 263050 263121 265954 266398 262747 260796 262658 264358 264383 265734 264364 261772 261725 263094 263801 265837 261924 261434
sum_num_deletes_total=12640283
sum_num_searches_by_thread=4709934 4743423 4771447 4761020 4735820 4693131 4712746 4740142 4784965 4790042 4740410 4719037 4726516 4750576 4785586 4782454 4762122 4726249 4711190 4734641 4759294 4781586 4729765 4692874 4715751 4740248 4778921 4761862 4739516 4710101 4728338 4737815 4784374 4784565 4730384 4705060 4731709 4751828 4773970 4777721 4758270 4722318 4699102 4729316 4751257 4771716 4716559 4691630
sum_num_searches_total=227637301
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=5233091 5270299 5301296 5289772 5262043 5214137 5236061 5265543 5315850 5321611 5266814 5243293 5252450 5278426 5315134 5314143 5290833 5251660 5235269 5259054 5287688 5313074 5254332 5214551 5240423 5266232 5309966 5289809 5266538 5233637 5254380 5264239 5315539 5317352 5255909 5227442 5256950 5279637 5304161 5309031 5286359 5246690 5221508 5254898 5279188 5303378 5239790 5213750
average_num_operations_total=5269233
stdev_num_operations_total=4609
sum_num_operations_total=252923230
min_num_operations_total=5213750
max_num_operations_total=5321611
first_time_thread_terminate_by_thread=10000136 10000137 10000137 10000136 10000137 10000136 10000136 10000137 10000136 10000136 10000137 10000136 10000136 10000136 10000136 10000136 10000136 10000137 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000137 10000137 10000136 10000137 10000136 10000136 10000137 10000136 10000136 10000137 10000136 10000136 10000136 10000136 10000136 10000136 10000137 10000136 10000137 10000136 10000136 10000136 10000136
min_time_thread_terminate_total=10000136
max_time_thread_terminate_total=10000137
first_time_thread_start_by_thread=5 5 5 6 5 6 6 5 6 6 5 6 6 6 5 6 6 5 5 6 5 5 6 5 5 5 5 6 5 6 6 5 6 6 5 6 6 6 5 6 6 5 5 6 5 5 6 5
min_time_thread_start_total=5
max_time_thread_start_total=6
sum_duration_all_ops_total=

threads_final_keysum=99440568826567
threads_final_size=9945377
final_keysum=99440568826567
final_size=9945377
validate_result=success
Validation OK.
Structural validation OK.

total_find=227637301
total_rq=0
total_inserts=12645646
total_deletes=12640283
total_updates=25285929
total_queries=227637301
total_ops=252923230
find_throughput=22763730
rq_throughput=0
update_throughput=2528592
query_throughput=22763730
total_throughput=25292323


total find                    : 227637301
total rq                      : 0
total inserts                 : 12645646
total deletes                 : 12640283
total updates                 : 25285929
total queries                 : 227637301
total ops                     : 252923230
find throughput               : 22763730
rq throughput                 : 0
update throughput             : 2528592
query throughput              : 22763730
total throughput              : 25292323

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=27.4734
PAPI_L3_TCM=9.37821
PAPI_TOT_CYC=5290.51
PAPI_TOT_INS=1297.42
garbage=1125453770680476
total_execution_walltime=14.451s
REALTIME_MAIN_END_PERF_FORMAT=6996981.185687678
[time_cmd_output] time_elapsed_sec=14.63, faults_major=0, faults_minor=234931, mem_maxresident_kb=941688, user_cputime=704.56, sys_cputime=3.18, percent_cpu=4836%
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=2