На сервере 1С настроен тех.журнал с отбором длительных выполнений запросов (более 10 сек.)

(

<?xml version="1.0"?>
<config xmlns=" v8.1c.ru/v8/tech-log »»">
<log history="168" location="C:\Program Files\1cv82\8.2.13.202\bin\logs">
<event>
 <eq property="name" value="proc"/>
 <eq property="name" value="scom"/>
 <eq property="name" value="conn"/>
 <eq property="name" value="admin"/>
 <eq property="name" value="excp"/>
 <eq property="name" value="qerr"/>
 <qt property="duration" value="100000"/>
</event>
<property name="all"/>
</log>
<dump create="true" location="F:\TechnologicalLogSetup" type="1023" prntscrn="true"/>
</config>

)



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

первая из них:

------------------------------------------------------------

31:41.6903-0,EXCPCNTX,0,ClientComputerName=CA07,ServerComputerName=DB-002,UserName=Иванова Наталья,ConnectString='Srvr="db-002";Ref="ZUP";'
31:41.6904-3,EXCPCNTX,6,SrcName=DBMSSQL,OSThread=72204,process=rphost,p:processName=ZUP,t:clientID=4,t:applicationName=1CV8,t:computerName=CA07,t:connectID=678,SessionID=8629,Usr=Иванова Наталья,Trans=1,dbpid=116,Sql=DROP INDEX #tt22.TMPIND_5
31:41.6905-5,EXCPCNTX,5,SrcName=SDBL,OSThread=72204,process=rphost,p:processName=ZUP,t:clientID=4,t:applicationName=1CV8,t:computerName=CA07,t:connectID=678,SessionID=8629,Usr=Иванова Наталья,Trans=1,Sdbl=DROP TABLE #T3aa7fc3536e24421b9bec4fdd70cfe84
31:41.6906-7,EXCPCNTX,4,SrcName=CALL,OSThread=72204,process=rphost,p:processName=ZUP,t:clientID=4,t:applicationName=1CV8,t:computerName=CA07,t:connectID=678,SessionID=8629,Usr=Иванова Наталья
31:41.6907-212625,EXCPCNTX,4,SrcName=SDBL,OSThread=72204,process=rphost,p:processName=ZUP,t:clientID=4,t:applicationName=1CV8,t:computerName=CA07,t:connectID=678,SessionID=8629,Usr=Иванова Наталья,Trans=0,Func=Transaction
31:41.6908-212627,EXCPCNTX,3,SrcName=SDBL,OSThread=72204,process=rphost,p:processName=ZUP,t:clientID=4,t:applicationName=1CV8,t:computerName=CA07,t:connectID=678,SessionID=8629,Usr=Иванова Наталья,Trans=0,Func=HoldConnection
31:41.6909-25100004,EXCPCNTX,2,SrcName=SCOM,OSThread=72204,process=rphost,t:clientID=4,ProcessName=ZUP,SrcProcessName=ZUP
31:41.6910-25103130,EXCPCNTX,0,SrcName=CONN,OSThread=72204,process=rphost,t:clientID=4
------------------------------------------------



Это я как понимаю удаление индекса временной таблицы и самой временногй таблицы? Т.е. это удаление заняло более 10 сек. поэтому в лог записалась?



И вторая запись:



20:05.4470-0,EXCPCNTX,0,ClientComputerName=UK04,ServerComputerName=DB-002,UserName=Борисова Татьяна,ConnectString='Srvr="db-002";Ref="ZUP";'
20:05.4471-3,EXCPCNTX,5,SrcName=DBMSSQL,OSThread=64300,process=rphost,p:processName=ZUP,t:clientID=10,t:applicationName=1CV8,t:computerName=UK04,t:connectID=702,SessionID=8679,Usr=Борисова Татьяна,Trans=1,dbpid=155,Sql="SELECT spid, blocked FROM master..sysprocesses WHERE blocked > 0 AND lastwaittype LIKE 'LCK_%'"
20:05.4472-8,EXCPCNTX,4,SrcName=SDBL,OSThread=64300,process=rphost,p:processName=ZUP,t:clientID=10,t:applicationName=1CV8,t:computerName=UK04,t:connectID=702,SessionID=8679,Usr=Борисова Татьяна,Trans=0,Func=Transaction
20:05.4473-10,EXCPCNTX,3,SrcName=SDBL,OSThread=64300,process=rphost,p:processName=ZUP,t:clientID=10,t:applicationName=1CV8,t:computerName=UK04,t:connectID=702,SessionID=8679,Usr=Борисова Татьяна,Trans=0,Func=HoldConnection
20:05.4474-12,EXCPCNTX,2,SrcName=CALL,OSThread=64300,process=rphost,p:processName=ZUP,t:clientID=10,t:applicationName=1CV8,t:computerName=UK04,t:connectID=702,SessionID=8679,Usr=Борисова Татьяна
20:05.4475-2227880,EXCPCNTX,2,SrcName=SCOM,OSThread=64300,process=rphost,t:clientID=10,ProcessName=ZUP,SrcProcessName=ZUP
20:05.4476-2228195,EXCPCNTX,0,SrcName=CONN,OSThread=64300,process=rphost,t:clientID=10

--------------------------------------------

Эта запись что означает? Похожа но ожидание на блокировку? (astwaittype LIKE 'LCK_%)

Спасибо

up

http://support.microsoft.com/kb/822101

2(0) мне кажется это просто запрос... но если хочешь посмотреть блокировки, то добавь


       <event>
           <eq property="name" value="tlock"/>
       </event>

(3)
а подскажи,
если такой конфигурационный файл сохранить на пользовательской машине,
в лог будут писаться процедуры который на клинетской машине выполнялись более 10 сек?

(0)1. емнип, EXCPCNTX - это контекст исключения, только вот само исключение у вас либо в лог не попадает, либо вы его просто не выложили. Что идет перед этими строками?

2. на "ожидание на блокировку" нифига не похоже. SQL Server с ними сам управляется, а агент сервера предприятия на зачем-то регулярно долбит SQL Server приведенным вами запросом. Зачем 1С'y он нужен одному Б-гу известно.

2(4) да

а из-за чего может быть,
что у пользователя при работе в интефейсных объектах заметны тормоза (открывается эдемент справочника 30сек, или документ записывается секунд 40),
но ни в локальный лог пользователя, ни в лог который на сервере 1С настроен, никаких записей по этим событиям не записывается?

Это получается сам компьютер пользователя тормозит работу?

это получается что это кропотливая работа за которую готовы взяться специалисты за деньги. :)

(8)
так где хоть копать-то? :)

(9)
начал правильно, продолжай, не останавливайся. меняй условия, но каждый раз только по одну.

(10) что-то у меня такое ощущение, что условия
<event>
 <eq property="name" value="proc"/>
 <eq property="name" value="scom"/>
 <eq property="name" value="conn"/>
 <eq property="name" value="admin"/>
 <eq property="name" value="excp"/>
 <eq property="name" value="qerr"/>
 <qt property="duration" value="100000"/>
</event>
<property name="all"/>

действуют только на обращение к СУБД,
а  клиентское выполнение каких-то процедур тут не регистрируется...

как собираешься проверить свои ощущения?

(12)
а где можно прочитать полное описание этих событий (proc,scom и пр...)?

наверное в книжках. Например в ТОЛСТОЙ КНИГЕ - но там про 81. Может еще на ИТС.

А еще вот:
http://screencast.com/t/SgNA4BiwO753

Но правильный ответ на вопрос (12) - такой - уберу условие на длительность, положу файл на локальный компьютер и зайду в ФАЙЛОВУЮ базу, и попытаюсь сделать что-то, что должно будет записать в лог...