__step=000289
__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=data000289.txt
__path_data=data/data000289.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6998155.240005286
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.024s
prefilling_size=980068 prefilling_elapsed_millis=1.001s
finished prefilling to size 980085 for expected size 1000000 keysum=980022394821, performing 8168275 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=980085
pref_millis=1102
prefill_elapsed_ms=1119
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=6998156.570421884
REALTIME_END_PERF_FORMAT=6998166.570591293
###############################################################################
################################## 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 4096 8192 16384 32729 64447 115339 155618 123387 44636 5306 111 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 35 892 11649 60919 144046 145428 56546 6662 135
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32764 65339 126988 216537 267433 190064 61852 6773 135
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32764 65339 126988 216537 267433 190064 61852 6773 135
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99976 1.9953 1.95718 1.79691 1.51638 1.24932 1.09058 1.02372 1.00354 1
tree_stats_height=24
tree_stats_numInternals=574340
tree_stats_numLeaves=426312
tree_stats_numNodes=1000652
tree_stats_numKeys=1000652
tree_stats_avgDegreeInternal=1.74226
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.42603
tree_stats_avgKeyDepth=18.3409
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=675792
first_thread_announced_epoch_by_thread=28936 28936 28936 28936 28936 28936 28936 28936 28936 28936 28936 28936 28936 28936 28936 28936 28936 28936 28936 28936 28936 28936 28936 28936 28936 28936 28936 28936 28936 28936 28936 28936 28936 28936 28936 28936 28936 28936 28936 28936 28936 28936 28936 28936 28936 28936 28936 28936
sum_num_inserts_by_thread=314376 317188 321618 322955 317391 317573 317874 317274 321910 320922 321311 318494 320264 321489 322401 317879 319487 316433 318210 320361 321130 322123 319912 314477 317233 317006 322507 323050 319431 315623 317161 321858 322423 319215 317653 319494 318232 319001 320391 321595 322710 316439 316539 320625 318852 322256 317283 315625
sum_num_inserts_total=15325254
sum_num_deletes_by_thread=315975 315922 322864 323101 318349 317937 318020 317860 322666 319608 320922 317112 319375 322579 321912 319153 320141 316385 318084 320192 320883 321623 320652 316280 316118 317082 322181 324113 319568 316222 316817 322038 322069 319579 319152 319877 317038 318386 320002 322509 322777 316942 316146 320282 319833 322504 316864 315457
sum_num_deletes_total=15331151
sum_num_searches_by_thread=5677462 5716812 5794695 5814703 5727954 5725333 5720234 5712136 5805182 5771152 5780660 5713338 5766342 5782317 5797205 5726561 5760722 5695379 5727705 5768612 5789585 5793658 5764012 5671753 5692502 5700173 5820785 5822096 5749215 5681552 5700342 5800056 5803478 5746827 5722266 5761319 5710533 5742343 5762633 5796306 5813693 5696958 5705396 5771794 5755010 5811526 5705081 5682859
sum_num_searches_total=275958255
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=6307813 6349922 6439177 6460759 6363694 6360843 6356128 6347270 6449758 6411682 6422893 6348944 6405981 6426385 6441518 6363593 6400350 6328197 6363999 6409165 6431598 6437404 6404576 6302510 6325853 6334261 6465473 6469259 6388214 6313397 6334320 6443952 6447970 6385621 6359071 6400690 6345803 6379730 6403026 6440410 6459180 6330339 6338081 6412701 6393695 6456286 6339228 6313941
average_num_operations_total=6387805
stdev_num_operations_total=7160
sum_num_operations_total=306614660
min_num_operations_total=6302510
max_num_operations_total=6469259
first_time_thread_terminate_by_thread=10000157 10000157 10000156 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000156 10000157 10000156 10000156 10000157 10000157 10000156 10000156 10000156 10000157 10000156 10000157 10000157 10000156 10000156 10000157 10000157 10000157 10000157 10000156 10000157 10000157 10000157 10000157 10000156 10000156 10000156 10000156 10000157 10000157 10000156 10000156 10000156 10000157 10000156 10000157 10000157 10000157
min_time_thread_terminate_total=10000156
max_time_thread_terminate_total=10000157
first_time_thread_start_by_thread=4 3 4 3 4 4 4 4 3 3 3 3 3 3 3 3 3 3 3 4 3 4 3 3 4 3 4 3 4 4 4 4 3 3 3 3 3 3 3 3 3 3 3 4 3 4 3 3
min_time_thread_start_total=3
max_time_thread_start_total=4
sum_duration_all_ops_total=
threads_final_keysum=1000693726173
threads_final_size=1000652
final_keysum=1000693726173
final_size=1000652
validate_result=success
Validation OK.
Structural validation OK.
total_find=275958255
total_rq=0
total_inserts=15325254
total_deletes=15331151
total_updates=30656405
total_queries=275958255
total_ops=306614660
find_throughput=27595825
rq_throughput=0
update_throughput=3065640
query_throughput=27595825
total_throughput=30661466
total find : 275958255
total rq : 0
total inserts : 15325254
total deletes : 15331151
total updates : 30656405
total queries : 275958255
total ops : 306614660
find throughput : 27595825
rq throughput : 0
update throughput : 3065640
query throughput : 27595825
total throughput : 30661466
elapsed milliseconds : 10000
napping milliseconds overtime : 0
PAPI_L2_TCM=13.4353
PAPI_L3_TCM=1.97979
PAPI_TOT_CYC=4296.23
PAPI_TOT_INS=2653.24
garbage=134880411288778
total_execution_walltime=11.439s
REALTIME_MAIN_END_PERF_FORMAT=6998166.695176747
HyTM1 system shutdown:
HTM_ATTEMPT_THRESH=40
[fast htm]
total fast htm commit : 314625421
[slow htm]
[fallback]
total fallback commit : 157515
seconds global lock is held : 3.39411
[time_cmd_output] time_elapsed_sec=11.63, faults_major=0, faults_minor=314756, mem_maxresident_kb=803008, user_cputime=557.75, sys_cputime=5.98, percent_cpu=4843%
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=1