__step=000030
__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.tl2 -nwork 144 -nprefill 144 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000030.txt
__path_data=data/data000030.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6992238.705155288
binary=./brown_int_bst_tm_auto.debra.tl2
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=20000000
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


TL2 system ready: GV=GV4
Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.071s
prefilling_size=4068939 prefilling_elapsed_millis=1.001s
prefilling_size=4370602 prefilling_elapsed_millis=1.101s
prefilling_size=4653982 prefilling_elapsed_millis=1.201s
prefilling_size=4921663 prefilling_elapsed_millis=1.302s
prefilling_size=5174715 prefilling_elapsed_millis=1.402s
prefilling_size=5413314 prefilling_elapsed_millis=1.502s
prefilling_size=5637553 prefilling_elapsed_millis=1.602s
prefilling_size=5850613 prefilling_elapsed_millis=1.703s
prefilling_size=6052524 prefilling_elapsed_millis=1.803s
prefilling_size=6242773 prefilling_elapsed_millis=1.903s
prefilling_size=6421259 prefilling_elapsed_millis=2.004s
prefilling_size=6592560 prefilling_elapsed_millis=2.104s
prefilling_size=6754888 prefilling_elapsed_millis=2.204s
prefilling_size=6908844 prefilling_elapsed_millis=2.304s
prefilling_size=7054477 prefilling_elapsed_millis=2.405s
prefilling_size=7192633 prefilling_elapsed_millis=2.505s
prefilling_size=7324829 prefilling_elapsed_millis=2.605s
prefilling_size=7448247 prefilling_elapsed_millis=2.705s
prefilling_size=7567497 prefilling_elapsed_millis=2.806s
prefilling_size=7680483 prefilling_elapsed_millis=2.906s
prefilling_size=7786662 prefilling_elapsed_millis=3.006s
prefilling_size=7887322 prefilling_elapsed_millis=3.107s
prefilling_size=7981253 prefilling_elapsed_millis=3.207s
prefilling_size=8072198 prefilling_elapsed_millis=3.307s
prefilling_size=8158356 prefilling_elapsed_millis=3.407s
prefilling_size=8239495 prefilling_elapsed_millis=3.508s
prefilling_size=8318871 prefilling_elapsed_millis=3.608s
prefilling_size=8393302 prefilling_elapsed_millis=3.708s
prefilling_size=8465198 prefilling_elapsed_millis=3.809s
prefilling_size=8531511 prefilling_elapsed_millis=3.909s
prefilling_size=8595778 prefilling_elapsed_millis=4.009s
prefilling_size=8655834 prefilling_elapsed_millis=4.109s
prefilling_size=8714734 prefilling_elapsed_millis=4.21s
prefilling_size=8769757 prefilling_elapsed_millis=4.31s
prefilling_size=8822913 prefilling_elapsed_millis=4.41s
prefilling_size=8874769 prefilling_elapsed_millis=4.511s
prefilling_size=8923634 prefilling_elapsed_millis=4.611s
prefilling_size=8968068 prefilling_elapsed_millis=4.711s
prefilling_size=9011110 prefilling_elapsed_millis=4.811s
prefilling_size=9052061 prefilling_elapsed_millis=4.912s
prefilling_size=9091787 prefilling_elapsed_millis=5.012s
Info: prefilling requires an additional insert phase to complete.
Info: prefilling using INSERTION ONLY.
timing_start inserting 908151 keys with 144 threads...
tid=0 thread_prefill_amount=87444 percent_done_estimate=1386.5 elapsed_s=5 est_remaining_s=-11 / -6
tid=0 thread_prefill_amount=88832 percent_done_estimate=1408.6 elapsed_s=5 est_remaining_s=-11 / -6
tid=0 thread_prefill_amount=90220 percent_done_estimate=1430.6 elapsed_s=5 est_remaining_s=-11 / -6
tid=0 thread_prefill_amount=91608 percent_done_estimate=1452.6 elapsed_s=5 est_remaining_s=-11 / -6
tid=0 thread_prefill_amount=92996 percent_done_estimate=1474.6 elapsed_s=5 est_remaining_s=-11 / -6
timing_elapsed 0.185604s
prefilling_size=10000000 prefilling_elapsed_millis=0.186s
finished prefilling to size 10000000 for expected size 10000000 keysum=100001831557905, performing 56340775 updates; total_prefilling_elapsed_ms=186 ms)
pref_size=10000000
pref_millis=186
prefill_elapsed_ms=186
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=297

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6992244.288169138
REALTIME_END_PERF_FORMAT=6992254.288256873

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

tree_stats_computeWalltime=0.066s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 63 126 250 489 939 1767 3301 6033 10619 18171 29955 47578 72141 104744 146556 197050 255089 315460 374315 425632 464291 487547 494100 482713 455887 415896 366907 314295 260713 209605 164604 125620 93123 67572 47790 32896 22115 14304 9129 5551 3328 1916 957 479 218 112 48 28 10 4 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 1 0 1 6 19 55 135 299 793 1688 3479 6709 12435 21354 33659 51421 74470 103886 136028 171292 204662 233466 252962 265803 267560 259347 243126 219068 192124 162813 132469 105555 81817 61562 45534 32364 22576 15568 10032 6554 4001 2425 1468 722 379 166 92 33 23 8 5
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 126 251 495 958 1822 3436 6332 11412 19859 33434 54287 84576 126098 180215 248471 329559 419346 510343 596924 668953 721013 747062 748516 723447 675243 610033 533363 452837 372418 297073 231175 174940 129134 93324 65260 44691 29872 19161 12105 7329 4341 2425 1201 597 278 140 61 33 12 5
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 126 251 495 958 1822 3436 6332 11412 19859 33434 54287 84576 126098 180215 248471 329559 419346 510343 596924 668953 721013 747062 748516 723447 675243 610033 533363 452837 372418 297073 231175 174940 129134 93324 65260 44691 29872 19161 12105 7329 4341 2425 1201 597 278 140 61 33 12 5
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 1.98438 1.99206 1.9761 1.94747 1.92171 1.91603 1.88213 1.84949 1.80967 1.76857 1.72776 1.68153 1.63797 1.59851 1.56552 1.5333 1.49841 1.46473 1.43619 1.40762 1.38377 1.35993 1.34056 1.32162 1.30321 1.28751 1.27286 1.25975 1.24668 1.23487 1.22409 1.21334 1.20585 1.19942 1.1872 1.18074 1.17357 1.16259 1.15532 1.14688 1.13822 1.11725 1.10062 1.09825 1.1005 1.10072 1.09286 1.08197 1.06061 1.08333 1

tree_stats_height=57
tree_stats_numInternals=6552099
tree_stats_numLeaves=3442014
tree_stats_numNodes=9994113
tree_stats_numKeys=9994113

tree_stats_avgDegreeInternal=1.52533
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.3444
tree_stats_avgKeyDepth=28.9392

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:0 4:0 8:45 16:87144 32:187661 64:46
    (2^03, 2^04]: 45
    (2^04, 2^05]: 87144
    (2^05, 2^06]: 187661
    (2^06, 2^07]: 46
sum_limbo_reclamation_event_size_total=9456424
count_limbo_reclamation_event_size_by_thread=1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909 1909
count_limbo_reclamation_event_size_total=274896
sum_limbo_reclamation_event_count_total=275311
first_thread_announced_epoch_by_thread=4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416 4416
sum_num_inserts_by_thread=128839 130217 130915 131414 130766 130121 130000 130416 131858 132610 131369 130623 130315 130552 130758 132053 131418 130977 129702 130307 131003 131248 130784 129818 129147 129643 130548 131532 131243 130161 130165 130942 131810 132017 131140 131055 130068 130492 132033 131798 131874 130093 129281 130010 130970 132137 131171 130307 128114 129000 129260 129723 129190 129353 128232 129225 130143 130312 130387 129942 128728 130108 130500 130268 129814 128492 127940 129159 130315 130326 130017 129430 128468 128423 130057 129508 128995 129044 127946 129435 129997 130366 130110 129034 127946 129341 130132 129683 129433 129243 128048 128683 130333 131013 130054 129515 132900 133796 134485 135022 134322 133682 133680 133792 135229 136005 134721 133615 133301 133869 134879 134944 134809 133327 133231 133358 134030 134577 134592 133178 132489 132752 134384 134482 134750 133952 133696 133744 134692 135455 134991 133791 132739 134072 135067 134812 134958 133511 133553 133274 134966 135787 134370 133809
sum_num_inserts_total=18929945
sum_num_deletes_by_thread=129577 130034 130625 130352 131238 130082 130404 130329 132270 132123 130836 130659 129962 130600 131803 131739 131615 131101 129041 130614 131220 130919 131453 130400 128891 130063 130988 131107 131089 130253 129589 131113 131480 131545 131388 130049 129550 130458 131882 131958 131422 131005 129093 130028 131449 131474 131173 130343 128785 128656 130599 129630 128692 129398 128568 129537 130115 131079 130307 129478 128621 129175 129631 130065 129940 128730 128617 128495 129646 130639 129985 129395 128313 128285 129253 130518 129672 129376 129220 128823 129838 130472 129794 129080 128567 128566 130545 130820 130547 128964 128366 129422 129618 130585 129991 129483 132714 133119 134695 134077 135630 134843 132889 134536 135078 135103 134561 133426 133617 134091 134932 134664 134626 133334 132769 133218 134522 135305 134603 133521 132712 133397 134368 134080 135199 134353 133266 134259 135103 135792 134214 133873 133416 134159 134873 135654 134689 132936 132361 133913 134792 135695 134451 133878
sum_num_deletes_total=18933593
sum_num_searches_by_thread=2325699 2342391 2359642 2364330 2362432 2342356 2340882 2349700 2370318 2376316 2365606 2352900 2340774 2349982 2366709 2368573 2368058 2357020 2330650 2345916 2354879 2367949 2356424 2348022 2325994 2341373 2355041 2363558 2364346 2343409 2340546 2351337 2375862 2377906 2363216 2358528 2342872 2352194 2365930 2369285 2368426 2354191 2329969 2345866 2357584 2371609 2360131 2347650 2308239 2321005 2333944 2339396 2331084 2332207 2318026 2326812 2347664 2357001 2345018 2330440 2317050 2329201 2344760 2348838 2342574 2322302 2305673 2321508 2342659 2344829 2337421 2327499 2309567 2318009 2334582 2341881 2329221 2327386 2315250 2322648 2342184 2351426 2342944 2326902 2313103 2332318 2340057 2344925 2338682 2316906 2305191 2319411 2338346 2347141 2340849 2330374 2390604 2400819 2418173 2425695 2430259 2419380 2399240 2410400 2431307 2433739 2422052 2408574 2396131 2415636 2427011 2430809 2415419 2393909 2392949 2404706 2420154 2435028 2421007 2403596 2389612 2400429 2417058 2426165 2428827 2418211 2401407 2412520 2434539 2438150 2426867 2413819 2399079 2413180 2424720 2430965 2419484 2397989 2395309 2409837 2421786 2435945 2426063 2409566
sum_num_searches_total=340876928
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=2584115 2602642 2621182 2626096 2624436 2602559 2601286 2610445 2634446 2641049 2627811 2614182 2601051 2611134 2629270 2632365 2631091 2619098 2589393 2606837 2617102 2630116 2618661 2608240 2584032 2601079 2616577 2626197 2626678 2603823 2600300 2613392 2639152 2641468 2625744 2619632 2602490 2613144 2629845 2633041 2631722 2615289 2588343 2605904 2620003 2635220 2622475 2608300 2565138 2578661 2593803 2598749 2588966 2590958 2574826 2585574 2607922 2618392 2605712 2589860 2574399 2588484 2604891 2609171 2602328 2579524 2562230 2579162 2602620 2605794 2597423 2586324 2566348 2574717 2593892 2601907 2587888 2585806 2572416 2580906 2602019 2612264 2602848 2585016 2569616 2590225 2600734 2605428 2598662 2575113 2561605 2577516 2598297 2608739 2600894 2589372 2656218 2667734 2687353 2694794 2700211 2687905 2665809 2678728 2701614 2704847 2691334 2675615 2663049 2683596 2696822 2700417 2684854 2660570 2658949 2671282 2688706 2704910 2690202 2670295 2654813 2666578 2685810 2694727 2698776 2686516 2668369 2680523 2704334 2709397 2696072 2681483 2665234 2681411 2694660 2701431 2689131 2664436 2661223 2677024 2691544 2707427 2694884 2677253
average_num_operations_total=2630142
stdev_num_operations_total=3525
sum_num_operations_total=378740466
min_num_operations_total=2561605
max_num_operations_total=2709397
first_time_thread_terminate_by_thread=10000174 10000087 10000090 10000093 10000089 10000091 10000087 10000092 10000092 10000089 10000091 10000092 10000087 10000087 10000090 10000090 10000088 10000090 10000093 10000090 10000088 10000091 10000091 10000090 10000088 10000091 10000090 10000087 10000089 10000091 10000092 10000087 10000092 10000089 10000087 10000092 10000091 10000092 10000090 10000090 10000088 10000090 10000092 10000087 10000090 10000087 10000091 10000090 10000091 10000091 10000089 10000089 10000093 10000089 10000093 10000090 10000094 10000093 10000090 10000089 10000090 10000088 10000088 10000089 10000089 10000094 10000089 10000094 10000091 10000093 10000091 10000090 10000091 10000088 10000088 10000089 10000093 10000088 10000093 10000090 10000094 10000093 10000091 10000092 10000090 10000092 10000092 10000089 10000089 10000094 10000089 10000094 10000091 10000088 10000091 10000090 10000088 10000093 10000088 10000093 10000088 10000089 10000093 10000093 10000088 10000090 10000088 10000088 10000093 10000089 10000088 10000088 10000088 10000093 10000090 10000088 10000093 10000088 10000088 10000088 10000088 10000088 10000092 10000093 10000088 10000088 10000093 10000088 10000088 10000090 10000088 10000088 10000088 10000088 10000088 10000088 10000091 10000093 10000088 10000088 10000093 10000088 10000088 10000092
min_time_thread_terminate_total=10000087
max_time_thread_terminate_total=10000174
first_time_thread_start_by_thread=10 6 6 6 6 5 5 5 5 6 6 5 6 6 6 5 6 5 6 5 5 6 5 6 5 6 6 6 6 5 5 5 5 6 6 5 6 6 6 5 6 5 6 5 5 6 5 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6
min_time_thread_start_total=5
max_time_thread_start_total=10
sum_duration_all_ops_total=

threads_final_keysum=99940836382120
threads_final_size=9994113
final_keysum=99940836382120
final_size=9994113
validate_result=success
Validation OK.
Structural validation OK.

total_find=340876928
total_rq=0
total_inserts=18929945
total_deletes=18933593
total_updates=37863538
total_queries=340876928
total_ops=378740466
find_throughput=34087692
rq_throughput=0
update_throughput=3786353
query_throughput=34087692
total_throughput=37874046


total find                    : 340876928
total rq                      : 0
total inserts                 : 18929945
total deletes                 : 18933593
total updates                 : 37863538
total queries                 : 340876928
total ops                     : 378740466
find throughput               : 34087692
rq throughput                 : 0
update throughput             : 3786353
query throughput              : 34087692
total throughput              : 37874046

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

PAPI_L2_TCM=42.5071
PAPI_L3_TCM=7.39237
PAPI_TOT_CYC=8504.72
PAPI_TOT_INS=2774.99
garbage=1704622406046531
total_execution_walltime=15.782s
REALTIME_MAIN_END_PERF_FORMAT=6992254.488454778
TL2 system shutdown:
  GCLOCK=0x1B6D0FA Starts=435028693 Aborts=1674636
  Overflows: R=0 W=0 L=0
[time_cmd_output] time_elapsed_sec=15.93, faults_major=0, faults_minor=259298, mem_maxresident_kb=702548, user_cputime=2129.01, sys_cputime=94.99, percent_cpu=13957%
timeout=false
algorithm=brown_int_bst_tm_auto.debra.tl2
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=2