__step=000329
__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 48 -nprefill 48 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 0.5 0.5 -k 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000329.txt
__path_data=data/data000329.txt
__hostname=jax
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x55b01ed09400
addrof(kcasDescriptors[1])=0x55b01ed09d00
addrof(rdcssDescriptors[0])=0x55b01ee29400
addrof(rdcssDescriptors[1])=0x55b01ee294c0
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=6982729.212169233
binary=./sigouin_int_avl_kcas_validate.debra
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
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=0.5
DEL_FRAC=0.5
RQ=0
RQSIZE=0
MAXKEY=200000
PREFILL_THREADS=48
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=48
WORK_THREADS=48
RQ_THREADS=0
distribution=0
INS_DEL_FRAC=0.5 0.5
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,96,97,98,99,100,101,102,103,104,105,106,107,108,109,110,111,112,113,114,115,116,117,118,119


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.005s
prefilling_size=99981 prefilling_elapsed_millis=1.001s
finished prefilling to size 99997 for expected size 100000 keysum=9998160538, performing 35402116 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=99997
pref_millis=1102
prefill_elapsed_ms=1132
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6982730.542044746
REALTIME_END_PERF_FORMAT=6982740.542182497

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

tree_stats_computeWalltime=0.037s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4095 8120 14461 16729 8537 1443 40 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 1 64 1553 9880 18497 10723 1839 50
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8184 16014 26609 27034 12166 1879 50
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8184 16014 26609 27034 12166 1879 50
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 1.99829 1.96457 1.75859 1.38727 1.13424 1.03584 1.00532 1

tree_stats_height=20
tree_stats_numInternals=57520
tree_stats_numLeaves=42607
tree_stats_numNodes=100127
tree_stats_numKeys=100127

tree_stats_avgDegreeInternal=1.74073
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.42553
tree_stats_avgKeyDepth=14.9208


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:176603 2:138731 4:13184 8:9
    [2^00, 2^01]: 176603
    (2^01, 2^02]: 138731
    (2^02, 2^03]: 13184
    (2^03, 2^04]: 9
sum_limbo_reclamation_event_size_total=548172
count_limbo_reclamation_event_size_by_thread=6804 6884 6868 6951 6837 6826 6840 6881 6877 6875 6921 6862 6788 6809 6822 6942 6863 6879 6876 6827 6752 6857 6821 6760 6830 6894 6878 6859 6759 6864 6905 6842 6797 6909 6756 6889 6768 6837 6825 6856 6871 6779 6769 6799 6772 6878 6932 6837
count_limbo_reclamation_event_size_total=328527
sum_limbo_reclamation_event_count_total=1943808
first_thread_announced_epoch_by_thread=84416 84416 84416 84416 84416 84416 84416 84416 84416 84416 84416 84416 84416 84416 84416 84416 84416 84416 84416 84416 84416 84416 84416 84416 84416 84416 84416 84416 84416 84416 84416 84416 84416 84416 84416 84416 84416 84416 84416 84416 84416 84416 84416 84416 84416 84416 84416 84416
sum_num_inserts_by_thread=91075 92473 92661 93664 91948 92528 91039 91572 93419 93335 92906 92917 91574 92420 92348 93828 92838 91702 92478 92116 93326 93602 92230 90839 90278 91773 93555 92256 92604 92159 92155 91900 92682 94922 93526 91684 92034 93582 92547 93462 93473 92923 90731 91894 92773 94039 93395 92395
sum_num_inserts_total=4441580
sum_num_deletes_by_thread=91299 93118 92969 93684 92129 92005 90588 91540 93353 93592 92752 92859 91977 92471 92694 94115 93454 92100 92093 91583 92726 93718 92019 90871 91033 92503 93221 92366 92381 91759 92769 92296 92418 94483 93080 91756 91887 93296 93060 93522 93899 92623 90528 92160 92439 93498 93614 92492
sum_num_deletes_total=4442792
sum_num_searches_by_thread=18103383 18408255 18401291 18537623 18296027 18210181 18053125 18112371 18448878 18565555 18451608 18341671 18141989 18283158 18384714 18664849 18483519 18263742 18246228 18178946 18428465 18521796 18212793 18040159 18012048 18169359 18513804 18314219 18399620 18220974 18212107 18214037 18297495 18724621 18442840 18068328 18129378 18481228 18425535 18516026 18541637 18423924 17938223 18231104 18401713 18542887 18516550 18276018
sum_num_searches_total=879794001
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=18285757 18593846 18586921 18724971 18480104 18394714 18234752 18295483 18635650 18752482 18637266 18527447 18325540 18468049 18569756 18852792 18669811 18447544 18430799 18362645 18614517 18709116 18397042 18221869 18193359 18353635 18700580 18498841 18584605 18404892 18397031 18398233 18482595 18914026 18629446 18251768 18313299 18668106 18611142 18703010 18729009 18609470 18119482 18415158 18586925 18730424 18703559 18460905
average_num_operations_total=18514132
stdev_num_operations_total=26652
sum_num_operations_total=888678373
min_num_operations_total=18119482
max_num_operations_total=18914026
first_time_thread_terminate_by_thread=10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000138 10000137 10000137 10000136 10000138 10000136 10000137 10000137 10000137 10000136 10000137 10000138 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000138 10000137 10000137 10000136 10000137 10000136 10000137 10000137 10000137 10000136 10000137 10000138 10000137 10000137 10000137
min_time_thread_terminate_total=10000136
max_time_thread_terminate_total=10000138
first_time_thread_start_by_thread=3 4 4 4 4 4 4 4 4 4 4 4 4 4 3 4 4 4 4 4 4 4 4 4 3 4 4 4 4 4 4 4 4 4 4 4 4 4 3 4 4 4 4 4 4 4 4 4
min_time_thread_start_total=3
max_time_thread_start_total=4
sum_duration_all_ops_total=

threads_final_keysum=10003225821
threads_final_size=100127
final_keysum=10003225821
final_size=100127
validate_result=success
Validation OK.
Structural validation OK.

total_find=879794001
total_rq=0
total_inserts=4441580
total_deletes=4442792
total_updates=8884372
total_queries=879794001
total_ops=888678373
find_throughput=87979400
rq_throughput=0
update_throughput=888437
query_throughput=87979400
total_throughput=88867837


total find                    : 879794001
total rq                      : 0
total inserts                 : 4441580
total deletes                 : 4442792
total updates                 : 8884372
total queries                 : 879794001
total ops                     : 888678373
find throughput               : 87979400
rq throughput                 : 0
update throughput             : 888437
query throughput              : 87979400
total throughput              : 88867837

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=5.8732
PAPI_L3_TCM=0.000143653
PAPI_TOT_CYC=1475.49
PAPI_TOT_INS=928.532
garbage=43970374630433
total_execution_walltime=11.442s
REALTIME_MAIN_END_PERF_FORMAT=6982740.670764626
[time_cmd_output] time_elapsed_sec=11.59, faults_major=0, faults_minor=76556, mem_maxresident_kb=307980, user_cputime=559.75, sys_cputime=2.67, percent_cpu=4851%
timeout=false
algorithm=sigouin_int_avl_kcas_validate.debra
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=1