__step=000697
__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 64 -nprefill 64 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 50.0 50.0 -k 20000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000697.txt
__path_data=data/data000697.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=215186.252162834
binary=./wang_openbwtree
parsed custom binding: 0-63,128-191,64-127,192-255
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=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
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.016s
prefilling_size=4882505 prefilling_elapsed_millis=1s
prefilling_size=5209391 prefilling_elapsed_millis=1.101s
prefilling_size=5516649 prefilling_elapsed_millis=1.201s
prefilling_size=5806226 prefilling_elapsed_millis=1.301s
prefilling_size=6070527 prefilling_elapsed_millis=1.401s
prefilling_size=6321735 prefilling_elapsed_millis=1.501s
prefilling_size=6558224 prefilling_elapsed_millis=1.601s
prefilling_size=6771961 prefilling_elapsed_millis=1.701s
prefilling_size=6978643 prefilling_elapsed_millis=1.801s
prefilling_size=7170250 prefilling_elapsed_millis=1.902s
prefilling_size=7351872 prefilling_elapsed_millis=2.002s
prefilling_size=7516217 prefilling_elapsed_millis=2.102s
prefilling_size=7673315 prefilling_elapsed_millis=2.202s
prefilling_size=7822129 prefilling_elapsed_millis=2.302s
prefilling_size=7963596 prefilling_elapsed_millis=2.402s
prefilling_size=8091282 prefilling_elapsed_millis=2.502s
prefilling_size=8211642 prefilling_elapsed_millis=2.602s
prefilling_size=8326184 prefilling_elapsed_millis=2.703s
prefilling_size=8430807 prefilling_elapsed_millis=2.803s
prefilling_size=8529411 prefilling_elapsed_millis=2.903s
prefilling_size=8622541 prefilling_elapsed_millis=3.003s
prefilling_size=8711150 prefilling_elapsed_millis=3.104s
prefilling_size=8790496 prefilling_elapsed_millis=3.204s
prefilling_size=8868079 prefilling_elapsed_millis=3.304s
prefilling_size=8940733 prefilling_elapsed_millis=3.404s
prefilling_size=9006090 prefilling_elapsed_millis=3.504s
prefilling_size=9068070 prefilling_elapsed_millis=3.604s
prefilling_size=9126000 prefilling_elapsed_millis=3.704s
prefilling_size=9182508 prefilling_elapsed_millis=3.804s
prefilling_size=9234274 prefilling_elapsed_millis=3.905s
prefilling_size=9283073 prefilling_elapsed_millis=4.005s
prefilling_size=9328778 prefilling_elapsed_millis=4.105s
prefilling_size=9370123 prefilling_elapsed_millis=4.205s
prefilling_size=9409963 prefilling_elapsed_millis=4.305s
prefilling_size=9447516 prefilling_elapsed_millis=4.405s
prefilling_size=9483097 prefilling_elapsed_millis=4.505s
prefilling_size=9516190 prefilling_elapsed_millis=4.605s
prefilling_size=9547048 prefilling_elapsed_millis=4.706s
prefilling_size=9574513 prefilling_elapsed_millis=4.806s
prefilling_size=9600584 prefilling_elapsed_millis=4.906s
prefilling_size=9627499 prefilling_elapsed_millis=5.006s
Info: prefilling requires an additional insert phase to complete.
Info: prefilling using INSERTION ONLY.
timing_start inserting 372497 keys with 64 threads...
tid=0 thread_prefill_amount=153125 percent_done_estimate=2630.9 elapsed_s=5 est_remaining_s=-11 / -6
tid=0 thread_prefill_amount=156250 percent_done_estimate=2684.6 elapsed_s=5 est_remaining_s=-11 / -6
timing_elapsed 0.0372603s
prefilling_size=10000000 prefilling_elapsed_millis=0.039s
finished prefilling to size 10000000 for expected size 10000000 keysum=100020202777594, performing 66768076 updates; total_prefilling_elapsed_ms=39 ms)
pref_size=10000000
pref_millis=39
prefill_elapsed_ms=39
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=215191.446876161
REALTIME_END_PERF_FORMAT=215201.446948119

###############################################################################
################################## 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.273s

tree_stats_numInternalsAtDepth=0
tree_stats_numLeavesAtDepth=1
tree_stats_numNodesAtDepth=1
tree_stats_numKeysAtDepth=10002589
tree_stats_avgDegreeAtDepth=1.00026e+07

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

tree_stats_avgDegreeInternal=0
tree_stats_avgDegreeLeaves=1.00026e+07
tree_stats_avgDegree=1.00026e+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=1005664 1005529 1003628 996229 1004624 1004396 1003155 999373 1009321 1007088 1005470 1002383 1009135 1005660 1003934 1002740 996975 999909 995237 997953 996907 998751 995254 997792 1006157 1005693 1003559 998317 1006007 1005893 1003670 1002007 1025956 1026152 1025087 1022435 1025658 1025649 1025066 1020642 1024981 1023615 1023441 1021429 1024369 1023289 1022807 1021073 1018393 1017212 1017039 1013565 1019697 1017302 1014285 1014221 1018308 1018340 1014729 1013744 1019307 1017953 1018281 1013820
sum_num_inserts_total=64726255
sum_num_deletes_by_thread=1004201 1004614 1002572 996070 1005733 1003795 1003039 1000619 1008429 1006735 1004835 1002920 1007892 1008141 1004692 1001505 997758 996057 995322 994544 998300 997825 994620 997817 1003346 1006220 1001993 998430 1004439 1003088 1003230 998761 1026918 1025172 1023044 1022091 1027002 1026124 1024034 1023477 1024554 1024187 1023400 1020768 1024708 1024515 1023603 1021220 1019365 1018780 1016676 1014293 1019281 1016079 1014850 1014257 1020332 1017482 1016970 1013955 1018320 1018343 1016582 1013420
sum_num_deletes_total=64711344
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=2009865 2010143 2006200 1992299 2010357 2008191 2006194 1999992 2017750 2013823 2010305 2005303 2017027 2013801 2008626 2004245 1994733 1995966 1990559 1992497 1995207 1996576 1989874 1995609 2009503 2011913 2005552 1996747 2010446 2008981 2006900 2000768 2052874 2051324 2048131 2044526 2052660 2051773 2049100 2044119 2049535 2047802 2046841 2042197 2049077 2047804 2046410 2042293 2037758 2035992 2033715 2027858 2038978 2033381 2029135 2028478 2038640 2035822 2031699 2027699 2037627 2036296 2034863 2027240
average_num_operations_total=2022462
stdev_num_operations_total=2527
sum_num_operations_total=129437599
min_num_operations_total=1989874
max_num_operations_total=2052874
first_time_thread_terminate_by_thread=10000117 10000072 10000071 10000071 10000076 10000073 10000073 10000073 10000077 10000077 10000076 10000076 10000071 10000074 10000074 10000071 10000077 10000074 10000074 10000077 10000072 10000078 10000078 10000078 10000072 10000072 10000072 10000073 10000073 10000073 10000073 10000072 10000076 10000074 10000076 10000074 10000077 10000075 10000075 10000075 10000076 10000076 10000076 10000074 10000074 10000079 10000074 10000074 10000075 10000075 10000075 10000075 10000078 10000073 10000074 10000074 10000075 10000075 10000075 10000075 10000075 10000075 10000075 10000075
min_time_thread_terminate_total=10000071
max_time_thread_terminate_total=10000117
first_time_thread_start_by_thread=9 4 4 4 6 6 5 6 5 4 5 5 5 5 5 5 6 6 7 7 6 6 6 6 5 5 5 5 8 7 7 7 7 7 7 7 7 7 7 7 8 8 8 8 6 6 6 6 8 8 8 8 5 5 5 5 6 6 6 6 7 7 7 7
min_time_thread_start_total=4
max_time_thread_start_total=9
sum_duration_all_ops_total=

threads_final_keysum=100053576840329
threads_final_size=10002589
final_keysum=100053576840329
final_size=10002589
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=64726255
total_deletes=64711344
total_updates=129437599
total_queries=0
total_ops=129437599
find_throughput=0
rq_throughput=0
update_throughput=12943759
query_throughput=0
total_throughput=12943759


total find                    : 0
total rq                      : 0
total inserts                 : 64726255
total deletes                 : 64711344
total updates                 : 129437599
total queries                 : 0
total ops                     : 129437599
find throughput               : 0
rq throughput                 : 0
update throughput             : 12943759
query throughput              : 0
total throughput              : 12943759

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

garbage=0
total_execution_walltime=15.569s
REALTIME_MAIN_END_PERF_FORMAT=215201.821702630
[time_cmd_output] time_elapsed_sec=15.74, faults_major=0, faults_minor=309789, mem_maxresident_kb=1221856, user_cputime=968.09, sys_cputime=6.83, percent_cpu=6193%
timeout=false
algorithm=wang_openbwtree
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1