__step=000355
__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 96 -nprefill 96 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000355.txt
__path_data=data/data000355.txt
__hostname=jax
sizeof(kcasdesc_t)=1920
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x55b7f4430480
addrof(kcasDescriptors[1])=0x55b7f4430c00
addrof(rdcssDescriptors[0])=0x55b7f4520480
addrof(rdcssDescriptors[1])=0x55b7f4520540
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=6983046.699889856
binary=./brown_sigouin_abtree_kcas_validate.debra
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
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=5
DEL_FRAC=5
RQ=0
RQSIZE=0
MAXKEY=20000000
PREFILL_THREADS=96
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=96
WORK_THREADS=96
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
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,96,97,98,99,100,101,102,103,104,105,106,107,108,109,110,111,112,113,114,115,116,117,118,119,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,120,121,122,123,124,125,126,127,128,129,130,131,132,133,134,135,136,137,138,139,140,141,142,143


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.008s
prefilling_size=9720284 prefilling_elapsed_millis=1.001s
prefilling_size=9803532 prefilling_elapsed_millis=1.101s
finished prefilling to size 9803581 for expected size 10000000 keysum=98038198861121, performing 87868203 updates; total_prefilling_elapsed_ms=1203 ms)
pref_size=9803581
pref_millis=1203
prefill_elapsed_ms=1223
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6983048.96852685
REALTIME_END_PERF_FORMAT=6983058.97006634

###############################################################################
################################## 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 (192 threads)...
partitioned into 3977 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...

tree_stats_computeWalltime=0.055s

tree_stats_numInternalsAtDepth=1 1 9 71 542 3977 29815 234116 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 1833533
tree_stats_numNodesAtDepth=1 1 9 71 542 3977 29815 234116 1833533
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 9999624
tree_stats_avgDegreeAtDepth=1 9 7.88889 7.6338 7.33764 7.49686 7.85229 7.83173 5.45375

tree_stats_height=9
tree_stats_numInternals=268532
tree_stats_numLeaves=1833533
tree_stats_numNodes=2102065
tree_stats_numKeys=9999624

tree_stats_avgDegreeInternal=7.82799
tree_stats_avgDegreeLeaves=5.45375
tree_stats_avgDegree=5.75705
tree_stats_avgKeyDepth=8


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:151737 2:200746 4:47630 8:1910 16:1
    [2^00, 2^01]: 151737
    (2^01, 2^02]: 200746
    (2^02, 2^03]: 47630
    (2^03, 2^04]: 1910
    (2^04, 2^05]: 1
sum_limbo_reclamation_event_size_total=822383
count_limbo_reclamation_event_size_by_thread=4354 4364 3982 4250 4096 4278 3960 4128 3972 4078 4440 4444 3986 4022 4480 4072 4122 3930 4116 4006 4068 4184 4472 4280 4060 4388 4378 4048 4018 3958 4362 4006 4368 4388 4100 3896 4388 4140 4062 4448 4058 4466 4312 3956 4422 4056 4352 4110 4018 4364 4212 4054 4434 4374 4524 4136 4112 4028 3932 4024 4212 4480 4038 4112 4486 3982 3968 4022 4052 4138 4364 4260 3978 4088 4308 4366 3920 3982 4210 4136 4098 4494 4140 4456 4000 4508 4448 4022 4128 4024 4370 3986 4466 4506 4060 4180
count_limbo_reclamation_event_size_total=402024
sum_limbo_reclamation_event_count_total=2080320
first_thread_announced_epoch_by_thread=23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698 23698
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=233
sum_abtree_erase_repeat_total=18
sum_abtree_search_repeat_total=5
sum_abtree_search_complete_total=97082969
sum_abtree_fix_weight_viol_attempt_total=291759
sum_abtree_fix_degree_viol_attempt_total=315024
sum_abtree_rebalancing_kcas_attempt_total=606769
sum_abtree_update_kcas_attempt_total=48247362
sum_abtree_internal_complex_search_while_iters_total=97082983
sum_abtree_internal_basic_search_while_iters_total=868313371
sum_kcas_desc_new_total=
sum_num_inserts_by_thread=498303 498083 500476 505735 504202 487637 498648 502630 507749 502405 499155 497255 500833 502012 500973 504022 505164 497971 494800 500149 504218 503475 498298 494581 498348 496772 501798 503513 504865 494464 493966 501880 507161 504390 498122 497441 499091 498303 506933 505471 502814 495390 493868 496380 503180 498386 492309 495310 500266 503575 506931 508711 503244 497584 498640 509466 509322 508395 503253 506171 503798 505343 511989 513774 507215 498033 500699 504738 504564 506327 503947 502493 502193 503725 504143 507930 503316 500475 496996 506110 510544 509008 503309 504972 504146 504500 508578 510279 505619 498605 497908 505086 510882 510170 506338 507133
sum_num_inserts_total=48239372
sum_num_deletes_by_thread=499624 498460 500403 506072 501813 488182 496868 503826 507849 502486 497730 496962 501203 501059 500971 504339 504645 499454 496602 501285 504816 503692 499532 496153 498075 496885 501426 503283 505506 494538 493558 501065 506828 502141 497888 496828 497883 497973 505055 505940 502039 497252 493587 498810 501456 499815 494366 496630 500974 503503 507006 509420 502598 497800 497008 508515 511120 507361 501775 504922 504537 505139 510881 513702 506965 495897 502896 504897 506587 506552 504616 502036 499597 505136 505274 506263 504000 500396 495931 504698 509569 508816 504948 504749 504676 504946 507726 509717 505713 497690 497954 506636 510770 509147 506396 506128
sum_num_deletes_total=48236436
sum_num_searches_by_thread=8966084 8962992 9015634 9084560 9049276 8792628 8949275 9042273 9135864 9050315 8969031 8950030 9026530 9028527 9038095 9074810 9079235 8972489 8903845 9002107 9081471 9059904 8976249 8918613 8987840 8942136 9048555 9059326 9085657 8891944 8877959 9036615 9121489 9053523 8976893 8964099 8978991 8967243 9096756 9106754 9046012 8939886 8904261 8954848 9053043 8996846 8860806 8931570 9019272 9059183 9134412 9167200 9059858 8957401 8953357 9147455 9165786 9131862 9043242 9094831 9084934 9089049 9191188 9246703 9118044 8967152 9039731 9066963 9100754 9122237 9070154 9048183 9025925 9079124 9094935 9135570 9069429 9003962 8934617 9086278 9184205 9160673 9087191 9097005 9071946 9082548 9155570 9190299 9106163 8979845 8965886 9116309 9184095 9182659 9103533 9121567
sum_num_searches_total=868311174
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=9964011 9959535 10016513 10096367 10055291 9768447 9944791 10048729 10151462 10055206 9965916 9944247 10028566 10031598 10040039 10083171 10089044 9969914 9895247 10003541 10090505 10067071 9974079 9909347 9984263 9935793 10051779 10066122 10096028 9880946 9865483 10039560 10135478 10060054 9972903 9958368 9975965 9963519 10108744 10118165 10050865 9932528 9891716 9950038 10057679 9995047 9847481 9923510 10020512 10066261 10148349 10185331 10065700 9952785 9949005 10165436 10186228 10147618 10048270 10105924 10093269 10099531 10214058 10274179 10132224 9961082 10043326 10076598 10111905 10135116 10078717 10052712 10027715 10087985 10104352 10149763 10076745 10004833 9927544 10097086 10204318 10178497 10095448 10106726 10080768 10091994 10171874 10210295 10117495 9976140 9961748 10128031 10205747 10201976 10116267 10134828
average_num_operations_total=10049864
stdev_num_operations_total=9672
sum_num_operations_total=964786982
min_num_operations_total=9768447
max_num_operations_total=10274179
first_time_thread_terminate_by_thread=10000155 10000157 10000156 10000156 10000155 10000155 10000157 10000157 10000156 10000155 10000156 10000157 10000155 10000155 10000156 10000156 10000155 10000156 10000155 10000157 10000156 10000156 10000156 10000156 10000155 10000156 10000156 10000156 10000155 10000155 10000157 10000156 10000156 10000155 10000156 10000157 10000155 10000155 10000156 10000156 10000155 10000156 10000155 10000157 10000156 10000156 10000156 10000156 10000156 10000155 10000156 10000156 10000155 10000155 10000155 10000156 10000156 10000155 10000156 10000156 10000155 10000155 10000155 10000155 10000155 10000156 10000156 10000156 10000155 10000155 10000156 10000155 10000156 10000155 10000156 10000155 10000155 10000155 10000155 10000156 10000156 10000155 10000156 10000156 10000155 10000155 10000155 10000155 10000155 10000156 10000155 10000156 10000155 10000155 10000156 10000155
min_time_thread_terminate_total=10000155
max_time_thread_terminate_total=10000157
first_time_thread_start_by_thread=3 3 4 3 3 3 3 3 3 3 4 4 3 3 4 3 3 3 3 3 3 3 3 3 3 3 4 3 3 3 3 3 3 3 4 4 3 3 4 3 3 3 3 3 3 3 3 3 4 4 4 4 4 4 4 4 4 4 4 4 3 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 3 4 4 4 4 4 4 4 4 4 4 4
min_time_thread_start_total=3
max_time_thread_start_total=4
sum_duration_all_ops_total=

threads_final_keysum=99991612793247
threads_final_size=9999624
final_keysum=99991612793247
final_size=9999624
validate_result=success
Validation OK.
Structural validation OK.

total_find=868311174
total_rq=0
total_inserts=48239372
total_deletes=48236436
total_updates=96475808
total_queries=868311174
total_ops=964786982
find_throughput=86831117
rq_throughput=0
update_throughput=9647580
query_throughput=86831117
total_throughput=96478698


total find                    : 868311174
total rq                      : 0
total inserts                 : 48239372
total deletes                 : 48236436
total updates                 : 96475808
total queries                 : 868311174
total ops                     : 964786982
find throughput               : 86831117
rq throughput                 : 0
update throughput             : 9647580
query throughput              : 86831117
total throughput              : 96478698

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=18.981
PAPI_L3_TCM=6.80537
PAPI_TOT_CYC=2755.1
PAPI_TOT_INS=962.093
garbage=4279159877698968
total_execution_walltime=11.561s
REALTIME_MAIN_END_PERF_FORMAT=6983058.261656915
[time_cmd_output] time_elapsed_sec=11.72, faults_major=0, faults_minor=193481, mem_maxresident_kb=769264, user_cputime=1106.67, sys_cputime=4.45, percent_cpu=9478%
timeout=false
algorithm=brown_sigouin_abtree_kcas_validate.debra
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=1