__step=000929
__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 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=data000929.txt
__path_data=data/data000929.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6990143.404815425
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=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=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.021s
prefilling_size=100098 prefilling_elapsed_millis=1.001s
finished prefilling to size 100088 for expected size 100000 keysum=10001742021, performing 50189605 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=100088
pref_millis=1102
prefill_elapsed_ms=1116
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=6990144.682267758
REALTIME_END_PERF_FORMAT=6990154.682430761

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

tree_stats_computeWalltime=0.034s

tree_stats_numInternalsAtDepth=1 1 1 2 4 8 16 32 64 128 241 448 818 1452 2362 3530 4818 6333 7957 9562 10692 10611 9616 8111 6533 5064 3849 2746 1778 1185 774 502 320 207 90 26 9 2 0
tree_stats_numLeavesAtDepth=0 1 1 0 0 0 0 0 0 0 15 34 78 184 542 1194 2242 3303 4709 6352 8432 10773 11606 11121 9689 8002 6279 4952 3714 2371 1596 1046 684 433 324 154 43 16 4
tree_stats_numNodesAtDepth=1 2 2 2 4 8 16 32 64 128 256 482 896 1636 2904 4724 7060 9636 12666 15914 19124 21384 21222 19232 16222 13066 10128 7698 5492 3556 2370 1548 1004 640 414 180 52 18 4
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 15 34 78 184 542 1194 2242 3303 4709 6352 8432 10773 11606 11121 9689 8002 6279 4952 3714 2371 1596 1046 684 433 324 154 43 16 4
tree_stats_avgDegreeAtDepth=2 1 1 2 2 2 2 2 2 2 1.94141 1.92946 1.91295 1.88753 1.81336 1.74725 1.68244 1.65722 1.62822 1.60085 1.55909 1.49621 1.45311 1.42175 1.40272 1.38757 1.38004 1.35672 1.32374 1.33324 1.32658 1.32429 1.31873 1.32344 1.21739 1.14444 1.17308 1.11111 1

tree_stats_height=39
tree_stats_numInternals=99893
tree_stats_numLeaves=99894
tree_stats_numNodes=199787
tree_stats_numKeys=99892

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

tree_stats_bytesAtDepth=40 80 80 80 160 320 640 1280 2560 5120 10240 19280 35840 65440 116160 188960 282400 385440 506640 636560 764960 855360 848880 769280 648880 522640 405120 307920 219680 142240 94800 61920 40160 25600 16560 7200 2080 720 160
tree_stats_sizeInBytes=7991480

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=29304

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:75 2:35 4:9 8:15 16:40 32:86 64:3678 128:283682 256:191890 512:82 1024:0 2048:0 4096:47 8192:47
    [2^00, 2^01]: 75
    (2^01, 2^02]: 35
    (2^02, 2^03]: 9
    (2^03, 2^04]: 15
    (2^04, 2^05]: 40
    (2^05, 2^06]: 86
    (2^06, 2^07]: 3678
    (2^07, 2^08]: 283682
    (2^08, 2^09]: 191890
    (2^09, 2^10]: 82
    (2^10, 2^11]: 0
    (2^11, 2^12]: 0
    (2^12, 2^13]: 47
    (2^13, 2^14]: 47
sum_limbo_reclamation_event_size_total=116229817
count_limbo_reclamation_event_size_by_thread=9992 9996 9994 9992 9994 9992 9992 9992 9994 9994 9992 9992 9992 9992 9992 9996 9990 9994 9996 9992 9996 9994 9994 9994 9992 9996 9996 9996 9992 9992 9992 9992 9994 9994 9996 9992 9996 9992 9994 9992 9994 9994 9992 9994 9994 9994 9992 9996
count_limbo_reclamation_event_size_total=479686
sum_limbo_reclamation_event_count_total=2548244
first_thread_announced_epoch_by_thread=58608 58608 58608 58608 58608 58608 58608 58608 58608 58608 58608 58608 58608 58608 58608 58608 58608 58608 58608 58608 58608 58608 58608 58608 58608 58608 58608 58608 58608 58608 58608 58608 58608 58608 58608 58608 58608 58608 58608 58608 58608 58608 58608 58608 58608 58608 58608 58608
sum_num_inserts_by_thread=5053059 5092975 5138326 5128818 5112157 5063148 5089346 5115313 5146600 5166643 5117751 5073532 5087209 5108274 5141839 5148782 5128782 5104832 5052340 5094422 5132081 5151140 5096824 5064761 5047732 5084385 5122243 5132644 5105815 5073334 5100294 5121174 5145124 5166698 5120383 5097263 5087050 5121847 5160404 5158975 5123232 5097455 5071669 5097905 5137634 5170114 5115842 5081855
sum_num_inserts_total=245350025
sum_num_deletes_by_thread=5053812 5094076 5142148 5131737 5107826 5056021 5088463 5116121 5148136 5171452 5120789 5071985 5081194 5105503 5141773 5147485 5126215 5106033 5057376 5093554 5134642 5150657 5092702 5066102 5047202 5085677 5123028 5133694 5107896 5071702 5099865 5120453 5147625 5162194 5115203 5093081 5083786 5122540 5164132 5160673 5118377 5105304 5072658 5096437 5137078 5166908 5116477 5079489
sum_num_deletes_total=245337281
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=10106871 10187051 10280474 10260555 10219983 10119169 10177809 10231434 10294736 10338095 10238540 10145517 10168403 10213777 10283612 10296267 10254997 10210865 10109716 10187976 10266723 10301797 10189526 10130863 10094934 10170062 10245271 10266338 10213711 10145036 10200159 10241627 10292749 10328892 10235586 10190344 10170836 10244387 10324536 10319648 10241609 10202759 10144327 10194342 10274712 10337022 10232319 10161344
average_num_operations_total=10222652
stdev_num_operations_total=9471
sum_num_operations_total=490687306
min_num_operations_total=10094934
max_num_operations_total=10338095
first_time_thread_terminate_by_thread=10000162 10000161 10000161 10000161 10000162 10000161 10000161 10000161 10000162 10000162 10000161 10000162 10000161 10000162 10000162 10000161 10000161 10000162 10000162 10000162 10000162 10000161 10000162 10000161 10000162 10000164 10000161 10000162 10000162 10000161 10000161 10000161 10000162 10000162 10000161 10000161 10000161 10000162 10000162 10000161 10000161 10000162 10000161 10000162 10000162 10000162 10000162 10000161
min_time_thread_terminate_total=10000161
max_time_thread_terminate_total=10000164
first_time_thread_start_by_thread=5 5 5 5 5 5 5 5 5 5 5 5 4 4 4 5 4 5 4 5 5 5 4 4 5 5 5 5 5 5 5 5 5 5 5 5 4 4 4 5 4 5 4 5 5 5 4 4
min_time_thread_start_total=4
max_time_thread_start_total=5
sum_duration_all_ops_total=

threads_final_keysum=9974325399
threads_final_size=99892
final_keysum=9974325399
final_size=99892
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=245350025
total_deletes=245337281
total_updates=490687306
total_queries=0
total_ops=490687306
find_throughput=0
rq_throughput=0
update_throughput=49068730
query_throughput=0
total_throughput=49068730


total find                    : 0
total rq                      : 0
total inserts                 : 245350025
total deletes                 : 245337281
total updates                 : 490687306
total queries                 : 0
total ops                     : 490687306
find throughput               : 0
rq throughput                 : 0
update throughput             : 49068730
query throughput              : 0
total throughput              : 49068730

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=21.2377
PAPI_L3_TCM=0.00896313
PAPI_TOT_CYC=2713.84
PAPI_TOT_INS=926.227
garbage=0
total_execution_walltime=11.425s
REALTIME_MAIN_END_PERF_FORMAT=6990154.830977292
[time_cmd_output] time_elapsed_sec=11.54, faults_major=0, faults_minor=92082, mem_maxresident_kb=354068, user_cputime=559.09, sys_cputime=5.20, percent_cpu=4889%
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=1