__step=000417
__cmd_run=LD_PRELOAD=../../setbench/lib/libjemalloc.so timeout 180 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 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000417.txt
__path_data=data/data000417.txt
__hostname=jax
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x55cf493ee400
addrof(kcasDescriptors[1])=0x55cf493eed00
addrof(rdcssDescriptors[0])=0x55cf4950e400
addrof(rdcssDescriptors[1])=0x55cf4950e4c0
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=6999826.443204820
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=2000000
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=1000438 prefilling_elapsed_millis=1.001s
finished prefilling to size 1000461 for expected size 1000000 keysum=1000336895364, performing 28663933 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=1000461
pref_millis=1102
prefill_elapsed_ms=1123
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6999827.733718797
REALTIME_END_PERF_FORMAT=6999837.733864529

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

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32762 65013 118691 161328 121098 38732 4321 103 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 6 473 9853 62103 153724 145072 49066 5469 130
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65486 128544 223431 274822 183804 53387 5572 130
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65486 128544 223431 274822 183804 53387 5572 130
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99866 1.97015 1.81482 1.50796 1.22817 1.07973 1.02343 1.00485 1

tree_stats_height=24
tree_stats_numInternals=574815
tree_stats_numLeaves=425896
tree_stats_numNodes=1000711
tree_stats_numKeys=1000711

tree_stats_avgDegreeInternal=1.74093
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.42559
tree_stats_avgKeyDepth=18.3037


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:57 2:1486 4:54499 8:377680 16:46172 32:2
    [2^00, 2^01]: 57
    (2^01, 2^02]: 1486
    (2^02, 2^03]: 54499
    (2^03, 2^04]: 377680
    (2^04, 2^05]: 46172
    (2^05, 2^06]: 2
sum_limbo_reclamation_event_size_total=5398363
count_limbo_reclamation_event_size_by_thread=9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9997 9998 9997 9997 9998 9998 9998 9998 9997 9998
count_limbo_reclamation_event_size_total=479896
sum_limbo_reclamation_event_count_total=1059696
first_thread_announced_epoch_by_thread=46878 46878 46878 46878 46878 46878 46878 46878 46878 46878 46878 46878 46878 46878 46878 46878 46878 46878 46878 46878 46878 46878 46878 46878 46878 46878 46878 46878 46878 46878 46878 46878 46878 46878 46878 46878 46878 46878 46878 46878 46878 46878 46878 46878 46878 46878 46878 46878
sum_num_inserts_by_thread=494923 497065 500501 499745 497872 491412 493553 498329 501667 503713 496098 496360 494565 496078 500186 501599 497349 496370 491017 494855 499276 500521 495624 491812 494953 496667 500332 499551 494360 492576 492006 497515 501978 502882 497826 495099 496571 499543 500354 499618 499230 495074 489555 494914 498558 501191 496457 492808
sum_num_inserts_total=23860108
sum_num_deletes_by_thread=495333 497587 499215 499233 497091 491172 492217 497893 501735 502522 496293 493769 495025 495474 499627 501478 497666 496047 490625 495068 498085 500816 496874 490807 494966 496901 501059 499623 495394 493627 492373 497339 503496 503372 498099 495606 496568 498854 501180 500313 497590 494893 489804 495310 498681 501857 499103 493286
sum_num_deletes_total=23860946
sum_num_searches_by_thread=8905157 8949168 8990130 8994470 8945336 8842311 8888062 8951944 9027636 9057664 8950987 8900250 8894553 8932429 8994808 9030067 8951372 8937502 8841304 8916116 8977740 9012744 8926489 8834447 8902180 8945243 9002778 9001475 8919301 8860204 8872991 8960607 9048509 9082958 8953654 8917651 8939949 8979662 9017495 8997905 8953480 8909061 8818151 8902468 8972206 9003499 8955636 8869864
sum_num_searches_total=429439613
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=9895413 9943820 9989846 9993448 9940299 9824895 9873832 9948166 10031038 10063899 9943378 9890379 9884143 9923981 9994621 10033144 9946387 9929919 9822946 9906039 9975101 10014081 9918987 9817066 9892099 9938811 10004169 10000649 9909055 9846407 9857370 9955461 10053983 10089212 9949579 9908356 9933088 9978059 10019029 9997836 9950300 9899028 9797510 9892692 9969445 10006547 9951196 9855958
average_num_operations_total=9940847
stdev_num_operations_total=9855
sum_num_operations_total=477160667
min_num_operations_total=9797510
max_num_operations_total=10089212
first_time_thread_terminate_by_thread=10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000146 10000146 10000145 10000145 10000146 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000146 10000146 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000145 10000146 10000146 10000145 10000145 10000146 10000145 10000145 10000145 10000146 10000145 10000145 10000145 10000146 10000146 10000145
min_time_thread_terminate_total=10000145
max_time_thread_terminate_total=10000146
first_time_thread_start_by_thread=3 3 4 3 3 3 4 3 3 3 4 3 3 4 4 4 4 4 4 3 4 4 4 4 3 3 4 3 3 3 4 3 3 3 4 3 3 4 4 4 4 4 4 3 4 4 4 4
min_time_thread_start_total=3
max_time_thread_start_total=4
sum_duration_all_ops_total=

threads_final_keysum=1000920591472
threads_final_size=1000711
final_keysum=1000920591472
final_size=1000711
validate_result=success
Validation OK.
Structural validation OK.

total_find=429439613
total_rq=0
total_inserts=23860108
total_deletes=23860946
total_updates=47721054
total_queries=429439613
total_ops=477160667
find_throughput=42943961
rq_throughput=0
update_throughput=4772105
query_throughput=42943961
total_throughput=47716066


total find                    : 429439613
total rq                      : 0
total inserts                 : 23860108
total deletes                 : 23860946
total updates                 : 47721054
total queries                 : 429439613
total ops                     : 477160667
find throughput               : 42943961
rq throughput                 : 0
update throughput             : 4772105
query throughput              : 42943961
total throughput              : 47716066

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=15.2801
PAPI_L3_TCM=2.10287
PAPI_TOT_CYC=2798.38
PAPI_TOT_INS=1237.18
garbage=214809055687680
total_execution_walltime=11.416s
REALTIME_MAIN_END_PERF_FORMAT=6999837.860405222
[time_cmd_output] time_elapsed_sec=11.55, faults_major=0, faults_minor=91178, mem_maxresident_kb=366624, user_cputime=558.96, sys_cputime=2.16, percent_cpu=4855%
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