__step=000257
__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 0.5 0.5 -k 200000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000257.txt
__path_data=data/data000257.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=209907.713882722
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=200000
PREFILL_THREADS=64
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=64
WORK_THREADS=64
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


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.014s
prefilling_size=99647 prefilling_elapsed_millis=1s
finished prefilling to size 99647 for expected size 100000 keysum=9960216906, performing 34719525 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=99647
pref_millis=1101
prefill_elapsed_ms=1112
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=1189

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=209908.868538256
REALTIME_END_PERF_FORMAT=209918.868611757

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

tree_stats_computeWalltime=0.105s

tree_stats_numInternalsAtDepth=1 1 1 2 4 8 16 31 59 113 221 419 751 1263 1965 2838 3877 5043 6232 7162 7849 8357 8741 8534 8039 7177 6006 4680 3591 2588 1796 1144 710 397 196 87 43 16 10 8 2 1 0
tree_stats_numLeavesAtDepth=0 1 1 0 0 0 0 1 3 5 5 23 87 239 561 1092 1799 2711 3854 5302 6475 7341 7973 8948 9029 8901 8348 7332 5769 4594 3380 2448 1578 1023 598 305 131 70 22 12 14 3 2
tree_stats_numNodesAtDepth=1 2 2 2 4 8 16 32 62 118 226 442 838 1502 2526 3930 5676 7754 10086 12464 14324 15698 16714 17482 17068 16078 14354 12012 9360 7182 5176 3592 2288 1420 794 392 174 86 32 20 16 4 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 1 3 5 5 23 87 239 561 1092 1799 2711 3854 5302 6475 7341 7973 8948 9029 8901 8348 7332 5769 4594 3380 2448 1578 1023 598 305 131 70 22 12 14 3 2
tree_stats_avgDegreeAtDepth=2 1 1 2 2 2 2 1.96875 1.95161 1.95763 1.97788 1.94796 1.89618 1.84088 1.77791 1.72214 1.68305 1.65037 1.61789 1.57461 1.54796 1.53236 1.52297 1.48816 1.471 1.44639 1.41842 1.38961 1.38365 1.36035 1.34699 1.31849 1.31031 1.27958 1.24685 1.22194 1.24713 1.18605 1.3125 1.4 1.125 1.25 1

tree_stats_height=43
tree_stats_numInternals=99979
tree_stats_numLeaves=99980
tree_stats_numNodes=199959
tree_stats_numKeys=99978

tree_stats_avgDegreeInternal=2.00001
tree_stats_avgDegreeLeaves=0.99998
tree_stats_avgDegree=1.49999
tree_stats_avgKeyDepth=23.9006

tree_stats_bytesAtDepth=40 80 80 80 160 320 640 1280 2480 4720 9040 17680 33520 60080 101040 157200 227040 310160 403440 498560 572960 627920 668560 699280 682720 643120 574160 480480 374400 287280 207040 143680 91520 56800 31760 15680 6960 3440 1280 800 640 160 80
tree_stats_sizeInBytes=7998360

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

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:79150 2:237922 4:245075 8:40914 16:185 32:79 64:47
    [2^00, 2^01]: 79150
    (2^01, 2^02]: 237922
    (2^02, 2^03]: 245075
    (2^03, 2^04]: 40914
    (2^04, 2^05]: 185
    (2^05, 2^06]: 79
    (2^06, 2^07]: 47
sum_limbo_reclamation_event_size_total=2288441
count_limbo_reclamation_event_size_by_thread=9448 9540 9522 9528 9552 9532 9506 9524 9516 9432 9438 9396 9412 9414 9416 9416 9596 9564 9418 9494 9468 9384 9444 9340 9426 9354 9354 9358 9314 9308 9450 9416 9496 9448 9468 9498 9446 9386 9340 9314 9330 9312 9346 9250 9356 9382 9450 9448 9454 9404 9364 9346 9404 9340 9310 9366 9346 9376 9446 9578 9482 9524 9542 9540
count_limbo_reclamation_event_size_total=603372
sum_limbo_reclamation_event_count_total=4734686
first_thread_announced_epoch_by_thread=76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358 76358
sum_num_inserts_by_thread=106907 114604 114054 113710 112943 112395 112404 112023 111416 109186 107565 105921 106285 106451 105603 105212 114908 114046 104499 112761 108060 107502 107907 105494 103985 103157 102885 102380 101810 101584 107823 106920 106846 107075 106832 106491 105831 104336 102696 100659 101115 99989 100329 99504 108393 106316 106218 106157 105963 105719 105300 102879 101053 100937 101705 100976 101675 102592 109498 117007 110235 111188 110974 111420
sum_num_inserts_total=6830308
sum_num_deletes_by_thread=106894 114168 114001 112915 113708 112826 112084 112602 111025 109774 108466 105974 106211 106069 105907 105383 114387 113495 104585 112769 107924 107674 107355 105368 104107 103144 103663 102221 101639 102351 108747 107429 107067 106757 106720 106652 105776 104212 102480 100221 100333 100054 100127 99787 108021 106623 105860 106147 105884 105551 105424 103729 100996 101177 101788 101422 101649 102193 110417 116772 110345 110841 110879 111630
sum_num_deletes_total=6832399
sum_num_searches_by_thread=21084655 22655486 22632258 22373676 22416863 22367513 22285288 22274297 22022022 21701902 21388533 21072544 21074490 20991933 20965448 20856320 22703327 22536365 20697915 22283142 21348216 21310419 21269922 20895961 20645227 20452727 20466180 20324068 20208816 20172733 21428407 21175160 21056345 21161953 21127672 21107807 20954205 20566004 20229820 19855136 20022825 19847165 19894432 19786827 21352009 21118890 21082326 21019715 20930383 20920775 20879320 20458954 20059785 20020320 20122676 20040606 20205852 20243142 21745356 23187953 21892530 22000840 22062224 22156597
sum_num_searches_total=1353192257
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=21298456 22884258 22860313 22600301 22643514 22592734 22509776 22498922 22244463 21920862 21604564 21284439 21286986 21204453 21176958 21066915 22932622 22763906 20906999 22508672 21564200 21525595 21485184 21106823 20853319 20659028 20672728 20528669 20412265 20376668 21644977 21389509 21270258 21375785 21341224 21320950 21165812 20774552 20434996 20056016 20224273 20047208 20094888 19986118 21568423 21331829 21294404 21232019 21142230 21132045 21090044 20665562 20261834 20222434 20326169 20243004 20409176 20447927 21965271 23421732 22113110 22222869 22284077 22379647
average_num_operations_total=21357108
stdev_num_operations_total=109664
sum_num_operations_total=1366854964
min_num_operations_total=19986118
max_num_operations_total=23421732
first_time_thread_terminate_by_thread=10000075 10000075 10000075 10000075 10000073 10000073 10000073 10000073 10000076 10000076 10000076 10000076 10000076 10000076 10000076 10000076 10000077 10000077 10000077 10000077 10000074 10000074 10000074 10000074 10000075 10000076 10000075 10000076 10000077 10000077 10000077 10000077 10000073 10000073 10000073 10000076 10000075 10000075 10000075 10000075 10000074 10000074 10000074 10000074 10000077 10000077 10000077 10000077 10000075 10000075 10000075 10000075 10000076 10000076 10000076 10000076 10000077 10000077 10000077 10000077 10000074 10000074 10000074 10000074
min_time_thread_terminate_total=10000073
max_time_thread_terminate_total=10000077
first_time_thread_start_by_thread=10 10 10 10 14 14 14 14 11 11 11 11 11 11 11 11 11 11 11 11 12 12 12 12 11 11 11 11 13 13 13 13 10 9 10 10 14 14 14 14 13 13 13 13 13 13 13 13 14 14 14 14 14 14 14 14 12 12 12 12 12 12 12 12
min_time_thread_start_total=9
max_time_thread_start_total=14
sum_duration_all_ops_total=

threads_final_keysum=9988027710
threads_final_size=99978
final_keysum=9988027710
final_size=99978
validate_result=success
Validation OK.
Structural validation OK.

total_find=1353192257
total_rq=0
total_inserts=6830308
total_deletes=6832399
total_updates=13662707
total_queries=1353192257
total_ops=1366854964
find_throughput=135319225
rq_throughput=0
update_throughput=1366270
query_throughput=135319225
total_throughput=136685496


total find                    : 1353192257
total rq                      : 0
total inserts                 : 6830308
total deletes                 : 6832399
total updates                 : 13662707
total queries                 : 1353192257
total ops                     : 1366854964
find throughput               : 135319225
rq throughput                 : 0
update throughput             : 1366270
query throughput              : 135319225
total throughput              : 136685496

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

garbage=9636181243227
total_execution_walltime=11.355s
REALTIME_MAIN_END_PERF_FORMAT=209919.69337927
[time_cmd_output] time_elapsed_sec=11.45, faults_major=0, faults_minor=79549, mem_maxresident_kb=317504, user_cputime=733.78, sys_cputime=6.16, percent_cpu=6457%
timeout=false
algorithm=ellen_ext_bst_lf.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1