__step=000034
__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 64 -nprefill 64 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 0.5 0.5 -k 20000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000034.txt
__path_data=data/data000034.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=207207.282180738
binary=./ellen_ext_bst_lf.debra
parsed custom binding: 0-63,128-191,64-127,192-255
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=20000000
PREFILL_THREADS=64
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=64
WORK_THREADS=64
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,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,48,49,50,51,52,53,54,55,56,57,58,59,60,61,62,63


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.021s
prefilling_size=6327337 prefilling_elapsed_millis=1s
prefilling_size=6625046 prefilling_elapsed_millis=1.101s
prefilling_size=6895586 prefilling_elapsed_millis=1.201s
prefilling_size=7143057 prefilling_elapsed_millis=1.301s
prefilling_size=7367410 prefilling_elapsed_millis=1.401s
prefilling_size=7572364 prefilling_elapsed_millis=1.501s
prefilling_size=7763271 prefilling_elapsed_millis=1.601s
prefilling_size=7930582 prefilling_elapsed_millis=1.701s
prefilling_size=8089616 prefilling_elapsed_millis=1.801s
prefilling_size=8234135 prefilling_elapsed_millis=1.901s
prefilling_size=8367198 prefilling_elapsed_millis=2.002s
prefilling_size=8488860 prefilling_elapsed_millis=2.102s
prefilling_size=8601982 prefilling_elapsed_millis=2.202s
prefilling_size=8706816 prefilling_elapsed_millis=2.302s
prefilling_size=8803122 prefilling_elapsed_millis=2.402s
prefilling_size=8890955 prefilling_elapsed_millis=2.502s
prefilling_size=8972777 prefilling_elapsed_millis=2.602s
prefilling_size=9048036 prefilling_elapsed_millis=2.702s
prefilling_size=9117436 prefilling_elapsed_millis=2.802s
prefilling_size=9180069 prefilling_elapsed_millis=2.903s
prefilling_size=9239125 prefilling_elapsed_millis=3.003s
prefilling_size=9293512 prefilling_elapsed_millis=3.103s
prefilling_size=9344540 prefilling_elapsed_millis=3.204s
prefilling_size=9392273 prefilling_elapsed_millis=3.304s
prefilling_size=9436751 prefilling_elapsed_millis=3.404s
prefilling_size=9477409 prefilling_elapsed_millis=3.504s
prefilling_size=9515960 prefilling_elapsed_millis=3.604s
prefilling_size=9549912 prefilling_elapsed_millis=3.704s
prefilling_size=9581823 prefilling_elapsed_millis=3.804s
prefilling_size=9610511 prefilling_elapsed_millis=3.904s
prefilling_size=9638309 prefilling_elapsed_millis=4.005s
prefilling_size=9664666 prefilling_elapsed_millis=4.105s
prefilling_size=9689129 prefilling_elapsed_millis=4.205s
prefilling_size=9711721 prefilling_elapsed_millis=4.305s
prefilling_size=9733802 prefilling_elapsed_millis=4.405s
prefilling_size=9753832 prefilling_elapsed_millis=4.505s
prefilling_size=9769460 prefilling_elapsed_millis=4.605s
prefilling_size=9785265 prefilling_elapsed_millis=4.705s
prefilling_size=9799591 prefilling_elapsed_millis=4.806s
prefilling_size=9813154 prefilling_elapsed_millis=4.906s
finished prefilling to size 9813160 for expected size 10000000 keysum=98124821150378, performing 83534331 updates; total_prefilling_elapsed_ms=5006 ms)
pref_size=9813160
pref_millis=5006
prefill_elapsed_ms=5019
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=2291

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=207212.339502727
REALTIME_END_PERF_FORMAT=207222.339601431

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

tree_stats_computeWalltime=0.205s

tree_stats_numInternalsAtDepth=1 1 1 2 4 8 16 32 64 128 253 498 975 1894 3649 6845 12551 22348 38308 62864 98742 149081 215491 297027 390175 487430 581473 661670 721649 755396 759222 736880 690364 626471 549821 467285 386122 308430 238258 177558 127926 89560 61073 40590 25782 15993 9700 5640 3109 1660 865 468 244 101 38 19 11 3 3 1 0
tree_stats_numLeavesAtDepth=0 1 1 0 0 0 0 0 0 0 3 8 21 56 139 453 1139 2754 6388 13752 26986 48403 82671 133955 203879 292920 393387 501276 601691 687902 751570 781564 783396 754257 703121 632357 548448 463814 378602 298958 227190 166292 118047 81556 55398 35571 22286 13760 8171 4558 2455 1262 692 387 164 57 27 19 3 5 2
tree_stats_numNodesAtDepth=1 2 2 2 4 8 16 32 64 128 256 506 996 1950 3788 7298 13690 25102 44696 76616 125728 197484 298162 430982 594054 780350 974860 1162946 1323340 1443298 1510792 1518444 1473760 1380728 1252942 1099642 934570 772244 616860 476516 355116 255852 179120 122146 81180 51564 31986 19400 11280 6218 3320 1730 936 488 202 76 38 22 6 6 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 3 8 21 56 139 453 1139 2754 6388 13752 26986 48403 82671 133955 203879 292920 393387 501276 601691 687902 751570 781564 783396 754257 703121 632357 548448 463814 378602 298958 227190 166292 118047 81556 55398 35571 22286 13760 8171 4558 2455 1262 692 387 164 57 27 19 3 5 2
tree_stats_avgDegreeAtDepth=2 1 1 2 2 2 2 2 2 2 1.98828 1.98419 1.97892 1.97128 1.96331 1.93793 1.9168 1.89029 1.85708 1.82051 1.78536 1.7549 1.72273 1.68919 1.6568 1.62463 1.59647 1.56896 1.54532 1.52338 1.50253 1.48529 1.46844 1.45373 1.43882 1.42494 1.41315 1.39939 1.38624 1.37262 1.36024 1.35005 1.34096 1.33231 1.31759 1.31016 1.30326 1.29072 1.27562 1.26697 1.26054 1.27052 1.26068 1.20697 1.18812 1.25 1.28947 1.13636 1.5 1.16667 1

tree_stats_height=61
tree_stats_numInternals=9831773
tree_stats_numLeaves=9831774
tree_stats_numNodes=19663547
tree_stats_numKeys=9831772

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

tree_stats_bytesAtDepth=40 80 80 80 160 320 640 1280 2560 5120 10240 20240 39840 78000 151520 291920 547600 1004080 1787840 3064640 5029120 7899360 11926480 17239280 23762160 31214000 38994400 46517840 52933600 57731920 60431680 60737760 58950400 55229120 50117680 43985680 37382800 30889760 24674400 19060640 14204640 10234080 7164800 4885840 3247200 2062560 1279440 776000 451200 248720 132800 69200 37440 19520 8080 3040 1520 880 240 240 80
tree_stats_sizeInBytes=786541880

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

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:68320 2:226186 4:264521 8:51025 16:499 32:39
    [2^00, 2^01]: 68320
    (2^01, 2^02]: 226186
    (2^02, 2^03]: 264521
    (2^03, 2^04]: 51025
    (2^04, 2^05]: 499
    (2^05, 2^06]: 39
sum_limbo_reclamation_event_size_total=2458782
count_limbo_reclamation_event_size_by_thread=9556 9582 9548 9546 9518 9558 9518 9562 9552 9500 9542 9562 9556 9496 9524 9500 9550 9584 9508 9550 9540 9560 9540 9596 9544 9540 9516 9548 9568 9560 9586 9482 9562 9514 9570 9548 9494 9524 9504 9546 9548 9512 9532 9542 9548 9548 9618 9534 9516 9524 9566 9518 9540 9556 9500 9540 9520 9548 9552 9538 9516 9546 9526 9548
count_limbo_reclamation_event_size_total=610590
sum_limbo_reclamation_event_count_total=733696
first_thread_announced_epoch_by_thread=16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046 16046
sum_num_inserts_by_thread=17780 17841 17789 17792 17836 17913 17701 17642 17592 17879 17322 17470 17770 17637 17375 17508 17946 17701 17585 17602 17850 17750 17661 17407 17548 17732 17558 17545 17999 17739 17588 17410 18105 17718 17750 17957 17445 17629 17844 17676 17755 17888 17958 17700 17894 17641 17684 17703 17595 17686 17550 17381 17584 17583 17470 17485 17625 17691 17443 17551 17742 17802 17618 17682
sum_num_inserts_total=1131303
sum_num_deletes_by_thread=17657 17729 17908 17732 17738 17879 17596 17561 17685 17501 17591 17611 17782 17702 17873 17779 17714 17924 17648 17620 17995 17863 17885 17609 17580 17715 17539 17471 17681 17757 17699 17614 17809 17627 17637 17833 17730 17735 17610 17641 17604 17638 17825 17616 17697 17753 17899 17710 17554 17586 17520 17607 17864 17450 17510 17552 17570 17566 17719 17593 17573 17847 17515 17629
sum_num_deletes_total=1131657
sum_num_searches_by_thread=3531006 3537183 3524818 3504324 3534887 3524599 3504848 3501237 3504553 3501620 3490277 3488904 3487803 3491859 3513778 3502542 3515164 3512461 3507148 3511110 3511585 3512295 3496483 3482035 3489057 3484675 3468934 3474842 3517146 3503927 3493593 3485014 3529896 3525704 3518893 3509942 3512378 3511728 3496219 3494025 3491720 3496410 3519998 3514600 3528495 3529676 3511904 3516857 3497528 3486530 3471724 3460433 3482500 3477420 3463374 3466698 3507110 3500176 3490040 3488014 3505512 3507642 3496133 3496061
sum_num_searches_total=224115047
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=3566443 3572753 3560515 3539848 3570461 3560391 3540145 3536440 3539830 3537000 3525190 3523985 3523355 3527198 3549026 3537829 3550824 3548086 3542381 3546332 3547430 3547908 3532029 3517051 3524185 3520122 3504031 3509858 3552826 3539423 3528880 3520038 3565810 3561049 3554280 3545732 3547553 3547092 3531673 3529342 3527079 3531936 3555781 3549916 3564086 3565070 3547487 3552270 3532677 3521802 3506794 3495421 3517948 3512453 3498354 3501735 3542305 3535433 3525202 3523158 3540827 3543291 3531266 3531372
average_num_operations_total=3537156
stdev_num_operations_total=2286
sum_num_operations_total=226378007
min_num_operations_total=3495421
max_num_operations_total=3572753
first_time_thread_terminate_by_thread=10000104 10000104 10000104 10000104 10000104 10000104 10000104 10000104 10000104 10000104 10000104 10000104 10000101 10000101 10000101 10000101 10000101 10000101 10000101 10000101 10000100 10000100 10000100 10000100 10000102 10000102 10000102 10000102 10000101 10000101 10000101 10000100 10000100 10000100 10000100 10000100 10000103 10000103 10000103 10000103 10000103 10000103 10000103 10000103 10000103 10000103 10000103 10000103 10000101 10000101 10000102 10000102 10000100 10000100 10000100 10000100 10000102 10000102 10000102 10000102 10000103 10000103 10000103 10000103
min_time_thread_terminate_total=10000100
max_time_thread_terminate_total=10000104
first_time_thread_start_by_thread=6 6 6 6 4 4 4 4 5 5 5 5 4 4 4 4 4 4 4 4 7 7 7 7 7 7 7 7 4 3 3 3 5 5 5 5 6 6 6 6 7 7 7 7 6 6 6 6 7 7 7 7 6 6 6 6 5 5 5 5 5 5 5 5
min_time_thread_start_total=3
max_time_thread_start_total=7
sum_duration_all_ops_total=

threads_final_keysum=98316848308157
threads_final_size=9831772
final_keysum=98316848308157
final_size=9831772
validate_result=success
Validation OK.
Structural validation OK.

total_find=224115047
total_rq=0
total_inserts=1131303
total_deletes=1131657
total_updates=2262960
total_queries=224115047
total_ops=226378007
find_throughput=22411504
rq_throughput=0
update_throughput=226296
query_throughput=22411504
total_throughput=22637800


total find                    : 224115047
total rq                      : 0
total inserts                 : 1131303
total deletes                 : 1131657
total updates                 : 2262960
total queries                 : 224115047
total ops                     : 226378007
find throughput               : 22411504
rq throughput                 : 0
update throughput             : 226296
query throughput              : 22411504
total throughput              : 22637800

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

garbage=326690425263133
total_execution_walltime=15.348s
REALTIME_MAIN_END_PERF_FORMAT=207222.631307676
[time_cmd_output] time_elapsed_sec=15.51, faults_major=0, faults_minor=313854, mem_maxresident_kb=1254668, user_cputime=990.35, sys_cputime=9.44, percent_cpu=6443%
timeout=false
algorithm=ellen_ext_bst_lf.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2