__step=000462
__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 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000462.txt
__path_data=data/data000462.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=7000369.233360919
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=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
TL2 system ready: GV=GV4
Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.024s
prefilling_size=100097 prefilling_elapsed_millis=1.001s
finished prefilling to size 100086 for expected size 100000 keysum=10019042013, performing 10964010 updates; total_prefilling_elapsed_ms=1103 ms)
pref_size=100086
pref_millis=1103
prefill_elapsed_ms=1128
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=62
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=7000370.628167620
REALTIME_END_PERF_FORMAT=7000380.628249986
###############################################################################
################################## 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 776 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.029s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 63 121 232 416 720 1170 1809 2672 3741 4881 5903 6600 6901 6771 6163 5180 4068 2959 1967 1276 810 460 227 114 54 16 3 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 1 4 4 29 56 152 298 521 860 1396 2078 2816 3330 3727 3975 3756 3315 2736 2063 1377 921 589 371 170 84 47 13 5
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 125 236 445 776 1322 2107 3193 4601 6277 7981 9416 10231 10498 10138 8936 7383 5695 4030 2653 1731 1049 598 284 138 63 16 5
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 125 236 445 776 1322 2107 3193 4601 6277 7981 9416 10231 10498 10138 8936 7383 5695 4030 2653 1731 1049 598 284 138 63 16 5
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 1.96875 1.92 1.90254 1.80899 1.77577 1.70877 1.65686 1.60413 1.55118 1.49387 1.44017 1.38562 1.35158 1.32073 1.27353 1.24653 1.22037 1.18806 1.17022 1.1715 1.13807 1.13155 1.09532 1.08451 1.06522 1 1.125 1
tree_stats_height=34
tree_stats_numInternals=65360
tree_stats_numLeaves=34694
tree_stats_numNodes=100054
tree_stats_numKeys=100054
tree_stats_avgDegreeInternal=1.53081
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34675
tree_stats_avgKeyDepth=18.774
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=2442
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:0 4:3 8:2097 16:194634 32:145698
(2^02, 2^03]: 3
(2^03, 2^04]: 2097
(2^04, 2^05]: 194634
(2^05, 2^06]: 145698
sum_limbo_reclamation_event_size_total=10404721
count_limbo_reclamation_event_size_by_thread=2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378 2378
count_limbo_reclamation_event_size_total=342432
sum_limbo_reclamation_event_count_total=342720
first_thread_announced_epoch_by_thread=4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884 4884
sum_num_inserts_by_thread=147917 148368 148992 149398 149077 149423 147455 147643 148698 148808 149016 148026 147472 147829 148434 149192 149143 147949 147667 148466 148164 149716 147815 148926 146954 147756 148769 150341 149518 149670 146659 148779 149017 149657 148039 148040 146873 148221 148611 148832 148463 148299 147875 147842 148106 149675 148208 147417 118405 119588 119434 120261 119559 119950 119072 119229 119691 120410 119519 119403 119106 119461 119553 120372 119872 119167 118334 119565 118788 120461 119310 119933 118601 118948 120003 120223 119436 119463 118053 119222 119467 120320 120023 119694 118475 119570 119920 120498 119893 119044 119274 120050 119775 119929 120094 119888 163746 165191 166611 166766 166712 166516 163934 165337 166358 166563 165397 165427 165283 165317 165875 166876 166347 164650 164821 164437 166217 167094 165780 164808 163764 164904 166192 167455 167440 165692 165366 165589 166860 168059 166940 165941 164641 167339 167087 167291 167145 165697 165840 165294 165865 166009 166257 165364
sum_num_inserts_total=20827615
sum_num_deletes_by_thread=148057 147688 149245 149804 149525 148507 146978 148026 149531 149226 148839 148344 147796 147070 148598 148538 149309 148066 147322 148691 148342 149735 147754 147742 147609 148176 148706 149137 148934 148874 147141 148672 149003 150085 147943 147857 148473 148818 148561 148972 150053 148171 147631 148384 147635 149320 147797 147608 119485 119208 119790 119890 119340 119882 119157 119334 119216 120857 120645 119937 118632 119232 119891 120366 120403 119302 118835 118685 119504 120321 119927 118840 118912 119046 120583 120473 119766 120566 118354 119202 119495 120012 119440 119760 119098 119464 119988 120582 119823 119183 118966 119718 120324 120750 120142 120823 163627 165218 166588 166521 166143 166373 164710 163733 165882 166625 166271 165924 164932 165418 164674 166405 166237 164866 163838 165132 165539 167261 166047 165572 163842 165222 166135 167591 167008 165754 165480 165698 166637 167572 167092 165217 164234 166524 166468 167208 167695 165882 165201 165749 165446 166510 166874 165856
sum_num_deletes_total=20831873
sum_num_searches_by_thread=2653598 2667511 2686505 2696341 2687043 2669974 2654482 2666941 2677834 2687575 2685814 2671553 2657637 2664610 2670158 2684245 2682977 2671252 2654464 2666433 2670366 2690516 2673800 2669088 2648863 2660419 2678022 2693639 2686409 2674136 2642836 2670155 2679867 2695658 2673115 2669249 2656580 2666159 2668927 2678240 2680197 2669822 2643843 2661508 2668778 2689186 2670785 2653201 2138115 2145075 2151660 2163869 2151611 2157321 2140875 2152813 2161336 2171772 2165888 2155860 2138396 2154104 2151430 2167190 2163261 2148541 2134393 2142825 2147496 2168557 2151376 2149817 2139791 2147831 2154008 2159724 2158598 2160135 2134500 2144313 2152243 2162766 2157283 2152169 2141180 2148727 2154976 2166430 2159399 2144115 2139165 2153900 2157944 2171898 2162050 2156170 2941779 2977672 2989863 2998460 3003142 2991059 2953459 2970769 2991398 3004247 2995142 2978364 2967706 2977536 2980646 3009029 2988640 2965035 2955506 2968575 2987699 3004353 2990676 2967364 2962586 2977854 2994785 3005072 3006384 2995035 2966581 2984745 3000199 3016009 3005849 2989483 2963000 2997998 2998690 3021434 3008733 2979837 2966837 2977244 2984172 3007560 2996987 2982197
sum_num_searches_total=374940597
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=2949572 2963567 2984742 2995543 2985645 2967904 2948915 2962610 2976063 2985609 2983669 2967923 2952905 2959509 2967190 2981975 2981429 2967267 2949453 2963590 2966872 2989967 2969369 2965756 2943426 2956351 2975497 2993117 2984861 2972680 2936636 2967606 2977887 2995400 2969097 2965146 2951926 2963198 2966099 2976044 2978713 2966292 2939349 2957734 2964519 2988181 2966790 2948226 2376005 2383871 2390884 2404020 2390510 2397153 2379104 2391376 2400243 2413039 2406052 2395200 2376134 2392797 2390874 2407928 2403536 2387010 2371562 2381075 2385788 2409339 2390613 2388590 2377304 2385825 2394594 2400420 2397800 2400164 2370907 2382737 2391205 2403098 2396746 2391623 2378753 2387761 2394884 2407510 2399115 2382342 2377405 2393668 2398043 2412577 2402286 2396881 3269152 3308081 3323062 3331747 3335997 3323948 3282103 3299839 3323638 3337435 3326810 3309715 3297921 3308271 3311195 3342310 3321224 3294551 3284165 3298144 3319455 3338708 3322503 3297744 3290192 3307980 3327112 3340118 3340832 3326481 3297427 3316032 3333696 3351640 3339881 3320641 3291875 3331861 3332245 3355933 3343573 3311416 3297878 3308287 3315483 3340079 3330118 3313417
average_num_operations_total=2893056
stdev_num_operations_total=32055
sum_num_operations_total=416600085
min_num_operations_total=2370907
max_num_operations_total=3355933
first_time_thread_terminate_by_thread=10000085 10000082 10000087 10000082 10000084 10000082 10000087 10000082 10000085 10000087 10000088 10000082 10000082 10000097 10000083 10000088 10000083 10000082 10000085 10000085 10000085 10000086 10000084 10000085 10000085 10000085 10000087 10000082 10000084 10000082 10000083 10000087 10000082 10000087 10000082 10000082 10000089 10000082 10000083 10000087 10000082 10000085 10000085 10000087 10000085 10000086 10000085 10000085 10000088 10000084 10000082 10000086 10000084 10000088 10000084 10000085 10000088 10000085 10000084 10000088 10000084 10000088 10000084 10000087 10000088 10000084 10000088 10000148 10000084 10000082 10000083 10000084 10000087 10000084 10000082 10000086 10000086 10000088 10000084 10000085 10000088 10000086 10000084 10000088 10000082 10000088 10000084 10000087 10000087 10000084 10000086 10000086 10000084 10000086 10000082 10000084 10000086 10000083 10000085 10000087 10000085 10000086 10000084 10000087 10000088 10000085 10000083 10000083 10000083 10000088 10000082 10000082 10000085 10000086 10000087 10000083 10000084 10000083 10000082 10000086 10000086 10000083 10000085 10000085 10000085 10000082 10000084 10000082 10000088 10000085 10000083 10000083 10000083 10000087 10000082 10000082 10000085 10000086 10000083 10000092 10000084 10000083 10000082 10000083
min_time_thread_terminate_total=10000082
max_time_thread_terminate_total=10000148
first_time_thread_start_by_thread=5 5 5 5 5 5 5 5 5 5 5 6 5 5 5 5 5 5 5 5 5 6 5 5 5 5 5 5 5 5 5 5 5 5 5 6 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 10 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 4 5 5 5 5 6 6 5 5 6 5 6 5 6 6 6 6 5 5 6 6 5 6 6 6 6 5 5 5 6 6 5 5 6 5 6 5 6 6 6 6 5 5 6 6 5 6 6 6 6 5 5 5
min_time_thread_start_total=4
max_time_thread_start_total=10
sum_duration_all_ops_total=
threads_final_keysum=10013288274
threads_final_size=100054
final_keysum=10013288274
final_size=100054
validate_result=success
Validation OK.
Structural validation OK.
total_find=374940597
total_rq=0
total_inserts=20827615
total_deletes=20831873
total_updates=41659488
total_queries=374940597
total_ops=416600085
find_throughput=37494059
rq_throughput=0
update_throughput=4165948
query_throughput=37494059
total_throughput=41660008
total find : 374940597
total rq : 0
total inserts : 20827615
total deletes : 20831873
total updates : 41659488
total queries : 374940597
total ops : 416600085
find throughput : 37494059
rq throughput : 0
update throughput : 4165948
query throughput : 37494059
total throughput : 41660008
elapsed milliseconds : 10000
napping milliseconds overtime : 100
PAPI_L2_TCM=11.6552
PAPI_L3_TCM=0.646877
PAPI_TOT_CYC=6460.51
PAPI_TOT_INS=1996.01
garbage=18458123117507
total_execution_walltime=11.565s
REALTIME_MAIN_END_PERF_FORMAT=7000380.812844818
TL2 system shutdown:
GCLOCK=0x11674C6 Starts=430839623 Aborts=3275527
Overflows: R=0 W=0 L=0
[time_cmd_output] time_elapsed_sec=11.70, faults_major=0, faults_minor=88104, mem_maxresident_kb=334700, user_cputime=1537.75, sys_cputime=88.65, percent_cpu=13897%
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