__step=000270
__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.hybridnorec -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=data000270.txt
__path_data=data/data000270.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6997858.620537886
binary=./brown_sigouin_int_avl_tm_auto.debra.hybridnorec
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


Hybrid noREC system ready

Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.027s
prefilling_size=216723 prefilling_elapsed_millis=1.001s
prefilling_size=235673 prefilling_elapsed_millis=1.101s
prefilling_size=253973 prefilling_elapsed_millis=1.201s
prefilling_size=271873 prefilling_elapsed_millis=1.301s
prefilling_size=289229 prefilling_elapsed_millis=1.401s
prefilling_size=306264 prefilling_elapsed_millis=1.502s
prefilling_size=323048 prefilling_elapsed_millis=1.602s
prefilling_size=339379 prefilling_elapsed_millis=1.702s
prefilling_size=355123 prefilling_elapsed_millis=1.802s
prefilling_size=370714 prefilling_elapsed_millis=1.902s
prefilling_size=385943 prefilling_elapsed_millis=2.003s
prefilling_size=400572 prefilling_elapsed_millis=2.103s
prefilling_size=415048 prefilling_elapsed_millis=2.203s
prefilling_size=429144 prefilling_elapsed_millis=2.303s
prefilling_size=442881 prefilling_elapsed_millis=2.403s
prefilling_size=456173 prefilling_elapsed_millis=2.503s
prefilling_size=469339 prefilling_elapsed_millis=2.604s
prefilling_size=482069 prefilling_elapsed_millis=2.704s
prefilling_size=494246 prefilling_elapsed_millis=2.804s
prefilling_size=506273 prefilling_elapsed_millis=2.904s
prefilling_size=518092 prefilling_elapsed_millis=3.004s
prefilling_size=529581 prefilling_elapsed_millis=3.105s
prefilling_size=540998 prefilling_elapsed_millis=3.205s
prefilling_size=551987 prefilling_elapsed_millis=3.305s
prefilling_size=562865 prefilling_elapsed_millis=3.405s
prefilling_size=573319 prefilling_elapsed_millis=3.505s
prefilling_size=583351 prefilling_elapsed_millis=3.605s
prefilling_size=593015 prefilling_elapsed_millis=3.706s
prefilling_size=602542 prefilling_elapsed_millis=3.806s
prefilling_size=611945 prefilling_elapsed_millis=3.906s
prefilling_size=621273 prefilling_elapsed_millis=4.006s
prefilling_size=630091 prefilling_elapsed_millis=4.106s
prefilling_size=639125 prefilling_elapsed_millis=4.206s
prefilling_size=647883 prefilling_elapsed_millis=4.307s
prefilling_size=656438 prefilling_elapsed_millis=4.407s
prefilling_size=664588 prefilling_elapsed_millis=4.507s
prefilling_size=672502 prefilling_elapsed_millis=4.607s
prefilling_size=680377 prefilling_elapsed_millis=4.707s
prefilling_size=688017 prefilling_elapsed_millis=4.808s
prefilling_size=695591 prefilling_elapsed_millis=4.908s
prefilling_size=702938 prefilling_elapsed_millis=5.008s
Info: prefilling requires an additional insert phase to complete.
Info: prefilling using INSERTION ONLY.
timing_start inserting 297014 keys with 144 threads...
tid=0 thread_prefill_amount=6940 percent_done_estimate=336.5 elapsed_s=6 est_remaining_s=-9 / -3
timing_elapsed 1.11787s
prefilling_size=1000000 prefilling_elapsed_millis=1.12s
finished prefilling to size 1000000 for expected size 1000000 keysum=999590397802, performing 2956579 updates; total_prefilling_elapsed_ms=1120 ms)
pref_size=1000000
pref_millis=1120
prefill_elapsed_ms=1120
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6997865.94512820
REALTIME_END_PERF_FORMAT=6997875.94622362

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

tree_stats_computeWalltime=0.017s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16381 32668 63807 113267 154310 124227 45793 6463 224 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 2 86 1323 12078 58563 141642 145567 57590 8175 274 1
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16383 32754 65130 125345 212873 265869 191360 64053 8399 275 1
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16383 32754 65130 125345 212873 265869 191360 64053 8399 275 1
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 1.99988 1.99939 1.99109 1.94485 1.79465 1.52406 1.2525 1.09542 1.03022 1.00607 1 1

tree_stats_height=25
tree_stats_numInternals=573524
tree_stats_numLeaves=425301
tree_stats_numNodes=998825
tree_stats_numKeys=998825

tree_stats_avgDegreeInternal=1.74156
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.4258
tree_stats_avgKeyDepth=18.3585


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=54384
first_thread_announced_epoch_by_thread=790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790 790
sum_num_inserts_by_thread=18838 18053 18021 19221 18608 19167 18605 18601 18788 19007 18807 19409 18482 19124 19381 19148 18669 19087 18661 18392 19069 18949 19195 19521 18950 18871 18579 19363 19461 19231 18967 18748 19035 18599 18643 19136 18468 18214 19293 18586 18592 19555 18711 18244 19103 19211 19011 19589 11676 11693 11879 11696 11986 11322 11953 11842 12304 11751 11656 11513 11905 11760 11940 12036 11693 11943 11058 10963 11963 12048 11725 12118 11742 11778 11799 11862 11927 11301 11600 11644 11981 11825 11712 12134 11865 11679 12260 12043 11511 11636 11380 11519 12140 11920 11705 12062 20253 19990 20410 20333 20168 20120 19791 19991 20064 20583 19994 20091 20492 20137 19941 20420 20557 20309 19757 19723 20116 20148 20533 20320 20029 19574 19902 19978 20069 19641 20185 19922 20248 20011 20718 19687 20473 20248 19989 20174 20095 20322 19840 19559 20453 20450 20455 20378
sum_num_inserts_total=2439052
sum_num_deletes_by_thread=18632 18251 18330 19005 18859 19302 18758 18395 18647 19161 18751 19161 18437 18832 19529 19100 18691 19063 18498 18529 19211 18899 18926 19880 18903 18880 18340 19426 19358 19450 18951 18967 19166 18723 18960 19344 18586 18611 19048 18895 18637 19583 18510 18457 19111 19201 18965 19761 11686 11744 11828 11705 11920 11207 11921 11733 12016 11622 11587 11595 11702 11794 11687 11928 11603 11986 11296 11295 12079 11744 11711 12013 11712 12259 11793 12020 11779 11284 11696 11833 12103 12166 11647 12309 11966 11476 12019 11991 11490 11802 11249 11589 11941 12041 12008 11873 20473 19857 19968 20452 20025 20029 19757 19919 20457 20865 19990 20350 20352 19921 19962 20321 20406 20208 20064 19708 20223 20010 20661 20417 20081 19831 20085 20435 19738 19653 20277 20057 20371 20278 20844 19790 20496 20305 20041 20252 20265 20161 19940 19686 20214 20784 20265 20343
sum_num_deletes_total=2442715
sum_num_searches_by_thread=334768 326885 329030 344143 340590 346823 335899 332698 339627 343338 336104 345823 331825 341485 352742 345238 336365 343441 334206 333692 341947 339737 343505 356186 336382 342322 333154 347524 348291 346508 340578 340603 345986 336095 338114 343219 332210 329861 345069 339862 333617 355016 336363 330654 341022 344340 340715 352562 210669 210357 213998 212883 217410 203581 212883 212515 218788 214125 207550 207605 212672 211755 211678 215966 208383 212014 203489 198813 214812 212188 208357 219095 210879 214892 209884 217282 213175 200512 209641 212010 216291 217656 209502 220495 209871 204324 215568 213463 206174 209727 203136 207620 215695 214632 211040 215633 365620 356167 362582 365201 362063 363453 353019 358506 361986 373678 357926 363369 370429 360034 358633 363829 366423 364456 357004 354820 359721 360667 372630 367566 360475 357359 359764 363126 360631 354839 361598 359937 363919 364969 374499 356880 367732 366665 361521 364339 362046 363094 360619 353611 366152 370525 369240 367009
sum_num_searches_total=43897183
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=372238 363189 365381 382369 378057 385292 373262 369694 377062 381506 373662 384393 368744 379441 391652 383486 373725 381591 371365 370613 380227 377585 381626 395587 374235 380073 370073 386313 387110 385189 378496 378318 384187 373417 375717 381699 369264 366686 383410 377343 370846 394154 373584 367355 379236 382752 378691 391912 234031 233794 237705 236284 241316 226110 236757 236090 243108 237498 230793 230713 236279 235309 235305 239930 231679 235943 225843 221071 238854 235980 231793 243226 234333 238929 233476 241164 236881 223097 232937 235487 240375 241647 232861 244938 233702 227479 239847 237497 229175 233165 225765 230728 239776 238593 234753 239568 406346 396014 402960 405986 402256 403602 392567 398416 402507 415126 397910 403810 411273 400092 398536 404570 407386 404973 396825 394251 400060 400825 413824 408303 400585 396764 399751 403539 400438 394133 402060 399916 404538 405258 416061 396357 408701 407218 401551 404765 402406 403577 400399 392856 406819 411759 409960 407730
average_num_operations_total=338742
stdev_num_operations_total=6234
sum_num_operations_total=48778950
min_num_operations_total=221071
max_num_operations_total=416061
first_time_thread_terminate_by_thread=10000327 10000258 10000272 10000339 10000848 10000368 10000212 10000289 10000120 10000329 10000226 10000365 10000346 10000113 10000350 10000330 10000364 10000362 10000340 10000207 10000361 10000228 10000840 10000113 10000245 10000112 10000242 10000338 10000345 10000371 10000182 10000111 10000335 10000287 10000224 10000836 10000321 10000366 10000326 10000216 10000369 10000284 10000370 10000205 10000296 10000239 10000841 10000275 10000851 10000843 10000845 10000249 10000319 10000156 10000857 10000353 10000215 10000111 10000310 10000856 10000858 10000189 10000316 10000862 10000278 10000253 10000318 10000265 10000356 10000193 10000268 10000865 10000314 10000859 10000860 10000855 10000348 10000152 10000850 10000292 10000842 10000852 10000179 10000257 10000858 10000354 10000302 10000219 10000308 10000837 10000861 10000865 10000358 10000848 10000851 10000863 10000197 10000229 10000163 10000304 10000306 10000307 10000115 10000262 10000139 10000332 10000161 10000344 10000235 10000109 10000132 10000260 10000109 10000323 10000124 10000298 10000838 10000165 10000136 10000174 10000109 10000128 10000121 10000110 10000233 10000334 10000112 10000263 10000159 10000148 10000303 10000359 10000141 10000109 10000198 10000146 10000200 10000109 10000293 10000112 10000864 10000170 10000117 10000172
min_time_thread_terminate_total=10000109
max_time_thread_terminate_total=10000865
first_time_thread_start_by_thread=10 4 5 4 4 5 5 4 4 5 4 5 4 4 5 4 5 5 4 5 5 4 4 5 4 4 5 4 4 5 5 4 4 5 4 5 4 4 5 4 5 5 4 5 5 4 4 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5
min_time_thread_start_total=4
max_time_thread_start_total=10
sum_duration_all_ops_total=

threads_final_keysum=998700422095
threads_final_size=998825
final_keysum=998700422095
final_size=998825
validate_result=success
Validation OK.
Structural validation OK.

total_find=43897183
total_rq=0
total_inserts=2439052
total_deletes=2442715
total_updates=4881767
total_queries=43897183
total_ops=48778950
find_throughput=4389718
rq_throughput=0
update_throughput=488176
query_throughput=4389718
total_throughput=4877895


total find                    : 43897183
total rq                      : 0
total inserts                 : 2439052
total deletes                 : 2442715
total updates                 : 4881767
total queries                 : 43897183
total ops                     : 48778950
find throughput               : 4389718
rq throughput                 : 0
update throughput             : 488176
query throughput              : 4389718
total throughput              : 4877895

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

PAPI_L2_TCM=28.2279
PAPI_L3_TCM=6.20147
PAPI_TOT_CYC=81971.3
PAPI_TOT_INS=8584.95
garbage=21918792175438
total_execution_walltime=16.601s
REALTIME_MAIN_END_PERF_FORMAT=6997875.223399894
Hybrid noREC system shutdown:
    HTM_ATTEMPT_THRESH=40
[fast htm]
total fast htm commit         : 48264584
[slow htm]
[fallback]
total fallback commit         : 3470946
seconds global lock is held   : 0.659798
[time_cmd_output] time_elapsed_sec=16.73, faults_major=0, faults_minor=120167, mem_maxresident_kb=475956, user_cputime=2338.33, sys_cputime=6.76, percent_cpu=14009%
timeout=false
algorithm=brown_sigouin_int_avl_tm_auto.debra.hybridnorec
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=2