__step=000890
__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 50.0 50.0 -k 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000890.txt
__path_data=data/data000890.txt
__hostname=jax
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x564d0c5ac400
addrof(kcasDescriptors[1])=0x564d0c5acd00
addrof(rdcssDescriptors[0])=0x564d0c6cc400
addrof(rdcssDescriptors[1])=0x564d0c6cc4c0
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=6989686.946299567
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=50
DEL_FRAC=50
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=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,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.004s
prefilling_size=1000893 prefilling_elapsed_millis=1.001s
finished prefilling to size 1000938 for expected size 1000000 keysum=1000990692007, performing 28562247 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=1000938
pref_millis=1102
prefill_elapsed_ms=1118
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6989688.239082029
REALTIME_END_PERF_FORMAT=6989698.239240326

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

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65347 122941 168734 118025 31284 2020 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 178 6947 63803 167309 144756 39952 2489
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65525 129888 232537 285334 176040 41972 2489
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65525 129888 232537 285334 176040 41972 2489
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99966 1.98498 1.84377 1.50143 1.20332 1.06071 1.01117 1

tree_stats_height=23
tree_stats_numInternals=573886
tree_stats_numLeaves=425434
tree_stats_numNodes=999320
tree_stats_numKeys=999320

tree_stats_avgDegreeInternal=1.74132
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.42572
tree_stats_avgKeyDepth=18.2504


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:0 4:0 8:0 16:2 32:253 64:465769 128:13880
    (2^04, 2^05]: 2
    (2^05, 2^06]: 253
    (2^06, 2^07]: 465769
    (2^07, 2^08]: 13880
sum_limbo_reclamation_event_size_total=52729464
count_limbo_reclamation_event_size_by_thread=9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998
count_limbo_reclamation_event_size_total=479904
sum_limbo_reclamation_event_count_total=611568
first_thread_announced_epoch_by_thread=28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190 28190
sum_num_inserts_by_thread=2781194 2794225 2816761 2812322 2811402 2786918 2788268 2804051 2820428 2828676 2810736 2791173 2801899 2798157 2806030 2812647 2805761 2793077 2791346 2799411 2814171 2813162 2784707 2784353 2790963 2798202 2817411 2816978 2800021 2774696 2788740 2771966 2815975 2815404 2796774 2778650 2777980 2802406 2803422 2820876 2803452 2792811 2774694 2787287 2805213 2817630 2803118 2784822
sum_num_inserts_total=134390366
sum_num_deletes_by_thread=2780583 2791950 2817530 2813988 2809769 2790335 2789413 2805187 2815818 2832402 2808301 2793641 2798843 2799661 2809438 2812826 2810744 2794562 2788510 2801773 2810080 2811211 2784786 2783307 2794297 2800192 2815830 2818043 2799795 2776730 2790477 2766856 2811836 2819714 2796944 2778273 2783035 2799779 2804333 2815910 2804305 2796212 2781481 2792677 2805572 2813251 2799567 2783877
sum_num_deletes_total=134403644
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=5561777 5586175 5634291 5626310 5621171 5577253 5577681 5609238 5636246 5661078 5619037 5584814 5600742 5597818 5615468 5625473 5616505 5587639 5579856 5601184 5624251 5624373 5569493 5567660 5585260 5598394 5633241 5635021 5599816 5551426 5579217 5538822 5627811 5635118 5593718 5556923 5561015 5602185 5607755 5636786 5607757 5589023 5556175 5579964 5610785 5630881 5602685 5568699
average_num_operations_total=5599875
stdev_num_operations_total=4041
sum_num_operations_total=268794010
min_num_operations_total=5538822
max_num_operations_total=5661078
first_time_thread_terminate_by_thread=10000158 10000157 10000158 10000158 10000158 10000160 10000158 10000158 10000161 10000157 10000157 10000158 10000157 10000158 10000157 10000158 10000157 10000158 10000157 10000159 10000158 10000160 10000158 10000157 10000158 10000157 10000159 10000158 10000158 10000158 10000158 10000159 10000161 10000157 10000157 10000158 10000157 10000158 10000158 10000158 10000158 10000158 10000157 10000159 10000158 10000157 10000157 10000157
min_time_thread_terminate_total=10000157
max_time_thread_terminate_total=10000161
first_time_thread_start_by_thread=5 5 5 5 5 5 5 5 6 6 5 5 5 5 6 5 5 5 5 5 5 6 5 5 5 5 5 5 5 5 5 5 6 6 5 5 5 5 6 5 5 5 5 5 5 6 5 5
min_time_thread_start_total=5
max_time_thread_start_total=6
sum_duration_all_ops_total=

threads_final_keysum=999367124096
threads_final_size=999320
final_keysum=999367124096
final_size=999320
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=134390366
total_deletes=134403644
total_updates=268794010
total_queries=0
total_ops=268794010
find_throughput=0
rq_throughput=0
update_throughput=26879401
query_throughput=0
total_throughput=26879401


total find                    : 0
total rq                      : 0
total inserts                 : 134390366
total deletes                 : 134403644
total updates                 : 268794010
total queries                 : 0
total ops                     : 268794010
find throughput               : 0
rq throughput                 : 0
update throughput             : 26879401
query throughput              : 0
total throughput              : 26879401

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=16.6686
PAPI_L3_TCM=3.07986
PAPI_TOT_CYC=4833.83
PAPI_TOT_INS=2981.48
garbage=0
total_execution_walltime=11.444s
REALTIME_MAIN_END_PERF_FORMAT=6989698.391899994
[time_cmd_output] time_elapsed_sec=11.57, faults_major=0, faults_minor=91758, mem_maxresident_kb=368692, user_cputime=561.02, sys_cputime=3.05, percent_cpu=4874%
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