__step=000446
__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 144 -nprefill 144 -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=data000446.txt
__path_data=data/data000446.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=7000172.756222509
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=200000
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=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


Hybrid noREC system ready

Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.054s
prefilling_size=89437 prefilling_elapsed_millis=1s
prefilling_size=91539 prefilling_elapsed_millis=1.1s
prefilling_size=93215 prefilling_elapsed_millis=1.201s
prefilling_size=94461 prefilling_elapsed_millis=1.301s
prefilling_size=95511 prefilling_elapsed_millis=1.401s
prefilling_size=96425 prefilling_elapsed_millis=1.501s
prefilling_size=97361 prefilling_elapsed_millis=1.601s
prefilling_size=97707 prefilling_elapsed_millis=1.701s
prefilling_size=98323 prefilling_elapsed_millis=1.802s
finished prefilling to size 98310 for expected size 100000 keysum=9837937445, performing 807814 updates; total_prefilling_elapsed_ms=1904 ms)
pref_size=98310
pref_millis=1904
prefill_elapsed_ms=1943
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=5

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=7000175.163007
REALTIME_END_PERF_FORMAT=7000185.268117

###############################################################################
################################## 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 894 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 252 469 824 1358 2153 3106 4135 5079 5882 6358 6476 6055 5473 4695 3748 2926 2157 1526 1021 669 408 254 150 78 35 8 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 2 24 70 166 305 630 1125 1709 2267 2847 3235 3613 3449 3289 2971 2390 1940 1444 1060 718 499 297 185 112 68 30 8
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 254 493 894 1524 2458 3736 5260 6788 8149 9205 9711 9668 8922 7984 6719 5316 4097 2970 2081 1387 907 551 335 190 103 38 8
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 254 493 894 1524 2458 3736 5260 6788 8149 9205 9711 9668 8922 7984 6719 5316 4097 2970 2081 1387 907 551 335 190 103 38 8
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 1.98438 1.94882 1.86207 1.783 1.72178 1.64402 1.57655 1.50437 1.45227 1.40778 1.36426 1.3287 1.29655 1.28144 1.25351 1.23337 1.22028 1.19844 1.18687 1.17588 1.17159 1.15766 1.14701 1.1194 1.13158 1.02913 1 1

tree_stats_height=35
tree_stats_numInternals=65550
tree_stats_numLeaves=34453
tree_stats_numNodes=100003
tree_stats_numKeys=100003

tree_stats_avgDegreeInternal=1.5256
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34452
tree_stats_avgKeyDepth=18.75

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:0 4:22 8:5869 16:41880 32:2773
    (2^02, 2^03]: 22
    (2^03, 2^04]: 5869
    (2^04, 2^05]: 41880
    (2^05, 2^06]: 2773
sum_limbo_reclamation_event_size_total=1130623
count_limbo_reclamation_event_size_by_thread=351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351 351
count_limbo_reclamation_event_size_total=50544
sum_limbo_reclamation_event_count_total=50832
first_thread_announced_epoch_by_thread=716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716 716
sum_num_inserts_by_thread=16037 16691 16685 16289 17378 18138 16301 17244 17053 16513 17111 18275 15917 16687 16226 16753 16201 17973 17008 16673 17591 16751 17230 18178 16623 16642 16138 16470 16908 18283 16344 16720 17482 16323 16901 18476 16622 16188 16994 16954 17180 18299 16955 16180 16605 16177 17582 17354 12136 11364 12049 12135 12031 12282 12168 11498 12159 11599 12306 13512 11816 11458 12162 12094 12148 12326 11450 11970 12562 12228 12401 12967 12025 11217 12030 12210 11730 12123 12091 12093 12100 11526 11740 13961 11940 11600 11847 12079 12066 13076 12345 12062 12749 11630 11891 13052 17422 17052 17978 18100 18937 18747 18316 18068 18216 17650 18850 20536 17601 17544 18468 18395 18603 19723 17869 17859 19220 18237 18520 20554 17790 17850 17548 17875 19234 18953 18032 18530 18162 18519 17962 20096 17826 17687 18310 18460 18360 19942 17795 18069 18992 17975 18577 20291
sum_num_inserts_total=2280607
sum_num_deletes_by_thread=16035 16721 16733 16185 17636 17887 16206 16981 17147 16309 16834 18133 15805 16800 16077 16453 16062 18035 16925 16737 17895 17042 17459 18218 16221 16586 16385 16636 17099 17859 16168 16781 17440 16215 16914 18565 16615 16197 16932 17145 16984 17914 16852 16199 16620 16325 17426 17234 11955 11595 11955 11892 11851 12367 12187 11665 11970 11666 12453 13710 12080 11429 12185 12145 11959 12650 11649 12063 12752 12341 12328 13243 11981 11318 12203 12138 11740 12241 12251 11942 12081 11285 11868 13807 12075 11661 12009 12040 12414 13045 12290 11939 12526 11802 12060 13140 17497 17142 18135 17788 18965 18760 18144 18145 18222 17474 18712 20670 17259 17630 18343 18083 18559 19474 18225 17980 19233 18144 18769 20615 17797 18211 17410 17884 19325 18920 18083 18442 17978 18497 18099 19894 17933 17582 18192 18385 18335 19682 17938 18602 19137 18002 18763 20561
sum_num_deletes_total=2281193
sum_num_searches_by_thread=288471 300021 299088 291849 313681 325153 292629 310067 308052 296646 304755 327171 283793 301467 288957 298495 290564 324454 304895 299359 318369 304816 314023 328484 297643 300477 292628 296727 304342 322873 292027 299232 316866 292698 305226 336408 301459 291377 303426 309559 307314 323951 304078 292142 298746 295058 315995 308264 218918 206334 217529 218048 213773 223108 220190 207556 220581 206555 221656 246160 212985 206725 219393 219264 216845 225179 210213 216530 224891 222903 222049 234512 216010 201983 221474 219674 210778 217543 217081 214885 219565 204394 213426 250817 215991 210682 216191 217912 218872 235506 223786 213284 228725 210150 214798 233599 311738 307078 324066 319460 344811 338206 329304 328829 326210 316552 340383 372480 314180 317902 331215 327282 337160 350991 326038 325785 343754 328766 334922 370728 319076 323773 315891 318194 347934 341668 325073 334269 326251 330476 325415 362410 320288 317808 331467 327956 332542 355950 320904 329614 343335 324569 336772 365920
sum_num_searches_total=41068193
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=320543 333433 332506 324323 348695 361178 325136 344292 342252 329468 338700 363579 315515 334954 321260 331701 322827 360462 338828 332769 353855 338609 348712 364880 330487 333705 325151 329833 338349 359015 324539 332733 351788 325236 339041 373449 334696 323762 337352 343658 341478 360164 337885 324521 331971 327560 351003 342852 243009 229293 241533 242075 237655 247757 244545 230719 244710 229820 246415 273382 236881 229612 243740 243503 240952 250155 233312 240563 250205 247472 246778 260722 240016 224518 245707 244022 234248 241907 241423 238920 243746 227205 237034 278585 240006 233943 240047 242031 243352 261627 248421 237285 254000 233582 238749 259791 346657 341272 360179 355348 382713 375713 365764 365042 362648 351676 377945 413686 349040 353076 368026 363760 374322 390188 362132 361624 382207 365147 372211 411897 354663 359834 350849 353953 386493 379541 361188 371241 362391 367492 361476 402400 356047 353077 367969 364801 369237 395574 356637 366285 381464 360546 374112 406772
average_num_operations_total=316874
stdev_num_operations_total=4650
sum_num_operations_total=45629993
min_num_operations_total=224518
max_num_operations_total=413686
first_time_thread_terminate_by_thread=10000431 10000328 10000205 10000346 10000340 10000381 10000289 10000302 10000355 10000389 10000181 10000208 10000238 10000244 10000140 10000310 10000345 10000105 10000412 10000370 10000378 10000435 10000107 10000135 10000128 10000251 10000212 10000108 10000405 10000380 10000270 10000300 10000354 10000409 10000368 10000249 10000242 10000293 10000315 10000105 10000390 10000236 10000146 10000371 10000313 10000139 10000350 10000343 10000408 10000423 10000217 10000420 10000284 10000254 10000432 10000153 10000433 10000157 10000425 10000422 10000425 10000240 10000407 10000399 10000417 10000246 10000397 10000175 10000411 10000412 10000362 10000339 10000274 10000377 10000255 10000419 10000221 10000427 10000428 10000278 10000433 10000107 10000426 10000421 10000393 10000161 10000169 10000430 10000418 10000414 10000395 10000110 10000429 10000413 10000106 10000415 10000105 10000163 10000228 10000110 10000184 10000286 10000230 10000365 10000323 10000258 10000198 10000308 10000109 10000222 10000383 10000189 10000404 10000333 10000374 10000402 10000118 10000325 10000167 10000375 10000305 10000385 10000226 10000114 10000105 10000105 10000275 10000329 10000359 10000320 10000191 10000168 10000164 10000224 10000264 10000188 10000105 10000351 10000335 10000401 10000400 10000201 10000357 10000387
min_time_thread_terminate_total=10000105
max_time_thread_terminate_total=10000435
first_time_thread_start_by_thread=5 5 4 4 5 5 5 4 5 4 5 4 5 4 5 5 5 5 5 4 4 5 4 5 5 5 4 4 5 5 5 4 5 4 5 4 5 4 5 5 5 5 5 4 4 5 4 5 4 5 4 4 4 4 5 5 5 4 4 5 5 5 4 5 4 4 4 5 4 4 4 4 4 5 4 4 4 4 5 5 5 4 4 5 5 5 4 5 4 4 4 5 4 4 4 4 4 4 4 4 4 4 5 5 4 4 4 3 4 4 4 4 4 4 4 5 4 4 4 4 4 4 4 4 4 4 5 5 4 4 4 9 4 4 4 4 4 4 4 5 4 4 4 4
min_time_thread_start_total=3
max_time_thread_start_total=9
sum_duration_all_ops_total=

threads_final_keysum=10011399090
threads_final_size=100003
final_keysum=10011399090
final_size=100003
validate_result=success
Validation OK.
Structural validation OK.

total_find=41068193
total_rq=0
total_inserts=2280607
total_deletes=2281193
total_updates=4561800
total_queries=41068193
total_ops=45629993
find_throughput=4106819
rq_throughput=0
update_throughput=456180
query_throughput=4106819
total_throughput=4562999


total find                    : 41068193
total rq                      : 0
total inserts                 : 2280607
total deletes                 : 2281193
total updates                 : 4561800
total queries                 : 41068193
total ops                     : 45629993
find throughput               : 4106819
rq throughput                 : 0
update throughput             : 456180
query throughput              : 4106819
total throughput              : 4562999

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

PAPI_L2_TCM=20.1659
PAPI_L3_TCM=3.92468
PAPI_TOT_CYC=87665.5
PAPI_TOT_INS=7018.69
garbage=2033176806849
total_execution_walltime=12.398s
REALTIME_MAIN_END_PERF_FORMAT=7000185.154908400
Hybrid noREC system shutdown:
    HTM_ATTEMPT_THRESH=40
[fast htm]
total fast htm commit         : 44005073
[slow htm]
[fallback]
total fallback commit         : 2432735
seconds global lock is held   : 0.172899
[time_cmd_output] time_elapsed_sec=12.52, faults_major=0, faults_minor=85448, mem_maxresident_kb=335044, user_cputime=1737.72, sys_cputime=4.78, percent_cpu=13912%
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=2