__step=000716
__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 96 -nprefill 96 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 50.0 50.0 -k 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000716.txt
__path_data=data/data000716.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6987532.125496707
binary=./guerraoui_ext_bst_ticket.debra
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
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=96
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=96
WORK_THREADS=96
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,96,97,98,99,100,101,102,103,104,105,106,107,108,109,110,111,112,113,114,115,116,117,118,119,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,120,121,122,123,124,125,126,127,128,129,130,131,132,133,134,135,136,137,138,139,140,141,142,143


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.009s
prefilling_size=8540584 prefilling_elapsed_millis=1.001s
prefilling_size=8749510 prefilling_elapsed_millis=1.101s
prefilling_size=8924026 prefilling_elapsed_millis=1.201s
prefilling_size=9072335 prefilling_elapsed_millis=1.301s
prefilling_size=9198347 prefilling_elapsed_millis=1.401s
prefilling_size=9308277 prefilling_elapsed_millis=1.502s
prefilling_size=9402172 prefilling_elapsed_millis=1.602s
prefilling_size=9483298 prefilling_elapsed_millis=1.702s
prefilling_size=9550084 prefilling_elapsed_millis=1.802s
prefilling_size=9607893 prefilling_elapsed_millis=1.902s
prefilling_size=9658107 prefilling_elapsed_millis=2.003s
prefilling_size=9705004 prefilling_elapsed_millis=2.103s
prefilling_size=9744806 prefilling_elapsed_millis=2.203s
prefilling_size=9776772 prefilling_elapsed_millis=2.303s
prefilling_size=9805646 prefilling_elapsed_millis=2.403s
finished prefilling to size 9805646 for expected size 10000000 keysum=98046219690290, performing 80891965 updates; total_prefilling_elapsed_ms=2505 ms)
pref_size=9805646
pref_millis=2505
prefill_elapsed_ms=2528
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=971

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6987534.843955256
REALTIME_END_PERF_FORMAT=6987544.844091065

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

tree_stats_computeWalltime=0.194s

tree_stats_numInternalsAtDepth=1 2 4 8 14 26 51 96 189 367 694 1281 2352 4215 7487 13095 22344 36825 58488 89729 133376 189919 258677 339619 427016 515530 599317 671096 724997 753857 755420 731001 680612 611318 530575 446104 364802 287445 219188 161661 116177 81489 56035 37824 25503 16692 10925 6934 4234 2413 1344 704 321 171 61 17 3 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 2 2 1 6 3 11 40 107 210 489 943 1879 3846 7863 15162 27247 46082 76833 121161 177735 252222 338502 431743 527538 617195 696137 752294 779839 781390 749906 692061 615046 527406 442159 355702 276715 207145 150865 106943 74246 50145 34314 22459 14916 9634 6055 3482 1984 1087 471 281 105 31 5 2
tree_stats_numNodesAtDepth=1 2 4 8 16 28 52 102 192 378 734 1388 2562 4704 8430 14974 26190 44688 73650 116976 179458 266752 379838 517354 679238 854032 1031060 1198634 1342192 1449994 1507714 1510840 1462002 1361224 1222636 1061150 892208 729604 574890 438376 323322 232354 162978 112070 75648 51006 33384 21850 13868 8468 4826 2688 1408 642 342 122 34 6 2
tree_stats_numKeysAtDepth=0 0 0 0 2 2 1 6 3 11 40 107 210 489 943 1879 3846 7863 15162 27247 46082 76832 121161 177735 252222 338502 431743 527538 617195 696137 752294 779839 781390 749906 692061 615046 527406 442159 355702 276715 207145 150865 106943 74246 50145 34314 22459 14916 9634 6055 3482 1984 1087 471 281 105 31 5 2
tree_stats_avgDegreeAtDepth=2 2 2 2 1.875 1.92857 1.98077 1.94118 1.98438 1.9709 1.9455 1.92291 1.91803 1.89605 1.88814 1.87452 1.85315 1.82405 1.79413 1.76707 1.74322 1.71196 1.68102 1.65645 1.62867 1.60364 1.58126 1.55988 1.54016 1.5199 1.50104 1.48384 1.46553 1.44909 1.43396 1.4204 1.40888 1.39397 1.38127 1.36877 1.35932 1.35071 1.34382 1.3375 1.33713 1.32726 1.32725 1.31735 1.30531 1.28496 1.27849 1.2619 1.22798 1.26636 1.17836 1.13934 1.08824 1.16667 1

tree_stats_height=59
tree_stats_numInternals=9999646
tree_stats_numLeaves=9999647
tree_stats_numNodes=19999293
tree_stats_numKeys=9999646

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

tree_stats_bytesAtDepth=40 80 160 320 640 1120 2080 4080 7680 15120 29360 55520 102480 188160 337200 598960 1047600 1787520 2946000 4679040 7178320 10670080 15193520 20694160 27169520 34161280 41242400 47945360 53687680 57999760 60308560 60433600 58480080 54448960 48905440 42446000 35688320 29184160 22995600 17535040 12932880 9294160 6519120 4482800 3025920 2040240 1335360 874000 554720 338720 193040 107520 56320 25680 13680 4880 1360 240 80
tree_stats_sizeInBytes=799971720

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:2 4:0 8:3 16:3 32:7 64:7 128:1222 256:346642 512:2316
    (2^01, 2^02]: 2
    (2^02, 2^03]: 0
    (2^03, 2^04]: 3
    (2^04, 2^05]: 3
    (2^05, 2^06]: 7
    (2^06, 2^07]: 7
    (2^07, 2^08]: 1222
    (2^08, 2^09]: 346642
    (2^09, 2^10]: 2316
sum_limbo_reclamation_event_size_total=143094802
count_limbo_reclamation_event_size_by_thread=3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3647 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3647 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3647 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3648 3646 3648 3648 3648 3648 3648 3648 3647 3648 3648
count_limbo_reclamation_event_size_total=350202
sum_limbo_reclamation_event_count_total=350400
first_thread_announced_epoch_by_thread=9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242
sum_num_inserts_by_thread=1482257 1492067 1499118 1501966 1489899 1478233 1488018 1495401 1504220 1506931 1489737 1486612 1489000 1499032 1499880 1501698 1496666 1488285 1481324 1489057 1491354 1497540 1483938 1476267 1485544 1492061 1493935 1503665 1493537 1482872 1485562 1495828 1502624 1505300 1490384 1483136 1488413 1498985 1506174 1508462 1497042 1485924 1483209 1487648 1495177 1502723 1482796 1480688 1485617 1487618 1495147 1508154 1497579 1492216 1488549 1487643 1498026 1511041 1488033 1481344 1493986 1503017 1506626 1498311 1497834 1477024 1475822 1482782 1502310 1503542 1485752 1489776 1494191 1494853 1499744 1510424 1491295 1481235 1483271 1499154 1509324 1512115 1500188 1482816 1496553 1501781 1509254 1501252 1489776 1489923 1488259 1484439 1507898 1497992 1499115 1493123
sum_num_inserts_total=143395913
sum_num_deletes_by_thread=1483111 1489823 1499240 1502308 1492332 1481948 1488176 1496173 1502067 1508274 1489619 1486091 1487443 1496692 1498621 1501320 1495126 1489090 1480801 1488273 1493684 1499527 1485506 1478121 1485112 1491421 1494442 1500549 1494540 1484438 1485603 1495823 1503673 1502835 1488227 1484139 1486182 1497649 1504979 1508603 1496391 1486314 1483987 1488000 1495012 1502441 1485125 1479501 1484569 1487835 1494902 1506495 1499194 1491859 1491022 1486586 1499458 1510572 1487563 1478833 1494051 1501714 1509793 1496951 1497531 1476391 1476496 1480811 1502884 1503555 1485393 1488180 1492705 1494201 1499926 1511666 1492583 1479070 1484622 1499619 1508922 1511743 1502959 1484634 1497624 1503926 1509744 1500735 1491875 1492355 1488002 1485545 1508984 1500208 1497341 1490042
sum_num_deletes_total=143400021
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=2965368 2981890 2998358 3004274 2982231 2960181 2976194 2991574 3006287 3015205 2979356 2972703 2976443 2995724 2998501 3003018 2991792 2977375 2962125 2977330 2985038 2997067 2969444 2954388 2970656 2983482 2988377 3004214 2988077 2967310 2971165 2991651 3006297 3008135 2978611 2967275 2974595 2996634 3011153 3017065 2993433 2972238 2967196 2975648 2990189 3005164 2967921 2960189 2970186 2975453 2990049 3014649 2996773 2984075 2979571 2974229 2997484 3021613 2975596 2960177 2988037 3004731 3016419 2995262 2995365 2953415 2952318 2963593 3005194 3007097 2971145 2977956 2986896 2989054 2999670 3022090 2983878 2960305 2967893 2998773 3018246 3023858 3003147 2967450 2994177 3005707 3018998 3001987 2981651 2982278 2976261 2969984 3016882 2998200 2996456 2983165
average_num_operations_total=2987457
stdev_num_operations_total=1832
sum_num_operations_total=286795934
min_num_operations_total=2952318
max_num_operations_total=3023858
first_time_thread_terminate_by_thread=10000135 10000138 10000138 10000138 10000160 10000134 10000138 10000137 10000135 10000134 10000135 10000137 10000136 10000136 10000136 10000138 10000134 10000137 10000137 10000134 10000137 10000137 10000136 10000135 10000138 10000138 10000138 10000135 10000138 10000137 10000138 10000137 10000135 10000137 10000135 10000134 10000136 10000137 10000136 10000138 10000134 10000134 10000137 10000134 10000137 10000137 10000134 10000134 10000160 10000134 10000136 10000136 10000135 10000136 10000137 10000136 10000135 10000134 10000135 10000135 10000135 10000135 10000136 10000135 10000136 10000160 10000135 10000137 10000135 10000135 10000136 10000135 10000134 10000135 10000134 10000136 10000135 10000136 10000137 10000136 10000135 10000134 10000134 10000136 10000135 10000138 10000135 10000136 10000136 10000137 10000158 10000137 10000136 10000135 10000136 10000138
min_time_thread_terminate_total=10000134
max_time_thread_terminate_total=10000160
first_time_thread_start_by_thread=5 5 5 5 5 5 5 5 5 5 5 5 5 4 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 4 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 4 5 4 5 5 5 5 4 5 4 5 4 4 4 5 5 5 5 5 5 5 5 5 5 4 5 4 5 5 5 5 4 5 4 5 4 4 4 5
min_time_thread_start_total=4
max_time_thread_start_total=5
sum_duration_all_ops_total=

threads_final_keysum=99998928139929
threads_final_size=9999646
final_keysum=99998928139929
final_size=9999646
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=143395913
total_deletes=143400021
total_updates=286795934
total_queries=0
total_ops=286795934
find_throughput=0
rq_throughput=0
update_throughput=28679593
query_throughput=0
total_throughput=28679593


total find                    : 0
total rq                      : 0
total inserts                 : 143395913
total deletes                 : 143400021
total updates                 : 286795934
total queries                 : 0
total ops                     : 286795934
find throughput               : 0
rq throughput                 : 0
update throughput             : 28679593
query throughput              : 0
total throughput              : 28679593

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=52.1637
PAPI_L3_TCM=20.9788
PAPI_TOT_CYC=9316.05
PAPI_TOT_INS=1033.51
garbage=0
total_execution_walltime=12.988s
REALTIME_MAIN_END_PERF_FORMAT=6987545.114545984
[time_cmd_output] time_elapsed_sec=13.17, faults_major=0, faults_minor=322847, mem_maxresident_kb=1289660, user_cputime=1224.58, sys_cputime=5.32, percent_cpu=9332%
timeout=false
algorithm=guerraoui_ext_bst_ticket.debra
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=2