__step=000609
__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" ./natarajan_ext_bst_lf.debra -nwork 48 -nprefill 48 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000609.txt
__path_data=data/data000609.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6986200.299673345
binary=./natarajan_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=natarajan_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=5
DEL_FRAC=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=5.0 5.0
PREFILL_TYPE=PREFILL_HYBRID
PREFILL_HYBRID_MIN_MS=1000
PREFILL_HYBRID_MAX_MS=5000
sizes: node=32
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=100069 prefilling_elapsed_millis=1.001s
finished prefilling to size 100183 for expected size 100000 keysum=10025605591, performing 66468102 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=100183
pref_millis=1102
prefill_elapsed_ms=1119
6node_tIxPvE_object_size=32
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=3328

main thread: starting timer...

###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################

REALTIME_START_PERF_FORMAT=6986201.606407267
REALTIME_END_PERF_FORMAT=6986211.606542234

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

tree_stats_computeWalltime=0.032s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 63 123 232 416 699 1131 1751 2519 3438 4508 5529 6639 7732 8348 8776 8639 8128 7337 6183 4968 3953 3072 2338 1525 920 535 271 132 74 45 29 11 5 1 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 1 3 14 48 133 267 511 983 1600 2368 3487 4419 5546 7116 7920 8913 9150 8919 8491 7398 5983 4834 3806 3151 2130 1305 799 410 190 103 61 47 17 9 1 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 126 246 464 832 1398 2262 3502 5038 6876 9016 11058 13278 15464 16696 17552 17278 16256 14674 12366 9936 7906 6144 4676 3050 1840 1070 542 264 148 90 58 22 10 2 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 1 3 14 48 133 267 511 983 1600 2368 3487 4419 5546 7116 7920 8913 9150 8919 8491 7398 5983 4834 3806 3151 2130 1305 799 410 190 103 61 47 17 9 1 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 1.98438 1.97619 1.94309 1.89655 1.84014 1.80901 1.77409 1.7193 1.68241 1.65561 1.61324 1.60038 1.58232 1.53983 1.52563 1.49219 1.47042 1.45134 1.42136 1.40175 1.39785 1.38857 1.38053 1.32613 1.30164 1.29076 1.25327 1.24354 1.2803 1.30405 1.32222 1.18966 1.22727 1.1 1.5 1

tree_stats_height=42
tree_stats_numInternals=100134
tree_stats_numLeaves=100135
tree_stats_numNodes=200269
tree_stats_numKeys=100135

tree_stats_avgDegreeInternal=2.00001
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=22.2795

tree_stats_bytesAtDepth=32 64 128 256 512 1024 2048 4032 7872 14848 26624 44736 72384 112064 161216 220032 288512 353856 424896 494848 534272 561664 552896 520192 469568 395712 317952 252992 196608 149632 97600 58880 34240 17344 8448 4736 2880 1856 704 320 64 64
tree_stats_sizeInBytes=6408608

6node_tIxPvE_object_size=32
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=46483


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:87 4:1495 8:50171 16:370898 32:57220 64:21
    (2^01, 2^02]: 87
    (2^02, 2^03]: 1495
    (2^03, 2^04]: 50171
    (2^04, 2^05]: 370898
    (2^05, 2^06]: 57220
    (2^06, 2^07]: 21
sum_limbo_reclamation_event_size_total=11069642
count_limbo_reclamation_event_size_by_thread=9997 9998 9998 9998 9998 9998 9996 9997 9998 9998 9998 9998 9997 9998 9998 9997 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9997 9998 9998 9998 9998 9997 9998 9997 9998 9997 9998
count_limbo_reclamation_event_size_total=479892
sum_limbo_reclamation_event_count_total=2071306
first_thread_announced_epoch_by_thread=92966 92966 92966 92966 92966 92966 92966 92966 92966 92966 92966 92966 92966 92966 92966 92966 92966 92966 92966 92966 92966 92966 92966 92966 92966 92966 92966 92966 92966 92966 92966 92966 92966 92966 92966 92966 92966 92966 92966 92966 92966 92966 92966 92966 92966 92966 92966 92966
sum_num_inserts_by_thread=987257 996316 1000948 1001599 992644 985697 986284 996945 1008657 1013603 989852 990867 984610 996124 1003756 1004126 1004457 991584 983691 997060 1010101 1012837 999300 992554 989494 993788 997008 1002678 996261 983151 989741 998267 1010612 1010379 993378 991259 992214 998531 1007314 1001517 1002695 993352 983294 995707 1006141 1013314 1002881 993960
sum_num_inserts_total=47877805
sum_num_deletes_by_thread=986440 994021 1000884 1001206 993293 986226 988804 997150 1008535 1011346 991897 988066 985003 996258 1004474 1004852 1004974 993237 984072 997320 1008875 1011488 999617 990865 990394 997119 997989 1001114 993857 984773 986861 999889 1010910 1011994 992012 992166 990682 1000085 1004443 1004980 1002639 992535 980056 994347 1006190 1013078 1003142 994623
sum_num_deletes_total=47874781
sum_num_searches_by_thread=17763477 17890103 18018189 18038294 17878305 17757216 17778047 17945674 18150575 18215445 17851391 17803833 17748977 17927765 18091995 18077244 18090777 17875034 17725737 17954119 18168493 18221660 17988024 17854583 17815532 17909532 17955286 18047634 17919121 17696820 17800839 17984328 18184017 18209992 17895921 17847257 17839473 17987016 18122723 18062284 18061090 17864967 17679972 17914543 18103665 18241033 18035046 17891418
sum_num_searches_total=861884466
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=19737174 19880440 20020021 20041099 19864242 19729139 19753135 19939769 20167767 20240394 19833140 19782766 19718590 19920147 20100225 20086222 20100208 19859855 19693500 19948499 20187469 20245985 19986941 19838002 19795420 19900439 19950283 20051426 19909239 19664744 19777441 19982484 20205539 20232365 19881311 19830682 19822369 19985632 20134480 20068781 20066424 19850854 19643322 19904597 20115996 20267425 20041069 19880001
average_num_operations_total=19950771
stdev_num_operations_total=24471
sum_num_operations_total=957637052
min_num_operations_total=19643322
max_num_operations_total=20267425
first_time_thread_terminate_by_thread=10000133 10000132 10000132 10000133 10000133 10000133 10000132 10000133 10000133 10000133 10000132 10000133 10000133 10000133 10000133 10000133 10000133 10000132 10000132 10000133 10000132 10000133 10000133 10000133 10000133 10000132 10000132 10000133 10000133 10000133 10000132 10000133 10000133 10000133 10000133 10000133 10000133 10000133 10000133 10000133 10000133 10000132 10000132 10000133 10000132 10000133 10000133 10000133
min_time_thread_terminate_total=10000132
max_time_thread_terminate_total=10000133
first_time_thread_start_by_thread=3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3
min_time_thread_start_total=3
max_time_thread_start_total=3
sum_duration_all_ops_total=

threads_final_keysum=10012867732
threads_final_size=100135
final_keysum=10012867732
final_size=100135
validate_result=success
Validation OK.
Structural validation OK.

total_find=861884466
total_rq=0
total_inserts=47877805
total_deletes=47874781
total_updates=95752586
total_queries=861884466
total_ops=957637052
find_throughput=86188446
rq_throughput=0
update_throughput=9575258
query_throughput=86188446
total_throughput=95763705


total find                    : 861884466
total rq                      : 0
total inserts                 : 47877805
total deletes                 : 47874781
total updates                 : 95752586
total queries                 : 861884466
total ops                     : 957637052
find throughput               : 86188446
rq throughput                 : 0
update throughput             : 9575258
query throughput              : 86188446
total throughput              : 95763705

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=5.15136
PAPI_L3_TCM=0.000120566
PAPI_TOT_CYC=1374.84
PAPI_TOT_INS=346.032
garbage=43111001600020
total_execution_walltime=11.445s
REALTIME_MAIN_END_PERF_FORMAT=6986211.746131551
[time_cmd_output] time_elapsed_sec=11.56, faults_major=0, faults_minor=76762, mem_maxresident_kb=309016, user_cputime=560.09, sys_cputime=2.40, percent_cpu=4863%
timeout=false
algorithm=natarajan_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