__step=000252
__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_int_bst_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=data000252.txt
__path_data=data/data000252.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6997587.737198283
binary=./brown_int_bst_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_int_bst_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=32
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.016s
prefilling_size=999606 prefilling_elapsed_millis=1.001s
finished prefilling to size 999640 for expected size 1000000 keysum=999409872006, performing 17716270 updates; total_prefilling_elapsed_ms=1103 ms)
pref_size=999640
pref_millis=1103
prefill_elapsed_ms=1128
4NodeIxPvL9tx_safety0EE_object_size=32
4NodeIxPvL9tx_safety0EE_allocated_count=0
4NodeIxPvL9tx_safety0EE_allocated_size=0MB
4NodeIxPvL9tx_safety0EE_get_from_pool=0
4NodeIxPvL9tx_safety0EE_deallocated=0
4NodeIxPvL9tx_safety0EE_limbo_count=0
4NodeIxPvL9tx_safety0EE_limbo_details=0 0 0 

global_epoch_counter=212

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6997589.76081190
REALTIME_END_PERF_FORMAT=6997599.76237952

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

tree_stats_computeWalltime=0.036s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 254 483 896 1579 2681 4411 6944 10395 14987 20578 27456 35067 42742 49853 54915 57184 56987 53486 47701 40733 33388 26240 20124 14505 10347 7208 4910 3200 1999 1232 745 439 215 102 39 20 7 2 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 1 18 40 124 281 521 1057 1919 3149 5097 7436 10652 14702 19007 23746 27889 30264 31953 31046 28786 25225 21077 16842 13446 9736 7030 4893 3441 2283 1431 884 527 331 161 89 29 16 5 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 255 501 936 1703 2962 4932 8001 12314 18136 25675 34892 45719 57444 68860 78661 85073 87251 85439 78747 69519 58613 47317 36966 27951 20083 14238 9803 6641 4282 2663 1629 966 546 263 128 49 23 7 2
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 255 501 936 1703 2962 4932 8001 12314 18136 25675 34892 45719 57444 68860 78661 85073 87251 85439 78747 69519 58613 47317 36966 27951 20083 14238 9803 6641 4282 2663 1629 966 546 263 128 49 23 7 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 1.99219 1.96863 1.90419 1.86218 1.8121 1.75996 1.7279 1.67117 1.62863 1.58933 1.55751 1.52342 1.48945 1.45467 1.41836 1.38339 1.35343 1.32609 1.29566 1.27706 1.2572 1.23764 1.22668 1.21174 1.19956 1.19375 1.18226 1.17658 1.16293 1.15507 1.14908 1.13567 1.11077 1.08791 1.09886 1.07812 1.06122 1 1 1

tree_stats_height=47
tree_stats_numInternals=654309
tree_stats_numLeaves=345136
tree_stats_numNodes=999445
tree_stats_numKeys=999445

tree_stats_avgDegreeInternal=1.52748
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34533
tree_stats_avgKeyDepth=24.1668

4NodeIxPvL9tx_safety0EE_object_size=32
4NodeIxPvL9tx_safety0EE_allocated_count=0
4NodeIxPvL9tx_safety0EE_allocated_size=0MB
4NodeIxPvL9tx_safety0EE_get_from_pool=0
4NodeIxPvL9tx_safety0EE_deallocated=0
4NodeIxPvL9tx_safety0EE_limbo_count=0
4NodeIxPvL9tx_safety0EE_limbo_details=0 0 0 

global_epoch_counter=8205


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:7 2:155 4:4025 8:73485 16:667492 32:21971
    [2^00, 2^01]: 7
    (2^01, 2^02]: 155
    (2^02, 2^03]: 4025
    (2^03, 2^04]: 73485
    (2^04, 2^05]: 667492
    (2^05, 2^06]: 21971
sum_limbo_reclamation_event_size_total=16738959
count_limbo_reclamation_event_size_by_thread=7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7990 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991 7991
count_limbo_reclamation_event_size_total=767135
sum_limbo_reclamation_event_count_total=767328
first_thread_announced_epoch_by_thread=16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410 16410
sum_num_inserts_by_thread=285743 366740 354161 362423 305006 362858 356530 353102 368525 369202 362598 350133 334767 332338 362363 321025 362813 368140 359037 362472 349622 372375 366881 344938 349841 361089 365500 334015 325938 366584 351157 365092 367607 365026 322312 359209 361577 313431 362711 361054 330906 366168 360198 356358 362112 366065 361515 354710 356382 307683 191962 366625 356151 354871 350495 324615 363502 374403 369829 366128 363831 368250 336402 374139 354764 371322 282246 357866 370719 371431 337099 307793 354472 154722 175483 360967 361476 354620 367245 307850 374413 374346 373941 367772 358958 354126 364063 374282 364963 371597 345543 370363 375504 376097 351984 352623
sum_num_inserts_total=33489885
sum_num_deletes_by_thread=284835 365912 353930 362278 304032 363124 356414 353567 370599 370220 364117 351616 334970 333217 363088 321575 362368 369421 358600 363865 350052 372438 366623 343926 349305 361841 364382 333778 326189 366629 351697 364757 368617 365909 322301 359367 360893 313528 364111 360604 330224 366358 359669 354759 360894 366310 361941 354071 355296 307469 191244 367208 355350 354826 350528 325187 364316 374174 369598 365399 363047 369532 336920 373254 354531 369733 280807 357759 371466 371704 338021 306587 354482 155148 176254 360655 361948 353777 367509 306786 375413 374005 374115 366443 359457 355804 363728 374511 366217 370616 345118 368334 374722 378045 352561 353983
sum_num_deletes_total=33492508
sum_num_searches_by_thread=5132640 6601596 6374402 6528810 5481192 6538944 6418559 6343080 6658761 6667649 6551107 6311109 6030154 5991633 6540955 5785227 6528865 6631627 6457133 6535121 6300415 6699057 6584626 6208982 6285734 6518527 6562162 6010515 5877101 6595290 6323963 6569852 6625514 6570796 5799320 6476817 6485006 5640968 6544474 6490630 5921569 6586575 6473783 6404320 6503879 6600221 6506377 6391214 6405186 5535487 3452970 6616348 6414742 6380513 6301791 5858627 6540709 6727560 6662314 6595234 6528458 6664405 6059948 6723266 6384477 6678067 5071433 6438021 6680170 6683716 6078571 5514500 6373214 2793512 3174191 6491640 6486273 6381300 6617272 5534551 6739704 6739945 6736880 6617097 6472666 6381736 6566005 6735841 6579076 6693295 6210881 6642723 6752848 6780186 6334047 6356988
sum_num_searches_total=602854635
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=5703218 7334248 7082493 7253511 6090230 7264926 7131503 7049749 7397885 7407071 7277822 7012858 6699891 6657188 7266406 6427827 7254046 7369188 7174770 7261458 7000089 7443870 7318130 6897846 6984880 7241457 7292044 6678308 6529228 7328503 7026817 7299701 7361738 7301731 6443933 7195393 7207476 6267927 7271296 7212288 6582699 7319101 7193650 7115437 7226885 7332596 7229833 7099995 7116864 6150639 3836176 7350181 7126243 7090210 7002814 6508429 7268527 7476137 7401741 7326761 7255336 7402187 6733270 7470659 7093772 7419122 5634486 7153646 7422355 7426851 6753691 6128880 7082168 3103382 3525928 7213262 7209697 7089697 7352026 6149187 7489530 7488296 7484936 7351312 7191081 7091666 7293796 7484634 7310256 7435508 6901542 7381420 7503074 7534328 7038592 7063594
average_num_operations_total=6977469
stdev_num_operations_total=76415
sum_num_operations_total=669837028
min_num_operations_total=3103382
max_num_operations_total=7534328
first_time_thread_terminate_by_thread=10000155 10000156 10000155 10000157 10000158 10000155 10000157 10000155 10000155 10000155 10000157 10000157 10000158 10000156 10000156 10000158 10000155 10000157 10000157 10000155 10000155 10000157 10000156 10000156 10000155 10000156 10000158 10000157 10000154 10000155 10000157 10000155 10000155 10000157 10000157 10000157 10000158 10000156 10000156 10000158 10000155 10000157 10000155 10000155 10000155 10000157 10000157 10000156 10000156 10000156 10000161 10000157 10000159 10000156 10000155 10000157 10000155 10000156 10000159 10000158 10000155 10000158 10000158 10000156 10000158 10000154 10000156 10000157 10000155 10000155 10000155 10000156 10000158 10000156 10000162 10000155 10000159 10000156 10000159 10000159 10000155 10000156 10000159 10000158 10000155 10000158 10000158 10000155 10000156 10000154 10000156 10000156 10000155 10000158 10000158 10000156
min_time_thread_terminate_total=10000154
max_time_thread_terminate_total=10000162
first_time_thread_start_by_thread=3 3 3 3 3 3 2 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 2 3 3 3 3 2 2 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 2 3 3 3 3 2 2 3 3 3 3 3 3 3 3 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=999193319725
threads_final_size=999445
final_keysum=999193319725
final_size=999445
validate_result=success
Validation OK.
Structural validation OK.

total_find=602854635
total_rq=0
total_inserts=33489885
total_deletes=33492508
total_updates=66982393
total_queries=602854635
total_ops=669837028
find_throughput=60285463
rq_throughput=0
update_throughput=6698239
query_throughput=60285463
total_throughput=66983702


total find                    : 602854635
total rq                      : 0
total inserts                 : 33489885
total deletes                 : 33492508
total updates                 : 66982393
total queries                 : 602854635
total ops                     : 669837028
find throughput               : 60285463
rq throughput                 : 0
update throughput             : 6698239
query throughput              : 60285463
total throughput              : 66983702

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=9.37793
PAPI_L3_TCM=0.510511
PAPI_TOT_CYC=3914.44
PAPI_TOT_INS=1821.91
garbage=291771464458635
total_execution_walltime=11.496s
REALTIME_MAIN_END_PERF_FORMAT=6997599.248699805
HyTM1 system shutdown:
    HTM_ATTEMPT_THRESH=40
[fast htm]
total fast htm commit         : 686369894
[slow htm]
[fallback]
total fallback commit         : 1183405
seconds global lock is held   : 1.4896
[time_cmd_output] time_elapsed_sec=11.64, faults_major=0, faults_minor=99894, mem_maxresident_kb=362648, user_cputime=1092.43, sys_cputime=3.15, percent_cpu=9409%
timeout=false
algorithm=brown_int_bst_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