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


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.023s
prefilling_size=100169 prefilling_elapsed_millis=1s
finished prefilling to size 100173 for expected size 100000 keysum=9996734398, performing 28830768 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=100173
pref_millis=1101
prefill_elapsed_ms=1113
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=902

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=218046.68775120
REALTIME_END_PERF_FORMAT=218056.68818882

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

tree_stats_computeWalltime=0.079s

tree_stats_numInternalsAtDepth=1 1 1 2 4 8 16 32 58 99 178 307 531 883 1427 2212 3342 4831 6515 8200 9564 10441 10644 9942 8555 6861 5168 3656 2473 1575 1009 627 373 188 93 41 18 3 0
tree_stats_numLeavesAtDepth=0 1 1 0 0 0 0 0 6 17 20 49 83 179 339 642 1082 1853 3147 4830 6836 8687 10238 11346 11329 10249 8554 6680 4839 3371 2141 1391 881 558 283 145 64 33 6
tree_stats_numNodesAtDepth=1 2 2 2 4 8 16 32 64 116 198 356 614 1062 1766 2854 4424 6684 9662 13030 16400 19128 20882 21288 19884 17110 13722 10336 7312 4946 3150 2018 1254 746 376 186 82 36 6
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 6 17 20 49 83 179 339 642 1082 1853 3147 4830 6836 8687 10238 11346 11329 10249 8554 6680 4839 3371 2141 1391 881 558 283 145 64 33 6
tree_stats_avgDegreeAtDepth=2 1 1 2 2 2 2 2 1.90625 1.85345 1.89899 1.86236 1.86482 1.83145 1.80804 1.77505 1.75542 1.72277 1.67429 1.62932 1.58317 1.54585 1.50972 1.46702 1.43025 1.40099 1.37662 1.35372 1.33821 1.31844 1.32032 1.3107 1.29745 1.25201 1.24734 1.22043 1.21951 1.08333 1

tree_stats_height=39
tree_stats_numInternals=99879
tree_stats_numLeaves=99880
tree_stats_numNodes=199759
tree_stats_numKeys=99878

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

tree_stats_bytesAtDepth=40 80 80 80 160 320 640 1280 2560 4640 7920 14240 24560 42480 70640 114160 176960 267360 386480 521200 656000 765120 835280 851520 795360 684400 548880 413440 292480 197840 126000 80720 50160 29840 15040 7440 3280 1440 240
tree_stats_sizeInBytes=7990360

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

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:267 2:84 4:7 8:18 16:27 32:60 64:940 128:199362 256:437771 512:474 1024:224 2048:126
    [2^00, 2^01]: 267
    (2^01, 2^02]: 84
    (2^02, 2^03]: 7
    (2^03, 2^04]: 18
    (2^04, 2^05]: 27
    (2^05, 2^06]: 60
    (2^06, 2^07]: 940
    (2^07, 2^08]: 199362
    (2^08, 2^09]: 437771
    (2^09, 2^10]: 474
    (2^10, 2^11]: 224
    (2^11, 2^12]: 126
sum_limbo_reclamation_event_size_total=196677368
count_limbo_reclamation_event_size_by_thread=9990 9992 9990 9990 9992 9986 9992 9990 9992 9988 9988 9994 9988 9990 9990 9990 9986 9990 9988 9992 9986 9988 9992 9992 9990 9986 9988 9992 9988 9992 9994 9988 9990 9990 9990 9988 9994 9990 9988 9990 9990 9984 9992 9992 9990 9992 9990 9984 9990 9992 9992 9988 9990 9992 9990 9994 9990 9990 9988 9988 9992 9986 9996 9994
count_limbo_reclamation_event_size_total=639360
sum_limbo_reclamation_event_count_total=1139856
first_thread_announced_epoch_by_thread=19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628 19628
sum_num_inserts_by_thread=2215912 2211596 2209937 2204878 2193786 2217312 2213365 2206705 2208674 2202460 2201811 2200792 2176558 2169943 2162659 2166321 2161102 2157099 2152848 2192055 2202297 2193020 2193947 2190743 2190953 2197528 2168945 2163724 2155172 2157609 2148014 2149777 2164698 2157973 2196985 2186671 2200805 2192299 2191471 2187315 2190093 2172269 2159802 2163121 2171408 2167193 2168276 2168572 2205289 2200335 2203481 2202356 2205047 2210618 2198289 2199197 2211034 2215452 2201945 2210491 2215918 2219377 2218484 2213337
sum_num_inserts_total=140107143
sum_num_deletes_by_thread=2215042 2212569 2208020 2203739 2190663 2218187 2211464 2206930 2207495 2206600 2200061 2200445 2176743 2169719 2161861 2165553 2161723 2158072 2153880 2193915 2197453 2196523 2196639 2189279 2193278 2195722 2171564 2163564 2156944 2158608 2147863 2151393 2163842 2158483 2197610 2186751 2197755 2192605 2190885 2185817 2190285 2172967 2159999 2162009 2168651 2164850 2168175 2168925 2204871 2203486 2204336 2202957 2201039 2211917 2199384 2202175 2211376 2211868 2205832 2210230 2218647 2220726 2219352 2214543
sum_num_deletes_total=140113859
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=4430954 4424165 4417957 4408617 4384449 4435499 4424829 4413635 4416169 4409060 4401872 4401237 4353301 4339662 4324520 4331874 4322825 4315171 4306728 4385970 4399750 4389543 4390586 4380022 4384231 4393250 4340509 4327288 4312116 4316217 4295877 4301170 4328540 4316456 4394595 4373422 4398560 4384904 4382356 4373132 4380378 4345236 4319801 4325130 4340059 4332043 4336451 4337497 4410160 4403821 4407817 4405313 4406086 4422535 4397673 4401372 4422410 4427320 4407777 4420721 4434565 4440103 4437836 4427880
average_num_operations_total=4378453
stdev_num_operations_total=5296
sum_num_operations_total=280221002
min_num_operations_total=4295877
max_num_operations_total=4440103
first_time_thread_terminate_by_thread=10000044 10000043 10000060 10000044 10000043 10000043 10000043 10000043 10000044 10000042 10000044 10000042 10000042 10000043 10000045 10000042 10000043 10000045 10000045 10000042 10000044 10000044 10000044 10000045 10000043 10000043 10000043 10000043 10000049 10000043 10000043 10000043 10000044 10000044 10000044 10000044 10000047 10000050 10000045 10000045 10000044 10000044 10000044 10000044 10000044 10000043 10000044 10000044 10000043 10000043 10000044 10000043 10000043 10000045 10000043 10000043 10000043 10000043 10000043 10000043 10000044 10000044 10000044 10000044
min_time_thread_terminate_total=10000042
max_time_thread_terminate_total=10000060
first_time_thread_start_by_thread=5 5 5 5 4 4 4 4 4 4 4 5 6 6 6 6 3 3 3 3 4 4 4 4 6 6 6 6 7 7 7 7 5 5 5 5 6 6 6 6 5 5 5 5 7 7 7 7 7 7 7 7 4 4 4 4 6 6 6 6 7 7 7 7
min_time_thread_start_total=3
max_time_thread_start_total=7
sum_duration_all_ops_total=

threads_final_keysum=9990276857
threads_final_size=99878
final_keysum=9990276857
final_size=99878
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=140107143
total_deletes=140113859
total_updates=280221002
total_queries=0
total_ops=280221002
find_throughput=0
rq_throughput=0
update_throughput=28022100
query_throughput=0
total_throughput=28022100


total find                    : 0
total rq                      : 0
total inserts                 : 140107143
total deletes                 : 140113859
total updates                 : 280221002
total queries                 : 0
total ops                     : 280221002
find throughput               : 0
rq throughput                 : 0
update throughput             : 28022100
query throughput              : 0
total throughput              : 28022100

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

garbage=0
total_execution_walltime=11.341s
REALTIME_MAIN_END_PERF_FORMAT=218056.247016207
[time_cmd_output] time_elapsed_sec=11.44, faults_major=0, faults_minor=83996, mem_maxresident_kb=334916, user_cputime=715.63, sys_cputime=10.46, percent_cpu=6342%
timeout=false
algorithm=ellen_ext_bst_lf.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2