__step=000146
__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_htm.debra -nwork 48 -nprefill 48 -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=data000146.txt
__path_data=data/data000146.txt
__hostname=jax
sizeof(kcasdesc_t)=1920
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x55f76fd3c480
addrof(kcasDescriptors[1])=0x55f76fd3cc00
addrof(rdcssDescriptors[0])=0x55f76fe2c480
addrof(rdcssDescriptors[1])=0x55f76fe2c540
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=6996134.292175867
binary=./brown_sigouin_abtree_kcas_validate_htm.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_htm
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=48
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=48
WORK_THREADS=48
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


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.017s
prefilling_size=8934894 prefilling_elapsed_millis=1.001s
prefilling_size=9140364 prefilling_elapsed_millis=1.101s
prefilling_size=9300473 prefilling_elapsed_millis=1.201s
prefilling_size=9429541 prefilling_elapsed_millis=1.302s
prefilling_size=9533495 prefilling_elapsed_millis=1.402s
prefilling_size=9620677 prefilling_elapsed_millis=1.502s
prefilling_size=9689385 prefilling_elapsed_millis=1.602s
prefilling_size=9749122 prefilling_elapsed_millis=1.702s
prefilling_size=9795230 prefilling_elapsed_millis=1.803s
prefilling_size=9834850 prefilling_elapsed_millis=1.903s
finished prefilling to size 9834882 for expected size 10000000 keysum=98350050631059, performing 82886314 updates; total_prefilling_elapsed_ms=2004 ms)
pref_size=9834882
pref_millis=2004
prefill_elapsed_ms=2026
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6996136.502057095
REALTIME_END_PERF_FORMAT=6996146.502202043

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

tree_stats_computeWalltime=0.066s

tree_stats_numInternalsAtDepth=1 1 8 68 504 3806 28611 222566 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 1751565
tree_stats_numNodesAtDepth=1 1 8 68 504 3806 28611 222566 1751565
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 9984225
tree_stats_avgDegreeAtDepth=1 8 8.5 7.41176 7.55159 7.51734 7.77904 7.86987 5.70017

tree_stats_height=9
tree_stats_numInternals=255565
tree_stats_numLeaves=1751565
tree_stats_numNodes=2007130
tree_stats_numKeys=9984225

tree_stats_avgDegreeInternal=7.8537
tree_stats_avgDegreeLeaves=5.70017
tree_stats_avgDegree=5.97438
tree_stats_avgKeyDepth=8


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:52428 2:58111 4:10235 8:368
    [2^00, 2^01]: 52428
    (2^01, 2^02]: 58111
    (2^02, 2^03]: 10235
    (2^03, 2^04]: 368
sum_limbo_reclamation_event_size_total=222821
count_limbo_reclamation_event_size_by_thread=2464 2614 2648 2412 2564 2466 2558 2460 2476 2408 2442 2586 2500 2558 2454 2580 2562 2484 2498 2606 2440 2412 2632 2474 2506 2556 2510 2588 2654 2346 2506 2584 2722 2478 2572 2544 2514 2596 2578 2476 2476 2464 2624 2480 2520 2412 2584 2554
count_limbo_reclamation_event_size_total=121142
sum_limbo_reclamation_event_count_total=2054208
first_thread_announced_epoch_by_thread=50440 50440 50440 50440 50440 50440 50440 50440 50440 50440 50440 50440 50440 50440 50440 50440 50440 50440 50440 50440 50440 50440 50440 50440 50440 50440 50440 50440 50440 50440 50440 50440 50440 50440 50440 50440 50440 50440 50440 50440 50440 50440 50440 50440 50440 50440 50440 50440
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=55
sum_abtree_erase_repeat_total=8
sum_abtree_search_repeat_total=
sum_abtree_search_complete_total=47707965
sum_abtree_fix_weight_viol_attempt_total=187452
sum_abtree_fix_degree_viol_attempt_total=119886
sum_abtree_rebalancing_kcas_attempt_total=307337
sum_abtree_update_kcas_attempt_total=23700278
sum_abtree_internal_complex_search_while_iters_total=47707965
sum_abtree_internal_basic_search_while_iters_total=426532888
sum_kcas_desc_new_total=
sum_num_inserts_by_thread=490575 492015 497158 496407 494010 490695 492369 492908 498283 498692 493500 490903 491968 493219 497393 495622 495025 493497 490037 492617 494853 497100 490136 488788 491629 493613 497626 496693 493692 488291 492215 491807 498025 500246 493500 491882 494198 494720 497192 497703 494965 493004 488629 492101 494875 495726 491717 487244
sum_num_inserts_total=23699063
sum_num_deletes_by_thread=492051 494407 496280 496267 494283 489021 490990 492883 497933 499763 494131 492291 491511 494783 498087 496029 493965 492884 488856 492580 495663 495759 490372 488879 491660 492992 496704 495112 494945 488711 492704 491505 498619 498881 495641 491100 493998 495675 497202 497948 494585 492181 490694 490978 494865 495676 491256 488164
sum_num_deletes_total=23701464
sum_num_searches_by_thread=8839146 8879647 8935514 8921395 8898634 8820447 8845212 8883338 8964101 8978240 8885164 8834790 8858813 8893076 8957217 8933169 8899349 8868860 8815590 8862094 8904395 8941269 8843359 8802043 8844730 8876925 8938162 8923340 8903532 8797089 8853367 8851410 8963989 8986958 8894984 8842988 8881421 8912465 8941868 8949272 8903897 8869213 8814717 8855156 8907119 8927971 8844325 8782556
sum_num_searches_total=426532316
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=9821772 9866069 9928952 9914069 9886927 9800163 9828571 9869129 9960317 9976695 9872795 9817984 9842292 9881078 9952697 9924820 9888339 9855241 9794483 9847291 9894911 9934128 9823867 9779710 9828019 9863530 9932492 9915145 9892169 9774091 9838286 9834722 9960633 9986085 9884125 9825970 9869617 9902860 9936262 9944923 9893447 9854398 9794040 9838235 9896859 9919373 9827298 9757964
average_num_operations_total=9873600
stdev_num_operations_total=8199
sum_num_operations_total=473932843
min_num_operations_total=9757964
max_num_operations_total=9986085
first_time_thread_terminate_by_thread=10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000145 10000144 10000144 10000145 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000145 10000144 10000144 10000145 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144
min_time_thread_terminate_total=10000144
max_time_thread_terminate_total=10000145
first_time_thread_start_by_thread=3 4 4 4 3 3 4 4 3 3 3 3 3 4 4 3 4 3 3 3 3 3 3 3 3 4 4 4 3 3 4 4 3 3 3 3 3 4 4 3 4 3 3 3 3 3 3 3
min_time_thread_start_total=3
max_time_thread_start_total=4
sum_duration_all_ops_total=

threads_final_keysum=99835390169908
threads_final_size=9984225
final_keysum=99835390169908
final_size=9984225
validate_result=success
Validation OK.
Structural validation OK.

total_find=426532316
total_rq=0
total_inserts=23699063
total_deletes=23701464
total_updates=47400527
total_queries=426532316
total_ops=473932843
find_throughput=42653231
rq_throughput=0
update_throughput=4740052
query_throughput=42653231
total_throughput=47393284


total find                    : 426532316
total rq                      : 0
total inserts                 : 23699063
total deletes                 : 23701464
total updates                 : 47400527
total queries                 : 426532316
total ops                     : 473932843
find throughput               : 42653231
rq throughput                 : 0
update throughput             : 4740052
query throughput              : 42653231
total throughput              : 47393284

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=18.4019
PAPI_L3_TCM=6.35987
PAPI_TOT_CYC=2813.58
PAPI_TOT_INS=944.99
garbage=2119459962417478
total_execution_walltime=12.353s
REALTIME_MAIN_END_PERF_FORMAT=6996146.659582648
[time_cmd_output] time_elapsed_sec=12.54, faults_major=0, faults_minor=185601, mem_maxresident_kb=742796, user_cputime=609.93, sys_cputime=3.15, percent_cpu=4888%
timeout=false
algorithm=brown_sigouin_abtree_kcas_validate_htm.debra
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=2