__step=000107
__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.tl2 -nwork 96 -nprefill 96 -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=data000107.txt
__path_data=data/data000107.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6995484.84393701
binary=./brown_abtree_tm_auto.debra.tl2
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=20000000
PREFILL_THREADS=96
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=96
WORK_THREADS=96
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,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,120,121,122,123,124,125,126,127,128,129,130,131,132,133,134,135,136,137,138,139,140,141,142,143


TL2 system ready: GV=GV4
Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.015s
prefilling_size=3621715 prefilling_elapsed_millis=1.001s
prefilling_size=3927120 prefilling_elapsed_millis=1.101s
prefilling_size=4218469 prefilling_elapsed_millis=1.201s
prefilling_size=4496191 prefilling_elapsed_millis=1.301s
prefilling_size=4763012 prefilling_elapsed_millis=1.402s
prefilling_size=5013177 prefilling_elapsed_millis=1.502s
prefilling_size=5256069 prefilling_elapsed_millis=1.602s
prefilling_size=5487504 prefilling_elapsed_millis=1.702s
prefilling_size=5707006 prefilling_elapsed_millis=1.803s
prefilling_size=5915273 prefilling_elapsed_millis=1.903s
prefilling_size=6114632 prefilling_elapsed_millis=2.003s
prefilling_size=6305216 prefilling_elapsed_millis=2.103s
prefilling_size=6486733 prefilling_elapsed_millis=2.203s
prefilling_size=6659984 prefilling_elapsed_millis=2.304s
prefilling_size=6823677 prefilling_elapsed_millis=2.404s
prefilling_size=6978938 prefilling_elapsed_millis=2.504s
prefilling_size=7127626 prefilling_elapsed_millis=2.604s
prefilling_size=7268700 prefilling_elapsed_millis=2.704s
prefilling_size=7404155 prefilling_elapsed_millis=2.805s
prefilling_size=7531956 prefilling_elapsed_millis=2.905s
prefilling_size=7654858 prefilling_elapsed_millis=3.005s
prefilling_size=7771679 prefilling_elapsed_millis=3.105s
prefilling_size=7881495 prefilling_elapsed_millis=3.205s
prefilling_size=7985956 prefilling_elapsed_millis=3.306s
prefilling_size=8086171 prefilling_elapsed_millis=3.406s
prefilling_size=8180033 prefilling_elapsed_millis=3.506s
prefilling_size=8270877 prefilling_elapsed_millis=3.606s
prefilling_size=8356419 prefilling_elapsed_millis=3.706s
prefilling_size=8438058 prefilling_elapsed_millis=3.807s
prefilling_size=8515946 prefilling_elapsed_millis=3.907s
prefilling_size=8588500 prefilling_elapsed_millis=4.007s
prefilling_size=8658224 prefilling_elapsed_millis=4.107s
prefilling_size=8724908 prefilling_elapsed_millis=4.207s
prefilling_size=8788752 prefilling_elapsed_millis=4.308s
prefilling_size=8848645 prefilling_elapsed_millis=4.408s
prefilling_size=8905473 prefilling_elapsed_millis=4.508s
prefilling_size=8960219 prefilling_elapsed_millis=4.608s
prefilling_size=9012492 prefilling_elapsed_millis=4.708s
prefilling_size=9061845 prefilling_elapsed_millis=4.809s
prefilling_size=9108582 prefilling_elapsed_millis=4.909s
prefilling_size=9153144 prefilling_elapsed_millis=5.009s
Info: prefilling requires an additional insert phase to complete.
Info: prefilling using INSERTION ONLY.
timing_start inserting 846779 keys with 96 threads...
tid=0 thread_prefill_amount=91652 percent_done_estimate=1039.1 elapsed_s=5 est_remaining_s=-10 / -5
tid=0 thread_prefill_amount=93735 percent_done_estimate=1062.7 elapsed_s=5 est_remaining_s=-11 / -5
tid=0 thread_prefill_amount=95818 percent_done_estimate=1086.3 elapsed_s=5 est_remaining_s=-11 / -5
tid=0 thread_prefill_amount=97901 percent_done_estimate=1109.9 elapsed_s=5 est_remaining_s=-11 / -6
timing_elapsed 0.173093s
prefilling_size=10000000 prefilling_elapsed_millis=0.173s
finished prefilling to size 10000000 for expected size 10000000 keysum=100011080260411, performing 51673860 updates; total_prefilling_elapsed_ms=173 ms)
pref_size=10000000
pref_millis=173
prefill_elapsed_ms=173
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6995489.588168163
REALTIME_END_PERF_FORMAT=6995499.588239490

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

tree_stats_computeWalltime=0.012s

tree_stats_numInternalsAtDepth=1 1 8 64 476 3567 26857 209429 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 1650920
tree_stats_numNodesAtDepth=1 1 8 64 476 3567 26857 209429 1650920
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 10003478
tree_stats_avgDegreeAtDepth=1 8 8 7.4375 7.4937 7.5293 7.79793 7.88296 6.05934

tree_stats_height=9
tree_stats_numInternals=240403
tree_stats_numLeaves=1650920
tree_stats_numNodes=1891323
tree_stats_numKeys=10003478

tree_stats_avgDegreeInternal=7.8673
tree_stats_avgDegreeLeaves=6.05934
tree_stats_avgDegree=6.28914
tree_stats_avgKeyDepth=8


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=391742
first_thread_announced_epoch_by_thread=9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406 9406
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=
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=186230 187332 188848 188050 187775 185972 186042 188007 188980 189920 187340 187645 186249 187647 188450 189324 187898 187568 186119 187454 187888 188048 186145 185605 185538 186585 187552 188560 187773 185878 187239 187535 188811 190130 187113 187819 187127 187632 189155 188491 188084 186169 185393 186826 188218 188116 187704 186244 184226 185495 187095 186312 185882 184882 184850 185990 187583 187717 185298 184690 185195 185269 187565 186326 186259 184739 184266 184607 187455 186884 185780 185127 183652 185084 187592 186607 185705 185131 185345 186466 187123 187840 186590 185654 185595 185918 186643 186592 186098 184503 184735 184519 186752 187295 186213 184540
sum_num_inserts_total=17921912
sum_num_deletes_by_thread=185736 187338 188436 188159 188787 185863 186609 186879 187915 189846 187251 187680 187373 188162 189407 188769 187476 186635 186044 186925 189287 188792 187576 185803 186366 186969 188249 188500 188335 186000 186186 187445 188228 188874 187441 186650 187634 187470 188462 188218 188066 186390 185433 187299 188156 188491 187840 186181 184074 186416 186771 187241 185634 185376 185508 185327 187503 187222 186794 184506 185320 185589 186586 187299 186272 185208 184034 185252 186218 186198 186800 184903 183882 185861 186173 186478 185183 184968 185060 186097 187429 188065 186793 185734 185239 185806 186580 186841 185902 183929 183400 185369 187448 187227 186725 185142
sum_num_deletes_total=17925013
sum_num_searches_by_thread=3343831 3369324 3388800 3389058 3379546 3346613 3363946 3375081 3389231 3407317 3373975 3363007 3363135 3371527 3399472 3398396 3377483 3364473 3347290 3371354 3390429 3391553 3376047 3349539 3344358 3372763 3392427 3393983 3385196 3349048 3358945 3376517 3402668 3406193 3375451 3364322 3359486 3369278 3399441 3394988 3383283 3356296 3345480 3365159 3395635 3394158 3383018 3357956 3318689 3340386 3363355 3369655 3341596 3332786 3328095 3344871 3372022 3380714 3346796 3327160 3328176 3342490 3362203 3359751 3348249 3316043 3313425 3330094 3352420 3360773 3346394 3319224 3317492 3340345 3362284 3363741 3339649 3337422 3329262 3344440 3373267 3381131 3356507 3329177 3333221 3355216 3360601 3360980 3347159 3320629 3312983 3330162 3359798 3366821 3356413 3334588
sum_num_searches_total=322575131
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=3715797 3743994 3766084 3765267 3756108 3718448 3736597 3749967 3766126 3787083 3748566 3738332 3736757 3747336 3777329 3776489 3752857 3738676 3719453 3745733 3767604 3768393 3749768 3720947 3716262 3746317 3768228 3771043 3761304 3720926 3732370 3751497 3779707 3785197 3750005 3738791 3734247 3744380 3777058 3771697 3759433 3728855 3716306 3739284 3772009 3770765 3758562 3730381 3686989 3712297 3737221 3743208 3713112 3703044 3698453 3716188 3747108 3755653 3718888 3696356 3698691 3713348 3736354 3733376 3720780 3685990 3681725 3699953 3726093 3733855 3718974 3689254 3685026 3711290 3736049 3736826 3710537 3707521 3699667 3717003 3747819 3757036 3729890 3700565 3704055 3726940 3733824 3734413 3719159 3689061 3681118 3700050 3733998 3741343 3729351 3704270
average_num_operations_total=3733563
stdev_num_operations_total=2700
sum_num_operations_total=358422056
min_num_operations_total=3681118
max_num_operations_total=3787083
first_time_thread_terminate_by_thread=10000141 10000071 10000071 10000071 10000073 10000074 10000072 10000073 10000072 10000071 10000074 10000074 10000071 10000073 10000074 10000071 10000073 10000074 10000072 10000074 10000072 10000073 10000071 10000072 10000072 10000071 10000071 10000071 10000071 10000074 10000072 10000073 10000072 10000071 10000074 10000074 10000073 10000073 10000074 10000071 10000071 10000074 10000072 10000074 10000072 10000073 10000071 10000071 10000074 10000073 10000073 10000071 10000072 10000075 10000073 10000072 10000073 10000071 10000071 10000071 10000071 10000072 10000071 10000071 10000072 10000071 10000071 10000071 10000071 10000072 10000071 10000071 10000074 10000073 10000073 10000073 10000073 10000073 10000073 10000072 10000073 10000071 10000071 10000071 10000071 10000072 10000071 10000073 10000072 10000071 10000071 10000074 10000071 10000071 10000071 10000071
min_time_thread_terminate_total=10000071
max_time_thread_terminate_total=10000141
first_time_thread_start_by_thread=10 5 5 5 5 5 5 6 5 5 5 5 5 6 5 5 5 5 5 5 5 6 5 6 4 5 5 5 5 5 5 6 5 5 5 5 5 6 5 5 5 5 5 5 5 6 5 6 5 5 5 5 5 5 5 6 5 5 6 5 5 5 5 5 6 6 5 5 6 6 5 5 5 5 5 5 5 5 5 6 5 5 6 5 5 5 5 5 6 6 5 5 6 6 5 5
min_time_thread_start_total=4
max_time_thread_start_total=10
sum_duration_all_ops_total=

threads_final_keysum=100023707821044
threads_final_size=10003478
final_keysum=100023707821044
final_size=10003478
validate_result=success
Validation OK.
Structural validation OK.

total_find=322575131
total_rq=0
total_inserts=17921912
total_deletes=17925013
total_updates=35846925
total_queries=322575131
total_ops=358422056
find_throughput=32257513
rq_throughput=0
update_throughput=3584692
query_throughput=32257513
total_throughput=35842205


total find                    : 322575131
total rq                      : 0
total inserts                 : 17921912
total deletes                 : 17925013
total updates                 : 35846925
total queries                 : 322575131
total ops                     : 358422056
find throughput               : 32257513
rq throughput                 : 0
update throughput             : 3584692
query throughput              : 32257513
total throughput              : 35842205

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

PAPI_L2_TCM=33.8326
PAPI_L3_TCM=7.0975
PAPI_TOT_CYC=5603.33
PAPI_TOT_INS=2425.99
garbage=1595288893482115
total_execution_walltime=15.639s
REALTIME_MAIN_END_PERF_FORMAT=6995499.733920251
TL2 system shutdown:
  GCLOCK=0x203FF12 Starts=415696928 Aborts=7208943
  Overflows: R=0 W=8758 L=0
[time_cmd_output] time_elapsed_sec=15.94, faults_major=0, faults_minor=823546, mem_maxresident_kb=2215228, user_cputime=1378.02, sys_cputime=101.78, percent_cpu=9283%
timeout=false
algorithm=brown_abtree_tm_auto.debra.tl2
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=1