__step=000706
__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=data000706.txt
__path_data=data/data000706.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6987388.592132968
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.009s
prefilling_size=6198046 prefilling_elapsed_millis=1.001s
prefilling_size=6493059 prefilling_elapsed_millis=1.101s
prefilling_size=6761613 prefilling_elapsed_millis=1.201s
prefilling_size=7008351 prefilling_elapsed_millis=1.301s
prefilling_size=7232650 prefilling_elapsed_millis=1.402s
prefilling_size=7440541 prefilling_elapsed_millis=1.502s
prefilling_size=7633107 prefilling_elapsed_millis=1.602s
prefilling_size=7808731 prefilling_elapsed_millis=1.702s
prefilling_size=7970636 prefilling_elapsed_millis=1.802s
prefilling_size=8119558 prefilling_elapsed_millis=1.903s
prefilling_size=8256441 prefilling_elapsed_millis=2.003s
prefilling_size=8382769 prefilling_elapsed_millis=2.103s
prefilling_size=8499980 prefilling_elapsed_millis=2.203s
prefilling_size=8608315 prefilling_elapsed_millis=2.304s
prefilling_size=8709112 prefilling_elapsed_millis=2.404s
prefilling_size=8803036 prefilling_elapsed_millis=2.504s
prefilling_size=8889221 prefilling_elapsed_millis=2.604s
prefilling_size=8968593 prefilling_elapsed_millis=2.704s
prefilling_size=9043546 prefilling_elapsed_millis=2.805s
prefilling_size=9111560 prefilling_elapsed_millis=2.905s
prefilling_size=9175403 prefilling_elapsed_millis=3.005s
prefilling_size=9233255 prefilling_elapsed_millis=3.105s
prefilling_size=9288372 prefilling_elapsed_millis=3.205s
prefilling_size=9339866 prefilling_elapsed_millis=3.306s
prefilling_size=9387434 prefilling_elapsed_millis=3.406s
prefilling_size=9431954 prefilling_elapsed_millis=3.506s
prefilling_size=9471879 prefilling_elapsed_millis=3.606s
prefilling_size=9509366 prefilling_elapsed_millis=3.706s
prefilling_size=9545229 prefilling_elapsed_millis=3.807s
prefilling_size=9577027 prefilling_elapsed_millis=3.907s
prefilling_size=9607595 prefilling_elapsed_millis=4.007s
prefilling_size=9635142 prefilling_elapsed_millis=4.107s
prefilling_size=9659796 prefilling_elapsed_millis=4.207s
prefilling_size=9683924 prefilling_elapsed_millis=4.308s
prefilling_size=9705878 prefilling_elapsed_millis=4.408s
prefilling_size=9727854 prefilling_elapsed_millis=4.508s
prefilling_size=9746486 prefilling_elapsed_millis=4.608s
prefilling_size=9764456 prefilling_elapsed_millis=4.708s
prefilling_size=9780674 prefilling_elapsed_millis=4.809s
prefilling_size=9795849 prefilling_elapsed_millis=4.909s
prefilling_size=9810847 prefilling_elapsed_millis=5.009s
finished prefilling to size 9810885 for expected size 10000000 keysum=98112892344019, performing 79548708 updates; total_prefilling_elapsed_ms=5110 ms)
pref_size=9810885
pref_millis=5110
prefill_elapsed_ms=5133
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=3691

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=6987393.886350467
REALTIME_END_PERF_FORMAT=6987403.886504639

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

tree_stats_computeWalltime=0.158s

tree_stats_numInternalsAtDepth=1 1 1 2 4 8 16 31 58 104 196 385 764 1492 2859 5311 9564 16567 27676 44369 68619 103322 150310 211188 285688 370547 461764 551825 634239 698757 740758 755538 744251 708894 652182 581092 500726 418272 338150 265315 201202 147242 104272 71764 48237 31186 19612 11657 6440 3435 1689 761 334 152 65 27 12 3 1 0
tree_stats_numLeavesAtDepth=0 1 1 0 0 0 0 1 4 12 12 7 6 36 125 407 1058 2561 5458 10983 20119 33916 56334 89432 136688 200829 279330 371703 469411 569721 656756 725978 766825 779608 765606 723272 661458 583180 498394 410985 329428 255162 190212 136780 95291 65288 42760 27567 16874 9445 5181 2617 1188 516 239 103 42 21 5 2
tree_stats_numNodesAtDepth=1 2 2 2 4 8 16 32 62 116 208 392 770 1528 2984 5718 10622 19128 33134 55352 88738 137238 206644 300620 422376 571376 741094 923528 1103650 1268478 1397514 1481516 1511076 1488502 1417788 1304364 1162184 1001452 836544 676300 530630 402404 294484 208544 143528 96474 62372 39224 23314 12880 6870 3378 1522 668 304 130 54 24 6 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 1 4 12 12 7 6 36 125 407 1058 2561 5458 10983 20119 33916 56334 89432 136688 200829 279330 371703 469411 569721 656756 725978 766825 779608 765606 723272 661458 583180 498394 410985 329428 255162 190212 136780 95291 65288 42760 27567 16874 9445 5181 2617 1188 516 239 103 42 21 5 2
tree_stats_avgDegreeAtDepth=2 1 1 2 2 2 2 1.96875 1.93548 1.89655 1.94231 1.98214 1.99221 1.97644 1.95811 1.92882 1.9004 1.86611 1.83527 1.80158 1.77328 1.75287 1.72739 1.70251 1.67638 1.64852 1.62308 1.59752 1.57467 1.55086 1.53005 1.50998 1.49253 1.47625 1.46 1.4455 1.43085 1.41767 1.40422 1.3923 1.37918 1.36591 1.35408 1.34412 1.33608 1.32326 1.31444 1.29719 1.27623 1.26669 1.24585 1.22528 1.21945 1.22754 1.21382 1.20769 1.22222 1.125 1.16667 1

tree_stats_height=60
tree_stats_numInternals=9998937
tree_stats_numLeaves=9998938
tree_stats_numNodes=19997875
tree_stats_numKeys=9998936

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

tree_stats_bytesAtDepth=40 80 80 80 160 320 640 1280 2480 4640 8320 15680 30800 61120 119360 228720 424880 765120 1325360 2214080 3549520 5489520 8265760 12024800 16895040 22855040 29643760 36941120 44146000 50739120 55900560 59260640 60443040 59540080 56711520 52174560 46487360 40058080 33461760 27052000 21225200 16096160 11779360 8341760 5741120 3858960 2494880 1568960 932560 515200 274800 135120 60880 26720 12160 5200 2160 960 240 80
tree_stats_sizeInBytes=799915000

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

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:0 32:0 64:4 128:239072 256:240732
    (2^06, 2^07]: 4
    (2^07, 2^08]: 239072
    (2^08, 2^09]: 240732
sum_limbo_reclamation_event_size_total=134690151
count_limbo_reclamation_event_size_by_thread=9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996
count_limbo_reclamation_event_size_total=479808
sum_limbo_reclamation_event_count_total=655200
first_thread_announced_epoch_by_thread=21032 21032 21032 21032 21032 21032 21032 21032 21032 21032 21032 21032 21032 21032 21032 21032 21032 21032 21032 21032 21032 21032 21032 21032 21032 21032 21032 21032 21032 21032 21032 21032 21032 21032 21032 21032 21032 21032 21032 21032 21032 21032 21032 21032 21032 21032 21032 21032
sum_num_inserts_by_thread=1526029 1531771 1541632 1540146 1535595 1521511 1528613 1530408 1545283 1548523 1530673 1525978 1531853 1538169 1545510 1545571 1536711 1530741 1521413 1528410 1537555 1539829 1526468 1518395 1525181 1532014 1541628 1537385 1538434 1523949 1530103 1533792 1548246 1545711 1531306 1527040 1529775 1538108 1545204 1545016 1535661 1529559 1522433 1529581 1537826 1541227 1526539 1516967
sum_num_inserts_total=73619472
sum_num_deletes_by_thread=1528066 1534255 1539935 1540958 1535354 1521147 1524305 1532663 1547149 1547917 1530504 1525430 1530828 1536384 1546223 1546843 1536791 1526842 1524244 1527989 1536222 1542351 1526447 1517103 1525851 1533056 1543660 1544085 1535862 1523091 1527280 1535351 1546816 1546638 1532134 1524593 1533205 1540625 1547653 1545554 1537127 1528180 1521971 1527379 1536882 1541845 1528227 1518797
sum_num_deletes_total=73631812
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=3054095 3066026 3081567 3081104 3070949 3042658 3052918 3063071 3092432 3096440 3061177 3051408 3062681 3074553 3091733 3092414 3073502 3057583 3045657 3056399 3073777 3082180 3052915 3035498 3051032 3065070 3085288 3081470 3074296 3047040 3057383 3069143 3095062 3092349 3063440 3051633 3062980 3078733 3092857 3090570 3072788 3057739 3044404 3056960 3074708 3083072 3054766 3035764
average_num_operations_total=3067735
stdev_num_operations_total=2448
sum_num_operations_total=147251284
min_num_operations_total=3035498
max_num_operations_total=3096440
first_time_thread_terminate_by_thread=10000153 10000154 10000153 10000153 10000185 10000153 10000153 10000153 10000155 10000153 10000153 10000153 10000153 10000154 10000157 10000153 10000153 10000155 10000153 10000154 10000153 10000153 10000153 10000153 10000153 10000153 10000153 10000153 10000153 10000153 10000153 10000153 10000153 10000153 10000153 10000153 10000174 10000153 10000153 10000154 10000154 10000154 10000153 10000154 10000154 10000153 10000153 10000153
min_time_thread_terminate_total=10000153
max_time_thread_terminate_total=10000185
first_time_thread_start_by_thread=5 4 4 5 4 4 4 5 5 5 4 4 5 4 5 5 4 4 4 5 4 5 4 5 5 4 4 5 4 4 4 5 5 5 4 4 5 4 5 5 4 4 4 5 4 5 4 5
min_time_thread_start_total=4
max_time_thread_start_total=5
sum_duration_all_ops_total=

threads_final_keysum=100000531989895
threads_final_size=9998936
final_keysum=100000531989895
final_size=9998936
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=73619472
total_deletes=73631812
total_updates=147251284
total_queries=0
total_ops=147251284
find_throughput=0
rq_throughput=0
update_throughput=14725128
query_throughput=0
total_throughput=14725128


total find                    : 0
total rq                      : 0
total inserts                 : 73619472
total deletes                 : 73631812
total updates                 : 147251284
total queries                 : 0
total ops                     : 147251284
find throughput               : 0
rq throughput                 : 0
update throughput             : 14725128
query throughput              : 0
total throughput              : 14725128

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=56.4223
PAPI_L3_TCM=20.2367
PAPI_TOT_CYC=9085.32
PAPI_TOT_INS=1210.27
garbage=0
total_execution_walltime=15.567s
REALTIME_MAIN_END_PERF_FORMAT=6987404.160758896
[time_cmd_output] time_elapsed_sec=15.78, faults_major=0, faults_minor=314169, mem_maxresident_kb=1258404, user_cputime=756.57, sys_cputime=3.13, percent_cpu=4813%
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