__step=000129
__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 64 -nprefill 64 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 2000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000129.txt
__path_data=data/data000129.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=221420.843287267
binary=./brown_abtree_tm_auto.debra.norec
parsed custom binding: 0-63,128-191,64-127,192-255
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=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=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,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=314049 prefilling_elapsed_millis=1s
prefilling_size=339195 prefilling_elapsed_millis=1.101s
prefilling_size=363464 prefilling_elapsed_millis=1.201s
prefilling_size=386571 prefilling_elapsed_millis=1.301s
prefilling_size=408822 prefilling_elapsed_millis=1.401s
prefilling_size=430159 prefilling_elapsed_millis=1.501s
prefilling_size=450577 prefilling_elapsed_millis=1.601s
prefilling_size=470371 prefilling_elapsed_millis=1.701s
prefilling_size=489703 prefilling_elapsed_millis=1.801s
prefilling_size=507979 prefilling_elapsed_millis=1.901s
prefilling_size=525632 prefilling_elapsed_millis=2.002s
prefilling_size=542553 prefilling_elapsed_millis=2.102s
prefilling_size=559000 prefilling_elapsed_millis=2.202s
prefilling_size=575233 prefilling_elapsed_millis=2.302s
prefilling_size=590628 prefilling_elapsed_millis=2.402s
prefilling_size=605701 prefilling_elapsed_millis=2.502s
prefilling_size=620068 prefilling_elapsed_millis=2.602s
prefilling_size=634124 prefilling_elapsed_millis=2.702s
prefilling_size=647569 prefilling_elapsed_millis=2.802s
prefilling_size=660606 prefilling_elapsed_millis=2.903s
prefilling_size=672997 prefilling_elapsed_millis=3.003s
prefilling_size=685144 prefilling_elapsed_millis=3.103s
prefilling_size=696780 prefilling_elapsed_millis=3.204s
prefilling_size=707964 prefilling_elapsed_millis=3.304s
prefilling_size=718863 prefilling_elapsed_millis=3.404s
prefilling_size=729017 prefilling_elapsed_millis=3.504s
prefilling_size=738718 prefilling_elapsed_millis=3.604s
prefilling_size=748409 prefilling_elapsed_millis=3.704s
prefilling_size=757707 prefilling_elapsed_millis=3.804s
prefilling_size=766995 prefilling_elapsed_millis=3.904s
prefilling_size=775649 prefilling_elapsed_millis=4.004s
prefilling_size=783690 prefilling_elapsed_millis=4.105s
prefilling_size=791713 prefilling_elapsed_millis=4.205s
prefilling_size=799335 prefilling_elapsed_millis=4.305s
prefilling_size=806886 prefilling_elapsed_millis=4.405s
prefilling_size=814248 prefilling_elapsed_millis=4.505s
prefilling_size=821084 prefilling_elapsed_millis=4.605s
prefilling_size=827712 prefilling_elapsed_millis=4.705s
prefilling_size=833980 prefilling_elapsed_millis=4.805s
prefilling_size=839877 prefilling_elapsed_millis=4.905s
prefilling_size=845700 prefilling_elapsed_millis=5.005s
Info: prefilling requires an additional insert phase to complete.
Info: prefilling using INSERTION ONLY.
timing_start inserting 154275 keys with 64 threads...
tid=0 thread_prefill_amount=12500 percent_done_estimate=518.6 elapsed_s=5 est_remaining_s=-9 / -4
timing_elapsed 0.370636s
prefilling_size=1000000 prefilling_elapsed_millis=0.389s
finished prefilling to size 1000000 for expected size 1000000 keysum=1000046673308, performing 4017877 updates; total_prefilling_elapsed_ms=389 ms)
pref_size=1000000
pref_millis=389
prefill_elapsed_ms=389
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=221426.394872314
REALTIME_END_PERF_FORMAT=221436.394940656
###############################################################################
################################## TIME IS UP #################################
###############################################################################
joining threads...
###############################################################################
################################# END RUNNING #################################
###############################################################################
10.1s
PRODUCING OUTPUT
computing tree_stats in PARALLEL...
bounded depth BFS to partition into subtrees for parallel computation (64 threads)...
partitioned into 418 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.031s
tree_stats_numInternalsAtDepth=1 1 8 60 418 3140 24454 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 190048
tree_stats_numNodesAtDepth=1 1 8 60 418 3140 24454 190048
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 1001408
tree_stats_avgDegreeAtDepth=1 8 7.5 6.96667 7.51196 7.7879 7.77165 5.26924
tree_stats_height=8
tree_stats_numInternals=28082
tree_stats_numLeaves=190048
tree_stats_numNodes=218130
tree_stats_numKeys=1001408
tree_stats_avgDegreeInternal=7.76761
tree_stats_avgDegreeLeaves=5.26924
tree_stats_avgDegree=5.59088
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=372407
first_thread_announced_epoch_by_thread=12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060 12060
sum_commit_tx_reader_total=180306788
sum_commit_tx_reader_by_thread=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 2334064 2288040 2334640 2410864 2311236 2273621 2318307 2344815 2631065 2664985 2630018 2675499 2345377 2642960 2605867 2629109 2588104 2665863 2887326 2829684 2869212 2910887 2843903 2782292 2897587 2830389 2837270 2884168 2311108 2833756 3420385 3382215 3488548 3421858 3309426 3398200 3329105 3411402 2341568 3337114 2717647 2652182 2944811 2443910 2950627 2405539 2754744 3416650 3319854 3345858 3500016 3294171 2630089 2749392 2686837 2755596 2846918 2830926 2857371 3409404 3424890 2438681 2307184 2371654
sum_commit_tx_writer_total=9490420
sum_commit_tx_writer_by_thread=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 122705 120463 122959 126743 121708 119434 121945 123585 138196 140611 137855 141014 123366 139208 136861 138447 135863 139592 152991 148554 150335 152914 148932 146969 152756 149289 149581 151238 121830 149757 180120 178483 183664 179829 173758 179013 174888 179760 123097 176208 143823 139567 155157 128927 155451 126143 144435 179807 174742 175597 184229 173630 138831 144736 140868 144675 149883 149746 149882 180179 180404 127856 122152 125179
sum_abort_tx_total=1127
sum_abort_tx_by_thread=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 17 13 21 15 19 19 20 12 11 18 23 20 17 16 18 16 20 16 13 22 18 27 18 15 24 12 13 13 22 14 14 13 19 23 16 22 19 17 22 18 20 25 15 19 17 19 21 10 14 15 18 16 13 17 16 15 22 17 20 16 15 17 21 24
max_ht_capacity_by_thread=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 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=21.1:2 31.2:590 41.3:13803 51.4:35599 61.5:13298 71.6:634 81.7:50 91.8:18 101.9:4 112:1
[ 11.00, 21.10]: 2
( 21.10, 31.20]: 590
( 31.20, 41.30]: 13803
( 41.30, 51.40]: 35599
( 51.40, 61.50]: 13298
( 61.50, 71.60]: 634
( 71.60, 81.70]: 50
( 81.70, 91.80]: 18
( 91.80, 101.90]: 4
( 101.90, 112.00]: 1
linear_histogram_of_none_tx_wrset_size_full_data=29.7:61249 57.4:10 85.1:2391 112.8:1 140.5:314 195.9:28 251.3:6
[ 2.00, 29.70]: 61249
( 29.70, 57.40]: 10
( 57.40, 85.10]: 2391
( 85.10, 112.80]: 1
( 112.80, 140.50]: 314
( 168.20, 195.90]: 28
( 223.60, 251.30]: 6
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=122014 125195 127906 123297 121849 123126 128485 122827 121089 123448 126500 121676 119385 122478 126694 123906 137922 141693 144504 140424 137982 140519 144703 139676 136897 139305 143138 138594 136221 138622 145282 139693 148935 152292 155821 151366 149742 150718 153117 149279 146862 149323 152642 148826 149595 151775 155037 149101 179996 180387 184424 180173 177768 179984 183890 180482 173418 173853 178500 174448 174570 175649 179810 176272
sum_num_inserts_total=9493105
sum_num_deletes_by_thread=121728 124869 127676 123193 121332 123543 128711 123317 119879 122907 127124 121652 119457 121569 126348 123414 138902 140898 144575 140413 138435 140962 145007 139167 137186 140062 143716 138097 136317 138318 144531 139980 148546 152475 154718 150593 149877 149794 153322 149993 146798 149713 152399 148598 149587 151197 155555 149795 179895 180453 183737 180043 178580 179661 182906 179668 173333 174427 178775 174169 175400 175915 179723 175741
sum_num_deletes_total=9488671
sum_num_searches_by_thread=2185594 2246769 2310955 2218175 2189757 2222074 2315641 2210625 2167535 2211244 2283983 2189616 2154213 2196205 2278640 2221080 2492437 2545114 2605049 2524759 2491456 2535032 2609469 2503325 2468645 2512382 2574616 2490865 2451429 2491980 2610458 2525782 2680757 2735550 2789429 2717588 2697182 2706741 2757362 2681400 2635601 2693799 2745302 2682254 2687669 2732434 2795486 2684617 3229692 3244454 3316084 3240289 3204350 3236812 3305416 3241537 3121050 3134904 3219938 3155376 3144626 3169891 3231629 3161309
sum_num_searches_total=170815432
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=2429336 2496833 2566537 2464665 2432938 2468743 2572837 2456769 2408503 2457599 2537607 2432944 2393055 2440252 2531682 2468400 2769261 2827705 2894128 2805596 2767873 2816513 2899179 2782168 2742728 2791749 2861470 2767556 2723967 2768920 2900271 2805455 2978238 3040317 3099968 3019547 2996801 3007253 3063801 2980672 2929261 2992835 3050343 2979678 2986851 3035406 3106078 2983513 3589583 3605294 3684245 3600505 3560698 3596457 3672212 3601687 3467801 3483184 3577213 3503993 3494596 3521455 3591162 3513322
average_num_operations_total=2965581
stdev_num_operations_total=50924
sum_num_operations_total=189797208
min_num_operations_total=2393055
max_num_operations_total=3684245
first_time_thread_terminate_by_thread=10000111 10000070 10000070 10000069 10000069 10000075 10000069 10000069 10000071 10000071 10000071 10000071 10000073 10000073 10000073 10000073 10000072 10000072 10000072 10000072 10000071 10000071 10000071 10000072 10000071 10000072 10000071 10000072 10000069 10000069 10000069 10000069 10000071 10000071 10000071 10000071 10000074 10000070 10000070 10000070 10000073 10000073 10000069 10000069 10000070 10000074 10000068 10000068 10000072 10000070 10000070 10000070 10000068 10000068 10000068 10000071 10000070 10000071 10000070 10000071 10000073 10000072 10000072 10000072
min_time_thread_terminate_total=10000068
max_time_thread_terminate_total=10000111
first_time_thread_start_by_thread=5 2 2 2 5 5 5 5 3 3 3 3 5 5 5 5 4 4 4 4 5 5 5 5 3 3 3 3 4 4 4 4 5 5 5 5 6 6 6 6 6 6 6 6 6 6 6 6 5 5 5 5 4 4 4 4 3 3 3 3 4 4 4 4
min_time_thread_start_total=2
max_time_thread_start_total=6
sum_duration_all_ops_total=
threads_final_keysum=1002093582959
threads_final_size=1001408
final_keysum=1002093582959
final_size=1001408
validate_result=success
Validation OK.
Structural validation OK.
total_find=170815432
total_rq=0
total_inserts=9493105
total_deletes=9488671
total_updates=18981776
total_queries=170815432
total_ops=189797208
find_throughput=17081543
rq_throughput=0
update_throughput=1898177
query_throughput=17081543
total_throughput=18979720
total find : 170815432
total rq : 0
total inserts : 9493105
total deletes : 9488671
total updates : 18981776
total queries : 170815432
total ops : 189797208
find throughput : 17081543
rq throughput : 0
update throughput : 1898177
query throughput : 17081543
total throughput : 18979720
elapsed milliseconds : 10000
napping milliseconds overtime : 100
garbage=19485602334985
total_execution_walltime=15.846s
REALTIME_MAIN_END_PERF_FORMAT=221436.690171555
noREC system shutdown:
[time_cmd_output] time_elapsed_sec=15.96, faults_major=0, faults_minor=136405, mem_maxresident_kb=543348, user_cputime=978.36, sys_cputime=17.77, percent_cpu=6239%
timeout=false
algorithm=brown_abtree_tm_auto.debra.norec
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1