__step=000705
__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 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000705.txt
__path_data=data/data000705.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6987372.510283989
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=20000000
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.019s
prefilling_size=6104646 prefilling_elapsed_millis=1.001s
prefilling_size=6388937 prefilling_elapsed_millis=1.101s
prefilling_size=6651453 prefilling_elapsed_millis=1.201s
prefilling_size=6889859 prefilling_elapsed_millis=1.301s
prefilling_size=7108078 prefilling_elapsed_millis=1.402s
prefilling_size=7309055 prefilling_elapsed_millis=1.502s
prefilling_size=7494096 prefilling_elapsed_millis=1.602s
prefilling_size=7664361 prefilling_elapsed_millis=1.702s
prefilling_size=7822383 prefilling_elapsed_millis=1.802s
prefilling_size=7967980 prefilling_elapsed_millis=1.903s
prefilling_size=8103565 prefilling_elapsed_millis=2.003s
prefilling_size=8228559 prefilling_elapsed_millis=2.103s
prefilling_size=8344363 prefilling_elapsed_millis=2.203s
prefilling_size=8450408 prefilling_elapsed_millis=2.303s
prefilling_size=8549457 prefilling_elapsed_millis=2.404s
prefilling_size=8642162 prefilling_elapsed_millis=2.504s
prefilling_size=8729681 prefilling_elapsed_millis=2.604s
prefilling_size=8811557 prefilling_elapsed_millis=2.704s
prefilling_size=8887184 prefilling_elapsed_millis=2.804s
prefilling_size=8957545 prefilling_elapsed_millis=2.905s
prefilling_size=9022714 prefilling_elapsed_millis=3.005s
prefilling_size=9083446 prefilling_elapsed_millis=3.105s
prefilling_size=9139363 prefilling_elapsed_millis=3.205s
prefilling_size=9192396 prefilling_elapsed_millis=3.305s
prefilling_size=9241910 prefilling_elapsed_millis=3.406s
prefilling_size=9288364 prefilling_elapsed_millis=3.506s
prefilling_size=9333254 prefilling_elapsed_millis=3.606s
prefilling_size=9373713 prefilling_elapsed_millis=3.706s
prefilling_size=9411636 prefilling_elapsed_millis=3.806s
prefilling_size=9447663 prefilling_elapsed_millis=3.907s
prefilling_size=9479726 prefilling_elapsed_millis=4.007s
prefilling_size=9512260 prefilling_elapsed_millis=4.107s
prefilling_size=9540951 prefilling_elapsed_millis=4.207s
prefilling_size=9567629 prefilling_elapsed_millis=4.307s
prefilling_size=9593071 prefilling_elapsed_millis=4.408s
prefilling_size=9616896 prefilling_elapsed_millis=4.508s
prefilling_size=9639827 prefilling_elapsed_millis=4.608s
prefilling_size=9662295 prefilling_elapsed_millis=4.708s
prefilling_size=9683438 prefilling_elapsed_millis=4.808s
prefilling_size=9700804 prefilling_elapsed_millis=4.909s
prefilling_size=9716645 prefilling_elapsed_millis=5.009s
Info: prefilling requires an additional insert phase to complete.
Info: prefilling using INSERTION ONLY.
timing_start inserting 283307 keys with 48 threads...
tid=0 thread_prefill_amount=166640 percent_done_estimate=2823.3 elapsed_s=5 est_remaining_s=-11 / -6
timing_elapsed 0.0458991s
prefilling_size=10000000 prefilling_elapsed_millis=0.046s
finished prefilling to size 10000000 for expected size 10000000 keysum=99987362092471, performing 80304594 updates; total_prefilling_elapsed_ms=46 ms)
pref_size=10000000
pref_millis=46
prefill_elapsed_ms=46
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=27545
6node_tIxPvE_limbo_details=9283 9909 8353 

global_epoch_counter=3731

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=27545
6info_tIxPvE_limbo_details=9283 9909 8353 

global_epoch_counter=0

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6987377.880159463
REALTIME_END_PERF_FORMAT=6987387.880241018

###############################################################################
################################## TIME IS UP #################################
###############################################################################

joining threads...
###############################################################################
################################# END RUNNING #################################
###############################################################################

10.1s
PRODUCING OUTPUT
computing tree_stats in PARALLEL...
bounded depth BFS to partition into subtrees for parallel computation (48 threads)...
partitioned into 256 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...

tree_stats_computeWalltime=0.204s

tree_stats_numInternalsAtDepth=1 1 1 2 4 8 16 32 64 128 256 511 1006 1967 3755 6973 12629 22072 37052 60240 93893 141022 203478 280928 370908 466990 563280 650487 720239 763004 775960 759036 716802 651443 573522 488291 401887 321397 249298 188474 138975 101626 73156 52094 36092 24679 16634 10724 6790 4038 2242 1265 713 447 270 153 89 54 24 11 6 0
tree_stats_numLeavesAtDepth=0 1 1 0 0 0 0 0 0 0 0 1 16 45 179 537 1317 3186 7092 13864 26587 46764 78566 126028 190948 274826 370700 476073 580735 677474 750048 792884 801270 782161 729364 658753 574695 482377 393496 310122 237973 176324 130096 94218 68096 47505 32724 22544 14658 9542 5834 3219 1817 979 624 387 217 124 84 37 16 12
tree_stats_numNodesAtDepth=1 2 2 2 4 8 16 32 64 128 256 512 1022 2012 3934 7510 13946 25258 44144 74104 120480 187786 282044 406956 561856 741816 933980 1126560 1300974 1440478 1526008 1551920 1518072 1433604 1302886 1147044 976582 803774 642794 498596 376948 277950 203252 146312 104188 72184 49358 33268 21448 13580 8076 4484 2530 1426 894 540 306 178 108 48 22 12
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 0 1 16 45 179 537 1317 3186 7092 13864 26587 46764 78566 126028 190948 274826 370700 476073 580735 677474 750048 792884 801270 782161 729364 658753 574695 482377 393496 310122 237973 176324 130096 94218 68096 47505 32724 22544 14658 9542 5834 3219 1817 979 624 387 217 124 84 37 16 12
tree_stats_avgDegreeAtDepth=2 1 1 2 2 2 2 2 2 2 2 1.99805 1.98434 1.97763 1.9545 1.9285 1.90556 1.87386 1.83934 1.81291 1.77932 1.75097 1.72144 1.69032 1.66015 1.62952 1.6031 1.57741 1.55362 1.52969 1.50849 1.48909 1.47218 1.45441 1.44019 1.4257 1.41152 1.39986 1.38783 1.37801 1.36868 1.36563 1.35993 1.35605 1.34641 1.34189 1.33701 1.32235 1.31658 1.29735 1.27761 1.28211 1.28182 1.31346 1.30201 1.28333 1.29085 1.30337 1.22222 1.22917 1.27273 1

tree_stats_height=62
tree_stats_numInternals=9997139
tree_stats_numLeaves=9997140
tree_stats_numNodes=19994279
tree_stats_numKeys=9997138

tree_stats_avgDegreeInternal=2
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=32.4355

tree_stats_bytesAtDepth=40 80 80 80 160 320 640 1280 2560 5120 10240 20480 40880 80480 157360 300400 557840 1010320 1765760 2964160 4819200 7511440 11281760 16278240 22474240 29672640 37359200 45062400 52038960 57619120 61040320 62076800 60722880 57344160 52115440 45881760 39063280 32150960 25711760 19943840 15077920 11118000 8130080 5852480 4167520 2887360 1974320 1330720 857920 543200 323040 179360 101200 57040 35760 21600 12240 7120 4320 1920 880 480
tree_stats_sizeInBytes=799771160

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

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:0 2:0 4:0 8:0 16:6 32:70 64:42 128:238917 256:240965
    (2^04, 2^05]: 6
    (2^05, 2^06]: 70
    (2^06, 2^07]: 42
    (2^07, 2^08]: 238917
    (2^08, 2^09]: 240965
sum_limbo_reclamation_event_size_total=135714364
count_limbo_reclamation_event_size_by_thread=10000 10000 10000 10000 10000 10000 10000 10000 10000 10000 10000 10000 10000 10000 10000 10000 10000 10000 10000 10000 10000 10000 10000 10000 10000 10000 10000 10000 10000 10000 10000 10000 10000 10000 10000 10000 10000 10000 10000 10000 10000 10000 10000 10000 10000 10000 10000 10000
count_limbo_reclamation_event_size_total=480000
sum_limbo_reclamation_event_count_total=660646
first_thread_announced_epoch_by_thread=21224 21224 21224 21224 21224 21224 21224 21224 21224 21224 21224 21224 21224 21224 21224 21224 21224 21224 21224 21224 21224 21224 21224 21224 21224 21224 21224 21224 21224 21224 21224 21224 21224 21224 21224 21224 21224 21224 21224 21224 21224 21224 21224 21224 21224 21224 21224 21224
sum_num_inserts_by_thread=1544573 1555953 1566382 1562311 1558549 1545012 1549943 1551272 1566910 1568853 1554345 1548577 1556726 1563479 1567651 1569052 1558457 1548684 1540664 1551429 1557772 1565352 1548846 1535254 1546318 1536547 1563467 1560957 1558971 1542999 1551801 1555959 1568535 1567785 1554264 1544104 1552110 1559557 1568062 1564449 1556577 1546286 1543497 1547291 1559499 1562933 1546990 1539611
sum_num_inserts_total=74634615
sum_num_deletes_by_thread=1545768 1554809 1566200 1562956 1559552 1544037 1551501 1553451 1567018 1571949 1553685 1545438 1552869 1560834 1569923 1566468 1559431 1547402 1541386 1551284 1560138 1564979 1548279 1536371 1546957 1536768 1564118 1561803 1558820 1542458 1548414 1555537 1566941 1566674 1553920 1544951 1553430 1558826 1571122 1565409 1557353 1546398 1543489 1547926 1559339 1563161 1548568 1539598
sum_num_deletes_total=74637708
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=3090341 3110762 3132582 3125267 3118101 3089049 3101444 3104723 3133928 3140802 3108030 3094015 3109595 3124313 3137574 3135520 3117888 3096086 3082050 3102713 3117910 3130331 3097125 3071625 3093275 3073315 3127585 3122760 3117791 3085457 3100215 3111496 3135476 3134459 3108184 3089055 3105540 3118383 3139184 3129858 3113930 3092684 3086986 3095217 3118838 3126094 3095558 3079209
average_num_operations_total=3109840
stdev_num_operations_total=2755
sum_num_operations_total=149272323
min_num_operations_total=3071625
max_num_operations_total=3140802
first_time_thread_terminate_by_thread=10000138 10000082 10000081 10000082 10000082 10000083 10000081 10000081 10000082 10000082 10000082 10000083 10000081 10000081 10000082 10000083 10000081 10000083 10000082 10000081 10000082 10000083 10000083 10000081 10000081 10000082 10000083 10000083 10000082 10000082 10000081 10000081 10000081 10000081 10000084 10000082 10000082 10000081 10000081 10000083 10000089 10000104 10000081 10000083 10000082 10000082 10000081 10000083
min_time_thread_terminate_total=10000081
max_time_thread_terminate_total=10000138
first_time_thread_start_by_thread=10 6 5 6 5 5 5 5 5 5 5 6 5 5 5 5 5 5 5 6 6 5 5 5 4 5 5 6 5 5 5 5 5 5 5 6 5 5 5 5 5 5 5 6 6 5 5 5
min_time_thread_start_total=4
max_time_thread_start_total=10
sum_duration_all_ops_total=

threads_final_keysum=99949405968528
threads_final_size=9997138
final_keysum=99949405968528
final_size=9997138
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=74634615
total_deletes=74637708
total_updates=149272323
total_queries=0
total_ops=149272323
find_throughput=0
rq_throughput=0
update_throughput=14927232
query_throughput=0
total_throughput=14927232


total find                    : 0
total rq                      : 0
total inserts                 : 74634615
total deletes                 : 74637708
total updates                 : 149272323
total queries                 : 0
total ops                     : 149272323
find throughput               : 0
rq throughput                 : 0
update throughput             : 14927232
query throughput              : 0
total throughput              : 14927232

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

PAPI_L2_TCM=55.7362
PAPI_L3_TCM=19.9397
PAPI_TOT_CYC=8944.1
PAPI_TOT_INS=1177.71
garbage=0
total_execution_walltime=15.726s
REALTIME_MAIN_END_PERF_FORMAT=6987388.260401268
[time_cmd_output] time_elapsed_sec=15.99, faults_major=0, faults_minor=504704, mem_maxresident_kb=2018920, user_cputime=739.40, sys_cputime=3.40, percent_cpu=4642%
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