__step=000441
__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 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000441.txt
__path_data=data/data000441.txt
__hostname=jax
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x55ba71b67400
addrof(kcasDescriptors[1])=0x55ba71b67d00
addrof(rdcssDescriptors[0])=0x55ba71c87400
addrof(rdcssDescriptors[1])=0x55ba71c874c0
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=6984218.564133904
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=20000000
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=6381539 prefilling_elapsed_millis=1.001s
prefilling_size=6699231 prefilling_elapsed_millis=1.101s
prefilling_size=6985431 prefilling_elapsed_millis=1.201s
prefilling_size=7244932 prefilling_elapsed_millis=1.301s
prefilling_size=7483080 prefilling_elapsed_millis=1.402s
prefilling_size=7699726 prefilling_elapsed_millis=1.502s
prefilling_size=7895939 prefilling_elapsed_millis=1.602s
prefilling_size=8074923 prefilling_elapsed_millis=1.702s
prefilling_size=8237892 prefilling_elapsed_millis=1.802s
prefilling_size=8389022 prefilling_elapsed_millis=1.903s
prefilling_size=8525333 prefilling_elapsed_millis=2.003s
prefilling_size=8648111 prefilling_elapsed_millis=2.103s
prefilling_size=8761741 prefilling_elapsed_millis=2.203s
prefilling_size=8867035 prefilling_elapsed_millis=2.303s
prefilling_size=8962169 prefilling_elapsed_millis=2.404s
prefilling_size=9049544 prefilling_elapsed_millis=2.504s
prefilling_size=9130003 prefilling_elapsed_millis=2.604s
prefilling_size=9203172 prefilling_elapsed_millis=2.704s
prefilling_size=9269972 prefilling_elapsed_millis=2.805s
prefilling_size=9331454 prefilling_elapsed_millis=2.905s
prefilling_size=9387460 prefilling_elapsed_millis=3.005s
prefilling_size=9438845 prefilling_elapsed_millis=3.105s
prefilling_size=9486745 prefilling_elapsed_millis=3.205s
prefilling_size=9528214 prefilling_elapsed_millis=3.306s
prefilling_size=9568400 prefilling_elapsed_millis=3.406s
prefilling_size=9605324 prefilling_elapsed_millis=3.506s
prefilling_size=9638275 prefilling_elapsed_millis=3.606s
prefilling_size=9668897 prefilling_elapsed_millis=3.706s
prefilling_size=9696347 prefilling_elapsed_millis=3.807s
prefilling_size=9721955 prefilling_elapsed_millis=3.907s
prefilling_size=9744297 prefilling_elapsed_millis=4.007s
prefilling_size=9766061 prefilling_elapsed_millis=4.107s
prefilling_size=9785253 prefilling_elapsed_millis=4.207s
prefilling_size=9801337 prefilling_elapsed_millis=4.308s
finished prefilling to size 9801388 for expected size 10000000 keysum=98013735443164, performing 78692127 updates; total_prefilling_elapsed_ms=4409 ms)
pref_size=9801388
pref_millis=4409
prefill_elapsed_ms=4436
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=6984223.141927378
REALTIME_END_PERF_FORMAT=6984233.142072188
###############################################################################
################################## 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.045s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262078 520263 970695 1452189 1391018 698231 143975 7178 7 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 63 3566 60580 401379 1174796 1530116 870383 184178 8980 7
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262141 523829 1031275 1853568 2565814 2228347 1014358 191356 8987 7
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262141 523829 1031275 1853568 2565814 2228347 1014358 191356 8987 7
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99998 1.99851 1.97553 1.8561 1.6008 1.32634 1.14187 1.04671 1.00945 1 1
tree_stats_height=28
tree_stats_numInternals=5707777
tree_stats_numLeaves=4234048
tree_stats_numNodes=9941825
tree_stats_numKeys=9941825
tree_stats_avgDegreeInternal=1.7418
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.42588
tree_stats_avgKeyDepth=21.6739
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:43 2:1479 4:54800 8:374401 16:49180
[2^00, 2^01]: 43
(2^01, 2^02]: 1479
(2^02, 2^03]: 54800
(2^03, 2^04]: 374401
(2^04, 2^05]: 49180
sum_limbo_reclamation_event_size_total=5422926
count_limbo_reclamation_event_size_by_thread=9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 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=479903
sum_limbo_reclamation_event_count_total=545616
first_thread_announced_epoch_by_thread=30032 30032 30032 30032 30032 30032 30032 30032 30032 30032 30032 30032 30032 30032 30032 30032 30032 30032 30032 30032 30032 30032 30032 30032 30032 30032 30032 30032 30032 30032 30032 30032 30032 30032 30032 30032 30032 30032 30032 30032 30032 30032 30032 30032 30032 30032 30032 30032
sum_num_inserts_by_thread=257733 259799 260598 261797 260036 257026 258532 259358 262103 261519 260307 258208 258923 259745 261721 261432 260500 259103 258101 259642 260556 261076 257929 256957 258435 259072 260631 260862 260661 259401 258984 259870 263321 262254 259708 258609 258199 260708 262298 261628 259898 259096 258333 259174 260416 261566 258792 257058
sum_num_inserts_total=12471675
sum_num_deletes_by_thread=258343 259331 261091 262093 260390 257280 259179 260103 262752 262171 259431 257805 258548 260322 261181 262022 261112 259728 257962 258502 260639 261801 257982 256849 257923 258987 261672 261424 261136 257859 259192 260193 262344 263164 260643 258331 258955 261764 261958 262052 259630 259498 257341 258749 259415 261743 258235 257751
sum_num_deletes_total=12476576
sum_num_searches_by_thread=4656538 4676909 4701390 4702624 4684898 4637317 4652929 4673627 4716094 4715085 4678866 4646806 4661727 4680721 4706794 4711287 4686000 4667925 4646309 4666221 4687445 4704658 4654789 4623120 4654718 4673053 4700163 4708901 4690699 4647030 4658593 4685347 4729042 4717585 4679637 4656691 4663011 4697267 4722815 4710120 4682951 4670027 4643379 4664380 4681494 4707324 4655501 4628205
sum_num_searches_total=224568012
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=5172614 5196039 5223079 5226514 5205324 5151623 5170640 5193088 5240949 5238775 5198604 5162819 5179198 5200788 5229696 5234741 5207612 5186756 5162372 5184365 5208640 5227535 5170700 5136926 5171076 5191112 5222466 5231187 5212496 5164290 5176769 5205410 5254707 5243003 5199988 5173631 5180165 5219739 5247071 5233800 5202479 5188621 5159053 5182303 5201325 5230633 5172528 5143014
average_num_operations_total=5198255
stdev_num_operations_total=4304
sum_num_operations_total=249516263
min_num_operations_total=5136926
max_num_operations_total=5254707
first_time_thread_terminate_by_thread=10000143 10000144 10000143 10000143 10000143 10000143 10000143 10000143 10000143 10000143 10000143 10000144 10000143 10000144 10000143 10000143 10000143 10000144 10000143 10000144 10000144 10000143 10000144 10000143 10000143 10000144 10000143 10000143 10000143 10000143 10000143 10000143 10000143 10000143 10000143 10000143 10000143 10000143 10000144 10000143 10000143 10000143 10000143 10000144 10000147 10000143 10000144 10000143
min_time_thread_terminate_total=10000143
max_time_thread_terminate_total=10000147
first_time_thread_start_by_thread=4 3 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 3 4 4 4 4 4 4 4 3 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 3 4 4 4 4 4 4
min_time_thread_start_total=3
max_time_thread_start_total=4
sum_duration_all_ops_total=
threads_final_keysum=99433880294293
threads_final_size=9941825
final_keysum=99433880294293
final_size=9941825
validate_result=success
Validation OK.
Structural validation OK.
total_find=224568012
total_rq=0
total_inserts=12471675
total_deletes=12476576
total_updates=24948251
total_queries=224568012
total_ops=249516263
find_throughput=22456801
rq_throughput=0
update_throughput=2494825
query_throughput=22456801
total_throughput=24951626
total find : 224568012
total rq : 0
total inserts : 12471675
total deletes : 12476576
total updates : 24948251
total queries : 224568012
total ops : 249516263
find throughput : 22456801
rq throughput : 0
update throughput : 2494825
query throughput : 22456801
total throughput : 24951626
elapsed milliseconds : 10000
napping milliseconds overtime : 0
PAPI_L2_TCM=27.5533
PAPI_L3_TCM=9.42518
PAPI_TOT_CYC=5363.11
PAPI_TOT_INS=1381.67
garbage=1110194579497498
total_execution_walltime=14.721s
REALTIME_MAIN_END_PERF_FORMAT=6984233.286432644
[time_cmd_output] time_elapsed_sec=14.91, faults_major=0, faults_minor=234951, mem_maxresident_kb=941588, user_cputime=721.08, sys_cputime=3.38, percent_cpu=4858%
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