__step=000722
__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" ./natarajan_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=data000722.txt
__path_data=data/data000722.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=215543.728264152
binary=./natarajan_ext_bst_lf.debra
parsed custom binding: 0-63,128-191,64-127,192-255
DS_TYPENAME=natarajan_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=32
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.02s
prefilling_size=7569212 prefilling_elapsed_millis=1s
prefilling_size=7816231 prefilling_elapsed_millis=1.101s
prefilling_size=8037638 prefilling_elapsed_millis=1.201s
prefilling_size=8231643 prefilling_elapsed_millis=1.301s
prefilling_size=8404698 prefilling_elapsed_millis=1.401s
prefilling_size=8557910 prefilling_elapsed_millis=1.501s
prefilling_size=8695314 prefilling_elapsed_millis=1.601s
prefilling_size=8818525 prefilling_elapsed_millis=1.701s
prefilling_size=8928866 prefilling_elapsed_millis=1.801s
prefilling_size=9025977 prefilling_elapsed_millis=1.901s
prefilling_size=9113619 prefilling_elapsed_millis=2.002s
prefilling_size=9195203 prefilling_elapsed_millis=2.102s
prefilling_size=9268218 prefilling_elapsed_millis=2.202s
prefilling_size=9332122 prefilling_elapsed_millis=2.302s
prefilling_size=9390653 prefilling_elapsed_millis=2.402s
prefilling_size=9444748 prefilling_elapsed_millis=2.502s
prefilling_size=9493638 prefilling_elapsed_millis=2.602s
prefilling_size=9538028 prefilling_elapsed_millis=2.702s
prefilling_size=9578599 prefilling_elapsed_millis=2.803s
prefilling_size=9613627 prefilling_elapsed_millis=2.903s
prefilling_size=9647116 prefilling_elapsed_millis=3.003s
prefilling_size=9677464 prefilling_elapsed_millis=3.103s
prefilling_size=9702435 prefilling_elapsed_millis=3.204s
prefilling_size=9725719 prefilling_elapsed_millis=3.304s
prefilling_size=9747471 prefilling_elapsed_millis=3.404s
prefilling_size=9768321 prefilling_elapsed_millis=3.504s
prefilling_size=9786777 prefilling_elapsed_millis=3.604s
prefilling_size=9805980 prefilling_elapsed_millis=3.704s
finished prefilling to size 9805980 for expected size 10000000 keysum=98075742713328, performing 86242847 updates; total_prefilling_elapsed_ms=3805 ms)
pref_size=9805980
pref_millis=3805
prefill_elapsed_ms=3825
6node_tIxPvE_object_size=32
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=2298

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=215547.588510550
REALTIME_END_PERF_FORMAT=215557.588614867

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

tree_stats_computeWalltime=0.182s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 255 509 1009 1985 3854 7348 13601 24397 42076 69170 109213 163876 234375 319797 416063 516500 613093 695335 754699 786529 787794 759808 704169 630717 544150 454682 366579 286858 217345 159056 112193 76298 49937 31720 19137 11173 6323 3340 1737 896 435 230 131 58 23 12 5 1 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 1 1 9 33 116 360 1095 2805 6718 14982 29127 54550 93377 148953 223531 315626 419907 530851 635971 722869 785264 815780 815447 777621 717284 633618 542785 446300 356371 275634 205919 148088 102659 68154 44303 27101 16023 9306 4943 2578 1357 640 329 204 93 34 19 9 1 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 510 1018 2018 3970 7708 14696 27202 48794 84152 138340 218426 327752 468750 639594 832126 1033000 1226186 1390670 1509398 1573058 1575588 1519616 1408338 1261434 1088300 909364 733158 573716 434690 318112 224386 152596 99874 63440 38274 22346 12646 6680 3474 1792 870 460 262 116 46 24 10 2 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 1 1 9 33 116 360 1095 2805 6718 14982 29127 54550 93377 148953 223531 315626 419907 530851 635971 722869 785264 815780 815447 777621 717284 633618 542785 446300 356371 275634 205919 148088 102659 68154 44303 27101 16023 9306 4943 2578 1357 640 329 204 93 34 19 9 1 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 1.99609 1.99804 1.99116 1.98365 1.97078 1.9533 1.92549 1.89688 1.86232 1.82197 1.78945 1.75026 1.7151 1.68223 1.65051 1.6207 1.59351 1.56707 1.54269 1.52109 1.5008 1.48224 1.46339 1.44784 1.43137 1.41779 1.40312 1.39126 1.37884 1.36591 1.35268 1.34003 1.32725 1.3176 1.30166 1.29192 1.28296 1.26412 1.26003 1.25792 1.24275 1.26437 1.28478 1.22137 1.19828 1.26087 1.20833 1.1 1.5 1

tree_stats_height=58
tree_stats_numInternals=9998747
tree_stats_numLeaves=9998748
tree_stats_numNodes=19997495
tree_stats_numKeys=9998748

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

tree_stats_bytesAtDepth=32 64 128 256 512 1024 2048 4096 8192 16320 32576 64576 127040 246656 470272 870464 1561408 2692864 4426880 6989632 10488064 15000000 20467008 26628032 33056000 39237952 44501440 48300736 50337856 50418816 48627712 45066816 40365888 34825600 29099648 23461056 18358912 13910080 10179584 7180352 4883072 3195968 2030080 1224768 715072 404672 213760 111168 57344 27840 14720 8384 3712 1472 768 320 64 64
tree_stats_sizeInBytes=639919840

6node_tIxPvE_object_size=32
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=7761


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:49 4:2 8:2 16:6 32:7 64:17 128:50319 256:298617 512:64 1024:189
    (2^01, 2^02]: 49
    (2^02, 2^03]: 2
    (2^03, 2^04]: 2
    (2^04, 2^05]: 6
    (2^05, 2^06]: 7
    (2^06, 2^07]: 17
    (2^07, 2^08]: 50319
    (2^08, 2^09]: 298617
    (2^09, 2^10]: 64
    (2^10, 2^11]: 189
sum_limbo_reclamation_event_size_total=99490438
count_limbo_reclamation_event_size_by_thread=5460 5459 5459 5457 5457 5460 5458 5458 5457 5456 5457 5456 5457 5458 5458 5459 5455 5457 5457 5457 5457 5457 5456 5456 5457 5456 5457 5457 5455 5458 5458 5457 5457 5456 5457 5457 5459 5457 5456 5456 5456 5458 5458 5457 5457 5460 5457 5457 5459 5458 5459 5460 5459 5455 5456 5458 5459 5457 5458 5458 5457 5456 5458 5457
count_limbo_reclamation_event_size_total=349272
sum_limbo_reclamation_event_count_total=349590
first_thread_announced_epoch_by_thread=15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522 15522
sum_num_inserts_by_thread=1561868 1561232 1561673 1556976 1555375 1570876 1558457 1565822 1560023 1559716 1556777 1554336 1553223 1557732 1546659 1554438 1556698 1555419 1547434 1557607 1562508 1567241 1553649 1549495 1556297 1556912 1551788 1555005 1549846 1550506 1547712 1545752 1559092 1554802 1570221 1562638 1570867 1564385 1563621 1564513 1562320 1562980 1555092 1555997 1553559 1555474 1556786 1557175 1566487 1567045 1556932 1553226 1555792 1557175 1557362 1552958 1558688 1560260 1552918 1558346 1566913 1568621 1553709 1567322
sum_num_inserts_total=99722328
sum_num_deletes_by_thread=1561354 1560831 1564871 1557291 1558877 1570240 1558123 1566022 1562588 1560339 1558710 1554968 1553642 1559278 1547452 1551948 1557984 1553948 1544303 1556841 1562719 1567610 1553452 1554028 1556683 1554602 1553630 1553675 1549267 1548755 1547915 1545677 1559791 1555701 1568836 1565637 1571745 1565335 1561495 1562444 1564575 1562676 1553810 1554335 1554030 1555939 1558809 1558876 1566615 1564851 1553970 1553074 1558105 1560796 1558132 1553149 1559083 1560072 1552344 1556330 1564522 1567713 1556503 1569105
sum_num_deletes_total=99736021
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=3123222 3122063 3126544 3114267 3114252 3141116 3116580 3131844 3122611 3120055 3115487 3109304 3106865 3117010 3094111 3106386 3114682 3109367 3091737 3114448 3125227 3134851 3107101 3103523 3112980 3111514 3105418 3108680 3099113 3099261 3095627 3091429 3118883 3110503 3139057 3128275 3142612 3129720 3125116 3126957 3126895 3125656 3108902 3110332 3107589 3111413 3115595 3116051 3133102 3131896 3110902 3106300 3113897 3117971 3115494 3106107 3117771 3120332 3105262 3114676 3131435 3136334 3110212 3136427
average_num_operations_total=3116536
stdev_num_operations_total=1517
sum_num_operations_total=199458349
min_num_operations_total=3091429
max_num_operations_total=3142612
first_time_thread_terminate_by_thread=10000106 10000106 10000106 10000106 10000104 10000146 10000110 10000104 10000105 10000105 10000107 10000107 10000107 10000106 10000106 10000109 10000104 10000107 10000104 10000104 10000107 10000107 10000106 10000128 10000105 10000105 10000140 10000105 10000107 10000104 10000146 10000104 10000104 10000104 10000104 10000108 10000105 10000105 10000106 10000105 10000106 10000106 10000106 10000106 10000105 10000105 10000105 10000105 10000105 10000103 10000105 10000103 10000106 10000106 10000106 10000106 10000104 10000104 10000104 10000104 10000104 10000104 10000105 10000104
min_time_thread_terminate_total=10000103
max_time_thread_terminate_total=10000146
first_time_thread_start_by_thread=5 5 5 5 7 7 7 7 6 6 7 7 6 6 6 6 6 6 6 6 8 8 8 8 7 7 7 7 8 8 8 8 9 9 9 9 8 8 8 8 5 5 5 5 9 9 9 9 5 5 5 5 5 5 6 6 7 7 7 7 6 6 6 6
min_time_thread_start_total=5
max_time_thread_start_total=9
sum_duration_all_ops_total=

threads_final_keysum=99988619631737
threads_final_size=9998748
final_keysum=99988619631737
final_size=9998748
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=99722328
total_deletes=99736021
total_updates=199458349
total_queries=0
total_ops=199458349
find_throughput=0
rq_throughput=0
update_throughput=19945834
query_throughput=0
total_throughput=19945834


total find                    : 0
total rq                      : 0
total inserts                 : 99722328
total deletes                 : 99736021
total updates                 : 199458349
total queries                 : 0
total ops                     : 199458349
find throughput               : 0
rq throughput                 : 0
update throughput             : 19945834
query throughput              : 0
total throughput              : 19945834

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

garbage=0
total_execution_walltime=14.202s
REALTIME_MAIN_END_PERF_FORMAT=215557.931107223
[time_cmd_output] time_elapsed_sec=14.35, faults_major=0, faults_minor=243857, mem_maxresident_kb=976552, user_cputime=904.88, sys_cputime=9.45, percent_cpu=6370%
timeout=false
algorithm=natarajan_ext_bst_lf.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2