__step=000035
__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 128 -nprefill 128 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 0.5 0.5 -k 20000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000035.txt
__path_data=data/data000035.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=207222.859927763
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=0.5
DEL_FRAC=0.5
RQ=0
RQSIZE=0
MAXKEY=20000000
PREFILL_THREADS=128
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=128
WORK_THREADS=128
RQ_THREADS=0
distribution=0
INS_DEL_FRAC=0.5 0.5
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,128,129,130,131,132,133,134,135,136,137,138,139,140,141,142,143,144,145,146,147,148,149,150,151,152,153,154,155,156,157,158,159,160,161,162,163,164,165,166,167,168,169,170,171,172,173,174,175,176,177,178,179,180,181,182,183,184,185,186,187,188,189,190,191


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.026s
prefilling_size=7575168 prefilling_elapsed_millis=1s
prefilling_size=7861768 prefilling_elapsed_millis=1.101s
prefilling_size=8112680 prefilling_elapsed_millis=1.201s
prefilling_size=8334294 prefilling_elapsed_millis=1.301s
prefilling_size=8527330 prefilling_elapsed_millis=1.401s
prefilling_size=8699627 prefilling_elapsed_millis=1.501s
prefilling_size=8846956 prefilling_elapsed_millis=1.601s
prefilling_size=8980993 prefilling_elapsed_millis=1.701s
prefilling_size=9094351 prefilling_elapsed_millis=1.801s
prefilling_size=9196956 prefilling_elapsed_millis=1.902s
prefilling_size=9287098 prefilling_elapsed_millis=2.002s
prefilling_size=9365683 prefilling_elapsed_millis=2.102s
prefilling_size=9437109 prefilling_elapsed_millis=2.202s
prefilling_size=9499891 prefilling_elapsed_millis=2.302s
prefilling_size=9556487 prefilling_elapsed_millis=2.402s
prefilling_size=9606041 prefilling_elapsed_millis=2.502s
prefilling_size=9651815 prefilling_elapsed_millis=2.602s
prefilling_size=9692043 prefilling_elapsed_millis=2.703s
prefilling_size=9726756 prefilling_elapsed_millis=2.803s
prefilling_size=9757593 prefilling_elapsed_millis=2.903s
prefilling_size=9783529 prefilling_elapsed_millis=3.003s
prefilling_size=9806499 prefilling_elapsed_millis=3.104s
finished prefilling to size 9806496 for expected size 10000000 keysum=98065958830381, performing 80570308 updates; total_prefilling_elapsed_ms=3205 ms)
pref_size=9806496
pref_millis=3205
prefill_elapsed_ms=3217
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=629

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=207226.140768566
REALTIME_END_PERF_FORMAT=207236.140863242

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

tree_stats_computeWalltime=0.349s

tree_stats_numInternalsAtDepth=1 1 1 2 4 8 16 32 64 128 256 509 1004 1929 3669 6741 11974 20494 33859 53683 81429 118827 166036 223027 289021 361001 434577 507010 571745 625061 661440 678519 675724 654785 618914 569088 509533 443207 373878 305096 240313 183256 134718 95904 66058 43712 28099 17820 10889 6116 3368 1812 1000 479 234 108 42 27 10 2 0
tree_stats_numLeavesAtDepth=0 1 1 0 0 0 0 0 0 0 0 3 14 79 189 597 1508 3454 7129 14035 25937 44031 71618 109045 157033 217041 287425 362144 442275 518429 588682 644361 681314 696663 690656 668740 628643 575859 512536 442660 369879 297370 231794 173532 125750 88404 59325 38378 24751 15662 8864 4924 2624 1521 724 360 174 57 44 18 4
tree_stats_numNodesAtDepth=1 2 2 2 4 8 16 32 64 128 256 512 1018 2008 3858 7338 13482 23948 40988 67718 107366 162858 237654 332072 446054 578042 722002 869154 1014020 1143490 1250122 1322880 1357038 1351448 1309570 1237828 1138176 1019066 886414 747756 610192 480626 366512 269436 191808 132116 87424 56198 35640 21778 12232 6736 3624 2000 958 468 216 84 54 20 4
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 0 3 14 79 189 597 1508 3454 7129 14035 25937 44031 71618 109045 157033 217041 287425 362144 442275 518429 588682 644361 681314 696663 690656 668740 628643 575859 512536 442660 369879 297370 231794 173532 125750 88404 59325 38378 24751 15662 8864 4924 2624 1521 724 360 174 57 44 18 4
tree_stats_avgDegreeAtDepth=2 1 1 2 2 2 2 2 2 2 2 1.99414 1.98625 1.96066 1.95101 1.91864 1.88815 1.85577 1.82607 1.79274 1.75842 1.72964 1.69865 1.67162 1.64795 1.62452 1.60191 1.58334 1.56384 1.54663 1.5291 1.51291 1.49794 1.48451 1.47261 1.45975 1.44768 1.43491 1.42179 1.40802 1.39383 1.38129 1.36757 1.35594 1.3444 1.33086 1.32141 1.31709 1.30553 1.28083 1.27534 1.269 1.27594 1.2395 1.24426 1.23077 1.19444 1.32143 1.18519 1.1 1

tree_stats_height=61
tree_stats_numInternals=9836260
tree_stats_numLeaves=9836261
tree_stats_numNodes=19672521
tree_stats_numKeys=9836259

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

tree_stats_bytesAtDepth=40 80 80 80 160 320 640 1280 2560 5120 10240 20480 40720 80320 154320 293520 539280 957920 1639520 2708720 4294640 6514320 9506160 13282880 17842160 23121680 28880080 34766160 40560800 45739600 50004880 52915200 54281520 54057920 52382800 49513120 45527040 40762640 35456560 29910240 24407680 19225040 14660480 10777440 7672320 5284640 3496960 2247920 1425600 871120 489280 269440 144960 80000 38320 18720 8640 3360 2160 800 160
tree_stats_sizeInBytes=786900840

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

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:5513 2:48623 4:257386 8:255715 16:20030 32:97
    [2^00, 2^01]: 5513
    (2^01, 2^02]: 48623
    (2^02, 2^03]: 257386
    (2^03, 2^04]: 255715
    (2^04, 2^05]: 20030
    (2^05, 2^06]: 97
sum_limbo_reclamation_event_size_total=4565062
count_limbo_reclamation_event_size_by_thread=4592 4594 4574 4592 4590 4592 4584 4590 4590 4586 4592 4592 4592 4592 4584 4584 4590 4584 4596 4590 4588 4588 4584 4584 4586 4594 4586 4592 4586 4594 4590 4582 4584 4588 4592 4590 4592 4588 4580 4594 4586 4590 4592 4590 4582 4588 4596 4590 4586 4590 4590 4590 4580 4592 4588 4594 4588 4594 4594 4584 4586 4590 4594 4592 4594 4592 4588 4590 4586 4590 4582 4588 4590 4588 4590 4590 4586 4590 4586 4592 4588 4588 4596 4586 4588 4586 4598 4594 4592 4588 4586 4592 4596 4588 4590 4592 4590 4592 4588 4590 4590 4588 4582 4588 4588 4582 4582 4582 4588 4584 4596 4584 4590 4594 4590 4580 4594 4588 4586 4590 4582 4582 4590 4588 4592 4586 4594 4586
count_limbo_reclamation_event_size_total=587364
sum_limbo_reclamation_event_count_total=589056
first_thread_announced_epoch_by_thread=5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860 5860
sum_num_inserts_by_thread=14391 14425 14395 14341 14764 14429 14237 14323 14152 14276 14363 14435 14609 14690 14336 14260 14263 14421 14265 14228 14285 14309 14081 14285 14256 14364 14218 14307 14648 14360 14230 14474 14315 14349 14407 14598 14553 14435 14387 14355 14318 14322 14522 14309 14642 14323 14532 14488 14404 14340 14256 14320 14380 14326 14379 14382 14373 14383 14352 14353 14402 14294 14232 14319 14202 14265 14175 14288 14150 14366 14412 14276 14269 14506 14375 14194 14356 14354 14244 14391 14291 14167 14211 14103 14421 14207 14248 14308 14101 14458 14039 14266 14290 14431 14062 14223 14403 14163 14203 14352 14366 14454 14292 14252 14330 14336 14183 14488 14297 14170 14275 14123 14316 14238 14456 14181 14474 14385 14414 14411 14257 13986 14098 13866 14212 14394 14362 14405
sum_num_inserts_total=1833561
sum_num_deletes_by_thread=14566 14605 14274 14609 14587 14423 14474 14271 14605 14351 14327 14396 14465 14677 14475 14222 14297 14334 14272 14356 14251 14212 14267 14183 14512 14155 14445 14122 14288 14519 14298 14334 14414 14552 14362 14356 14489 14443 14407 14482 14344 14375 14508 14519 14402 14459 14380 14565 14332 14235 14043 14063 14141 14391 14124 14227 14219 14458 14418 14275 14313 14229 14432 14260 14300 14092 14207 14102 14378 14129 14453 14372 14549 14387 14252 14419 14444 14157 14229 14251 14283 14179 14417 14177 14569 14292 14330 14295 14312 14324 14334 14416 14501 14154 14124 14418 14504 14452 13982 14371 14499 14427 14345 14280 14252 14418 14260 14325 14386 14218 14438 14257 14452 14312 14345 14299 14338 14349 14133 14336 14277 14219 14248 14346 14149 14209 14193 14433
sum_num_deletes_total=1835287
sum_num_searches_by_thread=2866156 2864329 2855398 2849591 2865218 2862920 2847504 2846917 2851529 2849738 2836370 2838770 2846925 2861510 2844526 2849778 2851285 2845444 2841597 2833097 2843543 2834359 2828172 2827979 2830798 2828339 2823376 2823284 2844978 2845695 2836803 2839827 2864931 2865196 2851720 2842889 2857197 2849156 2842820 2840386 2847295 2843662 2854304 2854894 2865885 2864429 2852116 2854776 2848170 2838254 2823258 2821999 2833507 2829710 2820857 2819587 2845884 2847800 2836331 2831680 2846103 2842230 2834276 2827574 2836581 2833224 2826692 2825850 2833214 2832039 2844665 2838910 2850789 2848764 2836357 2838464 2848238 2844352 2826297 2829498 2824270 2822865 2811534 2812839 2840059 2838996 2832776 2828245 2839474 2835516 2824598 2826067 2826596 2824991 2809637 2815266 2840668 2837500 2826962 2849347 2863401 2857248 2850615 2850651 2856846 2857349 2830563 2832984 2840887 2840416 2828693 2833383 2823947 2841595 2833164 2831683 2840671 2837688 2831821 2828858 2826997 2817451 2813082 2814603 2831407 2833789 2825696 2843996
sum_num_searches_total=363396255
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=2895113 2893359 2884067 2878541 2894569 2891772 2876215 2875511 2880286 2878365 2865060 2867601 2875999 2890877 2873337 2878260 2879845 2874199 2870134 2861681 2872079 2862880 2856520 2856447 2859566 2856858 2852039 2851713 2873914 2874574 2865331 2868635 2893660 2894097 2880489 2871843 2886239 2878034 2871614 2869223 2875957 2872359 2883334 2883722 2894929 2893211 2881028 2883829 2876906 2866829 2851557 2850382 2862028 2858427 2849360 2848196 2874476 2876641 2865101 2860308 2874818 2870753 2862940 2856153 2865083 2861581 2855074 2854240 2861742 2860534 2873530 2867558 2879607 2877657 2864984 2867077 2877038 2872863 2854770 2858140 2852844 2851211 2840162 2841119 2869049 2867495 2861354 2856848 2867887 2864298 2852971 2854749 2855387 2853576 2837823 2843907 2869575 2866115 2855147 2878070 2892266 2886129 2879252 2879183 2885428 2886103 2859006 2861797 2869570 2868804 2857406 2861763 2852715 2870145 2861965 2860163 2869483 2866422 2860368 2857605 2855531 2845656 2841428 2842815 2859768 2862392 2854251 2872834
average_num_operations_total=2867696
stdev_num_operations_total=1179
sum_num_operations_total=367065103
min_num_operations_total=2837823
max_num_operations_total=2895113
first_time_thread_terminate_by_thread=10000096 10000096 10000096 10000096 10000095 10000095 10000095 10000095 10000098 10000098 10000098 10000098 10000096 10000096 10000096 10000097 10000097 10000097 10000097 10000097 10000098 10000098 10000098 10000098 10000095 10000095 10000095 10000095 10000095 10000096 10000096 10000096 10000097 10000097 10000097 10000097 10000098 10000098 10000098 10000098 10000096 10000096 10000096 10000096 10000095 10000097 10000095 10000095 10000097 10000097 10000097 10000097 10000099 10000099 10000099 10000099 10000098 10000098 10000098 10000098 10000097 10000097 10000097 10000097 10000096 10000096 10000098 10000096 10000095 10000095 10000095 10000095 10000098 10000098 10000098 10000098 10000096 10000097 10000096 10000097 10000097 10000097 10000097 10000097 10000098 10000098 10000098 10000098 10000095 10000095 10000095 10000095 10000095 10000096 10000096 10000095 10000097 10000097 10000097 10000097 10000098 10000098 10000098 10000098 10000096 10000096 10000096 10000096 10000095 10000095 10000095 10000095 10000097 10000097 10000097 10000097 10000099 10000099 10000099 10000099 10000098 10000098 10000098 10000098 10000097 10000097 10000097 10000097
min_time_thread_terminate_total=10000095
max_time_thread_terminate_total=10000099
first_time_thread_start_by_thread=5 5 5 5 5 5 5 5 4 4 4 4 5 5 5 5 7 7 7 7 5 5 5 5 6 6 6 6 6 6 6 6 8 8 8 8 7 7 7 7 6 6 6 6 8 8 8 8 7 7 7 7 7 7 7 7 8 8 8 8 6 6 6 6 5 5 5 5 5 5 5 5 4 4 4 4 5 5 5 5 7 7 7 7 5 5 5 5 6 6 6 6 6 6 6 6 8 8 8 8 7 7 7 7 6 6 6 6 8 8 8 8 7 7 7 7 7 7 7 7 8 8 8 8 6 6 6 6
min_time_thread_start_total=4
max_time_thread_start_total=8
sum_duration_all_ops_total=

threads_final_keysum=98357405594506
threads_final_size=9836259
final_keysum=98357405594506
final_size=9836259
validate_result=success
Validation OK.
Structural validation OK.

total_find=363396255
total_rq=0
total_inserts=1833561
total_deletes=1835287
total_updates=3668848
total_queries=363396255
total_ops=367065103
find_throughput=36339625
rq_throughput=0
update_throughput=366884
query_throughput=36339625
total_throughput=36706510


total find                    : 363396255
total rq                      : 0
total inserts                 : 1833561
total deletes                 : 1835287
total updates                 : 3668848
total queries                 : 363396255
total ops                     : 367065103
find throughput               : 36339625
rq throughput                 : 0
update throughput             : 366884
query throughput              : 36339625
total throughput              : 36706510

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

garbage=264680983206266
total_execution_walltime=13.686s
REALTIME_MAIN_END_PERF_FORMAT=207236.546673047
[time_cmd_output] time_elapsed_sec=13.86, faults_major=0, faults_minor=321970, mem_maxresident_kb=1285040, user_cputime=1688.63, sys_cputime=21.16, percent_cpu=12336%
timeout=false
algorithm=ellen_ext_bst_lf.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1