__step=000258
__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" ./ellen_ext_bst_lf.debra -nwork 48 -nprefill 48 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 0.5 0.5 -k 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000258.txt
__path_data=data/data000258.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6981896.304500935
binary=./ellen_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=ellen_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=0.5
DEL_FRAC=0.5
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=0.5 0.5
PREFILL_TYPE=PREFILL_HYBRID
PREFILL_HYBRID_MIN_MS=1000
PREFILL_HYBRID_MAX_MS=5000
sizes: node=40 descriptor=64
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.005s
prefilling_size=99812 prefilling_elapsed_millis=1.001s
finished prefilling to size 99992 for expected size 100000 keysum=9970373027, performing 50122482 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=99992
pref_millis=1102
prefill_elapsed_ms=1120
6node_tIxPvE_object_size=40
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=2718

6info_tIxPvE_object_size=64
6info_tIxPvE_allocated_count=0
6info_tIxPvE_allocated_size=0MB
6info_tIxPvE_get_from_pool=0
6info_tIxPvE_deallocated=0
6info_tIxPvE_limbo_count=0
6info_tIxPvE_limbo_details=0 0 0 

global_epoch_counter=0

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6981897.597772654
REALTIME_END_PERF_FORMAT=6981907.597932583

###############################################################################
################################## 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 1008 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...

tree_stats_computeWalltime=0.047s

tree_stats_numInternalsAtDepth=1 1 1 2 4 8 16 32 64 128 256 504 936 1638 2711 4020 5499 7162 8676 9860 10390 10264 9535 8148 6569 5023 3535 2248 1358 767 394 187 96 59 36 12 2 1 0
tree_stats_numLeavesAtDepth=0 1 1 0 0 0 0 0 0 0 0 8 72 234 565 1402 2541 3836 5648 7492 9330 10516 10993 10922 9727 8115 6511 4822 3138 1949 1140 601 278 133 82 60 22 3 2
tree_stats_numNodesAtDepth=1 2 2 2 4 8 16 32 64 128 256 512 1008 1872 3276 5422 8040 10998 14324 17352 19720 20780 20528 19070 16296 13138 10046 7070 4496 2716 1534 788 374 192 118 72 24 4 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 0 8 72 234 565 1402 2541 3836 5648 7492 9330 10516 10993 10922 9727 8115 6511 4822 3138 1949 1140 601 278 133 82 60 22 3 2
tree_stats_avgDegreeAtDepth=2 1 1 2 2 2 2 2 2 2 2 1.98438 1.92857 1.875 1.82753 1.74142 1.68396 1.65121 1.6057 1.56823 1.52688 1.49394 1.46449 1.42727 1.40311 1.38233 1.35188 1.31796 1.30205 1.2824 1.25684 1.23731 1.25668 1.30729 1.30508 1.16667 1.08333 1.25 1

tree_stats_height=39
tree_stats_numInternals=100143
tree_stats_numLeaves=100144
tree_stats_numNodes=200287
tree_stats_numKeys=100142

tree_stats_avgDegreeInternal=2.00001
tree_stats_avgDegreeLeaves=0.99998
tree_stats_avgDegree=1.49999
tree_stats_avgKeyDepth=22.323

tree_stats_bytesAtDepth=40 80 80 80 160 320 640 1280 2560 5120 10240 20480 40320 74880 131040 216880 321600 439920 572960 694080 788800 831200 821120 762800 651840 525520 401840 282800 179840 108640 61360 31520 14960 7680 4720 2880 960 160 80
tree_stats_sizeInBytes=8011480

6node_tIxPvE_object_size=40
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=46155

6info_tIxPvE_object_size=64
6info_tIxPvE_allocated_count=0
6info_tIxPvE_allocated_size=0MB
6info_tIxPvE_get_from_pool=0
6info_tIxPvE_deallocated=0
6info_tIxPvE_limbo_count=0
6info_tIxPvE_limbo_details=0 0 0 

global_epoch_counter=0


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:81927 2:194382 4:140393 8:15479 16:122 32:5
    [2^00, 2^01]: 81927
    (2^01, 2^02]: 194382
    (2^02, 2^03]: 140393
    (2^03, 2^04]: 15479
    (2^04, 2^05]: 122
    (2^05, 2^06]: 5
sum_limbo_reclamation_event_size_total=1387447
count_limbo_reclamation_event_size_by_thread=8962 9020 9104 9028 9058 8966 8998 8960 9042 8956 9074 8952 9004 9060 8972 9066 8994 8946 9058 8956 9026 9074 9050 8996 8942 8998 9022 8998 8944 8976 9014 8972 9094 8982 9004 8964 8954 9050 9048 8986 9038 8960 8980 8936 9086 9028 9008 9002
count_limbo_reclamation_event_size_total=432308
sum_limbo_reclamation_event_count_total=4169946
first_thread_announced_epoch_by_thread=92310 92310 92310 92310 92310 92310 92310 92310 92310 92310 92310 92310 92310 92310 92310 92310 92310 92310 92310 92310 92310 92310 92310 92310 92310 92310 92310 92310 92310 92310 92310 92310 92310 92310 92310 92310 92310 92310 92310 92310 92310 92310 92310 92310 92310 92310 92310 92310
sum_num_inserts_by_thread=98897 99903 101192 100962 100731 98675 99588 100184 101165 101964 100949 100368 100104 100579 102179 101791 100800 100382 98726 99444 100970 101066 100572 99048 97732 99560 101171 101766 100914 99171 99761 100322 102150 101814 100735 100036 99746 101042 101989 102409 100265 99236 98386 99596 100808 101367 101068 100015
sum_num_inserts_total=4821298
sum_num_deletes_by_thread=98904 100084 101449 101368 100776 98904 99583 100253 101160 101649 101433 100142 99851 101197 101284 101433 100815 100014 99215 99535 100639 101325 100314 98505 98226 99158 100814 101256 100819 99400 99781 100919 101663 101678 99993 99925 99531 100767 101593 101407 100812 99513 98518 99724 101706 101094 100909 99575
sum_num_deletes_total=4818613
sum_num_searches_by_thread=19637898 19788667 20041148 20044877 19981252 19577822 19697488 19882937 20069280 20240208 19906886 19814848 19798517 19940123 20127236 20115272 19966904 19843964 19640127 19781621 20006366 20079604 19864228 19600561 19434695 19748644 19992744 20073993 19966261 19676136 19831149 19932155 20196217 20173699 19850936 19765653 19804812 19913228 20125462 20155925 19893817 19727795 19484902 19718012 19973445 20069573 19912681 19653755
sum_num_searches_total=954523523
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=19835699 19988654 20243789 20247207 20182759 19775401 19896659 20083374 20271605 20443821 20109268 20015358 19998472 20141899 20330699 20318496 20168519 20044360 19838068 19980600 20207975 20281995 20065114 19798114 19630653 19947362 20194729 20277015 20167994 19874707 20030691 20133396 20400030 20377191 20051664 19965614 20004089 20115037 20329044 20359741 20094894 19926544 19681806 19917332 20175959 20272034 20114658 19853345
average_num_operations_total=20086738
stdev_num_operations_total=28245
sum_num_operations_total=964163434
min_num_operations_total=19630653
max_num_operations_total=20443821
first_time_thread_terminate_by_thread=10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000159
min_time_thread_terminate_total=10000159
max_time_thread_terminate_total=10000159
first_time_thread_start_by_thread=4 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 4 3 4 3 3 3 3 4 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 4 3 3 3 3
min_time_thread_start_total=3
max_time_thread_start_total=4
sum_duration_all_ops_total=

threads_final_keysum=10008574894
threads_final_size=100142
final_keysum=10008574894
final_size=100142
validate_result=success
Validation OK.
Structural validation OK.

total_find=954523523
total_rq=0
total_inserts=4821298
total_deletes=4818613
total_updates=9639911
total_queries=954523523
total_ops=964163434
find_throughput=95452352
rq_throughput=0
update_throughput=963991
query_throughput=95452352
total_throughput=96416343


total find                    : 954523523
total rq                      : 0
total inserts                 : 4821298
total deletes                 : 4818613
total updates                 : 9639911
total queries                 : 954523523
total ops                     : 964163434
find throughput               : 95452352
rq throughput                 : 0
update throughput             : 963991
query throughput              : 95452352
total throughput              : 96416343

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=9.57308
PAPI_L3_TCM=0.000660647
PAPI_TOT_CYC=1388.41
PAPI_TOT_INS=308.828
garbage=47711098900524
total_execution_walltime=11.425s
REALTIME_MAIN_END_PERF_FORMAT=6981907.730949491
[time_cmd_output] time_elapsed_sec=11.56, faults_major=0, faults_minor=78229, mem_maxresident_kb=313600, user_cputime=562.13, sys_cputime=4.47, percent_cpu=4900%
timeout=false
algorithm=ellen_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=2