__step=000467
__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 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000467.txt
__path_data=data/data000467.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=7000427.736130920
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=200000
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=100072 prefilling_elapsed_millis=1.001s
finished prefilling to size 100064 for expected size 100000 keysum=10011093021, performing 37403027 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=100064
pref_millis=1102
prefill_elapsed_ms=1139
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=480
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=7000429.61295395
REALTIME_END_PERF_FORMAT=7000439.61450281
###############################################################################
################################## 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 937 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.035s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 62 111 193 306 511 839 1326 1995 2884 3878 4987 6048 6872 7215 6969 6258 5030 3779 2567 1606 947 529 278 151 56 26 7 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 1 10 16 44 55 98 202 353 590 1020 1493 2070 2806 3505 3993 4043 3952 3203 2592 1848 1200 678 397 198 122 44 22 7 1
tree_stats_numNodesAtDepth=1 2 4 8 16 32 63 121 209 350 566 937 1528 2348 3474 4898 6480 8118 9678 10720 10962 10301 8982 6982 5159 3454 2147 1207 675 349 178 70 29 8 1
tree_stats_numKeysAtDepth=1 2 4 8 16 32 63 121 209 350 566 937 1528 2348 3474 4898 6480 8118 9678 10720 10962 10301 8982 6982 5159 3454 2147 1207 675 349 178 70 29 8 1
tree_stats_avgDegreeAtDepth=2 2 2 2 2 1.96875 1.93651 1.80992 1.7512 1.74286 1.75265 1.73533 1.66885 1.6299 1.57974 1.53124 1.48318 1.44715 1.3976 1.34953 1.30396 1.26444 1.21732 1.19765 1.17193 1.15663 1.1211 1.12096 1.10519 1.07736 1.07865 1.04286 1.03448 1 1
tree_stats_height=35
tree_stats_numInternals=65494
tree_stats_numLeaves=34563
tree_stats_numNodes=100057
tree_stats_numKeys=100057
tree_stats_avgDegreeInternal=1.52773
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34543
tree_stats_avgKeyDepth=19.4179
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=12221
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:7 2:103 4:2594 8:107267 16:828468 32:21369
[2^00, 2^01]: 7
(2^01, 2^02]: 103
(2^02, 2^03]: 2594
(2^03, 2^04]: 107267
(2^04, 2^05]: 828468
(2^05, 2^06]: 21369
sum_limbo_reclamation_event_size_total=20450632
count_limbo_reclamation_event_size_by_thread=9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998
count_limbo_reclamation_event_size_total=959808
sum_limbo_reclamation_event_count_total=1127136
first_thread_announced_epoch_by_thread=24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442 24442
sum_num_inserts_by_thread=453380 420504 480787 538766 501379 506771 521664 439330 536576 525113 448897 536477 509540 500452 234124 510706 519888 465540 497060 530718 476735 499932 516838 526165 502858 417956 499935 538356 531348 473401 456837 529377 506688 520195 493103 494768 534922 524706 418604 518892 509019 506773 529718 510125 508966 509223 532039 517055 537688 456117 522638 541560 542811 446287 401187 531824 545862 526889 496125 498662 537744 535287 435170 480532 524235 533566 538117 518611 526566 428857 538107 498819 409448 521641 553524 545189 527254 453230 521860 529592 535060 523150 428163 525196 545002 537980 452174 459311 484522 533072 528213 402102 546793 493902 536136 534209
sum_num_inserts_total=48052190
sum_num_deletes_by_thread=453025 421687 482330 538937 502129 506547 523306 439227 536662 525922 449455 535671 510218 499517 235327 510395 519015 465630 498713 531527 475478 498836 518466 525598 502429 417000 500284 538151 532093 473753 456025 529671 507048 520754 493426 493782 537756 524546 418935 518113 508353 505769 529583 508396 508730 509322 531652 516884 538354 456646 521951 540257 542822 445855 399332 531556 546102 527376 496965 499171 536185 535711 434519 482131 523270 533350 537874 518706 526889 428780 538819 500576 408734 520097 551986 545416 525934 454360 521192 527756 534748 521608 427711 524965 543978 539111 454260 459329 485848 533158 526486 403251 548214 492771 535215 535288
sum_num_deletes_total=48050686
sum_num_searches_by_thread=8160531 7578544 8666263 9697288 9020010 9119547 9418410 7906891 9676358 9466220 8079502 9631814 9166619 9009016 4232129 9205885 9352627 8364343 8948134 9561582 8569642 8983663 9320899 9457457 9041182 7507389 8999340 9660732 9557440 8515723 8207257 9533040 9131898 9351974 8862610 8888403 9669108 9439254 7542727 9342828 9159984 9103865 9535850 9166422 9150296 9177352 9577287 9294136 9675765 8212523 9411380 9743008 9769250 8025052 7206228 9582720 9830518 9487417 8944716 8970020 9649628 9637477 7827596 8671809 9441117 9603599 9666508 9337961 9471146 7719126 9699333 8992746 7365381 9357347 9941995 9825816 9489052 8169996 9384682 9514205 9648468 9411981 7704080 9459654 9828460 9680578 8160923 8274779 8738429 9580356 9486799 7257047 9865272 8891801 9644716 9622176
sum_num_searches_total=864890107
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=9066936 8420735 9629380 10774991 10023518 10132865 10463380 8785448 10749596 10517255 8977854 10703962 10186377 10008985 4701580 10226986 10391530 9295513 9943907 10623827 9521855 9982431 10356203 10509220 10046469 8342345 9999559 10737239 10620881 9462877 9120119 10592088 10145634 10392923 9849139 9876953 10741786 10488506 8380266 10379833 10177356 10116407 10595151 10184943 10167992 10195897 10640978 10328075 10751807 9125286 10455969 10824825 10854883 8917194 8006747 10646100 10922482 10541682 9937806 9967853 10723557 10708475 8697285 9634472 10488622 10670515 10742499 10375278 10524601 8576763 10776259 9992141 8183563 10399085 11047505 10916421 10542240 9077586 10427734 10571553 10718276 10456739 8559954 10509815 10917440 10757669 9067357 9193419 9708799 10646586 10541498 8062400 10960279 9878474 10716067 10691673
average_num_operations_total=10010343
stdev_num_operations_total=96585
sum_num_operations_total=960992983
min_num_operations_total=4701580
max_num_operations_total=11047505
first_time_thread_terminate_by_thread=10000154 10000154 10000157 10000159 10000154 10000155 10000152 10000156 10000153 10000152 10000158 10000154 10000154 10000153 10000155 10000152 10000153 10000153 10000153 10000154 10000154 10000159 10000155 10000154 10000154 10000157 10000154 10000155 10000154 10000154 10000152 10000156 10000153 10000163 10000153 10000154 10000154 10000153 10000153 10000152 10000153 10000154 10000156 10000154 10000159 10000155 10000155 10000154 10000153 10000156 10000155 10000154 10000154 10000156 10000157 10000155 10000154 10000155 10000155 10000156 10000155 10000157 10000161 10000154 10000157 10000158 10000153 10000156 10000152 10000156 10000155 10000160 10000153 10000156 10000155 10000154 10000157 10000156 10000156 10000157 10000157 10000155 10000156 10000156 10000155 10000157 10000153 10000154 10000155 10000154 10000153 10000156 10000156 10000156 10000155 10000153
min_time_thread_terminate_total=10000152
max_time_thread_terminate_total=10000163
first_time_thread_start_by_thread=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 3 3 3 3 4 3 4 3 4 3 3 4 3 3 3 3 4 4 3 3 3 3 3 4 3 3 3 3 4 3 4 3 4 3 3 4 3 3 3 3 4 4 3 3 3 3 3 4 3 3 3
min_time_thread_start_total=3
max_time_thread_start_total=4
sum_duration_all_ops_total=
threads_final_keysum=10008219171
threads_final_size=100057
final_keysum=10008219171
final_size=100057
validate_result=success
Validation OK.
Structural validation OK.
total_find=864890107
total_rq=0
total_inserts=48052190
total_deletes=48050686
total_updates=96102876
total_queries=864890107
total_ops=960992983
find_throughput=86489010
rq_throughput=0
update_throughput=9610287
query_throughput=86489010
total_throughput=96099298
total find : 864890107
total rq : 0
total inserts : 48052190
total deletes : 48050686
total updates : 96102876
total queries : 864890107
total ops : 960992983
find throughput : 86489010
rq throughput : 0
update throughput : 9610287
query throughput : 86489010
total throughput : 96099298
elapsed milliseconds : 10000
napping milliseconds overtime : 0
PAPI_L2_TCM=4.07837
PAPI_L3_TCM=0.247263
PAPI_TOT_CYC=2665.48
PAPI_TOT_INS=1394.84
garbage=43240152136745
total_execution_walltime=11.48s
REALTIME_MAIN_END_PERF_FORMAT=7000439.217701167
HyTM1 system shutdown:
HTM_ATTEMPT_THRESH=40
[fast htm]
total fast htm commit : 997646198
[slow htm]
[fallback]
total fallback commit : 749813
seconds global lock is held : 0.617469
[time_cmd_output] time_elapsed_sec=11.61, faults_major=0, faults_minor=87278, mem_maxresident_kb=334792, user_cputime=1092.26, sys_cputime=2.86, percent_cpu=9432%
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=1