__step=000297
__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=data000297.txt
__path_data=data/data000297.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6998260.262389790
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.008s
prefilling_size=640378 prefilling_elapsed_millis=1.001s
prefilling_size=676124 prefilling_elapsed_millis=1.101s
prefilling_size=708368 prefilling_elapsed_millis=1.201s
prefilling_size=736608 prefilling_elapsed_millis=1.301s
prefilling_size=762727 prefilling_elapsed_millis=1.402s
prefilling_size=785851 prefilling_elapsed_millis=1.502s
prefilling_size=807296 prefilling_elapsed_millis=1.602s
prefilling_size=825913 prefilling_elapsed_millis=1.702s
prefilling_size=842830 prefilling_elapsed_millis=1.802s
prefilling_size=858399 prefilling_elapsed_millis=1.902s
prefilling_size=872663 prefilling_elapsed_millis=2.003s
prefilling_size=885611 prefilling_elapsed_millis=2.103s
prefilling_size=897346 prefilling_elapsed_millis=2.203s
prefilling_size=908320 prefilling_elapsed_millis=2.303s
prefilling_size=917515 prefilling_elapsed_millis=2.403s
prefilling_size=925990 prefilling_elapsed_millis=2.504s
prefilling_size=933477 prefilling_elapsed_millis=2.604s
prefilling_size=940305 prefilling_elapsed_millis=2.704s
prefilling_size=946175 prefilling_elapsed_millis=2.804s
prefilling_size=951616 prefilling_elapsed_millis=2.904s
prefilling_size=956095 prefilling_elapsed_millis=3.005s
prefilling_size=960246 prefilling_elapsed_millis=3.105s
prefilling_size=964156 prefilling_elapsed_millis=3.205s
prefilling_size=967852 prefilling_elapsed_millis=3.305s
prefilling_size=971182 prefilling_elapsed_millis=3.405s
prefilling_size=974281 prefilling_elapsed_millis=3.506s
prefilling_size=976852 prefilling_elapsed_millis=3.606s
prefilling_size=979001 prefilling_elapsed_millis=3.706s
prefilling_size=981306 prefilling_elapsed_millis=3.806s
finished prefilling to size 981307 for expected size 1000000 keysum=980669451544, performing 7951208 updates; total_prefilling_elapsed_ms=3907 ms)
pref_size=981307
pref_millis=3907
prefill_elapsed_ms=3929
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=6998264.370026177
REALTIME_END_PERF_FORMAT=6998274.370166811
###############################################################################
################################## 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 3110 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.06s
tree_stats_numInternalsAtDepth=1 1 8 57 423 3110 24242 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 189007
tree_stats_numNodesAtDepth=1 1 8 57 423 3110 24242 189007
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 999243
tree_stats_avgDegreeAtDepth=1 8 7.125 7.42105 7.35225 7.79486 7.79668 5.2868
tree_stats_height=8
tree_stats_numInternals=27842
tree_stats_numLeaves=189007
tree_stats_numNodes=216849
tree_stats_numKeys=999243
tree_stats_avgDegreeInternal=7.78856
tree_stats_avgDegreeLeaves=5.2868
tree_stats_avgDegree=5.60801
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=330432
first_thread_announced_epoch_by_thread=14518 14518 14518 14518 14518 14518 14518 14518 14518 14518 14518 14518 14518 14518 14518 14518 14518 14518 14518 14518 14518 14518 14518 14518 14518 14518 14518 14518 14518 14518 14518 14518 14518 14518 14518 14518 14518 14518 14518 14518 14518 14518 14518 14518 14518 14518 14518 14518
sum_commit_tx_reader_total=144577229
sum_commit_tx_reader_by_thread=0 2980667 2991398 3012805 3021511 2970368 3015523 3041387 3014463 3025890 3017968 2985447 3009337 3011585 3012132 3028477 2999283 2996942 3033960 2977406 2999582 3024540 3018020 2999903 3035257 3035441 2992335 3032746 2998341 3008017 3008019 3018959 3027566 3012218 3004827 3094421 3032823 3029513 3046882 2962776 3013361 3029118 2997739 2985691 3029064 2985009 2956115 3015163 3037234
sum_commit_tx_writer_total=7604512
sum_commit_tx_writer_by_thread=0 156661 157181 158889 159427 156215 158521 160363 158239 159495 158914 158080 158244 158249 158167 158961 157260 157747 159717 156560 157836 159354 158834 157161 159440 159333 157824 160198 157555 158643 158189 159426 159026 158452 158068 162897 158707 159329 159908 156423 158480 158560 157686 156592 158800 157491 155183 159012 159215
sum_abort_tx_total=409
sum_abort_tx_by_thread=0 11 5 6 8 12 6 8 11 3 13 8 10 10 5 13 11 6 7 10 7 3 9 10 8 6 7 10 8 6 9 12 11 9 12 9 7 12 7 11 7 12 7 11 4 8 5 10 9
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=30.8:218 37.6:3685 44.4:14231 51.2:19476 58:8546 64.8:1763 71.6:63 78.4:13 85.2:4
[ 24.00, 30.80]: 218
( 30.80, 37.60]: 3685
( 37.60, 44.40]: 14231
( 44.40, 51.20]: 19476
( 51.20, 58.00]: 8546
( 58.00, 64.80]: 1763
( 64.80, 71.60]: 63
( 71.60, 78.40]: 13
( 78.40, 85.20]: 4
linear_histogram_of_none_tx_wrset_size_full_data=24.4:47324 46.8:3 69.2:149 91.6:457 136.4:61 181.2:3 226:1
[ 2.00, 24.40]: 47324
( 24.40, 46.80]: 3
( 46.80, 69.20]: 149
( 69.20, 91.60]: 457
( 114.00, 136.40]: 61
( 158.80, 181.20]: 3
( 203.60, 226.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=158384 158232 158544 157417 157787 156708 157600 160116 159413 159033 158593 156017 155701 158785 158463 159732 159031 157840 157553 159036 158589 158434 158067 157432 157226 159071 159148 159888 158485 157119 157649 159524 158651 159622 157947 162714 158645 159492 159345 158131 159275 156505 159681 158733 158512 158999 157463 155995
sum_num_inserts_total=7604327
sum_num_deletes_by_thread=158261 157958 158486 157343 157523 156779 157454 160280 160239 159726 158685 155961 155264 158834 158605 158649 158688 156975 157679 160070 158578 158271 158079 157504 157533 159292 159382 159207 158091 156569 157862 160497 159593 159656 157897 163081 158607 159247 158779 158733 159269 156375 159995 158503 159042 158607 157968 156590
sum_num_deletes_total=7606266
sum_num_searches_by_thread=2846250 2851391 2853269 2841783 2842108 2820479 2842010 2886394 2873292 2876015 2854416 2814605 2800333 2856556 2849140 2867004 2859163 2828712 2839457 2875591 2859687 2855997 2853688 2835223 2827741 2862575 2869334 2877354 2850084 2828595 2833068 2881729 2860141 2867314 2840052 2931523 2853418 2868699 2873406 2854977 2870298 2806319 2874001 2856808 2866340 2870072 2839994 2824743
sum_num_searches_total=136971148
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=3162895 3167581 3170299 3156543 3157418 3133966 3157064 3206790 3192944 3194774 3171694 3126583 3111298 3174175 3166208 3185385 3176882 3143527 3154689 3194697 3176854 3172702 3169834 3150159 3142500 3180938 3187864 3196449 3166660 3142283 3148579 3201750 3178385 3186592 3155896 3257318 3170670 3187438 3191530 3171841 3188842 3119199 3193677 3174044 3183894 3187678 3155425 3137328
average_num_operations_total=3170452
stdev_num_operations_total=3707
sum_num_operations_total=152181741
min_num_operations_total=3111298
max_num_operations_total=3257318
first_time_thread_terminate_by_thread=10000140 10000141 10000142 10000141 10000141 10000141 10000141 10000141 10000141 10000140 10000141 10000140 10000140 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000140 10000142 10000141 10000141 10000141 10000141 10000142 10000140 10000141 10000141 10000141 10000141 10000141 10000140 10000141 10000140 10000141 10000141 10000141 10000141 10000140 10000141 10000141 10000140 10000140 10000142 10000141 10000141
min_time_thread_terminate_total=10000140
max_time_thread_terminate_total=10000142
first_time_thread_start_by_thread=4 4 5 5 5 5 4 4 5 4 5 4 5 5 4 5 4 4 5 5 4 4 5 4 4 4 5 5 5 5 4 4 5 4 5 4 5 5 4 5 4 4 5 5 4 4 5 4
min_time_thread_start_total=4
max_time_thread_start_total=5
sum_duration_all_ops_total=
threads_final_keysum=999174795276
threads_final_size=999243
final_keysum=999174795276
final_size=999243
validate_result=success
Validation OK.
Structural validation OK.
total_find=136971148
total_rq=0
total_inserts=7604327
total_deletes=7606266
total_updates=15210593
total_queries=136971148
total_ops=152181741
find_throughput=13697114
rq_throughput=0
update_throughput=1521059
query_throughput=13697114
total_throughput=15218174
total find : 136971148
total rq : 0
total inserts : 7604327
total deletes : 7606266
total updates : 15210593
total queries : 136971148
total ops : 152181741
find throughput : 13697114
rq throughput : 0
update throughput : 1521059
query throughput : 13697114
total throughput : 15218174
elapsed milliseconds : 10000
napping milliseconds overtime : 0
PAPI_L2_TCM=17.0497
PAPI_L3_TCM=1.33395
PAPI_TOT_CYC=7107
PAPI_TOT_INS=5569.97
garbage=68324133782425
total_execution_walltime=14.42s
REALTIME_MAIN_END_PERF_FORMAT=6998274.683363504
noREC system shutdown:
[time_cmd_output] time_elapsed_sec=14.55, faults_major=0, faults_minor=134804, mem_maxresident_kb=540240, user_cputime=665.23, sys_cputime=35.67, percent_cpu=4815%
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=1