Добро пожаловать в форум, Guest  >>   Войти | Регистрация | Поиск | Правила | В избранное | Подписаться
Все форумы / Microsoft SQL Server Новый топик    Ответить
 Что между SP:StmtCompleted и RPC:Completed  [new]
X-Cite
Member

Откуда: Минск
Сообщений: 1711
Event Duration
SP:StmtCompleted - 5100
RPC:Completed - 9797
Что 4.5 секунды делал сервер между SP и RPC ? Как это можно узнать или запрофайлерить или может по счетчикам каким вывести?
20 апр 17, 10:43    [20417628]     Ответить | Цитировать Сообщить модератору
 Re: Что между SP:StmtCompleted и RPC:Completed  [new]
X-Cite
Member

Откуда: Минск
Сообщений: 1711
В принципе я залогировал dm_tran_locks и увидел
METADATA: database_id = 9 DATABASE_PRINCIPAL(principal_id = 5), lockPartitionId = 0

вообще в профайлер такое можно вывести?
20 апр 17, 10:56    [20417715]     Ответить | Цитировать Сообщить модератору
 Re: Что между SP:StmtCompleted и RPC:Completed  [new]
Владислав Колосов
Member

Откуда:
Сообщений: 7651
X-Cite,

автор
Что 4.5 секунды делал сервер между SP и RPC

Составлял план запроса.
20 апр 17, 11:37    [20417967]     Ответить | Цитировать Сообщить модератору
 Re: Что между SP:StmtCompleted и RPC:Completed  [new]
SomewhereSomehow
Member

Откуда: Moscow
Сообщений: 2480
Блог
У нас такого нет, не могу ничего сказать по этому поводу, кроме как дать ссылку.
А что происходит между RPC Start и первым SP:Stmt Start?
Может быть там найдете ответ, либо можно написать ТС того топика, что он в итоге выяснил.
20 апр 17, 11:51    [20418056]     Ответить | Цитировать Сообщить модератору
 Re: Что между SP:StmtCompleted и RPC:Completed  [new]
Eleanor
Member

Откуда:
Сообщений: 2793
X-Cite
Что 4.5 секунды делал сервер между SP и RPC ?

Обновлял статистику?
20 апр 17, 12:02    [20418100]     Ответить | Цитировать Сообщить модератору
 Re: Что между SP:StmtCompleted и RPC:Completed  [new]
X-Cite
Member

Откуда: Минск
Сообщений: 1711
нет нет и нет. вся соль в том, что это уже Complited, т.е. выполнение завершено. и фактически между SP:StmtCompleted и RPC:Completed только передача ответа.
Почему 5 секунд ждал я нашел.
Было ожидание WaitResource METADATA: database_id = 9 DATABASE_PRINCIPAL(principal_id = 5), lockPartitionId = 0
В этот момент было обновление функционала. Я только не понимаю зачем серверу ждать собственно когда отпустят метаданные в БД если надо просто передать ответ из одного состояния в другое.

Процесс который блокировал, создавал системную ХП на обновление Application Role или что-то вроде этого. А процесс который был заблокирован, был имперсонирован от этой Application Role. Возможно это и послужило причиной ожидания.
Однако я не понимаю как отловить такие моменты не заглядывая в dmv
20 апр 17, 22:50    [20420473]     Ответить | Цитировать Сообщить модератору
Все форумы / Microsoft SQL Server Ответить