__step=000969
__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_bst_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 200000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000969.txt
__path_data=data/data000969.txt
__hostname=nasus
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x555f4414a3c0
addrof(kcasDescriptors[1])=0x555f4414acc0
addrof(rdcssDescriptors[0])=0x555f4426a3c0
addrof(rdcssDescriptors[1])=0x555f4426a480
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=218498.127489958
binary=./sigouin_int_bst_kcas_validate.debra
parsed custom binding: 0-63,128-191,64-127,192-255
DS_TYPENAME=sigouin_int_bst_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=200000
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.021s
prefilling_size=100200 prefilling_elapsed_millis=1s
finished prefilling to size 100191 for expected size 100000 keysum=10022445836, performing 49379608 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=100191
pref_millis=1101
prefill_elapsed_ms=1111
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=218499.278966636
REALTIME_END_PERF_FORMAT=218509.279005080
###############################################################################
################################## 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 1500 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.1s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 123 240 443 798 1380 2229 3325 4580 5855 6865 7439 7371 6705 5647 4338 2990 1958 1139 661 356 182 99 56 35 31 30 27 31 28 25 19 21 23 20 19 15 9 6 4 5 2 2 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 2 2 16 52 120 298 632 1154 1773 2640 3299 3990 4285 4120 3656 2994 2077 1443 835 497 270 135 73 36 20 17 19 13 19 16 17 9 9 12 14 12 10 7 4 1 4 1 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 125 242 459 850 1500 2527 3957 5734 7628 9505 10738 11361 10990 9767 7994 5984 4035 2582 1496 853 452 234 129 71 51 47 46 44 47 41 36 30 32 32 33 27 19 13 8 6 6 3 2
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 125 242 459 850 1500 2527 3957 5734 7628 9505 10738 11361 10990 9767 7994 5984 4035 2582 1496 853 452 234 129 71 51 47 46 44 47 41 36 30 32 32 33 27 19 13 8 6 6 3 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 1.95312 1.952 1.90496 1.88671 1.82588 1.76467 1.68381 1.60879 1.53157 1.4785 1.40747 1.36524 1.31855 1.27862 1.2403 1.2059 1.17463 1.15465 1.13826 1.12834 1.11254 1.11504 1.12821 1.11628 1.22535 1.31373 1.34043 1.36957 1.36364 1.2766 1.26829 1.30556 1.36667 1.28125 1.40625 1.24242 1.14815 1.21053 1.15385 1.25 1.16667 1.16667 1 1
tree_stats_height=50
tree_stats_numInternals=65258
tree_stats_numLeaves=34605
tree_stats_numNodes=99863
tree_stats_numKeys=99863
tree_stats_avgDegreeInternal=1.53028
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34652
tree_stats_avgKeyDepth=18.1256
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:52 2:5 4:4 8:24 16:45 32:114 64:234874 128:404318 256:125 512:11 1024:116
[2^00, 2^01]: 52
(2^01, 2^02]: 5
(2^02, 2^03]: 4
(2^03, 2^04]: 24
(2^04, 2^05]: 45
(2^05, 2^06]: 114
(2^06, 2^07]: 234874
(2^07, 2^08]: 404318
(2^08, 2^09]: 125
(2^09, 2^10]: 11
(2^10, 2^11]: 116
sum_limbo_reclamation_event_size_total=84856465
count_limbo_reclamation_event_size_by_thread=9995 9995 9994 9996 9994 9995 9996 9994 9995 9996 9995 9996 9996 9994 9996 9995 9995 9994 9996 9995 9995 9993 9997 9995 9995 9996 9996 9994 9996 9994 9996 9994 9997 9995 9994 9995 9997 9995 9995 9996 9997 9996 9996 9997 9995 9994 9996 9995 9993 9995 9995 9995 9996 9997 9994 9995 9995 9995 9994 9993 9996 9993 9995 9994
count_limbo_reclamation_event_size_total=639688
sum_limbo_reclamation_event_count_total=927490
first_thread_announced_epoch_by_thread=31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908 31908
sum_num_inserts_by_thread=3851980 3857335 3791350 3787148 3832151 3801394 3825126 3785253 3725398 3752739 3730096 3726569 3744824 3742483 3817738 3816201 4467900 4366911 4348655 4344792 3796397 3736204 3616143 3686900 3731138 3710207 3734423 3707474 3814354 3754788 3791013 3796833 3793898 3779226 3791816 3751083 3717495 3712500 3712694 3691743 3713829 3703153 3809526 3791136 3800624 3807513 3792365 3802336 3774023 3762421 3759212 3740242 3746854 3773111 3753066 3789949 4300128 4285663 4288977 4390445 3869214 3888952 3878648 3891042
sum_num_inserts_total=246054801
sum_num_deletes_by_thread=3855992 3859234 3794846 3788260 3833256 3796814 3824579 3783224 3717071 3755886 3729177 3728449 3745772 3739353 3816057 3811276 4468351 4367255 4349046 4348052 3796313 3735649 3615738 3690769 3730916 3709782 3732149 3703129 3818490 3754419 3793686 3795922 3790866 3781503 3784370 3753448 3716559 3715824 3716577 3696360 3714615 3697431 3809478 3788750 3797918 3811211 3785969 3803137 3767008 3763513 3759699 3737900 3746574 3771122 3755399 3791924 4300864 4280090 4290901 4385328 3868959 3892342 3878188 3888154
sum_num_deletes_total=246030893
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=7707972 7716569 7586196 7575408 7665407 7598208 7649705 7568477 7442469 7508625 7459273 7455018 7490596 7481836 7633795 7627477 8936251 8734166 8697701 8692844 7592710 7471853 7231881 7377669 7462054 7419989 7466572 7410603 7632844 7509207 7584699 7592755 7584764 7560729 7576186 7504531 7434054 7428324 7429271 7388103 7428444 7400584 7619004 7579886 7598542 7618724 7578334 7605473 7541031 7525934 7518911 7478142 7493428 7544233 7508465 7581873 8600992 8565753 8579878 8775773 7738173 7781294 7756836 7779196
average_num_operations_total=7688838
stdev_num_operations_total=50371
sum_num_operations_total=492085694
min_num_operations_total=7231881
max_num_operations_total=8936251
first_time_thread_terminate_by_thread=10000037 10000037 10000037 10000037 10000038 10000038 10000038 10000039 10000040 10000038 10000038 10000038 10000039 10000039 10000039 10000039 10000038 10000038 10000038 10000038 10000036 10000040 10000040 10000036 10000037 10000037 10000037 10000037 10000037 10000037 10000037 10000037 10000037 10000037 10000037 10000037 10000037 10000037 10000039 10000037 10000038 10000038 10000038 10000038 10000037 10000037 10000037 10000037 10000038 10000038 10000038 10000038 10000036 10000036 10000036 10000039 10000038 10000038 10000038 10000038 10000038 10000038 10000038 10000038
min_time_thread_terminate_total=10000036
max_time_thread_terminate_total=10000040
first_time_thread_start_by_thread=3 3 3 3 4 4 4 4 4 4 3 3 4 4 4 4 3 3 3 3 3 3 3 3 5 5 5 5 7 7 6 6 6 6 6 6 5 5 5 5 5 5 5 5 5 5 5 5 3 3 3 3 6 6 6 6 4 4 4 4 6 6 6 6
min_time_thread_start_total=3
max_time_thread_start_total=7
sum_duration_all_ops_total=
threads_final_keysum=9991082837
threads_final_size=99863
final_keysum=9991082837
final_size=99863
validate_result=success
Validation OK.
Structural validation OK.
total_find=0
total_rq=0
total_inserts=246054801
total_deletes=246030893
total_updates=492085694
total_queries=0
total_ops=492085694
find_throughput=0
rq_throughput=0
update_throughput=49208569
query_throughput=0
total_throughput=49208569
total find : 0
total rq : 0
total inserts : 246054801
total deletes : 246030893
total updates : 492085694
total queries : 0
total ops : 492085694
find throughput : 0
rq throughput : 0
update throughput : 49208569
query throughput : 0
total throughput : 49208569
elapsed milliseconds : 10000
napping milliseconds overtime : 0
garbage=0
total_execution_walltime=11.344s
REALTIME_MAIN_END_PERF_FORMAT=218509.472196321
[time_cmd_output] time_elapsed_sec=11.44, faults_major=0, faults_minor=78297, mem_maxresident_kb=313464, user_cputime=737.34, sys_cputime=4.11, percent_cpu=6479%
timeout=false
algorithm=sigouin_int_bst_kcas_validate.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1