__step=000293
__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 144 -nprefill 144 -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=data000293.txt
__path_data=data/data000293.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6998203.996846645
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=144
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=144
WORK_THREADS=144
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,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,48,49,50,51,52,53,54,55,56,57,58,59,60,61,62,63,64,65,66,67,68,69,70,71,144,145,146,147,148,149,150,151,152,153,154,155,156,157,158,159,160,161,162,163,164,165,166,167


HyTM1 system ready

Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.069s
prefilling_size=635812 prefilling_elapsed_millis=1s
prefilling_size=698487 prefilling_elapsed_millis=1.1s
prefilling_size=748220 prefilling_elapsed_millis=1.2s
prefilling_size=785108 prefilling_elapsed_millis=1.3s
prefilling_size=815239 prefilling_elapsed_millis=1.401s
prefilling_size=840697 prefilling_elapsed_millis=1.501s
prefilling_size=863558 prefilling_elapsed_millis=1.601s
prefilling_size=882903 prefilling_elapsed_millis=1.701s
prefilling_size=899512 prefilling_elapsed_millis=1.801s
prefilling_size=914291 prefilling_elapsed_millis=1.901s
prefilling_size=927847 prefilling_elapsed_millis=2.001s
prefilling_size=938772 prefilling_elapsed_millis=2.101s
prefilling_size=947719 prefilling_elapsed_millis=2.201s
prefilling_size=955299 prefilling_elapsed_millis=2.301s
prefilling_size=962693 prefilling_elapsed_millis=2.402s
prefilling_size=968491 prefilling_elapsed_millis=2.502s
prefilling_size=973315 prefilling_elapsed_millis=2.602s
prefilling_size=977534 prefilling_elapsed_millis=2.702s
prefilling_size=981382 prefilling_elapsed_millis=2.802s
finished prefilling to size 981389 for expected size 1000000 keysum=981355299363, performing 7916383 updates; total_prefilling_elapsed_ms=2904 ms)
pref_size=981389
pref_millis=2904
prefill_elapsed_ms=2932
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6998207.220171829
REALTIME_END_PERF_FORMAT=6998217.220251012

###############################################################################
################################## TIME IS UP #################################
###############################################################################

joining threads...
###############################################################################
################################# END RUNNING #################################
###############################################################################

10.1s
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.04s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32755 64840 118254 161283 120969 39246 4714 118 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 12 617 9832 61646 154159 144367 49495 5981 144
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32767 65457 128086 222929 275128 183613 54209 6099 144
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32767 65457 128086 222929 275128 183613 54209 6099 144
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99994 1.99802 1.96622 1.81722 1.51068 1.22769 1.08149 1.02555 1.00426 1

tree_stats_height=24
tree_stats_numInternals=574946
tree_stats_numLeaves=426253
tree_stats_numNodes=1001199
tree_stats_numKeys=1001199

tree_stats_avgDegreeInternal=1.74138
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.42574
tree_stats_avgKeyDepth=18.3086


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=203184
first_thread_announced_epoch_by_thread=2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902 2902
sum_num_inserts_by_thread=95672 95716 97560 97441 94159 96340 94492 96981 97517 99048 96754 97191 95339 96791 96840 94953 98394 94209 96227 96941 97419 97730 96130 97039 96311 96877 97267 97341 95368 95769 95599 96815 97899 95904 95654 96588 96544 96571 97233 95034 97997 96263 94836 96166 97104 97921 96794 96743 96891 97221 98273 97230 95825 97683 96569 98187 99205 96602 97643 96785 93650 97043 97870 98694 98182 96595 95992 96193 96152 98045 96612 97812 96772 97145 97718 98199 96662 97559 95917 97796 98593 98963 98222 96656 96369 98110 98129 96267 94480 97056 95973 97033 97066 98054 97242 97346 93519 94106 96120 95567 94155 95420 94504 96214 95727 96363 94246 93858 94870 94751 96208 97348 96066 94666 93884 95329 96442 96815 95352 93425 94885 94865 95644 95484 94809 94940 94365 95747 96662 94635 93915 94805 94708 93412 95161 97503 95372 95555 94547 94807 95898 97103 94479 95268
sum_num_inserts_total=13867286
sum_num_deletes_by_thread=95753 96087 96512 97182 94896 97261 94895 97534 97864 98686 96853 97017 95511 97160 96454 94880 98206 95007 96250 96801 98127 97916 96374 96593 96452 96192 96397 97363 95293 95267 95875 97064 98581 96234 95624 96374 96370 96905 97506 95475 97569 95846 94388 96904 97652 98098 96234 96580 96484 97639 98191 98147 95929 97548 95897 97655 99316 96830 97496 97247 93914 97374 97946 99002 97566 96873 96071 96013 96585 97925 96773 97301 97543 97997 97808 98511 97503 97524 95518 97614 98570 98930 97904 96536 96914 97657 97692 96713 93820 97029 95975 96912 96557 97946 97082 98258 94207 94261 96206 95745 93827 95741 94744 96039 95678 96519 93761 94336 94551 94482 96148 97654 95597 94626 93207 95239 95845 97058 95533 93652 94458 95302 95672 95408 95584 94519 94222 95412 97092 95137 93660 94633 94851 92912 95335 96899 96094 94983 94108 95189 95623 97340 93742 94171
sum_num_deletes_total=13869299
sum_num_searches_by_thread=1717591 1730113 1744261 1749367 1692576 1742054 1705369 1755543 1760945 1769922 1741593 1742184 1715772 1752959 1738873 1707995 1766279 1714697 1732560 1743649 1758909 1765653 1734058 1737538 1728297 1736477 1738558 1756666 1716523 1728328 1727103 1745362 1763748 1725620 1722557 1736686 1730956 1745349 1752726 1711248 1754382 1732493 1702171 1741660 1751507 1764003 1734971 1735115 1735775 1756306 1772320 1754797 1722812 1756163 1735173 1761796 1778544 1744731 1759156 1751904 1688863 1753161 1762181 1777582 1759057 1740744 1727790 1720960 1738387 1764407 1737539 1755468 1747458 1755351 1756312 1769876 1747681 1760109 1723805 1761296 1777749 1774472 1764708 1743646 1742295 1764997 1761151 1730082 1694158 1743431 1731681 1737734 1742636 1761623 1741853 1753366 1690010 1696901 1726005 1724644 1702130 1722063 1698676 1728815 1727698 1740249 1688140 1697635 1700303 1705120 1727799 1741283 1727065 1701308 1680755 1713506 1731442 1745671 1714843 1681042 1705510 1713569 1721568 1721554 1708017 1709737 1693205 1721322 1741023 1709221 1690641 1711424 1709595 1683244 1712469 1749039 1732647 1713868 1697796 1708237 1729039 1737738 1698253 1701365
sum_num_searches_total=249579236
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=1909016 1921916 1938333 1943990 1881631 1935655 1894756 1950058 1956326 1967656 1935200 1936392 1906622 1946910 1932167 1897828 1962879 1903913 1925037 1937391 1954455 1961299 1926562 1931170 1921060 1929546 1932222 1951370 1907184 1919364 1918577 1939241 1960228 1917758 1913835 1929648 1923870 1938825 1947465 1901757 1949948 1924602 1891395 1934730 1946263 1960022 1927999 1928438 1929150 1951166 1968784 1950174 1914566 1951394 1927639 1957638 1977065 1938163 1954295 1945936 1876427 1947578 1957997 1975278 1954805 1934212 1919853 1913166 1931124 1960377 1930924 1950581 1941773 1950493 1951838 1966586 1941846 1955192 1915240 1956706 1974912 1972365 1960834 1936838 1935578 1960764 1956972 1923062 1882458 1937516 1923629 1931679 1936259 1957623 1936177 1948970 1877736 1885268 1918331 1915956 1890112 1913224 1887924 1921068 1919103 1933131 1876147 1885829 1889724 1894353 1920155 1936285 1918728 1890600 1867846 1904074 1923729 1939544 1905728 1868119 1894853 1903736 1912884 1912446 1898410 1899196 1881792 1912481 1934777 1898993 1878216 1900862 1899154 1869568 1902965 1943441 1924113 1904406 1886451 1898233 1920560 1932181 1886474 1890804
average_num_operations_total=1925804
stdev_num_operations_total=2190
sum_num_operations_total=277315821
min_num_operations_total=1867846
max_num_operations_total=1977065
first_time_thread_terminate_by_thread=10000126 10000123 10000126 10000125 10000126 10000124 10000122 10000126 10000122 10000119 10000125 10000119 10000126 10000124 10000126 10000123 10000121 10000122 10000125 10000119 10000121 10000118 10000121 10000121 10000156 10000125 10000126 10000120 10000126 10000124 10000120 10000126 10000122 10000122 10000121 10000120 10000126 10000124 10000123 10000123 10000119 10000122 10000125 10000126 10000121 10000118 10000125 10000121 10000123 10000121 10000124 10000125 10000123 10000124 10000124 10000121 10000123 10000120 10000120 10000120 10000124 10000124 10000123 10000123 10000120 10000120 10000120 10000123 10000121 10000120 10000123 10000120 10000123 10000121 10000124 10000123 10000123 10000124 10000120 10000120 10000172 10000120 10000120 10000120 10000124 10000124 10000123 10000121 10000120 10000122 10000121 10000123 10000121 10000120 10000123 10000121 10000126 10000126 10000125 10000121 10000122 10000126 10000121 10000122 10000121 10000125 10000126 10000122 10000122 10000122 10000122 10000125 10000123 10000122 10000122 10000127 10000122 10000122 10000122 10000122 10000122 10000125 10000122 10000124 10000122 10000127 10000121 10000122 10000121 10000125 10000125 10000122 10000124 10000122 10000124 10000125 10000122 10000123 10000124 10000126 10000122 10000122 10000122 10000122
min_time_thread_terminate_total=10000118
max_time_thread_terminate_total=10000172
first_time_thread_start_by_thread=5 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 10 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 7 6 6 6 7 7 7 7 6 6 6 7 6 7 7 6 7 7 6 6 7 6 6 6 7 6 6 6 7 7 7 7 6 6 6 7 6 7 7 6 7 7 6 6 7 6 6 7 7 6 6 6 6 6 7 6 7 7 6 6 6 6 6 6 7 6 6 6 7 6 6 7 7 6 6 6 6 6 7 6 7 7 6 6 6 6 6 6 7 6 6 6 7 6 6
min_time_thread_start_total=5
max_time_thread_start_total=10
sum_duration_all_ops_total=

threads_final_keysum=1001230624633
threads_final_size=1001199
final_keysum=1001230624633
final_size=1001199
validate_result=success
Validation OK.
Structural validation OK.

total_find=249579236
total_rq=0
total_inserts=13867286
total_deletes=13869299
total_updates=27736585
total_queries=249579236
total_ops=277315821
find_throughput=24957923
rq_throughput=0
update_throughput=2773658
query_throughput=24957923
total_throughput=27731582


total find                    : 249579236
total rq                      : 0
total inserts                 : 13867286
total deletes                 : 13869299
total updates                 : 27736585
total queries                 : 249579236
total ops                     : 277315821
find throughput               : 24957923
rq throughput                 : 0
update throughput             : 2773658
query throughput              : 24957923
total throughput              : 27731582

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

PAPI_L2_TCM=14.2229
PAPI_L3_TCM=2.54726
PAPI_TOT_CYC=14244.6
PAPI_TOT_INS=17105.9
garbage=123835249057140
total_execution_walltime=13.399s
REALTIME_MAIN_END_PERF_FORMAT=6998217.411019218
HyTM1 system shutdown:
    HTM_ATTEMPT_THRESH=40
[fast htm]
total fast htm commit         : 285045633
[slow htm]
[fallback]
total fallback commit         : 186572
seconds global lock is held   : 10.1277
[time_cmd_output] time_elapsed_sec=13.57, faults_major=0, faults_minor=304368, mem_maxresident_kb=795700, user_cputime=1877.70, sys_cputime=13.39, percent_cpu=13931%
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