__step=000777
__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=data000777.txt
__path_data=data/data000777.txt
__hostname=nasus
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x560f61e0d3c0
addrof(kcasDescriptors[1])=0x560f61e0dcc0
addrof(rdcssDescriptors[0])=0x560f61f2d3c0
addrof(rdcssDescriptors[1])=0x560f61f2d480
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=216255.912424636
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=7319947 prefilling_elapsed_millis=1s
prefilling_size=7632663 prefilling_elapsed_millis=1.101s
prefilling_size=7909622 prefilling_elapsed_millis=1.201s
prefilling_size=8150593 prefilling_elapsed_millis=1.301s
prefilling_size=8362614 prefilling_elapsed_millis=1.401s
prefilling_size=8550225 prefilling_elapsed_millis=1.501s
prefilling_size=8712585 prefilling_elapsed_millis=1.601s
prefilling_size=8856283 prefilling_elapsed_millis=1.701s
prefilling_size=8985425 prefilling_elapsed_millis=1.801s
prefilling_size=9096695 prefilling_elapsed_millis=1.902s
prefilling_size=9194946 prefilling_elapsed_millis=2.002s
prefilling_size=9283348 prefilling_elapsed_millis=2.102s
prefilling_size=9360095 prefilling_elapsed_millis=2.202s
prefilling_size=9429518 prefilling_elapsed_millis=2.302s
prefilling_size=9489068 prefilling_elapsed_millis=2.402s
prefilling_size=9542044 prefilling_elapsed_millis=2.502s
prefilling_size=9588259 prefilling_elapsed_millis=2.602s
prefilling_size=9630035 prefilling_elapsed_millis=2.702s
prefilling_size=9669500 prefilling_elapsed_millis=2.803s
prefilling_size=9702770 prefilling_elapsed_millis=2.903s
prefilling_size=9733835 prefilling_elapsed_millis=3.003s
prefilling_size=9761530 prefilling_elapsed_millis=3.103s
prefilling_size=9787156 prefilling_elapsed_millis=3.204s
prefilling_size=9809423 prefilling_elapsed_millis=3.304s
finished prefilling to size 9809426 for expected size 10000000 keysum=98101167661361, performing 79979259 updates; total_prefilling_elapsed_ms=3404 ms)
pref_size=9809426
pref_millis=3404
prefill_elapsed_ms=3420
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=216259.370985049
REALTIME_END_PERF_FORMAT=216269.371065431

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

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262125 522129 986997 1492727 1409204 666785 130644 8736 72 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 19 1979 50408 397936 1225103 1574888 831222 165986 10988 82
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262144 524108 1037405 1890663 2634307 2241673 961866 174722 11060 82
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262144 524108 1037405 1890663 2634307 2241673 961866 174722 11060 82
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99939 1.98315 1.87108 1.6038 1.31601 1.13163 1.04583 1.0133 1.0009 1

tree_stats_height=28
tree_stats_numInternals=5741562
tree_stats_numLeaves=4258611
tree_stats_numNodes=10000173
tree_stats_numKeys=10000173

tree_stats_avgDegreeInternal=1.74172
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.42585
tree_stats_avgKeyDepth=21.6575


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:2 4:0 8:5 16:20 32:45 64:5903 128:361901 256:249 512:129
    (2^01, 2^02]: 2
    (2^02, 2^03]: 0
    (2^03, 2^04]: 5
    (2^04, 2^05]: 20
    (2^05, 2^06]: 45
    (2^06, 2^07]: 5903
    (2^07, 2^08]: 361901
    (2^08, 2^09]: 249
    (2^09, 2^10]: 129
sum_limbo_reclamation_event_size_total=55455704
count_limbo_reclamation_event_size_by_thread=5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5753 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5754 5753
count_limbo_reclamation_event_size_total=368254
sum_limbo_reclamation_event_count_total=368384
first_thread_announced_epoch_by_thread=15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648 15648
sum_num_inserts_by_thread=1745081 1739661 1730474 1728194 1734801 1734559 1726251 1724231 1736003 1736744 1734592 1732473 1734585 1736611 1730606 1723101 1743839 1738465 1730136 1728574 1734999 1735364 1749707 1743491 1742823 1742088 1741069 1738648 1741406 1738784 1723414 1730969 1734167 1738551 1732383 1729667 1754533 1749272 1739546 1745201 1744471 1746836 1737391 1736524 1738845 1735298 1727198 1728003 1728072 1730989 1724383 1741830 1741154 1742914 1736458 1738579 1739536 1741428 1737309 1734378 1736645 1740777 1738947 1741548
sum_num_inserts_total=111144576
sum_num_deletes_by_thread=1745593 1738854 1729955 1727780 1736807 1731078 1725701 1725066 1736007 1735325 1735128 1735132 1735949 1736085 1732438 1721536 1742408 1741584 1731313 1728393 1738238 1734113 1747856 1742673 1743606 1743500 1740033 1739543 1741419 1737098 1721794 1729368 1733441 1737511 1732970 1728600 1754034 1750929 1741785 1744068 1743882 1747736 1739315 1738453 1736576 1735436 1730329 1728059 1729348 1730218 1727709 1744449 1741635 1742119 1739113 1738273 1740862 1742597 1735266 1734345 1734210 1741123 1737788 1742525
sum_num_deletes_total=111156077
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=3490674 3478515 3460429 3455974 3471608 3465637 3451952 3449297 3472010 3472069 3469720 3467605 3470534 3472696 3463044 3444637 3486247 3480049 3461449 3456967 3473237 3469477 3497563 3486164 3486429 3485588 3481102 3478191 3482825 3475882 3445208 3460337 3467608 3476062 3465353 3458267 3508567 3500201 3481331 3489269 3488353 3494572 3476706 3474977 3475421 3470734 3457527 3456062 3457420 3461207 3452092 3486279 3482789 3485033 3475571 3476852 3480398 3484025 3472575 3468723 3470855 3481900 3476735 3484073
average_num_operations_total=3473447
stdev_num_operations_total=1683
sum_num_operations_total=222300653
min_num_operations_total=3444637
max_num_operations_total=3508567
first_time_thread_terminate_by_thread=10000083 10000087 10000081 10000083 10000084 10000084 10000084 10000084 10000082 10000082 10000083 10000083 10000081 10000083 10000083 10000081 10000083 10000083 10000083 10000083 10000082 10000082 10000082 10000082 10000090 10000083 10000083 10000082 10000083 10000083 10000083 10000083 10000083 10000083 10000083 10000083 10000084 10000084 10000084 10000084 10000080 10000082 10000082 10000080 10000082 10000082 10000082 10000085 10000082 10000082 10000082 10000084 10000083 10000083 10000084 10000084 10000086 10000086 10000081 10000081 10000081 10000081 10000081 10000081
min_time_thread_terminate_total=10000080
max_time_thread_terminate_total=10000090
first_time_thread_start_by_thread=4 4 4 4 3 3 3 3 4 4 4 4 4 4 4 4 5 5 5 5 4 4 4 4 5 5 2224 5 7 7 7 7 5 5 5 5 6 5 5 6 6 6 6 6 4 4 4 4 6 6 6 6 7 7 7 7 7 8 8 7 8 8 8 8
min_time_thread_start_total=3
max_time_thread_start_total=2224
sum_duration_all_ops_total=

threads_final_keysum=99984560451727
threads_final_size=10000173
final_keysum=99984560451727
final_size=10000173
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=111144576
total_deletes=111156077
total_updates=222300653
total_queries=0
total_ops=222300653
find_throughput=0
rq_throughput=0
update_throughput=22230065
query_throughput=0
total_throughput=22230065


total find                    : 0
total rq                      : 0
total inserts                 : 111144576
total deletes                 : 111156077
total updates                 : 222300653
total queries                 : 0
total ops                     : 222300653
find throughput               : 0
rq throughput                 : 0
update throughput             : 22230065
query throughput              : 0
total throughput              : 22230065

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

garbage=0
total_execution_walltime=13.582s
REALTIME_MAIN_END_PERF_FORMAT=216269.495730732
[time_cmd_output] time_elapsed_sec=13.73, faults_major=0, faults_minor=238513, mem_maxresident_kb=954748, user_cputime=873.68, sys_cputime=4.74, percent_cpu=6396%
timeout=false
algorithm=sigouin_int_avl_kcas_validate.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1