__step=000828
__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 128 -nprefill 128 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 50.0 50.0 -k 2000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000828.txt
__path_data=data/data000828.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=216859.704281581
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=50
DEL_FRAC=50
RQ=0
RQSIZE=0
MAXKEY=2000000
PREFILL_THREADS=128
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=128
WORK_THREADS=128
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
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,128,129,130,131,132,133,134,135,136,137,138,139,140,141,142,143,144,145,146,147,148,149,150,151,152,153,154,155,156,157,158,159,160,161,162,163,164,165,166,167,168,169,170,171,172,173,174,175,176,177,178,179,180,181,182,183,184,185,186,187,188,189,190,191


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.026s
prefilling_size=999380 prefilling_elapsed_millis=1s
finished prefilling to size 999453 for expected size 1000000 keysum=999702850318, performing 51537716 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=999453
pref_millis=1102
prefill_elapsed_ms=1119
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=380

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=216860.883942146
REALTIME_END_PERF_FORMAT=216870.884035116

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

tree_stats_computeWalltime=0.126s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 253 475 862 1539 2667 4485 7163 10978 16265 23112 31490 40764 51328 62463 72767 80940 86287 87421 84964 78252 67780 55582 43381 31737 22410 14841 9258 5364 3028 1617 782 365 150 68 27 11 6 5 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 3 31 88 185 411 849 1807 3348 5691 9418 14734 22216 30200 40193 52159 64594 75593 85153 89878 91676 88724 79978 67783 55025 41064 29979 20424 13152 7700 4439 2452 1199 580 232 109 43 16 7 9 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 506 950 1724 3078 5334 8970 14326 21956 32530 46224 62980 81528 102656 124926 145534 161880 172574 174842 169928 156504 135560 111164 86762 63474 44820 29682 18516 10728 6056 3234 1564 730 300 136 54 22 12 10 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 3 31 87 185 411 849 1807 3348 5691 9418 14734 22216 30200 40193 52159 64594 75593 85153 89878 91676 88724 79978 67783 55025 41064 29979 20424 13152 7700 4439 2452 1199 580 232 109 43 16 7 9 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 1.98828 1.93874 1.90632 1.89269 1.86647 1.84083 1.79855 1.7663 1.7408 1.71048 1.68125 1.64725 1.62958 1.60847 1.58248 1.55616 1.53303 1.50657 1.48595 1.4605 1.43309 1.41002 1.39024 1.36579 1.35306 1.33112 1.31191 1.2897 1.28225 1.26701 1.24181 1.23338 1.20548 1.22667 1.19853 1.2037 1.27273 1.41667 1.1 1

tree_stats_height=48
tree_stats_numInternals=1001143
tree_stats_numLeaves=1001144
tree_stats_numNodes=2002287
tree_stats_numKeys=1001143

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

tree_stats_bytesAtDepth=40 80 160 320 640 1280 2560 5120 10240 20240 38000 68960 123120 213360 358800 573040 878240 1301200 1848960 2519200 3261120 4106240 4997040 5821360 6475200 6902960 6993680 6797120 6260160 5422400 4446560 3470480 2538960 1792800 1187280 740640 429120 242240 129360 62560 29200 12000 5440 2160 880 480 400 80
tree_stats_sizeInBytes=80091480

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:43 4:2 8:4 16:9 32:16 64:54 128:174 256:271800 512:235172 1024:309 2048:126
    (2^01, 2^02]: 43
    (2^02, 2^03]: 2
    (2^03, 2^04]: 4
    (2^04, 2^05]: 9
    (2^05, 2^06]: 16
    (2^06, 2^07]: 54
    (2^07, 2^08]: 174
    (2^08, 2^09]: 271800
    (2^09, 2^10]: 235172
    (2^10, 2^11]: 309
    (2^11, 2^12]: 126
sum_limbo_reclamation_event_size_total=256895106
count_limbo_reclamation_event_size_by_thread=3967 3968 3967 3963 3964 3966 3967 3967 3964 3967 3966 3966 3967 3967 3963 3967 3968 3966 3968 3966 3968 3966 3966 3968 3964 3967 3968 3965 3967 3967 3966 3965 3968 3966 3967 3968 3968 3967 3967 3966 3966 3967 3967 3966 3967 3966 3967 3966 3966 3966 3966 3967 3967 3968 3967 3966 3968 3967 3968 3968 3967 3966 3965 3965 3967 3967 3968 3967 3964 3967 3966 3968 3964 3967 3967 3967 3964 3964 3967 3966 3967 3967 3967 3966 3965 3967 3966 3967 3967 3966 3964 3967 3966 3966 3967 3968 3967 3968 3966 3967 3966 3967 3966 3968 3966 3967 3967 3967 3967 3967 3968 3966 3967 3967 3968 3967 3966 3967 3967 3966 3965 3966 3964 3967 3965 3963 3967 3967
count_limbo_reclamation_event_size_total=507709
sum_limbo_reclamation_event_count_total=508105
first_thread_announced_epoch_by_thread=8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700 8700
sum_num_inserts_by_thread=2015905 2014476 1997785 2000049 2011018 2011197 2003732 1997293 2014846 2020795 2007432 2008496 2016228 2016462 2004602 1987225 1989335 2006676 1998424 1995563 2001459 1985596 2023583 2017781 2024587 2025792 1999279 2005531 2021104 2010397 1972861 1998431 1996401 1992383 1992028 1984628 2016974 2009744 2017404 2016145 2011702 2006256 2007909 1983794 2002647 2004598 1980234 1993925 1990528 1994337 2009240 2002398 1998617 2004016 2006732 2007496 2003488 1992959 1979948 1978119 1985338 1978989 1982307 1974817 1986806 2007634 2009816 2004670 2010063 2014178 2019249 2007767 1994268 1986580 1986767 1977909 1988782 1985122 1983978 2004432 2014259 2004473 2016945 2019143 2007430 2012597 1996972 2005158 2006213 2006560 1986490 2000800 2013557 2027488 2021611 2027165 2022211 2024951 2021013 2019898 2021366 2018008 2016117 2017092 2005041 2021055 2019676 2025990 2039688 2037133 2031779 2014006 2032044 2039680 2019642 2026304 2016275 2026434 2024357 2022484 2022774 2030857 2021985 2022474 2027041 2033960 2018417 2032996
sum_num_inserts_total=257017671
sum_num_deletes_by_thread=2016015 2013173 1996181 1997729 2007327 2011987 2002847 1995961 2010812 2021190 2010583 2010718 2015120 2015223 2005460 1987055 1988752 2007631 1997317 1995907 2001504 1987616 2024362 2020788 2022588 2026428 2000962 2002318 2021792 2008053 1973845 2000602 1994363 1997538 1994179 1984179 2018760 2012323 2017252 2017817 2016271 2005420 2008340 1988172 2002936 2004804 1978377 1994593 1989021 1995128 2011005 2000283 1999142 2005879 2008062 2005387 2004355 1993145 1981481 1978266 1982316 1979656 1982462 1974101 1988087 2008006 2010378 2004579 2012874 2015441 2015535 2011917 1993882 1987174 1983942 1978075 1989303 1989511 1982500 2007013 2017338 2005679 2020309 2019830 2011305 2010043 1997722 2003164 2006576 2007807 1986541 2003677 2014585 2029589 2019621 2023147 2020329 2026501 2022305 2020848 2020929 2015782 2020005 2018894 2006191 2022242 2019856 2022981 2038494 2037879 2030368 2012770 2027155 2037904 2019482 2025725 2017861 2028673 2026075 2023790 2021185 2028396 2024694 2025249 2028758 2034446 2017382 2031199
sum_num_deletes_total=257052357
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=4031920 4027649 3993966 3997778 4018345 4023184 4006579 3993254 4025658 4041985 4018015 4019214 4031348 4031685 4010062 3974280 3978087 4014307 3995741 3991470 4002963 3973212 4047945 4038569 4047175 4052220 4000241 4007849 4042896 4018450 3946706 3999033 3990764 3989921 3986207 3968807 4035734 4022067 4034656 4033962 4027973 4011676 4016249 3971966 4005583 4009402 3958611 3988518 3979549 3989465 4020245 4002681 3997759 4009895 4014794 4012883 4007843 3986104 3961429 3956385 3967654 3958645 3964769 3948918 3974893 4015640 4020194 4009249 4022937 4029619 4034784 4019684 3988150 3973754 3970709 3955984 3978085 3974633 3966478 4011445 4031597 4010152 4037254 4038973 4018735 4022640 3994694 4008322 4012789 4014367 3973031 4004477 4028142 4057077 4041232 4050312 4042540 4051452 4043318 4040746 4042295 4033790 4036122 4035986 4011232 4043297 4039532 4048971 4078182 4075012 4062147 4026776 4059199 4077584 4039124 4052029 4034136 4055107 4050432 4046274 4043959 4059253 4046679 4047723 4055799 4068406 4035799 4064195
average_num_operations_total=4016172
stdev_num_operations_total=2703
sum_num_operations_total=514070028
min_num_operations_total=3946706
max_num_operations_total=4078182
first_time_thread_terminate_by_thread=10000608 10000092 10000324 10000213 10000378 10000568 10000402 10000361 10000503 10000159 10000264 10000399 10000377 10000314 10000204 10000343 10000455 10000475 10000091 10000229 10000092 10000149 10000144 10000129 10000380 10000476 10000142 10000180 10000473 10000414 10000399 10000464 10000438 10000401 10000475 10000093 10000253 10000284 10000186 10000096 10000628 10000378 10000461 10000283 10000518 10000239 10000353 10000526 10000161 10000254 10000533 10000311 10000093 10000359 10000455 10000452 10000404 10000283 10000242 10000392 10000092 10000211 10000326 10000331 10000192 10000304 10000232 10000478 10000135 10000091 10000348 10000125 10000123 10000095 10000157 10000092 10000294 10000534 10000322 10000417 10000091 10000091 10000352 10000220 10000214 10000209 10000179 10000340 10000567 10000201 10000393 10000573 10000526 10000436 10000448 10000349 10000093 10000438 10000550 10000484 10000121 10000234 10000168 10000470 10000182 10000309 10000496 10000487 10000514 10000449 10000128 10000093 10000481 10000477 10000383 10000296 10000406 10000470 10000409 10000527 10000105 10000573 10000321 10000457 10000169 10000398 10000244 10000150
min_time_thread_terminate_total=10000091
max_time_thread_terminate_total=10000628
first_time_thread_start_by_thread=5 5 5 5 6 6 6 6 6 6 6 6 7 7 7 8 9 9 9 9 7 7 7 7 7 7 7 7 9 9 9 9 8 8 8 8 8 8 8 8 7 7 7 7 6 6 6 6 6 6 6 6 8 8 8 8 8 8 8 8 7 7 7 7 5 5 5 5 6 6 6 6 6 6 6 6 7 7 7 8 9 9 9 9 7 7 7 7 7 7 7 7 9 9 9 9 8 8 8 8 8 8 8 8 7 7 7 7 6 6 6 6 6 6 6 6 8 8 8 8 8 8 8 8 7 7 7 7
min_time_thread_start_total=5
max_time_thread_start_total=9
sum_duration_all_ops_total=

threads_final_keysum=1001367055043
threads_final_size=1001143
final_keysum=1001367055043
final_size=1001143
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=257017671
total_deletes=257052357
total_updates=514070028
total_queries=0
total_ops=514070028
find_throughput=0
rq_throughput=0
update_throughput=51407002
query_throughput=0
total_throughput=51407002


total find                    : 0
total rq                      : 0
total inserts                 : 257017671
total deletes                 : 257052357
total updates                 : 514070028
total queries                 : 0
total ops                     : 514070028
find throughput               : 0
rq throughput                 : 0
update throughput             : 51407002
query throughput              : 0
total throughput              : 51407002

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

garbage=0
total_execution_walltime=11.456s
REALTIME_MAIN_END_PERF_FORMAT=216871.161250720
[time_cmd_output] time_elapsed_sec=11.56, faults_major=0, faults_minor=105650, mem_maxresident_kb=418844, user_cputime=1357.16, sys_cputime=53.42, percent_cpu=12199%
timeout=false
algorithm=guerraoui_ext_bst_ticket.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2