__step=000427
__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" ./bronson_pext_bst_occ.debra -nwork 96 -nprefill 96 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000427.txt
__path_data=data/data000427.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6984038.612753021
binary=./bronson_pext_bst_occ.debra
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
DS_TYPENAME=bronson_pext_bst_occ
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=96
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=96
WORK_THREADS=96
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=56
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.038s
prefilling_size=9112256 prefilling_elapsed_millis=1s
prefilling_size=9284215 prefilling_elapsed_millis=1.1s
prefilling_size=9422647 prefilling_elapsed_millis=1.201s
prefilling_size=9535468 prefilling_elapsed_millis=1.301s
prefilling_size=9627666 prefilling_elapsed_millis=1.401s
prefilling_size=9701174 prefilling_elapsed_millis=1.501s
prefilling_size=9757211 prefilling_elapsed_millis=1.601s
prefilling_size=9801763 prefilling_elapsed_millis=1.701s
finished prefilling to size 9801750 for expected size 10000000 keysum=98018078430612, performing 79552524 updates; total_prefilling_elapsed_ms=1803 ms)
pref_size=9801750
pref_millis=1803
prefill_elapsed_ms=1826
6node_tIxPvE_object_size=56
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=909

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6984040.680560148
REALTIME_END_PERF_FORMAT=6984050.680640709

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

tree_stats_computeWalltime=0.037s

tree_stats_numInternalsAtDepth=1 1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262099 521633 991767 1583958 1746836 1101104 334452 38259 829 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 43 2389 45528 337238 1141809 1826317 1353454 433924 49378 1011
tree_stats_numNodesAtDepth=1 1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262142 524022 1037295 1921196 2888645 2927421 1687906 472183 50207 1011
tree_stats_numKeysAtDepth=0 0 1 0 6 5 14 31 66 130 262 540 1039 2060 4146 8164 16314 32937 65848 133877 282785 636391 1414548 2476148 2742396 1649087 469274 50166 1011
tree_stats_avgDegreeAtDepth=1 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99998 1.99916 1.98405 1.89601 1.67909 1.40868 1.20043 1.08157 1.02529 1.00362 1

tree_stats_height=29
tree_stats_numInternals=6843081
tree_stats_numLeaves=5191091
tree_stats_numNodes=12034172
tree_stats_numKeys=9987246

tree_stats_avgDegreeInternal=1.75859
tree_stats_avgDegreeLeaves=0.999964
tree_stats_avgDegree=1.43135
tree_stats_avgKeyDepth=23.2797

tree_stats_bytesAtDepth=56 56 112 224 448 896 1792 3584 7168 14336 28672 57344 114688 229376 458752 917504 1835008 3670016 7340032 14679952 29345232 58088520 107586976 161764120 163935576 94522736 26442248 2811592 56616
tree_stats_sizeInBytes=673913632

6node_tIxPvE_object_size=56
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=7100


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:2 2:42 4:3435 8:175905 16:411421 32:3172 64:166
    [2^00, 2^01]: 2
    (2^01, 2^02]: 42
    (2^02, 2^03]: 3435
    (2^03, 2^04]: 175905
    (2^04, 2^05]: 411421
    (2^05, 2^06]: 3172
    (2^06, 2^07]: 166
sum_limbo_reclamation_event_size_total=10776946
count_limbo_reclamation_event_size_by_thread=6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6188 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189 6189
count_limbo_reclamation_event_size_total=594143
sum_limbo_reclamation_event_count_total=594336
first_thread_announced_epoch_by_thread=14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200 14200
sum_num_inserts_by_thread=285908 285701 288146 290575 288527 285546 284057 288310 288601 291102 287396 285828 287190 288924 288236 289237 286693 283778 281566 283581 285899 289894 283981 281180 283964 287781 290346 289164 287589 284741 286700 287778 288858 288525 287961 284979 284076 289539 290106 287251 288282 285636 283316 286589 286341 288673 283131 282827 288235 289511 289912 289156 289426 286597 286623 286755 290476 288916 287518 285216 285951 289811 291333 289222 287788 286727 283094 284534 292017 289000 289141 287013 289018 287258 292120 290280 289927 288252 286236 288420 292828 289701 288072 285410 286068 290037 291952 291655 289998 286215 286669 284528 291400 292095 289889 284642
sum_num_inserts_total=27610651
sum_num_deletes_by_thread=286334 285077 287691 290751 288043 285103 283502 288344 289239 292120 287920 285829 287736 288265 287545 288129 286172 283247 282444 283701 287225 290108 283968 281215 284096 287184 290113 290393 288278 285250 286639 287626 287767 287423 287547 285176 284030 289226 290760 288451 288969 287988 281650 286887 286169 290593 283210 283667 288636 288761 289158 289754 290315 287508 285451 286614 289906 289468 286460 285075 286397 289943 292092 289738 286749 285947 283354 284616 291639 288262 290125 287553 287865 286159 292334 289457 290137 286981 286362 290585 292777 289446 287148 284461 286552 290967 293184 291372 289777 286019 286440 284028 290785 292888 289917 284353
sum_num_deletes_total=27612315
sum_num_searches_by_thread=5150701 5135875 5180540 5224994 5196398 5135537 5115550 5183933 5203094 5244149 5180945 5147455 5169631 5204222 5188127 5191448 5153332 5105178 5080369 5111590 5149126 5215540 5110926 5064157 5101419 5175182 5220267 5215363 5191048 5136864 5157621 5185655 5195227 5195646 5180411 5146994 5123792 5195908 5230280 5186480 5198180 5160748 5084171 5159752 5149926 5217592 5103150 5101756 5186846 5205186 5210503 5202181 5210810 5166545 5137907 5160360 5222144 5212049 5172593 5132078 5144381 5224819 5256531 5208012 5173646 5163643 5103931 5122009 5248720 5193391 5205132 5162280 5188270 5159817 5257751 5212615 5216604 5180369 5148482 5215924 5283106 5225879 5172466 5129548 5147937 5218707 5244130 5249099 5213173 5158478 5148858 5124102 5250571 5254055 5220724 5129877
sum_num_searches_total=497032488
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=5722943 5706653 5756377 5806320 5772968 5706186 5683109 5760587 5780934 5827371 5756261 5719112 5744557 5781411 5763908 5768814 5726197 5672203 5644379 5678872 5722250 5795542 5678875 5626552 5669479 5750147 5800726 5794920 5766915 5706855 5730960 5761059 5771852 5771594 5755919 5717149 5691898 5774673 5811146 5762182 5775431 5734372 5649137 5733228 5722436 5796858 5669491 5668250 5763717 5783458 5789573 5781091 5790551 5740650 5709981 5733729 5802526 5790433 5746571 5702369 5716729 5804573 5839956 5786972 5748183 5736317 5670379 5691159 5832376 5770653 5784398 5736846 5765153 5733234 5842205 5792352 5796668 5755602 5721080 5794929 5868711 5805026 5747686 5699419 5720557 5799711 5829266 5832126 5792948 5730712 5721967 5692658 5832756 5839038 5800530 5698872
average_num_operations_total=5752660
stdev_num_operations_total=5190
sum_num_operations_total=552255454
min_num_operations_total=5626552
max_num_operations_total=5868711
first_time_thread_terminate_by_thread=10000083 10000081 10000080 10000080 10000080 10000083 10000080 10000082 10000083 10000080 10000080 10000080 10000081 10000082 10000083 10000082 10000080 10000080 10000080 10000083 10000080 10000080 10000080 10000080 10000083 10000081 10000080 10000080 10000082 10000081 10000080 10000082 10000083 10000081 10000080 10000080 10000081 10000082 10000083 10000082 10000083 10000080 10000080 10000080 10000080 10000080 10000080 10000080 10000082 10000080 10000080 10000080 10000080 10000080 10000082 10000081 10000083 10000080 10000080 10000079 10000080 10000081 10000081 10000080 10000080 10000080 10000082 10000079 10000080 10000081 10000081 10000081 10000082 10000080 10000080 10000080 10000080 10000081 10000083 10000081 10000080 10000080 10000080 10000079 10000080 10000081 10000082 10000080 10000080 10000081 10000082 10000079 10000080 10000079 10000081 10000081
min_time_thread_terminate_total=10000079
max_time_thread_terminate_total=10000083
first_time_thread_start_by_thread=5 6 6 6 6 6 6 6 5 6 5 6 5 6 6 5 6 5 6 5 6 5 6 5 5 6 6 6 6 6 6 6 5 6 5 6 5 6 6 5 6 5 6 5 6 5 6 5 6 6 5 6 5 5 5 6 5 6 5 5 5 5 6 5 6 5 5 6 5 5 6 5 6 6 5 6 5 5 5 6 5 6 5 5 5 5 6 5 6 5 5 6 5 5 6 5
min_time_thread_start_total=5
max_time_thread_start_total=6
sum_duration_all_ops_total=

threads_final_keysum=99853788207026
threads_final_size=9987246
final_keysum=99853788207026
final_size=9987246
validate_result=success
Validation OK.
Structural validation OK.

total_find=497032488
total_rq=0
total_inserts=27610651
total_deletes=27612315
total_updates=55222966
total_queries=497032488
total_ops=552255454
find_throughput=49703248
rq_throughput=0
update_throughput=5522296
query_throughput=49703248
total_throughput=55225545


total find                    : 497032488
total rq                      : 0
total inserts                 : 27610651
total deletes                 : 27612315
total updates                 : 55222966
total queries                 : 497032488
total ops                     : 552255454
find throughput               : 49703248
rq throughput                 : 0
update throughput             : 5522296
query throughput              : 49703248
total throughput              : 55225545

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=29.7497
PAPI_L3_TCM=10.7307
PAPI_TOT_CYC=4831.84
PAPI_TOT_INS=1296
garbage=2468563510239752
total_execution_walltime=12.186s
REALTIME_MAIN_END_PERF_FORMAT=6984050.815096442
[time_cmd_output] time_elapsed_sec=12.38, faults_major=0, faults_minor=270993, mem_maxresident_kb=1081332, user_cputime=1158.53, sys_cputime=4.33, percent_cpu=9390%
timeout=false
algorithm=bronson_pext_bst_occ.debra
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=1