__step=000356
__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=data000356.txt
__path_data=data/data000356.txt
__hostname=jax
sizeof(kcasdesc_t)=1920
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x55bd28150480
addrof(kcasDescriptors[1])=0x55bd28150c00
addrof(rdcssDescriptors[0])=0x55bd28240480
addrof(rdcssDescriptors[1])=0x55bd28240540
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=6983058.472985157
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.007s
prefilling_size=9806987 prefilling_elapsed_millis=1.001s
finished prefilling to size 9807025 for expected size 10000000 keysum=98043968055181, performing 79628451 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=9807025
pref_millis=1102
prefill_elapsed_ms=1131
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6983059.779670625
REALTIME_END_PERF_FORMAT=6983069.779818729

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

tree_stats_computeWalltime=0.056s

tree_stats_numInternalsAtDepth=1 1 9 70 534 3968 29937 233892 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 1832545
tree_stats_numNodesAtDepth=1 1 9 70 534 3968 29937 233892 1832545
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 9999936
tree_stats_avgDegreeAtDepth=1 9 7.77778 7.62857 7.43071 7.54461 7.81281 7.83501 5.45686

tree_stats_height=9
tree_stats_numInternals=268412
tree_stats_numLeaves=1832545
tree_stats_numNodes=2100957
tree_stats_numKeys=9999936

tree_stats_avgDegreeInternal=7.82736
tree_stats_avgDegreeLeaves=5.45686
tree_stats_avgDegree=5.75971
tree_stats_avgKeyDepth=8


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:154270 2:205582 4:51445 8:2335 16:4
    [2^00, 2^01]: 154270
    (2^01, 2^02]: 205582
    (2^02, 2^03]: 51445
    (2^03, 2^04]: 2335
    (2^04, 2^05]: 4
sum_limbo_reclamation_event_size_total=857401
count_limbo_reclamation_event_size_by_thread=4048 4394 4182 4244 4310 4160 4348 4178 4214 4258 4512 4238 4328 4380 4270 4398 4288 4332 4342 4322 4284 4384 4318 4270 4410 4350 4424 4312 4302 4156 4208 4424 4232 4300 4264 4232 4232 4402 4216 4456 4398 4234 4102 4324 4388 4276 4198 4308 4198 4334 4468 4310 4248 4274 4220 4270 4374 4316 4350 4442 4284 4456 4306 4388 4326 4234 4208 4300 4424 4250 4220 4242 4338 4248 4370 4346 4312 4166 4228 4312 4380 4418 4416 4318 4290 4490 4396 4428 4232 4298 4348 4256 4374 4408 4358 4314
count_limbo_reclamation_event_size_total=413636
sum_limbo_reclamation_event_count_total=2081280
first_thread_announced_epoch_by_thread=23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512 23512
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=213
sum_abtree_erase_repeat_total=21
sum_abtree_search_repeat_total=4
sum_abtree_search_complete_total=97138160
sum_abtree_fix_weight_viol_attempt_total=314114
sum_abtree_fix_degree_viol_attempt_total=311997
sum_abtree_rebalancing_kcas_attempt_total=626108
sum_abtree_update_kcas_attempt_total=48252651
sum_abtree_internal_complex_search_while_iters_total=97138171
sum_abtree_internal_basic_search_while_iters_total=868572047
sum_kcas_desc_new_total=
sum_num_inserts_by_thread=496043 500329 503311 502511 498315 495092 500520 500835 505186 505682 501875 496397 499494 503112 507543 503320 500756 499735 499446 500890 502999 503795 498949 495069 492781 500566 505410 502563 499440 494766 499167 499267 502343 506970 498759 494503 499554 503819 503203 503510 502023 495581 497364 502252 500511 504032 499937 494158 503809 504765 509630 506084 504064 502168 499498 506836 508597 506513 502667 503635 502389 501679 504973 510651 506317 498040 497815 502406 507442 502619 503029 503102 502921 501272 504723 508590 504371 500677 505678 505108 508768 511928 506223 501313 503147 509185 510731 508984 506971 503497 500734 502064 511455 512978 508764 506658
sum_num_inserts_total=48269151
sum_num_deletes_by_thread=495212 502202 501775 501943 499311 495835 499662 500386 505411 505484 500874 497425 499019 503632 507926 503684 501475 498525 497277 499056 502112 504343 500003 494499 491641 500502 504602 502283 499865 494429 497149 500382 503246 504359 496472 493851 501163 502885 501004 503366 503020 494484 495053 500992 500545 504344 501193 494728 504299 505191 508463 506280 503731 502034 500585 505494 508739 507130 503258 504109 500003 502466 504614 510995 504794 498054 496985 502865 507852 502692 501732 502706 501850 502077 505010 508851 502981 499243 504977 505476 507277 511978 505747 500669 504802 509289 512070 508394 507741 503339 499737 502084 509430 511866 508744 505213
sum_num_deletes_total=48242545
sum_num_searches_by_thread=8918360 9032742 9063610 9040173 8977284 8926668 8999617 9013737 9091382 9100942 9040021 8950462 8985567 9056380 9141317 9063194 9019033 8989937 8970234 8999580 9039635 9066248 8991020 8911003 8855149 9004104 9093292 9053745 8999410 8918981 8979962 8995784 9051098 9097897 8951965 8907457 9003417 9055481 9034195 9064047 9046707 8910542 8924866 9006374 9003717 9082569 9008024 8888862 9072087 9107674 9157903 9111173 9098822 9026570 9001317 9116101 9151953 9127350 9041297 9068168 9021590 9041193 9090741 9187304 9110657 8966111 8972221 9038617 9126570 9045355 9050331 9053333 9042528 9030845 9082005 9151272 9054514 9000288 9090502 9095022 9126049 9200953 9108043 9011380 9088781 9166780 9191517 9160764 9118118 9059508 9010604 9023270 9189668 9210131 9148997 9098170
sum_num_searches_total=868569938
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=9909615 10035273 10068696 10044627 9974910 9917595 9999799 10014958 10101979 10112108 10042770 9944284 9984080 10063124 10156786 10070198 10021264 9988197 9966957 9999526 10044746 10074386 9989972 9900571 9839571 10005172 10103304 10058591 9998715 9908176 9976278 9995433 10056687 10109226 9947196 9895811 10004134 10062185 10038402 10070923 10051750 9900607 9917283 10009618 10004773 10090945 10009154 9877748 10080195 10117630 10175996 10123537 10106617 10030772 10001400 10128431 10169289 10140993 10047222 10075912 10023982 10045338 10100328 10208950 10121768 9962205 9967021 10043888 10141864 10050666 10055092 10059141 10047299 10034194 10091738 10168713 10061866 10000208 10101157 10105606 10142094 10224859 10120013 10013362 10096730 10185254 10214318 10178142 10132830 10066344 10011075 10027418 10210553 10234975 10166505 10110041
average_num_operations_total=10052933
stdev_num_operations_total=8536
sum_num_operations_total=965081634
min_num_operations_total=9839571
max_num_operations_total=10234975
first_time_thread_terminate_by_thread=10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000149 10000148 10000148 10000148 10000149 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000149 10000148 10000148 10000148 10000149 10000148 10000148 10000148 10000148 10000149 10000147 10000149 10000149 10000147 10000147 10000147 10000149 10000148 10000148 10000147 10000147 10000148 10000149 10000149 10000149 10000147 10000147 10000148 10000148 10000148 10000149 10000147 10000148 10000147 10000147 10000147 10000149 10000147 10000147 10000147 10000149 10000148 10000148 10000147 10000147 10000148 10000149 10000149 10000149 10000147 10000147 10000148 10000148 10000148 10000148 10000147 10000148
min_time_thread_terminate_total=10000147
max_time_thread_terminate_total=10000149
first_time_thread_start_by_thread=4 4 5 4 5 4 4 5 5 5 4 5 4 4 5 5 4 5 5 4 4 5 4 5 4 4 5 4 5 4 4 5 5 5 4 5 4 4 5 5 4 5 5 4 4 5 4 5 4 4 4 4 5 5 5 4 4 4 4 4 4 5 4 4 4 4 4 4 4 5 4 4 4 4 4 4 5 5 5 4 4 4 4 4 4 5 4 4 4 4 4 4 4 5 4 4
min_time_thread_start_total=4
max_time_thread_start_total=5
sum_duration_all_ops_total=

threads_final_keysum=100005066252807
threads_final_size=9999936
final_keysum=100005066252807
final_size=9999936
validate_result=success
Validation OK.
Structural validation OK.

total_find=868569938
total_rq=0
total_inserts=48269151
total_deletes=48242545
total_updates=96511696
total_queries=868569938
total_ops=965081634
find_throughput=86856993
rq_throughput=0
update_throughput=9651169
query_throughput=86856993
total_throughput=96508163


total find                    : 868569938
total rq                      : 0
total inserts                 : 48269151
total deletes                 : 48242545
total updates                 : 96511696
total queries                 : 868569938
total ops                     : 965081634
find throughput               : 86856993
rq throughput                 : 0
update throughput             : 9651169
query throughput              : 86856993
total throughput              : 96508163

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=18.9029
PAPI_L3_TCM=6.78763
PAPI_TOT_CYC=2752.7
PAPI_TOT_INS=962.595
garbage=4326011995739329
total_execution_walltime=11.473s
REALTIME_MAIN_END_PERF_FORMAT=6983069.946664004
[time_cmd_output] time_elapsed_sec=11.62, faults_major=0, faults_minor=193376, mem_maxresident_kb=768864, user_cputime=1096.12, sys_cputime=3.71, percent_cpu=9458%
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=2