__step=000069
__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.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=data000069.txt
__path_data=data/data000069.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6993774.504133996
binary=./brown_sigouin_int_avl_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_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=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=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


TL2 system ready: GV=GV4
Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.021s
prefilling_size=3804586 prefilling_elapsed_millis=1.001s
prefilling_size=4107312 prefilling_elapsed_millis=1.101s
prefilling_size=4393067 prefilling_elapsed_millis=1.201s
prefilling_size=4662074 prefilling_elapsed_millis=1.301s
prefilling_size=4919693 prefilling_elapsed_millis=1.401s
prefilling_size=5162926 prefilling_elapsed_millis=1.502s
prefilling_size=5395561 prefilling_elapsed_millis=1.602s
prefilling_size=5617620 prefilling_elapsed_millis=1.702s
prefilling_size=5828007 prefilling_elapsed_millis=1.802s
prefilling_size=6029169 prefilling_elapsed_millis=1.902s
prefilling_size=6218970 prefilling_elapsed_millis=2.003s
prefilling_size=6400475 prefilling_elapsed_millis=2.103s
prefilling_size=6573958 prefilling_elapsed_millis=2.203s
prefilling_size=6739302 prefilling_elapsed_millis=2.303s
prefilling_size=6897224 prefilling_elapsed_millis=2.403s
prefilling_size=7046218 prefilling_elapsed_millis=2.504s
prefilling_size=7188602 prefilling_elapsed_millis=2.604s
prefilling_size=7322260 prefilling_elapsed_millis=2.704s
prefilling_size=7450740 prefilling_elapsed_millis=2.804s
prefilling_size=7572620 prefilling_elapsed_millis=2.904s
prefilling_size=7688836 prefilling_elapsed_millis=3.004s
prefilling_size=7799335 prefilling_elapsed_millis=3.105s
prefilling_size=7904478 prefilling_elapsed_millis=3.205s
prefilling_size=8006067 prefilling_elapsed_millis=3.305s
prefilling_size=8102089 prefilling_elapsed_millis=3.405s
prefilling_size=8193496 prefilling_elapsed_millis=3.505s
prefilling_size=8280742 prefilling_elapsed_millis=3.606s
prefilling_size=8364933 prefilling_elapsed_millis=3.706s
prefilling_size=8443717 prefilling_elapsed_millis=3.806s
prefilling_size=8518856 prefilling_elapsed_millis=3.906s
prefilling_size=8589956 prefilling_elapsed_millis=4.006s
prefilling_size=8657465 prefilling_elapsed_millis=4.106s
prefilling_size=8721648 prefilling_elapsed_millis=4.207s
prefilling_size=8782629 prefilling_elapsed_millis=4.307s
prefilling_size=8841469 prefilling_elapsed_millis=4.407s
prefilling_size=8897871 prefilling_elapsed_millis=4.507s
prefilling_size=8950609 prefilling_elapsed_millis=4.607s
prefilling_size=9002615 prefilling_elapsed_millis=4.708s
prefilling_size=9051422 prefilling_elapsed_millis=4.808s
prefilling_size=9097930 prefilling_elapsed_millis=4.908s
prefilling_size=9142248 prefilling_elapsed_millis=5.008s
Info: prefilling requires an additional insert phase to complete.
Info: prefilling using INSERTION ONLY.
timing_start inserting 857706 keys with 144 threads...
tid=0 thread_prefill_amount=56908 percent_done_estimate=955.4 elapsed_s=5 est_remaining_s=-10 / -5
tid=0 thread_prefill_amount=58296 percent_done_estimate=978.7 elapsed_s=5 est_remaining_s=-10 / -5
tid=0 thread_prefill_amount=59684 percent_done_estimate=1002.0 elapsed_s=5 est_remaining_s=-11 / -5
tid=0 thread_prefill_amount=61072 percent_done_estimate=1025.3 elapsed_s=5 est_remaining_s=-11 / -5
timing_elapsed 0.190407s
prefilling_size=10000000 prefilling_elapsed_millis=0.19s
finished prefilling to size 10000000 for expected size 10000000 keysum=100013407201836, performing 51112536 updates; total_prefilling_elapsed_ms=190 ms)
pref_size=10000000
pref_millis=190
prefill_elapsed_ms=191
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6993780.46240217
REALTIME_END_PERF_FORMAT=6993790.46330426

###############################################################################
################################## 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.023s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262081 520057 970541 1456783 1407067 704891 149627 9536 42 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 61 3717 60366 398775 1174266 1549119 872682 190132 12007 49
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262142 523774 1030907 1855558 2581333 2254010 1022309 199668 12049 49
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262142 523774 1030907 1855558 2581333 2254010 1022309 199668 12049 49
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99998 1.99829 1.97533 1.85848 1.60604 1.3281 1.14082 1.04895 1.01259 1.00058 1

tree_stats_height=28
tree_stats_numInternals=5742768
tree_stats_numLeaves=4261174
tree_stats_numNodes=10003942
tree_stats_numKeys=10003942

tree_stats_avgDegreeInternal=1.74201
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.42595
tree_stats_avgKeyDepth=21.6837


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=269921
first_thread_announced_epoch_by_thread=4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290 4290
sum_num_inserts_by_thread=117738 118861 118802 119402 118999 118265 118694 119594 119929 120142 118841 118404 119284 119639 119671 119843 119289 119365 118028 118926 119297 119192 118430 118373 118744 118719 119806 119701 119219 118173 119053 119006 120154 120474 118691 118858 118522 118923 119582 120229 119432 118383 117746 119160 118831 119767 119256 118959 126617 128870 128792 129691 129417 128487 127905 128798 129618 130300 128732 128591 127997 128624 129089 129466 129267 126894 127101 127572 129509 129917 128537 128298 127793 128498 129529 129585 128381 128897 128289 128634 130027 130553 129549 128404 128178 128387 129250 129759 129090 127820 127690 128376 129359 129173 128660 128162 127932 129121 130286 130022 130129 129972 129181 129756 130469 131557 130177 128178 129652 129867 130050 130356 130108 128181 129654 130022 129846 130761 129751 128865 129242 128468 129089 130440 130466 130381 128442 129548 130525 130764 130099 128515 128738 130703 130467 130543 129864 128228 129029 129080 130419 131007 129616 128848
sum_num_inserts_total=18122942
sum_num_deletes_by_thread=117962 118769 119812 119186 119027 118764 119640 119038 119975 120211 119086 118618 118604 119006 119638 119356 119628 118928 117978 119161 119815 119257 119618 118608 118286 118646 119063 119580 119465 117713 118259 118990 120140 119605 119348 118470 118666 119658 119145 120212 119985 118538 118004 118889 119391 119843 119650 118356 127006 128913 128806 129914 129021 129063 128232 129297 129468 129711 128050 127939 128102 128595 129323 129833 129190 127314 127690 128513 129642 130040 128994 128272 127217 128884 129440 129264 129230 127678 128400 128400 130307 129758 129016 128413 127602 128617 129886 129933 128607 127669 127405 127837 129259 129668 128670 128391 128125 129125 130389 130078 130334 129889 129608 130064 130327 130545 129504 128729 129481 130176 129759 130648 130015 127800 128946 129852 129855 130457 130267 128401 128429 128566 129319 129786 131195 129338 129064 129919 130236 131264 129867 129158 129490 130009 130701 130437 130794 128054 128789 129296 130247 130522 130168 128805
sum_num_deletes_total=18123893
sum_num_searches_by_thread=2123402 2135406 2147594 2149316 2150182 2126008 2135737 2148928 2160031 2161045 2147890 2139465 2140235 2141858 2159199 2163067 2151513 2136702 2126767 2144002 2153469 2156217 2148438 2134331 2132341 2135120 2152491 2152394 2149717 2125302 2131867 2139454 2155192 2161798 2145351 2131157 2133942 2149274 2151313 2158205 2147472 2136461 2126856 2138556 2148302 2156771 2149277 2132645 2291786 2316913 2321542 2328092 2317497 2318422 2310230 2320177 2330203 2339775 2322281 2307890 2306319 2319010 2326824 2329545 2322389 2293610 2293692 2306135 2322058 2336363 2314556 2308687 2294340 2316502 2324971 2330910 2318545 2309119 2313322 2314887 2339696 2342523 2332857 2311221 2307993 2321250 2329857 2329005 2318852 2300165 2295854 2302604 2322646 2332559 2317823 2304968 2306796 2322075 2339689 2338087 2344151 2333468 2325485 2337755 2349571 2358848 2344105 2318498 2328509 2335659 2345429 2349738 2334418 2307738 2318975 2332898 2341544 2350539 2334772 2322691 2311013 2320199 2334732 2337201 2350959 2327598 2322648 2333961 2355314 2362183 2342575 2319813 2329059 2344711 2349956 2347119 2338906 2307844 2317656 2329143 2342512 2357637 2346674 2319955
sum_num_searches_total=326229331
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=2359102 2373036 2386208 2387904 2388208 2363037 2374071 2387560 2399935 2401398 2385817 2376487 2378123 2380503 2398508 2402266 2390430 2374995 2362773 2382089 2392581 2394666 2386486 2371312 2369371 2372485 2391360 2391675 2388401 2361188 2369179 2377450 2395486 2401877 2383390 2368485 2371130 2387855 2390040 2398646 2386889 2373382 2362606 2376605 2386524 2396381 2388183 2369960 2545409 2574696 2579140 2587697 2575935 2575972 2566367 2578272 2589289 2599786 2579063 2564420 2562418 2576229 2585236 2588844 2580846 2547818 2548483 2562220 2581209 2596320 2572087 2565257 2549350 2573884 2583940 2589759 2576156 2565694 2570011 2571921 2600030 2602834 2591422 2568038 2563773 2578254 2588993 2588697 2576549 2555654 2550949 2558817 2581264 2591400 2575153 2561521 2562853 2580321 2600364 2598187 2604614 2593329 2584274 2597575 2610367 2620950 2603786 2575405 2587642 2595702 2605238 2610742 2594541 2563719 2577575 2592772 2601245 2611757 2594790 2579957 2568684 2577233 2593140 2597427 2612620 2587317 2580154 2593428 2616075 2624211 2602541 2577486 2587287 2605423 2611124 2608099 2599564 2564126 2575474 2587519 2603178 2619166 2606458 2577608
average_num_operations_total=2517195
stdev_num_operations_total=8109
sum_num_operations_total=362476166
min_num_operations_total=2359102
max_num_operations_total=2624211
first_time_thread_terminate_by_thread=10000184 10000089 10000090 10000090 10000090 10000093 10000091 10000092 10000093 10000092 10000091 10000092 10000090 10000092 10000092 10000095 10000093 10000090 10000093 10000093 10000092 10000090 10000094 10000090 10000093 10000093 10000090 10000090 10000090 10000093 10000091 10000090 10000093 10000092 10000091 10000092 10000090 10000092 10000092 10000093 10000093 10000094 10000096 10000090 10000092 10000179 10000094 10000090 10000096 10000092 10000090 10000090 10000093 10000094 10000095 10000095 10000094 10000090 10000094 10000096 10000095 10000090 10000095 10000092 10000095 10000095 10000090 10000095 10000092 10000095 10000090 10000095 10000096 10000095 10000090 10000090 10000090 10000094 10000100 10000095 10000094 10000090 10000090 10000090 10000090 10000095 10000095 10000090 10000090 10000095 10000095 10000093 10000108 10000095 10000097 10000095 10000092 10000092 10000091 10000090 10000093 10000090 10000093 10000090 10000091 10000091 10000091 10000167 10000091 10000090 10000091 10000090 10000092 10000091 10000093 10000091 10000090 10000091 10000092 10000090 10000092 10000091 10000091 10000090 10000093 10000094 10000094 10000090 10000091 10000090 10000091 10000092 10000091 10000090 10000091 10000090 10000092 10000091 10000091 10000090 10000090 10000090 10000090 10000091
min_time_thread_terminate_total=10000089
max_time_thread_terminate_total=10000184
first_time_thread_start_by_thread=10 5 5 5 5 5 5 5 5 5 5 5 5 5 5 6 5 5 5 5 5 5 5 5 4 5 5 5 5 5 5 5 5 5 5 5 5 5 5 6 5 5 5 5 5 5 5 5 5 5 5 5 6 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 6 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 6 6 5 5 5 5 5 5 5 5 5 6 6 6 6 5 6 5 6 6 5 5 5 5 6 6 5 5 5 5 5 5 5 5 5 6 6 6 6 5 6 5 6 6 5 5
min_time_thread_start_total=4
max_time_thread_start_total=10
sum_duration_all_ops_total=

threads_final_keysum=100028722706801
threads_final_size=10003942
final_keysum=100028722706801
final_size=10003942
validate_result=success
Validation OK.
Structural validation OK.

total_find=326229331
total_rq=0
total_inserts=18122942
total_deletes=18123893
total_updates=36246835
total_queries=326229331
total_ops=362476166
find_throughput=32622933
rq_throughput=0
update_throughput=3624683
query_throughput=32622933
total_throughput=36247616


total find                    : 326229331
total rq                      : 0
total inserts                 : 18122942
total deletes                 : 18123893
total updates                 : 36246835
total queries                 : 326229331
total ops                     : 362476166
find throughput               : 32622933
rq throughput                 : 0
update throughput             : 3624683
query throughput              : 32622933
total throughput              : 36247616

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

PAPI_L2_TCM=46.9465
PAPI_L3_TCM=9.16198
PAPI_TOT_CYC=8848.92
PAPI_TOT_INS=2429.58
garbage=1619901491839776
total_execution_walltime=15.683s
REALTIME_MAIN_END_PERF_FORMAT=6993790.190071559
TL2 system shutdown:
  GCLOCK=0x1BABF76 Starts=421890900 Aborts=9936433
  Overflows: R=0 W=0 L=0
[time_cmd_output] time_elapsed_sec=15.92, faults_major=0, faults_minor=749328, mem_maxresident_kb=1684636, user_cputime=2095.00, sys_cputime=120.39, percent_cpu=13911%
timeout=false
algorithm=brown_sigouin_int_avl_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=1