__step=000209
__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_int_avl_tm_auto.debra.norec -nwork 64 -nprefill 64 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 200000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000209.txt
__path_data=data/data000209.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=222399.20982037
binary=./brown_sigouin_int_avl_tm_auto.debra.norec
parsed custom binding: 0-63,128-191,64-127,192-255
DS_TYPENAME=brown_sigouin_int_avl_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=200000
PREFILL_THREADS=64
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=64
WORK_THREADS=64
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=48
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
noREC system ready
Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.022s
prefilling_size=99885 prefilling_elapsed_millis=1s
finished prefilling to size 99892 for expected size 100000 keysum=9990303645, performing 1349221 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=99892
pref_millis=1101
prefill_elapsed_ms=1113
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=222400.170840350
REALTIME_END_PERF_FORMAT=222410.170926275
###############################################################################
################################## 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 1024 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.063s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4095 8104 14189 16491 8895 1616 72 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 1 81 1753 9602 17895 11157 2055 92
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8185 15942 26093 26790 12773 2127 92
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8185 15942 26093 26790 12773 2127 92
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 1.99854 1.95761 1.74671 1.3947 1.14476 1.04001 1.0094 1
tree_stats_height=20
tree_stats_numInternals=57557
tree_stats_numLeaves=42636
tree_stats_numNodes=100193
tree_stats_numKeys=100193
tree_stats_avgDegreeInternal=1.74076
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.42554
tree_stats_avgKeyDepth=14.9403
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=327808
first_thread_announced_epoch_by_thread=10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336 10336
sum_commit_tx_reader_total=150986437
sum_commit_tx_reader_by_thread=0 2379052 2068004 2147542 2057169 2217697 2346361 2324344 2388940 2732484 2080069 2310213 2763465 2194891 2242187 2034041 2310470 2908516 2119032 2080511 2322650 2781564 2658434 2848654 2777005 2765800 2219863 2114469 2041157 2247638 2180558 2112072 2211315 3100868 2211629 2806360 2222481 2207658 2162394 2243529 2204339 2208429 2037781 2246869 2304243 2769747 2078403 3035573 2274161 2314765 2067888 2747815 2203862 2316619 2043836 2039840 2857447 2291284 2217442 2769315 2216624 2903809 2258773 2255728 2380759
sum_commit_tx_writer_total=7948477
sum_commit_tx_writer_by_thread=0 125373 108578 113100 108337 116767 122984 122486 125638 144113 110061 121354 145266 115516 117755 107470 121281 152846 111877 109633 121721 146502 139628 149323 146225 146248 116812 111298 107518 118055 115329 110938 116074 162826 115601 148428 116477 116306 113906 118384 116464 116132 107052 118739 121510 145994 109582 160074 120522 122317 108836 144928 116035 122162 107374 107141 150549 120391 116594 145804 116380 152850 119163 118665 125185
sum_abort_tx_total=23378
sum_abort_tx_by_thread=0 350 355 371 368 387 377 331 399 336 374 379 344 364 373 370 361 372 377 354 408 373 327 334 317 384 340 389 382 413 415 367 354 359 414 307 352 382 339 411 364 324 402 364 367 330 367 352 389 360 374 311 384 357 399 361 352 384 375 358 368 312 340 378 397
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 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=17.5:43 27:1225 36.5:46463 46:14692 55.5:1381 65:153 74.5:36 84:6
[ 8.00, 17.50]: 43
( 17.50, 27.00]: 1225
( 27.00, 36.50]: 46463
( 36.50, 46.00]: 14692
( 46.00, 55.50]: 1381
( 55.50, 65.00]: 153
( 65.00, 74.50]: 36
( 74.50, 84.00]: 6
linear_histogram_of_none_tx_wrset_size_full_data=3.5:19387 6:4034 8.5:12202 11:8312 13.5:9579 16:5668 18.5:3795 21:182 23.5:810 26:29
[ 1.00, 3.50]: 19387
( 3.50, 6.00]: 4034
( 6.00, 8.50]: 12202
( 8.50, 11.00]: 8312
( 11.00, 13.50]: 9579
( 13.50, 16.00]: 5668
( 16.00, 18.50]: 3795
( 18.50, 21.00]: 182
( 21.00, 23.50]: 810
( 23.50, 26.00]: 29
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=122975 125618 124983 122419 116371 118273 121882 119706 121385 118809 119178 124930 118321 116025 116336 113810 111267 111839 115209 108369 111014 112694 109733 108674 106867 109670 106778 107830 107336 109023 109837 106879 146300 161958 150192 146077 139482 145806 145890 146411 147909 145475 144593 144023 153024 149758 152609 160528 118369 116177 115635 116550 120179 122280 116479 116783 116044 121151 122329 116343 116544 122063 117913 116856
sum_num_inserts_total=7945770
sum_num_deletes_by_thread=123228 125815 125369 122128 115964 118678 122221 120555 120800 118737 118805 125586 118461 115879 116625 113582 111719 110801 115486 108450 110607 113026 109939 108352 106749 109877 107658 107343 107067 108805 109476 107393 146007 163563 150253 145488 139781 146213 145448 146498 148189 144910 145012 144078 153035 149541 152688 159445 118382 116034 116187 116218 120261 121708 116775 116734 115651 121158 121717 115701 116683 121704 118152 116468
sum_num_deletes_total=7944863
sum_num_searches_by_thread=2223142 2263145 2254073 2202283 2091629 2128657 2192979 2154422 2189382 2136847 2139953 2255428 2128911 2095326 2100043 2048908 2007923 2003127 2065192 1948687 2001389 2034922 1970458 1959556 1927895 1970597 1930397 1933502 1932578 1958896 1968672 1936938 2630923 2938173 2707551 2623554 2518799 2620029 2624403 2635157 2658690 2618346 2603138 2588496 2755303 2698678 2751362 2875674 2125162 2092350 2095567 2088035 2171235 2200383 2101210 2103158 2078712 2183444 2194735 2087853 2100809 2187984 2123877 2105634
sum_num_searches_total=143044281
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=2469345 2514578 2504425 2446830 2323964 2365608 2437082 2394683 2431567 2374393 2377936 2505944 2365693 2327230 2333004 2276300 2230909 2225767 2295887 2165506 2223010 2260642 2190130 2176582 2141511 2190144 2144833 2148675 2146981 2176724 2187985 2151210 2923230 3263694 3007996 2915119 2798062 2912048 2915741 2928066 2954788 2908731 2892743 2876597 3061362 2997977 3056659 3195647 2361913 2324561 2327389 2320803 2411675 2444371 2334464 2336675 2310407 2425753 2438781 2319897 2334036 2431751 2359942 2338958
average_num_operations_total=2483358
stdev_num_operations_total=38673
sum_num_operations_total=158934914
min_num_operations_total=2141511
max_num_operations_total=3263694
first_time_thread_terminate_by_thread=10000096 10000091 10000090 10000090 10000088 10000088 10000090 10000088 10000086 10000086 10000086 10000086 10000092 10000092 10000092 10000092 10000092 10000092 10000094 10000092 10000090 10000089 10000095 10000090 10000092 10000095 10000092 10000092 10000094 10000094 10000094 10000094 10000090 10000090 10000087 10000090 10000089 10000089 10000089 10000089 10000089 10000089 10000087 10000095 10000088 10000088 10000088 10000088 10000093 10000093 10000093 10000093 10000089 10000089 10000089 10000092 10000092 10000092 10000092 10000092 10000093 10000093 10000093 10000093
min_time_thread_terminate_total=10000086
max_time_thread_terminate_total=10000096
first_time_thread_start_by_thread=16 22 22 22 2 2 2 2 3 3 3 3 3 3 3 3 3 3 3 3 6 16 6 6 15 4 4 4 2 2 2 2 3 3 3 3 17 17 24 4 3 3 3 3 16 16 27 24 6 18 6 5 27 13 14 13 12 12 22 22 16 15 14 15
min_time_thread_start_total=2
max_time_thread_start_total=27
sum_duration_all_ops_total=
threads_final_keysum=10027087713
threads_final_size=100193
final_keysum=10027087713
final_size=100193
validate_result=success
Validation OK.
Structural validation OK.
total_find=143044281
total_rq=0
total_inserts=7945770
total_deletes=7944863
total_updates=15890633
total_queries=143044281
total_ops=158934914
find_throughput=14304428
rq_throughput=0
update_throughput=1589063
query_throughput=14304428
total_throughput=15893491
total find : 143044281
total rq : 0
total inserts : 7945770
total deletes : 7944863
total updates : 15890633
total queries : 143044281
total ops : 158934914
find throughput : 14304428
rq throughput : 0
update throughput : 1589063
query throughput : 14304428
total throughput : 15893491
elapsed milliseconds : 10000
napping milliseconds overtime : 0
garbage=2466765350061
total_execution_walltime=11.383s
REALTIME_MAIN_END_PERF_FORMAT=222410.405025346
noREC system shutdown:
[time_cmd_output] time_elapsed_sec=11.49, faults_major=0, faults_minor=127720, mem_maxresident_kb=511008, user_cputime=718.18, sys_cputime=15.56, percent_cpu=6382%
timeout=false
algorithm=brown_sigouin_int_avl_tm_auto.debra.norec
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1