__step=000387
__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 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000387.txt
__path_data=data/data000387.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6983498.88755203
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=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=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.01s
prefilling_size=8690983 prefilling_elapsed_millis=1.001s
prefilling_size=8875669 prefilling_elapsed_millis=1.101s
prefilling_size=9028148 prefilling_elapsed_millis=1.201s
prefilling_size=9158606 prefilling_elapsed_millis=1.302s
prefilling_size=9271191 prefilling_elapsed_millis=1.402s
prefilling_size=9364920 prefilling_elapsed_millis=1.502s
prefilling_size=9444655 prefilling_elapsed_millis=1.602s
prefilling_size=9516402 prefilling_elapsed_millis=1.702s
prefilling_size=9578352 prefilling_elapsed_millis=1.803s
prefilling_size=9630938 prefilling_elapsed_millis=1.903s
prefilling_size=9677661 prefilling_elapsed_millis=2.003s
prefilling_size=9715258 prefilling_elapsed_millis=2.103s
prefilling_size=9749517 prefilling_elapsed_millis=2.203s
prefilling_size=9777609 prefilling_elapsed_millis=2.304s
prefilling_size=9805429 prefilling_elapsed_millis=2.404s
finished prefilling to size 9805411 for expected size 10000000 keysum=98034907861636, performing 86517027 updates; total_prefilling_elapsed_ms=2505 ms)
pref_size=9805411
pref_millis=2505
prefill_elapsed_ms=2539
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=1117

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6983500.788379802
REALTIME_END_PERF_FORMAT=6983510.788526574

###############################################################################
################################## 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.176s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1016 1996 3863 7298 13379 23649 40030 64767 100277 148584 210906 287272 373402 466287 558020 640675 707621 750873 763651 747142 704572 643664 569501 488152 405877 328689 257849 197235 146851 105415 73668 50061 33028 21315 13149 8044 4709 2810 1648 959 549 273 152 79 36 16 7 1 2 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 8 36 129 428 1217 3109 7268 15293 29257 51970 86262 134540 201142 280517 374554 475365 573729 664369 738095 780160 789712 765480 717827 650850 570427 483065 399529 318463 247619 188287 137162 97275 67094 44741 29481 18254 11379 6608 3972 2337 1369 825 394 225 122 56 25 13 0 4
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2032 3992 7726 14596 26758 47298 80060 129534 200554 297168 421812 574544 746804 932574 1116040 1281350 1415242 1501746 1527302 1494284 1409144 1287328 1139002 976304 811754 657378 515698 394470 293702 210830 147336 100122 66056 42630 26298 16088 9418 5620 3296 1918 1098 546 304 158 72 32 14 2 4
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 8 36 129 428 1217 3109 7268 15293 29257 51970 86262 134540 201142 280517 374554 475365 573729 664369 738095 780160 789712 765480 717827 650850 570427 483065 399529 318463 247619 188287 137162 97275 67094 44741 29481 18254 11379 6608 3972 2337 1369 825 394 225 122 56 25 13 0 4
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 1.99219 1.98228 1.96769 1.9446 1.91662 1.88381 1.84634 1.80898 1.77414 1.74087 1.70972 1.68104 1.64991 1.62438 1.59837 1.57406 1.55225 1.53056 1.50851 1.48919 1.47151 1.45678 1.44239 1.42858 1.41573 1.40491 1.39224 1.38246 1.37227 1.35892 1.34942 1.33977 1.32988 1.32268 1.30844 1.30588 1.2927 1.29836 1.29324 1.29096 1.28624 1.24863 1.27839 1.25987 1.22785 1.22222 1.21875 1.07143 2 1

tree_stats_height=60
tree_stats_numInternals=9970042
tree_stats_numLeaves=9970043
tree_stats_numNodes=19940085
tree_stats_numKeys=9970043

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

tree_stats_bytesAtDepth=32 64 128 256 512 1024 2048 4096 8192 16384 32768 65024 127744 247232 467072 856256 1513536 2561920 4145088 6417728 9509376 13497984 18385408 23897728 29842368 35713280 41003200 45287744 48055872 48873664 47817088 45092608 41194496 36448064 31241728 25976128 21036096 16502336 12623040 9398464 6746560 4714752 3203904 2113792 1364160 841536 514816 301376 179840 105472 61376 35136 17472 9728 5056 2304 1024 448 64 128
tree_stats_sizeInBytes=638082720

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:1 4:2 8:49 16:23549 32:456307 64:21901 128:270
    (2^01, 2^02]: 1
    (2^02, 2^03]: 2
    (2^03, 2^04]: 49
    (2^04, 2^05]: 23549
    (2^05, 2^06]: 456307
    (2^06, 2^07]: 21901
    (2^07, 2^08]: 270
sum_limbo_reclamation_event_size_total=23244886
count_limbo_reclamation_event_size_by_thread=5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5230 5229 5230 5230 5230 5230 5230 5230 5230 5230 5230
count_limbo_reclamation_event_size_total=502079
sum_limbo_reclamation_event_count_total=502272
first_thread_announced_epoch_by_thread=12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698 12698
sum_num_inserts_by_thread=240864 243554 245154 244608 243945 241125 243563 243817 246524 246599 242720 240552 243558 245507 246250 246376 246154 243274 242735 243152 244525 246809 242818 241970 242189 242529 245774 244886 243396 241235 242457 243756 246417 246910 244581 242526 243549 243804 245576 246723 244596 242064 242091 242947 245785 246068 242631 240902 243301 243298 245558 247246 243137 240936 241721 243916 246984 246514 245789 241539 242923 245288 245992 245960 244828 240469 240925 242400 246402 245214 244631 241932 241827 243398 246492 246205 243706 243089 242467 244283 246343 246779 244564 242442 243599 244802 245814 245263 243446 241011 241259 241721 246069 245700 243924 242309
sum_num_inserts_total=23422960
sum_num_deletes_by_thread=242913 243676 244148 245411 243339 240999 242829 245626 246425 247159 243660 240329 244425 245215 245970 247335 245833 242095 241646 242999 245005 246914 244107 241939 242753 243403 246407 246342 243390 241228 242512 243058 245735 246719 243481 241373 244192 244293 245401 247333 243643 242307 241516 243468 245250 246537 243544 241218 243248 244791 245307 246448 243529 242530 242073 243511 246670 246641 244344 242144 242864 245218 246392 246293 243687 240793 240977 242641 245541 244411 244948 242683 240984 242452 245829 245409 243476 243323 242637 243979 246863 246351 243588 242087 243165 244571 245536 245307 244375 241068 241735 242161 246265 245060 244087 242911
sum_num_deletes_total=23426003
sum_num_searches_by_thread=4348574 4374749 4411984 4407750 4388016 4336147 4378999 4401375 4432897 4437386 4382567 4349984 4383617 4409609 4421999 4445208 4420480 4375946 4363045 4372307 4420224 4441492 4387766 4351096 4369654 4376189 4427775 4424169 4387185 4340053 4359803 4383671 4431729 4433447 4399742 4354981 4387265 4393344 4421604 4442499 4399704 4366463 4357011 4379942 4417905 4441077 4370779 4332767 4371780 4393472 4414149 4428699 4378104 4359020 4365411 4403456 4435440 4434688 4398508 4357778 4370123 4412760 4439282 4414828 4405273 4337036 4332909 4351781 4416233 4412761 4396052 4355464 4352511 4375928 4432359 4429668 4391055 4371302 4358929 4396169 4436881 4438152 4398295 4359882 4380905 4399930 4412317 4415289 4386564 4334756 4345225 4352263 4427476 4417686 4383523 4376187
sum_num_searches_total=421600234
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=4832351 4861979 4901286 4897769 4875300 4818271 4865391 4890818 4925846 4931144 4868947 4830865 4871600 4900331 4914219 4938919 4912467 4861315 4847426 4858458 4909754 4935215 4874691 4835005 4854596 4862121 4919956 4915397 4873971 4822516 4844772 4870485 4923881 4927076 4887804 4838880 4875006 4881441 4912581 4936555 4887943 4850834 4840618 4866357 4908940 4933682 4856954 4814887 4858329 4881561 4905014 4922393 4864770 4842486 4849205 4890883 4929094 4927843 4888641 4841461 4855910 4903266 4931666 4907081 4893788 4818298 4814811 4836822 4908176 4902386 4885631 4840079 4835322 4861778 4924680 4921282 4878237 4857714 4844033 4884431 4930087 4931282 4886447 4844411 4867669 4889303 4903667 4905859 4874385 4816835 4828219 4836145 4919810 4908446 4871534 4861407
average_num_operations_total=4879679
stdev_num_operations_total=3573
sum_num_operations_total=468449197
min_num_operations_total=4814811
max_num_operations_total=4938919
first_time_thread_terminate_by_thread=10000146 10000148 10000149 10000148 10000148 10000146 10000146 10000149 10000149 10000147 10000146 10000149 10000149 10000149 10000148 10000149 10000149 10000146 10000146 10000146 10000146 10000146 10000146 10000149 10000146 10000148 10000149 10000148 10000148 10000146 10000148 10000149 10000146 10000146 10000146 10000149 10000149 10000149 10000148 10000149 10000149 10000146 10000147 10000146 10000147 10000146 10000147 10000149 10000145 10000147 10000146 10000147 10000149 10000147 10000147 10000145 10000146 10000146 10000146 10000147 10000147 10000145 10000147 10000147 10000147 10000148 10000146 10000148 10000147 10000147 10000146 10000146 10000148 10000147 10000145 10000147 10000148 10000147 10000145 10000145 10000146 10000148 10000147 10000147 10000147 10000147 10000147 10000146 10000147 10000148 10000146 10000146 10000147 10000147 10000146 10000146
min_time_thread_terminate_total=10000145
max_time_thread_terminate_total=10000149
first_time_thread_start_by_thread=4 4 4 4 4 4 4 4 4 4 4 4 3 3 4 3 3 4 4 4 3 4 4 3 4 4 4 4 4 4 4 4 4 4 4 4 3 3 4 3 3 4 4 4 3 4 4 3 3 3 3 4 4 4 4 3 4 4 4 3 4 4 4 4 4 4 4 4 4 4 4 4 3 3 3 4 4 4 4 3 4 4 4 3 4 4 4 4 4 4 4 4 4 4 4 4
min_time_thread_start_total=3
max_time_thread_start_total=4
sum_duration_all_ops_total=

threads_final_keysum=99693402795455
threads_final_size=9970043
final_keysum=99693402795455
final_size=9970043
validate_result=success
Validation OK.
Structural validation OK.

total_find=421600234
total_rq=0
total_inserts=23422960
total_deletes=23426003
total_updates=46848963
total_queries=421600234
total_ops=468449197
find_throughput=42160023
rq_throughput=0
update_throughput=4684896
query_throughput=42160023
total_throughput=46844919


total find                    : 421600234
total rq                      : 0
total inserts                 : 23422960
total deletes                 : 23426003
total updates                 : 46848963
total queries                 : 421600234
total ops                     : 468449197
find throughput               : 42160023
rq throughput                 : 0
update throughput             : 4684896
query throughput              : 42160023
total throughput              : 46844919

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=25.6867
PAPI_L3_TCM=10.0255
PAPI_TOT_CYC=5708.57
PAPI_TOT_INS=415.361
garbage=2093151433823847
total_execution_walltime=12.977s
REALTIME_MAIN_END_PERF_FORMAT=6983511.67109840
[time_cmd_output] time_elapsed_sec=13.16, faults_major=0, faults_minor=237984, mem_maxresident_kb=950044, user_cputime=1227.64, sys_cputime=5.71, percent_cpu=9367%
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