__step=000914
__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" ./brown_sigouin_abtree_kcas_validate.debra -nwork 64 -nprefill 64 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 50.0 50.0 -k 200000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000914.txt
__path_data=data/data000914.txt
__hostname=nasus
sizeof(kcasdesc_t)=1920
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x564793ee1440
addrof(kcasDescriptors[1])=0x564793ee1bc0
addrof(rdcssDescriptors[0])=0x564793fd1440
addrof(rdcssDescriptors[1])=0x564793fd1500
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=217859.39835788
binary=./brown_sigouin_abtree_kcas_validate.debra
parsed custom binding: 0-63,128-191,64-127,192-255
DS_TYPENAME=brown_sigouin_abtree_kcas_validate
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=200000
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
sizes: node=40
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.022s
prefilling_size=100027 prefilling_elapsed_millis=1s
finished prefilling to size 100053 for expected size 100000 keysum=10008461649, performing 84672754 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=100053
pref_millis=1101
prefill_elapsed_ms=1111
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=217860.193304754
REALTIME_END_PERF_FORMAT=217870.193375938
###############################################################################
################################## 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 (256 threads)...
partitioned into 3306 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.214s
tree_stats_numInternalsAtDepth=1 1 8 60 432 3306 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 19430
tree_stats_numNodesAtDepth=1 1 8 60 432 3306 19430
tree_stats_numKeysAtDepth=0 0 0 0 0 0 100476
tree_stats_avgDegreeAtDepth=1 8 7.5 7.2 7.65278 5.87719 5.17118
tree_stats_height=7
tree_stats_numInternals=3808
tree_stats_numLeaves=19430
tree_stats_numNodes=23238
tree_stats_numKeys=100476
tree_stats_avgDegreeInternal=6.10242
tree_stats_avgDegreeLeaves=5.17118
tree_stats_avgDegree=5.32378
tree_stats_avgKeyDepth=6
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:11017 2:78308 4:277263 8:245278 16:23324 32:10 64:74 128:48
[2^00, 2^01]: 11017
(2^01, 2^02]: 78308
(2^02, 2^03]: 277263
(2^03, 2^04]: 245278
(2^04, 2^05]: 23324
(2^05, 2^06]: 10
(2^06, 2^07]: 74
(2^07, 2^08]: 48
sum_limbo_reclamation_event_size_total=4665433
count_limbo_reclamation_event_size_by_thread=9948 9940 9944 9928 9924 9938 9918 9926 9942 9926 9914 9914 9916 9942 9928 9920 9936 9904 9928 9910 9932 9930 9920 9902 9904 9894 9914 9926 9934 9930 9938 9912 9948 9936 9922 9920 9942 9934 9928 9926 9918 9916 9936 9916 9942 9922 9934 9928 9922 9928 9934 9926 9938 9940 9936 9938 9924 9928 9942 9920 9930 9910 9932 9924
count_limbo_reclamation_event_size_total=635322
sum_limbo_reclamation_event_count_total=2930432
first_thread_announced_epoch_by_thread=50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236 50236
sum_commit_tx_reader_total=
sum_commit_tx_reader_by_thread=
sum_commit_tx_writer_total=
sum_commit_tx_writer_by_thread=
sum_abort_tx_total=
sum_abort_tx_by_thread=
max_ht_capacity_by_thread=
linear_histogram_of_none_tx_rdset_size_full_data=
linear_histogram_of_none_tx_wrset_size_full_data=
sum_fasthtm_commit_total=
sum_fasthtm_abort_total=
sum_htmpostfix_commit_total=
sum_htmpostfix_abort_total=
sum_htmprefix_commit_total=
sum_htmprefix_abort_total=
sum_htmprefix_abort_explicit_total=
sum_htmprefix_abort_conflict_total=
sum_htmprefix_abort_capacity_total=
sum_htmprefix_abort_nesting_total=
sum_htmprefix_abort_illegal_total=
sum_htmprefix_abort_zero_total=
sum_stmprefix_abort_total=
sum_stmprefix_commit_total=
sum_slow_commit_total=
sum_abtree_insert_repeat_total=373409
sum_abtree_erase_repeat_total=79260
sum_abtree_search_repeat_total=29713
sum_abtree_search_complete_total=883834924
sum_abtree_fix_weight_viol_attempt_total=822006
sum_abtree_fix_degree_viol_attempt_total=6364896
sum_abtree_rebalancing_kcas_attempt_total=7130199
sum_abtree_update_kcas_attempt_total=438468425
sum_abtree_internal_complex_search_while_iters_total=883883629
sum_abtree_internal_basic_search_while_iters_total=
sum_kcas_desc_new_total=
sum_num_inserts_by_thread=6904897 7018089 6870500 6985837 6991338 6799782 6907613 6735183 6858134 6727797 6837056 6692581 6804764 6808983 6903886 6775132 6914739 6766464 6903643 6769124 6858696 6683978 6774531 6647732 6740964 6465682 6740434 6780948 6859509 6763283 6902076 6839670 6960666 6900771 6886241 6756929 6823587 6746024 6831151 6732386 6808420 6920352 6947768 6874096 6978648 6884579 6966421 6877074 6749448 6921876 7001992 6886632 6817466 6722710 6821438 6920457 6984308 6756863 6923386 6796814 7011360 6862751 7036233 6894356
sum_num_inserts_total=438036248
sum_num_deletes_by_thread=6900537 7017016 6875554 6990571 6988918 6796394 6904665 6738681 6861710 6730414 6839968 6690671 6808361 6811674 6908028 6766458 6914974 6765940 6899378 6773466 6852038 6680915 6772221 6652495 6739578 6461295 6737272 6780932 6857604 6764150 6901638 6843723 6958482 6906159 6889509 6758442 6822752 6748401 6828388 6732609 6806099 6921375 6947157 6876892 6978035 6883782 6972864 6872474 6743578 6924617 7003533 6889135 6817897 6718469 6816690 6925616 6981925 6758884 6916510 6794849 7015760 6859208 7036593 6899663
sum_num_deletes_total=438033586
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=13805434 14035105 13746054 13976408 13980256 13596176 13812278 13473864 13719844 13458211 13677024 13383252 13613125 13620657 13811914 13541590 13829713 13532404 13803021 13542590 13710734 13364893 13546752 13300227 13480542 12926977 13477706 13561880 13717113 13527433 13803714 13683393 13919148 13806930 13775750 13515371 13646339 13494425 13659539 13464995 13614519 13841727 13894925 13750988 13956683 13768361 13939285 13749548 13493026 13846493 14005525 13775767 13635363 13441179 13638128 13846073 13966233 13515747 13839896 13591663 14027120 13721959 14072826 13794019
average_num_operations_total=13688591
stdev_num_operations_total=26274
sum_num_operations_total=876069834
min_num_operations_total=12926977
max_num_operations_total=14072826
first_time_thread_terminate_by_thread=10000073 10000073 10000073 10000073 10000074 10000074 10000074 10000074 10000072 10000072 10000072 10000072 10000072 10000072 10000072 10000072 10000073 10000073 10000073 10000073 10000074 10000074 10000074 10000074 10000070 10000071 10000073 10000071 10000071 10000071 10000072 10000072 10000071 10000071 10000071 10000071 10000073 10000073 10000073 10000073 10000072 10000072 10000070 10000072 10000071 10000071 10000071 10000071 10000074 10000074 10000074 10000074 10000073 10000073 10000073 10000073 10000072 10000072 10000072 10000072 10000072 10000072 10000072 10000072
min_time_thread_terminate_total=10000070
max_time_thread_terminate_total=10000074
first_time_thread_start_by_thread=7 7 7 7 5 5 5 5 7 7 7 7 6 6 6 6 7 7 7 7 9 9 9 9 5 5 5 5 6 6 6 6 6 6 6 7 6 6 6 6 8 8 8 8 7 7 7 7 8 8 8 8 8 8 8 8 9 9 9 9 8 8 8 8
min_time_thread_start_total=5
max_time_thread_start_total=9
sum_duration_all_ops_total=
threads_final_keysum=10053263124
threads_final_size=100476
final_keysum=10053263124
final_size=100476
validate_result=success
Validation OK.
Structural validation OK.
total_find=0
total_rq=0
total_inserts=438036248
total_deletes=438033586
total_updates=876069834
total_queries=0
total_ops=876069834
find_throughput=0
rq_throughput=0
update_throughput=87606983
query_throughput=0
total_throughput=87606983
total find : 0
total rq : 0
total inserts : 438036248
total deletes : 438033586
total updates : 876069834
total queries : 0
total ops : 876069834
find throughput : 0
rq throughput : 0
update throughput : 87606983
query throughput : 0
total throughput : 87606983
elapsed milliseconds : 10000
napping milliseconds overtime : 0
garbage=0
total_execution_walltime=11.462s
REALTIME_MAIN_END_PERF_FORMAT=217870.502755300
[time_cmd_output] time_elapsed_sec=11.56, faults_major=0, faults_minor=77695, mem_maxresident_kb=310372, user_cputime=762.61, sys_cputime=4.06, percent_cpu=6629%
timeout=false
algorithm=brown_sigouin_abtree_kcas_validate.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2