__step=000698
__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" ./wang_openbwtree -nwork 48 -nprefill 48 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 50.0 50.0 -k 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000698.txt
__path_data=data/data000698.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6987260.236800040
binary=./wang_openbwtree
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
DS_TYPENAME=wang_openbwtree
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=48
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=48
WORK_THREADS=48
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
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.007s
prefilling_size=5221597 prefilling_elapsed_millis=1.001s
prefilling_size=5555854 prefilling_elapsed_millis=1.101s
prefilling_size=5866776 prefilling_elapsed_millis=1.201s
prefilling_size=6154128 prefilling_elapsed_millis=1.301s
prefilling_size=6419903 prefilling_elapsed_millis=1.402s
prefilling_size=6669350 prefilling_elapsed_millis=1.502s
prefilling_size=6900066 prefilling_elapsed_millis=1.602s
prefilling_size=7115399 prefilling_elapsed_millis=1.702s
prefilling_size=7314801 prefilling_elapsed_millis=1.802s
prefilling_size=7499585 prefilling_elapsed_millis=1.903s
prefilling_size=7670127 prefilling_elapsed_millis=2.003s
prefilling_size=7830803 prefilling_elapsed_millis=2.103s
prefilling_size=7979719 prefilling_elapsed_millis=2.203s
prefilling_size=8118564 prefilling_elapsed_millis=2.303s
prefilling_size=8246936 prefilling_elapsed_millis=2.403s
prefilling_size=8367000 prefilling_elapsed_millis=2.504s
prefilling_size=8478745 prefilling_elapsed_millis=2.604s
prefilling_size=8581768 prefilling_elapsed_millis=2.704s
prefilling_size=8678133 prefilling_elapsed_millis=2.804s
prefilling_size=8767706 prefilling_elapsed_millis=2.904s
prefilling_size=8851734 prefilling_elapsed_millis=3.005s
prefilling_size=8928923 prefilling_elapsed_millis=3.105s
prefilling_size=9001455 prefilling_elapsed_millis=3.205s
prefilling_size=9070068 prefilling_elapsed_millis=3.305s
prefilling_size=9132524 prefilling_elapsed_millis=3.405s
prefilling_size=9192630 prefilling_elapsed_millis=3.506s
prefilling_size=9246844 prefilling_elapsed_millis=3.606s
prefilling_size=9297425 prefilling_elapsed_millis=3.706s
prefilling_size=9345699 prefilling_elapsed_millis=3.806s
prefilling_size=9390887 prefilling_elapsed_millis=3.906s
prefilling_size=9432530 prefilling_elapsed_millis=4.007s
prefilling_size=9471940 prefilling_elapsed_millis=4.107s
prefilling_size=9509384 prefilling_elapsed_millis=4.207s
prefilling_size=9543087 prefilling_elapsed_millis=4.307s
prefilling_size=9573205 prefilling_elapsed_millis=4.407s
prefilling_size=9603299 prefilling_elapsed_millis=4.508s
prefilling_size=9629856 prefilling_elapsed_millis=4.608s
prefilling_size=9654626 prefilling_elapsed_millis=4.708s
prefilling_size=9677481 prefilling_elapsed_millis=4.808s
prefilling_size=9698369 prefilling_elapsed_millis=4.908s
prefilling_size=9718660 prefilling_elapsed_millis=5.008s
Info: prefilling requires an additional insert phase to complete.
Info: prefilling using INSERTION ONLY.
timing_start inserting 281341 keys with 48 threads...
tid=0 thread_prefill_amount=191636 percent_done_estimate=3269.5 elapsed_s=5 est_remaining_s=-11 / -6
timing_elapsed 0.035782s
prefilling_size=10000000 prefilling_elapsed_millis=0.035s
finished prefilling to size 10000000 for expected size 10000000 keysum=99983121195635, performing 72730165 updates; total_prefilling_elapsed_ms=35 ms)
pref_size=10000000
pref_millis=35
prefill_elapsed_ms=36
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6987265.564155416
REALTIME_END_PERF_FORMAT=6987275.564232687

###############################################################################
################################## TIME IS UP #################################
###############################################################################

joining threads...
###############################################################################
################################# END RUNNING #################################
###############################################################################

10.1s
PRODUCING OUTPUT
Open BwTree: createTreeStats iterating over all kv-pairs...
Open BwTree: createTreeStats finished iterating.

tree_stats_computeWalltime=0.219s

tree_stats_numInternalsAtDepth=0
tree_stats_numLeavesAtDepth=1
tree_stats_numNodesAtDepth=1
tree_stats_numKeysAtDepth=10000164
tree_stats_avgDegreeAtDepth=1.00002e+07

tree_stats_height=1
tree_stats_numInternals=0
tree_stats_numLeaves=1
tree_stats_numNodes=1
tree_stats_numKeys=10000164

tree_stats_avgDegreeInternal=0
tree_stats_avgDegreeLeaves=1.00002e+07
tree_stats_avgDegree=1.00002e+07
tree_stats_avgKeyDepth=0


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0
    [2^00, 2^01]: 0
sum_limbo_reclamation_event_size_total=
count_limbo_reclamation_event_size_by_thread=
count_limbo_reclamation_event_size_total=
sum_limbo_reclamation_event_count_total=
first_thread_announced_epoch_by_thread=
sum_num_inserts_by_thread=1481841 1484177 1497918 1479859 1489578 1477307 1483410 1485210 1506665 1492863 1485013 1484634 1483629 1487081 1506741 1484759 1488726 1479504 1478314 1479588 1503616 1488784 1482797 1470049 1482828 1486613 1497673 1480203 1491023 1476610 1482990 1485382 1507999 1486851 1481837 1481216 1486102 1485082 1509334 1485939 1486731 1479207 1480888 1481512 1502692 1488892 1484992 1472796
sum_num_inserts_total=71367455
sum_num_deletes_by_thread=1481086 1483888 1498578 1481326 1488645 1477178 1484422 1484915 1507822 1490222 1483174 1486256 1486160 1487137 1507780 1484812 1486992 1480534 1478935 1474836 1504547 1489874 1484360 1469380 1482214 1487956 1498264 1478757 1488355 1478556 1481374 1485671 1506355 1485682 1483108 1480619 1486203 1485929 1509685 1485593 1487013 1479388 1478850 1481631 1503490 1486204 1483290 1473114
sum_num_deletes_total=71360160
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=2962927 2968065 2996496 2961185 2978223 2954485 2967832 2970125 3014487 2983085 2968187 2970890 2969789 2974218 3014521 2969571 2975718 2960038 2957249 2954424 3008163 2978658 2967157 2939429 2965042 2974569 2995937 2958960 2979378 2955166 2964364 2971053 3014354 2972533 2964945 2961835 2972305 2971011 3019019 2971532 2973744 2958595 2959738 2963143 3006182 2975096 2968282 2945910
average_num_operations_total=2973491
stdev_num_operations_total=2657
sum_num_operations_total=142727615
min_num_operations_total=2939429
max_num_operations_total=3019019
first_time_thread_terminate_by_thread=10000130 10000080 10000077 10000077 10000078 10000077 10000079 10000077 10000077 10000079 10000077 10000078 10000078 10000078 10000078 10000078 10000078 10000080 10000077 10000077 10000077 10000077 10000078 10000078 10001552 10000079 10000077 10000078 10000077 10000079 10000081 10000078 10000077 10001732 10000077 10000078 10000078 10000077 10000078 10000078 10000077 10000078 10000078 10000077 10000077 10000078 10000077 10000078
min_time_thread_terminate_total=10000077
max_time_thread_terminate_total=10001732
first_time_thread_start_by_thread=9 5 5 5 5 5 5 5 5 5 5 5 4 5 5 5 4 5 5 5 5 5 5 5 4 5 5 5 5 5 5 5 5 5 5 5 4 5 5 5 4 5 5 5 5 5 5 5
min_time_thread_start_total=4
max_time_thread_start_total=9
sum_duration_all_ops_total=

threads_final_keysum=99988675994289
threads_final_size=10000164
final_keysum=99988675994289
final_size=10000164
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=71367455
total_deletes=71360160
total_updates=142727615
total_queries=0
total_ops=142727615
find_throughput=0
rq_throughput=0
update_throughput=14272761
query_throughput=0
total_throughput=14272761


total find                    : 0
total rq                      : 0
total inserts                 : 71367455
total deletes                 : 71360160
total updates                 : 142727615
total queries                 : 0
total ops                     : 142727615
find throughput               : 0
rq throughput                 : 0
update throughput             : 14272761
query throughput              : 0
total throughput              : 14272761

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

PAPI_L2_TCM=55.2609
PAPI_L3_TCM=25.5327
PAPI_TOT_CYC=9364.27
PAPI_TOT_INS=1289.04
garbage=0
total_execution_walltime=15.648s
REALTIME_MAIN_END_PERF_FORMAT=6987275.885843791
[time_cmd_output] time_elapsed_sec=15.84, faults_major=0, faults_minor=290045, mem_maxresident_kb=1147020, user_cputime=734.61, sys_cputime=3.34, percent_cpu=4658%
timeout=false
algorithm=wang_openbwtree
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=2