__step=000025
__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_sigouin_int_avl_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=data000025.txt
__path_data=data/data000025.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=219747.112727005
binary=./brown_sigouin_int_avl_tm_auto.debra.tl2
parsed custom binding: 0-63,128-191,64-127,192-255
DS_TYPENAME=brown_sigouin_int_avl_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=48
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.023s
prefilling_size=3690304 prefilling_elapsed_millis=1s
prefilling_size=3991445 prefilling_elapsed_millis=1.101s
prefilling_size=4278382 prefilling_elapsed_millis=1.201s
prefilling_size=4552677 prefilling_elapsed_millis=1.301s
prefilling_size=4811068 prefilling_elapsed_millis=1.401s
prefilling_size=5058597 prefilling_elapsed_millis=1.501s
prefilling_size=5292992 prefilling_elapsed_millis=1.601s
prefilling_size=5516736 prefilling_elapsed_millis=1.701s
prefilling_size=5729961 prefilling_elapsed_millis=1.801s
prefilling_size=5931899 prefilling_elapsed_millis=1.901s
prefilling_size=6122727 prefilling_elapsed_millis=2.002s
prefilling_size=6305814 prefilling_elapsed_millis=2.102s
prefilling_size=6480379 prefilling_elapsed_millis=2.202s
prefilling_size=6645981 prefilling_elapsed_millis=2.302s
prefilling_size=6803237 prefilling_elapsed_millis=2.402s
prefilling_size=6954190 prefilling_elapsed_millis=2.502s
prefilling_size=7098843 prefilling_elapsed_millis=2.602s
prefilling_size=7235162 prefilling_elapsed_millis=2.702s
prefilling_size=7365804 prefilling_elapsed_millis=2.803s
prefilling_size=7487982 prefilling_elapsed_millis=2.903s
prefilling_size=7603794 prefilling_elapsed_millis=3.003s
prefilling_size=7709247 prefilling_elapsed_millis=3.103s
prefilling_size=7817221 prefilling_elapsed_millis=3.203s
prefilling_size=7915783 prefilling_elapsed_millis=3.304s
prefilling_size=8009130 prefilling_elapsed_millis=3.404s
prefilling_size=8098223 prefilling_elapsed_millis=3.504s
prefilling_size=8184228 prefilling_elapsed_millis=3.604s
prefilling_size=8265631 prefilling_elapsed_millis=3.704s
prefilling_size=8343641 prefilling_elapsed_millis=3.804s
prefilling_size=8418284 prefilling_elapsed_millis=3.904s
prefilling_size=8490334 prefilling_elapsed_millis=4.004s
prefilling_size=8561354 prefilling_elapsed_millis=4.104s
prefilling_size=8629698 prefilling_elapsed_millis=4.205s
prefilling_size=8693490 prefilling_elapsed_millis=4.305s
prefilling_size=8754908 prefilling_elapsed_millis=4.405s
prefilling_size=8813602 prefilling_elapsed_millis=4.505s
prefilling_size=8868350 prefilling_elapsed_millis=4.605s
prefilling_size=8921385 prefilling_elapsed_millis=4.705s
prefilling_size=8971942 prefilling_elapsed_millis=4.805s
prefilling_size=9020054 prefilling_elapsed_millis=4.905s
prefilling_size=9066168 prefilling_elapsed_millis=5.006s
Info: prefilling requires an additional insert phase to complete.
Info: prefilling using INSERTION ONLY.
timing_start inserting 933801 keys with 64 threads...
tid=0 thread_prefill_amount=131250 percent_done_estimate=899.5 elapsed_s=5 est_remaining_s=-10 / -5
tid=0 thread_prefill_amount=134375 percent_done_estimate=921.0 elapsed_s=5 est_remaining_s=-10 / -5
tid=0 thread_prefill_amount=137500 percent_done_estimate=942.4 elapsed_s=5 est_remaining_s=-11 / -5
tid=0 thread_prefill_amount=140625 percent_done_estimate=963.8 elapsed_s=5 est_remaining_s=-11 / -5
timing_elapsed 0.199275s
prefilling_size=10000000 prefilling_elapsed_millis=0.209s
finished prefilling to size 10000000 for expected size 10000000 keysum=99998430139806, performing 50159306 updates; total_prefilling_elapsed_ms=209 ms)
pref_size=10000000
pref_millis=209
prefill_elapsed_ms=209
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=219752.498873334
REALTIME_END_PERF_FORMAT=219762.498944083

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

tree_stats_computeWalltime=0.026s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262069 519479 962486 1424282 1380453 737838 182297 15605 219 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 72 4224 66084 410358 1140144 1488141 903069 231395 19524 261
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262141 523703 1028570 1834640 2520597 2225979 1085366 247000 19743 261
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262141 523703 1028570 1834640 2520597 2225979 1085366 247000 19743 261
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99998 1.99807 1.9721 1.84793 1.59756 1.33545 1.15612 1.05961 1.01675 1.00213 1

tree_stats_height=28
tree_stats_numInternals=5746871
tree_stats_numLeaves=4263272
tree_stats_numNodes=10010143
tree_stats_numKeys=10010143

tree_stats_avgDegreeInternal=1.74184
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.4259
tree_stats_avgKeyDepth=21.7137


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0
    [2^00, 2^01]: 0
sum_limbo_reclamation_event_size_total=
count_limbo_reclamation_event_size_by_thread=
count_limbo_reclamation_event_size_total=
sum_limbo_reclamation_event_count_total=365030
first_thread_announced_epoch_by_thread=14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014 14014
sum_num_inserts_by_thread=175246 175422 175452 174282 175450 175090 174313 175047 174628 174546 173730 174220 174516 174814 174994 175678 174946 175025 174930 174753 175381 174485 174452 174420 173655 173904 173474 173818 174284 175268 174884 173887 176979 176501 176403 174785 175158 176732 176216 175534 175972 175543 175777 175850 175762 176453 176158 175294 175219 174616 173943 174333 174597 175190 173066 174066 174860 174777 174940 175261 175696 175869 175391 175197
sum_num_inserts_total=11201132
sum_num_deletes_by_thread=174796 176035 175082 174744 174744 175332 175067 174323 174313 175112 174404 173588 174569 174582 173808 174969 174587 175023 175177 175627 175317 175356 174390 174319 174238 174111 174098 174181 174147 174518 174760 173684 177115 175792 175476 175860 175713 176030 175406 175053 175402 175543 175296 175620 176212 176022 175702 175415 175669 174897 174235 174132 175665 175180 174154 174171 174263 175900 175226 174997 175902 176820 175261 175250
sum_num_deletes_total=11202380
sum_num_searches_by_thread=3157711 3165470 3150932 3137867 3159288 3169662 3152394 3144640 3143740 3140660 3133321 3135718 3143007 3147599 3141661 3147919 3152075 3152642 3152390 3151577 3150557 3162321 3142284 3141641 3134362 3134240 3136289 3125670 3133664 3142829 3144461 3136094 3184775 3174173 3166319 3167670 3164680 3170041 3161533 3164953 3162185 3153952 3153553 3167832 3163072 3163557 3164268 3157434 3150369 3150626 3130460 3137180 3143980 3144047 3128763 3128703 3141730 3150362 3149528 3150283 3163402 3165989 3148683 3160425
sum_num_searches_total=201649212
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=3507753 3516927 3501466 3486893 3509482 3520084 3501774 3494010 3492681 3490318 3481455 3483526 3492092 3496995 3490463 3498566 3501608 3502690 3502497 3501957 3501255 3512162 3491126 3490380 3482255 3482255 3483861 3473669 3482095 3492615 3494105 3483665 3538869 3526466 3518198 3518315 3515551 3522803 3513155 3515540 3513559 3505038 3504626 3519302 3515046 3516032 3516128 3508143 3501257 3500139 3478638 3485645 3494242 3494417 3475983 3476940 3490853 3501039 3499694 3500541 3515000 3518678 3499335 3510872
average_num_operations_total=3500823
stdev_num_operations_total=1783
sum_num_operations_total=224052724
min_num_operations_total=3473669
max_num_operations_total=3538869
first_time_thread_terminate_by_thread=10000111 10000070 10000070 10000077 10000071 10000071 10000071 10000082 10000073 10000073 10000073 10000073 10000073 10000074 10000074 10000073 10000071 10000071 10000071 10000071 10000073 10000073 10000073 10000073 10000071 10000071 10000071 10000071 10000073 10000073 10000073 10000073 10000072 10000072 10000072 10000072 10000072 10000072 10000072 10000072 10000074 10000074 10000074 10000074 10000070 10000070 10000070 10000070 10000074 10000074 10000074 10000074 10000074 10000074 10000074 10000074 10000071 10000070 10000070 10000071 10000072 10000072 10000072 10000072
min_time_thread_terminate_total=10000070
max_time_thread_terminate_total=10000111
first_time_thread_start_by_thread=8 3 3 3 6 6 6 6 6 6 6 6 6 6 6 6 7 7 7 7 4 4 4 4 6 6 6 7 4 4 4 4 5 5 5 5 4 4 4 4 5 5 5 5 3 3 3 3 4 4 4 4 5 5 5 5 4 4 4 4 5 5 5 5
min_time_thread_start_total=3
max_time_thread_start_total=8
sum_duration_all_ops_total=

threads_final_keysum=100101317619303
threads_final_size=10010143
final_keysum=100101317619303
final_size=10010143
validate_result=success
Validation OK.
Structural validation OK.

total_find=201649212
total_rq=0
total_inserts=11201132
total_deletes=11202380
total_updates=22403512
total_queries=201649212
total_ops=224052724
find_throughput=20164921
rq_throughput=0
update_throughput=2240351
query_throughput=20164921
total_throughput=22405272


total find                    : 201649212
total rq                      : 0
total inserts                 : 11201132
total deletes                 : 11202380
total updates                 : 22403512
total queries                 : 201649212
total ops                     : 224052724
find throughput               : 20164921
rq throughput                 : 0
update throughput             : 2240351
query throughput              : 20164921
total throughput              : 22405272

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

garbage=299480611411283
total_execution_walltime=15.547s
REALTIME_MAIN_END_PERF_FORMAT=219762.661010314
TL2 system shutdown:
  GCLOCK=0x1EB2C5C Starts=278414033 Aborts=5960138
  Overflows: R=0 W=0 L=0
[time_cmd_output] time_elapsed_sec=15.73, faults_major=1, faults_minor=639411, mem_maxresident_kb=1433828, user_cputime=947.70, sys_cputime=40.15, percent_cpu=6276%
timeout=false
algorithm=brown_sigouin_int_avl_tm_auto.debra.tl2
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1