__step=000290
__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.hytm1 -nwork 48 -nprefill 48 -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=data000290.txt
__path_data=data/data000290.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6998166.932223424
binary=./brown_sigouin_int_avl_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_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=2000000
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
HyTM1 system ready
Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.006s
prefilling_size=979677 prefilling_elapsed_millis=1.001s
prefilling_size=986375 prefilling_elapsed_millis=1.101s
finished prefilling to size 986315 for expected size 1000000 keysum=987185205563, performing 9055449 updates; total_prefilling_elapsed_ms=1202 ms)
pref_size=986315
pref_millis=1202
prefill_elapsed_ms=1223
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=6998168.334259624
REALTIME_END_PERF_FORMAT=6998178.334397369
###############################################################################
################################## 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.037s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32756 64753 117312 159417 123003 40022 4035 40 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 12 679 10484 61329 149876 147233 50916 5092 45
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65432 127796 220746 272879 187255 54951 5132 45
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65432 127796 220746 272879 187255 54951 5132 45
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99719 1.96349 1.80937 1.51399 1.23546 1.07973 1.01996 1.00097 1
tree_stats_height=24
tree_stats_numInternals=574105
tree_stats_numLeaves=425666
tree_stats_numNodes=999771
tree_stats_numKeys=999771
tree_stats_avgDegreeInternal=1.74144
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.42576
tree_stats_avgKeyDepth=18.3123
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=673536
first_thread_announced_epoch_by_thread=28924 28924 28924 28924 28924 28924 28924 28924 28924 28924 28924 28924 28924 28924 28924 28924 28924 28924 28924 28924 28924 28924 28924 28924 28924 28924 28924 28924 28924 28924 28924 28924 28924 28924 28924 28924 28924 28924 28924 28924 28924 28924 28924 28924 28924 28924 28924 28924
sum_num_inserts_by_thread=316714 318856 318417 321708 319829 315985 319472 318256 323243 316633 320278 318833 318532 318355 316430 318027 317894 320987 313050 316479 319213 322819 312248 313518 317469 314320 319342 323126 316286 314420 315881 316953 319667 324612 317886 315980 318261 317501 317560 318767 316276 316053 312276 315679 318713 323195 316425 316788
sum_num_inserts_total=15259212
sum_num_deletes_by_thread=317012 320127 317313 321951 320734 316432 318514 318036 323231 318404 320908 319091 320031 317128 317610 319897 317801 320988 313777 316402 319270 322557 312079 313117 316634 315249 319499 321590 317044 314267 315435 317887 318358 325125 318020 315764 317751 316031 318308 319539 316718 316238 311203 315063 318544 324133 316442 316910
sum_num_deletes_total=15264162
sum_num_searches_by_thread=5702206 5753286 5719596 5794506 5769140 5691712 5725746 5737782 5791017 5717264 5765741 5747756 5752641 5710739 5703221 5748577 5726714 5763720 5640674 5694833 5732971 5807339 5623173 5634741 5724312 5666536 5745775 5797175 5705784 5665027 5671904 5720040 5737811 5845677 5719913 5686606 5722532 5708660 5728744 5743499 5697722 5689703 5620169 5680322 5741593 5828314 5708033 5721069
sum_num_searches_total=274732015
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=6335932 6392269 6355326 6438165 6409703 6324129 6363732 6374074 6437491 6352301 6406927 6385680 6391204 6346222 6337261 6386501 6362409 6405695 6267501 6327714 6371454 6452715 6247500 6261376 6358415 6296105 6384616 6441891 6339114 6293714 6303220 6354880 6375836 6495414 6355819 6318350 6358544 6342192 6364612 6381805 6330716 6321994 6243648 6311064 6378850 6475642 6340900 6354767
average_num_operations_total=6359487
stdev_num_operations_total=7927
sum_num_operations_total=305255389
min_num_operations_total=6243648
max_num_operations_total=6495414
first_time_thread_terminate_by_thread=10000136 10000136 10000135 10000136 10000135 10000136 10000136 10000135 10000135 10000136 10000136 10000135 10000136 10000135 10000136 10000136 10000135 10000136 10000135 10000136 10000135 10000135 10000135 10000136 10000136 10000136 10000135 10000136 10000135 10000136 10000136 10000135 10000135 10000136 10000136 10000135 10000136 10000136 10000136 10000136 10000135 10000136 10000135 10000136 10000135 10000135 10000135 10000136
min_time_thread_terminate_total=10000135
max_time_thread_terminate_total=10000136
first_time_thread_start_by_thread=3 3 3 3 3 3 3 2 2 3 3 3 3 3 3 3 2 3 2 3 3 3 3 3 3 3 3 3 3 3 3 2 2 3 3 3 3 3 3 3 2 3 2 3 3 3 3 3
min_time_thread_start_total=2
max_time_thread_start_total=3
sum_duration_all_ops_total=
threads_final_keysum=1000013514228
threads_final_size=999771
final_keysum=1000013514228
final_size=999771
validate_result=success
Validation OK.
Structural validation OK.
total_find=274732015
total_rq=0
total_inserts=15259212
total_deletes=15264162
total_updates=30523374
total_queries=274732015
total_ops=305255389
find_throughput=27473201
rq_throughput=0
update_throughput=3052337
query_throughput=27473201
total_throughput=30525538
total find : 274732015
total rq : 0
total inserts : 15259212
total deletes : 15264162
total updates : 30523374
total queries : 274732015
total ops : 305255389
find throughput : 27473201
rq throughput : 0
update throughput : 3052337
query throughput : 27473201
total throughput : 30525538
elapsed milliseconds : 10000
napping milliseconds overtime : 0
PAPI_L2_TCM=13.5123
PAPI_L3_TCM=1.97279
PAPI_TOT_CYC=4306.84
PAPI_TOT_INS=2639.07
garbage=137200549327738
total_execution_walltime=11.536s
REALTIME_MAIN_END_PERF_FORMAT=6998178.469846536
HyTM1 system shutdown:
HTM_ATTEMPT_THRESH=40
[fast htm]
total fast htm commit : 314150577
[slow htm]
[fallback]
total fallback commit : 160262
seconds global lock is held : 3.43582
[time_cmd_output] time_elapsed_sec=11.70, faults_major=0, faults_minor=318993, mem_maxresident_kb=811120, user_cputime=562.22, sys_cputime=5.12, percent_cpu=4848%
timeout=false
algorithm=brown_sigouin_int_avl_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