__step=000209
__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=data000209.txt
__path_data=data/data000209.txt
__hostname=jax
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x564bf5fa1400
addrof(kcasDescriptors[1])=0x564bf5fa1d00
addrof(rdcssDescriptors[0])=0x564bf60c1400
addrof(rdcssDescriptors[1])=0x564bf60c14c0
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=6996951.905068043
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.006s
prefilling_size=6707782 prefilling_elapsed_millis=1.001s
prefilling_size=7012080 prefilling_elapsed_millis=1.101s
prefilling_size=7287096 prefilling_elapsed_millis=1.201s
prefilling_size=7535537 prefilling_elapsed_millis=1.301s
prefilling_size=7761096 prefilling_elapsed_millis=1.402s
prefilling_size=7963930 prefilling_elapsed_millis=1.502s
prefilling_size=8149721 prefilling_elapsed_millis=1.602s
prefilling_size=8316452 prefilling_elapsed_millis=1.702s
prefilling_size=8467632 prefilling_elapsed_millis=1.802s
prefilling_size=8606141 prefilling_elapsed_millis=1.903s
prefilling_size=8731668 prefilling_elapsed_millis=2.003s
prefilling_size=8846279 prefilling_elapsed_millis=2.103s
prefilling_size=8949523 prefilling_elapsed_millis=2.203s
prefilling_size=9042544 prefilling_elapsed_millis=2.304s
prefilling_size=9126979 prefilling_elapsed_millis=2.404s
prefilling_size=9205416 prefilling_elapsed_millis=2.504s
prefilling_size=9274483 prefilling_elapsed_millis=2.604s
prefilling_size=9338379 prefilling_elapsed_millis=2.704s
prefilling_size=9398294 prefilling_elapsed_millis=2.805s
prefilling_size=9451674 prefilling_elapsed_millis=2.905s
prefilling_size=9501235 prefilling_elapsed_millis=3.005s
prefilling_size=9543462 prefilling_elapsed_millis=3.105s
prefilling_size=9583278 prefilling_elapsed_millis=3.205s
prefilling_size=9618989 prefilling_elapsed_millis=3.305s
prefilling_size=9650997 prefilling_elapsed_millis=3.406s
prefilling_size=9683037 prefilling_elapsed_millis=3.506s
prefilling_size=9711753 prefilling_elapsed_millis=3.606s
prefilling_size=9735865 prefilling_elapsed_millis=3.706s
prefilling_size=9758015 prefilling_elapsed_millis=3.806s
prefilling_size=9779295 prefilling_elapsed_millis=3.907s
prefilling_size=9799027 prefilling_elapsed_millis=4.007s
prefilling_size=9817532 prefilling_elapsed_millis=4.107s
finished prefilling to size 9817550 for expected size 10000000 keysum=98171836716213, performing 81168891 updates; total_prefilling_elapsed_ms=4208 ms)
pref_size=9817550
pref_millis=4208
prefill_elapsed_ms=4235
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6996956.330296102
REALTIME_END_PERF_FORMAT=6996966.330453311

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

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131068 261960 518247 955921 1399862 1350287 743486 198264 18688 246 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 4 164 5080 69232 417757 1120408 1439922 905389 252881 23578 288
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262124 523327 1025153 1817619 2470695 2183408 1103653 271569 23824 288
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262124 523327 1025153 1817619 2470695 2183408 1103653 271569 23824 288
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99988 1.99711 1.96862 1.84056 1.58914 1.3372 1.16496 1.06642 1.01891 1.00176 1

tree_stats_height=28
tree_stats_numInternals=5709100
tree_stats_numLeaves=4234703
tree_stats_numNodes=9943803
tree_stats_numKeys=9943803

tree_stats_avgDegreeInternal=1.74175
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.42586
tree_stats_avgKeyDepth=21.7227


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:48 2:1512 4:54251 8:373500 16:50588
    [2^00, 2^01]: 48
    (2^01, 2^02]: 1512
    (2^02, 2^03]: 54251
    (2^03, 2^04]: 373500
    (2^04, 2^05]: 50588
sum_limbo_reclamation_event_size_total=5442325
count_limbo_reclamation_event_size_by_thread=9998 9997 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 9997 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9997 9998 9998 9998 9998 9997
count_limbo_reclamation_event_size_total=479899
sum_limbo_reclamation_event_count_total=550272
first_thread_announced_epoch_by_thread=30398 30398 30398 30398 30398 30398 30398 30398 30398 30398 30398 30398 30398 30398 30398 30398 30398 30398 30398 30398 30398 30398 30398 30398 30398 30398 30398 30398 30398 30398 30398 30398 30398 30398 30398 30398 30398 30398 30398 30398 30398 30398 30398 30398 30398 30398 30398 30398
sum_num_inserts_by_thread=262494 262941 263618 263916 262449 260454 261371 262433 264298 264999 262785 260306 261934 264072 265055 265199 262581 262339 260231 261478 263514 263587 260862 260462 261106 261839 265667 262805 263684 260795 262651 262324 264329 265922 262805 261647 262339 262537 265586 265323 263772 260997 260101 262406 264628 263270 261591 261250
sum_num_inserts_total=12612752
sum_num_deletes_by_thread=262404 263576 264550 263676 263075 260772 260296 261781 264433 266878 263175 260168 261330 264148 266509 264375 261889 262967 260682 261518 263142 263708 261667 260958 260994 262233 263818 263355 264258 261963 262703 262485 265113 265530 262453 260068 262899 262203 265826 265171 263943 261557 261288 262801 265011 263790 261694 260113
sum_num_deletes_total=12618946
sum_num_searches_by_thread=4713587 4736866 4751269 4743431 4724222 4682380 4699892 4716525 4761949 4790187 4735883 4687866 4707703 4751664 4779937 4757965 4733565 4718719 4678654 4706191 4736566 4749433 4704856 4686558 4699025 4721005 4769200 4749183 4745448 4711288 4724245 4723240 4764409 4787434 4712313 4694155 4726088 4733790 4784055 4776041 4748505 4700183 4694715 4722563 4752765 4755998 4723656 4691104
sum_num_searches_total=227066276
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=5238485 5263383 5279437 5271023 5249746 5203606 5221559 5240739 5290680 5322064 5261843 5208340 5230967 5279884 5311501 5287539 5258035 5244025 5199567 5229187 5263222 5276728 5227385 5207978 5221125 5245077 5298685 5275343 5273390 5234046 5249599 5248049 5293851 5318886 5237571 5215870 5251326 5258530 5315467 5306535 5276220 5222737 5216104 5247770 5282404 5283058 5246941 5212467
average_num_operations_total=5256207
stdev_num_operations_total=4785
sum_num_operations_total=252297974
min_num_operations_total=5199567
max_num_operations_total=5322064
first_time_thread_terminate_by_thread=10000157 10000157 10000157 10000156 10000156 10000156 10000156 10000156 10000156 10000156 10000156 10000157 10000157 10000157 10000156 10000157 10000156 10000156 10000156 10000157 10000156 10000156 10000157 10000156 10000157 10000156 10000156 10000156 10000157 10000156 10000156 10000156 10000156 10000156 10000156 10000157 10000157 10000157 10000156 10000157 10000156 10000156 10000156 10000157 10000156 10000156 10000157 10000156
min_time_thread_terminate_total=10000156
max_time_thread_terminate_total=10000157
first_time_thread_start_by_thread=4 5 4 5 4 4 4 5 4 4 4 4 5 5 4 4 5 4 4 4 4 4 4 4 4 5 4 5 4 4 4 5 4 4 4 4 5 5 4 4 5 4 4 4 4 4 4 4
min_time_thread_start_total=4
max_time_thread_start_total=5
sum_duration_all_ops_total=

threads_final_keysum=99449121246763
threads_final_size=9943803
final_keysum=99449121246763
final_size=9943803
validate_result=success
Validation OK.
Structural validation OK.

total_find=227066276
total_rq=0
total_inserts=12612752
total_deletes=12618946
total_updates=25231698
total_queries=227066276
total_ops=252297974
find_throughput=22706627
rq_throughput=0
update_throughput=2523169
query_throughput=22706627
total_throughput=25229797


total find                    : 227066276
total rq                      : 0
total inserts                 : 12612752
total deletes                 : 12618946
total updates                 : 25231698
total queries                 : 227066276
total ops                     : 252297974
find throughput               : 22706627
rq throughput                 : 0
update throughput             : 2523169
query throughput              : 22706627
total throughput              : 25229797

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=27.4689
PAPI_L3_TCM=9.38394
PAPI_TOT_CYC=5303.4
PAPI_TOT_INS=1297.87
garbage=1123795834412342
total_execution_walltime=14.549s
REALTIME_MAIN_END_PERF_FORMAT=6996966.477735365
[time_cmd_output] time_elapsed_sec=14.75, faults_major=0, faults_minor=234947, mem_maxresident_kb=941708, user_cputime=710.41, sys_cputime=2.39, percent_cpu=4829%
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