__step=000665
__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=data000665.txt
__path_data=data/data000665.txt
__hostname=jax
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x55dc452b4400
addrof(kcasDescriptors[1])=0x55dc452b4d00
addrof(rdcssDescriptors[0])=0x55dc453d4400
addrof(rdcssDescriptors[1])=0x55dc453d44c0
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=6986856.75654390
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.004s
prefilling_size=99740 prefilling_elapsed_millis=1.001s
finished prefilling to size 99785 for expected size 100000 keysum=9974112062, performing 35268416 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=99785
pref_millis=1102
prefill_elapsed_ms=1122
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=6986857.389823966
REALTIME_END_PERF_FORMAT=6986867.389958468
###############################################################################
################################## 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 8081 14467 16999 8608 1129 11 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 101 1483 9699 18927 10991 1396 12
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8182 15950 26698 27535 12120 1407 12
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8182 15950 26698 27535 12120 1407 12
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 1.99756 1.96175 1.76683 1.39464 1.12755 1.02294 1.00071 1
tree_stats_height=20
tree_stats_numInternals=57486
tree_stats_numLeaves=42609
tree_stats_numNodes=100095
tree_stats_numKeys=100095
tree_stats_avgDegreeInternal=1.74121
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.42569
tree_stats_avgKeyDepth=14.9099
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:64 2:1687 4:60051 8:379855 16:38234 32:3
[2^00, 2^01]: 64
(2^01, 2^02]: 1687
(2^02, 2^03]: 60051
(2^03, 2^04]: 379855
(2^04, 2^05]: 38234
(2^05, 2^06]: 3
sum_limbo_reclamation_event_size_total=5276622
count_limbo_reclamation_event_size_by_thread=9996 9997 9998 9998 9998 9998 9998 9997 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9997 9997 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998
count_limbo_reclamation_event_size_total=479894
sum_limbo_reclamation_event_count_total=1743928
first_thread_announced_epoch_by_thread=76078 76078 76078 76078 76078 76078 76078 76078 76078 76078 76078 76078 76078 76078 76078 76078 76078 76078 76078 76078 76078 76078 76078 76078 76078 76078 76078 76078 76078 76078 76078 76078 76078 76078 76078 76078 76078 76078 76078 76078 76078 76078 76078 76078 76078 76078 76078 76078
sum_num_inserts_by_thread=793065 796642 804372 804348 800670 788775 790088 797801 809386 811715 800899 793452 794885 799716 804539 809075 804724 799551 792614 799804 806077 809131 801417 791664 792603 797815 803983 804071 799639 793422 791217 795397 808435 811445 800752 792734 794013 796261 808555 805147 803861 799092 791056 798785 804777 813970 806128 796132
sum_num_inserts_total=38413700
sum_num_deletes_by_thread=791545 798467 805103 805406 799987 789681 790407 797258 811089 809992 800144 792528 794568 798975 806207 807291 804478 798706 791849 800028 805883 809598 801633 788845 791063 796982 806722 806179 800552 790092 792331 797721 807197 810982 800809 793395 792613 798163 808826 803463 803633 800162 793533 798934 807304 812962 805873 796115
sum_num_deletes_total=38415274
sum_num_searches_by_thread=14246117 14356555 14480891 14472779 14410832 14224284 14247401 14358407 14576066 14594637 14400110 14269752 14297288 14382071 14499709 14533185 14495844 14401959 14274551 14406204 14520278 14569524 14429479 14227322 14248943 14358850 14488355 14494022 14410531 14240542 14238761 14334006 14550544 14592432 14419439 14276863 14311538 14355348 14545165 14489969 14468344 14416788 14269656 14388176 14506414 14654466 14514714 14323341
sum_num_searches_total=691572452
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=15830727 15951664 16090366 16082533 16011489 15802740 15827896 15953466 16196541 16216344 16001153 15855732 15886741 15980762 16110455 16149551 16105046 16000216 15859014 16006036 16132238 16188253 16032529 15807831 15832609 15953647 16099060 16104272 16010722 15824056 15822309 15927124 16166176 16214859 16021000 15862992 15898164 15949772 16162546 16098579 16075838 16016042 15854245 15985895 16118495 16281398 16126715 15915588
average_num_operations_total=16008363
stdev_num_operations_total=18958
sum_num_operations_total=768401426
min_num_operations_total=15802740
max_num_operations_total=16281398
first_time_thread_terminate_by_thread=10000134 10000134 10000134 10000133 10000133 10000134 10000133 10000134 10000134 10000141 10000134 10000133 10000134 10000134 10000133 10000134 10000134 10000133 10000134 10000134 10000134 10000133 10000134 10000134 10000136 10000134 10000134 10000133 10000133 10000134 10000133 10000133 10000134 10000135 10000134 10000133 10000134 10000134 10000133 10000134 10000134 10000133 10000135 10000134 10000134 10000133 10000134 10000133
min_time_thread_terminate_total=10000133
max_time_thread_terminate_total=10000141
first_time_thread_start_by_thread=3 2 3 3 2 3 3 3 3 3 2 3 2 3 2 2 2 3 3 3 3 3 2 3 3 2 3 3 2 3 3 3 3 3 2 3 2 3 2 2 2 3 3 3 3 3 2 3
min_time_thread_start_total=2
max_time_thread_start_total=3
sum_duration_all_ops_total=
threads_final_keysum=10025260321
threads_final_size=100095
final_keysum=10025260321
final_size=100095
validate_result=success
Validation OK.
Structural validation OK.
total_find=691572452
total_rq=0
total_inserts=38413700
total_deletes=38415274
total_updates=76828974
total_queries=691572452
total_ops=768401426
find_throughput=69157245
rq_throughput=0
update_throughput=7682897
query_throughput=69157245
total_throughput=76840142
total find : 691572452
total rq : 0
total inserts : 38413700
total deletes : 38415274
total updates : 76828974
total queries : 691572452
total ops : 768401426
find throughput : 69157245
rq throughput : 0
update throughput : 7682897
query throughput : 69157245
total throughput : 76840142
elapsed milliseconds : 10000
napping milliseconds overtime : 0
PAPI_L2_TCM=6.47815
PAPI_L3_TCM=0.000169287
PAPI_TOT_CYC=1705.04
PAPI_TOT_INS=1096.14
garbage=34571443573359
total_execution_walltime=11.439s
REALTIME_MAIN_END_PERF_FORMAT=6986867.527803540
[time_cmd_output] time_elapsed_sec=11.56, faults_major=0, faults_minor=76903, mem_maxresident_kb=309392, user_cputime=561.59, sys_cputime=2.95, percent_cpu=4879%
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