__step=000371
__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" ./ellen_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=data000371.txt
__path_data=data/data000371.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6983277.556277738
binary=./ellen_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=ellen_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=40 descriptor=64
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.026s
prefilling_size=7307100 prefilling_elapsed_millis=1.001s
prefilling_size=7596948 prefilling_elapsed_millis=1.101s
prefilling_size=7857922 prefilling_elapsed_millis=1.201s
prefilling_size=8084771 prefilling_elapsed_millis=1.302s
prefilling_size=8289576 prefilling_elapsed_millis=1.402s
prefilling_size=8471825 prefilling_elapsed_millis=1.502s
prefilling_size=8633318 prefilling_elapsed_millis=1.602s
prefilling_size=8778999 prefilling_elapsed_millis=1.702s
prefilling_size=8906833 prefilling_elapsed_millis=1.803s
prefilling_size=9018399 prefilling_elapsed_millis=1.903s
prefilling_size=9121567 prefilling_elapsed_millis=2.003s
prefilling_size=9211808 prefilling_elapsed_millis=2.103s
prefilling_size=9295350 prefilling_elapsed_millis=2.203s
prefilling_size=9366380 prefilling_elapsed_millis=2.304s
prefilling_size=9432725 prefilling_elapsed_millis=2.404s
prefilling_size=9491816 prefilling_elapsed_millis=2.504s
prefilling_size=9544365 prefilling_elapsed_millis=2.604s
prefilling_size=9590088 prefilling_elapsed_millis=2.704s
prefilling_size=9632234 prefilling_elapsed_millis=2.805s
prefilling_size=9671511 prefilling_elapsed_millis=2.905s
prefilling_size=9705770 prefilling_elapsed_millis=3.005s
prefilling_size=9735530 prefilling_elapsed_millis=3.105s
prefilling_size=9761427 prefilling_elapsed_millis=3.205s
prefilling_size=9784975 prefilling_elapsed_millis=3.306s
prefilling_size=9806519 prefilling_elapsed_millis=3.406s
finished prefilling to size 9806543 for expected size 10000000 keysum=98060430544561, performing 79478958 updates; total_prefilling_elapsed_ms=3508 ms)
pref_size=9806543
pref_millis=3508
prefill_elapsed_ms=3529
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=1166

6info_tIxPvE_object_size=64
6info_tIxPvE_allocated_count=0
6info_tIxPvE_allocated_size=0MB
6info_tIxPvE_get_from_pool=0
6info_tIxPvE_deallocated=0
6info_tIxPvE_limbo_count=0
6info_tIxPvE_limbo_details=0 0 0 

global_epoch_counter=0

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6983281.291742660
REALTIME_END_PERF_FORMAT=6983291.291926992

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

tree_stats_computeWalltime=0.174s

tree_stats_numInternalsAtDepth=1 1 1 2 4 8 16 32 64 128 256 511 1003 1927 3674 6769 11961 20301 33251 52366 79423 115917 162597 219891 287521 364211 445882 529147 608697 677242 727590 753933 751697 722660 670199 598385 512981 424012 338558 260133 191801 136538 93820 62387 40290 25330 15588 9315 5335 3031 1689 902 436 238 110 51 25 12 5 3 1 0
tree_stats_numLeavesAtDepth=0 1 1 0 0 0 0 0 0 0 0 1 19 79 180 579 1577 3621 7351 14136 25309 42929 69237 105303 152261 210831 282540 362617 449597 540152 626894 701247 756169 780734 775121 742013 683789 601950 509466 416983 328465 247064 179256 125253 84484 55250 35072 21861 13295 7639 4373 2476 1368 634 366 169 77 38 19 7 5 2
tree_stats_numNodesAtDepth=1 2 2 2 4 8 16 32 64 128 256 512 1022 2006 3854 7348 13538 23922 40602 66502 104732 158846 231834 325194 439782 575042 728422 891764 1058294 1217394 1354484 1455180 1507866 1503394 1445320 1340398 1196770 1025962 848024 677116 520266 383602 273076 187640 124774 80580 50660 31176 18630 10670 6062 3378 1804 872 476 220 102 50 24 10 6 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 0 1 19 79 180 579 1577 3621 7351 14136 25309 42929 69237 105303 152261 210831 282540 362617 449597 540152 626894 701247 756169 780734 775121 742013 683789 601950 509466 416983 328465 247064 179256 125253 84484 55250 35072 21861 13295 7639 4373 2476 1368 634 366 169 77 38 19 7 5 2
tree_stats_avgDegreeAtDepth=2 1 1 2 2 2 2 2 2 2 2 1.99805 1.98141 1.96062 1.9533 1.9212 1.88351 1.84863 1.81895 1.78743 1.75835 1.72974 1.70135 1.67618 1.65378 1.63336 1.61212 1.59337 1.57517 1.5563 1.53717 1.5181 1.49852 1.48069 1.4637 1.44642 1.42864 1.41328 1.39923 1.38418 1.36866 1.35594 1.34357 1.33248 1.3229 1.31435 1.3077 1.29879 1.28637 1.28407 1.27862 1.26702 1.24169 1.27294 1.23109 1.23182 1.2451 1.24 1.20833 1.3 1.16667 1

tree_stats_height=62
tree_stats_numInternals=9969859
tree_stats_numLeaves=9969860
tree_stats_numNodes=19939719
tree_stats_numKeys=9969858

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

tree_stats_bytesAtDepth=40 80 80 80 160 320 640 1280 2560 5120 10240 20480 40880 80240 154160 293920 541520 956880 1624080 2660080 4189280 6353840 9273360 13007760 17591280 23001680 29136880 35670560 42331760 48695760 54179360 58207200 60314640 60135760 57812800 53615920 47870800 41038480 33920960 27084640 20810640 15344080 10923040 7505600 4990960 3223200 2026400 1247040 745200 426800 242480 135120 72160 34880 19040 8800 4080 2000 960 400 240 80
tree_stats_sizeInBytes=797588760

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

6info_tIxPvE_object_size=64
6info_tIxPvE_allocated_count=0
6info_tIxPvE_allocated_size=0MB
6info_tIxPvE_get_from_pool=0
6info_tIxPvE_deallocated=0
6info_tIxPvE_limbo_count=0
6info_tIxPvE_limbo_details=0 0 0 

global_epoch_counter=0


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:1 2:2 4:4 8:31 16:3909 32:544050 64:309293 128:181 256:1
    [2^00, 2^01]: 1
    (2^01, 2^02]: 2
    (2^02, 2^03]: 4
    (2^03, 2^04]: 31
    (2^04, 2^05]: 3909
    (2^05, 2^06]: 544050
    (2^06, 2^07]: 309293
    (2^07, 2^08]: 181
    (2^08, 2^09]: 1
sum_limbo_reclamation_event_size_total=49820363
count_limbo_reclamation_event_size_by_thread=8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932 8932
count_limbo_reclamation_event_size_total=857472
sum_limbo_reclamation_event_count_total=857856
first_thread_announced_epoch_by_thread=11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268 11268
sum_num_inserts_by_thread=206456 206951 208549 208959 208350 205629 207156 207927 209273 209886 208290 206821 207292 208180 210103 208337 207741 207000 205506 207226 207829 209142 207124 205034 206052 208531 208643 209974 208417 206653 206607 207601 210324 209906 207158 206197 207788 208787 209368 209455 207759 207232 205368 206564 207755 208876 206577 204321 207366 207420 209660 209285 207989 207237 207441 208317 210656 209989 208584 207699 207332 209561 210974 210415 209150 206732 205972 206421 209800 209111 207230 206549 206656 208184 209120 209927 207567 206134 206560 208868 210091 209860 209019 207242 208535 208279 209821 210194 208071 206649 205950 206815 209742 210076 208885 206216
sum_num_inserts_total=19970025
sum_num_deletes_by_thread=206275 207282 209928 208565 207936 205229 207345 207905 209792 210425 207438 205867 207511 208521 210323 209527 208733 206896 205891 208517 208168 209475 207797 205346 205769 208080 210026 208959 209108 205575 207244 208365 210398 209951 208128 206479 207751 207970 209784 210259 207260 206185 205876 206359 208175 208671 206320 204918 206154 208333 209287 209132 206445 207596 207536 208638 210153 211248 208611 207698 208220 208328 210897 209935 209082 206113 204994 206937 208506 210235 207918 206253 206526 208347 209148 209090 207815 206524 206468 208027 210149 210723 208177 206868 207703 208515 210346 208721 208954 207215 206048 207167 209423 210215 207281 206879
sum_num_deletes_total=19972880
sum_num_searches_by_thread=3710364 3732127 3765189 3760088 3744021 3703475 3721448 3741936 3775175 3782552 3737377 3707585 3728922 3748071 3772658 3772297 3746057 3724177 3699732 3720912 3749381 3768179 3720033 3690365 3711281 3741827 3769085 3765342 3749344 3704646 3722771 3742186 3778260 3786712 3735606 3714705 3729556 3756932 3774318 3772110 3738004 3724449 3699385 3718914 3744173 3762540 3720929 3693017 3721140 3739507 3774566 3770826 3740486 3722592 3729947 3746837 3786065 3791635 3754785 3728025 3742947 3764543 3788637 3788277 3758534 3717230 3709584 3728180 3769691 3768660 3738487 3712310 3719029 3744975 3774553 3770553 3738054 3711796 3719267 3738949 3782905 3781396 3751233 3734209 3740811 3759664 3779881 3783366 3747451 3718405 3705551 3725314 3777447 3775157 3748912 3717541
sum_num_searches_total=359418123
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=4123095 4146360 4183666 4177612 4160307 4114333 4135949 4157768 4194240 4202863 4153105 4120273 4143725 4164772 4193084 4190161 4162531 4138073 4111129 4136655 4165378 4186796 4134954 4100745 4123102 4158438 4187754 4184275 4166869 4116874 4136622 4158152 4198982 4206569 4150892 4127381 4145095 4173689 4193470 4191824 4153023 4137866 4110629 4131837 4160103 4180087 4133826 4102256 4134660 4155260 4193513 4189243 4154920 4137425 4144924 4163792 4206874 4212872 4171980 4143422 4158499 4182432 4210508 4208627 4176766 4130075 4120550 4141538 4187997 4188006 4153635 4125112 4132211 4161506 4192821 4189570 4153436 4124454 4132295 4155844 4203145 4201979 4168429 4148319 4157049 4176458 4200048 4202281 4164476 4132269 4117549 4139296 4196612 4195448 4165078 4130636
average_num_operations_total=4160010
stdev_num_operations_total=2978
sum_num_operations_total=399361028
min_num_operations_total=4100745
max_num_operations_total=4212872
first_time_thread_terminate_by_thread=10000183 10000184 10000184 10000184 10000184 10000184 10000184 10000186 10000184 10000184 10000184 10000184 10000184 10000184 10000185 10000184 10000184 10000184 10000184 10000184 10000184 10000184 10000184 10000183 10000183 10000184 10000184 10000184 10000184 10000184 10000184 10000186 10000184 10000184 10000184 10000184 10000183 10000184 10000183 10000185 10000184 10000184 10000184 10000185 10000184 10000184 10000184 10000183 10000187 10000183 10000185 10000185 10000186 10000184 10000186 10000185 10000186 10000188 10000185 10000183 10000186 10000186 10000184 10000186 10000183 10000183 10000186 10000184 10000186 10000183 10000185 10000185 10000187 10000183 10000186 10000185 10000184 10000184 10000183 10000185 10000185 10000186 10000185 10000183 10000186 10000186 10000185 10000184 10000183 10000186 10000186 10000184 10000186 10000186 10000185 10000185
min_time_thread_terminate_total=10000183
max_time_thread_terminate_total=10000188
first_time_thread_start_by_thread=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 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 4 3 3 3 3 3 3 3 3 3 4 4 4 4 3 4 4 4 4 3 4 4 4 4 4 4 3 4 4 4 4 3 3 3 4 4 4 4 3 4 4 4 4 3 4 4 4 4 4 4 3 4 4 4 4 3
min_time_thread_start_total=3
max_time_thread_start_total=4
sum_duration_all_ops_total=

threads_final_keysum=99686441803877
threads_final_size=9969858
final_keysum=99686441803877
final_size=9969858
validate_result=success
Validation OK.
Structural validation OK.

total_find=359418123
total_rq=0
total_inserts=19970025
total_deletes=19972880
total_updates=39942905
total_queries=359418123
total_ops=399361028
find_throughput=35941812
rq_throughput=0
update_throughput=3994290
query_throughput=35941812
total_throughput=39936102


total find                    : 359418123
total rq                      : 0
total inserts                 : 19970025
total deletes                 : 19972880
total updates                 : 39942905
total queries                 : 359418123
total ops                     : 399361028
find throughput               : 35941812
rq throughput                 : 0
update throughput             : 3994290
query throughput              : 35941812
total throughput              : 39936102

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=39.7465
PAPI_L3_TCM=15.4408
PAPI_TOT_CYC=6684.81
PAPI_TOT_INS=410.328
garbage=1763520014605612
total_execution_walltime=14.021s
REALTIME_MAIN_END_PERF_FORMAT=6983291.593086247
[time_cmd_output] time_elapsed_sec=14.23, faults_major=0, faults_minor=323563, mem_maxresident_kb=1258924, user_cputime=1322.35, sys_cputime=4.88, percent_cpu=9325%
timeout=false
algorithm=ellen_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