__step=000945
__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" ./natarajan_ext_bst_lf.debra -nwork 48 -nprefill 48 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 50.0 50.0 -k 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000945.txt
__path_data=data/data000945.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6990331.264684067
binary=./natarajan_ext_bst_lf.debra
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
DS_TYPENAME=natarajan_ext_bst_lf
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=50
DEL_FRAC=50
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=50.0 50.0
PREFILL_TYPE=PREFILL_HYBRID
PREFILL_HYBRID_MIN_MS=1000
PREFILL_HYBRID_MAX_MS=5000
sizes: node=32
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=99958 prefilling_elapsed_millis=1.001s
finished prefilling to size 99974 for expected size 100000 keysum=9992657606, performing 68382358 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=99974
pref_millis=1102
prefill_elapsed_ms=1122
6node_tIxPvE_object_size=32
6node_tIxPvE_allocated_count=0
6node_tIxPvE_allocated_size=0MB
6node_tIxPvE_get_from_pool=0
6node_tIxPvE_deallocated=0
6node_tIxPvE_limbo_count=0
6node_tIxPvE_limbo_details=0 0 0
global_epoch_counter=3435
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=6990332.546477983
REALTIME_END_PERF_FORMAT=6990342.546638338
###############################################################################
################################## 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 888 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 127 246 444 748 1242 2070 3119 4462 5996 7529 8969 9936 10237 9936 8974 7468 5811 4305 3128 2153 1361 803 461 235 92 31 4 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 1 8 48 140 254 414 1021 1776 2928 4463 6089 8002 9635 10538 10898 10480 9125 7317 5482 4103 2945 1919 1145 687 378 153 58 7 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 254 492 888 1496 2484 4140 6238 8924 11992 15058 17938 19872 20474 19872 17948 14936 11622 8610 6256 4306 2722 1606 922 470 184 62 8 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 1 8 48 140 254 414 1021 1776 2928 4463 6089 8002 9635 10538 10898 10480 9125 7317 5482 4103 2945 1919 1145 687 378 153 58 7 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 1.99219 1.9685 1.90244 1.84234 1.83021 1.83333 1.75338 1.71529 1.6719 1.62784 1.59563 1.55391 1.51515 1.4853 1.45159 1.41609 1.38906 1.37042 1.3633 1.34415 1.31607 1.295 1.28705 1.25488 1.19574 1.16848 1.06452 1.125 1
tree_stats_height=36
tree_stats_numInternals=100015
tree_stats_numLeaves=100016
tree_stats_numNodes=200031
tree_stats_numKeys=100016
tree_stats_avgDegreeInternal=2.00001
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=20.987
tree_stats_bytesAtDepth=32 64 128 256 512 1024 2048 4096 8128 15744 28416 47872 79488 132480 199616 285568 383744 481856 574016 635904 655168 635904 574336 477952 371904 275520 200192 137792 87104 51392 29504 15040 5888 1984 256 64
tree_stats_sizeInBytes=6400992
6node_tIxPvE_object_size=32
6node_tIxPvE_allocated_count=0
6node_tIxPvE_allocated_size=0MB
6node_tIxPvE_get_from_pool=0
6node_tIxPvE_deallocated=0
6node_tIxPvE_limbo_count=0
6node_tIxPvE_limbo_details=0 0 0
global_epoch_counter=36684
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:39 4:1 8:9 16:15 32:40 64:829 128:470243 256:8579 512:51 1024:4
(2^01, 2^02]: 39
(2^02, 2^03]: 1
(2^03, 2^04]: 9
(2^04, 2^05]: 15
(2^05, 2^06]: 40
(2^06, 2^07]: 829
(2^07, 2^08]: 470243
(2^08, 2^09]: 8579
(2^09, 2^10]: 51
(2^10, 2^11]: 4
sum_limbo_reclamation_event_size_total=99351524
count_limbo_reclamation_event_size_by_thread=9997 9997 9996 9994 9997 9995 9997 9994 9994 9995 9996 9996 9996 9996 9997 9995 9997 9996 9997 9995 9997 9996 9996 9996 9995 9997 9997 9996 9994 9998 9995 9994 9996 9997 9996 9997 9996 9996 9998 9996 9996 9996 9996 9997 9996 9996 9997 9996
count_limbo_reclamation_event_size_total=479810
sum_limbo_reclamation_event_count_total=1595245
first_thread_announced_epoch_by_thread=73368 73368 73368 73368 73368 73368 73368 73368 73368 73368 73368 73368 73368 73368 73368 73368 73368 73368 73368 73368 73368 73368 73368 73368 73368 73368 73368 73368 73368 73368 73368 73368 73368 73368 73368 73368 73368 73368 73368 73368 73368 73368 73368 73368 73368 73368 73368 73368
sum_num_inserts_by_thread=6804452 6845313 6908172 6909577 6882982 6819056 6835879 6866743 6935810 6958468 6894347 6857870 6848136 6872009 6930309 6955383 6899843 6858619 6823456 6849864 6908642 6929001 6870544 6825911 6807583 6830629 6891231 6890869 6888402 6833711 6838332 6863262 6945438 6953084 6885189 6855868 6835419 6878375 6919780 6945514 6895948 6871306 6822120 6864435 6899534 6958974 6870083 6839036
sum_num_inserts_total=330174508
sum_num_deletes_by_thread=6805547 6840112 6908510 6905233 6885076 6819885 6832781 6872645 6935567 6957185 6895838 6855558 6846719 6871072 6928426 6960877 6900604 6863082 6814983 6843634 6911773 6928842 6875137 6823456 6807170 6836243 6893357 6891415 6891848 6834652 6839477 6860994 6942971 6953250 6885970 6857734 6838525 6881296 6923906 6946288 6891929 6870698 6825495 6861907 6902398 6955331 6869578 6832385
sum_num_deletes_total=330177359
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=13609999 13685425 13816682 13814810 13768058 13638941 13668660 13739388 13871377 13915653 13790185 13713428 13694855 13743081 13858735 13916260 13800447 13721701 13638439 13693498 13820415 13857843 13745681 13649367 13614753 13666872 13784588 13782284 13780250 13668363 13677809 13724256 13888409 13906334 13771159 13713602 13673944 13759671 13843686 13891802 13787877 13742004 13647615 13726342 13801932 13914305 13739661 13671421
average_num_operations_total=13757330
stdev_num_operations_total=12626
sum_num_operations_total=660351867
min_num_operations_total=13609999
max_num_operations_total=13916260
first_time_thread_terminate_by_thread=10000159 10000159 10000160 10000159 10000159 10000160 10000159 10000159 10000159 10000159 10000159 10000159 10000160 10000159 10000160 10000159 10000159 10000160 10000159 10000159 10000160 10000159 10000159 10000159 10000159 10000159 10000160 10000159 10000159 10000160 10000159 10000159 10000159 10000159 10000159 10000159 10000160 10000159 10000160 10000159 10000159 10000160 10000159 10000159 10000160 10000159 10000159 10000160
min_time_thread_terminate_total=10000159
max_time_thread_terminate_total=10000160
first_time_thread_start_by_thread=4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4
min_time_thread_start_total=4
max_time_thread_start_total=4
sum_duration_all_ops_total=
threads_final_keysum=10006614314
threads_final_size=100016
final_keysum=10006614314
final_size=100016
validate_result=success
Validation OK.
Structural validation OK.
total_find=0
total_rq=0
total_inserts=330174508
total_deletes=330177359
total_updates=660351867
total_queries=0
total_ops=660351867
find_throughput=0
rq_throughput=0
update_throughput=66035186
query_throughput=0
total_throughput=66035186
total find : 0
total rq : 0
total inserts : 330174508
total deletes : 330177359
total updates : 660351867
total queries : 0
total ops : 660351867
find throughput : 0
rq throughput : 0
update throughput : 66035186
query throughput : 0
total throughput : 66035186
elapsed milliseconds : 10000
napping milliseconds overtime : 0
PAPI_L2_TCM=9.58161
PAPI_L3_TCM=0.000282422
PAPI_TOT_CYC=2016.25
PAPI_TOT_INS=850.7
garbage=0
total_execution_walltime=11.433s
REALTIME_MAIN_END_PERF_FORMAT=6990342.698345643
[time_cmd_output] time_elapsed_sec=11.54, faults_major=0, faults_minor=77476, mem_maxresident_kb=311804, user_cputime=560.44, sys_cputime=3.59, percent_cpu=4887%
timeout=false
algorithm=natarajan_ext_bst_lf.debra
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=1