Имя: Пароль:
1C
1С v8
Технологический журнал 8.2.18.61 событие CONN
, ,
0 servs
 
04.07.13
17:36
Добрый день!
Создал настройку для сбора информации в технологический журнал 1с:

<?xml version="1.0" encoding="UTF-8"?>
<config xmlns="http://v8.1c.ru/v8/tech-log">
   <log history="48" location="F:\TechnologicalJournal_1C\Logs">        

       <event> <eq property="Name" value="PR0C"/> </event>
       <event> <eq property="Name" value="EXCP"/> </event>
       <event> <eq property="Name" value="ADMIN"/> </event>
       <event> <eq property="Name" value="QERR"/> </event>            
       <event> <gt property= "Duration" value="200000"/> </event>
       
       <property name="all"/>        

   </log>

   <dump location="F:\TechnologicalJournal_1C\Dumps" create="1" type="3" prntscrn="1"/>

</config>

Почти сразу же выдало события ниже, эти события повторяются с постоянной регулярностью.

21:43.7162-218131,SCOM,2,process=rphost,t:clientID=1475,ProcessName=ServerJobExecutorContext,SrcProcessName=ServerJobExecutorContext
21:43.7311-218440,CONN,0,process=rphost,t:clientID=1475,t:clientID=1475,t:computerName=SST0,t:applicationName=JobScheduler,t:connectID=0,Calls=6
23:43.9661-231547,SCOM,2,process=rphost,t:clientID=1476,ProcessName=ServerJobExecutorContext,SrcProcessName=ServerJobExecutorContext
23:43.9971-231880,CONN,0,process=rphost,t:clientID=1476,t:clientID=1476,t:computerName=SST0,t:applicationName=JobScheduler,t:connectID=0,Calls=6
25:44.5291-228265,SCOM,2,process=rphost,t:clientID=1478,ProcessName=ServerJobExecutorContext,SrcProcessName=ServerJobExecutorContext
25:44.5601-228590,CONN,0,process=rphost,t:clientID=1478,t:clientID=1478,t:computerName=SST0,t:applicationName=JobScheduler,t:connectID=0,Calls=6
27:45.1381-228729,SCOM,2,process=rphost,t:clientID=1481,ProcessName=ServerJobExecutorContext,SrcProcessName=ServerJobExecutorContext
27:45.1701-229070,CONN,0,process=rphost,t:clientID=1481,t:clientID=1481,t:computerName=SST0,t:applicationName=JobScheduler,t:connectID=0,Calls=6
29:25.9500-140394336,SCOM,2,process=rphost,t:clientID=1090,ProcessName=ut23,SrcProcessName=ut23,ProcessName=ut23f0fe8761-a8a1-494a-8ef6-25a9f7ed1b30
29:26.0280-140395430,CONN,0,process=rphost,t:clientID=1090,t:clientID=1090,t:computerName=AZ-ALEKSANDR,t:applicationName=1CV8,t:connectID=7198,Calls=136899
29:45.2782-215757,SCOM,2,process=rphost,t:clientID=1483,ProcessName=ServerJobExecutorContext,SrcProcessName=ServerJobExecutorContext
29:45.3250-216242,CONN,0,process=rphost,t:clientID=1483,t:clientID=1483,t:computerName=SST0,t:applicationName=JobScheduler,t:connectID=0,Calls=6

Подскажите как их интерпретировать. Мне непонятно почему соединение длится больше 20 секунд.
1 Maxus43
 
04.07.13
17:36
фоновые задания, не?
2 servs
 
04.07.13
17:41
Есть регламентое задание, которое работает по расписанию:
"каждый  день; каждые 2 сек., повторять после завершения через 2 сек."

Но оно выполняется не больше 5 секунд, а в ТЖ задержка больше 20с.
3 MadHead
 
04.07.13
17:43
не вижу задержку в 20 секунд
4 MadHead
 
04.07.13
17:43
где она скопируйте коннект и дисконнект (только 2 строки)
5 servs
 
04.07.13
17:44
(2) + время выполнения 5 секунд - вижу через консоль администрирования
6 servs
 
04.07.13
17:45
(3) я смотрю по 21:43.7162-218131, последнее число, это же длительность события, не так ли?
7 servs
 
04.07.13
18:08
архитектура клиент-сервер
8 servs
 
04.07.13
18:08
СУБД MSSQL 2008
9 MadHead
 
04.07.13
18:10
218131 / 10000 ~ 2.1
10 MadHead
 
04.07.13
18:11
Но это всего лишь время установки контекста и коннекта. А код видимо вообще за 1-2 секунды выполняется
11 servs
 
04.07.13
18:18
(10) я так понимаю эти события попадают туди из-за этого фильтра:

<event> <gt property= "Duration" value="200000"/> </event>

понимаю так: фиксировать события длительность которых больше 20 секунд. А по факту получается это 2 секунды, так?

Т. е. мне нужно исправить на
<event> <gt property= "Duration" value="2000000"/> </event>
чтобы видеть события длительность которых > 20 секунд?
12 DS
 
04.07.13
18:21
(9) точно?
13 MadHead
 
04.07.13
18:23
(11),(12) нет. Ошибся на десяток. Действительно там 20 секунд
14 MadHead
 
04.07.13
18:24
но все равно это время установки соединения, а не выполнения фонового. Но 20 секунд это много.
15 servs
 
04.07.13
18:37
(14) да, вот я и пытаюсь понять почему так долго...

Когда открываю обработку "Консоль регл. заданий" в 1С, тоже открывается не быстро, секунд 5-10.

Может поиск ключа долго длится?
Но в консоли регл. заданий в колонке "Начало" между выполненными заданиями разница 4 секунды.

Иногда пользователи жалуются что 1С долго запускается...
16 servs
 
04.07.13
18:49
ЧЯДНТ?
Чтобы обнаруживать ошибки, программист должен иметь ум, которому доставляет удовольствие находить изъяны там, где, казалось, царят красота и совершенство. Фредерик Брукс-младший