__step=000068
__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 96 -nprefill 96 -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=data000068.txt
__path_data=data/data000068.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6993758.600522579
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=96
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=96
WORK_THREADS=96
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


TL2 system ready: GV=GV4
Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.016s
prefilling_size=4230085 prefilling_elapsed_millis=1.001s
prefilling_size=4541205 prefilling_elapsed_millis=1.101s
prefilling_size=4832728 prefilling_elapsed_millis=1.201s
prefilling_size=5110492 prefilling_elapsed_millis=1.301s
prefilling_size=5374568 prefilling_elapsed_millis=1.402s
prefilling_size=5624661 prefilling_elapsed_millis=1.502s
prefilling_size=5860403 prefilling_elapsed_millis=1.602s
prefilling_size=6082846 prefilling_elapsed_millis=1.702s
prefilling_size=6293434 prefilling_elapsed_millis=1.802s
prefilling_size=6493567 prefilling_elapsed_millis=1.903s
prefilling_size=6684264 prefilling_elapsed_millis=2.003s
prefilling_size=6862954 prefilling_elapsed_millis=2.103s
prefilling_size=7032489 prefilling_elapsed_millis=2.203s
prefilling_size=7192362 prefilling_elapsed_millis=2.303s
prefilling_size=7344169 prefilling_elapsed_millis=2.404s
prefilling_size=7487529 prefilling_elapsed_millis=2.504s
prefilling_size=7624430 prefilling_elapsed_millis=2.604s
prefilling_size=7753041 prefilling_elapsed_millis=2.704s
prefilling_size=7873286 prefilling_elapsed_millis=2.804s
prefilling_size=7987504 prefilling_elapsed_millis=2.905s
prefilling_size=8096121 prefilling_elapsed_millis=3.005s
prefilling_size=8198311 prefilling_elapsed_millis=3.105s
prefilling_size=8296301 prefilling_elapsed_millis=3.205s
prefilling_size=8387321 prefilling_elapsed_millis=3.305s
prefilling_size=8474141 prefilling_elapsed_millis=3.406s
prefilling_size=8556393 prefilling_elapsed_millis=3.506s
prefilling_size=8633204 prefilling_elapsed_millis=3.606s
prefilling_size=8707740 prefilling_elapsed_millis=3.706s
prefilling_size=8778870 prefilling_elapsed_millis=3.806s
prefilling_size=8844498 prefilling_elapsed_millis=3.907s
prefilling_size=8905412 prefilling_elapsed_millis=4.007s
prefilling_size=8965508 prefilling_elapsed_millis=4.107s
prefilling_size=9020607 prefilling_elapsed_millis=4.207s
prefilling_size=9073384 prefilling_elapsed_millis=4.307s
prefilling_size=9123749 prefilling_elapsed_millis=4.408s
prefilling_size=9171538 prefilling_elapsed_millis=4.508s
prefilling_size=9215976 prefilling_elapsed_millis=4.608s
prefilling_size=9257630 prefilling_elapsed_millis=4.708s
prefilling_size=9298152 prefilling_elapsed_millis=4.808s
prefilling_size=9336803 prefilling_elapsed_millis=4.909s
prefilling_size=9372240 prefilling_elapsed_millis=5.009s
Info: prefilling requires an additional insert phase to complete.
Info: prefilling using INSERTION ONLY.
timing_start inserting 627675 keys with 96 threads...
tid=0 thread_prefill_amount=89569 percent_done_estimate=1369.9 elapsed_s=5 est_remaining_s=-11 / -6
tid=0 thread_prefill_amount=91652 percent_done_estimate=1401.8 elapsed_s=5 est_remaining_s=-11 / -6
tid=0 thread_prefill_amount=93735 percent_done_estimate=1433.6 elapsed_s=5 est_remaining_s=-11 / -6
timing_elapsed 0.130288s
prefilling_size=10000000 prefilling_elapsed_millis=0.13s
finished prefilling to size 10000000 for expected size 10000000 keysum=100003066791890, performing 56833143 updates; total_prefilling_elapsed_ms=130 ms)
pref_size=10000000
pref_millis=130
prefill_elapsed_ms=130
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6993764.55633906
REALTIME_END_PERF_FORMAT=6993774.55727986

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

tree_stats_computeWalltime=0.028s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262007 518553 959591 1431653 1397524 725192 167090 14423 311 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 132 4880 66521 399654 1141861 1523579 891407 211073 18226 380
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262139 523433 1026112 1831307 2539385 2248771 1058497 225496 18537 380
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262139 523433 1026112 1831307 2539385 2248771 1058497 225496 18537 380
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99996 1.99728 1.96967 1.84953 1.60489 1.33522 1.14822 1.05518 1.01824 1.00372 1

tree_stats_height=28
tree_stats_numInternals=5738487
tree_stats_numLeaves=4257713
tree_stats_numNodes=9996200
tree_stats_numKeys=9996200

tree_stats_avgDegreeInternal=1.74196
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.42593
tree_stats_avgKeyDepth=21.7042


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=327628
first_thread_announced_epoch_by_thread=8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168 8168
sum_num_inserts_by_thread=152731 153477 154864 155367 155259 153138 153074 154324 155355 155847 154797 154135 153485 154383 155504 155837 154730 153345 152310 152612 154443 155473 153448 152979 153814 153988 154788 154772 154672 152250 153262 153898 156360 156117 154404 153861 153296 153957 155709 156033 155598 153801 152665 153240 154562 155839 153844 153255 154919 156232 157732 158253 157375 156023 156495 156805 158953 158510 158378 155483 156091 156408 158636 158317 157599 155944 154772 156002 158172 158426 157165 156132 155263 156730 158194 158779 156806 157713 156493 157630 158487 158473 157500 156742 156571 157511 157978 157938 157031 155084 155447 156909 158031 158521 157358 157535
sum_num_inserts_total=14948448
sum_num_deletes_by_thread=152265 154050 154859 155025 154352 153137 153010 154350 155630 155816 155395 154106 153454 153679 155558 155297 155212 154024 152079 154381 154796 155444 154246 153241 152611 154131 154542 155017 153980 152703 153824 154293 156222 155571 154733 153960 153691 154813 154972 155521 155450 153801 152079 153856 154856 154887 154351 152985 155619 156200 157584 157945 157017 157234 155978 156740 158295 159787 157686 156404 156122 157285 158349 158785 157329 155204 155865 156408 158053 157933 157707 156163 155946 156932 158433 158393 157876 156479 156421 155952 158807 159249 158598 157012 156388 156822 157674 158125 157740 155500 154459 156292 157858 159233 157592 156658
sum_num_deletes_total=14952386
sum_num_searches_by_thread=2745254 2761829 2788191 2791033 2786777 2749511 2763671 2778674 2806312 2811069 2785885 2770700 2764192 2778844 2797827 2801042 2787797 2765479 2747909 2765066 2784188 2795760 2775610 2751509 2754111 2767485 2783188 2789796 2785713 2750540 2755675 2768405 2799314 2803751 2784865 2765110 2768106 2782351 2795161 2802285 2795365 2769210 2751868 2767328 2783179 2797733 2779396 2756046 2798313 2815490 2841059 2846154 2822509 2821598 2810489 2820589 2854103 2859713 2843277 2820537 2810173 2832558 2848765 2854228 2834758 2801609 2791553 2815555 2845348 2850174 2835305 2821096 2799930 2820236 2844259 2849663 2831682 2826166 2807570 2823963 2856691 2859245 2843348 2818927 2806321 2826552 2845902 2848121 2837948 2799817 2791097 2817525 2848985 2851044 2834034 2819663
sum_num_searches_total=269113752
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=3050250 3069356 3097914 3101425 3096388 3055786 3069755 3087348 3117297 3122732 3096077 3078941 3071131 3086906 3108889 3112176 3097739 3072848 3052298 3072059 3093427 3106677 3083304 3057729 3060536 3075604 3092518 3099585 3094365 3055493 3062761 3076596 3111896 3115439 3094002 3072931 3075093 3091121 3105842 3113839 3106413 3076812 3056612 3074424 3092597 3108459 3087591 3062286 3108851 3127922 3156375 3162352 3136901 3134855 3122962 3134134 3171351 3178010 3159341 3132424 3122386 3146251 3165750 3171330 3149686 3112757 3102190 3127965 3161573 3166533 3150177 3133391 3111139 3133898 3160886 3166835 3146364 3140358 3120484 3137545 3173985 3176967 3159446 3132681 3119280 3140885 3161554 3164184 3152719 3110401 3101003 3130726 3164874 3168798 3148984 3133856
average_num_operations_total=3114735
stdev_num_operations_total=3642
sum_num_operations_total=299014586
min_num_operations_total=3050250
max_num_operations_total=3178010
first_time_thread_terminate_by_thread=10000170 10000095 10000096 10000094 10000096 10000096 10000094 10000095 10000093 10000093 10000094 10000093 10000095 10000095 10000094 10000096 10000094 10000095 10000095 10000094 10000097 10000094 10000095 10000094 10000097 10000095 10000096 10000094 10000096 10000096 10000094 10000098 10000094 10000093 10000098 10000093 10000095 10000098 10000094 10000096 10000095 10000095 10000095 10000095 10000097 10000094 10000095 10000094 10000097 10000096 10000096 10000096 10000094 10000095 10000094 10000096 10000096 10000095 10000095 10000097 10000095 10000096 10000101 10000097 10000096 10000094 10000094 10000096 10000094 10000094 10000095 10000094 10000097 10000094 10000097 10000094 10000094 10000096 10000094 10000097 10000096 10000095 10000094 10000094 10000094 10000096 10000096 10000094 10000094 10000095 10000094 10000096 10000094 10000094 10000097 10000095
min_time_thread_terminate_total=10000093
max_time_thread_terminate_total=10000170
first_time_thread_start_by_thread=10 6 5 6 5 6 5 6 5 5 5 5 6 5 6 5 5 6 6 5 5 5 5 5 4 6 5 6 5 6 5 6 5 5 5 5 6 5 6 5 5 6 6 5 5 5 5 5 6 6 5 5 6 5 5 6 6 6 6 5 6 6 5 6 5 5 6 6 5 5 5 5 6 6 5 5 6 5 5 6 6 6 6 5 6 6 5 6 6 5 6 6 5 5 5 5
min_time_thread_start_total=4
max_time_thread_start_total=10
sum_duration_all_ops_total=

threads_final_keysum=99967981879603
threads_final_size=9996200
final_keysum=99967981879603
final_size=9996200
validate_result=success
Validation OK.
Structural validation OK.

total_find=269113752
total_rq=0
total_inserts=14948448
total_deletes=14952386
total_updates=29900834
total_queries=269113752
total_ops=299014586
find_throughput=26911375
rq_throughput=0
update_throughput=2990083
query_throughput=26911375
total_throughput=29901458


total find                    : 269113752
total rq                      : 0
total inserts                 : 14948448
total deletes                 : 14952386
total updates                 : 29900834
total queries                 : 269113752
total ops                     : 299014586
find throughput               : 26911375
rq throughput                 : 0
update throughput             : 2990083
query throughput              : 26911375
total throughput              : 29901458

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

PAPI_L2_TCM=46.6328
PAPI_L3_TCM=8.65124
PAPI_TOT_CYC=7245.22
PAPI_TOT_INS=2417.76
garbage=1345656477639942
total_execution_walltime=15.609s
REALTIME_MAIN_END_PERF_FORMAT=6993774.210517142
TL2 system shutdown:
  GCLOCK=0x24A9592 Starts=359676513 Aborts=5031744
  Overflows: R=0 W=0 L=0
[time_cmd_output] time_elapsed_sec=15.84, faults_major=0, faults_minor=730394, mem_maxresident_kb=1633588, user_cputime=1383.41, sys_cputime=89.46, percent_cpu=9297%
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=2