__step=000585
__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 5.0 5.0 -k 200000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000585.txt
__path_data=data/data000585.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=213876.887985700
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=5
DEL_FRAC=5
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=5.0 5.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.027s
prefilling_size=100066 prefilling_elapsed_millis=1s
finished prefilling to size 100041 for expected size 100000 keysum=10005943257, performing 13411452 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=100041
pref_millis=1101
prefill_elapsed_ms=1113
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=213878.46290344
REALTIME_END_PERF_FORMAT=213888.46433080
###############################################################################
################################## 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.003s
tree_stats_numInternalsAtDepth=0
tree_stats_numLeavesAtDepth=1
tree_stats_numNodesAtDepth=1
tree_stats_numKeysAtDepth=99953
tree_stats_avgDegreeAtDepth=99953
tree_stats_height=1
tree_stats_numInternals=0
tree_stats_numLeaves=1
tree_stats_numNodes=1
tree_stats_numKeys=99953
tree_stats_avgDegreeInternal=0
tree_stats_avgDegreeLeaves=99953
tree_stats_avgDegree=99954
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=430755 431309 431522 430376 430826 429786 428852 429618 433579 431420 431064 432338 428946 428514 428154 429858 431191 431631 429008 429077 428090 427715 428026 427561 428990 428087 426918 427334 426608 427158 427680 425550 450357 451044 448578 449325 451929 450598 450156 449600 447365 448572 448007 447587 449431 450923 448173 449325 438123 437239 436932 436504 437026 437881 436510 434784 438838 437041 436566 437002 438893 438769 437206 438111
sum_num_inserts_total=27925936
sum_num_deletes_by_thread=432088 431334 431477 429244 429278 430152 430308 430315 432902 431433 432331 432814 430084 429591 428811 427982 430062 430845 430604 428487 428271 427581 427208 426807 427610 426943 425866 426648 426594 427146 427320 426130 449664 449589 449997 449756 451122 451285 450383 448816 447335 449728 447338 449480 448777 449608 448508 448672 437802 436635 436504 437407 437954 436653 437092 435782 438224 437285 436474 437045 439780 438866 436032 438156
sum_num_deletes_total=27922015
sum_num_searches_by_thread=7782231 7775448 7752423 7732842 7745736 7743811 7728120 7744774 7796465 7774734 7765854 7774716 7740236 7736778 7719578 7721249 7753579 7742600 7725417 7721650 7706486 7704177 7690351 7704016 7706655 7702109 7675882 7699242 7689138 7679039 7676789 7679397 8110046 8100003 8085366 8089456 8120242 8117409 8106326 8102002 8052268 8084714 8049493 8081519 8075727 8095042 8072859 8077642 7879816 7869586 7855170 7857558 7868957 7859520 7854675 7851945 7885806 7880160 7863761 7855021 7901542 7893430 7860043 7881892
sum_num_searches_total=502630518
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=8645074 8638091 8615422 8592462 8605840 8603749 8587280 8604707 8662946 8637587 8629249 8639868 8599266 8594883 8576543 8579089 8614832 8605076 8585029 8579214 8562847 8559473 8545585 8558384 8563255 8557139 8528666 8553224 8542340 8533343 8531789 8531077 9010067 9000636 8983941 8988537 9023293 9019292 9006865 9000418 8946968 8983014 8944838 8978586 8973935 8995573 8969540 8975639 8755741 8743460 8728606 8731469 8743937 8734054 8728277 8722511 8762868 8754486 8736801 8729068 8780215 8771065 8733281 8758159
average_num_operations_total=8726226
stdev_num_operations_total=21175
sum_num_operations_total=558478469
min_num_operations_total=8528666
max_num_operations_total=9023293
first_time_thread_terminate_by_thread=10000143 10000143 10000143 10000143 10000145 10000145 10000145 10000145 10000141 10000141 10000141 10000141 10000142 10000142 10000142 10000142 10000145 10000145 10000145 10000145 10000144 10000144 10000144 10000144 10000143 10000142 10000142 10000143 10000145 10000145 10000145 10000145 10000144 10000144 10000144 10000144 10000144 10000145 10000145 10000144 10000143 10000143 10000143 10000143 10000145 10000145 10000145 10000145 10000142 10000142 10000143 10000142 10000144 10000144 10000144 10000144 10000143 10000143 10000143 10000143 10000141 10000662 10000141 10000141
min_time_thread_terminate_total=10000141
max_time_thread_terminate_total=10000662
first_time_thread_start_by_thread=7 7 7 7 7 7 7 7 6 6 5 6 10 10 10 11 7 7 7 7 9 9 9 9 10 10 10 10 9 9 9 9 8 8 8 8 8 8 8 8 8 8 8 8 11 11 11 11 9 9 9 9 10 10 10 10 11 11 12 11 10 10 10 10
min_time_thread_start_total=5
max_time_thread_start_total=12
sum_duration_all_ops_total=
threads_final_keysum=10010968682
threads_final_size=99953
final_keysum=10010968682
final_size=99953
validate_result=success
Validation OK.
Structural validation OK.
total_find=502630518
total_rq=0
total_inserts=27925936
total_deletes=27922015
total_updates=55847951
total_queries=502630518
total_ops=558478469
find_throughput=50263051
rq_throughput=0
update_throughput=5584795
query_throughput=50263051
total_throughput=55847846
total find : 502630518
total rq : 0
total inserts : 27925936
total deletes : 27922015
total updates : 55847951
total queries : 502630518
total ops : 558478469
find throughput : 50263051
rq throughput : 0
update throughput : 5584795
query throughput : 50263051
total throughput : 55847846
elapsed milliseconds : 10000
napping milliseconds overtime : 100
garbage=3148527589697
total_execution_walltime=11.277s
REALTIME_MAIN_END_PERF_FORMAT=213888.165478291
[time_cmd_output] time_elapsed_sec=11.38, faults_major=0, faults_minor=119560, mem_maxresident_kb=442196, user_cputime=715.06, sys_cputime=4.48, percent_cpu=6319%
timeout=false
algorithm=wang_openbwtree
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1