Next Generation CMS :: Форум поддержки

Заинтересовала наша система? Тогда этот форум для Вас!

Вы не зашли.

#101 2011-12-27 12:26:07

legenda
Участник
Откуда ua
Зарегистрирован: 2009-12-22
Сообщений: 2,151
Рейтинг :   39 

Re: Помогите разобратся что так грузит сайт

vitaly пишет:

Раз ты не хочешь выяснять что это за плагин у тебя такой странный (жрущий ресурсы, причём - не входящий в базовую поставку системы), то вариант только один - увеличить производительность сервака.
Разве нет?

я какраз и хочу вияснить, список плагинов я показал, football_stats - я отключал конешно, если он и напрягает то это в пределал милисекунд, а мне интересно что напрягает в десятки секунд, если у меня иногда генерация странички бывает 56 секунд например...

На счет сервака я писал что гдето неделю назал я удвоил ресурсы, именно по этому сайт впринцыпе работает, до того он еле откривался, счас у меня
Virtual CPU 2048Mhz x 2, 2048Mb memory, 204800Mb disk, я думаю это более чем достаточно , но всеравно сервак идет на гране 80% нагрузки

Изменено legenda (2011-12-27 12:27:01)

Не в сети

#102 2011-12-27 13:09:52

Wolverine
Модератор
Откуда Домодедово
Зарегистрирован: 2008-10-13
Сообщений: 3,538
Рейтинг :   160 
Сайт

Re: Помогите разобратся что так грузит сайт

56 секунд yikes жесть, все логи, которые ты сюда сбрасываешь показывают, что выполнение сайта хоть и велико, бывает и 3 секунды, но это все не то, championat.com у меня тоже грузится по две-три секунды, а ведь там работает целая команда smile

Меня смущает самый первый лог в первом сообщении

43.852     0.000    Config file is loaded    
43.887     0.035    Core files are included

То есть даже до момента работы всех плагинов, на загрузку config файла уже потратилось 43 секунды, потом все плагины за 1 секунду отработали. Все это происходит еще до момента соединения с БД.

Можно начать мониторить такие события.

Открой /engine/includes/classes/timer.class.php

Найди     

class microTimer {

Замени на

class microTimer {
	private $flag = false;

Найди

// REGISTER measurment
	function registerEvent($eventName, $eventParams = ''){
		$current_time = $this->stop(4);
		$delta = $current_time - $this->last_event;
		if ($delta < 0) $delta = 0;

		array_push($this->events, array( $current_time, sprintf('%7.3f', $delta), $eventName, $eventParams ));
		$this->last_event = $current_time;
	}

замени на

   

// REGISTER measurment
	function registerEvent($eventName, $eventParams = ''){
		$current_time = $this->stop(4);
		if($current_time > 10) $this->flag = true;
		$delta = $current_time - $this->last_event;
		if ($delta < 0) $delta = 0;

		array_push($this->events, array( $current_time, sprintf('%7.3f', $delta), $eventName, $eventParams ));
		$this->last_event = $current_time;
	}

Найди

// Print events
	function printEvents($html = 0){
		$out = ($html)?"<table class='timeProfiler'>\n<tr><td><b>Time</b></td><td><b>Delta</b></td><td><b>Event</b></td><td><b>Desc</b></td></tr>\n":'';
		foreach ($this->events as $v) {
			$out .= ($html)?('<tr><td>'.sprintf('%7.3f', $v[0]).'</td><td>'.$v[1].'</td><td>'.$v[2].'</td><td>'.$v[3]."</td></tr>\n"):$v[0]."\t".$v[1]."\t".$v[2]."\t".$v[3]."\n";
		}
		$out .= (($html)?"</table>":'')."\n";
		return $out;
	}

Замени на     

// Print events
	function printEvents($html = 0){
		$out = ($html)?"<table class='timeProfiler'>\n<tr><td><b>Time</b></td><td><b>Delta</b></td><td><b>Event</b></td><td><b>Desc</b></td></tr>\n":'';
		foreach ($this->events as $v) {
			$out .= ($html)?('<tr><td>'.sprintf('%7.3f', $v[0]).'</td><td>'.$v[1].'</td><td>'.$v[2].'</td><td>'.$v[3]."</td></tr>\n"):$v[0]."\t".$v[1]."\t".$v[2]."\t".$v[3]."\n";
		}
		$out .= (($html)?"</table>":'')."\n";
		if($this->flag) file_put_contents('log.txt', $out, FILE_APPEND);
		return $out;
	}

Позже надо будет посмотреть содержимое файла log.txt в корне и увидим как часто это происходит. Потом надо будет смотреть на какие операции тратилось 40 секунд.

Не в сети

#103 2011-12-27 13:19:32

legenda
Участник
Откуда ua
Зарегистрирован: 2009-12-22
Сообщений: 2,151
Рейтинг :   39 

Re: Помогите разобратся что так грузит сайт

Wolverine, я не о загрузке а именно о генерации странички, я ж писал 11 секунд при 300 онлайн посетителях, бывает и больше если людей 500-1000 онлайн то и 40 и 50, но это счас практически нету так как специфика сайта футбольная, уже все турниры закончились, но когда идут топ матчи то на сайте до 2-3 тис. онлайн бывает...


счас сделаю то что ти написал...

Не в сети

#104 2011-12-27 13:26:49

Wolverine
Модератор
Откуда Домодедово
Зарегистрирован: 2008-10-13
Сообщений: 3,538
Рейтинг :   160 
Сайт

Re: Помогите разобратся что так грузит сайт

В логах будут всё, что обрабатывалось больше 10 секунд.

Не в сети

#105 2011-12-28 03:27:20

legenda
Участник
Откуда ua
Зарегистрирован: 2009-12-22
Сообщений: 2,151
Рейтинг :   39 

Re: Помогите разобратся что так грузит сайт

вот лог за сегодня

<table class='timeProfiler'>
<tr><td><b>Time</b></td><td><b>Delta</b></td><td><b>Event</b></td><td><b>Desc</b></td></tr>
<tr><td>  0.002</td><td>  0.000</td><td>Config file is loaded</td><td></td></tr>
<tr><td>  0.016</td><td>  0.014</td><td>Core files are included</td><td></td></tr>
<tr><td>  0.025</td><td>  0.010</td><td>Template engine is activated</td><td></td></tr>
<tr><td>  0.029</td><td>  0.004</td><td>DB connection established</td><td></td></tr>
<tr><td>  0.031</td><td>  0.002</td><td>DB category list is loaded</td><td></td></tr>
<tr><td>  0.031</td><td>  0.000</td><td>Ready to load auth plugins</td><td></td></tr>
<tr><td>  0.034</td><td>  0.003</td><td>loadActionHandlers(auth): preloaded file "auth_basic/auth_basic.php" for 0.0021 sec</td><td></td></tr>
<tr><td>  0.034</td><td>  0.000</td><td>Auth plugins are loaded</td><td></td></tr>
<tr><td>  0.034</td><td>  0.000</td><td>Auth procedure is finished</td><td></td></tr>
<tr><td>  0.034</td><td>  0.000</td><td>ALL core-related plugins are loaded</td><td></td></tr>
<tr><td>  0.034</td><td>  0.000</td><td>exec EXEC_ACTS (core)</td><td></td></tr>
<tr><td>  0.040</td><td>  0.005</td><td>loadPluginLibrary: uprofile [lib] for 0.0003 sec</td><td></td></tr>
<tr><td>  0.040</td><td>  0.000</td><td>loadActionHandlers(core): preloaded file "xfields/xfields.php" for 0.005 sec</td><td></td></tr>
<tr><td>  0.040</td><td>  0.000</td><td>ALL core-related plugins are executed</td><td></td></tr>
<tr><td>  0.041</td><td>  0.001</td><td>* CORE.PHP is complete</td><td></td></tr>
<tr><td>  0.041</td><td>  0.000</td><td>exec EXEC_ACTS (index_pre)</td><td></td></tr>
<tr><td>  0.041</td><td>  0.001</td><td>loadActionHandlers(index_pre): preloaded file "multi_main/multi_main.php" for 0.0004 sec</td><td></td></tr>
<tr><td>  0.041</td><td>  0.000</td><td>Search route for URL "/gallery-fotofootball/edgar-davids-ta-iogo-podruzhka-v-sonyachnomu-mayami-foto972.html"</td><td></td></tr>
<tr><td>  0.045</td><td>  0.004</td><td>loadActionHandlers(news): preloaded file "ads/ads.php" for 0.0005 sec</td><td></td></tr>
<tr><td>  0.047</td><td>  0.002</td><td>loadActionHandlers(news): preloaded file "tags/tags.php" for 0.0019 sec</td><td></td></tr>
<tr><td>  0.051</td><td>  0.004</td><td>loadActionHandlers(news): preloaded file "comments/comments.php" for 0.0033 sec</td><td></td></tr>
<tr><td>  0.051</td><td>  0.001</td><td>loadActionHandlers(news): preloaded file "cat_description/cat_description.php" for 0.0004 sec</td><td></td></tr>
<tr><td>  0.053</td><td>  0.002</td><td>loadActionHandlers(news): preloaded file "similar/similar.php" for 0.0015 sec</td><td></td></tr>
<tr><td>  0.056</td><td>  0.003</td><td>call showNewsPre() for [ 0 ] sec</td><td></td></tr>
<tr><td>  0.056</td><td>  0.000</td><td>call newsFillVariables() for [ 0.0027 ] sec</td><td></td></tr>
<tr><td>  0.057</td><td>  0.000</td><td>exec EXEC_ACTS (news_full)</td><td></td></tr>
<tr><td>  0.057</td><td>  0.000</td><td>func EXEC_ACTS (news_full): call function "plugin_multi_main_full" [3 params] for 0.0001 sec</td><td></td></tr>
<tr><td>  0.057</td><td>  0.000</td><td>exec showNews // xfields</td><td></td></tr>
<tr><td>  0.058</td><td>  0.001</td><td>exec showNews // ads</td><td></td></tr>
<tr><td>  0.058</td><td>  0.000</td><td>exec showNews // tags</td><td></td></tr>
<tr><td>  0.058</td><td>  0.001</td><td>exec showNews // comments</td><td></td></tr>
<tr><td>  0.078</td><td>  0.019</td><td>exec EXEC_ACTS (comments_form)</td><td></td></tr>
<tr><td>  0.079</td><td>  0.002</td><td>exec showNews // cat_description</td><td></td></tr>
<tr><td>  0.079</td><td>  0.000</td><td>exec showNews // similar</td><td></td></tr>
<tr><td> 10.613</td><td> 10.533</td><td>call showNews() for [ 10.5561 ] sec</td><td></td></tr>
<tr><td> 10.616</td><td>  0.003</td><td>exec EXEC_ACTS (index)</td><td></td></tr>
<tr><td> 10.617</td><td>  0.001</td><td>loadActionHandlers(index): preloaded file "elka/elka.php" for 0.00050000000000061 sec</td><td></td></tr>
<tr><td> 10.617</td><td>  0.001</td><td>loadActionHandlers(index): preloaded file "favorites/favorites.php" for 0.00030000000000108 sec</td><td></td></tr>
<tr><td> 10.618</td><td>  0.001</td><td>loadActionHandlers(index): preloaded file "top_news/top_news.php" for 0.00079999999999991 sec</td><td></td></tr>
<tr><td> 10.623</td><td>  0.005</td><td>loadActionHandlers(index): preloaded file "football_stats/football_stats.php" for 0.0047999999999995 sec</td><td></td></tr>
<tr><td> 10.623</td><td>  0.000</td><td>func EXEC_ACTS (index): call function "plugin_ads" [1 params] for 0.00019999999999953 sec</td><td></td></tr>
<tr><td> 10.625</td><td>  0.002</td><td>func EXEC_ACTS (index): call function "plugin_tags_cloudblock" [1 params] for 0.0015000000000001 sec</td><td></td></tr>
<tr><td> 10.625</td><td>  0.000</td><td>func EXEC_ACTS (index): call function "elka" [1 params] for 0.0002999999999993 sec</td><td></td></tr>
<tr><td> 10.626</td><td>  0.000</td><td>func EXEC_ACTS (index): call function "plugin_favorites" [1 params] for 0.00030000000000108 sec</td><td></td></tr>
<tr><td> 10.632</td><td>  0.006</td><td>func EXEC_ACTS (index): call function "top_news" [1 params] for 0.0062999999999995 sec</td><td></td></tr>
<tr><td> 10.659</td><td>  0.027</td><td>func EXEC_ACTS (index): call function "showTablesMain" [1 params] for 0.0268 sec</td><td></td></tr>
<tr><td> 10.659</td><td>  0.000</td><td>Master activity finished</td><td></td></tr>
<tr><td> 10.663</td><td>  0.004</td><td>Category menu created</td><td></td></tr>
<tr><td> 10.664</td><td>  0.001</td><td>exec EXEC_ACTS (usermenu)</td><td></td></tr>
<tr><td> 10.665</td><td>  0.001</td><td>exec EXEC_ACTS (index_post)</td><td></td></tr>
<tr><td> 10.666</td><td>  0.001</td><td>loadActionHandlers(index_post): preloaded file "simple_title_ng/simple_title.php" for 0.00050000000000061 sec</td><td></td></tr>
<tr><td> 10.668</td><td>  0.002</td><td>loadActionHandlers(index_post): preloaded file "ads_sape/ads_sape.php" for 0.0020000000000007 sec</td><td></td></tr>
<tr><td> 10.668</td><td>  0.000</td><td>func EXEC_ACTS (index_post): call function "plugin_multi_main" [1 params] for 0 sec</td><td></td></tr>
<tr><td> 10.668</td><td>  0.000</td><td>func EXEC_ACTS (index_post): call function "simple_tags" [1 params] for 0 sec</td><td></td></tr>
<tr><td> 10.671</td><td>  0.002</td><td>func EXEC_ACTS (index_post): call function "plugin_ads_sape" [1 params] for 0.0022000000000002 sec</td><td></td></tr>
<tr><td> 10.671</td><td>  0.000</td><td>Templates generation time: 0.0263512134552 (65 times called)</td><td></td></tr>
<tr><td> 10.671</td><td>  0.000</td><td>Generate DEBUG output</td><td></td></tr>
</table>
<table class='timeProfiler'>
<tr><td><b>Time</b></td><td><b>Delta</b></td><td><b>Event</b></td><td><b>Desc</b></td></tr>
<tr><td>  0.001</td><td>  0.000</td><td>Config file is loaded</td><td></td></tr>
<tr><td>  0.016</td><td>  0.015</td><td>Core files are included</td><td></td></tr>
<tr><td>  0.025</td><td>  0.008</td><td>Template engine is activated</td><td></td></tr>
<tr><td>  5.833</td><td>  5.808</td><td>DB connection established</td><td></td></tr>
<tr><td>  6.053</td><td>  0.220</td><td>DB category list is loaded</td><td></td></tr>
<tr><td>  6.053</td><td>  0.000</td><td>Ready to load auth plugins</td><td></td></tr>
<tr><td>  6.056</td><td>  0.003</td><td>loadActionHandlers(auth): preloaded file "auth_basic/auth_basic.php" for 0.0019999999999998 sec</td><td></td></tr>
<tr><td>  6.056</td><td>  0.000</td><td>Auth plugins are loaded</td><td></td></tr>
<tr><td>  6.252</td><td>  0.196</td><td>Auth procedure is finished</td><td></td></tr>
<tr><td>  6.252</td><td>  0.000</td><td>ALL core-related plugins are loaded</td><td></td></tr>
<tr><td>  6.252</td><td>  0.000</td><td>exec EXEC_ACTS (core)</td><td></td></tr>
<tr><td>  6.257</td><td>  0.005</td><td>loadPluginLibrary: uprofile [lib] for 0.00019999999999953 sec</td><td></td></tr>
<tr><td>  6.257</td><td>  0.000</td><td>loadActionHandlers(core): preloaded file "xfields/xfields.php" for 0.0046999999999997 sec</td><td></td></tr>
<tr><td>  6.257</td><td>  0.000</td><td>ALL core-related plugins are executed</td><td></td></tr>
<tr><td>  6.258</td><td>  0.001</td><td>* CORE.PHP is complete</td><td></td></tr>
<tr><td>  6.258</td><td>  0.000</td><td>exec EXEC_ACTS (index_pre)</td><td></td></tr>
<tr><td>  6.258</td><td>  0.000</td><td>loadActionHandlers(index_pre): preloaded file "multi_main/multi_main.php" for 0.00039999999999996 sec</td><td></td></tr>
<tr><td>  6.258</td><td>  0.000</td><td>Search route for URL "/spain.html"</td><td></td></tr>
<tr><td>  6.262</td><td>  0.004</td><td>loadActionHandlers(news): preloaded file "ads/ads.php" for 0.00049999999999972 sec</td><td></td></tr>
<tr><td>  6.264</td><td>  0.002</td><td>loadActionHandlers(news): preloaded file "tags/tags.php" for 0.0017999999999994 sec</td><td></td></tr>
<tr><td>  6.267</td><td>  0.003</td><td>loadActionHandlers(news): preloaded file "comments/comments.php" for 0.0030000000000001 sec</td><td></td></tr>
<tr><td>  6.268</td><td>  0.000</td><td>loadActionHandlers(news): preloaded file "cat_description/cat_description.php" for 0.00030000000000019 sec</td><td></td></tr>
<tr><td>  6.269</td><td>  0.002</td><td>loadActionHandlers(news): preloaded file "similar/similar.php" for 0.0014000000000003 sec</td><td></td></tr>
<tr><td> 14.390</td><td>  8.121</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 14.394</td><td>  0.004</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 14.397</td><td>  0.003</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 14.400</td><td>  0.003</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 14.403</td><td>  0.003</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 14.406</td><td>  0.003</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 14.409</td><td>  0.003</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 14.412</td><td>  0.003</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 14.415</td><td>  0.003</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 14.419</td><td>  0.003</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 14.422</td><td>  0.003</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 14.425</td><td>  0.003</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 14.428</td><td>  0.003</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 14.431</td><td>  0.003</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 14.435</td><td>  0.004</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 14.593</td><td>  0.158</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 14.596</td><td>  0.003</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 14.599</td><td>  0.003</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 14.602</td><td>  0.003</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 14.714</td><td>  0.112</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 14.717</td><td>  0.003</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 14.720</td><td>  0.003</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 14.723</td><td>  0.003</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 14.726</td><td>  0.003</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 14.729</td><td>  0.003</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 14.734</td><td>  0.005</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 14.737</td><td>  0.003</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 14.740</td><td>  0.003</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 14.743</td><td>  0.003</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 14.939</td><td>  0.195</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 14.942</td><td>  0.003</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 14.945</td><td>  0.003</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 14.950</td><td>  0.005</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 15.247</td><td>  0.297</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 15.495</td><td>  0.248</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 15.549</td><td>  0.054</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 15.678</td><td>  0.129</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 15.812</td><td>  0.134</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 15.925</td><td>  0.114</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 16.175</td><td>  0.249</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 16.178</td><td>  0.004</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 16.183</td><td>  0.004</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 16.186</td><td>  0.003</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 18.591</td><td>  2.405</td><td>exec EXEC_ACTS (index)</td><td></td></tr>
<tr><td> 18.592</td><td>  0.001</td><td>loadActionHandlers(index): preloaded file "elka/elka.php" for 0.00049999999999883 sec</td><td></td></tr>
<tr><td> 18.592</td><td>  0.001</td><td>loadActionHandlers(index): preloaded file "favorites/favorites.php" for 0.00039999999999907 sec</td><td></td></tr>
<tr><td> 18.593</td><td>  0.001</td><td>loadActionHandlers(index): preloaded file "top_news/top_news.php" for 0.00069999999999837 sec</td><td></td></tr>
<tr><td> 18.598</td><td>  0.005</td><td>loadActionHandlers(index): preloaded file "football_stats/football_stats.php" for 0.0045999999999999 sec</td><td></td></tr>
<tr><td> 18.598</td><td>  0.000</td><td>func EXEC_ACTS (index): call function "plugin_ads" [1 params] for 0.00019999999999953 sec</td><td></td></tr>
<tr><td> 18.600</td><td>  0.002</td><td>func EXEC_ACTS (index): call function "plugin_tags_cloudblock" [1 params] for 0.0015999999999998 sec</td><td></td></tr>
<tr><td> 18.600</td><td>  0.000</td><td>func EXEC_ACTS (index): call function "elka" [1 params] for 0.00040000000000262 sec</td><td></td></tr>
<tr><td> 18.601</td><td>  0.000</td><td>func EXEC_ACTS (index): call function "plugin_favorites" [1 params] for 0.00039999999999907 sec</td><td></td></tr>
<tr><td> 18.607</td><td>  0.006</td><td>func EXEC_ACTS (index): call function "top_news" [1 params] for 0.0061 sec</td><td></td></tr>
<tr><td> 18.633</td><td>  0.026</td><td>func EXEC_ACTS (index): call function "showTablesMain" [1 params] for 0.026199999999999 sec</td><td></td></tr>
<tr><td> 18.633</td><td>  0.000</td><td>Master activity finished</td><td></td></tr>
<tr><td> 18.637</td><td>  0.004</td><td>Category menu created</td><td></td></tr>
<tr><td> 18.638</td><td>  0.001</td><td>exec EXEC_ACTS (usermenu)</td><td></td></tr>
<tr><td> 18.639</td><td>  0.001</td><td>exec EXEC_ACTS (index_post)</td><td></td></tr>
<tr><td> 18.640</td><td>  0.001</td><td>loadActionHandlers(index_post): preloaded file "simple_title_ng/simple_title.php" for 0.00039999999999907 sec</td><td></td></tr>
<tr><td> 18.642</td><td>  0.002</td><td>loadActionHandlers(index_post): preloaded file "ads_sape/ads_sape.php" for 0.0019999999999989 sec</td><td></td></tr>
<tr><td> 18.642</td><td>  0.000</td><td>func EXEC_ACTS (index_post): call function "plugin_multi_main" [1 params] for 9.9999999999767E-5 sec</td><td></td></tr>
<tr><td> 18.642</td><td>  0.000</td><td>func EXEC_ACTS (index_post): call function "simple_tags" [1 params] for 9.9999999999767E-5 sec</td><td></td></tr>
<tr><td> 18.645</td><td>  0.002</td><td>func EXEC_ACTS (index_post): call function "plugin_ads_sape" [1 params] for 0.0023000000000017 sec</td><td></td></tr>
<tr><td> 18.645</td><td>  0.000</td><td>Templates generation time: 0.092736482620239 (81 times called)</td><td></td></tr>
<tr><td> 18.645</td><td>  0.000</td><td>Generate DEBUG output</td><td></td></tr>
</table>
<table class='timeProfiler'>
<tr><td><b>Time</b></td><td><b>Delta</b></td><td><b>Event</b></td><td><b>Desc</b></td></tr>
<tr><td>  1.970</td><td>  0.000</td><td>Config file is loaded</td><td></td></tr>
<tr><td>  1.984</td><td>  0.014</td><td>Core files are included</td><td></td></tr>
<tr><td>  1.992</td><td>  0.008</td><td>Template engine is activated</td><td></td></tr>
<tr><td>  4.211</td><td>  2.218</td><td>DB connection established</td><td></td></tr>
<tr><td>  5.879</td><td>  1.668</td><td>DB category list is loaded</td><td></td></tr>
<tr><td>  5.879</td><td>  0.000</td><td>Ready to load auth plugins</td><td></td></tr>
<tr><td>  5.936</td><td>  0.057</td><td>loadActionHandlers(auth): preloaded file "auth_basic/auth_basic.php" for 0.0521 sec</td><td></td></tr>
<tr><td>  5.936</td><td>  0.000</td><td>Auth plugins are loaded</td><td></td></tr>
<tr><td>  6.688</td><td>  0.752</td><td>Auth procedure is finished</td><td></td></tr>
<tr><td>  6.688</td><td>  0.000</td><td>ALL core-related plugins are loaded</td><td></td></tr>
<tr><td>  6.688</td><td>  0.000</td><td>exec EXEC_ACTS (core)</td><td></td></tr>
<tr><td>  6.878</td><td>  0.190</td><td>loadPluginLibrary: uprofile [lib] for 0.00020000000000042 sec</td><td></td></tr>
<tr><td>  6.878</td><td>  0.000</td><td>loadActionHandlers(core): preloaded file "xfields/xfields.php" for 0.1899 sec</td><td></td></tr>
<tr><td>  6.878</td><td>  0.000</td><td>ALL core-related plugins are executed</td><td></td></tr>
<tr><td>  6.879</td><td>  0.001</td><td>* CORE.PHP is complete</td><td></td></tr>
<tr><td>  6.879</td><td>  0.000</td><td>exec EXEC_ACTS (index_pre)</td><td></td></tr>
<tr><td>  6.879</td><td>  0.000</td><td>loadActionHandlers(index_pre): preloaded file "multi_main/multi_main.php" for 0.00039999999999996 sec</td><td></td></tr>
<tr><td>  6.879</td><td>  0.000</td><td>Search route for URL "/online.html"</td><td></td></tr>
<tr><td>  6.883</td><td>  0.004</td><td>loadActionHandlers(news): preloaded file "ads/ads.php" for 0.00050000000000061 sec</td><td></td></tr>
<tr><td>  6.885</td><td>  0.002</td><td>loadActionHandlers(news): preloaded file "tags/tags.php" for 0.0017000000000005 sec</td><td></td></tr>
<tr><td>  6.888</td><td>  0.003</td><td>loadActionHandlers(news): preloaded file "comments/comments.php" for 0.0030000000000001 sec</td><td></td></tr>
<tr><td>  6.888</td><td>  0.000</td><td>loadActionHandlers(news): preloaded file "cat_description/cat_description.php" for 0.0002999999999993 sec</td><td></td></tr>
<tr><td>  6.890</td><td>  0.002</td><td>loadActionHandlers(news): preloaded file "similar/similar.php" for 0.0012999999999996 sec</td><td></td></tr>
<tr><td> 15.737</td><td>  8.847</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 19.276</td><td>  3.539</td><td>exec EXEC_ACTS (index)</td><td></td></tr>
<tr><td> 19.277</td><td>  0.001</td><td>loadActionHandlers(index): preloaded file "elka/elka.php" for 0.00060000000000215 sec</td><td></td></tr>
<tr><td> 19.277</td><td>  0.000</td><td>loadActionHandlers(index): preloaded file "favorites/favorites.php" for 0.0002999999999993 sec</td><td></td></tr>
<tr><td> 19.278</td><td>  0.001</td><td>loadActionHandlers(index): preloaded file "top_news/top_news.php" for 0.00080000000000169 sec</td><td></td></tr>
<tr><td> 19.283</td><td>  0.005</td><td>loadActionHandlers(index): preloaded file "football_stats/football_stats.php" for 0.0048999999999992 sec</td><td></td></tr>
<tr><td> 19.284</td><td>  0.000</td><td>func EXEC_ACTS (index): call function "plugin_ads" [1 params] for 0.00019999999999953 sec</td><td></td></tr>
<tr><td> 19.285</td><td>  0.002</td><td>func EXEC_ACTS (index): call function "plugin_tags_cloudblock" [1 params] for 0.0015000000000001 sec</td><td></td></tr>
<tr><td> 19.286</td><td>  0.000</td><td>func EXEC_ACTS (index): call function "elka" [1 params] for 0.00039999999999907 sec</td><td></td></tr>
<tr><td> 19.286</td><td>  0.000</td><td>func EXEC_ACTS (index): call function "plugin_favorites" [1 params] for 0.00030000000000285 sec</td><td></td></tr>
<tr><td> 21.343</td><td>  2.057</td><td>func EXEC_ACTS (index): call function "top_news" [1 params] for 2.0568 sec</td><td></td></tr>
<tr><td> 21.369</td><td>  0.026</td><td>func EXEC_ACTS (index): call function "showTablesMain" [1 params] for 0.026299999999999 sec</td><td></td></tr>
<tr><td> 21.369</td><td>  0.000</td><td>Master activity finished</td><td></td></tr>
<tr><td> 21.373</td><td>  0.004</td><td>Category menu created</td><td></td></tr>
<tr><td> 21.374</td><td>  0.001</td><td>exec EXEC_ACTS (usermenu)</td><td></td></tr>
<tr><td> 21.375</td><td>  0.001</td><td>exec EXEC_ACTS (index_post)</td><td></td></tr>
<tr><td> 21.376</td><td>  0.001</td><td>loadActionHandlers(index_post): preloaded file "simple_title_ng/simple_title.php" for 0.00040000000000262 sec</td><td></td></tr>
<tr><td> 21.378</td><td>  0.002</td><td>loadActionHandlers(index_post): preloaded file "ads_sape/ads_sape.php" for 0.0019999999999989 sec</td><td></td></tr>
<tr><td> 21.378</td><td>  0.000</td><td>func EXEC_ACTS (index_post): call function "plugin_multi_main" [1 params] for 9.9999999999767E-5 sec</td><td></td></tr>
<tr><td> 21.378</td><td>  0.000</td><td>func EXEC_ACTS (index_post): call function "simple_tags" [1 params] for 9.9999999999767E-5 sec</td><td></td></tr>
<tr><td> 21.381</td><td>  0.002</td><td>func EXEC_ACTS (index_post): call function "plugin_ads_sape" [1 params] for 0.002200000000002 sec</td><td></td></tr>
<tr><td> 21.381</td><td>  0.000</td><td>Templates generation time: 0.0068879127502441 (41 times called)</td><td></td></tr>
<tr><td> 21.381</td><td>  0.000</td><td>Generate DEBUG output</td><td></td></tr>
</table>
<table class='timeProfiler'>
<tr><td><b>Time</b></td><td><b>Delta</b></td><td><b>Event</b></td><td><b>Desc</b></td></tr>
<tr><td> 19.032</td><td>  0.000</td><td>Config file is loaded</td><td></td></tr>
<tr><td> 19.069</td><td>  0.037</td><td>Core files are included</td><td></td></tr>
<tr><td> 19.078</td><td>  0.009</td><td>Template engine is activated</td><td></td></tr>
<tr><td> 19.095</td><td>  0.017</td><td>DB connection established</td><td></td></tr>
<tr><td> 19.097</td><td>  0.002</td><td>DB category list is loaded</td><td></td></tr>
<tr><td> 19.097</td><td>  0.000</td><td>Ready to load auth plugins</td><td></td></tr>
<tr><td> 19.100</td><td>  0.003</td><td>loadActionHandlers(auth): preloaded file "auth_basic/auth_basic.php" for 0.0021000000000022 sec</td><td></td></tr>
<tr><td> 19.100</td><td>  0.000</td><td>Auth plugins are loaded</td><td></td></tr>
<tr><td> 19.137</td><td>  0.036</td><td>Auth procedure is finished</td><td></td></tr>
<tr><td> 19.137</td><td>  0.000</td><td>ALL core-related plugins are loaded</td><td></td></tr>
<tr><td> 19.137</td><td>  0.000</td><td>exec EXEC_ACTS (core)</td><td></td></tr>
<tr><td> 19.141</td><td>  0.005</td><td>loadPluginLibrary: uprofile [lib] for 0.0002999999999993 sec</td><td></td></tr>
<tr><td> 19.142</td><td>  0.000</td><td>loadActionHandlers(core): preloaded file "xfields/xfields.php" for 0.0046999999999997 sec</td><td></td></tr>
<tr><td> 19.142</td><td>  0.000</td><td>ALL core-related plugins are executed</td><td></td></tr>
<tr><td> 19.142</td><td>  0.001</td><td>* CORE.PHP is complete</td><td></td></tr>
<tr><td> 19.142</td><td>  0.000</td><td>exec EXEC_ACTS (index_pre)</td><td></td></tr>
<tr><td> 19.143</td><td>  0.001</td><td>loadActionHandlers(index_pre): preloaded file "multi_main/multi_main.php" for 0.0002999999999993 sec</td><td></td></tr>
<tr><td> 19.143</td><td>  0.000</td><td>Search route for URL "/engine/plugins/football_stats/channel_logo/{channel}"</td><td></td></tr>
<tr><td> 19.144</td><td>  0.001</td><td>exec EXEC_ACTS (index)</td><td></td></tr>
<tr><td> 19.145</td><td>  0.001</td><td>loadActionHandlers(index): preloaded file "ads/ads.php" for 0.00039999999999907 sec</td><td></td></tr>
<tr><td> 19.146</td><td>  0.002</td><td>loadActionHandlers(index): preloaded file "tags/tags.php" for 0.0017999999999994 sec</td><td></td></tr>
<tr><td> 19.147</td><td>  0.001</td><td>loadActionHandlers(index): preloaded file "elka/elka.php" for 0.00050000000000239 sec</td><td></td></tr>
<tr><td> 19.148</td><td>  0.000</td><td>loadActionHandlers(index): preloaded file "favorites/favorites.php" for 0.0002999999999993 sec</td><td></td></tr>
<tr><td> 19.149</td><td>  0.001</td><td>loadActionHandlers(index): preloaded file "top_news/top_news.php" for 0.00080000000000169 sec</td><td></td></tr>
<tr><td> 19.150</td><td>  0.002</td><td>loadActionHandlers(index): preloaded file "similar/similar.php" for 0.0014000000000003 sec</td><td></td></tr>
<tr><td> 19.157</td><td>  0.007</td><td>loadActionHandlers(index): preloaded file "football_stats/football_stats.php" for 0.0064999999999991 sec</td><td></td></tr>
<tr><td> 19.157</td><td>  0.000</td><td>func EXEC_ACTS (index): call function "plugin_ads" [1 params] for 0.0002999999999993 sec</td><td></td></tr>
<tr><td> 19.161</td><td>  0.004</td><td>func EXEC_ACTS (index): call function "plugin_tags_cloudblock" [1 params] for 0.003700000000002 sec</td><td></td></tr>
<tr><td> 19.162</td><td>  0.000</td><td>func EXEC_ACTS (index): call function "elka" [1 params] for 0.0002999999999993 sec</td><td></td></tr>
<tr><td> 19.162</td><td>  0.000</td><td>func EXEC_ACTS (index): call function "plugin_favorites" [1 params] for 0.0002999999999993 sec</td><td></td></tr>
<tr><td> 19.169</td><td>  0.007</td><td>func EXEC_ACTS (index): call function "top_news" [1 params] for 0.0073000000000008 sec</td><td></td></tr>
<tr><td> 19.209</td><td>  0.040</td><td>func EXEC_ACTS (index): call function "showTablesMain" [1 params] for 0.040199999999999 sec</td><td></td></tr>
<tr><td> 19.209</td><td>  0.000</td><td>Master activity finished</td><td></td></tr>
<tr><td> 19.214</td><td>  0.004</td><td>Category menu created</td><td></td></tr>
<tr><td> 19.215</td><td>  0.001</td><td>exec EXEC_ACTS (usermenu)</td><td></td></tr>
<tr><td> 19.216</td><td>  0.001</td><td>exec EXEC_ACTS (index_post)</td><td></td></tr>
<tr><td> 19.217</td><td>  0.001</td><td>loadActionHandlers(index_post): preloaded file "simple_title_ng/simple_title.php" for 0.00039999999999907 sec</td><td></td></tr>
<tr><td> 19.219</td><td>  0.003</td><td>loadActionHandlers(index_post): preloaded file "ads_sape/ads_sape.php" for 0.002200000000002 sec</td><td></td></tr>
<tr><td> 19.219</td><td>  0.000</td><td>func EXEC_ACTS (index_post): call function "plugin_multi_main" [1 params] for 0 sec</td><td></td></tr>
<tr><td> 19.219</td><td>  0.000</td><td>func EXEC_ACTS (index_post): call function "simple_tags" [1 params] for 0 sec</td><td></td></tr>
<tr><td> 19.221</td><td>  0.002</td><td>func EXEC_ACTS (index_post): call function "plugin_ads_sape" [1 params] for 0.0021999999999984 sec</td><td></td></tr>
<tr><td> 19.222</td><td>  0.000</td><td>Templates generation time: 0.0040285587310791 (39 times called)</td><td></td></tr>
<tr><td> 19.222</td><td>  0.000</td><td>Generate DEBUG output</td><td></td></tr>
</table>
<table class='timeProfiler'>
<tr><td><b>Time</b></td><td><b>Delta</b></td><td><b>Event</b></td><td><b>Desc</b></td></tr>
<tr><td> 11.047</td><td>  0.000</td><td>Config file is loaded</td><td></td></tr>
<tr><td> 11.077</td><td>  0.030</td><td>Core files are included</td><td></td></tr>
<tr><td> 11.105</td><td>  0.028</td><td>Template engine is activated</td><td></td></tr>
<tr><td> 11.198</td><td>  0.093</td><td>DB connection established</td><td></td></tr>
<tr><td> 11.213</td><td>  0.015</td><td>DB category list is loaded</td><td></td></tr>
<tr><td> 11.213</td><td>  0.000</td><td>Ready to load auth plugins</td><td></td></tr>
<tr><td> 11.221</td><td>  0.008</td><td>loadActionHandlers(auth): preloaded file "auth_basic/auth_basic.php" for 0.0074000000000005 sec</td><td></td></tr>
<tr><td> 11.221</td><td>  0.000</td><td>Auth plugins are loaded</td><td></td></tr>
<tr><td> 11.224</td><td>  0.003</td><td>Auth procedure is finished</td><td></td></tr>
<tr><td> 11.224</td><td>  0.000</td><td>ALL core-related plugins are loaded</td><td></td></tr>
<tr><td> 11.224</td><td>  0.000</td><td>exec EXEC_ACTS (core)</td><td></td></tr>
<tr><td> 11.232</td><td>  0.008</td><td>loadPluginLibrary: uprofile [lib] for 0.0002999999999993 sec</td><td></td></tr>
<tr><td> 11.233</td><td>  0.000</td><td>loadActionHandlers(core): preloaded file "xfields/xfields.php" for 0.0052000000000003 sec</td><td></td></tr>
<tr><td> 11.233</td><td>  0.000</td><td>ALL core-related plugins are executed</td><td></td></tr>
<tr><td> 11.233</td><td>  0.001</td><td>* CORE.PHP is complete</td><td></td></tr>
<tr><td> 11.233</td><td>  0.000</td><td>exec EXEC_ACTS (index_pre)</td><td></td></tr>
<tr><td> 11.234</td><td>  0.001</td><td>loadActionHandlers(index_pre): preloaded file "multi_main/multi_main.php" for 0.00039999999999907 sec</td><td></td></tr>
<tr><td> 11.234</td><td>  0.000</td><td>Search route for URL "/online.html"</td><td></td></tr>
<tr><td> 11.238</td><td>  0.004</td><td>loadActionHandlers(news): preloaded file "ads/ads.php" for 0.00039999999999907 sec</td><td></td></tr>
<tr><td> 11.240</td><td>  0.002</td><td>loadActionHandlers(news): preloaded file "tags/tags.php" for 0.0018000000000011 sec</td><td></td></tr>
<tr><td> 11.246</td><td>  0.006</td><td>loadActionHandlers(news): preloaded file "comments/comments.php" for 0.0055999999999994 sec</td><td></td></tr>
<tr><td> 11.246</td><td>  0.001</td><td>loadActionHandlers(news): preloaded file "cat_description/cat_description.php" for 0.0002999999999993 sec</td><td></td></tr>
<tr><td> 11.248</td><td>  0.002</td><td>loadActionHandlers(news): preloaded file "similar/similar.php" for 0.0020000000000007 sec</td><td></td></tr>
<tr><td> 13.218</td><td>  1.969</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 16.355</td><td>  3.138</td><td>exec EXEC_ACTS (index)</td><td></td></tr>
<tr><td> 16.356</td><td>  0.001</td><td>loadActionHandlers(index): preloaded file "elka/elka.php" for 0.0005999999999986 sec</td><td></td></tr>
<tr><td> 16.356</td><td>  0.001</td><td>loadActionHandlers(index): preloaded file "favorites/favorites.php" for 0.0002999999999993 sec</td><td></td></tr>
<tr><td> 16.357</td><td>  0.001</td><td>loadActionHandlers(index): preloaded file "top_news/top_news.php" for 0.00079999999999814 sec</td><td></td></tr>
<tr><td> 16.363</td><td>  0.006</td><td>loadActionHandlers(index): preloaded file "football_stats/football_stats.php" for 0.0052999999999983 sec</td><td></td></tr>
<tr><td> 16.363</td><td>  0.000</td><td>func EXEC_ACTS (index): call function "plugin_ads" [1 params] for 0.00019999999999953 sec</td><td></td></tr>
<tr><td> 16.365</td><td>  0.002</td><td>func EXEC_ACTS (index): call function "plugin_tags_cloudblock" [1 params] for 0.0015000000000001 sec</td><td></td></tr>
<tr><td> 16.365</td><td>  0.001</td><td>func EXEC_ACTS (index): call function "elka" [1 params] for 0.00040000000000262 sec</td><td></td></tr>
<tr><td> 16.366</td><td>  0.001</td><td>func EXEC_ACTS (index): call function "plugin_favorites" [1 params] for 0.0005999999999986 sec</td><td></td></tr>
<tr><td> 17.721</td><td>  1.355</td><td>func EXEC_ACTS (index): call function "top_news" [1 params] for 1.3549 sec</td><td></td></tr>
<tr><td> 17.747</td><td>  0.026</td><td>func EXEC_ACTS (index): call function "showTablesMain" [1 params] for 0.026399999999999 sec</td><td></td></tr>
<tr><td> 17.747</td><td>  0.000</td><td>Master activity finished</td><td></td></tr>
<tr><td> 17.751</td><td>  0.004</td><td>Category menu created</td><td></td></tr>
<tr><td> 17.753</td><td>  0.001</td><td>exec EXEC_ACTS (usermenu)</td><td></td></tr>
<tr><td> 17.754</td><td>  0.001</td><td>exec EXEC_ACTS (index_post)</td><td></td></tr>
<tr><td> 17.754</td><td>  0.001</td><td>loadActionHandlers(index_post): preloaded file "simple_title_ng/simple_title.php" for 0.00039999999999907 sec</td><td></td></tr>
<tr><td> 17.757</td><td>  0.002</td><td>loadActionHandlers(index_post): preloaded file "ads_sape/ads_sape.php" for 0.0019999999999989 sec</td><td></td></tr>
<tr><td> 17.757</td><td>  0.000</td><td>func EXEC_ACTS (index_post): call function "plugin_multi_main" [1 params] for 0 sec</td><td></td></tr>
<tr><td> 17.757</td><td>  0.000</td><td>func EXEC_ACTS (index_post): call function "simple_tags" [1 params] for 9.9999999999767E-5 sec</td><td></td></tr>
<tr><td> 17.759</td><td>  0.002</td><td>func EXEC_ACTS (index_post): call function "plugin_ads_sape" [1 params] for 0.002200000000002 sec</td><td></td></tr>
<tr><td> 17.759</td><td>  0.000</td><td>Templates generation time: 0.0068566799163818 (41 times called)</td><td></td></tr>
<tr><td> 17.759</td><td>  0.000</td><td>Generate DEBUG output</td><td></td></tr>
</table>
<table class='timeProfiler'>
<tr><td><b>Time</b></td><td><b>Delta</b></td><td><b>Event</b></td><td><b>Desc</b></td></tr>
<tr><td> 17.988</td><td>  0.000</td><td>Config file is loaded</td><td></td></tr>
<tr><td> 18.005</td><td>  0.017</td><td>Core files are included</td><td></td></tr>
<tr><td> 18.014</td><td>  0.009</td><td>Template engine is activated</td><td></td></tr>
<tr><td> 18.111</td><td>  0.097</td><td>DB connection established</td><td></td></tr>
<tr><td> 18.114</td><td>  0.003</td><td>DB category list is loaded</td><td></td></tr>
<tr><td> 18.114</td><td>  0.000</td><td>Ready to load auth plugins</td><td></td></tr>
<tr><td> 18.118</td><td>  0.005</td><td>loadActionHandlers(auth): preloaded file "auth_basic/auth_basic.php" for 0.0038000000000018 sec</td><td></td></tr>
<tr><td> 18.118</td><td>  0.000</td><td>Auth plugins are loaded</td><td></td></tr>
<tr><td> 18.119</td><td>  0.001</td><td>Auth procedure is finished</td><td></td></tr>
<tr><td> 18.119</td><td>  0.000</td><td>ALL core-related plugins are loaded</td><td></td></tr>
<tr><td> 18.119</td><td>  0.000</td><td>exec EXEC_ACTS (core)</td><td></td></tr>
<tr><td> 18.129</td><td>  0.010</td><td>loadPluginLibrary: uprofile [lib] for 0.00030000000000285 sec</td><td></td></tr>
<tr><td> 18.129</td><td>  0.000</td><td>loadActionHandlers(core): preloaded file "xfields/xfields.php" for 0.009800000000002 sec</td><td></td></tr>
<tr><td> 18.129</td><td>  0.000</td><td>ALL core-related plugins are executed</td><td></td></tr>
<tr><td> 18.130</td><td>  0.001</td><td>* CORE.PHP is complete</td><td></td></tr>
<tr><td> 18.130</td><td>  0.000</td><td>exec EXEC_ACTS (index_pre)</td><td></td></tr>
<tr><td> 18.131</td><td>  0.001</td><td>loadActionHandlers(index_pre): preloaded file "multi_main/multi_main.php" for 0.00030000000000285 sec</td><td></td></tr>
<tr><td> 18.131</td><td>  0.000</td><td>Search route for URL "/engine/plugins/football_stats/channel_logo/{channel}"</td><td></td></tr>
<tr><td> 18.131</td><td>  0.001</td><td>exec EXEC_ACTS (index)</td><td></td></tr>
<tr><td> 18.132</td><td>  0.001</td><td>loadActionHandlers(index): preloaded file "ads/ads.php" for 0.00050000000000239 sec</td><td></td></tr>
<tr><td> 18.135</td><td>  0.003</td><td>loadActionHandlers(index): preloaded file "tags/tags.php" for 0.0028000000000006 sec</td><td></td></tr>
<tr><td> 18.136</td><td>  0.001</td><td>loadActionHandlers(index): preloaded file "elka/elka.php" for 0.00049999999999883 sec</td><td></td></tr>
<tr><td> 18.136</td><td>  0.001</td><td>loadActionHandlers(index): preloaded file "favorites/favorites.php" for 0.00039999999999907 sec</td><td></td></tr>
<tr><td> 18.137</td><td>  0.001</td><td>loadActionHandlers(index): preloaded file "top_news/top_news.php" for 0.00079999999999814 sec</td><td></td></tr>
<tr><td> 18.139</td><td>  0.002</td><td>loadActionHandlers(index): preloaded file "similar/similar.php" for 0.0013000000000005 sec</td><td></td></tr>
<tr><td> 18.144</td><td>  0.005</td><td>loadActionHandlers(index): preloaded file "football_stats/football_stats.php" for 0.004999999999999 sec</td><td></td></tr>
<tr><td> 18.144</td><td>  0.000</td><td>func EXEC_ACTS (index): call function "plugin_ads" [1 params] for 0.00030000000000285 sec</td><td></td></tr>
<tr><td> 18.146</td><td>  0.002</td><td>func EXEC_ACTS (index): call function "plugin_tags_cloudblock" [1 params] for 0.0015000000000001 sec</td><td></td></tr>
<tr><td> 18.146</td><td>  0.000</td><td>func EXEC_ACTS (index): call function "elka" [1 params] for 0.0002999999999993 sec</td><td></td></tr>
<tr><td> 18.147</td><td>  0.000</td><td>func EXEC_ACTS (index): call function "plugin_favorites" [1 params] for 0.0002999999999993 sec</td><td></td></tr>
<tr><td> 18.152</td><td>  0.005</td><td>func EXEC_ACTS (index): call function "top_news" [1 params] for 0.0053000000000019 sec</td><td></td></tr>
<tr><td> 18.178</td><td>  0.026</td><td>func EXEC_ACTS (index): call function "showTablesMain" [1 params] for 0.0259 sec</td><td></td></tr>
<tr><td> 18.178</td><td>  0.000</td><td>Master activity finished</td><td></td></tr>
<tr><td> 18.182</td><td>  0.004</td><td>Category menu created</td><td></td></tr>
<tr><td> 18.183</td><td>  0.001</td><td>exec EXEC_ACTS (usermenu)</td><td></td></tr>
<tr><td> 18.185</td><td>  0.001</td><td>exec EXEC_ACTS (index_post)</td><td></td></tr>
<tr><td> 18.185</td><td>  0.001</td><td>loadActionHandlers(index_post): preloaded file "simple_title_ng/simple_title.php" for 0.00039999999999907 sec</td><td></td></tr>
<tr><td> 18.187</td><td>  0.002</td><td>loadActionHandlers(index_post): preloaded file "ads_sape/ads_sape.php" for 0.0019999999999989 sec</td><td></td></tr>
<tr><td> 18.188</td><td>  0.000</td><td>func EXEC_ACTS (index_post): call function "plugin_multi_main" [1 params] for 0 sec</td><td></td></tr>
<tr><td> 18.188</td><td>  0.000</td><td>func EXEC_ACTS (index_post): call function "simple_tags" [1 params] for 9.9999999999767E-5 sec</td><td></td></tr>
<tr><td> 18.190</td><td>  0.002</td><td>func EXEC_ACTS (index_post): call function "plugin_ads_sape" [1 params] for 0.002200000000002 sec</td><td></td></tr>
<tr><td> 18.190</td><td>  0.000</td><td>Templates generation time: 0.0040600299835205 (39 times called)</td><td></td></tr>
<tr><td> 18.190</td><td>  0.000</td><td>Generate DEBUG output</td><td></td></tr>
</table>
<table class='timeProfiler'>
<tr><td><b>Time</b></td><td><b>Delta</b></td><td><b>Event</b></td><td><b>Desc</b></td></tr>
<tr><td>  0.001</td><td>  0.000</td><td>Config file is loaded</td><td></td></tr>
<tr><td>  0.015</td><td>  0.014</td><td>Core files are included</td><td></td></tr>
<tr><td>  0.024</td><td>  0.009</td><td>Template engine is activated</td><td></td></tr>
<tr><td>  0.030</td><td>  0.006</td><td>DB connection established</td><td></td></tr>
<tr><td>  0.031</td><td>  0.002</td><td>DB category list is loaded</td><td></td></tr>
<tr><td>  0.031</td><td>  0.000</td><td>Ready to load auth plugins</td><td></td></tr>
<tr><td>  0.034</td><td>  0.003</td><td>loadActionHandlers(auth): preloaded file "auth_basic/auth_basic.php" for 0.002 sec</td><td></td></tr>
<tr><td>  0.034</td><td>  0.000</td><td>Auth plugins are loaded</td><td></td></tr>
<tr><td>  0.034</td><td>  0.000</td><td>Auth procedure is finished</td><td></td></tr>
<tr><td>  0.034</td><td>  0.000</td><td>ALL core-related plugins are loaded</td><td></td></tr>
<tr><td>  0.034</td><td>  0.000</td><td>exec EXEC_ACTS (core)</td><td></td></tr>
<tr><td>  0.039</td><td>  0.005</td><td>loadPluginLibrary: uprofile [lib] for 0.00029999999999999 sec</td><td></td></tr>
<tr><td>  0.039</td><td>  0.000</td><td>loadActionHandlers(core): preloaded file "xfields/xfields.php" for 0.0046 sec</td><td></td></tr>
<tr><td>  0.039</td><td>  0.000</td><td>ALL core-related plugins are executed</td><td></td></tr>
<tr><td>  0.040</td><td>  0.001</td><td>* CORE.PHP is complete</td><td></td></tr>
<tr><td>  0.040</td><td>  0.000</td><td>exec EXEC_ACTS (index_pre)</td><td></td></tr>
<tr><td>  0.040</td><td>  0.001</td><td>loadActionHandlers(index_pre): preloaded file "multi_main/multi_main.php" for 0.0003 sec</td><td></td></tr>
<tr><td>  0.040</td><td>  0.000</td><td>Search route for URL "/box-novyny/klichki-svyatkuvatimut-novii-rik-na-beregah-atlantiki166.html"</td><td></td></tr>
<tr><td>  0.044</td><td>  0.004</td><td>loadActionHandlers(news): preloaded file "ads/ads.php" for 0.0005 sec</td><td></td></tr>
<tr><td>  0.046</td><td>  0.002</td><td>loadActionHandlers(news): preloaded file "tags/tags.php" for 0.0018 sec</td><td></td></tr>
<tr><td>  0.049</td><td>  0.003</td><td>loadActionHandlers(news): preloaded file "comments/comments.php" for 0.003 sec</td><td></td></tr>
<tr><td>  0.050</td><td>  0.001</td><td>loadActionHandlers(news): preloaded file "cat_description/cat_description.php" for 0.0004 sec</td><td></td></tr>
<tr><td>  0.051</td><td>  0.002</td><td>loadActionHandlers(news): preloaded file "similar/similar.php" for 0.0014 sec</td><td></td></tr>
<tr><td>  0.054</td><td>  0.003</td><td>call showNewsPre() for [ 0 ] sec</td><td></td></tr>
<tr><td>  0.054</td><td>  0.000</td><td>call newsFillVariables() for [ 0.002 ] sec</td><td></td></tr>
<tr><td>  0.055</td><td>  0.000</td><td>exec EXEC_ACTS (news_full)</td><td></td></tr>
<tr><td>  0.055</td><td>  0.000</td><td>func EXEC_ACTS (news_full): call function "plugin_multi_main_full" [3 params] for 0 sec</td><td></td></tr>
<tr><td>  0.055</td><td>  0.000</td><td>exec showNews // xfields</td><td></td></tr>
<tr><td>  0.055</td><td>  0.001</td><td>exec showNews // ads</td><td></td></tr>
<tr><td>  0.056</td><td>  0.000</td><td>exec showNews // tags</td><td></td></tr>
<tr><td>  0.056</td><td>  0.001</td><td>exec showNews // comments</td><td></td></tr>
<tr><td>  0.074</td><td>  0.018</td><td>exec EXEC_ACTS (comments_form)</td><td></td></tr>
<tr><td>  0.075</td><td>  0.002</td><td>exec showNews // cat_description</td><td></td></tr>
<tr><td>  0.075</td><td>  0.000</td><td>exec showNews // similar</td><td></td></tr>
<tr><td> 11.394</td><td> 11.318</td><td>call showNews() for [ 11.3389 ] sec</td><td></td></tr>
<tr><td> 11.396</td><td>  0.003</td><td>exec EXEC_ACTS (index)</td><td></td></tr>
<tr><td> 11.397</td><td>  0.001</td><td>loadActionHandlers(index): preloaded file "elka/elka.php" for 0.00050000000000061 sec</td><td></td></tr>
<tr><td> 11.398</td><td>  0.001</td><td>loadActionHandlers(index): preloaded file "favorites/favorites.php" for 0.00040000000000084 sec</td><td></td></tr>
<tr><td> 11.399</td><td>  0.001</td><td>loadActionHandlers(index): preloaded file "top_news/top_news.php" for 0.00070000000000014 sec</td><td></td></tr>
<tr><td> 11.404</td><td>  0.005</td><td>loadActionHandlers(index): preloaded file "football_stats/football_stats.php" for 0.004900000000001 sec</td><td></td></tr>
<tr><td> 11.406</td><td>  0.003</td><td>loadActionHandlers(index): preloaded file "boxers/boxers.php" for 0.0025999999999993 sec</td><td></td></tr>
<tr><td> 11.407</td><td>  0.000</td><td>func EXEC_ACTS (index): call function "plugin_ads" [1 params] for 0.00030000000000108 sec</td><td></td></tr>
<tr><td> 11.408</td><td>  0.002</td><td>func EXEC_ACTS (index): call function "plugin_tags_cloudblock" [1 params] for 0.0016999999999996 sec</td><td></td></tr>
<tr><td> 11.409</td><td>  0.000</td><td>func EXEC_ACTS (index): call function "elka" [1 params] for 0.00039999999999907 sec</td><td></td></tr>
<tr><td> 11.409</td><td>  0.000</td><td>func EXEC_ACTS (index): call function "plugin_favorites" [1 params] for 0.00040000000000084 sec</td><td></td></tr>
<tr><td> 11.415</td><td>  0.006</td><td>func EXEC_ACTS (index): call function "top_news" [1 params] for 0.0062999999999995 sec</td><td></td></tr>
<tr><td> 11.442</td><td>  0.027</td><td>func EXEC_ACTS (index): call function "showTablesMain" [1 params] for 0.026899999999999 sec</td><td></td></tr>
<tr><td> 11.444</td><td>  0.001</td><td>func EXEC_ACTS (index): call function "showRatings" [1 params] for 0.0012000000000008 sec</td><td></td></tr>
<tr><td> 11.444</td><td>  0.000</td><td>Master activity finished</td><td></td></tr>
<tr><td> 11.450</td><td>  0.007</td><td>Category menu created</td><td></td></tr>
<tr><td> 11.451</td><td>  0.001</td><td>exec EXEC_ACTS (usermenu)</td><td></td></tr>
<tr><td> 11.453</td><td>  0.001</td><td>exec EXEC_ACTS (index_post)</td><td></td></tr>
<tr><td> 11.453</td><td>  0.001</td><td>loadActionHandlers(index_post): preloaded file "simple_title_ng/simple_title.php" for 0.00050000000000061 sec</td><td></td></tr>
<tr><td> 11.456</td><td>  0.002</td><td>loadActionHandlers(index_post): preloaded file "ads_sape/ads_sape.php" for 0.0021000000000004 sec</td><td></td></tr>
<tr><td> 11.456</td><td>  0.000</td><td>func EXEC_ACTS (index_post): call function "plugin_multi_main" [1 params] for 0 sec</td><td></td></tr>
<tr><td> 11.456</td><td>  0.000</td><td>func EXEC_ACTS (index_post): call function "simple_tags" [1 params] for 0 sec</td><td></td></tr>
<tr><td> 11.458</td><td>  0.002</td><td>func EXEC_ACTS (index_post): call function "plugin_ads_sape" [1 params] for 0.0021000000000004 sec</td><td></td></tr>
<tr><td> 11.458</td><td>  0.000</td><td>Templates generation time: 0.025873899459839 (66 times called)</td><td></td></tr>
<tr><td> 11.458</td><td>  0.000</td><td>Generate DEBUG output</td><td></td></tr>
</table>
<table class='timeProfiler'>
<tr><td><b>Time</b></td><td><b>Delta</b></td><td><b>Event</b></td><td><b>Desc</b></td></tr>
<tr><td>  0.001</td><td>  0.000</td><td>Config file is loaded</td><td></td></tr>
<tr><td>  0.132</td><td>  0.130</td><td>Core files are included</td><td></td></tr>
<tr><td>  0.177</td><td>  0.046</td><td>Template engine is activated</td><td></td></tr>
<tr><td>  0.184</td><td>  0.006</td><td>DB connection established</td><td></td></tr>
<tr><td>  0.185</td><td>  0.002</td><td>DB category list is loaded</td><td></td></tr>
<tr><td>  0.185</td><td>  0.000</td><td>Ready to load auth plugins</td><td></td></tr>
<tr><td>  0.188</td><td>  0.003</td><td>loadActionHandlers(auth): preloaded file "auth_basic/auth_basic.php" for 0.0023 sec</td><td></td></tr>
<tr><td>  0.189</td><td>  0.000</td><td>Auth plugins are loaded</td><td></td></tr>
<tr><td>  0.191</td><td>  0.003</td><td>Auth procedure is finished</td><td></td></tr>
<tr><td>  0.191</td><td>  0.000</td><td>ALL core-related plugins are loaded</td><td></td></tr>
<tr><td>  0.191</td><td>  0.000</td><td>exec EXEC_ACTS (core)</td><td></td></tr>
<tr><td>  0.197</td><td>  0.006</td><td>loadPluginLibrary: uprofile [lib] for 0.00020000000000001 sec</td><td></td></tr>
<tr><td>  0.197</td><td>  0.000</td><td>loadActionHandlers(core): preloaded file "xfields/xfields.php" for 0.0053 sec</td><td></td></tr>
<tr><td>  0.197</td><td>  0.000</td><td>ALL core-related plugins are executed</td><td></td></tr>
<tr><td>  0.198</td><td>  0.001</td><td>* CORE.PHP is complete</td><td></td></tr>
<tr><td>  0.198</td><td>  0.000</td><td>exec EXEC_ACTS (index_pre)</td><td></td></tr>
<tr><td>  0.198</td><td>  0.001</td><td>loadActionHandlers(index_pre): preloaded file "multi_main/multi_main.php" for 0.00040000000000001 sec</td><td></td></tr>
<tr><td>  0.198</td><td>  0.000</td><td>Search route for URL "/search/"</td><td></td></tr>
<tr><td>  0.558</td><td>  0.360</td><td>loadActionHandlers(news): preloaded file "ads/ads.php" for 0.00049999999999994 sec</td><td></td></tr>
<tr><td>  0.560</td><td>  0.002</td><td>loadActionHandlers(news): preloaded file "tags/tags.php" for 0.0018 sec</td><td></td></tr>
<tr><td>  0.563</td><td>  0.003</td><td>loadActionHandlers(news): preloaded file "comments/comments.php" for 0.003 sec</td><td></td></tr>
<tr><td>  0.563</td><td>  0.001</td><td>loadActionHandlers(news): preloaded file "cat_description/cat_description.php" for 0.00040000000000007 sec</td><td></td></tr>
<tr><td>  0.565</td><td>  0.002</td><td>loadActionHandlers(news): preloaded file "similar/similar.php" for 0.0016 sec</td><td></td></tr>
<tr><td> 16.108</td><td> 15.543</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 16.113</td><td>  0.005</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 16.205</td><td>  0.092</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 16.210</td><td>  0.005</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 16.214</td><td>  0.004</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 16.216</td><td>  0.003</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 16.223</td><td>  0.006</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 16.226</td><td>  0.003</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 16.231</td><td>  0.005</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 16.234</td><td>  0.002</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 16.236</td><td>  0.002</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 16.238</td><td>  0.002</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 16.241</td><td>  0.003</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 16.243</td><td>  0.002</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 16.246</td><td>  0.003</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 16.248</td><td>  0.002</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 16.279</td><td>  0.031</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 16.287</td><td>  0.008</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 16.292</td><td>  0.005</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 16.294</td><td>  0.002</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 16.297</td><td>  0.002</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 16.303</td><td>  0.007</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 16.311</td><td>  0.007</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 16.322</td><td>  0.012</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 16.331</td><td>  0.009</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 16.342</td><td>  0.011</td><td>exec EXEC_ACTS (news_short)</td><td></td></tr>
<tr><td> 80.361</td><td> 64.018</td><td>exec EXEC_ACTS (index)</td><td></td></tr>
<tr><td> 80.367</td><td>  0.007</td><td>loadActionHandlers(index): preloaded file "elka/elka.php" for 0.0005999999999915 sec</td><td></td></tr>
<tr><td> 80.370</td><td>  0.003</td><td>loadActionHandlers(index): preloaded file "favorites/favorites.php" for 0.00039999999999907 sec</td><td></td></tr>
<tr><td> 80.371</td><td>  0.001</td><td>loadActionHandlers(index): preloaded file "top_news/top_news.php" for 0.00079999999999814 sec</td><td></td></tr>
<tr><td> 80.380</td><td>  0.009</td><td>loadActionHandlers(index): preloaded file "football_stats/football_stats.php" for 0.0089000000000112 sec</td><td></td></tr>
<tr><td> 82.836</td><td>  2.456</td><td>loadActionHandlers(index): preloaded file "boxers/boxers.php" for 2.4507 sec</td><td></td></tr>
<tr><td> 82.837</td><td>  0.000</td><td>func EXEC_ACTS (index): call function "plugin_ads" [1 params] for 0.00029999999999575 sec</td><td></td></tr>
<tr><td> 82.842</td><td>  0.005</td><td>func EXEC_ACTS (index): call function "plugin_tags_cloudblock" [1 params] for 0.0054999999999978 sec</td><td></td></tr>
<tr><td> 82.842</td><td>  0.000</td><td>func EXEC_ACTS (index): call function "elka" [1 params] for 0.00029999999999575 sec</td><td></td></tr>
<tr><td> 82.843</td><td>  0.000</td><td>func EXEC_ACTS (index): call function "plugin_favorites" [1 params] for 0.00029999999999575 sec</td><td></td></tr>
<tr><td> 82.870</td><td>  0.027</td><td>func EXEC_ACTS (index): call function "top_news" [1 params] for 0.027300000000011 sec</td><td></td></tr>
<tr><td> 82.998</td><td>  0.128</td><td>func EXEC_ACTS (index): call function "showTablesMain" [1 params] for 0.1279 sec</td><td></td></tr>
<tr><td> 83.007</td><td>  0.009</td><td>func EXEC_ACTS (index): call function "showRatings" [1 params] for 0.0090999999999894 sec</td><td></td></tr>
<tr><td> 83.007</td><td>  0.000</td><td>Master activity finished</td><td></td></tr>
<tr><td> 83.011</td><td>  0.004</td><td>Category menu created</td><td></td></tr>
<tr><td> 83.014</td><td>  0.003</td><td>exec EXEC_ACTS (usermenu)</td><td></td></tr>
<tr><td> 83.023</td><td>  0.008</td><td>exec EXEC_ACTS (index_post)</td><td></td></tr>
<tr><td> 83.023</td><td>  0.001</td><td>loadActionHandlers(index_post): preloaded file "simple_title_ng/simple_title.php" for 0.00050000000000239 sec</td><td></td></tr>
<tr><td> 83.025</td><td>  0.002</td><td>loadActionHandlers(index_post): preloaded file "ads_sape/ads_sape.php" for 0.0019999999999953 sec</td><td></td></tr>
<tr><td> 83.026</td><td>  0.000</td><td>func EXEC_ACTS (index_post): call function "plugin_multi_main" [1 params] for 0.00010000000000332 sec</td><td></td></tr>
<tr><td> 83.026</td><td>  0.000</td><td>func EXEC_ACTS (index_post): call function "simple_tags" [1 params] for 0.00010000000000332 sec</td><td></td></tr>
<tr><td> 83.029</td><td>  0.003</td><td>func EXEC_ACTS (index_post): call function "plugin_ads_sape" [1 params] for 0.0031000000000034 sec</td><td></td></tr>
<tr><td> 83.029</td><td>  0.000</td><td>Templates generation time: 0.19256258010864 (65 times called)</td><td></td></tr>
<tr><td> 83.029</td><td>  0.000</td><td>Generate DEBUG output</td><td></td></tr>
</table>

Изменено legenda (2011-12-28 04:14:52)

Не в сети

#106 2011-12-28 08:47:04

Wolverine
Модератор
Откуда Домодедово
Зарегистрирован: 2008-10-13
Сообщений: 3,538
Рейтинг :   160 
Сайт

Re: Помогите разобратся что так грузит сайт

Ну во первых таких событий всего 7. То есть тормоза появляются относительно редко. Файл удали пока, чтобы заново отсчет пошел.

Затыка всего три.

Первый это:

0.025 0.008 Template engine is activated
5.833 5.808 DB connection established

5 секунд подключение к БД?

Второй:

19.032 Config file is loaded
19 секунд загрузка config файла?
17.988 Config file is loaded
18 секунд загрузка config файла?

И третий:

0.075  exec showNews // similar
11.394 call showNews() for [ 11.3389 ] sec

0.079 0.000 exec showNews // similar
10.613 10.533 call showNews() for [ 10.5561 ] sec

Что он тут делает 10 секунд при первом вызове showNews тоже непонятно?

Подождем коммента Виталия smile

Не в сети

#107 2011-12-28 09:44:57

vitaly
Администратор
Откуда Россия
Зарегистрирован: 2008-10-08
Сообщений: 2,822
Рейтинг :   117 

Re: Помогите разобратся что так грузит сайт

legenda, посмотри сам на логи.
Обрати внимание, что тормоза происходят в самые непредсказуемые моменты.

В такой ситуации мы тебе ничем не поможем, тут одно из двух:
1. Кол-во посетителей превышает возможности сервера
2. У хостера серьёзные проблемы с нагрузкой на систему (ты же не один на этом сервере живёшь)

Я склоняюсь к первому варианту.
Я ведь всё правильно помню, сайт - sportanalytic.com ?

Вот для примера результаты проверки скорости работы твоего сайта.
* 30 запросов в 1 поток:

Concurrency Level:      1
Time taken for tests:   23.003 seconds
Complete requests:      30
Failed requests:        0
Write errors:           0
Total transferred:      6007020 bytes
HTML transferred:       5994870 bytes
Requests per second:    1.30 [#/sec] (mean)
Time per request:       766.759 [ms] (mean)
Time per request:       766.759 [ms] (mean, across all concurrent requests)
Transfer rate:          255.02 [Kbytes/sec] received

* 30 запросов в 2 потока:

Concurrency Level:      2
Time taken for tests:   16.312 seconds
Complete requests:      30
Failed requests:        2
   (Connect: 0, Receive: 0, Length: 2, Exceptions: 0)
Write errors:           0
Total transferred:      6007018 bytes
HTML transferred:       5994868 bytes
Requests per second:    1.84 [#/sec] (mean)
Time per request:       1087.499 [ms] (mean)
Time per request:       543.750 [ms] (mean, across all concurrent requests)
Transfer rate:          359.62 [Kbytes/sec] received

* 30 запросов в 3 потока:

Concurrency Level:      3
Time taken for tests:   12.068 seconds
Complete requests:      30
Failed requests:        2
   (Connect: 0, Receive: 0, Length: 2, Exceptions: 0)
Write errors:           0
Total transferred:      6205693 bytes
HTML transferred:       6193138 bytes
Requests per second:    2.49 [#/sec] (mean)
Time per request:       1206.825 [ms] (mean)
Time per request:       402.275 [ms] (mean, across all concurrent requests)
Transfer rate:          502.16 [Kbytes/sec] received

Обрати внимание, даже при 3х одновременных запросах (на главную страницу) время генерации страницы составляет 1.2 сек.
3 одновременных потока и время генерации 1.5 секунды дадут нам производительность в 1.5/3 = 0.5 req/sec => 172k (теоретических) и ~70k (практических с учётом неравномерности нагрузки в разное время суток) хитов в сутки.

А теперь - смертельный номер, делаем 10 одновременных запросов:

Concurrency Level:      10
Time taken for tests:   9.645 seconds
Complete requests:      30
Failed requests:        2
   (Connect: 0, Receive: 0, Length: 2, Exceptions: 0)
Write errors:           0
Total transferred:      6004978 bytes
HTML transferred:       5992828 bytes
Requests per second:    3.11 [#/sec] (mean)
Time per request:       3215.132 [ms] (mean)
Time per request:       321.513 [ms] (mean, across all concurrent requests)
Transfer rate:          607.98 [Kbytes/sec] received

... странно, смерть не наступила. Ну да ладно.
Заметь, теперь на генерацию страницы уходит уже 3.2 секунды (одновременно сервер получает по 10 запросов !!)

Идём дальше - 20 одновременных запросов, общее кол-во - 100 штук:

Concurrency Level:      20
Time taken for tests:   28.831 seconds
Complete requests:      100
Failed requests:        9
   (Connect: 0, Receive: 0, Length: 9, Exceptions: 0)
Write errors:           0
Total transferred:      20016587 bytes
HTML transferred:       19976087 bytes
Requests per second:    3.47 [#/sec] (mean)
Time per request:       5766.234 [ms] (mean)
Time per request:       288.312 [ms] (mean, across all concurrent requests)
Transfer rate:          678.00 [Kbytes/sec] received

Время генерации - 5.7sec/запрос (в одном потоке).

Продолжаем DOS'ить сайт - 40 одновременных запросов,  всего 100 штук:

Concurrency Level:      40
Time taken for tests:   26.310 seconds
Complete requests:      100
Failed requests:        26
   (Connect: 0, Receive: 0, Length: 26, Exceptions: 0)
Write errors:           0
Total transferred:      20016605 bytes
HTML transferred:       19976105 bytes
Requests per second:    3.80 [#/sec] (mean)
Time per request:       10524.014 [ms] (mean)
Time per request:       263.100 [ms] (mean, across all concurrent requests)
Transfer rate:          742.97 [Kbytes/sec] received

При 40 одновременных запросах время генерации страницы составило уже 10.5 секунд.... для посетителей это уже совсем плохо, но до твоих цифр (под 60+ секунд) мы пока не добрались.

Увеличиваем нагрузку - 500 запросов в 60 одновременных сессиях (уже явная DOS атака):

Concurrency Level:      60
Time taken for tests:   149.762 seconds
Complete requests:      500
Failed requests:        418
   (Connect: 0, Receive: 0, Length: 418, Exceptions: 0)
Write errors:           0
Total transferred:      100080882 bytes
HTML transferred:       99878382 bytes
Requests per second:    3.34 [#/sec] (mean)
Time per request:       17971.388 [ms] (mean)
Time per request:       299.523 [ms] (mean, across all concurrent requests)
Transfer rate:          652.61 [Kbytes/sec] received

Ура, мы уже добрались до 17 секунд на генерацию страницы. Правда добрались под явным DOS'ом... при этом среднее время генерации страницы (с учётом одновременных потоков) получается 300ms, т.е. в пике в час ты можешь отдать до 12 тысяч хитов.

Но и в этой ситуации мы так и не увидели твоих 80+ секунд... что же делать?
Раз уж пошла такая пьянка, то давай отправим 1000 запросов в 150 одновременных сессий...

Concurrency Level:      150
Time taken for tests:   288.442 seconds
Complete requests:      1000
Failed requests:        904
   (Connect: 0, Receive: 0, Length: 904, Exceptions: 0)
Write errors:           0
Non-2xx responses:      7
Total transferred:      198798784 bytes
HTML transferred:       198395108 bytes
Requests per second:    3.47 [#/sec] (mean)
Time per request:       43266.315 [ms] (mean)
Time per request:       288.442 [ms] (mean, across all concurrent requests)
Transfer rate:          673.06 [Kbytes/sec] received

Ура, мы добились этого!
Время генерации 43 секунды... но постойте, такое время получилось при 150 одновременных запросах!!!
Т.е. за 280 секунд (4.5 минуты) ты выдал 1000 хитов, что даёт ~13k хитов в час.
Как ты видишь, цифра (максимальная производительность) на 150 одновременных запросах очень близка к цифре, полученной и на 60 одновременных запросах..

Мой вывод:
1. У сайта нет проблем с производительностью, цифры в 15-30-60-90 секунд выдаются из-за бешенного кол-ва одновременных запросов к серверу, сервер физически не может справиться с таким потоком. Обращать внимания на эти цифры нет никакого смысла, у тебя же не 100 ядерный процессор и ты сам должен понимать, что увеличение одновременного кол-ва запросов в 2 раза ведёт к замедлению работы всех одновременных скриптов в те же 2 (и даже больше) раз. Кстати, у твоего сервера (судя по результатам) - всего 2-3 ядра.
2. Пиковая оптимальная производительность твоего сервера (с твоей конфигурацией плагинов) составляет 2.5 запроса в секунду.
3. Пиковая допустимая производительность составляет 2.8-2.9 запросов в секунду. Всё что выше - ведёт у показанным тобой (и мной) примерам.
4. Если хочешь, чтобы сайт работал быстрее, то на выбор:
4.1. Ставь более мощный сервер (отчасти может спасти вынос mySQL на отдельный сервер (может дать прирост до 40+%), кое-что даст оптимизация настроек mySQL...)
4.2. Отключай всякие ресурсоёмкие плагины

Кстати, для сравнения - вот результаты отправки 1000 запросов в 30 сессиях на сайт (работает на NG), получающий 2 ядра от Core2Quad Q9550:

Concurrency Level:      30
Time taken for tests:   144.562 seconds
Complete requests:      1000
Failed requests:        624
   (Connect: 0, Receive: 0, Length: 624, Exceptions: 0)
Write errors:           0
Total transferred:      95647694 bytes
HTML transferred:       95337694 bytes
Requests per second:    6.92 [#/sec] (mean)
Time per request:       4336.868 [ms] (mean)
Time per request:       144.562 [ms] (mean, across all concurrent requests)
Transfer rate:          646.13 [Kbytes/sec] received

ему требуется 150-160ms на генерацию страницы, что даёт оптимальную нагрузку в 6 запросов в секунду.
Если сайт получит все 4 ядра, то сможет отдавать до 12 запросов в секунду (в максимуме это 1 миллион запросов в сутки, в реальности же с учётом неравномерности нагрузки - всего 400-500k запросов в сутки, что позволит обслужить 50-150k посетителей в сутки).
Много это или мало - судить не мне.

Не в сети

#108 2011-12-28 09:53:58

Wolverine
Модератор
Откуда Домодедово
Зарегистрирован: 2008-10-13
Сообщений: 3,538
Рейтинг :   160 
Сайт

Re: Помогите разобратся что так грузит сайт

vitaly, супер. А что за софт, которым запросы делал?

Не в сети

#109 2011-12-28 09:54:58

vitaly
Администратор
Откуда Россия
Зарегистрирован: 2008-10-08
Сообщений: 2,822
Рейтинг :   117 

Re: Помогите разобратся что так грузит сайт

Wolverine пишет:

vitaly, супер. А что за софт, которым запросы делал?

Самый банальный ab (Apache Benchmark), входящий в состав апача smile

Не в сети

#110 2011-12-28 17:06:59

legenda
Участник
Откуда ua
Зарегистрирован: 2009-12-22
Сообщений: 2,151
Рейтинг :   39 

Re: Помогите разобратся что так грузит сайт

vitaly, у меня есть такой же но другой сервак (по характеристикам в 4 раза меньше) для других сайтов, там стоит 3 сайта с такими же плагинами (в том числе similar, top_news, xfields), и их посещалка в 2-3 раза више, а вчера например сумарно было больше 100к, что практически в 10 раз больше чем вчера на спортаналитике. Единственное чем отличается что там в каждого сайта сравнительно мало новостей (5-10 тис.) и база весит примерно 20 мбт, а у спортаналитика около 100 тис. и вес бази - 0,5 гиг, при этом на втором серваке даже близко нету той проблемы, поэтому я почемуто не думаю что все связано с серваком.

Если смотреть на что тратятся все ресурси так это все идлет на mysqld, нуда скорее всего надо оптимизацию настроек mySQL, кто может в этом помочь?

цифры в 15-30-60-90 секунд выдаются из-за бешенного кол-ва одновременных запросов к серверу, сервер физически не может справиться с таким потоком.

Я думаю что правельнее не наращивать ресурсы сервера а смотреть откуда берется бешеное кол-во одновременных запросов к серверу, как мне кажется что 90% запросов просто левых...

Сегодня ночью я пробовал отключить 3 плагина similar, top_news, xfields. Сайт просто летал (SQL запитів: 5, Генерація сторінки: 0.15 сек - 0,35 максимум) , думаю примерно что также летал бы и при большом количестве посетителей (500-1000 онлайн)

Тоесть проблему надо искать именно в этих трех плагинах.


Если similar, хрен с ним могу и без него обойтись раз уж такое дело, но вот с xfields и top_news проблемно.

1. Можно както оптимизировать чтоб xfields не делал 50 запросов? ато както это очень меня напрягает.
2. Если в top_news много блоков он очень долго грузится, что можно сделать чтоб оптимизировать нагрузку?

Изменено legenda (2011-12-28 17:23:57)

Не в сети

#111 2011-12-28 17:34:06

legenda
Участник
Откуда ua
Зарегистрирован: 2009-12-22
Сообщений: 2,151
Рейтинг :   39 

Re: Помогите разобратся что так грузит сайт

vitaly, Раз уж пошла такая пьянка, то давай отправим 1000 запросов в 150 одновременных сессий...

Код:
Concurrency Level:      150
Time taken for tests:   288.442 seconds
Complete requests:      1000
Failed requests:        904
   (Connect: 0, Receive: 0, Length: 904, Exceptions: 0)
Write errors:           0
Non-2xx responses:      7
Total transferred:      198798784 bytes
HTML transferred:       198395108 bytes
Requests per second:    3.47 [#/sec] (mean)
Time per request:       43266.315 [ms] (mean)
Time per request:       288.442 [ms] (mean, across all concurrent requests)
Transfer rate:          673.06 [Kbytes/sec] received

если перевести в реал сколько это хитов за минуту?

Изменено legenda (2011-12-28 17:34:29)

Не в сети

#112 2011-12-28 18:55:53

Wolverine
Модератор
Откуда Домодедово
Зарегистрирован: 2008-10-13
Сообщений: 3,538
Рейтинг :   160 
Сайт

Re: Помогите разобратся что так грузит сайт

Я думаю что правельнее не наращивать ресурсы сервера а смотреть откуда берется бешеное кол-во одновременных запросов к серверу, как мне кажется что 90% запросов просто левых...

Я думаю Виталий имел ввиду не запросов SQL, а запросов от людей smile

Все запросы у тебя выполняются моментально, очень быстро, судя по логам которые ты выкладывал. Даже те 50 от xfields меньше секунды.

Не в сети

#113 2011-12-28 19:32:05

legenda
Участник
Откуда ua
Зарегистрирован: 2009-12-22
Сообщений: 2,151
Рейтинг :   39 

Re: Помогите разобратся что так грузит сайт

Wolverine, ты хочеш сказать что 300 людей это бешеное кол-во?

Не в сети

#114 2011-12-29 02:48:36

vitaly
Администратор
Откуда Россия
Зарегистрирован: 2008-10-08
Сообщений: 2,822
Рейтинг :   117 

Re: Помогите разобратся что так грузит сайт

legenda пишет:

vitaly, Раз уж пошла такая пьянка, то давай отправим 1000 запросов в 150 одновременных сессий...

Код:
Concurrency Level:      150
Time taken for tests:   288.442 seconds
Complete requests:      1000
Failed requests:        904
   (Connect: 0, Receive: 0, Length: 904, Exceptions: 0)
Write errors:           0
Non-2xx responses:      7
Total transferred:      198798784 bytes
HTML transferred:       198395108 bytes
Requests per second:    3.47 [#/sec] (mean)
Time per request:       43266.315 [ms] (mean)
Time per request:       288.442 [ms] (mean, across all concurrent requests)
Transfer rate:          673.06 [Kbytes/sec] received

если перевести в реал сколько это хитов за минуту?

Это ~200 хитов в минуту.


По поводу оптимизации и всего остального - это уже работа для системного администратора.
Проанализировать логи, посмотреть средний профиль запросов, выполнить тонкую настройку mysql, web сервера и так далее.
К примеру, некоторые страницы можно кешировать средствами nginx'а, это может дать (а может и не дать - нужно чётко понимать требования) значительный прирост в производительности.

Будет желание - обращайся. Но ценник начинается от $100 (зависит от требований).
Как вариант - можешь найти исполнителей на такую задачу на сайтах фрилансеров.

Не в сети

#115 2011-12-29 03:21:39

legenda
Участник
Откуда ua
Зарегистрирован: 2009-12-22
Сообщений: 2,151
Рейтинг :   39 

Re: Помогите разобратся что так грузит сайт

Это ~200 хитов в минуту.

да это смешно, без xfields и top_news, сайт летает при 2000 хитов в минуту, что тогда настраивать, надо плагины смотреть

Не в сети

#116 2011-12-29 15:02:13

legenda
Участник
Откуда ua
Зарегистрирован: 2009-12-22
Сообщений: 2,151
Рейтинг :   39 

Re: Помогите разобратся что так грузит сайт

vitaly, можеш помочь откоректировать xfields чтоб небило этих 50 запросов?, я понимаю что они виполняются бистро, но всетаки я б хотел както убрать, а то страничках новостей

SQL запитів: 6, Генерація сторінки: 0.15 сек

а на главной

SQL запитів: 55, Генерація сторінки: 0.38 сек

Я вот немного подкоректировал сам шаблон, немного блоки top_news поменял, счас боюсь накаркать но все летает, жду болееменее нормальной посещалки чтоб понять все ли ок, но єти 50запросов от xfields меня очень волнуют.

Изменено legenda (2011-12-29 15:02:43)

Не в сети

#117 2011-12-30 15:45:21

legenda
Участник
Откуда ua
Зарегистрирован: 2009-12-22
Сообщений: 2,151
Рейтинг :   39 

Re: Помогите разобратся что так грузит сайт

вот что увидел, когда ставлю в настройках сайта "Количество новостей для отображения на одной странице" - 10 , то xfields генерует на главной 10 запросов, когда 50 то 50 запросов, хотя у меня на главной ваше неидуть те новости, у меня там только блоки, че делать?

Не в сети

#118 2011-12-30 18:13:44

vitaly
Администратор
Откуда Россия
Зарегистрирован: 2008-10-08
Сообщений: 2,822
Рейтинг :   117 

Re: Помогите разобратся что так грузит сайт

legenda, на текущий момент это - штатное поведение для плагина xfields при использовании полей типа "группа изображений".

Не в сети

#119 2011-12-30 18:24:07

Wolverine
Модератор
Откуда Домодедово
Зарегистрирован: 2008-10-13
Сообщений: 3,538
Рейтинг :   160 
Сайт

Re: Помогите разобратся что так грузит сайт

В принципе проблема решаема, как и с рейтингом http://ngcms.ru/forum/viewtopic.php?pid=24165#p24165

Если бы это было сделано в двиге, то эти IDшники и здесь можно было использовать, чтобы делать один запрос вместо N = количеству новостей.

Не в сети

#120 2011-12-31 16:28:07

legenda
Участник
Откуда ua
Зарегистрирован: 2009-12-22
Сообщений: 2,151
Рейтинг :   39 

Re: Помогите разобратся что так грузит сайт

Сегодня еще случайно в базе заметил таблицу с назвой test_news весит примерно 200 метров и практичести  в ней все тожесамое что и в 2z_news, я чет немогу вспомнить откуда она там могла взятся, насколько я понимаю такой таблици не должно бить, или она для чегото предназначена?

вот ее структура

attachment.php?item=739&download=1

Изменено legenda (2011-12-31 16:28:42)

Не в сети

#121 2011-12-31 16:41:26

Wolverine
Модератор
Откуда Домодедово
Зарегистрирован: 2008-10-13
Сообщений: 3,538
Рейтинг :   160 
Сайт

Re: Помогите разобратся что так грузит сайт

Это таблица новостей. Откуда она у тебя ХЗ smile

Не в сети

#122 2011-12-31 17:02:41

legenda
Участник
Откуда ua
Зарегистрирован: 2009-12-22
Сообщений: 2,151
Рейтинг :   39 

Re: Помогите разобратся что так грузит сайт

Wolverine, ее можно удалить?

Не в сети

#123 2011-12-31 18:39:21

Wolverine
Модератор
Откуда Домодедово
Зарегистрирован: 2008-10-13
Сообщений: 3,538
Рейтинг :   160 
Сайт

Re: Помогите разобратся что так грузит сайт

Я ж не знаю, может она у тебя используется где-то)) Если нет, то бэкап сделай таблицы и удаляй

Не в сети

#124 2012-01-25 16:06:50

kolia
Участник
Откуда Ukraine, Украина
Зарегистрирован: 2010-01-10
Сообщений: 330
Рейтинг :   
Сайт

Re: Помогите разобратся что так грузит сайт

Внимательно ознакомился с выше написанным включил кеширование где смог, и хотел-бы задать такой-же вопрос, сайт постоянно чего-то грузит

SQL queries:
[ 0.0002 ] select nc.*, ni.id as icon_id, ni.name as icon_name, ni.storage as icon_storage, ni.folder as icon_folder, ni.preview as icon_preview, ni.width as icon_width, ni.height as icon_height, ni.p_width as icon_pwidth, ni.p_height as icon_pheight from `ng_category` as nc left join `ng_images` ni on nc.image_id = ni.id order by nc.posorder asc
[ 9.9999999999999E-5 ] select * from ng_users where authcookie = '98db920e29cb05e16debb205d115a74a' limit 1
[ 0.0002 ] SELECT * FROM ng_news WHERE (`approve` = '1') AND (`mainpage` = '1') order by pinned desc, id desc limit 0,3
[ 9.9999999999999E-5 ] SELECT n.id, n.title, n.alt_name, n.catid, n.postdate FROM ng_bookmarks AS b LEFT JOIN ng_news n ON n.id = b.news_id WHERE b.user_id = '1'
[ 0 ] SELECT COUNT(*) FROM ng_bookmarks WHERE news_id=86
[ 0.008 ] SELECT * FROM ng_news WHERE id !=86 AND approve=1 AND ((catid regexp '[[:<:]](19)[[:>:]]')) ORDER BY rand() LIMIT 0,20
[ 0.0001 ] SELECT COUNT(*) FROM ng_bookmarks WHERE news_id=28
[ 0.0071 ] SELECT * FROM ng_news WHERE id !=28 AND approve=1 AND ((catid regexp '[[:<:]](19)[[:>:]]') OR (catid regexp '[[:<:]](18)[[:>:]]')) ORDER BY rand() LIMIT 0,20
[ 0 ] SELECT COUNT(*) FROM ng_bookmarks WHERE news_id=25
[ 0.0075 ] SELECT * FROM ng_news WHERE id !=25 AND approve=1 AND ((catid regexp '[[:<:]](8)[[:>:]]')) ORDER BY rand() LIMIT 0,20
[ 0 ] SELECT count(*) as count FROM ng_news WHERE (`approve` = '1') AND (`mainpage` = '1')
[ 0.0008 ] select * from ng_vote where id = '1'
[ 0.00020000000000001 ] SELECT `session` FROM ng_online WHERE `session` = '7d11ec7ef3d50f6f3be061c4cba083ee' LIMIT 1
[ 0.00070000000000001 ] UPDATE `ng_online` SET `lasttime`=1327494204, `id`=1, `login`='kolia_jim', `status`=1, `com`='5' WHERE `session`='7d11ec7ef3d50f6f3be061c4cba083ee'
[ 0.00020000000000001 ] SELECT * FROM `ng_online` WHERE `lasttime` > 1327493904;
Time profiler:
Time	Delta	Event	Desc
0.001	0.000	Config file is loaded	
0.002	0.001	Core files are included	
0.004	0.002	Template engine is activated	
0.005	0.001	DB connection established	
0.005	0.000	DB category list is loaded	
0.005	0.000	Ready to load auth plugins	
0.006	0.001	loadActionHandlers(auth): preloaded file "auth_basic/auth_basic.php" for 0.0006 sec	
0.006	0.000	Auth plugins are loaded	
0.006	0.000	Auth procedure is finished	
0.006	0.000	ALL core-related plugins are loaded	
0.006	0.000	exec EXEC_ACTS (core)	
0.006	0.000	loadActionHandlers(core): preloaded file "switcher/switcher.php" for 0 sec	
0.007	0.000	loadActionHandlers(core): preloaded file "autokeys/autokeys.php" for 0.0001 sec	
0.007	0.000	func EXEC_ACTS (core): call function "plugin_switcher" [1 params] for 0.0001 sec	
0.007	0.000	ALL core-related plugins are executed	
0.007	0.000	* CORE.PHP is complete	
0.007	0.000	exec EXEC_ACTS (index_pre)	
0.007	0.000	Search route for URL "/"	
0.008	0.001	loadActionHandlers(news): preloaded file "similar/similar.php" for 9.9999999999999E-5 sec	
0.008	0.000	loadActionHandlers(news): preloaded file "make_links/news.php" for 0 sec	
0.008	0.000	loadActionHandlers(news): preloaded file "cat_description/cat_description.php" for 9.9999999999999E-5 sec	
0.009	0.001	loadActionHandlers(news): preloaded file "bookmarks/bookmarks.php" for 0.0006 sec	
0.009	0.000	loadActionHandlers(news): preloaded file "tags/tags.php" for 9.9999999999999E-5 sec	
0.010	0.001	loadActionHandlers(news): preloaded file "comments/comments.php" for 0.0007 sec	
0.011	0.000	loadActionHandlers(news:show): preloaded file "same_category_news/same_category_news.php" for 0.0001 sec	
0.011	0.000	loadActionHandlers(news:show): preloaded file "varmgr/varmgr.php" for 0 sec	
0.026	0.015	exec EXEC_ACTS (news_short)	
0.026	0.000	loadActionHandlers(news_short): preloaded file "bb_media/bb_media.php" for 9.9999999999999E-5 sec	
0.026	0.001	loadActionHandlers(news_short): preloaded file "downloadcounter/downloadcounter.php" for 0.0005 sec	
0.027	0.000	loadActionHandlers(news_short): preloaded file "rating/rating.php" for 0.0001 sec	
0.103	0.076	exec EXEC_ACTS (news_short)	
0.178	0.075	exec EXEC_ACTS (news_short)	
0.202	0.024	exec EXEC_ACTS (index)	
0.203	0.000	loadActionHandlers(index): preloaded file "voting/voting.php" for 9.9999999999989E-5 sec	
0.203	0.000	loadActionHandlers(index): preloaded file "weather/weather.php" for 0 sec	
0.203	0.000	loadActionHandlers(index): CAN't preload file that doesn't exists: "top_news/top_news.php"	
0.203	0.001	loadActionHandlers(index): preloaded file "breadcrumbs/breadcrumbs.php" for 0.00049999999999997 sec	
0.204	0.000	loadActionHandlers(index): preloaded file "calendar/calendar.php" for 9.9999999999989E-5 sec	
0.204	0.000	loadActionHandlers(index): preloaded file "hsgallery/gallery.php" for 0 sec	
0.204	0.000	loadActionHandlers(index): preloaded file "lastnews/lastnews.php" for 9.9999999999989E-5 sec	
0.204	0.000	loadActionHandlers(index): preloaded file "popular/popular.php" for 0 sec	
0.204	0.000	loadActionHandlers(index): preloaded file "who_online/who_online.php" for 0.00010000000000002 sec	
0.205	0.001	loadActionHandlers(index): preloaded file "archive/archive.php" for 0.00040000000000001 sec	
0.206	0.001	func EXEC_ACTS (index): call function "plugin_switcher_menu" [1 params] for 0.00089999999999998 sec	
0.207	0.001	func EXEC_ACTS (index): call function "bookmarks_view" [1 params] for 0.0013 sec	
0.208	0.001	func EXEC_ACTS (index): call function "plugin_tags_cloudblock" [1 params] for 0.00080000000000002 sec	
0.212	0.005	func EXEC_ACTS (index): call function "plugin_voting" [1 params] for 0.0045 sec	
0.213	0.000	func EXEC_ACTS (index): call function "plugin_weather_block" [1 params] for 0.00029999999999999 sec	
0.214	0.001	func EXEC_ACTS (index): call function "breadcrumbs" [1 params] for 0.0011 sec	
0.214	0.000	func EXEC_ACTS (index): call function "plugin_calendar" [1 params] for 0.00029999999999999 sec	
0.216	0.002	func EXEC_ACTS (index): call function "plugin_hsgallery" [1 params] for 0.0015 sec	
0.216	0.000	func EXEC_ACTS (index): call function "plugin_lastnews" [1 params] for 0.00029999999999999 sec	
0.216	0.000	func EXEC_ACTS (index): call function "plugin_popular" [1 params] for 0.00020000000000001 sec	
0.220	0.003	func EXEC_ACTS (index): call function "who_online" [1 params] for 0.0031 sec	
0.220	0.000	func EXEC_ACTS (index): call function "plugin_archive" [1 params] for 0.00020000000000001 sec	
0.220	0.000	Master activity finished	
0.221	0.002	Category menu created	
0.222	0.000	exec EXEC_ACTS (usermenu)	
0.223	0.001	loadPluginLibrary: pm [lib] for 0 sec	
0.223	0.000	loadActionHandlers(usermenu): preloaded file "pm/pm.php" for 0.00059999999999999 sec	
0.223	0.000	func EXEC_ACTS (usermenu): call function "new_pm" [1 params] for 0 sec	
0.224	0.001	exec EXEC_ACTS (index_post)	
0.224	0.000	loadActionHandlers(index_post): CAN't preload file that doesn't exists: "simple_title_ng/simple_title.php"	
0.224	0.000	loadActionHandlers(index_post): preloaded file "simple_title_pro/index.php" for 9.9999999999989E-5 sec	
0.224	0.000	loadActionHandlers(index_post): preloaded file "ads_sape/ads_sape.php" for 0.00020000000000001 sec	
0.224	0.000	func EXEC_ACTS (index_post): call function "simple_title_pro" [1 params] for 0.00010000000000002 sec	
0.224	0.000	func EXEC_ACTS (index_post): call function "plugin_ads_sape" [1 params] for 0 sec	
0.224	0.000	Templates generation time: 0.022810459136963 (52 times called)	
0.224	0.000	Generate DEBUG output

Изменено kolia (2012-01-25 16:24:06)


Чем дальше в лес - тем ближе вылез smile

Не в сети

#125 2012-01-25 16:29:05

Wolverine
Модератор
Откуда Домодедово
Зарегистрирован: 2008-10-13
Сообщений: 3,538
Рейтинг :   160 
Сайт

Re: Помогите разобратся что так грузит сайт

1. Отредактировал твое сообщение, зря ты куку админа выложил, погулял как админ у тебя smile
2. В логах все отлично для такого объема включенных плагинов, запросы выполняются быстро, страница загрузилась за 0.2 секунды. Как проявляется "торможение"?

Не в сети

Подвал раздела

Работает на FluxBB