__step=000778
__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_avl_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=data000778.txt
__path_data=data/data000778.txt
__hostname=nasus
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x5646b319d3c0
addrof(kcasDescriptors[1])=0x5646b319dcc0
addrof(rdcssDescriptors[0])=0x5646b32bd3c0
addrof(rdcssDescriptors[1])=0x5646b32bd480
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=216269.701710134
binary=./sigouin_int_avl_kcas_validate.debra
parsed custom binding: 0-63,128-191,64-127,192-255
DS_TYPENAME=sigouin_int_avl_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.02s
prefilling_size=7272618 prefilling_elapsed_millis=1s
prefilling_size=7578688 prefilling_elapsed_millis=1.101s
prefilling_size=7850460 prefilling_elapsed_millis=1.201s
prefilling_size=8090345 prefilling_elapsed_millis=1.301s
prefilling_size=8305105 prefilling_elapsed_millis=1.401s
prefilling_size=8492902 prefilling_elapsed_millis=1.501s
prefilling_size=8657830 prefilling_elapsed_millis=1.601s
prefilling_size=8803714 prefilling_elapsed_millis=1.701s
prefilling_size=8932174 prefilling_elapsed_millis=1.801s
prefilling_size=9048898 prefilling_elapsed_millis=1.902s
prefilling_size=9153456 prefilling_elapsed_millis=2.002s
prefilling_size=9244773 prefilling_elapsed_millis=2.102s
prefilling_size=9325507 prefilling_elapsed_millis=2.202s
prefilling_size=9397862 prefilling_elapsed_millis=2.302s
prefilling_size=9461832 prefilling_elapsed_millis=2.402s
prefilling_size=9520436 prefilling_elapsed_millis=2.502s
prefilling_size=9572883 prefilling_elapsed_millis=2.602s
prefilling_size=9621316 prefilling_elapsed_millis=2.703s
prefilling_size=9661776 prefilling_elapsed_millis=2.803s
prefilling_size=9696320 prefilling_elapsed_millis=2.903s
prefilling_size=9728958 prefilling_elapsed_millis=3.003s
prefilling_size=9758241 prefilling_elapsed_millis=3.103s
prefilling_size=9784055 prefilling_elapsed_millis=3.204s
prefilling_size=9807964 prefilling_elapsed_millis=3.304s
finished prefilling to size 9807992 for expected size 10000000 keysum=98099278556312, performing 79473207 updates; total_prefilling_elapsed_ms=3404 ms)
pref_size=9807992
pref_millis=3404
prefill_elapsed_ms=3417
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=216273.165869439
REALTIME_END_PERF_FORMAT=216283.165945215

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

tree_stats_computeWalltime=0.06s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 261948 517749 962440 1463649 1422656 698789 142784 9411 89 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 187 5479 62140 379010 1172958 1575009 868887 181653 11799 112
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262135 523228 1024580 1842659 2595614 2273798 1011671 191064 11888 112
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262135 523228 1024580 1842659 2595614 2273798 1011671 191064 11888 112
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99993 1.99674 1.96866 1.8591 1.61431 1.32792 1.1376 1.04772 1.01296 1.00193 1

tree_stats_height=28
tree_stats_numInternals=5741658
tree_stats_numLeaves=4257234
tree_stats_numNodes=9998892
tree_stats_numKeys=9998892

tree_stats_avgDegreeInternal=1.74146
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.42577
tree_stats_avgKeyDepth=21.6835


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:0 4:2 8:1 16:0 32:17 64:6435 128:355107 256:108 512:249
    (2^02, 2^03]: 2
    (2^03, 2^04]: 1
    (2^04, 2^05]: 0
    (2^05, 2^06]: 17
    (2^06, 2^07]: 6435
    (2^07, 2^08]: 355107
    (2^08, 2^09]: 108
    (2^09, 2^10]: 249
sum_limbo_reclamation_event_size_total=54388198
count_limbo_reclamation_event_size_by_thread=5655 5655 5655 5654 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655 5655
count_limbo_reclamation_event_size_total=361919
sum_limbo_reclamation_event_count_total=362048
first_thread_announced_epoch_by_thread=15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466 15466
sum_num_inserts_by_thread=1713452 1711015 1702592 1695503 1715112 1711862 1707638 1707891 1705160 1711444 1705913 1699083 1692147 1696930 1692701 1689209 1698112 1695814 1712478 1709825 1713533 1712656 1704472 1703054 1708095 1702503 1694738 1693770 1697982 1695233 1690276 1687203 1718420 1718379 1713937 1711183 1713946 1713406 1712217 1702441 1704151 1700486 1694183 1696984 1699237 1700840 1695462 1708547 1709374 1708604 1702023 1703184 1706976 1705702 1699015 1695109 1696772 1690372 1693760 1693640 1700687 1715221 1713208 1714155
sum_num_inserts_total=109029017
sum_num_deletes_by_thread=1714468 1711450 1703400 1694470 1715268 1710634 1704818 1706453 1709166 1708897 1704570 1697852 1689681 1697957 1691879 1688716 1698091 1696791 1713984 1712125 1711855 1712140 1706422 1703590 1706669 1704788 1695261 1693962 1696679 1696284 1691010 1688133 1720894 1717276 1710965 1711440 1714652 1713561 1709491 1703804 1703295 1701985 1693910 1695630 1700112 1698283 1694105 1712414 1708515 1707655 1698993 1705198 1709040 1705755 1697552 1694116 1696407 1687214 1692412 1692980 1702846 1715972 1711557 1712220
sum_num_deletes_total=109017712
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=3427920 3422465 3405992 3389973 3430380 3422496 3412456 3414344 3414326 3420341 3410483 3396935 3381828 3394887 3384580 3377925 3396203 3392605 3426462 3421950 3425388 3424796 3410894 3406644 3414764 3407291 3389999 3387732 3394661 3391517 3381286 3375336 3439314 3435655 3424902 3422623 3428598 3426967 3421708 3406245 3407446 3402471 3388093 3392614 3399349 3399123 3389567 3420961 3417889 3416259 3401016 3408382 3416016 3411457 3396567 3389225 3393179 3377586 3386172 3386620 3403533 3431193 3424765 3426375
average_num_operations_total=3406980
stdev_num_operations_total=2091
sum_num_operations_total=218046729
min_num_operations_total=3375336
max_num_operations_total=3439314
first_time_thread_terminate_by_thread=10000078 10000078 10000078 10000078 10000077 10000077 10000077 10000077 10000079 10000079 10000080 10000079 10000075 10000075 10000075 10000075 10000076 10000075 10000076 10000076 10000076 10000076 10000076 10000076 10000078 10000078 10000078 10000078 10000076 10000077 10000076 10000077 10000078 10000078 10000078 10000078 10000076 10000076 10000076 10000077 10000077 10000077 10000077 10000077 10000075 10000076 10000075 10000076 10000077 10000077 10000077 10000077 10000075 10000077 10000077 10000077 10000078 10000078 10000078 10000078 10000078 10000078 10000078 10000078
min_time_thread_terminate_total=10000075
max_time_thread_terminate_total=10000080
first_time_thread_start_by_thread=11 11 11 11 11 11 11 11 9 9 9 9 12 12 12 12 7 7 7 7 10 10 10 10 15 15 15 15 11 11 12 11 10 10 10 10 10 10 10 10 13 13 13 13 12 12 12 12 9 9 9 9 13 13 13 13 14 14 14 14 10 10 10 10
min_time_thread_start_total=7
max_time_thread_start_total=15
sum_duration_all_ops_total=

threads_final_keysum=100009146416670
threads_final_size=9998892
final_keysum=100009146416670
final_size=9998892
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=109029017
total_deletes=109017712
total_updates=218046729
total_queries=0
total_ops=218046729
find_throughput=0
rq_throughput=0
update_throughput=21804672
query_throughput=0
total_throughput=21804672


total find                    : 0
total rq                      : 0
total inserts                 : 109029017
total deletes                 : 109017712
total updates                 : 218046729
total queries                 : 0
total ops                     : 218046729
find throughput               : 0
rq throughput                 : 0
update throughput             : 21804672
query throughput              : 0
total throughput              : 21804672

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

garbage=0
total_execution_walltime=13.579s
REALTIME_MAIN_END_PERF_FORMAT=216283.281159145
[time_cmd_output] time_elapsed_sec=13.72, faults_major=0, faults_minor=238980, mem_maxresident_kb=956456, user_cputime=872.84, sys_cputime=5.38, percent_cpu=6398%
timeout=false
algorithm=sigouin_int_avl_kcas_validate.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2