__step=000481
__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.hybridnorec -nwork 48 -nprefill 48 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000481.txt
__path_data=data/data000481.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=7000596.820368472
binary=./brown_sigouin_int_avl_tm_auto.debra.hybridnorec
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
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=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=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,96,97,98,99,100,101,102,103,104,105,106,107,108,109,110,111,112,113,114,115,116,117,118,119


Hybrid noREC system ready

Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.023s
prefilling_size=100096 prefilling_elapsed_millis=1.001s
finished prefilling to size 100091 for expected size 100000 keysum=10004796720, performing 1692874 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=100091
pref_millis=1102
prefill_elapsed_ms=1125
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=7000598.161932939
REALTIME_END_PERF_FORMAT=7000608.162068111

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

tree_stats_computeWalltime=0.038s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4095 8113 14574 16900 8410 1212 42 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 1 71 1458 10026 18785 10707 1536 52
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8184 16032 26926 27195 11919 1578 52
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8184 16032 26926 27195 11919 1578 52
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 1.99829 1.96762 1.77046 1.38234 1.12903 1.03071 1.00634 1

tree_stats_height=20
tree_stats_numInternals=57441
tree_stats_numLeaves=42636
tree_stats_numNodes=100077
tree_stats_numKeys=100077

tree_stats_avgDegreeInternal=1.74226
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.42603
tree_stats_avgKeyDepth=14.9083


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=554913
first_thread_announced_epoch_by_thread=23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300 23300
sum_num_inserts_by_thread=190329 185168 185455 185212 182288 176790 191664 186188 186998 185610 183723 183074 190729 187362 185429 186198 183446 182199 198469 191986 185693 185376 183603 183854 192105 187956 185945 185524 182895 178565 191693 188243 189016 187597 184626 184204 192012 187529 188021 185254 185214 182022 200317 192017 187075 185879 185559 184583
sum_num_inserts_total=8960694
sum_num_deletes_by_thread=189913 186296 185469 183890 182413 177696 191171 185369 186358 185655 182714 182095 190765 186838 185023 186226 184697 182232 198215 191465 184697 184899 184952 183738 191764 188212 185493 186056 183507 178626 191033 188421 188486 187612 184454 183710 192259 187560 186900 185429 185671 182219 199795 191296 187161 186510 184923 183618
sum_num_deletes_total=8953501
sum_num_searches_by_thread=3421070 3349413 3336181 3328926 3283301 3191258 3457340 3348359 3356839 3345752 3296575 3291237 3436230 3369045 3336945 3348748 3312920 3285908 3566659 3445531 3332629 3329783 3317198 3312284 3451388 3390747 3349053 3346039 3303819 3207867 3448269 3395130 3382625 3372762 3326973 3316213 3463328 3368739 3369696 3340987 3328678 3285429 3595703 3445896 3367366 3355104 3340501 3303253
sum_num_searches_total=161255696
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=3801312 3720877 3707105 3698028 3648002 3545744 3840175 3719916 3730195 3717017 3663012 3656406 3817724 3743245 3707397 3721172 3681063 3650339 3963343 3828982 3703019 3700058 3685753 3679876 3835257 3766915 3720491 3717619 3670221 3565058 3830995 3771794 3760127 3747971 3696053 3684127 3847599 3743828 3744617 3711670 3699563 3649670 3995815 3829209 3741602 3727493 3710983 3671454
average_num_operations_total=3732706
stdev_num_operations_total=12095
sum_num_operations_total=179169891
min_num_operations_total=3545744
max_num_operations_total=3995815
first_time_thread_terminate_by_thread=10000133 10000167 10000164 10000133 10000160 10000133 10000133 10000133 10000133 10000133 10000141 10000161 10000159 10000133 10000147 10000133 10000133 10000135 10000133 10000140 10000163 10000133 10000133 10000165 10000143 10000140 10000133 10000163 10000139 10000156 10000133 10000147 10000137 10000145 10000141 10000157 10000133 10000161 10000134 10000161 10000142 10000136 10000164 10000164 10000163 10000157 10000133 10000133
min_time_thread_terminate_total=10000133
max_time_thread_terminate_total=10000167
first_time_thread_start_by_thread=4 4 4 4 4 4 4 4 4 4 4 4 4 5 5 5 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 5 5 5 4 4 4 4 4 4 4 4
min_time_thread_start_total=4
max_time_thread_start_total=5
sum_duration_all_ops_total=

threads_final_keysum=10020394599
threads_final_size=100077
final_keysum=10020394599
final_size=100077
validate_result=success
Validation OK.
Structural validation OK.

total_find=161255696
total_rq=0
total_inserts=8960694
total_deletes=8953501
total_updates=17914195
total_queries=161255696
total_ops=179169891
find_throughput=16125569
rq_throughput=0
update_throughput=1791419
query_throughput=16125569
total_throughput=17916989


total find                    : 161255696
total rq                      : 0
total inserts                 : 8960694
total deletes                 : 8953501
total updates                 : 17914195
total queries                 : 161255696
total ops                     : 179169891
find throughput               : 16125569
rq throughput                 : 0
update throughput             : 1791419
query throughput              : 16125569
total throughput              : 17916989

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=11.5967
PAPI_L3_TCM=0.0556321
PAPI_TOT_CYC=7425.66
PAPI_TOT_INS=2471.29
garbage=8066331225360
total_execution_walltime=11.453s
REALTIME_MAIN_END_PERF_FORMAT=7000608.292801766
Hybrid noREC system shutdown:
    HTM_ATTEMPT_THRESH=40
[fast htm]
total fast htm commit         : 177657193
[slow htm]
[fallback]
total fallback commit         : 3205573
seconds global lock is held   : 0.587473
[time_cmd_output] time_elapsed_sec=11.60, faults_major=0, faults_minor=134396, mem_maxresident_kb=539100, user_cputime=558.95, sys_cputime=3.32, percent_cpu=4843%
timeout=false
algorithm=brown_sigouin_int_avl_tm_auto.debra.hybridnorec
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=1