__step=000473
__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 2000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000473.txt
__path_data=data/data000473.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=212576.609534551
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=2000000
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.019s
prefilling_size=990794 prefilling_elapsed_millis=1s
finished prefilling to size 990789 for expected size 1000000 keysum=990482349527, performing 10791573 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=990789
pref_millis=1101
prefill_elapsed_ms=1115
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=212577.766284308
REALTIME_END_PERF_FORMAT=212587.766385533
###############################################################################
################################## TIME IS UP #################################
###############################################################################
joining threads...
###############################################################################
################################# END RUNNING #################################
###############################################################################
10s
PRODUCING OUTPUT
Open BwTree: createTreeStats iterating over all kv-pairs...
Open BwTree: createTreeStats finished iterating.
tree_stats_computeWalltime=0.022s
tree_stats_numInternalsAtDepth=0
tree_stats_numLeavesAtDepth=1
tree_stats_numNodesAtDepth=1
tree_stats_numKeysAtDepth=999948
tree_stats_avgDegreeAtDepth=999948
tree_stats_height=1
tree_stats_numInternals=0
tree_stats_numLeaves=1
tree_stats_numNodes=1
tree_stats_numKeys=999948
tree_stats_avgDegreeInternal=0
tree_stats_avgDegreeLeaves=999948
tree_stats_avgDegree=999949
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=333695 334018 333090 333724 334778 333423 332986 335360 333883 333533 334382 334234 334769 334945 334388 333361 328680 328543 328132 328338 328874 329271 327812 328099 328332 328320 327474 327606 328650 328534 327540 328264 351230 350828 350962 351712 351488 351748 350634 350175 351038 350473 349796 348588 349995 350594 348890 350460 334238 335214 334144 334436 334507 335097 335435 333250 334794 334656 334364 333132 334757 334646 333719 333427
sum_num_inserts_total=21555465
sum_num_deletes_by_thread=333926 333499 332703 332848 334244 334728 333212 334999 335106 333710 334143 333843 334021 334344 334054 334319 329305 328311 327714 328528 327985 329131 327844 327507 329131 326807 328511 327652 328540 329196 327961 328113 351300 351451 351112 350502 351997 350977 350600 350947 350349 350861 349185 350501 350702 350027 349518 349440 335527 334753 333263 334547 334687 334666 333863 335056 334863 333664 333346 335487 334331 334491 334625 334664
sum_num_deletes_total=21557237
sum_num_searches_by_thread=6019989 6013712 6001463 5985662 6020117 6013649 6014669 6012097 6025182 6021674 6012188 6017010 6020161 6016619 6005468 6010476 5915477 5913142 5900818 5909521 5920582 5914438 5907877 5914187 5911680 5909789 5899304 5904596 5915847 5909538 5899244 5906236 6329672 6322759 6313555 6317644 6329705 6328753 6317560 6303073 6304031 6303445 6291175 6297239 6308906 6301133 6296772 6297210 6025091 6020924 6010624 6015443 6027771 6021350 6013939 6020153 6023625 6017454 6006964 6011269 6028355 6023278 6015024 6018554
sum_num_searches_total=388024862
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=6687610 6681229 6667256 6652234 6689139 6681800 6680867 6682456 6694171 6688917 6680713 6685087 6688951 6685908 6673910 6678156 6573462 6569996 6556664 6566387 6577441 6572840 6563533 6569793 6569143 6564916 6555289 6559854 6573037 6567268 6554745 6562613 7032202 7025038 7015629 7019858 7033190 7031478 7018794 7004195 7005418 7004779 6990156 6996328 7009603 7001754 6995180 6997110 6694856 6690891 6678031 6684426 6696965 6691113 6683237 6688459 6693282 6685774 6674674 6679888 6697443 6692415 6683368 6686645
average_num_operations_total=6736524
stdev_num_operations_total=21095
sum_num_operations_total=431137564
min_num_operations_total=6554745
max_num_operations_total=7033190
first_time_thread_terminate_by_thread=10000100 10000100 10000100 10000100 10000101 10000099 10000099 10000099 10000101 10000101 10000101 10000101 10000102 10000102 10000102 10000102 10000101 10000101 10000101 10000101 10000101 10000101 10000101 10000101 10000101 10000101 10000101 10000100 10000101 10000100 10000100 10000099 10000100 10000100 10000100 10000100 10000101 10000101 10000101 10000101 10000100 10000100 10000100 10000100 10000099 10000099 10000099 10000099 10000102 10000102 10000102 10000102 10000102 10000103 10000102 10000102 10000100 10000100 10000100 10000100 10000100 10000100 10000100 10000100
min_time_thread_terminate_total=10000099
max_time_thread_terminate_total=10000103
first_time_thread_start_by_thread=3 3 3 3 3 3 3 3 3 3 3 3 4 4 4 4 5 5 5 5 7 7 7 7 8 8 8 8 4 4 4 4 3 4 4 3 9 9 9 9 4 5 5 5 6 6 6 6 7 7 7 7 7 7 7 7 3 3 3 3 6 6 6 6
min_time_thread_start_total=3
max_time_thread_start_total=9
sum_duration_all_ops_total=
threads_final_keysum=999939383221
threads_final_size=999948
final_keysum=999939383221
final_size=999948
validate_result=success
Validation OK.
Structural validation OK.
total_find=388024862
total_rq=0
total_inserts=21555465
total_deletes=21557237
total_updates=43112702
total_queries=388024862
total_ops=431137564
find_throughput=38802486
rq_throughput=0
update_throughput=4311270
query_throughput=38802486
total_throughput=43113756
total find : 388024862
total rq : 0
total inserts : 21555465
total deletes : 21557237
total updates : 43112702
total queries : 388024862
total ops : 431137564
find throughput : 38802486
rq throughput : 0
update throughput : 4311270
query throughput : 38802486
total throughput : 43113756
elapsed milliseconds : 10000
napping milliseconds overtime : 0
garbage=51292084768820
total_execution_walltime=11.196s
REALTIME_MAIN_END_PERF_FORMAT=212587.811225428
[time_cmd_output] time_elapsed_sec=11.31, faults_major=0, faults_minor=123590, mem_maxresident_kb=443204, user_cputime=714.53, sys_cputime=4.51, percent_cpu=6355%
timeout=false
algorithm=wang_openbwtree
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1