__step=000332
__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.hytm1 -nwork 96 -nprefill 96 -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=data000332.txt
__path_data=data/data000332.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6998821.508452386
binary=./brown_abtree_tm_auto.debra.hytm1
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=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


HyTM1 system ready

Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.044s
prefilling_size=584705 prefilling_elapsed_millis=1s
prefilling_size=611350 prefilling_elapsed_millis=1.1s
prefilling_size=668914 prefilling_elapsed_millis=1.2s
prefilling_size=724226 prefilling_elapsed_millis=1.301s
prefilling_size=775648 prefilling_elapsed_millis=1.401s
prefilling_size=821922 prefilling_elapsed_millis=1.501s
prefilling_size=863623 prefilling_elapsed_millis=1.601s
prefilling_size=895887 prefilling_elapsed_millis=1.701s
prefilling_size=917692 prefilling_elapsed_millis=1.801s
prefilling_size=935304 prefilling_elapsed_millis=1.901s
prefilling_size=949843 prefilling_elapsed_millis=2.001s
prefilling_size=961084 prefilling_elapsed_millis=2.102s
prefilling_size=969004 prefilling_elapsed_millis=2.202s
prefilling_size=974025 prefilling_elapsed_millis=2.302s
prefilling_size=977509 prefilling_elapsed_millis=2.402s
prefilling_size=982611 prefilling_elapsed_millis=2.502s
finished prefilling to size 982633 for expected size 1000000 keysum=983136427393, performing 8221503 updates; total_prefilling_elapsed_ms=2604 ms)
pref_size=982633
pref_millis=2604
prefill_elapsed_ms=2631
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6998824.364471164
REALTIME_END_PERF_FORMAT=6998834.364614971

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

tree_stats_computeWalltime=0.059s

tree_stats_numInternalsAtDepth=1 1 8 62 457 3471 26876 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 196530
tree_stats_numNodesAtDepth=1 1 8 62 457 3471 26876 196530
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 998841
tree_stats_avgDegreeAtDepth=1 8 7.75 7.37097 7.59519 7.74301 7.31247 5.08238

tree_stats_height=8
tree_stats_numInternals=30876
tree_stats_numLeaves=196530
tree_stats_numNodes=227406
tree_stats_numKeys=998841

tree_stats_avgDegreeInternal=7.36514
tree_stats_avgDegreeLeaves=5.08238
tree_stats_avgDegree=5.39232
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=574176
first_thread_announced_epoch_by_thread=12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162 12162
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=267687 266997 270868 270042 270063 265851 267579 269504 272303 270380 268440 268704 268432 268322 271154 271372 268517 262347 266135 268307 269304 270365 269142 267189 267348 266909 270682 271242 270020 266782 268211 269309 272053 269503 269893 268349 267718 266473 271285 269711 270538 262111 263639 266115 269780 269952 268179 265756 268411 268374 273637 271303 270264 268783 269492 270909 274114 273192 272463 268744 269744 271763 275308 274845 274859 269386 271438 271412 274488 272470 270679 270304 270515 269918 271356 272769 270210 268246 270121 271867 273187 271510 272823 268179 270107 272023 273934 273929 272665 270209 270698 271444 275012 275932 274712 272852
sum_num_inserts_total=25931162
sum_num_deletes_by_thread=267720 266398 269238 269956 269884 266914 267598 269723 272327 268710 268704 267578 268077 267079 271471 270306 270220 261178 265631 267911 271653 271485 268547 267588 266515 265581 270193 270435 270619 265759 267458 269512 272040 269732 267920 268099 268417 266760 270773 269547 270447 262607 262836 267243 269807 269333 268741 265261 267531 269720 273187 272947 270032 268324 270368 270358 275251 273934 273085 268849 269953 271661 274681 275039 274631 268561 269920 270874 274834 273131 271247 271098 269610 268059 273049 271225 269528 268090 270199 271757 274550 271419 273590 267733 270926 271674 273970 273266 272579 269861 270986 270996 275750 274814 275371 273193
sum_num_deletes_total=25922942
sum_num_searches_by_thread=4820859 4788265 4868195 4867168 4847724 4801658 4809473 4855803 4898071 4857372 4840416 4819048 4828963 4820405 4871591 4880658 4847472 4704900 4788563 4834988 4865278 4872604 4842511 4819223 4805333 4791530 4855801 4866707 4864630 4791607 4829261 4843626 4893876 4856642 4851452 4837862 4826425 4798310 4885414 4862405 4864686 4718496 4732162 4809445 4858535 4842420 4828859 4776061 4828608 4834055 4915613 4903081 4868264 4823299 4856911 4874986 4946629 4917942 4909413 4825705 4860650 4878613 4955257 4951466 4936470 4845778 4864389 4886544 4940905 4906986 4891494 4866829 4856249 4845593 4904096 4897401 4858381 4827675 4849234 4888727 4925549 4879516 4900298 4825311 4871971 4892264 4929085 4925362 4909125 4851134 4859828 4897503 4962468 4947730 4953259 4916295
sum_num_searches_total=466606694
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=5356266 5321660 5408301 5407166 5387671 5334423 5344650 5395030 5442701 5396462 5377560 5355330 5365472 5355806 5414216 5422336 5386209 5228425 5320329 5371206 5406235 5414454 5380200 5354000 5339196 5324020 5396676 5408384 5405269 5324148 5364930 5382447 5437969 5395877 5389265 5374310 5362560 5331543 5427472 5401663 5405671 5243214 5258637 5342803 5398122 5381705 5365779 5307078 5364550 5372149 5462437 5447331 5408560 5360406 5396771 5416253 5495994 5465068 5454961 5363298 5400347 5422037 5505246 5501350 5485960 5383725 5405747 5428830 5490227 5452587 5433420 5408231 5396374 5383570 5448501 5441395 5398119 5364011 5389554 5432351 5473286 5422445 5446711 5361223 5413004 5435961 5476989 5472557 5454369 5391204 5401512 5439943 5513230 5498476 5503342 5462340
average_num_operations_total=5400633
stdev_num_operations_total=5653
sum_num_operations_total=518460798
min_num_operations_total=5228425
max_num_operations_total=5513230
first_time_thread_terminate_by_thread=10000144 10000145 10000142 10000143 10000142 10000145 10000142 10000143 10000142 10000143 10000142 10000142 10000142 10000143 10000144 10000142 10000142 10000144 10000141 10000142 10000144 10000142 10000144 10000141 10000144 10000145 10000142 10000143 10000142 10000145 10000142 10000143 10000142 10000143 10000142 10000142 10000142 10000143 10000144 10000142 10000142 10000144 10000141 10000142 10000144 10000144 10000143 10000141 10000144 10000142 10000142 10000143 10000143 10000142 10000142 10000144 10000143 10000143 10000144 10000144 10000142 10000144 10000143 10000142 10000143 10000142 10000143 10000142 10000142 10000144 10000144 10000143 10000144 10000142 10000143 10000143 10000143 10000142 10000142 10000144 10000163 10000143 10000144 10000143 10000142 10000144 10000143 10000142 10000144 10000142 10000143 10000145 10000142 10000144 10000144 10000143
min_time_thread_terminate_total=10000141
max_time_thread_terminate_total=10000163
first_time_thread_start_by_thread=5 5 6 5 5 6 5 5 5 5 6 6 6 6 5 6 5 6 6 6 6 6 5 6 5 5 6 5 5 6 5 5 5 5 6 6 6 6 5 6 5 6 6 6 6 6 5 6 5 5 6 5 5 6 6 6 5 5 5 6 6 5 6 5 6 5 6 5 5 5 5 5 5 5 6 5 5 6 6 6 5 5 5 6 6 5 6 5 6 5 6 5 5 5 5 5
min_time_thread_start_total=5
max_time_thread_start_total=6
sum_duration_all_ops_total=

threads_final_keysum=998647294289
threads_final_size=998841
final_keysum=998647294289
final_size=998841
validate_result=success
Validation OK.
Structural validation OK.

total_find=466606694
total_rq=0
total_inserts=25931162
total_deletes=25922942
total_updates=51854104
total_queries=466606694
total_ops=518460798
find_throughput=46660669
rq_throughput=0
update_throughput=5185410
query_throughput=46660669
total_throughput=51846079


total find                    : 466606694
total rq                      : 0
total inserts                 : 25931162
total deletes                 : 25922942
total updates                 : 51854104
total queries                 : 466606694
total ops                     : 518460798
find throughput               : 46660669
rq throughput                 : 0
update throughput             : 5185410
query throughput              : 46660669
total throughput              : 51846079

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=11.5275
PAPI_L3_TCM=1.88288
PAPI_TOT_CYC=5130.92
PAPI_TOT_INS=3797.95
garbage=230703013709430
total_execution_walltime=12.999s
REALTIME_MAIN_END_PERF_FORMAT=6998834.508683301
HyTM1 system shutdown:
    HTM_ATTEMPT_THRESH=40
[fast htm]
total fast htm commit         : 526156134
[slow htm]
[fallback]
total fallback commit         : 526168
seconds global lock is held   : 7.65922
[time_cmd_output] time_elapsed_sec=13.17, faults_major=0, faults_minor=278927, mem_maxresident_kb=1027372, user_cputime=1242.40, sys_cputime=4.49, percent_cpu=9463%
timeout=false
algorithm=brown_abtree_tm_auto.debra.hytm1
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=2