__step=000139
__cmd_run=LD_PRELOAD=../../setbench/lib/libjemalloc.so timeout 180 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=data000139.txt
__path_data=data/data000139.txt
__hostname=jax
sizeof(kcasdesc_t)=1920
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x56060f013480
addrof(kcasDescriptors[1])=0x56060f013c00
addrof(rdcssDescriptors[0])=0x56060f103480
addrof(rdcssDescriptors[1])=0x56060f103540
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=6996050.612721326
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.022s
prefilling_size=9763166 prefilling_elapsed_millis=1.001s
prefilling_size=9839344 prefilling_elapsed_millis=1.101s
finished prefilling to size 9839398 for expected size 10000000 keysum=98387139011345, performing 87632898 updates; total_prefilling_elapsed_ms=1203 ms)
pref_size=9839398
pref_millis=1203
prefill_elapsed_ms=1227
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6996052.64095398
REALTIME_END_PERF_FORMAT=6996062.64236152

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

tree_stats_computeWalltime=0.064s

tree_stats_numInternalsAtDepth=1 1 10 73 536 3953 30088 234836 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 1838229
tree_stats_numNodesAtDepth=1 1 10 73 536 3953 30088 234836 1838229
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 9998688
tree_stats_avgDegreeAtDepth=1 10 7.3 7.34247 7.375 7.61143 7.80497 7.82771 5.4393

tree_stats_height=9
tree_stats_numInternals=269498
tree_stats_numLeaves=1838229
tree_stats_numNodes=2107727
tree_stats_numKeys=9998688

tree_stats_avgDegreeInternal=7.82094
tree_stats_avgDegreeLeaves=5.4393
tree_stats_avgDegree=5.74382
tree_stats_avgKeyDepth=8


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:152854 2:202926 4:47490 8:1887 16:3
    [2^00, 2^01]: 152854
    (2^01, 2^02]: 202926
    (2^02, 2^03]: 47490
    (2^03, 2^04]: 1887
    (2^04, 2^05]: 3
sum_limbo_reclamation_event_size_total=827850
count_limbo_reclamation_event_size_by_thread=4162 4112 4044 4440 4084 4278 4348 4174 4086 4088 3922 4274 4106 4270 4048 4206 4302 4118 4298 4394 4126 4494 4326 4206 4026 4368 4102 3962 4078 4070 3958 4408 4048 4078 4316 4350 4088 4268 3996 4080 4114 4386 3960 4138 4094 4340 4258 4392 4500 4438 4436 4294 4212 3962 4106 4306 4060 4312 4166 4322 4422 4176 4432 4178 4354 4364 4032 4004 4362 4068 4424 4412 4198 4418 4164 4180 4300 4102 4078 4432 4424 4174 4174 4092 4360 4206 4312 4260 4334 4434 4064 4428 4250 4140 4446 4064
count_limbo_reclamation_event_size_total=405160
sum_limbo_reclamation_event_count_total=2094336
first_thread_announced_epoch_by_thread=23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838 23838
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=227
sum_abtree_erase_repeat_total=15
sum_abtree_search_repeat_total=7
sum_abtree_search_complete_total=97550408
sum_abtree_fix_weight_viol_attempt_total=288971
sum_abtree_fix_degree_viol_attempt_total=327278
sum_abtree_rebalancing_kcas_attempt_total=616240
sum_abtree_update_kcas_attempt_total=48464400
sum_abtree_internal_complex_search_while_iters_total=97550428
sum_abtree_internal_basic_search_while_iters_total=872496496
sum_kcas_desc_new_total=
sum_num_inserts_by_thread=498337 502902 508805 504230 504822 500982 498647 502099 508191 509372 499632 499852 501731 507318 506456 506605 502549 504444 500931 499374 505021 509119 497422 492933 499956 503907 502689 502517 504322 499255 499159 499837 508202 510355 501068 496071 502305 504322 503695 505030 504375 500675 496526 497808 505878 506991 495852 494736 505808 507344 508352 510338 505735 500839 508512 506810 508699 511531 512870 503149 503305 509365 510700 509606 506535 504228 500507 499884 506897 506523 500188 502248 505077 507115 511522 511045 505828 504254 502315 500596 513195 516552 509947 505499 510618 511058 512808 513556 511333 502595 502878 504091 512445 514420 508173 506878
sum_num_inserts_total=48471076
sum_num_deletes_by_thread=499225 501040 509277 503766 504383 499895 497985 502636 508261 509849 499379 500375 501021 506849 507394 507573 501737 503961 499986 498350 503927 509131 498408 491494 499404 504223 503319 502790 504863 500070 499786 500218 509025 510133 499992 495706 504143 504180 503882 503694 505424 501946 495610 498527 505255 506625 496536 496041 507366 505660 508863 510518 505476 500527 507111 508998 509447 511974 511631 501520 503206 510235 509804 508268 504432 504143 501321 498724 508089 505726 499260 502614 504339 507333 511185 509626 505395 505095 501441 498477 513938 515029 510383 505642 510533 510361 512796 513332 511661 503138 503042 504894 514488 512861 508590 506924
sum_num_deletes_total=48462710
sum_num_searches_by_thread=8974469 9021398 9158473 9085917 9070347 9010832 8966467 9041718 9170580 9176585 8989081 8986618 9028951 9121736 9122213 9121621 9057151 9084889 8995889 8991427 9088315 9172767 8954881 8866103 9005860 9075041 9054048 9043911 9071733 8989125 8994602 9011017 9137051 9189307 9017213 8934447 9046811 9097315 9074250 9077691 9088796 9035310 8920446 8988133 9104161 9129819 8935756 8921762 9125562 9112566 9150099 9201927 9093494 9013323 9134514 9135553 9156101 9217676 9204080 9044372 9046705 9176823 9185826 9152210 9096975 9073880 9020674 8982157 9149888 9108159 9005216 9060298 9089444 9117159 9211231 9170328 9095896 9082344 9032528 8998086 9254186 9298285 9186828 9111958 9185431 9204838 9233111 9234147 9202845 9054638 9050111 9075461 9239039 9251203 9144975 9120093
sum_num_searches_total=872494276
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=9972031 10025340 10176555 10093913 10079552 10011709 9963099 10046453 10187032 10195806 9988092 9986845 10031703 10135903 10136063 10135799 10061437 10093294 9996806 9989151 10097263 10191017 9950711 9850530 10005220 10083171 10060056 10049218 10080918 9988450 9993547 10011072 10154278 10209795 10018273 9926224 10053259 10105817 10081827 10086415 10098595 10037931 9912582 9984468 10115294 10143435 9928144 9912539 10138736 10125570 10167314 10222783 10104705 10014689 10150137 10151361 10174247 10241181 10228581 10049041 10053216 10196423 10206330 10170084 10107942 10082251 10022502 9980765 10164874 10120408 10004664 10065160 10098860 10131607 10233938 10190999 10107119 10091693 10036284 9997159 10281319 10329866 10207158 10123099 10206582 10226257 10258715 10261035 10225839 10060371 10056031 10084446 10265972 10278484 10161738 10133895
average_num_operations_total=10098208
stdev_num_operations_total=9922
sum_num_operations_total=969428062
min_num_operations_total=9850530
max_num_operations_total=10329866
first_time_thread_terminate_by_thread=10000140 10000140 10000140 10000143 10000142 10000141 10000141 10000141 10000142 10000142 10000142 10000142 10000140 10000143 10000140 10000140 10000142 10000140 10000141 10000143 10000142 10000140 10000140 10000143 10000140 10000143 10000140 10000140 10000142 10000141 10000141 10000141 10000142 10000142 10000142 10000142 10000140 10000143 10000140 10000140 10000142 10000140 10000141 10000143 10000142 10000140 10000140 10000143 10000140 10000142 10000141 10000142 10000143 10000141 10000141 10000141 10000143 10000139 10000142 10000140 10000139 10000141 10000140 10000142 10000141 10000140 10000140 10000140 10000140 10000140 10000139 10000140 10000140 10000142 10000141 10000141 10000143 10000140 10000141 10000140 10000143 10000139 10000139 10000140 10000139 10000141 10000140 10000141 10000141 10000140 10000140 10000140 10000140 10000140 10000140 10000140
min_time_thread_terminate_total=10000139
max_time_thread_terminate_total=10000143
first_time_thread_start_by_thread=5 5 4 5 4 5 5 5 4 5 5 4 5 5 5 5 5 5 5 5 5 5 5 5 5 5 4 5 4 5 5 5 4 5 5 4 5 5 5 5 5 5 5 5 5 5 5 5 4 5 4 4 4 5 4 5 5 5 5 4 4 5 5 4 5 4 5 5 4 4 5 4 4 5 4 4 4 5 4 5 5 5 5 4 4 5 5 4 5 4 5 5 4 4 5 4
min_time_thread_start_total=4
max_time_thread_start_total=5
sum_duration_all_ops_total=

threads_final_keysum=99975909159468
threads_final_size=9998688
final_keysum=99975909159468
final_size=9998688
validate_result=success
Validation OK.
Structural validation OK.

total_find=872494276
total_rq=0
total_inserts=48471076
total_deletes=48462710
total_updates=96933786
total_queries=872494276
total_ops=969428062
find_throughput=87249427
rq_throughput=0
update_throughput=9693378
query_throughput=87249427
total_throughput=96942806


total find                    : 872494276
total rq                      : 0
total inserts                 : 48471076
total deletes                 : 48462710
total updates                 : 96933786
total queries                 : 872494276
total ops                     : 969428062
find throughput               : 87249427
rq throughput                 : 0
update throughput             : 9693378
query throughput              : 87249427
total throughput              : 96942806

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=18.9165
PAPI_L3_TCM=6.79684
PAPI_TOT_CYC=2741.58
PAPI_TOT_INS=962.275
garbage=4303240659441347
total_execution_walltime=11.634s
REALTIME_MAIN_END_PERF_FORMAT=6996062.248266723
[time_cmd_output] time_elapsed_sec=11.79, faults_major=0, faults_minor=193843, mem_maxresident_kb=770624, user_cputime=1107.18, sys_cputime=3.33, percent_cpu=9412%
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