__step=000353
__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 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=data000353.txt
__path_data=data/data000353.txt
__hostname=jax
sizeof(kcasdesc_t)=1920
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x5596e32f4480
addrof(kcasDescriptors[1])=0x5596e32f4c00
addrof(rdcssDescriptors[0])=0x5596e33e4480
addrof(rdcssDescriptors[1])=0x5596e33e4540
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=6983021.486995526
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=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.005s
prefilling_size=8894416 prefilling_elapsed_millis=1.001s
prefilling_size=9105810 prefilling_elapsed_millis=1.101s
prefilling_size=9276802 prefilling_elapsed_millis=1.201s
prefilling_size=9414868 prefilling_elapsed_millis=1.301s
prefilling_size=9519853 prefilling_elapsed_millis=1.402s
prefilling_size=9608255 prefilling_elapsed_millis=1.502s
prefilling_size=9679068 prefilling_elapsed_millis=1.602s
prefilling_size=9740188 prefilling_elapsed_millis=1.702s
prefilling_size=9786768 prefilling_elapsed_millis=1.802s
prefilling_size=9825328 prefilling_elapsed_millis=1.903s
finished prefilling to size 9825403 for expected size 10000000 keysum=98255391913204, performing 82171387 updates; total_prefilling_elapsed_ms=2004 ms)
pref_size=9825403
pref_millis=2004
prefill_elapsed_ms=2031
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6983023.694347494
REALTIME_END_PERF_FORMAT=6983033.694497272

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

tree_stats_computeWalltime=0.058s

tree_stats_numInternalsAtDepth=1 1 8 70 500 3775 28519 222087 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 1747789
tree_stats_numNodesAtDepth=1 1 8 70 500 3775 28519 222087 1747789
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 9983199
tree_stats_avgDegreeAtDepth=1 8 8.75 7.14286 7.55 7.5547 7.78733 7.86984 5.7119

tree_stats_height=9
tree_stats_numInternals=254961
tree_stats_numLeaves=1747789
tree_stats_numNodes=2002750
tree_stats_numKeys=9983199

tree_stats_avgDegreeInternal=7.85512
tree_stats_avgDegreeLeaves=5.7119
tree_stats_avgDegree=5.98475
tree_stats_avgKeyDepth=8


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:52479 2:58419 4:10440 8:391 16:1
    [2^00, 2^01]: 52479
    (2^01, 2^02]: 58419
    (2^02, 2^03]: 10440
    (2^03, 2^04]: 391
    (2^04, 2^05]: 1
sum_limbo_reclamation_event_size_total=224686
count_limbo_reclamation_event_size_by_thread=2658 2544 2424 2554 2544 2558 2568 2564 2552 2482 2468 2556 2414 2644 2482 2622 2594 2532 2472 2428 2494 2450 2608 2460 2350 2458 2684 2682 2480 2496 2474 2668 2506 2476 2502 2560 2558 2620 2528 2538 2520 2586 2604 2590 2570 2554 2518 2536
count_limbo_reclamation_event_size_total=121730
sum_limbo_reclamation_event_count_total=2035392
first_thread_announced_epoch_by_thread=49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960
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=52
sum_abtree_erase_repeat_total=8
sum_abtree_search_repeat_total=
sum_abtree_search_complete_total=47273347
sum_abtree_fix_weight_viol_attempt_total=188390
sum_abtree_fix_degree_viol_attempt_total=117076
sum_abtree_rebalancing_kcas_attempt_total=305464
sum_abtree_update_kcas_attempt_total=23481936
sum_abtree_internal_complex_search_while_iters_total=47273352
sum_abtree_internal_basic_search_while_iters_total=422622849
sum_kcas_desc_new_total=
sum_num_inserts_by_thread=486152 488991 491808 489532 488869 485322 487615 488724 492943 493172 489143 486282 485785 491415 492528 492691 490801 486882 486387 487634 491498 493292 487757 484709 487471 488662 491522 490856 490612 484813 487675 487724 492768 493513 488190 486206 488274 491754 492479 493935 490268 487622 485901 487570 491173 492464 487892 485299
sum_num_inserts_total=23484575
sum_num_deletes_by_thread=486439 489559 491983 491729 488534 484444 486252 487806 492113 492698 488829 485933 488266 490273 495097 491904 489315 486578 485019 486590 491077 492719 486390 484552 486429 487665 493715 491196 491018 486941 487126 488840 491915 493055 488406 487486 487919 491033 494292 493162 491329 487751 484843 488106 491625 493207 487757 484291
sum_num_deletes_total=23483206
sum_num_searches_by_thread=8740906 8797657 8849083 8843351 8812014 8730788 8751890 8783768 8869615 8882338 8807933 8747926 8771314 8821884 8888247 8865240 8827038 8769472 8742067 8782800 8838805 8862818 8769038 8725448 8743756 8791441 8852905 8834731 8828905 8733132 8777497 8789707 8882001 8881995 8791898 8747887 8777491 8837880 8871442 8877092 8832766 8780104 8734507 8778928 8836330 8859215 8781783 8717280
sum_num_searches_total=422622113
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=9713497 9776207 9832874 9824612 9789417 9700554 9725757 9760298 9854671 9868208 9785905 9720141 9745365 9803572 9875872 9849835 9807154 9742932 9713473 9757024 9821380 9848829 9743185 9694709 9717656 9767768 9838142 9816783 9810535 9704886 9752298 9766271 9866684 9868563 9768494 9721579 9753684 9820667 9858213 9864189 9814363 9755477 9705251 9754604 9819128 9844886 9757432 9686870
average_num_operations_total=9783122
stdev_num_operations_total=8160
sum_num_operations_total=469589894
min_num_operations_total=9686870
max_num_operations_total=9875872
first_time_thread_terminate_by_thread=10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149
min_time_thread_terminate_total=10000149
max_time_thread_terminate_total=10000149
first_time_thread_start_by_thread=3 3 3 3 3 2 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 2 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3
min_time_thread_start_total=2
max_time_thread_start_total=3
sum_duration_all_ops_total=

threads_final_keysum=99828585671872
threads_final_size=9983199
final_keysum=99828585671872
final_size=9983199
validate_result=success
Validation OK.
Structural validation OK.

total_find=422622113
total_rq=0
total_inserts=23484575
total_deletes=23483206
total_updates=46967781
total_queries=422622113
total_ops=469589894
find_throughput=42262211
rq_throughput=0
update_throughput=4696778
query_throughput=42262211
total_throughput=46958989


total find                    : 422622113
total rq                      : 0
total inserts                 : 23484575
total deletes                 : 23483206
total updates                 : 46967781
total queries                 : 422622113
total ops                     : 469589894
find throughput               : 42262211
rq throughput                 : 0
update throughput             : 4696778
query throughput              : 42262211
total throughput              : 46958989

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=18.447
PAPI_L3_TCM=6.36524
PAPI_TOT_CYC=2836.65
PAPI_TOT_INS=963.206
garbage=2099115872720926
total_execution_walltime=12.356s
REALTIME_MAIN_END_PERF_FORMAT=6983033.843663461
[time_cmd_output] time_elapsed_sec=12.51, faults_major=0, faults_minor=185244, mem_maxresident_kb=741804, user_cputime=608.82, sys_cputime=3.41, percent_cpu=4891%
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