__step=000298
__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_abtree_tm_auto.debra.norec -nwork 48 -nprefill 48 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000298.txt
__path_data=data/data000298.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6998274.865523959
binary=./brown_abtree_tm_auto.debra.norec
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
DS_TYPENAME=brown_abtree_tm_auto
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=2000000
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=200
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
noREC system ready
Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.006s
prefilling_size=632009 prefilling_elapsed_millis=1.001s
prefilling_size=667406 prefilling_elapsed_millis=1.101s
prefilling_size=699082 prefilling_elapsed_millis=1.201s
prefilling_size=728406 prefilling_elapsed_millis=1.301s
prefilling_size=754400 prefilling_elapsed_millis=1.401s
prefilling_size=777832 prefilling_elapsed_millis=1.502s
prefilling_size=798982 prefilling_elapsed_millis=1.602s
prefilling_size=817930 prefilling_elapsed_millis=1.702s
prefilling_size=835162 prefilling_elapsed_millis=1.802s
prefilling_size=850878 prefilling_elapsed_millis=1.902s
prefilling_size=864515 prefilling_elapsed_millis=2.002s
prefilling_size=877373 prefilling_elapsed_millis=2.103s
prefilling_size=889062 prefilling_elapsed_millis=2.203s
prefilling_size=899992 prefilling_elapsed_millis=2.303s
prefilling_size=909232 prefilling_elapsed_millis=2.403s
prefilling_size=917682 prefilling_elapsed_millis=2.504s
prefilling_size=925945 prefilling_elapsed_millis=2.604s
prefilling_size=933039 prefilling_elapsed_millis=2.704s
prefilling_size=939118 prefilling_elapsed_millis=2.804s
prefilling_size=944623 prefilling_elapsed_millis=2.904s
prefilling_size=949432 prefilling_elapsed_millis=3.004s
prefilling_size=953638 prefilling_elapsed_millis=3.105s
prefilling_size=958604 prefilling_elapsed_millis=3.205s
prefilling_size=962209 prefilling_elapsed_millis=3.305s
prefilling_size=965261 prefilling_elapsed_millis=3.405s
prefilling_size=968680 prefilling_elapsed_millis=3.505s
prefilling_size=971572 prefilling_elapsed_millis=3.606s
prefilling_size=973864 prefilling_elapsed_millis=3.706s
prefilling_size=976519 prefilling_elapsed_millis=3.806s
prefilling_size=978687 prefilling_elapsed_millis=3.906s
prefilling_size=980829 prefilling_elapsed_millis=4.006s
finished prefilling to size 980808 for expected size 1000000 keysum=980556965107, performing 8216687 updates; total_prefilling_elapsed_ms=4107 ms)
pref_size=980808
pref_millis=4107
prefill_elapsed_ms=4126
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=6998279.162342007
REALTIME_END_PERF_FORMAT=6998289.162494155
###############################################################################
################################## 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 3142 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.05s
tree_stats_numInternalsAtDepth=1 1 8 55 415 3142 24247 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 189123
tree_stats_numNodesAtDepth=1 1 8 55 415 3142 24247 189123
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 999341
tree_stats_avgDegreeAtDepth=1 8 6.875 7.54545 7.57108 7.71706 7.79985 5.28408
tree_stats_height=8
tree_stats_numInternals=27869
tree_stats_numLeaves=189123
tree_stats_numNodes=216992
tree_stats_numKeys=999341
tree_stats_avgDegreeInternal=7.78614
tree_stats_avgDegreeLeaves=5.28408
tree_stats_avgDegree=5.60543
tree_stats_avgKeyDepth=7
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0
[2^00, 2^01]: 0
sum_limbo_reclamation_event_size_total=
count_limbo_reclamation_event_size_by_thread=
count_limbo_reclamation_event_size_total=
sum_limbo_reclamation_event_count_total=332448
first_thread_announced_epoch_by_thread=14620 14620 14620 14620 14620 14620 14620 14620 14620 14620 14620 14620 14620 14620 14620 14620 14620 14620 14620 14620 14620 14620 14620 14620 14620 14620 14620 14620 14620 14620 14620 14620 14620 14620 14620 14620 14620 14620 14620 14620 14620 14620 14620 14620 14620 14620 14620 14620
sum_commit_tx_reader_total=145049206
sum_commit_tx_reader_by_thread=0 3014931 3002970 3032248 3039590 3020538 3017994 3025123 2982969 3011260 3014926 3048702 3031736 3045000 2996594 3055867 2980857 2989624 3086516 3048799 3027862 3026933 3000806 3026703 3010526 3030413 2984955 3024175 3005021 3018737 3021300 2987152 3045624 3042076 3011362 3018752 3020704 3020203 3010392 3009611 3006969 2988498 3015565 3031204 3031986 3119258 2991091 3038531 3036553
sum_commit_tx_writer_total=7636711
sum_commit_tx_writer_by_thread=0 158497 158181 160242 160167 159231 158993 159669 157175 158671 158512 160883 159166 160099 157625 161109 156896 157170 162372 160324 159530 159342 157840 158577 158535 159822 157728 159531 158476 159022 159523 156824 159622 160158 159196 159249 159046 159475 158616 157769 157705 157207 159005 159972 159399 163858 157326 160058 159318
sum_abort_tx_total=363
sum_abort_tx_by_thread=0 9 9 5 9 9 4 3 15 5 7 4 13 3 6 6 7 8 5 10 5 9 8 12 8 10 6 5 12 5 8 8 11 6 8 4 9 11 6 12 11 9 8 13 3 5 4 7 3
max_ht_capacity_by_thread=0 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048 2048
linear_histogram_of_none_tx_rdset_size_full_data=28.8:69 35.6:2132 42.4:10778 49.2:19484 56:11420 62.8:3681 69.6:392 76.4:36 83.2:6 90:1
[ 22.00, 28.80]: 69
( 28.80, 35.60]: 2132
( 35.60, 42.40]: 10778
( 42.40, 49.20]: 19484
( 49.20, 56.00]: 11420
( 56.00, 62.80]: 3681
( 62.80, 69.60]: 392
( 69.60, 76.40]: 36
( 76.40, 83.20]: 6
( 83.20, 90.00]: 1
linear_histogram_of_none_tx_wrset_size_full_data=24.5:47316 47:5 69.5:173 92:437 137:57 182:10 227:1
[ 2.00, 24.50]: 47316
( 24.50, 47.00]: 5
( 47.00, 69.50]: 173
( 69.50, 92.00]: 437
( 114.50, 137.00]: 57
( 159.50, 182.00]: 10
( 204.50, 227.00]: 1
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=
sum_abtree_erase_repeat_total=
sum_abtree_search_repeat_total=
sum_abtree_search_complete_total=
sum_abtree_fix_weight_viol_attempt_total=
sum_abtree_fix_degree_viol_attempt_total=
sum_abtree_rebalancing_kcas_attempt_total=
sum_abtree_update_kcas_attempt_total=
sum_abtree_internal_complex_search_while_iters_total=
sum_abtree_internal_basic_search_while_iters_total=
sum_kcas_desc_new_total=
sum_num_inserts_by_thread=159130 157042 156864 159870 159524 157169 156806 160229 159273 160147 158539 159108 156790 159206 159729 158630 158875 159718 162287 159590 158266 158821 159972 158948 157536 159102 159527 160434 159313 158549 157640 159468 159783 161071 159910 157433 159513 158482 159248 160380 160493 158648 157023 158864 158496 164605 158153 158412
sum_num_inserts_total=7636616
sum_num_deletes_by_thread=158514 156764 157106 158900 160482 157064 157937 160097 160100 159376 157765 158861 157877 159442 159211 158427 159526 158674 162278 159509 158048 158261 158563 159348 157336 159869 159797 161393 158601 158519 157817 159759 159345 161111 160107 158418 159463 158648 158849 159962 159740 159691 156948 158104 158667 163754 158152 158611
sum_num_deletes_total=7634791
sum_num_searches_by_thread=2860115 2826338 2830006 2872132 2871170 2832561 2827940 2878263 2868019 2885723 2851076 2868306 2833750 2865058 2871295 2856381 2859600 2852166 2924323 2872286 2848360 2846415 2861143 2856274 2830833 2865821 2876547 2887758 2861855 2852863 2838762 2873263 2883106 2894794 2879740 2842795 2861847 2862620 2867183 2884757 2888890 2858648 2823782 2852093 2856265 2954757 2844846 2851985
sum_num_searches_total=137414510
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=3177759 3140144 3143976 3190902 3191176 3146794 3142683 3198589 3187392 3205246 3167380 3186275 3148417 3183706 3190235 3173438 3178001 3170558 3248888 3191385 3164674 3163497 3179678 3174570 3145705 3184792 3195871 3209585 3179769 3169931 3154219 3192490 3202234 3216976 3199757 3158646 3180823 3179750 3185280 3205099 3209123 3176987 3137753 3169061 3173428 3283116 3161151 3169008
average_num_operations_total=3180956
stdev_num_operations_total=3924
sum_num_operations_total=152685917
min_num_operations_total=3137753
max_num_operations_total=3283116
first_time_thread_terminate_by_thread=10000151 10000151 10000152 10000151 10000151 10000151 10000151 10000151 10000151 10000151 10000151 10000151 10000151 10000151 10000151 10000152 10000151 10000152 10000151 10000151 10000151 10000151 10000151 10000152 10000151 10000151 10000152 10000151 10000151 10000152 10000151 10000151 10000151 10000151 10000151 10000151 10000151 10000151 10000151 10000152 10000151 10000151 10000151 10000151 10000151 10000152 10000151 10000152
min_time_thread_terminate_total=10000151
max_time_thread_terminate_total=10000152
first_time_thread_start_by_thread=5 4 4 5 4 4 4 4 5 4 4 5 4 5 4 4 4 4 4 5 4 4 4 4 5 4 4 5 4 4 4 4 5 4 4 5 4 5 4 4 4 4 4 5 4 4 4 4
min_time_thread_start_total=4
max_time_thread_start_total=5
sum_duration_all_ops_total=
threads_final_keysum=999234267327
threads_final_size=999341
final_keysum=999234267327
final_size=999341
validate_result=success
Validation OK.
Structural validation OK.
total_find=137414510
total_rq=0
total_inserts=7636616
total_deletes=7634791
total_updates=15271407
total_queries=137414510
total_ops=152685917
find_throughput=13741451
rq_throughput=0
update_throughput=1527140
query_throughput=13741451
total_throughput=15268591
total find : 137414510
total rq : 0
total inserts : 7636616
total deletes : 7634791
total updates : 15271407
total queries : 137414510
total ops : 152685917
find throughput : 13741451
rq throughput : 0
update throughput : 1527140
query throughput : 13741451
total throughput : 15268591
elapsed milliseconds : 10000
napping milliseconds overtime : 0
PAPI_L2_TCM=16.9368
PAPI_L3_TCM=1.33288
PAPI_TOT_CYC=7094.1
PAPI_TOT_INS=5503.35
garbage=68527223688887
total_execution_walltime=14.606s
REALTIME_MAIN_END_PERF_FORMAT=6998289.472209743
noREC system shutdown:
[time_cmd_output] time_elapsed_sec=14.74, faults_major=0, faults_minor=135170, mem_maxresident_kb=541588, user_cputime=676.44, sys_cputime=35.17, percent_cpu=4825%
timeout=false
algorithm=brown_abtree_tm_auto.debra.norec
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=2