__step=000666
__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 5.0 5.0 -k 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000666.txt
__path_data=data/data000666.txt
__hostname=jax
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x562187ec5400
addrof(kcasDescriptors[1])=0x562187ec5d00
addrof(rdcssDescriptors[0])=0x562187fe5400
addrof(rdcssDescriptors[1])=0x562187fe54c0
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=6986867.708134498
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=5
DEL_FRAC=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=5.0 5.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,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.006s
prefilling_size=100025 prefilling_elapsed_millis=1.001s
finished prefilling to size 99960 for expected size 100000 keysum=10005511096, performing 34843553 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=99960
pref_millis=1102
prefill_elapsed_ms=1132
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6986869.34566740
REALTIME_END_PERF_FORMAT=6986879.34730913

###############################################################################
################################## 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 4096 8159 15022 17892 7518 583 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 32 1158 10049 20881 9639 718
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8191 16180 27941 28399 10222 718
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8191 16180 27941 28399 10222 718
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 1.99976 1.97925 1.79845 1.37604 1.09521 1.01321 1

tree_stats_height=19
tree_stats_numInternals=57365
tree_stats_numLeaves=42477
tree_stats_numNodes=99842
tree_stats_numKeys=99842

tree_stats_avgDegreeInternal=1.74047
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.42544
tree_stats_avgKeyDepth=14.8566


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:68 2:1664 4:58651 8:380994 16:38492 32:23
    [2^00, 2^01]: 68
    (2^01, 2^02]: 1664
    (2^02, 2^03]: 58651
    (2^03, 2^04]: 380994
    (2^04, 2^05]: 38492
    (2^05, 2^06]: 23
sum_limbo_reclamation_event_size_total=5291754
count_limbo_reclamation_event_size_by_thread=9998 9998 9998 9998 9998 9998 9997 9998 9998 9997 9998 9998 9998 9997 9997 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9997 9998 9998 9996 9998 9998 9998 9998 9997 9998 9998 9997 9997 9998 9998 9998 9997 9998 9998 9998
count_limbo_reclamation_event_size_total=479892
sum_limbo_reclamation_event_count_total=1726896
first_thread_announced_epoch_by_thread=75332 75332 75332 75332 75332 75332 75332 75332 75332 75332 75332 75332 75332 75332 75332 75332 75332 75332 75332 75332 75332 75332 75332 75332 75332 75332 75332 75332 75332 75332 75332 75332 75332 75332 75332 75332 75332 75332 75332 75332 75332 75332 75332 75332 75332 75332 75332 75332
sum_num_inserts_by_thread=784795 793233 799548 795789 793526 785754 789493 791728 804107 806589 792684 788846 788950 793372 799104 802391 797593 789186 782443 793184 798529 805043 789805 788251 782818 796143 800157 798024 797025 786732 788144 793399 803114 806461 795047 791580 788993 792449 802287 800224 792833 789985 784636 785640 794039 797067 797076 789519
sum_num_inserts_total=38107335
sum_num_deletes_by_thread=784423 794107 799821 798113 792546 787122 788049 792134 804787 805873 791703 787756 790089 792692 798952 800762 796845 791573 782961 795223 800932 803144 787842 788457 783750 794834 801587 798322 796419 787970 789409 794012 803823 803458 793798 791023 788388 792272 799799 799205 794055 792750 782627 787031 793365 798396 797910 789515
sum_num_deletes_total=38109624
sum_num_searches_by_thread=14121661 14278941 14384622 14352602 14263259 14167166 14184773 14267106 14462726 14494320 14257741 14197642 14202317 14274010 14366706 14431344 14337923 14218782 14110982 14297595 14387487 14458767 14209997 14186124 14106250 14317605 14410136 14367126 14319987 14164660 14213736 14316860 14469076 14485035 14309791 14218363 14194768 14275852 14416665 14400857 14277827 14248333 14070950 14150576 14279947 14365725 14338242 14209409
sum_num_searches_total=685842369
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=15690879 15866281 15983991 15946504 15849331 15740042 15762315 15850968 16071620 16106782 15842128 15774244 15781356 15860074 15964762 16034497 15932361 15799541 15676386 15886002 15986948 16066954 15787644 15762832 15672818 15908582 16011880 15963472 15913431 15739362 15791289 15904271 16076013 16094954 15898636 15800966 15772149 15860573 16018751 16000286 15864715 15831068 15638213 15723247 15867351 15961188 15933228 15788443
average_num_operations_total=15876236
stdev_num_operations_total=17610
sum_num_operations_total=762059328
min_num_operations_total=15638213
max_num_operations_total=16106782
first_time_thread_terminate_by_thread=10000161 10000162 10000162 10000161 10000161 10000162 10000162 10000161 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000161 10000161 10000162 10000162 10000161 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162 10000162
min_time_thread_terminate_total=10000161
max_time_thread_terminate_total=10000162
first_time_thread_start_by_thread=3 3 3 2 3 2 3 3 3 2 3 3 3 3 3 3 2 2 2 2 3 2 2 3 3 3 3 2 3 2 3 3 3 2 3 3 3 3 3 3 2 2 2 2 3 2 2 3
min_time_thread_start_total=2
max_time_thread_start_total=3
sum_duration_all_ops_total=

threads_final_keysum=9987384825
threads_final_size=99842
final_keysum=9987384825
final_size=99842
validate_result=success
Validation OK.
Structural validation OK.

total_find=685842369
total_rq=0
total_inserts=38107335
total_deletes=38109624
total_updates=76216959
total_queries=685842369
total_ops=762059328
find_throughput=68584236
rq_throughput=0
update_throughput=7621695
query_throughput=68584236
total_throughput=76205932


total find                    : 685842369
total rq                      : 0
total inserts                 : 38107335
total deletes                 : 38109624
total updates                 : 76216959
total queries                 : 685842369
total ops                     : 762059328
find throughput               : 68584236
rq throughput                 : 0
update throughput             : 7621695
query throughput              : 68584236
total throughput              : 76205932

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=6.48205
PAPI_L3_TCM=0.000171558
PAPI_TOT_CYC=1719.07
PAPI_TOT_INS=1093.34
garbage=34294066209026
total_execution_walltime=11.462s
REALTIME_MAIN_END_PERF_FORMAT=6986879.170738911
[time_cmd_output] time_elapsed_sec=11.59, faults_major=0, faults_minor=76856, mem_maxresident_kb=309084, user_cputime=560.37, sys_cputime=3.15, percent_cpu=4860%
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=2