__step=000009
__cmd_run=LD_PRELOAD=../../setbench/lib/libjemalloc.so timeout 180 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" ./brown_int_bst_tm_auto.debra.tl2 -nwork 64 -nprefill 64 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 20000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000009.txt
__path_data=data/data000009.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=219278.820948775
binary=./brown_int_bst_tm_auto.debra.tl2
parsed custom binding: 0-63,128-191,64-127,192-255
DS_TYPENAME=brown_int_bst_tm_auto
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=5
DEL_FRAC=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=5.0 5.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


TL2 system ready: GV=GV4
Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.024s
prefilling_size=4472429 prefilling_elapsed_millis=1s
prefilling_size=4791319 prefilling_elapsed_millis=1.101s
prefilling_size=5096148 prefilling_elapsed_millis=1.201s
prefilling_size=5383604 prefilling_elapsed_millis=1.301s
prefilling_size=5650872 prefilling_elapsed_millis=1.401s
prefilling_size=5903978 prefilling_elapsed_millis=1.501s
prefilling_size=6140242 prefilling_elapsed_millis=1.601s
prefilling_size=6362816 prefilling_elapsed_millis=1.701s
prefilling_size=6573359 prefilling_elapsed_millis=1.801s
prefilling_size=6781193 prefilling_elapsed_millis=1.902s
prefilling_size=6969822 prefilling_elapsed_millis=2.002s
prefilling_size=7147942 prefilling_elapsed_millis=2.102s
prefilling_size=7316534 prefilling_elapsed_millis=2.202s
prefilling_size=7474759 prefilling_elapsed_millis=2.302s
prefilling_size=7622702 prefilling_elapsed_millis=2.402s
prefilling_size=7763069 prefilling_elapsed_millis=2.502s
prefilling_size=7894168 prefilling_elapsed_millis=2.602s
prefilling_size=8017527 prefilling_elapsed_millis=2.703s
prefilling_size=8132602 prefilling_elapsed_millis=2.803s
prefilling_size=8243653 prefilling_elapsed_millis=2.903s
prefilling_size=8347359 prefilling_elapsed_millis=3.003s
prefilling_size=8443965 prefilling_elapsed_millis=3.104s
prefilling_size=8535444 prefilling_elapsed_millis=3.204s
prefilling_size=8622564 prefilling_elapsed_millis=3.304s
prefilling_size=8705191 prefilling_elapsed_millis=3.404s
prefilling_size=8781144 prefilling_elapsed_millis=3.504s
prefilling_size=8853281 prefilling_elapsed_millis=3.604s
prefilling_size=8921192 prefilling_elapsed_millis=3.704s
prefilling_size=8984202 prefilling_elapsed_millis=3.804s
prefilling_size=9043602 prefilling_elapsed_millis=3.905s
prefilling_size=9100397 prefilling_elapsed_millis=4.005s
prefilling_size=9155538 prefilling_elapsed_millis=4.105s
prefilling_size=9206929 prefilling_elapsed_millis=4.205s
prefilling_size=9254142 prefilling_elapsed_millis=4.305s
prefilling_size=9297909 prefilling_elapsed_millis=4.405s
prefilling_size=9339082 prefilling_elapsed_millis=4.505s
prefilling_size=9376797 prefilling_elapsed_millis=4.605s
prefilling_size=9414662 prefilling_elapsed_millis=4.706s
prefilling_size=9449202 prefilling_elapsed_millis=4.806s
prefilling_size=9481829 prefilling_elapsed_millis=4.906s
prefilling_size=9512087 prefilling_elapsed_millis=5.006s
Info: prefilling requires an additional insert phase to complete.
Info: prefilling using INSERTION ONLY.
timing_start inserting 487887 keys with 64 threads...
tid=0 thread_prefill_amount=146875 percent_done_estimate=1926.7 elapsed_s=5 est_remaining_s=-11 / -6
tid=0 thread_prefill_amount=150000 percent_done_estimate=1967.7 elapsed_s=5 est_remaining_s=-11 / -6
tid=0 thread_prefill_amount=153125 percent_done_estimate=2008.7 elapsed_s=5 est_remaining_s=-11 / -6
timing_elapsed 0.0929414s
prefilling_size=10000000 prefilling_elapsed_millis=0.097s
finished prefilling to size 10000000 for expected size 10000000 keysum=100007926788659, performing 61447166 updates; total_prefilling_elapsed_ms=97 ms)
pref_size=10000000
pref_millis=97
prefill_elapsed_ms=97
4NodeIxPvL9tx_safety0EE_object_size=32
4NodeIxPvL9tx_safety0EE_allocated_count=0
4NodeIxPvL9tx_safety0EE_allocated_size=0MB
4NodeIxPvL9tx_safety0EE_get_from_pool=0
4NodeIxPvL9tx_safety0EE_deallocated=0
4NodeIxPvL9tx_safety0EE_limbo_count=0
4NodeIxPvL9tx_safety0EE_limbo_details=0 0 0 

global_epoch_counter=1583

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=219284.74887167
REALTIME_END_PERF_FORMAT=219294.74956290

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

tree_stats_computeWalltime=0.149s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 126 246 472 881 1585 2773 4698 7755 12411 19538 29735 44175 63653 89288 122136 161771 208555 260718 316058 371456 420854 461293 486380 494302 482710 454300 412714 361706 306514 251289 198961 152315 113296 81860 56876 38183 24728 15760 9889 6096 3564 2056 1118 572 280 122 51 20 8 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 2 3 12 37 93 208 464 845 1678 2847 4981 8229 13278 20339 30160 44098 61056 83227 109190 138081 170700 201385 230173 251797 266351 268121 259245 242432 217500 188291 158083 127968 99347 74797 55187 39170 26710 17227 11088 7009 4464 2558 1559 834 457 226 96 41 16 9
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 249 484 918 1678 2981 5162 8600 14089 22385 34716 52404 76931 109627 152296 205869 269611 343945 425248 509537 591554 662678 716553 746099 749061 722421 671959 604138 524014 439580 357044 280283 212643 156657 112063 77353 51438 32987 20977 13105 8028 4614 2677 1406 737 348 147 61 24 9
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 249 484 918 1678 2981 5162 8600 14089 22385 34716 52404 76931 109627 152296 205869 269611 343945 425248 509537 591554 662678 716553 746099 749061 722421 671959 604138 524014 439580 357044 280283 212643 156657 112063 77353 51438 32987 20977 13105 8028 4614 2677 1406 737 348 147 61 24 9
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 1.96094 1.95582 1.92149 1.86819 1.83194 1.80141 1.75591 1.73651 1.70793 1.67804 1.65298 1.62507 1.5976 1.57475 1.5498 1.52383 1.50217 1.47836 1.45498 1.43196 1.40879 1.38519 1.36246 1.34145 1.32002 1.30129 1.28487 1.26866 1.25394 1.24058 1.22776 1.21524 1.20391 1.1928 1.18273 1.17136 1.16056 1.15815 1.15331 1.14742 1.13079 1.13459 1.10758 1.11735 1.09227 1.07184 1.06803 1.06557 1.04167 1

tree_stats_height=57
tree_stats_numInternals=6555974
tree_stats_numLeaves=3441669
tree_stats_numNodes=9997643
tree_stats_numKeys=9997643

tree_stats_avgDegreeInternal=1.52497
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34425
tree_stats_avgKeyDepth=30.5402

4NodeIxPvL9tx_safety0EE_object_size=32
4NodeIxPvL9tx_safety0EE_allocated_count=0
4NodeIxPvL9tx_safety0EE_allocated_size=0MB
4NodeIxPvL9tx_safety0EE_get_from_pool=0
4NodeIxPvL9tx_safety0EE_deallocated=0
4NodeIxPvL9tx_safety0EE_limbo_count=0
4NodeIxPvL9tx_safety0EE_limbo_details=0 0 0 

global_epoch_counter=7414


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:22 2:55 4:4879 8:193852 16:174070 32:20 64:0 128:126
    [2^00, 2^01]: 22
    (2^01, 2^02]: 55
    (2^02, 2^03]: 4879
    (2^03, 2^04]: 193852
    (2^04, 2^05]: 174070
    (2^05, 2^06]: 20
    (2^06, 2^07]: 0
    (2^07, 2^08]: 126
sum_limbo_reclamation_event_size_total=5739928
count_limbo_reclamation_event_size_by_thread=5829 5829 5828 5828 5828 5828 5828 5828 5828 5828 5829 5829 5828 5828 5828 5829 5828 5829 5829 5829 5828 5829 5829 5829 5828 5829 5828 5828 5828 5829 5829 5829 5829 5829 5828 5828 5829 5828 5829 5828 5829 5829 5828 5828 5828 5828 5828 5829 5829 5828 5829 5828 5829 5828 5829 5829 5829 5828 5829 5828 5829 5828 5829 5829
count_limbo_reclamation_event_size_total=373024
sum_limbo_reclamation_event_count_total=373198
first_thread_announced_epoch_by_thread=14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828 14828
sum_num_inserts_by_thread=180457 180499 178771 180604 181355 180448 179984 179810 179953 179527 179185 178524 178873 178835 177859 177553 178284 180769 179783 178946 180060 179031 179415 179833 180023 177794 178259 177799 177530 176797 177459 179281 181994 181251 179759 180256 180845 180631 178675 179406 179437 179510 178096 179091 178749 181428 180574 180255 179574 180013 180468 179425 179643 178279 178342 178051 177906 177578 177008 180416 180265 180050 179752 179584
sum_num_inserts_total=11479611
sum_num_deletes_by_thread=180479 181072 178809 180054 180707 181148 180332 180765 179015 180042 178820 179054 179617 177813 178367 177781 178500 180504 179732 179050 180483 180496 178758 179950 179174 178258 177009 177142 177831 177726 177582 179614 181777 181401 180114 180387 180998 181342 178934 179245 179795 179148 177859 179221 178312 181028 180748 180492 179831 179667 179854 179751 178984 178329 178567 178277 177442 177388 177008 180752 180278 180260 179313 180109
sum_num_deletes_total=11482295
sum_num_searches_by_thread=3252915 3248360 3233989 3246216 3263467 3259404 3244069 3251197 3241310 3234753 3229764 3222829 3223167 3210710 3202484 3201211 3204214 3242757 3231963 3231481 3247283 3234638 3227658 3237576 3230749 3210671 3195560 3193241 3200199 3195837 3195949 3229327 3268334 3261651 3246740 3253786 3249149 3260757 3229782 3233004 3229623 3229115 3206413 3213053 3212816 3261685 3251842 3246661 3234323 3230019 3236054 3235645 3218055 3212507 3207401 3198471 3201629 3200332 3190573 3241805 3252460 3238327 3239222 3236607
sum_num_searches_total=206702789
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=3613851 3609931 3591569 3606874 3625529 3621000 3604385 3611772 3600278 3594322 3587769 3580407 3581657 3567358 3558710 3556545 3560998 3604030 3591478 3589477 3607826 3594165 3585831 3597359 3589946 3566723 3550828 3548182 3555560 3550360 3550990 3588222 3632105 3624303 3606613 3614429 3610992 3622730 3587391 3591655 3588855 3587773 3562368 3571365 3569877 3624141 3613164 3607408 3593728 3589699 3596376 3594821 3576682 3569115 3564310 3554799 3556977 3555298 3544589 3602973 3613003 3598637 3598287 3596300
average_num_operations_total=3588510
stdev_num_operations_total=2890
sum_num_operations_total=229664695
min_num_operations_total=3544589
max_num_operations_total=3632105
first_time_thread_terminate_by_thread=10000109 10000071 10000068 10000069 10000073 10000073 10000073 10000073 10000072 10000072 10000072 10000072 10000074 10000074 10000074 10000074 10000069 10000069 10000069 10000069 10000070 10000070 10000070 10000070 10000074 10000074 10000074 10000074 10000074 10000074 10000074 10000074 10000073 10000073 10000073 10000073 10000072 10000072 10000072 10000072 10000071 10000071 10000071 10000071 10000071 10000071 10000071 10000071 10000072 10000072 10000072 10000072 10000074 10000074 10000074 10000074 10000073 10000073 10000073 10000073 10000072 10000072 10000072 10000072
min_time_thread_terminate_total=10000068
max_time_thread_terminate_total=10000109
first_time_thread_start_by_thread=6 2 2 2 3 3 3 3 3 3 3 3 3 3 3 3 4 4 4 4 5 5 5 5 6 6 6 6 3 4 4 4 5 5 5 5 7 7 7 7 4 4 4 4 6 6 6 6 10 9 9 9 8 8 8 8 8 8 8 8 9 9 9 9
min_time_thread_start_total=2
max_time_thread_start_total=10
sum_duration_all_ops_total=

threads_final_keysum=99977138134765
threads_final_size=9997643
final_keysum=99977138134765
final_size=9997643
validate_result=success
Validation OK.
Structural validation OK.

total_find=206702789
total_rq=0
total_inserts=11479611
total_deletes=11482295
total_updates=22961906
total_queries=206702789
total_ops=229664695
find_throughput=20670278
rq_throughput=0
update_throughput=2296190
query_throughput=20670278
total_throughput=22966469


total find                    : 206702789
total rq                      : 0
total inserts                 : 11479611
total deletes                 : 11482295
total updates                 : 22961906
total queries                 : 206702789
total ops                     : 229664695
find throughput               : 20670278
rq throughput                 : 0
update throughput             : 2296190
query throughput              : 20670278
total throughput              : 22966469

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

garbage=274357930111799
total_execution_walltime=15.549s
REALTIME_MAIN_END_PERF_FORMAT=219294.371075705
TL2 system shutdown:
  GCLOCK=0x2115EF0 Starts=291217227 Aborts=1043525
  Overflows: R=0 W=0 L=0
[time_cmd_output] time_elapsed_sec=15.68, faults_major=1, faults_minor=240264, mem_maxresident_kb=634880, user_cputime=949.19, sys_cputime=31.80, percent_cpu=6255%
timeout=false
algorithm=brown_int_bst_tm_auto.debra.tl2
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1