__step=000745
__cmd_run=LD_PRELOAD=../../setbench/lib/libjemalloc.so timeout 60 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" ./sigouin_int_bst_kcas_validate.debra -nwork 64 -nprefill 64 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 50.0 50.0 -k 20000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000745.txt
__path_data=data/data000745.txt
__hostname=nasus
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x564be4ccf3c0
addrof(kcasDescriptors[1])=0x564be4ccfcc0
addrof(rdcssDescriptors[0])=0x564be4def3c0
addrof(rdcssDescriptors[1])=0x564be4def480
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=215839.148603341
binary=./sigouin_int_bst_kcas_validate.debra
parsed custom binding: 0-63,128-191,64-127,192-255
DS_TYPENAME=sigouin_int_bst_kcas_validate
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=50
DEL_FRAC=50
RQ=0
RQSIZE=0
MAXKEY=20000000
PREFILL_THREADS=64
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=64
WORK_THREADS=64
RQ_THREADS=0
distribution=0
INS_DEL_FRAC=50.0 50.0
PREFILL_TYPE=PREFILL_HYBRID
PREFILL_HYBRID_MIN_MS=1000
PREFILL_HYBRID_MAX_MS=5000
sizes: node=56
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,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,48,49,50,51,52,53,54,55,56,57,58,59,60,61,62,63


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.017s
prefilling_size=7737000 prefilling_elapsed_millis=1s
prefilling_size=7998227 prefilling_elapsed_millis=1.1s
prefilling_size=8230608 prefilling_elapsed_millis=1.201s
prefilling_size=8431325 prefilling_elapsed_millis=1.301s
prefilling_size=8611301 prefilling_elapsed_millis=1.401s
prefilling_size=8768817 prefilling_elapsed_millis=1.501s
prefilling_size=8907517 prefilling_elapsed_millis=1.601s
prefilling_size=9030491 prefilling_elapsed_millis=1.701s
prefilling_size=9139307 prefilling_elapsed_millis=1.801s
prefilling_size=9234870 prefilling_elapsed_millis=1.901s
prefilling_size=9317795 prefilling_elapsed_millis=2.002s
prefilling_size=9394935 prefilling_elapsed_millis=2.102s
prefilling_size=9458479 prefilling_elapsed_millis=2.202s
prefilling_size=9516520 prefilling_elapsed_millis=2.302s
prefilling_size=9569039 prefilling_elapsed_millis=2.402s
prefilling_size=9614964 prefilling_elapsed_millis=2.502s
prefilling_size=9658546 prefilling_elapsed_millis=2.602s
prefilling_size=9696052 prefilling_elapsed_millis=2.702s
prefilling_size=9729717 prefilling_elapsed_millis=2.802s
prefilling_size=9758340 prefilling_elapsed_millis=2.903s
prefilling_size=9783290 prefilling_elapsed_millis=3.003s
prefilling_size=9806971 prefilling_elapsed_millis=3.103s
finished prefilling to size 9806985 for expected size 10000000 keysum=98052891029155, performing 81226568 updates; total_prefilling_elapsed_ms=3204 ms)
pref_size=9806985
pref_millis=3204
prefill_elapsed_ms=3217
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=215842.408375817
REALTIME_END_PERF_FORMAT=215852.408429872

###############################################################################
################################## TIME IS UP #################################
###############################################################################

joining threads...
###############################################################################
################################# END RUNNING #################################
###############################################################################

10s
PRODUCING OUTPUT
computing tree_stats in PARALLEL...
bounded depth BFS to partition into subtrees for parallel computation (256 threads)...
partitioned into 1836 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...

tree_stats_computeWalltime=0.126s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 251 493 941 1763 3187 5503 9407 15514 24931 39037 59227 86957 123334 169060 224123 285485 349750 411965 464223 501915 519269 517010 493530 453313 401108 341834 280939 221754 169018 124085 87793 60126 39655 25153 15247 8971 5124 2721 1371 674 332 130 34 12 2 1 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 3 5 23 73 185 505 877 1818 3306 5926 10251 16945 27300 41841 61491 87589 118930 153713 191933 226773 257355 275836 285494 281395 266009 242135 211191 177617 143136 111479 83445 59877 41978 28051 18067 11126 6644 3842 2063 1050 511 271 123 28 13 1 1 1
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 254 498 964 1836 3372 6008 10284 17332 28237 44963 69478 103902 150634 210901 285614 373074 468680 565678 656156 728688 776624 792846 779024 734708 667117 583969 492130 399371 312154 235564 171238 120003 81633 53204 33314 20097 11768 6563 3434 1724 843 401 157 40 15 2 2 1
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 254 498 964 1836 3372 6008 10284 17332 28237 44963 69478 103902 150634 210901 285614 373074 468680 565678 656156 728688 776624 792846 779024 734708 667117 583969 492130 399371 312154 235564 171238 120003 81633 53204 33314 20097 11768 6563 3434 1724 843 401 157 40 15 2 2 1
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 1.98438 1.97244 1.94578 1.92842 1.87636 1.8366 1.79577 1.77061 1.73408 1.70942 1.67702 1.64301 1.61286 1.58132 1.55265 1.52151 1.49104 1.46072 1.43168 1.40305 1.37699 1.35226 1.33047 1.30959 1.29101 1.27411 1.25737 1.24065 1.22636 1.21318 1.20017 1.1881 1.17922 1.16597 1.15339 1.14558 1.13918 1.12228 1.10864 1.1028 1.09803 1.08185 1.06733 1.03822 1.075 1 1.5 1 1

tree_stats_height=56
tree_stats_numInternals=6546528
tree_stats_numLeaves=3458226
tree_stats_numNodes=10004754
tree_stats_numKeys=10004754

tree_stats_avgDegreeInternal=1.52825
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34566
tree_stats_avgKeyDepth=29.1481


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:1 2:0 4:1 8:0 16:0 32:42 64:7458 128:393297 256:182 512:104
    [2^00, 2^01]: 1
    (2^01, 2^02]: 0
    (2^02, 2^03]: 1
    (2^03, 2^04]: 0
    (2^04, 2^05]: 0
    (2^05, 2^06]: 42
    (2^06, 2^07]: 7458
    (2^07, 2^08]: 393297
    (2^08, 2^09]: 182
    (2^09, 2^10]: 104
sum_limbo_reclamation_event_size_total=60314891
count_limbo_reclamation_event_size_by_thread=6267 6267 6267 6264 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267 6267
count_limbo_reclamation_event_size_total=401085
sum_limbo_reclamation_event_count_total=401214
first_thread_announced_epoch_by_thread=16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728 16728
sum_num_inserts_by_thread=1899428 1897360 1890350 1883681 1898205 1893826 1893698 1887213 1886898 1887429 1877928 1878412 1884778 1883117 1896977 1894124 1897920 1904887 1890477 1897032 1896641 1889322 1877663 1879883 1876650 1879212 1874482 1875109 1876410 1892361 1891742 1889320 1906751 1901699 1897083 1897921 1904300 1892021 1884095 1884066 1884520 1880809 1881589 1896445 1899988 1898950 1900046 1893676 1887587 1884240 1876118 1874311 1878827 1878885 1869203 1868561 1872617 1896307 1889814 1887768 1892877 1903158 1894089 1895329
sum_num_inserts_total=120876185
sum_num_deletes_by_thread=1902478 1898624 1892977 1883528 1898576 1895637 1894864 1887091 1886335 1889164 1879460 1879283 1886526 1880224 1897584 1894633 1894507 1901123 1891812 1897136 1896931 1888093 1881881 1878922 1877303 1879049 1874235 1871267 1881479 1895502 1887621 1888400 1907971 1899788 1899854 1894146 1900907 1892884 1884649 1881336 1884418 1881589 1878300 1896507 1900023 1897931 1898375 1896340 1885217 1886102 1877003 1873205 1878288 1874908 1870168 1869593 1870829 1894628 1889281 1886994 1894831 1901642 1894256 1896765
sum_num_deletes_total=120870973
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=3801906 3795984 3783327 3767209 3796781 3789463 3788562 3774304 3773233 3776593 3757388 3757695 3771304 3763341 3794561 3788757 3792427 3806010 3782289 3794168 3793572 3777415 3759544 3758805 3753953 3758261 3748717 3746376 3757889 3787863 3779363 3777720 3814722 3801487 3796937 3792067 3805207 3784905 3768744 3765402 3768938 3762398 3759889 3792952 3800011 3796881 3798421 3790016 3772804 3770342 3753121 3747516 3757115 3753793 3739371 3738154 3743446 3790935 3779095 3774762 3787708 3804800 3788345 3792094
average_num_operations_total=3777299
stdev_num_operations_total=2390
sum_num_operations_total=241747158
min_num_operations_total=3738154
max_num_operations_total=3814722
first_time_thread_terminate_by_thread=10000054 10000054 10000054 10000056 10000054 10000054 10000054 10000054 10000056 10000055 10000055 10000055 10000054 10000054 10000054 10000054 10000053 10000053 10000053 10000054 10000056 10000057 10000057 10000057 10000056 10000053 10000053 10000053 10000057 10000056 10000056 10000056 10000054 10000055 10000055 10000055 10000054 10000054 10000054 10000054 10000056 10000056 10000056 10000056 10000056 10000056 10000056 10000056 10000056 10000056 10000056 10000056 10000055 10000055 10000055 10000055 10000055 10000055 10000055 10000055 10000056 10000055 10000055 10000056
min_time_thread_terminate_total=10000053
max_time_thread_terminate_total=10000057
first_time_thread_start_by_thread=10 10 10 10 11 11 11 11 11 11 11 11 9 8 9 9 9 9 10 9 16 16 16 16 17 17 17 17 16 16 16 16 15 15 15 15 10 10 10 10 12 12 12 12 13 13 13 13 13 13 13 13 13 13 13 13 15 15 15 15 11 11 11 11
min_time_thread_start_total=8
max_time_thread_start_total=17
sum_duration_all_ops_total=

threads_final_keysum=100029235243404
threads_final_size=10004754
final_keysum=100029235243404
final_size=10004754
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=120876185
total_deletes=120870973
total_updates=241747158
total_queries=0
total_ops=241747158
find_throughput=0
rq_throughput=0
update_throughput=24174715
query_throughput=0
total_throughput=24174715


total find                    : 0
total rq                      : 0
total inserts                 : 120876185
total deletes                 : 120870973
total updates                 : 241747158
total queries                 : 0
total ops                     : 241747158
find throughput               : 0
rq throughput                 : 0
update throughput             : 24174715
query throughput              : 0
total throughput              : 24174715

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

garbage=0
total_execution_walltime=13.452s
REALTIME_MAIN_END_PERF_FORMAT=215852.601030129
[time_cmd_output] time_elapsed_sec=13.60, faults_major=0, faults_minor=241222, mem_maxresident_kb=965744, user_cputime=876.36, sys_cputime=5.86, percent_cpu=6483%
timeout=false
algorithm=sigouin_int_bst_kcas_validate.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1