__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 64 -nprefill 64 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 50.0 50.0 -k 20000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000706.txt
__path_data=data/data000706.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=215326.379690916
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=50
DEL_FRAC=50
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=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,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=6536568 prefilling_elapsed_millis=1s
prefilling_size=6832897 prefilling_elapsed_millis=1.101s
prefilling_size=7103017 prefilling_elapsed_millis=1.201s
prefilling_size=7348492 prefilling_elapsed_millis=1.301s
prefilling_size=7569348 prefilling_elapsed_millis=1.401s
prefilling_size=7773051 prefilling_elapsed_millis=1.501s
prefilling_size=7959288 prefilling_elapsed_millis=1.601s
prefilling_size=8129116 prefilling_elapsed_millis=1.701s
prefilling_size=8283839 prefilling_elapsed_millis=1.801s
prefilling_size=8422680 prefilling_elapsed_millis=1.902s
prefilling_size=8548428 prefilling_elapsed_millis=2.002s
prefilling_size=8667244 prefilling_elapsed_millis=2.102s
prefilling_size=8775183 prefilling_elapsed_millis=2.202s
prefilling_size=8874150 prefilling_elapsed_millis=2.302s
prefilling_size=8967067 prefilling_elapsed_millis=2.402s
prefilling_size=9051205 prefilling_elapsed_millis=2.502s
prefilling_size=9128273 prefilling_elapsed_millis=2.602s
prefilling_size=9199653 prefilling_elapsed_millis=2.703s
prefilling_size=9264916 prefilling_elapsed_millis=2.803s
prefilling_size=9323672 prefilling_elapsed_millis=2.903s
prefilling_size=9376520 prefilling_elapsed_millis=3.003s
prefilling_size=9425147 prefilling_elapsed_millis=3.104s
prefilling_size=9471091 prefilling_elapsed_millis=3.204s
prefilling_size=9512664 prefilling_elapsed_millis=3.304s
prefilling_size=9551044 prefilling_elapsed_millis=3.404s
prefilling_size=9587430 prefilling_elapsed_millis=3.504s
prefilling_size=9621462 prefilling_elapsed_millis=3.604s
prefilling_size=9651769 prefilling_elapsed_millis=3.704s
prefilling_size=9678685 prefilling_elapsed_millis=3.805s
prefilling_size=9702668 prefilling_elapsed_millis=3.905s
prefilling_size=9724478 prefilling_elapsed_millis=4.005s
prefilling_size=9745611 prefilling_elapsed_millis=4.105s
prefilling_size=9766467 prefilling_elapsed_millis=4.205s
prefilling_size=9783532 prefilling_elapsed_millis=4.305s
prefilling_size=9801433 prefilling_elapsed_millis=4.405s
finished prefilling to size 9801435 for expected size 10000000 keysum=98014440887778, performing 79050486 updates; total_prefilling_elapsed_ms=4506 ms)
pref_size=9801435
pref_millis=4506
prefill_elapsed_ms=4526
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=2138

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=215330.938989872
REALTIME_END_PERF_FORMAT=215340.939084917

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

tree_stats_computeWalltime=0.388s

tree_stats_numInternalsAtDepth=1 1 1 2 4 8 16 32 64 128 256 512 1021 2018 3928 7385 13414 23381 38884 62135 95050 139432 196860 266428 346689 432620 517796 596300 661840 708084 730545 730910 707628 662452 603269 531995 453980 375708 301833 233772 175119 127563 90078 61189 39484 24727 14810 8540 4739 2430 1175 518 194 73 19 12 3 1 0
tree_stats_numLeavesAtDepth=0 1 1 0 0 0 0 0 0 0 0 0 3 24 108 471 1356 3447 7878 15633 29220 50668 82004 127292 186167 260758 347444 439292 530760 615596 685623 730180 754192 752804 721635 674543 610010 532252 449583 369894 292425 222675 165048 118967 82894 54241 34644 21080 12341 7048 3685 1832 842 315 127 26 21 5 2
tree_stats_numNodesAtDepth=1 2 2 2 4 8 16 32 64 128 256 512 1024 2042 4036 7856 14770 26828 46762 77768 124270 190100 278864 393720 532856 693378 865240 1035592 1192600 1323680 1416168 1461090 1461820 1415256 1324904 1206538 1063990 907960 751416 603666 467544 350238 255126 180156 122378 78968 49454 29620 17080 9478 4860 2350 1036 388 146 38 24 6 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 3 24 108 471 1356 3447 7878 15633 29220 50668 82004 127292 186167 260758 347444 439292 530760 615596 685623 730180 754192 752804 721635 674543 610010 532252 449583 369894 292425 222675 165048 118967 82894 54241 34644 21080 12341 7048 3685 1832 842 315 127 26 21 5 2
tree_stats_avgDegreeAtDepth=2 1 1 2 2 2 2 2 2 2 2 2 1.99707 1.98825 1.97324 1.94005 1.90819 1.87151 1.83153 1.79898 1.76487 1.73347 1.70594 1.67669 1.65062 1.62393 1.59844 1.57581 1.55496 1.53494 1.51586 1.50025 1.48407 1.46808 1.45533 1.44093 1.42668 1.41379 1.40169 1.38725 1.37455 1.36422 1.35307 1.33964 1.32264 1.31313 1.29947 1.28832 1.27746 1.25638 1.24177 1.22043 1.18726 1.18814 1.13014 1.31579 1.125 1.16667 1

tree_stats_height=59
tree_stats_numInternals=9997056
tree_stats_numLeaves=9997057
tree_stats_numNodes=19994113
tree_stats_numKeys=9997055

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

tree_stats_bytesAtDepth=40 80 80 80 160 320 640 1280 2560 5120 10240 20480 40960 81680 161440 314240 590800 1073120 1870480 3110720 4970800 7604000 11154560 15748800 21314240 27735120 34609600 41423680 47704000 52947200 56646720 58443600 58472800 56610240 52996160 48261520 42559600 36318400 30056640 24146640 18701760 14009520 10205040 7206240 4895120 3158720 1978160 1184800 683200 379120 194400 94000 41440 15520 5840 1520 960 240 80
tree_stats_sizeInBytes=799764520

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

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:43 2:20 4:3 8:5 16:19 32:17 64:64 128:24156 256:556316 512:1094 1024:126 2048:63
    [2^00, 2^01]: 43
    (2^01, 2^02]: 20
    (2^02, 2^03]: 3
    (2^03, 2^04]: 5
    (2^04, 2^05]: 19
    (2^05, 2^06]: 17
    (2^06, 2^07]: 64
    (2^07, 2^08]: 24156
    (2^08, 2^09]: 556316
    (2^09, 2^10]: 1094
    (2^10, 2^11]: 126
    (2^11, 2^12]: 63
sum_limbo_reclamation_event_size_total=210449892
count_limbo_reclamation_event_size_by_thread=9094 9094 9094 9088 9094 9094 9090 9092 9094 9092 9092 9090 9092 9094 9094 9092 9092 9092 9092 9090 9092 9092 9092 9094 9094 9092 9092 9090 9094 9092 9090 9092 9094 9092 9092 9094 9092 9092 9092 9092 9094 9092 9094 9092 9092 9094 9094 9094 9094 9092 9094 9094 9094 9092 9094 9092 9094 9092 9090 9094 9092 9094 9092 9094
count_limbo_reclamation_event_size_total=581926
sum_limbo_reclamation_event_count_total=582268
first_thread_announced_epoch_by_thread=13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374 13374
sum_num_inserts_by_thread=1323064 1322110 1320796 1317196 1322358 1325401 1319218 1309548 1319747 1314372 1310151 1308927 1311407 1310663 1306526 1305558 1322742 1321365 1318787 1318193 1322605 1322709 1317920 1313588 1310751 1310656 1305570 1304491 1310685 1310340 1317872 1313918 1327691 1327611 1324474 1324496 1329098 1324365 1318315 1315811 1314998 1320214 1313368 1312239 1327503 1327593 1322562 1321131 1317248 1315722 1313425 1312000 1311996 1311935 1307159 1308020 1310407 1311068 1306856 1314870 1320597 1322192 1320082 1316749
sum_num_inserts_total=84261029
sum_num_deletes_by_thread=1322953 1320662 1319503 1317836 1323385 1323900 1319606 1308809 1319876 1315825 1308172 1307356 1313139 1312206 1308345 1305807 1322921 1323633 1316697 1317999 1321386 1321197 1317153 1312141 1311008 1311790 1306773 1306392 1310778 1309745 1315389 1313598 1327589 1330107 1326170 1325186 1327346 1322804 1317953 1315538 1317239 1319188 1314099 1313865 1327955 1327606 1322988 1320984 1317930 1315940 1315523 1313250 1311075 1311934 1307407 1307914 1312406 1313560 1308805 1317224 1322714 1325637 1317767 1319753
sum_num_deletes_total=84281436
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=2646017 2642772 2640299 2635032 2645743 2649301 2638824 2618357 2639623 2630197 2618323 2616283 2624546 2622869 2614871 2611365 2645663 2644998 2635484 2636192 2643991 2643906 2635073 2625729 2621759 2622446 2612343 2610883 2621463 2620085 2633261 2627516 2655280 2657718 2650644 2649682 2656444 2647169 2636268 2631349 2632237 2639402 2627467 2626104 2655458 2655199 2645550 2642115 2635178 2631662 2628948 2625250 2623071 2623869 2614566 2615934 2622813 2624628 2615661 2632094 2643311 2647829 2637849 2636502
average_num_operations_total=2633476
stdev_num_operations_total=1599
sum_num_operations_total=168542465
min_num_operations_total=2610883
max_num_operations_total=2657718
first_time_thread_terminate_by_thread=10000096 10000096 10000098 10000096 10000097 10000097 10000097 10000097 10000098 10000098 10000095 10000095 10000097 10000097 10000097 10000097 10000095 10000096 10000096 10000096 10000098 10000098 10000098 10000098 10000096 10000096 10000096 10000096 10000096 10000096 10000096 10000096 10000095 10000096 10000112 10000098 10000098 10000098 10000098 10000098 10000097 10000097 10000097 10000097 10000097 10000097 10000097 10000097 10000097 10000097 10000097 10000097 10000096 10000096 10000096 10000096 10000098 10000098 10000098 10000098 10000095 10000097 10000095 10000095
min_time_thread_terminate_total=10000095
max_time_thread_terminate_total=10000112
first_time_thread_start_by_thread=4 4 4 4 3 3 3 3 4 4 4 4 5 5 5 5 8 7 7 7 6 6 6 6 7 7 7 7 7 7 7 7 3 3 3 3 5 5 5 5 5 5 6 5 5 5 5 5 7 7 7 7 6 6 6 6 4 4 4 4 6 6 6 6
min_time_thread_start_total=3
max_time_thread_start_total=8
sum_duration_all_ops_total=

threads_final_keysum=99985827767962
threads_final_size=9997055
final_keysum=99985827767962
final_size=9997055
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=84261029
total_deletes=84281436
total_updates=168542465
total_queries=0
total_ops=168542465
find_throughput=0
rq_throughput=0
update_throughput=16854246
query_throughput=0
total_throughput=16854246


total find                    : 0
total rq                      : 0
total inserts                 : 84261029
total deletes                 : 84281436
total updates                 : 168542465
total queries                 : 0
total ops                     : 168542465
find throughput               : 0
rq throughput                 : 0
update throughput             : 16854246
query throughput              : 0
total throughput              : 16854246

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

garbage=0
total_execution_walltime=15.039s
REALTIME_MAIN_END_PERF_FORMAT=215341.419261487
[time_cmd_output] time_elapsed_sec=15.20, faults_major=0, faults_minor=317706, mem_maxresident_kb=1271328, user_cputime=944.75, sys_cputime=10.27, percent_cpu=6280%
timeout=false
algorithm=ellen_ext_bst_lf.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2