Время запроса журнала доступа php-fpm и время выполнения xdebug не совпадают.
Почему профилирование xdebug показывает 100 мс для запроса и журнал доступа php-fpm, показывающий разницу 700 мс + 7х или даже больше?
Xdebug пропускает / пропускает что-то в пути или fpm делает что-то между фактической обработкой php?
Автозагрузка Xdebug также включает / требует времени? Соединения с базой данных и т. Д.?
Есть ли способ заглянуть глубже во времена, когда php-fpm входит в access.log?
Я подозреваю, что php-fpm регистрирует время, необходимое для настройки / завершения фактической загрузки и очистки php-файла в конце обработки. Xdebug может стать «самоосознанным» только после настройки вызова и появляется, когда php-fpm начинает очищаться после завершения выполнения php. Я думаю. Я наблюдаю то же самое без php-fpm (из расширенных журналов apache).
из апача:
192.168.1.54 - - [19/Aug/2016:10:35:17 -0400] "POST /idm/feed/do.php HTTP/1.1" 200 2186 0/128868 I:252 O:2434
из процесса php:
2016-08-19T10:35:17-04:00 -api.idm.feed.Servlet DEBUG /idm/feed[detail] processed in 12.8 ms. , 3 MB
тот же звонок! Apache 128 мс, php 12,8 мс
Если вы используете apache, загрузите дополнительные модули и используйте этот формат журнала, чтобы иметь сквозное время и IO, как указано выше:
нагрузка:
LoadModule log_config_module libexec/mod_log_config.so
формат журнала:
LogFormat "%h %l %u %t \"%r\" %>s %b %T/%D I:%I O:%O" common
Других решений пока нет …