__step=000713
__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 50.0 50.0 -k 20000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000713.txt
__path_data=data/data000713.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=215422.357800553
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=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=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.021s
prefilling_size=7343397 prefilling_elapsed_millis=1s
prefilling_size=7615750 prefilling_elapsed_millis=1.101s
prefilling_size=7855130 prefilling_elapsed_millis=1.201s
prefilling_size=8067613 prefilling_elapsed_millis=1.301s
prefilling_size=8257256 prefilling_elapsed_millis=1.401s
prefilling_size=8427172 prefilling_elapsed_millis=1.501s
prefilling_size=8579050 prefilling_elapsed_millis=1.601s
prefilling_size=8714992 prefilling_elapsed_millis=1.701s
prefilling_size=8836223 prefilling_elapsed_millis=1.801s
prefilling_size=8947611 prefilling_elapsed_millis=1.901s
prefilling_size=9047200 prefilling_elapsed_millis=2.002s
prefilling_size=9135507 prefilling_elapsed_millis=2.102s
prefilling_size=9217251 prefilling_elapsed_millis=2.202s
prefilling_size=9289606 prefilling_elapsed_millis=2.302s
prefilling_size=9354742 prefilling_elapsed_millis=2.402s
prefilling_size=9413920 prefilling_elapsed_millis=2.502s
prefilling_size=9466363 prefilling_elapsed_millis=2.602s
prefilling_size=9515432 prefilling_elapsed_millis=2.702s
prefilling_size=9559449 prefilling_elapsed_millis=2.802s
prefilling_size=9600354 prefilling_elapsed_millis=2.903s
prefilling_size=9636164 prefilling_elapsed_millis=3.003s
prefilling_size=9668372 prefilling_elapsed_millis=3.103s
prefilling_size=9697489 prefilling_elapsed_millis=3.203s
prefilling_size=9724459 prefilling_elapsed_millis=3.304s
prefilling_size=9750783 prefilling_elapsed_millis=3.404s
prefilling_size=9772675 prefilling_elapsed_millis=3.504s
prefilling_size=9792538 prefilling_elapsed_millis=3.604s
prefilling_size=9811612 prefilling_elapsed_millis=3.704s
finished prefilling to size 9811588 for expected size 10000000 keysum=98123332302838, performing 79598585 updates; total_prefilling_elapsed_ms=3805 ms)
pref_size=9811588
pref_millis=3805
prefill_elapsed_ms=3817
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=2073

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=215426.217227136
REALTIME_END_PERF_FORMAT=215436.217287411

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

tree_stats_computeWalltime=0.318s

tree_stats_numInternalsAtDepth=1 2 4 8 16 31 62 124 247 491 961 1833 3410 6202 10994 19052 32102 52469 82587 124612 180054 249999 332239 424136 519992 610113 686043 737947 764210 760603 728966 673246 600642 518993 435639 355976 283624 220323 166867 123286 89206 63833 45104 31528 21283 14239 9208 5967 3884 2434 1575 1070 645 369 223 103 48 15 2 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 1 0 0 1 3 21 89 256 618 1410 2936 6002 11735 22351 40562 69170 110109 167759 240342 328280 429871 534183 634139 711684 767817 792240 784686 745850 682291 602347 515302 428328 346925 273779 210448 157366 114579 82562 58680 41773 28327 19270 12449 8050 5334 3293 2080 1495 921 515 343 158 81 28 3 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 62 124 248 494 982 1922 3666 6820 12404 21988 38104 64204 104938 165174 249224 360108 499998 664478 848272 1039984 1220226 1372086 1475894 1528420 1521206 1457932 1346492 1201284 1037986 871278 711952 567248 440646 333734 246572 178412 127666 90208 63056 42566 28478 18416 11934 7768 4868 3150 2140 1290 738 446 206 96 30 4 2
tree_stats_numKeysAtDepth=0 0 0 0 0 1 0 0 1 3 21 89 256 618 1410 2936 6002 11735 22351 40561 69170 110109 167759 240342 328280 429871 534183 634139 711684 767817 792240 784686 745850 682291 602347 515302 428328 346925 273779 210448 157366 114579 82562 58680 41773 28327 19270 12449 8050 5334 3293 2080 1495 921 515 343 158 81 28 3 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 1.96875 2 2 1.99597 1.99393 1.97862 1.95369 1.93017 1.90938 1.88633 1.86647 1.84248 1.81722 1.78701 1.75442 1.72246 1.69423 1.66448 1.6383 1.613 1.58666 1.56223 1.53783 1.51779 1.49764 1.4792 1.46178 1.44608 1.43203 1.4197 1.40857 1.39838 1.38841 1.37869 1.36941 1.36178 1.35778 1.3533 1.3495 1.33753 1.33452 1.32334 1.32401 1.32546 1.31334 1.32354 1.33968 1.3014 1.28605 1.30217 1.23094 1.23301 1.15625 1.06667 1.25 1

tree_stats_height=61
tree_stats_numInternals=9998843
tree_stats_numLeaves=9998844
tree_stats_numNodes=19997687
tree_stats_numKeys=9998843

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

tree_stats_bytesAtDepth=40 80 160 320 640 1280 2480 4960 9920 19760 39280 76880 146640 272800 496160 879520 1524160 2568160 4197520 6606960 9968960 14404320 19999920 26579120 33930880 41599360 48809040 54883440 59035760 61136800 60848240 58317280 53859680 48051360 41519440 34851120 28478080 22689920 17625840 13349360 9862880 7136480 5106640 3608320 2522240 1702640 1139120 736640 477360 310720 194720 126000 85600 51600 29520 17840 8240 3840 1200 160 80
tree_stats_sizeInBytes=799907480

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:0 4:0 8:0 16:4 32:13 64:68 128:14071 256:302331 512:121 1024:126
    (2^04, 2^05]: 4
    (2^05, 2^06]: 13
    (2^06, 2^07]: 68
    (2^07, 2^08]: 14071
    (2^08, 2^09]: 302331
    (2^09, 2^10]: 121
    (2^10, 2^11]: 126
sum_limbo_reclamation_event_size_total=93595156
count_limbo_reclamation_event_size_by_thread=4949 4949 4949 4949 4949 4949 4949 4949 4949 4949 4949 4949 4949 4949 4949 4949 4949 4949 4949 4949 4949 4949 4949 4949 4949 4949 4949 4949 4949 4949 4949 4949 4949 4949 4949 4949 4949 4949 4949 4948 4949 4949 4949 4949 4949 4949 4949 4949 4949 4948 4949 4949 4949 4949 4949 4949 4949 4949 4949 4949 4949 4949 4949 4949
count_limbo_reclamation_event_size_total=316734
sum_limbo_reclamation_event_count_total=316864
first_thread_announced_epoch_by_thread=14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048 14048
sum_num_inserts_by_thread=1479038 1477233 1474116 1470275 1475040 1476893 1465689 1468013 1469144 1466766 1461639 1460125 1466701 1475111 1470191 1469162 1464961 1467723 1462955 1462990 1463352 1462634 1456115 1452310 1455644 1458770 1454710 1465176 1467778 1468469 1464828 1465173 1473735 1474610 1465914 1462091 1465071 1465176 1461753 1462414 1463604 1476750 1468695 1468450 1476075 1476397 1470819 1471383 1459539 1458966 1452521 1453074 1457393 1457738 1453483 1453798 1466626 1468387 1464970 1464325 1473487 1472396 1468604 1469996
sum_num_inserts_total=93816964
sum_num_deletes_by_thread=1478246 1477593 1472259 1470289 1473254 1477613 1466504 1464805 1468257 1465914 1464427 1462312 1465999 1473499 1469745 1469615 1468056 1468625 1464836 1464476 1462102 1459335 1457439 1455703 1455010 1461410 1456516 1464331 1466543 1467698 1462240 1465080 1475790 1472885 1465139 1465390 1464958 1467708 1461246 1464119 1464818 1476573 1469828 1468241 1477099 1472898 1472556 1472548 1462107 1461559 1457505 1451730 1458283 1455020 1454176 1453359 1470749 1469419 1463059 1466239 1471206 1473075 1468524 1470911
sum_num_deletes_total=93838448
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=2957284 2954826 2946375 2940564 2948294 2954506 2932193 2932818 2937401 2932680 2926066 2922437 2932700 2948610 2939936 2938777 2933017 2936348 2927791 2927466 2925454 2921969 2913554 2908013 2910654 2920180 2911226 2929507 2934321 2936167 2927068 2930253 2949525 2947495 2931053 2927481 2930029 2932884 2922999 2926533 2928422 2953323 2938523 2936691 2953174 2949295 2943375 2943931 2921646 2920525 2910026 2904804 2915676 2912758 2907659 2907157 2937375 2937806 2928029 2930564 2944693 2945471 2937128 2940907
average_num_operations_total=2932115
stdev_num_operations_total=1666
sum_num_operations_total=187655412
min_num_operations_total=2904804
max_num_operations_total=2957284
first_time_thread_terminate_by_thread=10000060 10000060 10000062 10000062 10000061 10000063 10000061 10000064 10000062 10000064 10000062 10000062 10000060 10000060 10000060 10000060 10000063 10000063 10000060 10000060 10000060 10000060 10000062 10000060 10000062 10000062 10000062 10000062 10000062 10000062 10000061 10000061 10000061 10000061 10000061 10000064 10000063 10000063 10000063 10000063 10000063 10000063 10000063 10000063 10000063 10000063 10000063 10000063 10000063 10000063 10000063 10000063 10000062 10000064 10000062 10000062 10000062 10000062 10000062 10000062 10000061 10000064 10000061 10000061
min_time_thread_terminate_total=10000060
max_time_thread_terminate_total=10000064
first_time_thread_start_by_thread=4 4 4 4 4 4 4 4 5 5 5 5 7 7 7 7 5 5 5 5 6 6 6 6 7 7 8 7 7 7 7 7 5 5 5 5 6 6 6 6 3 3 3 3 3 3 3 3 8 8 8 8 4 4 4 4 8 7 7 8 3 3 3 3
min_time_thread_start_total=3
max_time_thread_start_total=8
sum_duration_all_ops_total=

threads_final_keysum=99988077828946
threads_final_size=9998843
final_keysum=99988077828946
final_size=9998843
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=93816964
total_deletes=93838448
total_updates=187655412
total_queries=0
total_ops=187655412
find_throughput=0
rq_throughput=0
update_throughput=18765541
query_throughput=0
total_throughput=18765541


total find                    : 0
total rq                      : 0
total inserts                 : 93816964
total deletes                 : 93838448
total updates                 : 187655412
total queries                 : 0
total ops                     : 187655412
find throughput               : 0
rq throughput                 : 0
update throughput             : 18765541
query throughput              : 0
total throughput              : 18765541

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

garbage=0
total_execution_walltime=14.221s
REALTIME_MAIN_END_PERF_FORMAT=215436.580097807
[time_cmd_output] time_elapsed_sec=14.39, faults_major=0, faults_minor=314758, mem_maxresident_kb=1259992, user_cputime=915.95, sys_cputime=6.24, percent_cpu=6408%
timeout=false
algorithm=guerraoui_ext_bst_ticket.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1