__step=000370
__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 64 -nprefill 64 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 20000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000370.txt
__path_data=data/data000370.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=211266.502537684
binary=./ellen_ext_bst_lf.debra
parsed custom binding: 0-63,128-191,64-127,192-255
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=64
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=64
WORK_THREADS=64
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,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,48,49,50,51,52,53,54,55,56,57,58,59,60,61,62,63
Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.021s
prefilling_size=6370208 prefilling_elapsed_millis=1s
prefilling_size=6670625 prefilling_elapsed_millis=1.1s
prefilling_size=6942676 prefilling_elapsed_millis=1.201s
prefilling_size=7191527 prefilling_elapsed_millis=1.301s
prefilling_size=7420990 prefilling_elapsed_millis=1.401s
prefilling_size=7630082 prefilling_elapsed_millis=1.501s
prefilling_size=7821133 prefilling_elapsed_millis=1.601s
prefilling_size=7996686 prefilling_elapsed_millis=1.701s
prefilling_size=8156510 prefilling_elapsed_millis=1.801s
prefilling_size=8301253 prefilling_elapsed_millis=1.901s
prefilling_size=8435242 prefilling_elapsed_millis=2.002s
prefilling_size=8559604 prefilling_elapsed_millis=2.102s
prefilling_size=8672976 prefilling_elapsed_millis=2.202s
prefilling_size=8777714 prefilling_elapsed_millis=2.302s
prefilling_size=8874175 prefilling_elapsed_millis=2.402s
prefilling_size=8962330 prefilling_elapsed_millis=2.502s
prefilling_size=9042788 prefilling_elapsed_millis=2.602s
prefilling_size=9118075 prefilling_elapsed_millis=2.702s
prefilling_size=9186847 prefilling_elapsed_millis=2.802s
prefilling_size=9250483 prefilling_elapsed_millis=2.903s
prefilling_size=9309824 prefilling_elapsed_millis=3.003s
prefilling_size=9363094 prefilling_elapsed_millis=3.103s
prefilling_size=9411742 prefilling_elapsed_millis=3.203s
prefilling_size=9456799 prefilling_elapsed_millis=3.303s
prefilling_size=9498023 prefilling_elapsed_millis=3.404s
prefilling_size=9536601 prefilling_elapsed_millis=3.504s
prefilling_size=9571758 prefilling_elapsed_millis=3.604s
prefilling_size=9605006 prefilling_elapsed_millis=3.704s
prefilling_size=9635984 prefilling_elapsed_millis=3.804s
prefilling_size=9664243 prefilling_elapsed_millis=3.904s
prefilling_size=9690040 prefilling_elapsed_millis=4.004s
prefilling_size=9713516 prefilling_elapsed_millis=4.104s
prefilling_size=9736353 prefilling_elapsed_millis=4.205s
prefilling_size=9756983 prefilling_elapsed_millis=4.305s
prefilling_size=9774966 prefilling_elapsed_millis=4.405s
prefilling_size=9792528 prefilling_elapsed_millis=4.505s
prefilling_size=9808977 prefilling_elapsed_millis=4.605s
finished prefilling to size 9809001 for expected size 10000000 keysum=98081357893791, performing 79142925 updates; total_prefilling_elapsed_ms=4706 ms)
pref_size=9809001
pref_millis=4706
prefill_elapsed_ms=4719
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=2179
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=211271.258978239
REALTIME_END_PERF_FORMAT=211281.259011287
###############################################################################
################################## 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 (256 threads)...
partitioned into 1854 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.225s
tree_stats_numInternalsAtDepth=1 1 1 2 4 8 16 32 64 127 251 481 927 1749 3263 5989 10716 18436 30420 48324 74150 108740 153084 208055 272215 343853 421771 500092 575168 640616 691070 721170 728139 709599 668289 605807 529751 447194 365048 288422 221612 166202 121831 86677 60108 40459 26341 16601 10156 5966 3465 1884 964 488 263 130 49 30 17 13 3 1 0
tree_stats_numLeavesAtDepth=0 1 1 0 0 0 0 0 0 1 3 21 35 105 235 537 1262 2996 6452 12516 22498 39560 64396 98113 143895 200577 265935 343450 425016 509720 590162 660970 714201 746679 750909 730771 681863 612308 529340 441674 355232 277022 210573 156985 113246 79757 54577 36081 23046 14346 8467 5046 2804 1440 713 396 211 68 43 21 23 5 2
tree_stats_numNodesAtDepth=1 2 2 2 4 8 16 32 64 128 254 502 962 1854 3498 6526 11978 21432 36872 60840 96648 148300 217480 306168 416110 544430 687706 843542 1000184 1150336 1281232 1382140 1442340 1456278 1419198 1336578 1211614 1059502 894388 730096 576844 443224 332404 243662 173354 120216 80918 52682 33202 20312 11932 6930 3768 1928 976 526 260 98 60 34 26 6 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 1 3 21 35 105 235 537 1262 2996 6452 12516 22498 39560 64396 98113 143895 200577 265935 343450 425016 509720 590162 660970 714201 746679 750909 730771 681863 612308 529340 441674 355232 277022 210573 156985 113246 79757 54577 36081 23046 14346 8467 5046 2804 1440 713 396 211 68 43 21 23 5 2
tree_stats_avgDegreeAtDepth=2 1 1 2 2 2 2 2 2 1.99219 1.98819 1.95817 1.96362 1.94337 1.93282 1.91771 1.89464 1.86021 1.82502 1.79428 1.76722 1.73324 1.7039 1.67955 1.65419 1.63158 1.6133 1.59285 1.57506 1.55689 1.53938 1.52178 1.50483 1.48727 1.47089 1.45325 1.43723 1.42208 1.40815 1.39505 1.38418 1.37498 1.36651 1.35573 1.34674 1.33655 1.32553 1.31512 1.30589 1.29372 1.2904 1.27186 1.25584 1.25311 1.26947 1.24715 1.18846 1.30612 1.28333 1.38235 1.11538 1.16667 1
tree_stats_height=63
tree_stats_numInternals=9936305
tree_stats_numLeaves=9936306
tree_stats_numNodes=19872611
tree_stats_numKeys=9936304
tree_stats_avgDegreeInternal=2
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=33.695
tree_stats_bytesAtDepth=40 80 80 80 160 320 640 1280 2560 5120 10160 20080 38480 74160 139920 261040 479120 857280 1474880 2433600 3865920 5932000 8699200 12246720 16644400 21777200 27508240 33741680 40007360 46013440 51249280 55285600 57693600 58251120 56767920 53463120 48464560 42380080 35775520 29203840 23073760 17728960 13296160 9746480 6934160 4808640 3236720 2107280 1328080 812480 477280 277200 150720 77120 39040 21040 10400 3920 2400 1360 1040 240 80
tree_stats_sizeInBytes=794904440
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=7921
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:1 4:5 8:351 16:192261 32:438631 64:8368 128:124
[2^00, 2^01]: 1
(2^01, 2^02]: 1
(2^02, 2^03]: 5
(2^03, 2^04]: 351
(2^04, 2^05]: 192261
(2^05, 2^06]: 438631
(2^06, 2^07]: 8368
(2^07, 2^08]: 124
sum_limbo_reclamation_event_size_total=24588659
count_limbo_reclamation_event_size_by_thread=9996 9996 9996 9994 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996
count_limbo_reclamation_event_size_total=639742
sum_limbo_reclamation_event_count_total=734976
first_thread_announced_epoch_by_thread=15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842 15842
sum_num_inserts_by_thread=178269 177894 176810 177107 178071 177112 177348 177560 177632 177515 176435 177184 177169 176481 176179 175531 176149 176705 175701 175436 177294 177991 177134 176670 177021 176705 176745 177206 176161 176599 175938 175068 177833 177776 176732 178369 179547 178754 178590 178467 178672 178444 178064 176888 178240 176757 176177 176258 175399 175256 177228 177145 177635 176846 176358 177069 177288 176763 175440 175726 175707 174851 175548 175842
sum_num_inserts_total=11324489
sum_num_deletes_by_thread=178140 178201 177561 177018 177820 177600 177101 177838 177967 177763 177793 176442 177467 177862 175268 176220 175923 176228 176635 176285 175734 178916 177642 177398 177068 176465 177282 176607 177221 175787 175331 175497 177496 176731 176829 178672 178590 179511 178262 177977 178157 178150 177530 177268 177425 177284 176711 175910 175388 175446 176809 176341 176445 176780 177027 176184 176361 176458 175284 175734 176130 175933 176518 175908
sum_num_deletes_total=11325329
sum_num_searches_by_thread=3209533 3208893 3193389 3176379 3198500 3194791 3185041 3200873 3196612 3191304 3184019 3183106 3189929 3187201 3176583 3167147 3175127 3179997 3165363 3167688 3173212 3205953 3194648 3189983 3193432 3187450 3181308 3177933 3180484 3170384 3156482 3155290 3193217 3192997 3181555 3220142 3228461 3222549 3213540 3211233 3212801 3209456 3203265 3189020 3189874 3187108 3179827 3175762 3158619 3152621 3184811 3181992 3188466 3188084 3180252 3176821 3186383 3173856 3163001 3154213 3166925 3169452 3167114 3167649
sum_num_searches_total=203869100
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=3565942 3564988 3547760 3530504 3554391 3549503 3539490 3556271 3552211 3546582 3538247 3536732 3544565 3541544 3528030 3518898 3527199 3532930 3517699 3519409 3526240 3562860 3549424 3544051 3547521 3540620 3535335 3531746 3533866 3522770 3507751 3505855 3548546 3547504 3535116 3577183 3586598 3580814 3570392 3567677 3569630 3566050 3558859 3543176 3545539 3541149 3532715 3527930 3509406 3503323 3538848 3535478 3542546 3541710 3533637 3530074 3540032 3527077 3513725 3505673 3518762 3520236 3519180 3519399
average_num_operations_total=3539358
stdev_num_operations_total=2399
sum_num_operations_total=226518918
min_num_operations_total=3503323
max_num_operations_total=3586598
first_time_thread_terminate_by_thread=10000037 10000037 10000037 10000037 10000035 10000035 10000035 10000035 10000037 10000037 10000037 10000037 10000037 10000037 10000037 10000037 10000038 10000038 10000038 10000038 10000038 10000038 10000038 10000038 10000036 10000035 10000035 10000036 10000038 10000038 10000038 10000038 10000036 10000036 10000036 10000036 10000037 10000037 10000037 10000037 10000037 10000037 10000037 10000037 10000036 10000036 10000036 10000036 10000036 10000036 10000036 10000036 10000039 10000039 10000039 10000039 10000035 10000035 10000035 10000035 10000039 10000039 10000039 10000039
min_time_thread_terminate_total=10000035
max_time_thread_terminate_total=10000039
first_time_thread_start_by_thread=4 4 4 4 6 6 6 6 5 5 5 5 5 5 5 5 4 4 4 4 5 5 5 5 5 5 5 5 7 7 7 7 6 6 6 6 7 7 7 7 8 8 8 8 4 4 4 4 8 7 8 7 6 6 6 6 6 6 6 6 7 7 7 7
min_time_thread_start_total=4
max_time_thread_start_total=8
sum_duration_all_ops_total=
threads_final_keysum=99350471828339
threads_final_size=9936304
final_keysum=99350471828339
final_size=9936304
validate_result=success
Validation OK.
Structural validation OK.
total_find=203869100
total_rq=0
total_inserts=11324489
total_deletes=11325329
total_updates=22649818
total_queries=203869100
total_ops=226518918
find_throughput=20386910
rq_throughput=0
update_throughput=2264981
query_throughput=20386910
total_throughput=22651891
total find : 203869100
total rq : 0
total inserts : 11324489
total deletes : 11325329
total updates : 22649818
total queries : 203869100
total ops : 226518918
find throughput : 20386910
rq throughput : 0
update throughput : 2264981
query throughput : 20386910
total throughput : 22651891
elapsed milliseconds : 10000
napping milliseconds overtime : 0
garbage=975803901717613
total_execution_walltime=15.071s
REALTIME_MAIN_END_PERF_FORMAT=211281.574746551
[time_cmd_output] time_elapsed_sec=15.25, faults_major=0, faults_minor=312657, mem_maxresident_kb=1247448, user_cputime=967.20, sys_cputime=8.39, percent_cpu=6394%
timeout=false
algorithm=ellen_ext_bst_lf.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2