__step=000708
__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 50.0 50.0 -k 20000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000708.txt
__path_data=data/data000708.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=215355.460858386
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=50
DEL_FRAC=50
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=50.0 50.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,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.029s
prefilling_size=7703101 prefilling_elapsed_millis=1s
prefilling_size=7980131 prefilling_elapsed_millis=1.101s
prefilling_size=8227429 prefilling_elapsed_millis=1.201s
prefilling_size=8434710 prefilling_elapsed_millis=1.301s
prefilling_size=8620532 prefilling_elapsed_millis=1.401s
prefilling_size=8785123 prefilling_elapsed_millis=1.501s
prefilling_size=8927462 prefilling_elapsed_millis=1.601s
prefilling_size=9052436 prefilling_elapsed_millis=1.701s
prefilling_size=9165093 prefilling_elapsed_millis=1.801s
prefilling_size=9262080 prefilling_elapsed_millis=1.901s
prefilling_size=9349528 prefilling_elapsed_millis=2.002s
prefilling_size=9424199 prefilling_elapsed_millis=2.102s
prefilling_size=9492872 prefilling_elapsed_millis=2.202s
prefilling_size=9553385 prefilling_elapsed_millis=2.302s
prefilling_size=9604254 prefilling_elapsed_millis=2.402s
prefilling_size=9650176 prefilling_elapsed_millis=2.502s
prefilling_size=9689958 prefilling_elapsed_millis=2.602s
prefilling_size=9727704 prefilling_elapsed_millis=2.702s
prefilling_size=9758835 prefilling_elapsed_millis=2.803s
prefilling_size=9785953 prefilling_elapsed_millis=2.903s
prefilling_size=9812205 prefilling_elapsed_millis=3.003s
finished prefilling to size 9812249 for expected size 10000000 keysum=98104395158582, performing 79659806 updates; total_prefilling_elapsed_ms=3105 ms)
pref_size=9812249
pref_millis=3105
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=628

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=215358.631577023
REALTIME_END_PERF_FORMAT=215368.631631168

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

tree_stats_computeWalltime=0.188s

tree_stats_numInternalsAtDepth=1 1 1 2 4 8 16 32 64 128 256 505 991 1930 3708 6851 12357 21713 36657 59822 93841 140786 201761 277081 365177 461212 557943 648983 723893 777366 801552 793455 754082 689446 603678 508437 410947 319104 238349 171531 118188 78111 49642 30216 18065 10707 6070 3342 1713 856 429 218 105 39 5 0
tree_stats_numLeavesAtDepth=0 1 1 0 0 0 0 0 0 0 0 7 19 52 152 565 1345 3001 6769 13492 25803 46896 79811 126441 188985 269142 364481 466903 574073 670420 753180 809649 832828 818718 775214 698919 605927 502790 399859 305167 224874 158265 106580 69068 42367 25423 15344 8798 4971 2570 1283 640 331 171 73 10
tree_stats_numNodesAtDepth=1 2 2 2 4 8 16 32 64 128 256 512 1010 1982 3860 7416 13702 24714 43426 73314 119644 187682 281572 403522 554162 730354 922424 1115886 1297966 1447786 1554732 1603104 1586910 1508164 1378892 1207356 1016874 821894 638208 476698 343062 236376 156222 99284 60432 36130 21414 12140 6684 3426 1712 858 436 210 78 10
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 0 7 19 52 152 565 1345 3001 6769 13492 25803 46896 79811 126441 188985 269142 364481 466903 574073 670420 753180 809649 832828 818718 775214 698919 605927 502790 399859 305167 224874 158265 106580 69068 42367 25423 15344 8798 4971 2570 1283 640 331 171 73 10
tree_stats_avgDegreeAtDepth=2 1 1 2 2 2 2 2 2 2 2 1.98633 1.98119 1.97376 1.96062 1.92381 1.90184 1.87857 1.84413 1.81597 1.78434 1.75013 1.71655 1.68666 1.65897 1.63149 1.60487 1.58159 1.55771 1.53693 1.51556 1.49495 1.47519 1.45714 1.4378 1.42112 1.40413 1.38825 1.37347 1.35983 1.34451 1.33045 1.31777 1.30434 1.29893 1.29635 1.28346 1.27529 1.25628 1.24985 1.25058 1.25408 1.24083 1.18571 1.0641 1

tree_stats_height=56
tree_stats_numInternals=10001377
tree_stats_numLeaves=10001378
tree_stats_numNodes=20002755
tree_stats_numKeys=10001376

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

tree_stats_bytesAtDepth=40 80 80 80 160 320 640 1280 2560 5120 10240 20480 40400 79280 154400 296640 548080 988560 1737040 2932560 4785760 7507280 11262880 16140880 22166480 29214160 36896960 44635440 51918640 57911440 62189280 64124160 63476400 60326560 55155680 48294240 40674960 32875760 25528320 19067920 13722480 9455040 6248880 3971360 2417280 1445200 856560 485600 267360 137040 68480 34320 17440 8400 3120 400
tree_stats_sizeInBytes=800110200

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

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:21 2:7 4:3 8:6 16:6 32:27 64:59 128:415 256:156167 512:353583 1024:409 2048:237
    [2^00, 2^01]: 21
    (2^01, 2^02]: 7
    (2^02, 2^03]: 3
    (2^03, 2^04]: 6
    (2^04, 2^05]: 6
    (2^05, 2^06]: 27
    (2^06, 2^07]: 59
    (2^07, 2^08]: 415
    (2^08, 2^09]: 156167
    (2^09, 2^10]: 353583
    (2^10, 2^11]: 409
    (2^11, 2^12]: 237
sum_limbo_reclamation_event_size_total=311962029
count_limbo_reclamation_event_size_by_thread=3992 3992 3992 3992 3992 3992 3992 3992 3990 3992 3992 3992 3992 3992 3992 3992 3992 3992 3992 3992 3992 3988 3992 3992 3992 3992 3992 3990 3992 3992 3992 3992 3990 3990 3992 3992 3990 3992 3992 3990 3990 3992 3992 3992 3992 3992 3992 3992 3992 3992 3990 3992 3992 3992 3992 3992 3992 3992 3992 3990 3992 3992 3992 3990 3992 3992 3992 3992 3992 3992 3992 3992 3992 3992 3990 3992 3990 3992 3992 3992 3992 3992 3992 3992 3992 3992 3992 3992 3992 3992 3992 3990 3992 3992 3992 3992 3992 3992 3992 3992 3990 3992 3992 3992 3992 3992 3992 3992 3992 3992 3992 3992 3992 3992 3992 3990 3992 3992 3990 3992 3992 3992 3992 3992 3992 3992 3992 3992
count_limbo_reclamation_event_size_total=510940
sum_limbo_reclamation_event_count_total=511488
first_thread_announced_epoch_by_thread=5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252 5252
sum_num_inserts_by_thread=980280 976053 972886 970115 977097 977746 970898 973758 969021 974898 969826 977215 981199 979735 976605 977868 977722 977422 967861 972307 970623 973320 972230 963572 973714 974017 971415 974397 978710 969080 974175 975908 975548 972854 974796 976847 974329 974522 975249 978295 979714 980304 977297 980678 976882 981011 974098 973737 972421 970790 970105 965435 969532 974573 971193 970060 974185 978985 967076 973129 972771 966982 968459 969025 972091 972045 969798 972356 981002 981788 973978 977250 979699 974978 974405 971461 974702 974165 970963 968580 975384 974092 976202 979160 979965 981256 976838 978650 975844 976514 971180 969448 979753 978066 973513 974191 983803 987473 983755 982367 986594 986547 980480 986305 979167 987298 982696 981726 985868 984826 987566 984241 976283 982883 975759 979601 980375 979647 976991 981921 983262 984911 977790 974966 979423 981967 978403 980622
sum_num_inserts_total=124967388
sum_num_deletes_by_thread=979046 976296 972318 972055 973733 978273 971968 974609 968517 973659 968528 977453 981734 978610 977590 978904 980951 977184 968646 971631 969305 971809 974651 963747 970945 973717 972721 973796 978072 969805 974860 975487 977957 975606 974828 979029 975568 973926 974553 979196 978155 982516 976651 981530 977597 982571 974829 974590 974340 972552 970197 965982 970206 972178 970712 971827 972838 978513 967818 971381 973981 966940 968274 970176 973906 973914 970493 970106 979955 982189 974277 974553 980223 977956 975113 972815 975063 976294 971158 970524 976337 976162 978270 977207 978133 980864 975629 977128 977886 974507 972631 969879 978640 980452 974453 971380 984882 987199 981997 981765 987269 988675 980290 984866 980657 988578 983095 983365 987045 986500 986937 982436 976465 980098 973996 978181 981252 978266 976672 980987 983813 984190 979399 975770 978120 980505 978820 978781
sum_num_deletes_total=124986605
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=1959326 1952349 1945204 1942170 1950830 1956019 1942866 1948367 1937538 1948557 1938354 1954668 1962933 1958345 1954195 1956772 1958673 1954606 1936507 1943938 1939928 1945129 1946881 1927319 1944659 1947734 1944136 1948193 1956782 1938885 1949035 1951395 1953505 1948460 1949624 1955876 1949897 1948448 1949802 1957491 1957869 1962820 1953948 1962208 1954479 1963582 1948927 1948327 1946761 1943342 1940302 1931417 1939738 1946751 1941905 1941887 1947023 1957498 1934894 1944510 1946752 1933922 1936733 1939201 1945997 1945959 1940291 1942462 1960957 1963977 1948255 1951803 1959922 1952934 1949518 1944276 1949765 1950459 1942121 1939104 1951721 1950254 1954472 1956367 1958098 1962120 1952467 1955778 1953730 1951021 1943811 1939327 1958393 1958518 1947966 1945571 1968685 1974672 1965752 1964132 1973863 1975222 1960770 1971171 1959824 1975876 1965791 1965091 1972913 1971326 1974503 1966677 1952748 1962981 1949755 1957782 1961627 1957913 1953663 1962908 1967075 1969101 1957189 1950736 1957543 1962472 1957223 1959403
average_num_operations_total=1952765
stdev_num_operations_total=893
sum_num_operations_total=249953993
min_num_operations_total=1927319
max_num_operations_total=1975876
first_time_thread_terminate_by_thread=10000055 10000055 10000055 10000055 10000054 10000054 10000054 10000054 10000054 10000055 10000054 10000055 10000055 10000055 10000056 10000055 10000056 10000056 10000056 10000056 10000054 10000054 10000054 10000055 10000055 10000055 10000055 10000056 10000055 10000055 10000056 10000056 10000054 10000055 10000055 10000054 10000056 10000056 10000056 10000057 10000057 10000057 10000057 10000057 10000056 10000056 10000056 10000056 10000056 10000056 10000055 10000057 10000056 10000056 10000056 10000056 10000056 10000056 10000056 10000056 10000054 10000054 10000055 10000055 10000055 10000055 10000058 10000055 10000053 10000053 10000054 10000054 10000054 10000055 10000054 10000055 10000056 10000068 10000055 10000056 10000056 10000056 10000056 10000056 10000055 10000055 10000054 10000055 10000055 10000055 10000056 10000055 10000055 10000055 10000055 10000055 10000060 10000055 10000059 10000055 10000056 10000056 10000058 10000056 10000057 10000057 10000057 10000057 10000056 10000056 10000056 10000056 10000056 10000056 10000055 10000057 10000058 10000058 10000056 10000056 10000056 10000056 10000056 10000056 10000054 10000054 10000054 10000054
min_time_thread_terminate_total=10000053
max_time_thread_terminate_total=10000068
first_time_thread_start_by_thread=9 10 10 9 9 9 9 9 9 9 9 9 10 10 10 10 12 12 12 12 10 10 10 10 11 11 11 11 13 13 13 13 12 11 11 12 12 12 12 12 11 11 11 11 11 11 11 11 11 11 11 11 12 12 12 12 10 10 10 10 13 13 13 13 9 10 10 9 9 9 9 9 9 9 9 9 10 10 10 10 12 12 12 12 10 10 10 10 11 11 11 11 13 13 13 12 12 11 11 12 12 12 12 12 11 11 11 11 11 11 11 11 11 11 11 11 12 12 12 12 10 10 10 10 13 13 13 13
min_time_thread_start_total=9
max_time_thread_start_total=13
sum_duration_all_ops_total=

threads_final_keysum=100038746188529
threads_final_size=10001376
final_keysum=100038746188529
final_size=10001376
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=124967388
total_deletes=124986605
total_updates=249953993
total_queries=0
total_ops=249953993
find_throughput=0
rq_throughput=0
update_throughput=24995399
query_throughput=0
total_throughput=24995399


total find                    : 0
total rq                      : 0
total inserts                 : 124967388
total deletes                 : 124986605
total updates                 : 249953993
total queries                 : 0
total ops                     : 249953993
find throughput               : 0
rq throughput                 : 0
update throughput             : 24995399
query throughput              : 0
total throughput              : 24995399

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

garbage=0
total_execution_walltime=13.41s
REALTIME_MAIN_END_PERF_FORMAT=215368.871930017
[time_cmd_output] time_elapsed_sec=13.58, faults_major=0, faults_minor=327844, mem_maxresident_kb=1306684, user_cputime=1577.13, sys_cputime=64.52, percent_cpu=12087%
timeout=false
algorithm=ellen_ext_bst_lf.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2