__step=000692
__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 128 -nprefill 128 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 50.0 50.0 -k 20000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000692.txt
__path_data=data/data000692.txt
__hostname=nasus
sizeof(kcasdesc_t)=1920
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x555bc48f2440
addrof(kcasDescriptors[1])=0x555bc48f2bc0
addrof(rdcssDescriptors[0])=0x555bc49e2440
addrof(rdcssDescriptors[1])=0x555bc49e2500
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=215127.507472945
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=20000000
PREFILL_THREADS=128
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=128
WORK_THREADS=128
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,128,129,130,131,132,133,134,135,136,137,138,139,140,141,142,143,144,145,146,147,148,149,150,151,152,153,154,155,156,157,158,159,160,161,162,163,164,165,166,167,168,169,170,171,172,173,174,175,176,177,178,179,180,181,182,183,184,185,186,187,188,189,190,191


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.034s
prefilling_size=9709004 prefilling_elapsed_millis=1s
prefilling_size=9808960 prefilling_elapsed_millis=1.101s
finished prefilling to size 9809065 for expected size 10000000 keysum=98091912441438, performing 79331724 updates; total_prefilling_elapsed_ms=1203 ms)
pref_size=9809065
pref_millis=1203
prefill_elapsed_ms=1215
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=215128.785711798
REALTIME_END_PERF_FORMAT=215138.785812852

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

tree_stats_computeWalltime=0.146s

tree_stats_numInternalsAtDepth=1 1 11 83 623 4684 35452 277417 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 1960504
tree_stats_numNodesAtDepth=1 1 11 83 623 4684 35452 277417 1960504
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 9999772
tree_stats_avgDegreeAtDepth=1 11 7.54545 7.50602 7.51846 7.56874 7.82514 7.06699 5.10061

tree_stats_height=9
tree_stats_numInternals=318272
tree_stats_numLeaves=1960504
tree_stats_numNodes=2278776
tree_stats_numKeys=9999772

tree_stats_avgDegreeInternal=7.15984
tree_stats_avgDegreeLeaves=5.10061
tree_stats_avgDegree=5.38822
tree_stats_avgKeyDepth=8


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:696 2:8638 4:125480 8:663094 16:467213 32:13589 64:564 128:32
    [2^00, 2^01]: 696
    (2^01, 2^02]: 8638
    (2^02, 2^03]: 125480
    (2^03, 2^04]: 663094
    (2^04, 2^05]: 467213
    (2^05, 2^06]: 13589
    (2^06, 2^07]: 564
    (2^07, 2^08]: 32
sum_limbo_reclamation_event_size_total=18524497
count_limbo_reclamation_event_size_by_thread=9994 9990 9996 9994 9996 9994 9994 9994 9996 9994 9996 9994 9994 9996 9996 9996 9994 9996 9996 9988 9996 9996 9996 9994 9996 9996 9994 9996 9996 9996 9990 9996 9996 9992 9994 9994 9992 9996 9996 9992 9996 9996 9992 9992 9990 9992 9996 9992 9996 9996 9994 9994 9996 9996 9996 9994 9996 9994 9992 9990 9996 9996 9992 9994 9990 9992 9996 9996 9996 9996 9994 9996 9994 9996 9996 9996 9996 9994 9994 9994 9996 9996 9996 9996 9996 9992 9996 9996 9992 9996 9996 9994 9996 9996 9996 9996 9996 9996 9996 9994 9992 9996 9990 9990 9996 9996 9994 9996 9994 9996 9996 9996 9992 9996 9996 9996 9992 9992 9994 9988 9994 9996 9996 9994 9996 9996 9996 9996
count_limbo_reclamation_event_size_total=1279306
sum_limbo_reclamation_event_count_total=1446902
first_thread_announced_epoch_by_thread=12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386 12386
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=9007
sum_abtree_erase_repeat_total=874
sum_abtree_search_repeat_total=741
sum_abtree_search_complete_total=884923206
sum_abtree_fix_weight_viol_attempt_total=1164039
sum_abtree_fix_degree_viol_attempt_total=5902540
sum_abtree_rebalancing_kcas_attempt_total=7065613
sum_abtree_update_kcas_attempt_total=438948097
sum_abtree_internal_complex_search_while_iters_total=884924325
sum_abtree_internal_basic_search_while_iters_total=
sum_kcas_desc_new_total=
sum_num_inserts_by_thread=3518057 3511164 3531017 3471141 3513729 3516987 3498683 3504650 3506757 3538807 3520387 3518208 3529463 3523881 3523437 3522936 3515634 3506757 3506867 3497706 3504740 3504108 3495895 3537389 3530951 3528740 3512902 3520497 3502995 3521298 3475947 3477686 3459480 3458410 3454238 3455455 3028052 3056103 3045681 3052935 3465290 3502457 3493814 3507501 3463419 3468763 3455005 3463904 3432713 3442450 3444628 3471420 3058950 3056148 3045129 3044687 3450280 3495008 3451028 3451849 3444543 3457925 3445185 3448897 3445051 3444870 3505291 3504382 3507588 3501928 3504479 3514459 3507885 3463220 3444858 3461662 3459098 3459294 3451532 3457904 3507570 3509717 3510298 3516217 3523007 3509139 3508253 3474807 3462944 3466421 3462551 3453858 3452557 3458261 3501322 3505495 3476329 3460820 3474982 3261075 3052165 3015162 3011717 3005584 3407179 3437322 3451290 3458710 3496927 3510373 3501647 3503447 3483397 3490999 3482056 3435075 3022897 3022738 3015404 3003027 3423218 3493009 3514777 3527339 3532537 3541430 3530766 3535676
sum_num_inserts_total=438895755
sum_num_deletes_by_thread=3518000 3511433 3529174 3473056 3516566 3519567 3499708 3505164 3509206 3537278 3518736 3518362 3528343 3529407 3519536 3522479 3515168 3506862 3509367 3500915 3507226 3506187 3498843 3540581 3528565 3530586 3519102 3523927 3507965 3520849 3474217 3478106 3464140 3460137 3456578 3459415 3024665 3058201 3046781 3048448 3465311 3501460 3497226 3505480 3461566 3469041 3453700 3463846 3434579 3443574 3445948 3469052 3063135 3063920 3046364 3041867 3450631 3502440 3450909 3453542 3445858 3453537 3442170 3447576 3448229 3443549 3505862 3500446 3508837 3501111 3501185 3512684 3504786 3465877 3448132 3461915 3457992 3455137 3449935 3453742 3508603 3511137 3512125 3515017 3519669 3509181 3507286 3475067 3460678 3466948 3457129 3455368 3453760 3459994 3504056 3505223 3481786 3461799 3472378 3260950 3054963 3017555 3009325 3005152 3407975 3436150 3451524 3460551 3499266 3510826 3500535 3499171 3484799 3491008 3481450 3431799 3021601 3024194 3013787 3005634 3426334 3493675 3518548 3525878 3533370 3541134 3532974 3532621
sum_num_deletes_total=438944950
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=7036057 7022597 7060191 6944197 7030295 7036554 6998391 7009814 7015963 7076085 7039123 7036570 7057806 7053288 7042973 7045415 7030802 7013619 7016234 6998621 7011966 7010295 6994738 7077970 7059516 7059326 7032004 7044424 7010960 7042147 6950164 6955792 6923620 6918547 6910816 6914870 6052717 6114304 6092462 6101383 6930601 7003917 6991040 7012981 6924985 6937804 6908705 6927750 6867292 6886024 6890576 6940472 6122085 6120068 6091493 6086554 6900911 6997448 6901937 6905391 6890401 6911462 6887355 6896473 6893280 6888419 7011153 7004828 7016425 7003039 7005664 7027143 7012671 6929097 6892990 6923577 6917090 6914431 6901467 6911646 7016173 7020854 7022423 7031234 7042676 7018320 7015539 6949874 6923622 6933369 6919680 6909226 6906317 6918255 7005378 7010718 6958115 6922619 6947360 6522025 6107128 6032717 6021042 6010736 6815154 6873472 6902814 6919261 6996193 7021199 7002182 7002618 6968196 6982007 6963506 6866874 6044498 6046932 6029191 6008661 6849552 6986684 7033325 7053217 7065907 7082564 7063740 7068297
average_num_operations_total=6858130
stdev_num_operations_total=27372
sum_num_operations_total=877840705
min_num_operations_total=6008661
max_num_operations_total=7082564
first_time_thread_terminate_by_thread=10000104 10000104 10000104 10000104 10000101 10000101 10000101 10000101 10000103 10000103 10000103 10000103 10000102 10000102 10000102 10000102 10000105 10000105 10000105 10000105 10000105 10000105 10000105 10000104 10000104 10000104 10000104 10000104 10000106 10000106 10000106 10000106 10000102 10000102 10000102 10000102 10000105 10000105 10000105 10000105 10000107 10000106 10000106 10000106 10000106 10000106 10000106 10000106 10000103 10000103 10000103 10000103 10000102 10000102 10000102 10000102 10000103 10000103 10000104 10000103 10000103 10000103 10000103 10000103 10000104 10000104 10000104 10000104 10000101 10000101 10000101 10000101 10000103 10000103 10000103 10000103 10000102 10000102 10000102 10000102 10000105 10000105 10000105 10000105 10000105 10000105 10000105 10000104 10000104 10000104 10000104 10000104 10000106 10000106 10000106 10000106 10000102 10000102 10000102 10000102 10000105 10000105 10000105 10000105 10000107 10000107 10000106 10000106 10000106 10000106 10000106 10000106 10000103 10000103 10000103 10000103 10000102 10000102 10000102 10000102 10000103 10000103 10000104 10000103 10000103 10000103 10000103 10000103
min_time_thread_terminate_total=10000101
max_time_thread_terminate_total=10000107
first_time_thread_start_by_thread=11 11 11 11 9 9 9 9 11 11 11 11 10 10 10 10 10 10 10 10 9 9 9 9 12 12 12 12 9 9 9 9 8 8 8 8 9 9 9 9 12 12 12 12 10 10 10 10 11 11 11 11 10 10 10 10 11 11 11 11 9 9 9 9 11 11 11 11 9 9 9 9 11 11 11 11 10 10 10 10 10 10 10 10 9 9 9 9 12 12 12 12 9 9 9 9 8 8 8 8 9 9 9 9 12 12 12 12 10 10 10 10 11 11 11 11 10 10 10 10 11 11 11 11 9 9 9 9
min_time_thread_start_total=8
max_time_thread_start_total=12
sum_duration_all_ops_total=

threads_final_keysum=100008964921701
threads_final_size=9999772
final_keysum=100008964921701
final_size=9999772
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=438895755
total_deletes=438944950
total_updates=877840705
total_queries=0
total_ops=877840705
find_throughput=0
rq_throughput=0
update_throughput=87784070
query_throughput=0
total_throughput=87784070


total find                    : 0
total rq                      : 0
total inserts                 : 438895755
total deletes                 : 438944950
total updates                 : 877840705
total queries                 : 0
total ops                     : 877840705
find throughput               : 0
rq throughput                 : 0
update throughput             : 87784070
query throughput              : 0
total throughput              : 87784070

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

garbage=0
total_execution_walltime=11.551s
REALTIME_MAIN_END_PERF_FORMAT=215139.59292428
[time_cmd_output] time_elapsed_sec=11.69, faults_major=0, faults_minor=204449, mem_maxresident_kb=811200, user_cputime=1459.60, sys_cputime=5.89, percent_cpu=12531%
timeout=false
algorithm=brown_sigouin_abtree_kcas_validate.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2