__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 48 -nprefill 48 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 0.5 0.5 -k 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000257.txt
__path_data=data/data000257.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6981884.701353662
binary=./ellen_ext_bst_lf.debra
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
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=48
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=48
WORK_THREADS=48
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,96,97,98,99,100,101,102,103,104,105,106,107,108,109,110,111,112,113,114,115,116,117,118,119


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.005s
prefilling_size=100212 prefilling_elapsed_millis=1.001s
finished prefilling to size 100198 for expected size 100000 keysum=10048025470, performing 49577621 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=100198
pref_millis=1102
prefill_elapsed_ms=1129
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=2677

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=6981885.977987598
REALTIME_END_PERF_FORMAT=6981895.978145714

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

tree_stats_computeWalltime=0.036s

tree_stats_numInternalsAtDepth=1 1 1 2 4 8 16 32 61 118 224 405 686 1119 1707 2553 3627 4767 6132 7456 8397 8866 8789 8247 7395 6461 5525 4537 3618 2801 2147 1545 1063 691 417 240 118 55 36 13 5 0
tree_stats_numLeavesAtDepth=0 1 1 0 0 0 0 0 3 4 12 43 124 253 531 861 1479 2487 3402 4808 6515 7928 8943 9331 9099 8329 7397 6513 5456 4435 3455 2749 2027 1435 965 594 362 181 74 59 21 10
tree_stats_numNodesAtDepth=1 2 2 2 4 8 16 32 64 122 236 448 810 1372 2238 3414 5106 7254 9534 12264 14912 16794 17732 17578 16494 14790 12922 11050 9074 7236 5602 4294 3090 2126 1382 834 480 236 110 72 26 10
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 3 4 12 43 124 253 531 861 1479 2487 3402 4808 6515 7928 8943 9331 9099 8329 7397 6513 5456 4435 3455 2749 2027 1435 965 594 362 181 74 59 21 10
tree_stats_avgDegreeAtDepth=2 1 1 2 2 2 2 2 1.95312 1.96721 1.94915 1.90402 1.84691 1.8156 1.76273 1.7478 1.71034 1.65715 1.64317 1.60796 1.5631 1.52793 1.49566 1.46917 1.44834 1.43685 1.42757 1.41059 1.39872 1.38709 1.38326 1.3598 1.34401 1.32502 1.30174 1.28777 1.24583 1.23305 1.32727 1.18056 1.19231 1

tree_stats_height=42
tree_stats_numInternals=99886
tree_stats_numLeaves=99887
tree_stats_numNodes=199773
tree_stats_numKeys=99885

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

tree_stats_bytesAtDepth=40 80 80 80 160 320 640 1280 2560 4880 9440 17920 32400 54880 89520 136560 204240 290160 381360 490560 596480 671760 709280 703120 659760 591600 516880 442000 362960 289440 224080 171760 123600 85040 55280 33360 19200 9440 4400 2880 1040 400
tree_stats_sizeInBytes=7990920

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

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:82457 2:194666 4:140739 8:15349 16:31
    [2^00, 2^01]: 82457
    (2^01, 2^02]: 194666
    (2^02, 2^03]: 140739
    (2^03, 2^04]: 15349
    (2^04, 2^05]: 31
sum_limbo_reclamation_event_size_total=1386753
count_limbo_reclamation_event_size_by_thread=9008 9030 9074 9058 8990 9100 8944 8972 9076 9008 9012 8972 9066 9034 9042 9042 9034 9062 9046 8988 9026 8972 8994 9052 8988 9002 9126 9004 9010 9084 8956 9080 8994 9070 8958 9032 9066 9056 9058 9028 8996 9028 8998 9088 9020 9020 8978 9000
count_limbo_reclamation_event_size_total=433242
sum_limbo_reclamation_event_count_total=4103902
first_thread_announced_epoch_by_thread=90852 90852 90852 90852 90852 90852 90852 90852 90852 90852 90852 90852 90852 90852 90852 90852 90852 90852 90852 90852 90852 90852 90852 90852 90852 90852 90852 90852 90852 90852 90852 90852 90852 90852 90852 90852 90852 90852 90852 90852 90852 90852 90852 90852 90852 90852 90852 90852
sum_num_inserts_by_thread=97409 98216 99027 98559 98412 97606 98223 98747 99604 100130 98232 98406 98318 99185 100212 99622 100097 98797 97320 97920 99891 99009 98232 97761 96527 97898 99220 99109 99027 97582 97920 98431 99752 100207 98198 98672 98220 99207 100141 99252 98477 98508 97462 98700 99176 99939 98919 97207
sum_num_inserts_total=4736686
sum_num_deletes_by_thread=97362 97895 99058 98863 98875 97329 97601 99086 99603 100818 98831 98846 98975 99479 99236 99912 100080 98674 97753 97897 99042 99376 97852 98270 96452 98064 98948 99357 99099 97624 98427 99168 100274 100170 99289 98228 98022 99175 99793 99179 99011 98795 97304 97932 99919 99196 98170 96828
sum_num_deletes_total=4739137
sum_num_searches_by_thread=19303638 19456173 19625072 19617310 19513133 19301800 19420271 19578367 19765882 19918465 19507407 19472169 19496654 19593727 19749949 19739134 19742900 19559988 19296923 19448811 19695515 19687502 19366615 19315288 19116742 19407304 19601187 19697016 19651043 19349829 19446584 19594003 19793222 19897833 19595424 19527442 19520703 19620419 19792130 19688511 19516763 19488471 19329887 19485879 19764708 19749012 19517456 19248916
sum_num_searches_total=938573177
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=19498409 19652284 19823157 19814732 19710420 19496735 19616095 19776200 19965089 20119413 19704470 19669421 19693947 19792391 19949397 19938668 19943077 19757459 19491996 19644628 19894448 19885887 19562699 19511319 19309721 19603266 19799355 19895482 19849169 19545035 19642931 19791602 19993248 20098210 19792911 19724342 19716945 19818801 19992064 19886942 19714251 19685774 19524653 19682511 19963803 19948147 19714545 19442951
average_num_operations_total=19751020
stdev_num_operations_total=26023
sum_num_operations_total=948049000
min_num_operations_total=19309721
max_num_operations_total=20119413
first_time_thread_terminate_by_thread=10000156 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000156 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000156 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000156 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157
min_time_thread_terminate_total=10000156
max_time_thread_terminate_total=10000157
first_time_thread_start_by_thread=2 3 2 2 2 2 3 2 2 3 3 2 2 2 2 2 2 2 3 3 2 3 3 3 2 3 2 2 2 2 3 2 2 3 3 2 2 2 2 2 2 2 3 3 2 3 3 3
min_time_thread_start_total=2
max_time_thread_start_total=3
sum_duration_all_ops_total=

threads_final_keysum=10003419083
threads_final_size=99885
final_keysum=10003419083
final_size=99885
validate_result=success
Validation OK.
Structural validation OK.

total_find=938573177
total_rq=0
total_inserts=4736686
total_deletes=4739137
total_updates=9475823
total_queries=938573177
total_ops=948049000
find_throughput=93857317
rq_throughput=0
update_throughput=947582
query_throughput=93857317
total_throughput=94804900


total find                    : 938573177
total rq                      : 0
total inserts                 : 4736686
total deletes                 : 4739137
total updates                 : 9475823
total queries                 : 938573177
total ops                     : 948049000
find throughput               : 93857317
rq throughput                 : 0
update throughput             : 947582
query throughput              : 93857317
total throughput              : 94804900

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=9.57327
PAPI_L3_TCM=0.000321061
PAPI_TOT_CYC=1412
PAPI_TOT_INS=319.763
garbage=46951275148404
total_execution_walltime=11.41s
REALTIME_MAIN_END_PERF_FORMAT=6981896.112485206
[time_cmd_output] time_elapsed_sec=11.53, faults_major=0, faults_minor=78032, mem_maxresident_kb=313116, user_cputime=559.51, sys_cputime=2.45, percent_cpu=4871%
timeout=false
algorithm=ellen_ext_bst_lf.debra
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=1