__step=000485
__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 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000485.txt
__path_data=data/data000485.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=7000644.136140117
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=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=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.06s
prefilling_size=91801 prefilling_elapsed_millis=1s
prefilling_size=93739 prefilling_elapsed_millis=1.1s
prefilling_size=95173 prefilling_elapsed_millis=1.201s
prefilling_size=96292 prefilling_elapsed_millis=1.301s
prefilling_size=97256 prefilling_elapsed_millis=1.401s
prefilling_size=97812 prefilling_elapsed_millis=1.501s
prefilling_size=98353 prefilling_elapsed_millis=1.601s
finished prefilling to size 98341 for expected size 100000 keysum=9820927472, performing 830474 updates; total_prefilling_elapsed_ms=1704 ms)
pref_size=98341
pref_millis=1704
prefill_elapsed_ms=1728
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=7000646.133743349
REALTIME_END_PERF_FORMAT=7000656.133908492
###############################################################################
################################## 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.038s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4092 7937 13388 15984 9634 2077 111 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 4 225 2105 8712 16768 12064 2665 140
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8162 15493 24696 26402 14141 2776 140
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8162 15493 24696 26402 14141 2776 140
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 1.99365 1.92575 1.72988 1.42185 1.17071 1.04943 1.01045 1
tree_stats_height=20
tree_stats_numInternals=57318
tree_stats_numLeaves=42683
tree_stats_numNodes=100001
tree_stats_numKeys=100001
tree_stats_avgDegreeInternal=1.74467
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.42683
tree_stats_avgKeyDepth=14.99
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=52272
first_thread_announced_epoch_by_thread=736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736 736
sum_num_inserts_by_thread=16526 16525 16369 16337 17199 16864 16955 16814 16470 16421 17231 16642 16835 16839 16655 16843 17192 17319 16386 16382 17028 16783 17347 16759 16379 16159 16347 16126 16844 16728 16511 16705 17097 16682 17249 17120 16507 16281 16704 16904 17108 17370 15834 15989 17135 16880 17086 16982 17041 17262 16639 17243 17424 17461 16603 17102 17534 17083 17584 18103 17654 17281 17167 17505 17573 17738 17061 16306 17610 17418 17342 18081 16657 16823 17127 17498 17626 17300 16823 16535 17526 17233 17035 18246 17338 16848 17381 17270 17447 18042 16611 16442 17675 17279 17543 17842 18921 19208 19771 19670 19702 19203 19267 19222 19409 19067 19147 19310 19065 19222 19667 19495 19666 20063 18823 18526 19498 19685 20274 19843 18956 19184 19695 19278 19641 19466 19128 18999 19212 18296 18660 20261 19023 18951 19058 19369 19405 19688 19215 18439 18717 19493 19666 19350
sum_num_inserts_total=2560284
sum_num_deletes_by_thread=16363 16314 16409 16313 17344 16969 17216 17038 16725 16528 17308 16802 16691 16199 16932 16816 16960 17295 16647 16396 16864 16524 17497 16753 16338 16031 16403 16407 16572 16706 16842 16987 17125 16872 16810 16946 16335 16131 16759 16474 16835 17046 15924 16122 17023 16708 17053 16906 16993 16916 16807 17524 17451 17251 16676 17244 17590 17326 17465 18040 17038 16911 17332 17389 17481 17743 16847 16369 17393 17525 17452 17724 16970 16756 17313 17071 17748 16962 17013 16468 17167 17278 17036 18595 17388 16960 17420 17004 17602 17621 16353 16391 17542 16996 17228 18047 19224 19233 19700 19601 19289 18937 19389 19056 19513 19070 19267 19225 19284 19286 19602 19381 19756 20172 18908 18629 19520 19453 20201 20042 18991 18901 19657 19527 19718 19568 18966 19010 19045 18620 18954 20072 19116 19313 18934 19065 19850 19512 18845 18652 18662 19694 19715 19418
sum_num_deletes_total=2557217
sum_num_searches_by_thread=298219 294860 294438 293188 312850 303440 305845 306279 301540 296258 309431 300549 303535 296947 303619 305630 306868 313916 297411 295995 302732 302816 315464 300741 295648 290947 294356 290201 302273 299966 296350 302179 307376 301949 307967 308009 297166 294923 301841 299231 306250 310262 287726 290322 307671 302121 308898 304612 306640 307830 299012 310912 313562 311200 303179 310151 319172 311877 313920 322985 312101 307101 312368 315452 314747 318509 302465 293200 313082 313068 314550 320676 302843 303335 310911 312360 315373 307181 303273 295022 311523 311075 304858 328401 310608 303466 312637 308583 318389 322635 298512 295247 313647 310201 309963 326174 342358 345961 353988 357459 348332 342008 348159 342991 349595 342954 346959 349129 346288 346649 355413 351244 353636 365063 338922 332058 350727 353393 363424 358063 339559 345870 352610 351418 356486 349222 345357 343526 345156 334046 337645 362344 343159 342644 340236 346964 355993 351724 343321 332126 334081 355118 355079 348223
sum_num_searches_total=46071471
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=331108 327699 327216 325838 347393 337273 340016 340131 334735 329207 343970 333993 337061 329985 337206 339289 341020 348530 330444 328773 336624 336123 350308 334253 328365 323137 327106 322734 335689 333400 329703 335871 341598 335503 342026 342075 330008 327335 335304 332609 340193 344678 319484 322433 341829 335709 343037 338500 340674 342008 332458 345679 348437 345912 336458 344497 354296 346286 348969 359128 346793 341293 346867 350346 349801 353990 336373 325875 348085 348011 349344 356481 336470 336914 345351 346929 350747 341443 337109 328025 346216 345586 338929 365242 345334 337274 347438 342857 353438 358298 331476 328080 348864 344476 344734 362063 380503 384402 393459 396730 387323 380148 386815 381269 388517 381091 385373 387664 384637 385157 394682 390120 393058 405298 376653 369213 389745 392531 403899 397948 377506 383955 391962 390223 395845 388256 383451 381535 383413 370962 375259 402677 381298 380908 378228 385398 395248 390924 381381 369217 371460 394305 394460 386991
average_num_operations_total=355478
stdev_num_operations_total=1989
sum_num_operations_total=51188972
min_num_operations_total=319484
max_num_operations_total=405298
first_time_thread_terminate_by_thread=10000291 10000400 10000276 10000468 10000266 10000474 10000398 10000166 10000443 10000280 10000433 10000425 10000463 10000385 10000173 10000406 10000465 10000485 10000482 10000470 10000274 10000164 10000384 10000266 10000485 10000177 10000358 10000396 10000382 10000475 10000197 10000440 10000442 10000177 10000163 10000164 10000439 10000278 10000253 10000467 10000464 10000459 10000349 10000471 10000404 10000364 10000486 10000285 10000457 10000353 10000423 10000216 10000226 10000343 10000304 10000246 10000431 10000422 10000455 10000391 10000355 10000164 10000223 10000452 10000484 10000478 10000310 10000304 10000434 10000356 10000214 10000410 10000456 10000421 10000446 10000311 10000165 10000481 10000182 10000347 10000428 10000451 10000453 10000408 10000391 10000361 10000222 10000436 10000477 10000482 10000231 10000306 10000472 10000165 10000299 10000294 10000386 10000372 10000334 10000330 10000240 10000319 10000168 10000234 10000203 10000449 10000323 10000417 10000419 10000368 10000414 10000458 10000373 10000377 10000321 10000415 10000446 10000165 10000164 10000315 10000248 10000296 10000171 10000375 10000190 10000449 10000193 10000370 10000205 10000314 10000395 10000271 10000328 10000337 10000480 10000395 10000239 10000380 10000327 10000235 10000164 10000169 10000189 10000426
min_time_thread_terminate_total=10000163
max_time_thread_terminate_total=10000486
first_time_thread_start_by_thread=4 4 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 4 4 4 4 4 4 4 5 4 4 4 4 4 4 4 4 4 4 4 4 4 5 4 5 5 4 4 4 4 5 5 4 4 4 4 5 4 4 4 4 4 5 5 5 4 5 4 5 5 4 4 4 4 5 5 4 4 4 4 5 4 4 4 4 4 5 5 5 4 4 4 4 4 4 5 4 4 4 5 4 5 4 4 4 4 4 5 4 4 4 4 4 4 4 4 4 4 4 5 4 4 4 5 4 5 4 4 4 4 4 5 4 4 4 4 4
min_time_thread_start_total=4
max_time_thread_start_total=5
sum_duration_all_ops_total=
threads_final_keysum=10014385601
threads_final_size=100001
final_keysum=10014385601
final_size=100001
validate_result=success
Validation OK.
Structural validation OK.
total_find=46071471
total_rq=0
total_inserts=2560284
total_deletes=2557217
total_updates=5117501
total_queries=46071471
total_ops=51188972
find_throughput=4607147
rq_throughput=0
update_throughput=511750
query_throughput=4607147
total_throughput=5118897
total find : 46071471
total rq : 0
total inserts : 2560284
total deletes : 2557217
total updates : 5117501
total queries : 46071471
total ops : 51188972
find throughput : 4607147
rq throughput : 0
update throughput : 511750
query throughput : 4607147
total throughput : 5118897
elapsed milliseconds : 10000
napping milliseconds overtime : 100
PAPI_L2_TCM=22.5195
PAPI_L3_TCM=4.76039
PAPI_TOT_CYC=78142.6
PAPI_TOT_INS=8076.87
garbage=2271753659156
total_execution_walltime=12.169s
REALTIME_MAIN_END_PERF_FORMAT=7000656.306646451
Hybrid noREC system shutdown:
HTM_ATTEMPT_THRESH=40
[fast htm]
total fast htm commit : 49491330
[slow htm]
[fallback]
total fallback commit : 2528117
seconds global lock is held : 0.440057
[time_cmd_output] time_elapsed_sec=12.30, faults_major=0, faults_minor=102101, mem_maxresident_kb=401168, user_cputime=1710.03, sys_cputime=5.92, percent_cpu=13945%
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=1