__step=000106
__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 0.5 0.5 -k 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000106.txt
__path_data=data/data000106.txt
__hostname=jax
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x55cab3934400
addrof(kcasDescriptors[1])=0x55cab3934d00
addrof(rdcssDescriptors[0])=0x55cab3a54400
addrof(rdcssDescriptors[1])=0x55cab3a544c0
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=6980106.916002433
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=0.5
DEL_FRAC=0.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=0.5 0.5
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.005s
prefilling_size=6306609 prefilling_elapsed_millis=1.001s
prefilling_size=6616438 prefilling_elapsed_millis=1.101s
prefilling_size=6896831 prefilling_elapsed_millis=1.201s
prefilling_size=7152744 prefilling_elapsed_millis=1.301s
prefilling_size=7385267 prefilling_elapsed_millis=1.402s
prefilling_size=7597466 prefilling_elapsed_millis=1.502s
prefilling_size=7791016 prefilling_elapsed_millis=1.602s
prefilling_size=7966723 prefilling_elapsed_millis=1.702s
prefilling_size=8126706 prefilling_elapsed_millis=1.803s
prefilling_size=8275813 prefilling_elapsed_millis=1.903s
prefilling_size=8412392 prefilling_elapsed_millis=2.003s
prefilling_size=8536523 prefilling_elapsed_millis=2.103s
prefilling_size=8651093 prefilling_elapsed_millis=2.203s
prefilling_size=8754453 prefilling_elapsed_millis=2.304s
prefilling_size=8848901 prefilling_elapsed_millis=2.404s
prefilling_size=8935863 prefilling_elapsed_millis=2.504s
prefilling_size=9017495 prefilling_elapsed_millis=2.604s
prefilling_size=9091144 prefilling_elapsed_millis=2.704s
prefilling_size=9160440 prefilling_elapsed_millis=2.805s
prefilling_size=9223629 prefilling_elapsed_millis=2.905s
prefilling_size=9282032 prefilling_elapsed_millis=3.005s
prefilling_size=9335931 prefilling_elapsed_millis=3.105s
prefilling_size=9385967 prefilling_elapsed_millis=3.205s
prefilling_size=9430859 prefilling_elapsed_millis=3.305s
prefilling_size=9474036 prefilling_elapsed_millis=3.406s
prefilling_size=9512698 prefilling_elapsed_millis=3.506s
prefilling_size=9548671 prefilling_elapsed_millis=3.606s
prefilling_size=9583585 prefilling_elapsed_millis=3.706s
prefilling_size=9613986 prefilling_elapsed_millis=3.806s
prefilling_size=9642988 prefilling_elapsed_millis=3.907s
prefilling_size=9669791 prefilling_elapsed_millis=4.007s
prefilling_size=9693605 prefilling_elapsed_millis=4.107s
prefilling_size=9716392 prefilling_elapsed_millis=4.207s
prefilling_size=9737363 prefilling_elapsed_millis=4.307s
prefilling_size=9755874 prefilling_elapsed_millis=4.408s
prefilling_size=9772972 prefilling_elapsed_millis=4.508s
prefilling_size=9788139 prefilling_elapsed_millis=4.608s
prefilling_size=9802648 prefilling_elapsed_millis=4.708s
finished prefilling to size 9802678 for expected size 10000000 keysum=98018911450301, performing 85748700 updates; total_prefilling_elapsed_ms=4809 ms)
pref_size=9802678
pref_millis=4809
prefill_elapsed_ms=4833
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=6980111.972338193
REALTIME_END_PERF_FORMAT=6980121.972473497
###############################################################################
################################## 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.072s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262115 521515 983228 1479604 1377702 632613 115026 6184 28 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 28 2480 52260 402554 1228197 1551777 793213 146632 7791 30
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262143 523995 1035488 1882158 2605899 2184390 908239 152816 7819 30
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262143 523995 1035488 1882158 2605899 2184390 908239 152816 7819 30
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99999 1.999 1.98087 1.86812 1.59841 1.30956 1.12618 1.04161 1.0107 1.00026 1
tree_stats_height=28
tree_stats_numInternals=5640158
tree_stats_numLeaves=4184962
tree_stats_numNodes=9825120
tree_stats_numKeys=9825120
tree_stats_avgDegreeInternal=1.74199
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.42595
tree_stats_avgKeyDepth=21.6279
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:175871 2:136734 4:13042 8:11
[2^00, 2^01]: 175871
(2^01, 2^02]: 136734
(2^02, 2^03]: 13042
(2^03, 2^04]: 11
sum_limbo_reclamation_event_size_total=541774
count_limbo_reclamation_event_size_by_thread=6718 6714 6756 6736 6732 6811 6740 6748 6728 6874 6830 6793 6828 6844 6807 6731 6766 6710 6762 6740 6804 6810 6677 6745 6858 6870 6801 6834 6814 6807 6675 6701 6919 6776 6786 6789 6870 6724 6895 6798 6799 6746 6754 6797 6827 6781 6854 6779
count_limbo_reclamation_event_size_total=325658
sum_limbo_reclamation_event_count_total=571056
first_thread_announced_epoch_by_thread=31760 31760 31760 31760 31760 31760 31760 31760 31760 31760 31760 31760 31760 31760 31760 31760 31760 31760 31760 31760 31760 31760 31760 31760 31760 31760 31760 31760 31760 31760 31760 31760 31760 31760 31760 31760 31760 31760 31760 31760 31760 31760 31760 31760 31760 31760 31760 31760
sum_num_inserts_by_thread=27564 27408 27928 27486 27957 26871 27525 27241 27899 28013 27220 27449 27033 27300 27583 27753 27252 27385 26955 27077 27495 27518 27580 26753 27165 27342 27272 27633 27240 27399 27385 27408 27374 27974 27327 27042 27373 27863 27283 27381 27307 27528 26931 27034 27322 27259 27064 26791
sum_num_inserts_total=1313942
sum_num_deletes_by_thread=27442 27219 27423 27284 27330 27089 27492 27337 27436 27558 27322 27435 26901 27411 27873 27884 27561 27137 26848 27139 27217 27379 27149 26802 27207 27148 27399 27461 27234 27725 27362 26872 27682 27829 27265 27085 27240 27407 27562 27558 27353 27281 26914 27095 27448 27492 27094 26720
sum_num_deletes_total=1311101
sum_num_searches_by_thread=5405198 5445206 5480910 5474614 5454415 5353763 5422040 5447750 5500080 5445016 5387594 5414351 5384124 5406284 5492297 5489274 5452223 5419771 5345063 5372885 5399551 5424520 5416459 5335109 5359068 5386451 5428281 5420003 5402026 5400786 5426872 5396439 5446501 5502292 5382268 5360411 5379286 5464850 5443356 5438017 5408355 5422706 5347796 5378906 5407639 5434799 5373864 5339849
sum_num_searches_total=259919318
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=5460204 5499833 5536261 5529384 5509702 5407723 5477057 5502328 5555415 5500587 5442136 5469235 5438058 5460995 5547753 5544911 5507036 5474293 5398866 5427101 5454263 5479417 5471188 5388664 5413440 5440941 5482952 5475097 5456500 5455910 5481619 5450719 5501557 5558095 5436860 5414538 5433899 5520120 5498201 5492956 5463015 5477515 5401641 5433035 5462409 5489550 5428022 5393360
average_num_operations_total=5469674
stdev_num_operations_total=6378
sum_num_operations_total=262544361
min_num_operations_total=5388664
max_num_operations_total=5558095
first_time_thread_terminate_by_thread=10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136 10000136
min_time_thread_terminate_total=10000136
max_time_thread_terminate_total=10000136
first_time_thread_start_by_thread=7 7 7 7 6 7 7 7 7 7 7 7 6 7 7 7 6 7 6 7 7 6 7 7 7 7 7 7 6 7 7 7 7 7 7 7 6 7 7 7 6 7 6 7 7 6 7 7
min_time_thread_start_total=6
max_time_thread_start_total=7
sum_duration_all_ops_total=
threads_final_keysum=98244760990041
threads_final_size=9825120
final_keysum=98244760990041
final_size=9825120
validate_result=success
Validation OK.
Structural validation OK.
total_find=259919318
total_rq=0
total_inserts=1313942
total_deletes=1311101
total_updates=2625043
total_queries=259919318
total_ops=262544361
find_throughput=25991931
rq_throughput=0
update_throughput=262504
query_throughput=25991931
total_throughput=26254436
total find : 259919318
total rq : 0
total inserts : 1313942
total deletes : 1311101
total updates : 2625043
total queries : 259919318
total ops : 262544361
find throughput : 25991931
rq throughput : 0
update throughput : 262504
query throughput : 25991931
total throughput : 26254436
elapsed milliseconds : 10000
napping milliseconds overtime : 0
PAPI_L2_TCM=27.3846
PAPI_L3_TCM=9.25863
PAPI_TOT_CYC=5097.17
PAPI_TOT_INS=1208.19
garbage=1279130159978951
total_execution_walltime=15.2s
REALTIME_MAIN_END_PERF_FORMAT=6980122.131889083
[time_cmd_output] time_elapsed_sec=15.39, faults_major=0, faults_minor=233033, mem_maxresident_kb=933992, user_cputime=739.51, sys_cputime=2.59, percent_cpu=4821%
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