__step=000489
__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" ./guerraoui_ext_bst_ticket.debra -nwork 64 -nprefill 64 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 2000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000489.txt
__path_data=data/data000489.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=212761.652207992
binary=./guerraoui_ext_bst_ticket.debra
parsed custom binding: 0-63,128-191,64-127,192-255
DS_TYPENAME=guerraoui_ext_bst_ticket
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=2000000
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=40
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.013s
prefilling_size=999918 prefilling_elapsed_millis=1.001s
finished prefilling to size 999906 for expected size 1000000 keysum=1000488235854, performing 32545737 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=999906
pref_millis=1101
prefill_elapsed_ms=1120
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=894

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=212762.798981795
REALTIME_END_PERF_FORMAT=212772.799018813

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

tree_stats_computeWalltime=0.142s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 127 248 475 884 1602 2812 4717 7623 12001 18105 25842 35178 45225 55552 65286 73184 79641 83628 83525 80516 74102 64816 53749 41768 31102 21913 14347 9138 5497 3036 1585 849 440 225 110 46 23 4 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 1 6 21 66 166 392 907 1811 3245 5897 10368 16506 25131 34898 45818 57388 66727 75654 83731 86534 86930 83388 75883 65730 52434 40291 29479 19556 12779 7958 4487 2321 1258 655 340 174 69 42 8
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 254 496 950 1768 3204 5624 9434 15246 24002 36210 51684 70356 90450 111104 130572 146368 159282 167256 167050 161032 148204 129632 107498 83536 62204 43826 28694 18276 10994 6072 3170 1698 880 450 220 92 46 8
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 1 5 21 66 166 392 907 1811 3245 5897 10368 16506 25131 34898 45818 57388 66727 75654 83731 86534 86930 83388 75883 65730 52434 40291 29479 19556 12779 7958 4487 2321 1258 655 340 174 69 42 8
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 1.99219 1.97244 1.95766 1.93053 1.90611 1.87765 1.83873 1.80803 1.78716 1.75431 1.71367 1.68064 1.6428 1.61417 1.58761 1.56049 1.54411 1.52503 1.49938 1.48199 1.46017 1.43734 1.41463 1.38855 1.37232 1.35228 1.32736 1.31846 1.30078 1.27615 1.26103 1.26782 1.25913 1.25568 1.24444 1.20909 1.25 1.08696 1

tree_stats_height=46
tree_stats_numInternals=999048
tree_stats_numLeaves=999049
tree_stats_numNodes=1998097
tree_stats_numKeys=999048

tree_stats_avgDegreeInternal=2
tree_stats_avgDegreeLeaves=0.999999
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=26.2763

tree_stats_bytesAtDepth=40 80 160 320 640 1280 2560 5120 10160 19840 38000 70720 128160 224960 377360 609840 960080 1448400 2067360 2814240 3618000 4444160 5222880 5854720 6371280 6690240 6682000 6441280 5928160 5185280 4299920 3341440 2488160 1753040 1147760 731040 439760 242880 126800 67920 35200 18000 8800 3680 1840 320
tree_stats_sizeInBytes=79923880

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:2 4:86 8:9329 16:338227 32:291642 64:430 128:156
    (2^01, 2^02]: 2
    (2^02, 2^03]: 86
    (2^03, 2^04]: 9329
    (2^04, 2^05]: 338227
    (2^05, 2^06]: 291642
    (2^06, 2^07]: 430
    (2^07, 2^08]: 156
sum_limbo_reclamation_event_size_total=19546808
count_limbo_reclamation_event_size_by_thread=9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998
count_limbo_reclamation_event_size_total=639872
sum_limbo_reclamation_event_count_total=674944
first_thread_announced_epoch_by_thread=22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880 22880
sum_num_inserts_by_thread=327091 328158 325948 324817 327212 326073 324404 323144 323113 322381 320395 320863 325539 325481 323389 323557 324275 324812 322443 323956 322183 321600 318895 317194 318163 317236 316716 322933 323057 322879 321125 321140 324895 324931 323460 321565 320211 321346 320339 319337 318540 326444 323489 322595 325203 324991 322630 323115 320530 318699 316711 316329 316315 316184 315681 324248 323410 323556 322091 322836 322379 323067 322724 321856
sum_num_inserts_total=20619879
sum_num_deletes_by_thread=328105 327504 326980 324048 326573 326655 324149 322856 322944 321476 321268 320567 325635 325052 323454 323088 324624 324657 323147 322975 320831 320689 318083 319123 317596 318039 316328 323487 323175 323152 321285 320660 326415 325155 321964 320146 320430 320802 319652 318178 317734 325932 324000 323977 324789 325355 323311 323776 319837 319270 316986 315976 316999 317776 315334 322481 323045 324148 323134 323475 323079 322508 323156 321311
sum_num_deletes_total=20618336
sum_num_searches_by_thread=5898885 5898126 5878250 5842902 5890123 5875761 5825079 5823712 5814265 5795507 5766367 5771343 5858736 5849241 5826632 5827447 5838121 5834521 5813732 5811389 5785751 5767737 5733482 5726959 5721781 5721009 5700625 5820333 5817700 5805382 5791184 5789342 5854260 5849064 5802417 5773605 5777645 5777929 5749061 5743485 5712755 5865437 5833720 5815156 5852047 5845828 5823045 5817442 5764739 5736289 5703954 5698364 5709333 5707254 5679033 5820018 5825641 5825290 5806164 5807068 5811046 5818618 5810617 5799282
sum_num_searches_total=371137030
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=6554081 6553788 6531178 6491767 6543908 6528489 6473632 6469712 6460322 6439364 6408030 6412773 6509910 6499774 6473475 6474092 6487020 6483990 6459322 6458320 6428765 6410026 6370460 6363276 6357540 6356284 6333669 6466753 6463932 6451413 6433594 6431142 6505570 6499150 6447841 6415316 6418286 6420077 6389052 6381000 6349029 6517813 6481209 6461728 6502039 6496174 6468986 6464333 6405106 6374258 6337651 6330669 6342647 6341214 6310048 6466747 6472096 6472994 6451389 6453379 6456504 6464193 6456497 6442449
average_num_operations_total=6443363
stdev_num_operations_total=7474
sum_num_operations_total=412375245
min_num_operations_total=6310048
max_num_operations_total=6554081
first_time_thread_terminate_by_thread=10000040 10000040 10000040 10000040 10000041 10000041 10000041 10000041 10000041 10000041 10000041 10000041 10000038 10000038 10000038 10000038 10000041 10000041 10000041 10000041 10000040 10000040 10000040 10000040 10000038 10000038 10000038 10000038 10000042 10000042 10000042 10000042 10000038 10000037 10000038 10000037 10000040 10000040 10000040 10000040 10000038 10000038 10000038 10000038 10000039 10000039 10000039 10000039 10000040 10000040 10000040 10000040 10000039 10000039 10000039 10000039 10000039 10000039 10000039 10000039 10000041 10000041 10000041 10000041
min_time_thread_terminate_total=10000037
max_time_thread_terminate_total=10000042
first_time_thread_start_by_thread=5 5 5 5 6 6 6 6 5 5 5 5 7 8 8 8 5 5 5 5 5 5 5 5 7 7 7 7 6 6 6 6 8 8 8 8 6 6 7 6 7 7 7 7 4 4 4 4 4 4 4 4 4 4 4 4 3 3 3 3 4 4 4 4
min_time_thread_start_total=3
max_time_thread_start_total=8
sum_duration_all_ops_total=

threads_final_keysum=998964770407
threads_final_size=999048
final_keysum=998964770407
final_size=999048
validate_result=success
Validation OK.
Structural validation OK.

total_find=371137030
total_rq=0
total_inserts=20619879
total_deletes=20618336
total_updates=41238215
total_queries=371137030
total_ops=412375245
find_throughput=37113703
rq_throughput=0
update_throughput=4123821
query_throughput=37113703
total_throughput=41237524


total find                    : 371137030
total rq                      : 0
total inserts                 : 20619879
total deletes                 : 20618336
total updates                 : 41238215
total queries                 : 371137030
total ops                     : 412375245
find throughput               : 37113703
rq throughput                 : 0
update throughput             : 4123821
query throughput              : 37113703
total throughput              : 41237524

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

garbage=118885667727118
total_execution_walltime=11.384s
REALTIME_MAIN_END_PERF_FORMAT=212773.37048551
[time_cmd_output] time_elapsed_sec=11.49, faults_major=0, faults_minor=99655, mem_maxresident_kb=399760, user_cputime=740.21, sys_cputime=6.02, percent_cpu=6493%
timeout=false
algorithm=guerraoui_ext_bst_ticket.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1