__step=000033
__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=data000033.txt
__path_data=data/data000033.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=207191.939813989
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.023s
prefilling_size=6488243 prefilling_elapsed_millis=1s
prefilling_size=6786293 prefilling_elapsed_millis=1.1s
prefilling_size=7053499 prefilling_elapsed_millis=1.201s
prefilling_size=7299586 prefilling_elapsed_millis=1.301s
prefilling_size=7521845 prefilling_elapsed_millis=1.401s
prefilling_size=7724795 prefilling_elapsed_millis=1.501s
prefilling_size=7909542 prefilling_elapsed_millis=1.601s
prefilling_size=8078935 prefilling_elapsed_millis=1.701s
prefilling_size=8233899 prefilling_elapsed_millis=1.801s
prefilling_size=8375868 prefilling_elapsed_millis=1.901s
prefilling_size=8505097 prefilling_elapsed_millis=2.002s
prefilling_size=8623956 prefilling_elapsed_millis=2.102s
prefilling_size=8731571 prefilling_elapsed_millis=2.202s
prefilling_size=8831139 prefilling_elapsed_millis=2.302s
prefilling_size=8923932 prefilling_elapsed_millis=2.402s
prefilling_size=9007287 prefilling_elapsed_millis=2.502s
prefilling_size=9084195 prefilling_elapsed_millis=2.602s
prefilling_size=9155794 prefilling_elapsed_millis=2.702s
prefilling_size=9220622 prefilling_elapsed_millis=2.802s
prefilling_size=9280547 prefilling_elapsed_millis=2.903s
prefilling_size=9335974 prefilling_elapsed_millis=3.003s
prefilling_size=9389281 prefilling_elapsed_millis=3.103s
prefilling_size=9437179 prefilling_elapsed_millis=3.203s
prefilling_size=9480278 prefilling_elapsed_millis=3.303s
prefilling_size=9521250 prefilling_elapsed_millis=3.404s
prefilling_size=9558481 prefilling_elapsed_millis=3.504s
prefilling_size=9592146 prefilling_elapsed_millis=3.604s
prefilling_size=9624242 prefilling_elapsed_millis=3.704s
prefilling_size=9652405 prefilling_elapsed_millis=3.804s
prefilling_size=9678971 prefilling_elapsed_millis=3.904s
prefilling_size=9705349 prefilling_elapsed_millis=4.004s
prefilling_size=9727116 prefilling_elapsed_millis=4.104s
prefilling_size=9748228 prefilling_elapsed_millis=4.205s
prefilling_size=9766582 prefilling_elapsed_millis=4.305s
prefilling_size=9784046 prefilling_elapsed_millis=4.405s
prefilling_size=9799943 prefilling_elapsed_millis=4.505s
prefilling_size=9814103 prefilling_elapsed_millis=4.605s
finished prefilling to size 9814130 for expected size 10000000 keysum=98133283990675, performing 81142378 updates; total_prefilling_elapsed_ms=4706 ms)
pref_size=9814130
pref_millis=4706
prefill_elapsed_ms=4720
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=2278

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=207196.698080016
REALTIME_END_PERF_FORMAT=207206.698168997

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

tree_stats_computeWalltime=0.257s

tree_stats_numInternalsAtDepth=1 1 1 2 4 8 16 32 64 128 251 499 966 1838 3403 6074 10506 17521 28340 44444 67502 99019 141017 194175 258499 333877 416679 502071 583324 653719 705701 734829 738463 713903 665999 601227 524304 442615 361302 284233 216154 159073 112751 77619 51114 32506 19808 11834 6992 3897 2099 1045 583 273 127 59 35 23 9 2 2 0
tree_stats_numLeavesAtDepth=0 1 1 0 0 0 0 0 0 0 5 3 32 94 273 732 1642 3491 6702 12236 21386 35985 57021 87859 129851 183121 251075 331287 420818 512929 601737 676573 731195 763023 761807 730771 678150 605993 523928 438371 352312 273235 205395 147883 104124 69722 45204 27782 16676 10087 5695 3153 1507 893 419 195 83 47 37 16 2 4
tree_stats_numNodesAtDepth=1 2 2 2 4 8 16 32 64 128 256 502 998 1932 3676 6806 12148 21012 35042 56680 88888 135004 198038 282034 388350 516998 667754 833358 1004142 1166648 1307438 1411402 1469658 1476926 1427806 1331998 1202454 1048608 885230 722604 568466 432308 318146 225502 155238 102228 65012 39616 23668 13984 7794 4198 2090 1166 546 254 118 70 46 18 4 4
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 5 3 32 94 273 732 1642 3491 6702 12236 21386 35985 57021 87859 129851 183121 251075 331287 420818 512929 601737 676573 731195 763023 761807 730771 678150 605993 523928 438371 352312 273235 205395 147883 104124 69722 45204 27782 16676 10087 5695 3153 1507 893 419 195 83 47 37 16 2 4
tree_stats_avgDegreeAtDepth=2 1 1 2 2 2 2 2 2 2 1.98047 1.99402 1.96794 1.95135 1.92573 1.89245 1.86483 1.83386 1.80874 1.78412 1.75941 1.73345 1.71207 1.68848 1.66563 1.6458 1.624 1.60247 1.58092 1.56034 1.53976 1.52064 1.50247 1.48337 1.46645 1.45137 1.43603 1.4221 1.40814 1.39335 1.38024 1.36796 1.3544 1.34421 1.32926 1.31798 1.30468 1.29872 1.29542 1.27868 1.26931 1.24893 1.27895 1.23413 1.2326 1.23228 1.29661 1.32857 1.19565 1.11111 1.5 1

tree_stats_height=62
tree_stats_numInternals=9832562
tree_stats_numLeaves=9832563
tree_stats_numNodes=19665125
tree_stats_numKeys=9832561

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

tree_stats_bytesAtDepth=40 80 80 80 160 320 640 1280 2560 5120 10240 20080 39920 77280 147040 272240 485920 840480 1401680 2267200 3555520 5400160 7921520 11281360 15534000 20679920 26710160 33334320 40165680 46665920 52297520 56456080 58786320 59077040 57112240 53279920 48098160 41944320 35409200 28904160 22738640 17292320 12725840 9020080 6209520 4089120 2600480 1584640 946720 559360 311760 167920 83600 46640 21840 10160 4720 2800 1840 720 160 160
tree_stats_sizeInBytes=786605000

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

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:68038 2:226258 4:264504 8:51148 16:482 32:50
    [2^00, 2^01]: 68038
    (2^01, 2^02]: 226258
    (2^02, 2^03]: 264504
    (2^03, 2^04]: 51148
    (2^04, 2^05]: 482
    (2^05, 2^06]: 50
sum_limbo_reclamation_event_size_total=2460490
count_limbo_reclamation_event_size_by_thread=9546 9556 9536 9560 9532 9578 9546 9512 9528 9580 9560 9520 9526 9560 9526 9512 9568 9584 9586 9548 9582 9548 9564 9548 9576 9518 9518 9468 9532 9520 9560 9502 9492 9546 9504 9554 9528 9558 9578 9568 9570 9488 9574 9552 9512 9506 9566 9528 9538 9514 9506 9530 9536 9490 9568 9498 9518 9482 9528 9472 9524 9586 9562 9604
count_limbo_reclamation_event_size_total=610480
sum_limbo_reclamation_event_count_total=762368
first_thread_announced_epoch_by_thread=16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468 16468
sum_num_inserts_by_thread=18575 18623 18442 18293 18401 18603 18398 18524 18410 18222 18155 18315 18316 17970 18049 18047 18392 18554 18484 18299 18488 18384 18313 18337 18456 18284 17933 17982 18346 18372 18327 18082 18402 18511 18423 18380 18311 18405 18492 18338 18205 18435 18245 18167 18263 18360 18486 18542 18441 18526 18510 18278 18321 18371 18362 18258 18062 18257 17981 18128 18528 18584 18406 18374
sum_num_inserts_total=1173728
sum_num_deletes_by_thread=18574 18468 18381 18268 18498 18509 18472 18287 18494 18632 18564 18227 18184 18556 18154 18346 18181 18577 18255 18468 18400 18304 18448 18448 18463 18302 18294 18192 18200 18201 18149 18206 18454 18707 18503 18438 18399 18545 18405 18697 18446 18112 18422 18372 18487 18119 18552 18269 18531 18465 18323 18361 18238 18338 18264 18068 18255 18158 18106 18428 18374 18406 18695 18409
sum_num_deletes_total=1176048
sum_num_searches_by_thread=3664344 3661265 3645106 3639453 3656647 3659635 3644023 3642489 3644795 3644538 3621897 3613360 3620435 3613387 3602551 3600459 3624061 3655437 3648902 3637208 3653622 3645645 3637768 3634589 3640472 3632505 3606408 3600594 3611553 3613517 3602255 3595838 3680738 3671278 3663449 3661299 3666393 3663290 3655212 3646759 3636607 3628651 3624974 3613763 3627976 3623087 3654648 3647074 3645838 3640867 3635845 3633318 3644731 3627826 3616521 3608183 3618267 3608830 3600222 3594690 3652350 3654164 3639398 3648055
sum_num_searches_total=232649061
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=3701493 3698356 3681929 3676014 3693546 3696747 3680893 3679300 3681699 3681392 3658616 3649902 3656935 3649913 3638754 3636852 3660634 3692568 3685641 3673975 3690510 3682333 3674529 3671374 3677391 3669091 3642635 3636768 3648099 3650090 3638731 3632126 3717594 3708496 3700375 3698117 3703103 3700240 3692109 3683794 3673258 3665198 3661641 3650302 3664726 3659566 3691686 3683885 3682810 3677858 3672678 3669957 3681290 3664535 3653147 3644509 3654584 3645245 3636309 3631246 3689252 3691154 3676499 3684838
average_num_operations_total=3671856
stdev_num_operations_total=2687
sum_num_operations_total=234998837
min_num_operations_total=3631246
max_num_operations_total=3717594
first_time_thread_terminate_by_thread=10000093 10000093 10000093 10000093 10000092 10000092 10000092 10000092 10000092 10000092 10000092 10000092 10000097 10000097 10000097 10000097 10000094 10000094 10000094 10000094 10000095 10000095 10000095 10000095 10000095 10000095 10000095 10000095 10000091 10000091 10000091 10000091 10000097 10000097 10000097 10000097 10000095 10000094 10000095 10000095 10000093 10000093 10000093 10000093 10000094 10000094 10000094 10000094 10000096 10000096 10000096 10000096 10000093 10000093 10000093 10000093 10000095 10000095 10000095 10000095 10000091 10000091 10000091 10000093
min_time_thread_terminate_total=10000091
max_time_thread_terminate_total=10000097
first_time_thread_start_by_thread=4 4 4 4 4 4 4 4 4 4 4 4 5 5 5 5 4 4 4 4 5 5 5 5 4 4 4 4 5 5 5 5 4 4 4 4 6 6 6 6 6 6 6 6 7 7 6 6 7 7 7 7 7 7 7 7 5 5 5 5 8 7 7 7
min_time_thread_start_total=4
max_time_thread_start_total=8
sum_duration_all_ops_total=

threads_final_keysum=98318560991134
threads_final_size=9832561
final_keysum=98318560991134
final_size=9832561
validate_result=success
Validation OK.
Structural validation OK.

total_find=232649061
total_rq=0
total_inserts=1173728
total_deletes=1176048
total_updates=2349776
total_queries=232649061
total_ops=234998837
find_throughput=23264906
rq_throughput=0
update_throughput=234977
query_throughput=23264906
total_throughput=23499883


total find                    : 232649061
total rq                      : 0
total inserts                 : 1173728
total deletes                 : 1176048
total updates                 : 2349776
total queries                 : 232649061
total ops                     : 234998837
find throughput               : 23264906
rq throughput                 : 0
update throughput             : 234977
query throughput              : 23264906
total throughput              : 23499883

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

garbage=410401150883974
total_execution_walltime=15.103s
REALTIME_MAIN_END_PERF_FORMAT=207207.44118967
[time_cmd_output] time_elapsed_sec=15.28, faults_major=1, faults_minor=310362, mem_maxresident_kb=1241856, user_cputime=973.73, sys_cputime=8.29, percent_cpu=6426%
timeout=false
algorithm=ellen_ext_bst_lf.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1