__step=000036
__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=data000036.txt
__path_data=data/data000036.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=207236.775943797
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.021s
prefilling_size=7676538 prefilling_elapsed_millis=1s
prefilling_size=7959627 prefilling_elapsed_millis=1.101s
prefilling_size=8200323 prefilling_elapsed_millis=1.201s
prefilling_size=8415101 prefilling_elapsed_millis=1.301s
prefilling_size=8602217 prefilling_elapsed_millis=1.401s
prefilling_size=8769251 prefilling_elapsed_millis=1.501s
prefilling_size=8914694 prefilling_elapsed_millis=1.601s
prefilling_size=9042437 prefilling_elapsed_millis=1.701s
prefilling_size=9153724 prefilling_elapsed_millis=1.801s
prefilling_size=9253289 prefilling_elapsed_millis=1.901s
prefilling_size=9340658 prefilling_elapsed_millis=2.002s
prefilling_size=9418011 prefilling_elapsed_millis=2.102s
prefilling_size=9486224 prefilling_elapsed_millis=2.202s
prefilling_size=9545646 prefilling_elapsed_millis=2.302s
prefilling_size=9596450 prefilling_elapsed_millis=2.402s
prefilling_size=9641909 prefilling_elapsed_millis=2.502s
prefilling_size=9684099 prefilling_elapsed_millis=2.602s
prefilling_size=9720331 prefilling_elapsed_millis=2.702s
prefilling_size=9751145 prefilling_elapsed_millis=2.803s
prefilling_size=9780648 prefilling_elapsed_millis=2.903s
prefilling_size=9805704 prefilling_elapsed_millis=3.003s
finished prefilling to size 9805683 for expected size 10000000 keysum=98049263730193, performing 79234283 updates; total_prefilling_elapsed_ms=3104 ms)
pref_size=9805683
pref_millis=3104
prefill_elapsed_ms=3118
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=627
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=207239.943848774
REALTIME_END_PERF_FORMAT=207249.943945844
###############################################################################
################################## 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 1968 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.221s
tree_stats_numInternalsAtDepth=1 1 1 2 4 8 16 32 64 128 255 501 984 1896 3589 6531 11545 19687 32708 52800 82711 124578 179463 248607 329731 418138 509988 596946 669897 722551 749695 748123 720312 668740 599989 520750 437768 356665 281958 216108 161012 117603 83728 57850 39207 25761 16365 9956 5815 3314 1906 992 505 272 125 49 17 7 2 3 1 0
tree_stats_numLeavesAtDepth=0 1 1 0 0 0 0 0 0 0 1 9 18 72 203 647 1517 3403 6666 12616 22889 40844 69693 110319 167483 241324 326288 423030 523995 617243 695407 751267 775934 771884 737491 679228 603732 518871 431372 347808 271204 204421 151478 109606 76493 52653 35157 22774 14097 8316 4722 2820 1479 738 419 201 81 27 12 1 5 2
tree_stats_numNodesAtDepth=1 2 2 2 4 8 16 32 64 128 256 510 1002 1968 3792 7178 13062 23090 39374 65416 105600 165422 249156 358926 497214 659462 836276 1019976 1193892 1339794 1445102 1499390 1496246 1440624 1337480 1199978 1041500 875536 713330 563916 432216 322024 235206 167456 115700 78414 51522 32730 19912 11630 6628 3812 1984 1010 544 250 98 34 14 4 6 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 1 9 18 72 203 647 1517 3403 6666 12616 22889 40844 69693 110319 167483 241324 326288 423030 523995 617243 695407 751267 775934 771884 737491 679228 603732 518871 431372 347808 271204 204421 151478 109606 76493 52653 35157 22774 14097 8316 4722 2820 1479 738 419 201 81 27 12 1 5 2
tree_stats_avgDegreeAtDepth=2 1 1 2 2 2 2 2 2 2 1.99609 1.98235 1.98204 1.96341 1.94647 1.90986 1.88386 1.85262 1.8307 1.80714 1.78325 1.75309 1.72028 1.69264 1.66316 1.63406 1.60983 1.58525 1.5611 1.5393 1.51878 1.49895 1.48141 1.4642 1.4486 1.43397 1.42032 1.40737 1.39527 1.38323 1.37253 1.3652 1.35598 1.34546 1.33887 1.32853 1.31763 1.30419 1.29203 1.28495 1.28757 1.26023 1.25454 1.26931 1.22978 1.196 1.17347 1.20588 1.14286 1.75 1.16667 1
tree_stats_height=62
tree_stats_numInternals=9837961
tree_stats_numLeaves=9837962
tree_stats_numNodes=19675923
tree_stats_numKeys=9837960
tree_stats_avgDegreeInternal=2
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=32.8229
tree_stats_bytesAtDepth=40 80 80 80 160 320 640 1280 2560 5120 10240 20400 40080 78720 151680 287120 522480 923600 1574960 2616640 4224000 6616880 9966240 14357040 19888560 26378480 33451040 40799040 47755680 53591760 57804080 59975600 59849840 57624960 53499200 47999120 41660000 35021440 28533200 22556640 17288640 12880960 9408240 6698240 4628000 3136560 2060880 1309200 796480 465200 265120 152480 79360 40400 21760 10000 3920 1360 560 160 240 80
tree_stats_sizeInBytes=787036920
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=2969
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:5387 2:48492 4:262109 8:261045 16:20819 32:90
[2^00, 2^01]: 5387
(2^01, 2^02]: 48492
(2^02, 2^03]: 262109
(2^03, 2^04]: 261045
(2^04, 2^05]: 20819
(2^05, 2^06]: 90
sum_limbo_reclamation_event_size_total=4660570
count_limbo_reclamation_event_size_by_thread=4666 4668 4672 4670 4674 4672 4672 4672 4670 4674 4672 4666 4676 4668 4668 4664 4658 4666 4674 4670 4672 4676 4676 4664 4664 4674 4678 4666 4676 4676 4676 4664 4670 4672 4670 4676 4670 4674 4670 4672 4670 4670 4666 4676 4666 4678 4666 4672 4670 4670 4676 4672 4674 4674 4672 4674 4670 4674 4678 4666 4680 4672 4670 4670 4670 4670 4674 4664 4674 4674 4672 4672 4674 4670 4664 4674 4670 4672 4670 4670 4672 4672 4668 4662 4676 4672 4676 4672 4680 4668 4672 4666 4670 4674 4674 4666 4668 4676 4672 4678 4668 4674 4676 4674 4672 4668 4664 4674 4676 4676 4668 4680 4672 4672 4672 4674 4672 4672 4672 4672 4672 4670 4666 4674 4676 4670 4678 4666
count_limbo_reclamation_event_size_total=597942
sum_limbo_reclamation_event_count_total=599552
first_thread_announced_epoch_by_thread=5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938 5938
sum_num_inserts_by_thread=14513 14865 14673 14766 14716 14777 14702 14636 14837 14595 14613 14482 14754 14777 14793 14533 14686 14504 14625 14914 14836 14551 14720 14706 14650 14754 14459 14744 14769 14625 14324 14884 14824 14761 14665 14671 14668 14656 14621 14665 14548 14407 14276 14673 14708 14932 14749 14547 14630 14469 14414 14356 14253 14682 14514 14611 14675 14832 14581 14557 14647 14687 14501 14483 14689 14535 14604 14308 14539 14532 14586 14755 14850 14524 14540 14590 14691 14719 14540 14598 14700 14506 14329 14349 14600 14543 14644 14573 14798 14488 14428 14540 14596 14552 14436 14398 14553 14410 14679 14803 14870 14652 14503 14911 14901 14543 14429 14630 14458 14590 14394 14661 14640 14526 14566 14629 14524 14568 14472 14647 14692 14563 14397 14319 14564 14812 14550 14372
sum_num_inserts_total=1869954
sum_num_deletes_by_thread=14782 14741 14593 14609 14787 14769 14440 14668 14655 14802 14635 14670 14699 14711 14577 14661 14448 14517 14594 14557 14685 14579 14681 14447 14602 14666 14780 14707 14600 14587 14457 14373 14661 14816 14742 14470 14903 14744 14672 14638 14594 14743 14586 14634 14856 14646 14624 14932 14463 14470 14777 14533 14488 14567 14914 14480 14714 14540 14461 14719 14700 14681 14454 14608 14808 14468 14678 14564 14646 14416 14605 14536 14703 14531 14737 14617 14649 14553 14534 14543 14614 14645 14429 14348 14628 14783 14582 14567 14795 14731 14399 14386 14462 14451 14359 14410 14608 14647 14881 14761 14684 14514 14689 14658 14656 14648 14709 14494 14493 14605 14604 14790 14578 14862 14479 14613 14575 14635 14440 14666 14651 14646 14504 14430 14584 14555 14574 14591
sum_num_deletes_total=1870910
sum_num_searches_by_thread=2923494 2919562 2907203 2895664 2919071 2917932 2899523 2897855 2906899 2905420 2893524 2893430 2900943 2912513 2901032 2903590 2907720 2904683 2896167 2892274 2894493 2893115 2881259 2880793 2886274 2888241 2874817 2889793 2902286 2896208 2889497 2889522 2916909 2911178 2895862 2892045 2901603 2898922 2884297 2887764 2895598 2915348 2908509 2904544 2915529 2911011 2903013 2903639 2888080 2882431 2872592 2873079 2878906 2878427 2868232 2867961 2896727 2891667 2886635 2886703 2893360 2890915 2881188 2872271 2891432 2884196 2874939 2878048 2886429 2881860 2894805 2894566 2901908 2904659 2892098 2891273 2901775 2889989 2877112 2875039 2879637 2874524 2864782 2862212 2896819 2893408 2883319 2886527 2890841 2892090 2879184 2871536 2879319 2873660 2866316 2863267 2893707 2886024 2899320 2899779 2909933 2907710 2892901 2896428 2904640 2895503 2882330 2879578 2889746 2887074 2876172 2874773 2893179 2889239 2878666 2880815 2891097 2888680 2878645 2879860 2876079 2870674 2864802 2869248 2879303 2880519 2871189 2890181
sum_num_searches_total=369955105
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=2952789 2949168 2936469 2925039 2948574 2947478 2928665 2927159 2936391 2934817 2922772 2922582 2930396 2942001 2930402 2932784 2936854 2933704 2925386 2921745 2924014 2922245 2910660 2909946 2915526 2917661 2904056 2919244 2931655 2925420 2918278 2918779 2946394 2940755 2925269 2921186 2931174 2928322 2913590 2917067 2924740 2944498 2937371 2933851 2945093 2940589 2932386 2933118 2917173 2911370 2901783 2901968 2907647 2907676 2897660 2897052 2926116 2921039 2915677 2915979 2922707 2920283 2910143 2901362 2920929 2913199 2904221 2906920 2915614 2910808 2923996 2923857 2931461 2933714 2921375 2920480 2931115 2919261 2906186 2904180 2908951 2903675 2893540 2890909 2926047 2922734 2912545 2915667 2920434 2921309 2908011 2900462 2908377 2902663 2895111 2892075 2922868 2915081 2928880 2929343 2939487 2936876 2922093 2925997 2934197 2924694 2911468 2908702 2918697 2916269 2905170 2904224 2922397 2918627 2907711 2910057 2920196 2917883 2907557 2909173 2905422 2899883 2893703 2897997 2908451 2909886 2900313 2919144
average_num_operations_total=2919499
stdev_num_operations_total=1209
sum_num_operations_total=373695969
min_num_operations_total=2890909
max_num_operations_total=2952789
first_time_thread_terminate_by_thread=10000101 10000100 10000100 10000100 10000099 10000099 10000101 10000099 10000100 10000100 10000098 10000100 10000099 10000097 10000097 10000099 10000099 10000098 10000098 10000099 10000102 10000102 10000102 10000102 10000100 10000100 10000101 10000101 10000099 10000101 10000099 10000099 10000101 10000101 10000101 10000101 10000101 10000101 10000101 10000101 10000100 10000100 10000100 10000100 10000102 10000102 10000102 10000102 10000100 10000100 10000100 10000100 10000102 10000102 10000102 10000102 10000101 10000101 10000101 10000101 10000099 10000099 10000100 10000099 10000101 10000100 10000100 10000101 10000099 10000099 10000099 10000099 10000098 10000098 10000098 10000100 10000099 10000099 10000097 10000099 10000099 10000098 10000098 10000098 10000102 10000102 10000102 10000102 10000100 10000100 10000100 10000100 10000099 10000101 10000101 10000099 10000101 10000101 10000103 10000101 10000101 10000102 10000101 10000101 10000100 10000100 10000100 10000100 10000102 10000102 10000102 10000102 10000100 10000100 10000100 10000100 10000102 10000102 10000102 10000102 10000101 10000103 10000101 10000101 10000099 10000099 10000100 10000099
min_time_thread_terminate_total=10000097
max_time_thread_terminate_total=10000103
first_time_thread_start_by_thread=3 3 3 3 4 4 4 4 5 5 5 5 4 4 4 4 7 7 7 7 6 6 6 6 7 7 7 7 7 7 7 7 6 6 6 6 5 5 5 5 5 5 5 5 6 6 6 6 5 6 6 6 7 7 7 7 8 8 8 8 4 4 4 4 3 3 3 3 4 4 4 4 5 5 5 5 4 4 4 4 7 7 7 7 6 6 6 6 7 7 7 7 7 7 7 7 6 6 6 6 5 5 5 5 5 5 5 5 6 6 6 6 5 6 6 6 7 7 7 7 8 8 8 8 4 4 4 4
min_time_thread_start_total=3
max_time_thread_start_total=8
sum_duration_all_ops_total=
threads_final_keysum=98366847620601
threads_final_size=9837960
final_keysum=98366847620601
final_size=9837960
validate_result=success
Validation OK.
Structural validation OK.
total_find=369955105
total_rq=0
total_inserts=1869954
total_deletes=1870910
total_updates=3740864
total_queries=369955105
total_ops=373695969
find_throughput=36995510
rq_throughput=0
update_throughput=374086
query_throughput=36995510
total_throughput=37369596
total find : 369955105
total rq : 0
total inserts : 1869954
total deletes : 1870910
total updates : 3740864
total queries : 369955105
total ops : 373695969
find throughput : 36995510
rq throughput : 0
update throughput : 374086
query throughput : 36995510
total throughput : 37369596
elapsed milliseconds : 10000
napping milliseconds overtime : 0
garbage=198637571435096
total_execution_walltime=13.447s
REALTIME_MAIN_END_PERF_FORMAT=207250.223614145
[time_cmd_output] time_elapsed_sec=13.61, faults_major=0, faults_minor=318549, mem_maxresident_kb=1271312, user_cputime=1676.66, sys_cputime=17.81, percent_cpu=12442%
timeout=false
algorithm=ellen_ext_bst_lf.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2