__step=000499
__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" ./natarajan_ext_bst_lf.debra -nwork 96 -nprefill 96 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000499.txt
__path_data=data/data000499.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6984911.219022078
binary=./natarajan_ext_bst_lf.debra
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
DS_TYPENAME=natarajan_ext_bst_lf
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=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=32
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.019s
prefilling_size=999940 prefilling_elapsed_millis=1.001s
finished prefilling to size 999933 for expected size 1000000 keysum=1000128405126, performing 48563240 updates; total_prefilling_elapsed_ms=1103 ms)
pref_size=999933
pref_millis=1103
prefill_elapsed_ms=1126
6node_tIxPvE_object_size=32
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=767

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6984912.548416291
REALTIME_END_PERF_FORMAT=6984922.548553619

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

tree_stats_computeWalltime=0.04s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 254 497 944 1779 3225 5469 8865 13635 20157 28604 38642 49808 61366 71859 80012 84424 85294 82690 76191 67486 57290 45983 35196 25890 18433 12910 8663 5638 3588 2088 1217 693 358 179 84 44 24 22 16 8 2 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 2 11 50 109 333 981 2073 4095 7113 11710 18566 27476 38250 50873 63706 75600 83554 87898 89189 84896 77682 68597 56770 44502 33347 23956 17157 11688 7688 5088 2959 1741 1028 537 274 124 64 26 28 24 14 3 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 508 994 1888 3558 6450 10938 17730 27270 40314 57208 77284 99616 122732 143718 160024 168848 170588 165380 152382 134972 114580 91966 70392 51780 36866 25820 17326 11276 7176 4176 2434 1386 716 358 168 88 48 44 32 16 4 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 2 11 50 109 333 981 2073 4095 7113 11710 18566 27476 38250 50873 63706 75600 83554 87898 89189 84896 77682 68597 56770 44502 33347 23956 17157 11688 7688 5088 2959 1741 1028 537 274 124 64 26 28 24 14 3 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 1.99219 1.97835 1.9497 1.94227 1.90641 1.84791 1.81048 1.76904 1.73916 1.70953 1.67546 1.64448 1.61603 1.5855 1.55673 1.52757 1.50515 1.48474 1.4607 1.44287 1.42446 1.40132 1.38271 1.3678 1.35599 1.35019 1.33552 1.32541 1.3182 1.29097 1.29143 1.28472 1.2583 1.25 1.23464 1.2619 1.27273 1.45833 1.36364 1.25 1.125 1.25 1

tree_stats_height=51
tree_stats_numInternals=999783
tree_stats_numLeaves=999784
tree_stats_numNodes=1999567
tree_stats_numKeys=999784

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

tree_stats_bytesAtDepth=32 64 128 256 512 1024 2048 4096 8192 16256 31808 60416 113856 206400 350016 567360 872640 1290048 1830656 2473088 3187712 3927424 4598976 5120768 5403136 5458816 5292160 4876224 4319104 3666560 2942912 2252544 1656960 1179712 826240 554432 360832 229632 133632 77888 44352 22912 11456 5376 2816 1536 1408 1024 512 128 64
tree_stats_sizeInBytes=63986144

6node_tIxPvE_object_size=32
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=12252


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:0 4:0 8:74 16:42819 32:874892 64:41928 128:95
    (2^03, 2^04]: 74
    (2^04, 2^05]: 42819
    (2^05, 2^06]: 874892
    (2^06, 2^07]: 41928
    (2^07, 2^08]: 95
sum_limbo_reclamation_event_size_total=44515106
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 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=959808
sum_limbo_reclamation_event_count_total=1102560
first_thread_announced_epoch_by_thread=24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504 24504
sum_num_inserts_by_thread=526201 531694 536051 536129 531423 524494 527021 530041 539051 538697 532262 529385 528299 532110 537324 537893 537976 532742 527222 531728 536555 538522 531276 527284 525313 530200 535998 536073 528450 524578 527409 530740 538470 539664 532368 527699 527421 531403 536410 537820 533160 529350 528445 532032 536397 537262 530830 525977 528499 533430 537524 537808 531408 530486 529055 533963 538313 539716 532937 531611 530260 533782 538632 536444 533172 526918 526743 530831 536225 536653 532514 530057 528652 531972 537802 537093 531485 529072 527396 533791 541989 541467 536023 533116 530371 531337 537113 535330 531777 526734 526401 531173 537160 539912 534672 532255
sum_num_inserts_total=51145923
sum_num_deletes_by_thread=525973 529832 537329 535383 531720 524365 525884 530451 538795 539070 531950 529143 530021 532605 538335 540843 537337 532447 527469 530439 536121 538494 530453 526755 525121 529740 535209 535411 529569 524187 526490 528989 538388 539574 530066 526458 526687 530263 535442 538648 533005 528960 527776 531401 535230 538693 529917 525800 529105 532612 539232 537722 532652 531353 530446 534209 540291 538976 534577 528718 530338 533515 537495 537608 534498 528819 526680 529576 535789 539452 531746 530931 529114 532329 537591 536638 532535 526487 529233 534339 540989 542049 536725 532828 531130 533310 536332 536624 531013 524836 527488 531155 536364 538196 534251 531629
sum_num_deletes_total=51141763
sum_num_searches_by_thread=9473253 9550864 9654024 9634520 9565549 9435042 9481912 9541993 9678595 9711230 9574533 9523396 9539887 9594521 9663499 9684505 9659169 9591083 9500315 9578835 9638730 9690472 9551565 9480407 9459264 9537709 9647738 9648302 9521963 9426401 9483668 9559063 9671662 9700897 9574304 9493616 9496013 9575572 9646587 9660061 9589145 9517872 9490429 9566951 9639545 9679958 9556148 9466260 9528741 9592960 9703587 9668095 9572805 9556396 9549427 9617868 9711726 9696418 9613654 9539817 9523796 9608464 9678700 9660361 9612643 9495790 9471669 9542337 9659879 9672116 9563366 9535593 9513235 9577033 9684743 9660430 9567175 9512032 9510518 9595871 9737520 9744068 9653782 9585311 9542165 9594895 9651749 9656174 9561309 9459801 9475260 9550360 9678781 9693294 9619727 9564972
sum_num_searches_total=920373440
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=10525427 10612390 10727404 10706032 10628692 10483901 10534817 10602485 10756441 10788997 10638745 10581924 10598207 10659236 10739158 10763241 10734482 10656272 10555006 10641002 10711406 10767488 10613294 10534446 10509698 10597649 10718945 10719786 10579982 10475166 10537567 10618792 10748520 10780135 10636738 10547773 10550121 10637238 10718439 10736529 10655310 10576182 10546650 10630384 10711172 10755913 10616895 10518037 10586345 10659002 10780343 10743625 10636865 10618235 10608928 10686040 10790330 10775110 10681168 10600146 10584394 10675761 10754827 10734413 10680313 10551527 10525092 10602744 10731893 10748221 10627626 10596581 10571001 10641334 10760136 10734161 10631195 10567591 10567147 10664001 10820498 10827584 10726530 10651255 10603666 10659542 10725194 10728128 10624099 10511371 10529149 10612688 10752305 10771402 10688650 10628856
average_num_operations_total=10652720
stdev_num_operations_total=8772
sum_num_operations_total=1022661126
min_num_operations_total=10475166
max_num_operations_total=10827584
first_time_thread_terminate_by_thread=10000138 10000138 10000136 10000137 10000137 10000137 10000137 10000136 10000136 10000138 10000136 10000138 10000138 10000136 10000136 10000138 10000136 10000137 10000136 10000136 10000138 10000137 10000137 10000136 10000138 10000136 10000136 10000137 10000137 10000138 10000137 10000136 10000136 10000138 10000137 10000138 10000136 10000136 10000136 10000138 10000136 10000137 10000136 10000136 10000138 10000137 10000137 10000136 10000137 10000136 10000137 10000138 10000137 10000136 10000137 10000137 10000138 10000137 10000137 10000137 10000137 10000136 10000136 10000137 10000137 10000137 10000137 10000139 10000137 10000137 10000137 10000136 10000137 10000138 10000137 10000138 10000137 10000136 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000136 10000137 10000137 10000137 10000137 10000137 10000138 10000137 10000137 10000137 10000137
min_time_thread_terminate_total=10000136
max_time_thread_terminate_total=10000139
first_time_thread_start_by_thread=3 3 3 3 3 3 3 3 4 3 4 3 3 4 4 3 3 3 3 3 4 4 3 4 3 3 3 3 3 3 3 3 4 3 4 3 3 4 4 3 3 3 3 3 4 4 3 4 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 4 3 3 3 3 3 3 3 3
min_time_thread_start_total=3
max_time_thread_start_total=4
sum_duration_all_ops_total=

threads_final_keysum=999643482869
threads_final_size=999784
final_keysum=999643482869
final_size=999784
validate_result=success
Validation OK.
Structural validation OK.

total_find=920373440
total_rq=0
total_inserts=51145923
total_deletes=51141763
total_updates=102287686
total_queries=920373440
total_ops=1022661126
find_throughput=92037344
rq_throughput=0
update_throughput=10228768
query_throughput=92037344
total_throughput=102266112


total find                    : 920373440
total rq                      : 0
total inserts                 : 51145923
total deletes                 : 51141763
total updates                 : 102287686
total queries                 : 920373440
total ops                     : 1022661126
find throughput               : 92037344
rq throughput                 : 0
update throughput             : 10228768
query throughput              : 92037344
total throughput              : 102266112

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=12.3501
PAPI_L3_TCM=2.06441
PAPI_TOT_CYC=2612.68
PAPI_TOT_INS=378.234
garbage=460228752842808
total_execution_walltime=11.5s
REALTIME_MAIN_END_PERF_FORMAT=6984922.733577923
[time_cmd_output] time_elapsed_sec=11.64, faults_major=0, faults_minor=95277, mem_maxresident_kb=379180, user_cputime=1093.28, sys_cputime=2.29, percent_cpu=9407%
timeout=false
algorithm=natarajan_ext_bst_lf.debra
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=1