__step=000231
__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.hybridnorec -nwork 190 -nprefill 190 -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=data000231.txt
__path_data=data/data000231.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6997285.328692537
binary=./brown_int_bst_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_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=190
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=190
WORK_THREADS=190
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,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,72,73,74,75,76,77,78,79,80,81,82,83,84,85,86,87,88,89,90,91,92,93,94,95,168,169,170,171,172,173,174,175,176,177,178,179,180,181,182,183,184,185,186,187,188,189


Hybrid noREC system ready

Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.071s
prefilling_size=189139 prefilling_elapsed_millis=1.005s
prefilling_size=206006 prefilling_elapsed_millis=1.105s
prefilling_size=222745 prefilling_elapsed_millis=1.205s
prefilling_size=238792 prefilling_elapsed_millis=1.306s
prefilling_size=254527 prefilling_elapsed_millis=1.406s
prefilling_size=270138 prefilling_elapsed_millis=1.506s
prefilling_size=285333 prefilling_elapsed_millis=1.607s
prefilling_size=300232 prefilling_elapsed_millis=1.707s
prefilling_size=314820 prefilling_elapsed_millis=1.807s
prefilling_size=329218 prefilling_elapsed_millis=1.907s
prefilling_size=343220 prefilling_elapsed_millis=2.008s
prefilling_size=357052 prefilling_elapsed_millis=2.108s
prefilling_size=370562 prefilling_elapsed_millis=2.208s
prefilling_size=383764 prefilling_elapsed_millis=2.308s
prefilling_size=396859 prefilling_elapsed_millis=2.409s
prefilling_size=409553 prefilling_elapsed_millis=2.509s
prefilling_size=421971 prefilling_elapsed_millis=2.609s
prefilling_size=434095 prefilling_elapsed_millis=2.71s
prefilling_size=446021 prefilling_elapsed_millis=2.81s
prefilling_size=457523 prefilling_elapsed_millis=2.91s
prefilling_size=468821 prefilling_elapsed_millis=3.011s
prefilling_size=479946 prefilling_elapsed_millis=3.111s
prefilling_size=490717 prefilling_elapsed_millis=3.211s
prefilling_size=501364 prefilling_elapsed_millis=3.312s
prefilling_size=511746 prefilling_elapsed_millis=3.412s
prefilling_size=521622 prefilling_elapsed_millis=3.512s
prefilling_size=531865 prefilling_elapsed_millis=3.613s
prefilling_size=541473 prefilling_elapsed_millis=3.713s
prefilling_size=551075 prefilling_elapsed_millis=3.813s
prefilling_size=560626 prefilling_elapsed_millis=3.914s
prefilling_size=569741 prefilling_elapsed_millis=4.014s
prefilling_size=578616 prefilling_elapsed_millis=4.114s
prefilling_size=587462 prefilling_elapsed_millis=4.215s
prefilling_size=596170 prefilling_elapsed_millis=4.315s
prefilling_size=604678 prefilling_elapsed_millis=4.415s
prefilling_size=613146 prefilling_elapsed_millis=4.515s
prefilling_size=621296 prefilling_elapsed_millis=4.616s
prefilling_size=629427 prefilling_elapsed_millis=4.716s
prefilling_size=637211 prefilling_elapsed_millis=4.817s
prefilling_size=645180 prefilling_elapsed_millis=4.917s
prefilling_size=652681 prefilling_elapsed_millis=5.017s
Info: prefilling requires an additional insert phase to complete.
Info: prefilling using INSERTION ONLY.
timing_start inserting 347241 keys with 190 threads...
tid=0 thread_prefill_amount=2104 percent_done_estimate=115.1 elapsed_s=5 est_remaining_s=-2 / 4
tid=0 thread_prefill_amount=3156 percent_done_estimate=172.7 elapsed_s=7 est_remaining_s=-6 / 0
timing_elapsed 1.41859s
prefilling_size=1000000 prefilling_elapsed_millis=1.422s
finished prefilling to size 1000000 for expected size 1000000 keysum=999614471648, performing 2713559 updates; total_prefilling_elapsed_ms=1422 ms)
pref_size=1000000
pref_millis=1422
prefill_elapsed_ms=1422
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=14

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6997292.177128490
REALTIME_END_PERF_FORMAT=6997302.177220817

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

tree_stats_computeWalltime=0.014s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 63 124 244 474 887 1642 2917 4965 7954 12107 17544 24227 31332 38218 44474 49190 52069 53003 51857 49096 44867 39819 33961 27561 21291 15884 11294 7502 4721 2816 1675 940 512 241 126 51 20 9 1 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 1 1 6 33 73 211 473 1048 2054 3602 5803 8999 13024 16843 21164 24309 26942 28575 28656 27824 26065 23772 21024 17725 13917 10590 7862 5310 3435 2024 1213 707 404 179 103 44 16 9 0 1
tree_stats_numNodesAtDepth=1 2 4 8 16 32 63 125 245 480 920 1715 3128 5438 9002 14161 21146 30030 40331 51242 61317 70354 76378 79945 80432 77752 72691 65884 57733 48585 39016 29801 21884 15364 10031 6251 3699 2153 1219 645 305 154 64 25 10 1 1
tree_stats_numKeysAtDepth=1 2 4 8 16 32 63 125 245 480 920 1715 3128 5438 9002 14161 21146 30030 40331 51242 61317 70354 76378 79945 80432 77752 72691 65884 57733 48585 39016 29801 21884 15364 10031 6251 3699 2153 1219 645 305 154 64 25 10 1 1
tree_stats_avgDegreeAtDepth=2 2 2 2 2 1.96875 1.98413 1.968 1.96327 1.92917 1.9 1.86647 1.80595 1.74237 1.68951 1.6383 1.59047 1.53626 1.49366 1.45078 1.42207 1.38645 1.36497 1.3431 1.32195 1.30346 1.28913 1.2719 1.2533 1.23577 1.21812 1.20134 1.18598 1.16461 1.15253 1.14126 1.12922 1.12959 1.10911 1.09922 1.0918 1.08442 1.07812 1.04 1 1 1

tree_stats_height=47
tree_stats_numInternals=655742
tree_stats_numLeaves=344041
tree_stats_numNodes=999783
tree_stats_numKeys=999783

tree_stats_avgDegreeInternal=1.52466
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34412
tree_stats_avgKeyDepth=23.996

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=250


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:2 4:232 8:8377 16:27593 32:8246 64:2
    (2^01, 2^02]: 2
    (2^02, 2^03]: 232
    (2^03, 2^04]: 8377
    (2^04, 2^05]: 27593
    (2^05, 2^06]: 8246
    (2^06, 2^07]: 2
sum_limbo_reclamation_event_size_total=1075307
count_limbo_reclamation_event_size_by_thread=234 234 234 234 234 233 234 233 234 234 234 234 234 234 234 234 233 234 234 234 233 234 234 234 234 233 234 234 234 234 234 233 234 234 234 234 234 233 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 233 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234 234
count_limbo_reclamation_event_size_total=44452
sum_limbo_reclamation_event_count_total=44974
first_thread_announced_epoch_by_thread=500 500 500 500 500 498 500 498 500 500 500 500 500 500 500 500 498 500 500 500 498 500 500 500 500 498 500 500 500 500 500 498 500 500 500 500 500 498 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 498 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500 500
sum_num_inserts_by_thread=6208 6366 6617 6376 6514 6344 6739 6309 6741 6464 5917 6093 6673 6350 6316 6310 6480 6416 6802 6283 6365 6654 6298 6088 6712 6386 6640 6739 6299 6219 6583 6416 6696 6549 6235 6083 6378 6373 6574 6587 6453 6393 6851 6311 6444 6223 6020 6017 14671 13387 15041 14199 14172 14476 14969 14722 14810 14641 14330 14459 15211 14799 14426 14221 14195 14306 14788 14164 14405 14528 14228 14340 15397 14454 14930 14683 14009 14169 15238 14500 14910 14656 14454 14532 15355 14579 14212 14330 14389 13510 14376 14152 14363 14117 13866 14081 13552 12796 13006 13042 12751 12785 13374 13285 13062 13025 12365 12571 13873 12941 12732 13116 12619 12476 13526 12744 12793 13090 12814 12429 14035 12609 13222 12674 12773 12462 13224 12404 13351 13430 12969 12800 13326 13218 12714 13316 12755 12925 13436 12982 12349 12912 12271 12388 11198 11652 11405 11150 11427 10663 11593 11954 11627 11541 11349 10632 11761 11570 11378 11482 10907 11214 11786 11277 11257 11866 21155 21036 11559 11466 11507 11158 11565 10998 11820 11440 11795 11533 11405 10841 11644 11719 11341 11680 11098 10897 11902 11517 10723 11365
sum_num_inserts_total=2167819
sum_num_deletes_by_thread=6310 6116 6727 6409 6444 6541 6656 6462 6795 6459 6053 5977 6777 6304 6429 6379 6553 6253 6671 6195 6430 6743 6230 6245 6589 6508 6371 6694 6270 6181 6540 6332 6778 6575 6089 6128 6276 6540 6492 6575 6637 6449 6693 6338 6423 6553 6035 5842 14850 13665 14885 14264 14263 14234 15076 14927 14627 14886 14269 14410 15158 14579 14481 14103 14091 14179 14639 14525 14382 14673 14101 14296 15199 14212 14629 14546 14226 14346 15167 14426 14796 14646 14280 14505 15426 14458 14057 14156 14434 13910 14416 14135 14259 14403 13790 14070 13059 12611 13079 12957 12855 12818 13135 13279 13274 12930 12413 12761 14018 13013 12624 12914 12553 12711 13461 12890 12784 12895 12765 12316 14128 12634 13186 12833 13072 12698 13293 12695 13126 13244 12863 13005 13488 13251 12724 13256 12508 12954 13430 12991 12389 12857 12419 12452 10999 11664 11532 11204 11532 10649 11436 11982 11772 11540 11289 10766 11904 11602 11609 11644 10924 11157 12148 11369 11217 11718 21156 21406 11731 11356 11271 11316 11519 10946 11792 11506 11426 11571 11266 10875 11740 11523 11257 11430 11202 11089 11860 11549 10813 11228
sum_num_deletes_total=2168217
sum_num_searches_by_thread=111224 112106 121282 115190 115483 114335 121361 114984 122685 117334 109229 105939 121298 113862 113854 113467 119384 113667 121949 113296 115490 118855 112980 111676 119438 116470 117291 119474 111837 112283 117398 114120 120922 117049 109631 109639 112274 115892 117357 118472 116390 115385 120841 114633 115597 114078 108256 106762 266336 245300 269834 256773 256543 260762 272260 268258 264248 268094 255584 258131 272958 263904 262534 255083 255478 254634 263708 258979 261178 261404 253750 254792 275069 258571 265112 264564 253843 256196 273246 259436 269272 261088 259572 259903 278493 262365 255769 257245 259466 246136 261687 256774 257415 253577 247892 250264 241002 232142 234250 231306 229927 232052 238839 236912 235088 233090 220823 225675 250509 232490 226597 235802 226837 226597 243290 227447 230050 231812 230403 221215 255197 226524 236823 230036 234249 228529 239881 227202 238970 240821 231652 232045 242692 240748 228468 236773 226727 230684 241456 235860 224360 233013 224927 224782 199569 211139 206164 199011 208920 193209 205209 212984 210762 209072 205327 193981 214451 208896 206644 209534 195355 199912 213128 201414 202155 212382 385450 384855 209229 207124 204510 202511 207899 200480 213342 205047 207214 206905 203764 194573 212273 209177 205099 205969 201697 200121 216022 209993 192607 203664
sum_num_searches_total=39031216
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=123742 124588 134626 127975 128441 127220 134756 127755 136221 130257 121199 118009 134748 126516 126599 126156 132417 126336 135422 125774 128285 132252 125508 124009 132739 129364 130302 132907 124406 124683 130521 126868 134396 130173 121955 121850 124928 128805 130423 131634 129480 128227 134385 127282 128464 126854 120311 118621 295857 272352 299760 285236 284978 289472 302305 297907 293685 297621 284183 287000 303327 293282 291441 283407 283764 283119 293135 287668 289965 290605 282079 283428 305665 287237 294671 293793 282078 284711 303651 288362 298978 290390 288306 288940 309274 291402 284038 285731 288289 273556 290479 285061 286037 282097 275548 278415 267613 257549 260335 257305 255533 257655 265348 263476 261424 259045 245601 251007 278400 258444 251953 261832 252009 251784 270277 253081 255627 257797 255982 245960 283360 251767 263231 255543 260094 253689 266398 252301 265447 267495 257484 257850 269506 267217 253906 263345 251990 256563 268322 261833 249098 258782 249617 249622 221766 234455 229101 221365 231879 214521 228238 236920 234161 232153 227965 215379 238116 232068 229631 232660 217186 222283 237062 224060 224629 235966 427761 427297 232519 229946 227288 224985 230983 222424 236954 227993 230435 230009 226435 216289 235657 232419 227697 229079 223997 222107 239784 233059 214143 226257
average_num_operations_total=228248
stdev_num_operations_total=4716
sum_num_operations_total=43367252
min_num_operations_total=118009
max_num_operations_total=427761
first_time_thread_terminate_by_thread=10000537 10000241 10000536 10000480 10000555 10000193 10000545 10000344 10000527 10000525 10000501 10000549 10000160 10000108 10000494 10000433 10000190 10000548 10000270 10000404 10000297 10000544 10000551 10000531 10000438 10000246 10000516 10000373 10000547 10000521 10000092 10000135 10000408 10000540 10000402 10000544 10000157 10000101 10000503 10000322 10000538 10000095 10000541 10000520 10000187 10000507 10000550 10000530 10000238 10000413 10000248 10000418 10000384 10000120 10000390 10000425 10000227 10000371 10000445 10000165 10000300 10000250 10000092 10000427 10000266 10000386 10000483 10000333 10000424 10000441 10000095 10000480 10000448 10000420 10000263 10000430 10000092 10000267 10000446 10000389 10000114 10000411 10000454 10000325 10000417 10000234 10000225 10000228 10000276 10000222 10000455 10000093 10000440 10000450 10000232 10000452 10000534 10000209 10000486 10000218 10000518 10000560 10000272 10000561 10000472 10000562 10000563 10000561 10000135 10000208 10000213 10000559 10000564 10000273 10000559 10000553 10000091 10000492 10000556 10000560 10000533 10000393 10000152 10000216 10000092 10000103 10000150 10000554 10000094 10000563 10000564 10000263 10000139 10000558 10000542 10000559 10000564 10000142 10000144 10000556 10000562 10000490 10000093 10000474 10000360 10000348 10000379 10000356 10000174 10000180 10000496 10000465 10000495 10000184 10000428 10000094 10000130 10000202 10000467 10000468 10000328 10000499 10000407 10000293 10000524 10000461 10000351 10000315 10000366 10000167 10000254 10000307 10000284 10000367 10000377 10000463 10000369 10000457 10000288 10000509 10000093 10000320 10000314 10000256 10000338 10000511 10000459 10000355 10000513 10000258
min_time_thread_terminate_total=10000091
max_time_thread_terminate_total=10000564
first_time_thread_start_by_thread=10 4 4 4 4 4 4 4 4 4 5 4 4 4 4 4 4 4 4 4 4 4 4 4 3 4 4 4 4 4 4 4 4 4 5 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 5 5 4 4 4 5 5 5 5 4 4 4 4 4 4 5 4 4 4 4 5 4 4 4 5 5 4 4 4 5 5 5 5 4 4 4 4 4 4 5 4 4 4 4 5 4 4 4 5 4 4 4 4 4 5 4 4 5 4 4 4 4 5 4 4 4 4 5 4 4 4 4 5 4 4 4 4 4 5 4 4 5 4 4 4 4 5 4 4 4 4 5 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 5 4 4 4 4 4 4 5 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 5 4 4 4 4 4 4 5
min_time_thread_start_total=3
max_time_thread_start_total=10
sum_duration_all_ops_total=

threads_final_keysum=1000068207766
threads_final_size=999783
final_keysum=1000068207766
final_size=999783
validate_result=success
Validation OK.
Structural validation OK.

total_find=39031216
total_rq=0
total_inserts=2167819
total_deletes=2168217
total_updates=4336036
total_queries=39031216
total_ops=43367252
find_throughput=3903121
rq_throughput=0
update_throughput=433603
query_throughput=3903121
total_throughput=4336725


total find                    : 39031216
total rq                      : 0
total inserts                 : 2167819
total deletes                 : 2168217
total updates                 : 4336036
total queries                 : 39031216
total ops                     : 43367252
find throughput               : 3903121
rq throughput                 : 0
update throughput             : 433603
query throughput              : 3903121
total throughput              : 4336725

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

PAPI_L2_TCM=27.7893
PAPI_L3_TCM=4.8322
PAPI_TOT_CYC=121748
PAPI_TOT_INS=9281.43
garbage=19499527469650
total_execution_walltime=16.978s
REALTIME_MAIN_END_PERF_FORMAT=6997302.308180043
Hybrid noREC system shutdown:
    HTM_ATTEMPT_THRESH=40
[fast htm]
total fast htm commit         : 42987319
[slow htm]
[fallback]
total fallback commit         : 3093493
seconds global lock is held   : 0.292998
[time_cmd_output] time_elapsed_sec=17.11, faults_major=0, faults_minor=105811, mem_maxresident_kb=416356, user_cputime=3135.57, sys_cputime=6.53, percent_cpu=18361%
timeout=false
algorithm=brown_int_bst_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=1