Имя: Пароль:
1C
1С v8
Служба сервера 1с 8.2 при завершении вешается намертво. Причины, способы решения?
,
0 e053nk
 
13.09.18
15:38
На сервере (он же сервер SQL) подняты серверы 1с 8.3 и 8.2. Пользователь запуска службы агента -один и тот же, стандартный usr1cv8. Все это работало несколько лет, без  больших проблем. Сейчас ,уже несколько дней наблюдается след . ситуация. Пользователи в базах сервера8.2 работают нормально,у них проблем нет. Но первым признаком проблемы был полный отруб фоновых заданий ( всех сразу). Средствами 1с они не запускались,вообще никак не реагировали на попытки их запустить-не ошибок, ни сообщений. Из консоли заданий-таже самая ситуация. В  администрирование кластера -блокировки никакой нет. И дальше : при попытке перезагрузить службу агента сервера 1с-она переводится в стояние "Остановка" и в этом положении замирает намертво. В диспетчере задач по привязке к серверу 8,2 ragent или rmngr  или rphost-не удаляются вообще никак, либо ничего не пишет, либо пишет "нет доступа". TasKill тоже не не помогает. И помогает только перезагрузка сервака полностью, аппаратно .Но это не решение-причина не определена. При этом все ресурсы  серввера 1.с 8,3 работаю отлично, без каких либо проблем.
В интернете ковырялся ,но что то не нашел причин, что может блочить службу 1с в режиме "Остановка".
У кого то такое было, как решали?
1 Cyberhawk
 
13.09.18
15:41
Это называется "порча севрера 1С". Диагностике практически не поддается. Но ты ТЖ собери хоть.
2 e053nk
 
20.09.18
10:36
Продолжение банкета..
Вчера  опять служба сервера 1с 8,2 зависла. Произошло вечером-перегрузили службу. Сегодня ТЖ включил, но так как не совсем понимаю  что там собирать нужно -взял настройки ТЖ с Интрнета. Содержание файла настройки:
<?xml version="1.0" encoding="UTF-8"?>
-<config xmlns="http://v8.1c.ru/v8/tech-log"><dump type="2" create="1" location="E:\1C_Info\Dumps"/>-<log location="E:\1C_Info\Logs" history="1">-<event><eq value="proc" property="name"/></event>-<event><eq value="scom" property="name"/></event>-<event><eq value="conn" property="name"/></event>-<event><eq value="admin" property="name"/></event>-<event><eq value="excp" property="name"/></event>-<event><eq value="qerr" property="name"/></event><property name="all"/></log></config>

Что то пишет в файлики лога-пока не разобрался что там.
Но сегодня "встал" уже сервак 8.3, на этом же сервере физическом. А я создал только ТЖ для 8.2 -что бы объем по меньше был.
Сейчас конечно уже и сервер 8,3 подключил, но там  все пусто, создался только каталог ragent_3992-в нем пустой файл. Остальные файлы  логов даже не создались, Служба Агента сервера 8,3 висит в состояние "Остановка" и не реагирует ни на что. Процессы также как и в сервере 8.2. убить не дает.
Это что эпидемия какая то что ли?\
Что хоть смотреть в ТЖ, может какие то другие настройки  включать?
3 e053nk
 
21.09.18
13:54
Сегодня опять встала служба сервера 8,3. ТЖ создал дампы, и логи. В логах можно утонуть.Как их можно расшифровать? где то есть информация по содержимому этих файлов?
Например,в файле из папки ragent_3000 есть такие строки(первое что отличается от предыдущего содержимого:


22:59.123000-0,EXCP,1,process=ragent,ClientID=1720,Exception=NetDataExchangeException,Descr=Передача данных прервана по инициативе принимающей стороны.
22:59.123001-0,EXCPCNTX,0,ClientComputerName=,ServerComputerName=,UserName=,ConnectString=
22:59.123002-4047001,EXCPCNTX,0,SrcName=SCALL,OSThread=4776,process=ragent,ClientID=1720,Interface=0459eaa0-589f-4a6d-9eed-c1a7461c8e3f,IName=IClusterRegistry,Method=3,CallID=1225471,MName=getToDelete
22:59.123004-0,EXCP,0,process=ragent,ClientID=1720,Exception=NetDataExchangeException,Descr=Передача данных прервана по инициативе принимающей стороны.
22:59.123005-0,EXCPCNTX,0,ClientComputerName=,ServerComputerName=,UserName=,ConnectString=
22:59.123006-0,EXCP,0,process=ragent,Exception=81029657-3fe6-4cd6-80c0-36de78fe6657,Descr='src\RemoteInterfaceImpl.cpp(808):
81029657-3fe6-4cd6-80c0-36de78fe6657: Передача данных прервана по инициативе принимающей стороны.'
22:59.123007-0,CONN,0,process=ragent,Txt='Connection removed from ping direction: address=192.168.98.14:1741,pingTimeout=5000,pingPeriod=1000,clientID=1720'
22:59.123008-231861007,CONN,1,process=ragent,ClientID=1720,Txt=Outgoing connection closed
22:59.123009-0,EXCP,0,process=ragent,Exception=81029657-3fe6-4cd6-80c0-36de78fe6657,Descr='src\RMngrCalls.cpp(542):
81029657-3fe6-4cd6-80c0-36de78fe6657: Передача данных прервана по инициативе принимающей стороны.'
22:59.795000-0,EXCP,2,process=ragent,ClientID=1724,Exception=NetDataExchangeException,Descr=Передача данных прервана по инициативе принимающей стороны.
22:59.795001-0,EXCPCNTX,0,ClientComputerName=,ServerComputerName=,UserName=,ConnectString=
22:59.795002-5062002,EXCPCNTX,2,SrcName=SCALL,OSThread=4636,process=ragent,ClientID=1724,Interface=64016dc5-c439-49fa-8a71-c3cb708e243b,IName=IClusterLocks,Method=8,CallID=1225470,MName=getProcessesSetVersion
22:59.795003-88043002,EXCPCNTX,1,SrcName=CONN,OSThread=4636,process=ragent,ClientID=1724,Txt=Outgoing connection closed
22:59.795005-0,EXCP,1,process=ragent,ClientID=1724,Exception=NetDataExchangeException,Descr=Передача данных прервана по инициативе принимающей стороны.
22:59.795006-0,EXCPCNTX,0,ClientComputerName=,ServerComputerName=,UserName=,ConnectString=
22:59.795007-88043006,EXCPCNTX,1,SrcName=CONN,OSThread=4636,process=ragent,ClientID=1724,Txt=Outgoing connection closed
22:59.795008-0,EXCP,1,process=ragent,Exception=81029657-3fe6-4cd6-80c0-36de78fe6657,Descr='src\RemoteInterfaceImpl.cpp(808):
81029657-3fe6-4cd6-80c0-36de78fe6657: Передача данных прервана по инициативе принимающей стороны.'
22:59.795009-0,CONN,1,process=ragent,Txt='Connection removed from ping direction: address=192.168.98.14:1741,pingTimeout=5000,pingPeriod=1000,clientID=1724'
22:59.795010-88043009,CONN,1,process=ragent,ClientID=1724,Txt=Outgoing connection closed
22:59.795011-0,EXCP,0,process=ragent,Exception=81029657-3fe6-4cd6-80c0-36de78fe6657,Descr='src\RMngrCalls.cpp(542):
81029657-3fe6-4cd6-80c0-36de78fe6657: Передача данных прервана по инициативе принимающей стороны.'
22:59.842000-0,EXCP,3,process=ragent,ClientID=1726,Exception=NetDataExchangeException,Descr='server_addr=tcp://ssd:1741 descr=192.168.98.14:1741:10061(0x0000274D): Подключение не установлено, т.к. конечный компьютер отверг запрос на подключение. ;
192.168.0.126:1741:10061(0x0000274D): Подключение не установлено, т.к. конечный компьютер отверг запрос на подключение. ;
[::1]:1741:10061(0x0000274D): Подключение не установлено, т.к. конечный компьютер отверг запрос на подключение. ;
line=1058 file=src\DataExchangeTcpClientImpl.cpp'
22:59.842001-0,EXCPCNTX,0,ClientComputerName=,ServerComputerName=,UserName=,ConnectString=
22:59.842002-3109001,EXCPCNTX,2,SrcName=CONN,OSThread=7064,process=ragent,ClientID=1726,Txt=Outgoing connection closed
22:59.842003-590349979,EXCPCNTX,2,SrcName=CONN,OSThread=7064,process=ragent,ClientID=1712,Txt=Outgoing connection closed
22:59.842004-91056420000,EXCPCNTX,1,SrcName=CONN,OSThread=7064,process=ragent,ClientID=10,Txt=Outgoing connection closed
22:59.842005-3109004,CONN,2,process=ragent,ClientID=1726,Txt=Outgoing connection closed
23:01.061000-0,CONN,0,process=ragent,Txt='Ping direction statistics: address=192.168.98.14:1741,pingTimeout=5000,pingPeriod=1000,period=10172,packetsSent=10,avgResponseTime=0,maxResponseTime=0,packetsTimedOut=2,packetsLost=5,packetsLostAndFound=1'
23:02.373001-0,EXCP,1,process=ragent,ClientID=1727,Exception=NetDataExchangeException,Descr='server_addr=tcp://ssd:1741 descr=192.168.98.14:1741:10061(0x0000274D): Подключение не установлено, т.к. конечный компьютер отверг запрос на подключение. ;
192.168.0.126:1741:10061(0x0000274D): Подключение не установлено, т.к. конечный компьютер отверг запрос на подключение. ;
[::1]:1741:10061(0x0000274D): Подключение не установлено, т.к. конечный компьютер отверг запрос на подключение. ;
line=1058 file=src\DataExchangeTcpClientImpl.cpp'
23:02.373002-0,EXCPCNTX,0,ClientComputerName=,ServerComputerName=,UserName=,ConnectString=
23:02.373003-3047003,EXCPCNTX,0,SrcName=CONN,OSThread=4776,process=ragent,ClientID=1727,Txt=Outgoing connection closed
23:02.373004-3047004,CONN,0,process=ragent,ClientID=1727,Txt=Outgoing connection closed
23:02.373005-0,EXCP,0,process=ragent,Exception=acea3e6e-3687-4792-8319-09c009274c9a,Descr='src\ServerAgentImpl.cpp(140):
acea3e6e-3687-4792-8319-09c009274c9a: Ошибка запуска процесса менеджера кластера'
23:03.108000-0,EXCP,1,process=ragent,ClientID=1728,Exception=NetDataExchangeException,Descr='server_addr=tcp://ssd:1741 descr=192.168.98.14:1741:10061(0x0000274D): Подключение не установлено, т.к. конечный компьютер отверг запрос на подключение. ;
192.168.0.126:1741:10061(0x0000274D): Подключение не установлено, т.к. конечный компьютер отверг запрос на подключение. ;
[::1]:1741:10061(0x0000274D): Подключение не установлено, т.к. конечный компьютер отверг запрос на подключение. ;
line=1058 file=src\DataExchangeTcpClientImpl.cpp'
23:03.108001-0,EXCPCNTX,0,ClientComputerName=,ServerComputerName=,UserName=,ConnectString=:

в файле rmngr_8224 только один блок всего:

51:04.581002-0,EXCP,0,process=rmngr,setUnhandledExceptionFilter=setUnhandledExceptionFilter
51:04.581004-0,PROC,1,process=rmngr,Err=0,Txt=1C:Enterprise 8.3 (x86-64) (8.3.10.2561) Cluster Manager started. Ctrl+C to exit.
51:05.534001-0,CONN,0,process=rmngr,Txt='addrBelongsToThisComputer2, address=ssd, result=true'
51:08.550000-0,EXCP,1,process=rmngr,Exception=81029657-3fe6-4cd6-80c0-36de78fe6657,Descr='src\RHostImpl.cpp(2515):
81029657-3fe6-4cd6-80c0-36de78fe6657: ᅫ£￷■○ ￰¢￧￰¥￸¢¥￲￱￿ ￲○→↑○ ○¦■○ │￱￯○→￧○¬¢■│¥ ¢¦￰¥￱¢ ￱○↑¥￲¢ (￯￰○￲○↑○→/￱¥￲¥¬○← ¢¦￰¥￱/￯○￰￲)'
51:08.550001-0,PROC,1,process=rmngr,Err=0,Txt=1C:Enterprise 8.3 (x86-64) (8.3.10.2561) Cluster Manager finished.


в файле из папки rmngr_5668:

13:03.454043-0,EXCPCNTX,0,ClientComputerName=,ServerComputerName=,UserName=,ConnectString=
13:03.454044-3,EXCPCNTX,0,SrcName=MEM,OSThread=8280,process=rmngr,p:processName=RegMngrCntxt,p:processName=ServerJobExecutorContext
13:03.454045-0,CONN,1,process=rmngr,p:processName=RegMngrCntxt,p:processName=ServerJobExecutorContext,Txt='Connection removed from ping direction on server: directionID=facc2d73-3d9c-49e2-9888-a729524167c5,clientID=2048'
13:03.454046-0,CONN,1,process=rmngr,p:processName=RegMngrCntxt,p:processName=ServerJobExecutorContext,ClientID=2048,Txt=Incomming connection closed: client disconnected
13:03.454047-270757045,CONN,0,process=rmngr,p:processName=RegMngrCntxt,p:processName=ServerJobExecutorContext,t:clientID=2048,t:clientID=2048,t:computerName=ssd,t:applicationName=ServerProcess,t:connectID=0,Calls=163
13:06.625000-0,EXCP,0,process=rmngr,p:processName=RegMngrCntxt,p:processName=ServerJobExecutorContext,ClientID=2039,Exception=NetDataExchangeException,Descr='server_addr=(2)192.168.98.14:49276 descr=10054(0x00002746): Удаленный хост принудительно разорвал существующее подключение.  line=1126 file=src\DataExchangeServerImpl.cpp'
13:06.625001-0,EXCPCNTX,0,ClientComputerName=,ServerComputerName=,UserName=,ConnectString=
13:06.625002-0,CONN,0,process=rmngr,p:processName=RegMngrCntxt,p:processName=ServerJobExecutorContext,Txt='Connection removed from ping direction on server: directionID=facc2d73-3d9c-49e2-9888-a729524167c5,clientID=2039'
13:06.625003-0,CONN,0,process=rmngr,p:processName=RegMngrCntxt,p:processName=ServerJobExecutorContext,ClientID=2039,Txt=Incomming connection closed: client disconnected after silence
13:06.625004-641035003,CONN,0,process=rmngr,p:processName=RegMngrCntxt,p:processName=ServerJobExecutorContext,t:clientID=2039,t:clientID=2039,t:computerName=ssd,t:applicationName=ServerProcess,t:connectID=0,Calls=4429
13:06.625005-0,EXCP,1,process=rmngr,p:processName=RegMngrCntxt,p:processName=ServerJobExecutorContext,ClientID=2032,Exception=NetDataExchangeException,Descr='server_addr=(2)192.168.98.14:49268 descr=10054(0x00002746): Удаленный хост принудительно разорвал существующее подключение.  line=2241 file=src\DataExchangeServerImpl.cpp'
13:06.625006-0,EXCPCNTX,0,ClientComputerName=,ServerComputerName=,UserName=,ConnectString=
13:06.625007-186999,EXCPCNTX,0,SrcName=MEM,OSThread=96,process=rmngr,p:processName=RegMngrCntxt,p:processName=ServerJobExecutorContext
13:06.625008-0,CONN,1,process=rmngr,p:processName=RegMngrCntxt,p:processName=ServerJobExecutorContext,Txt='Connection removed from ping direction on server: directionID=facc2d73-3d9c-49e2-9888-a729524167c5,clientID=2032'
13:06.625009-0,CONN,1,process=rmngr,p:processName=RegMngrCntxt,p:processName=ServerJobExecutorContext,Txt='Ping direction closed on server: directionID=facc2d73-3d9c-49e2-9888-a729524167c5'
13:07.157000-0,CONN,0,process=rmngr,p:processName=RegMngrCntxt,p:processName=ServerJobExecutorContext,ClientID=2053,Protected=0,Txt='Accepted, client=(2)192.168.98.14:49848, server=(2)192.168.98.14:1741'
13:07.157001-0,CONN,0,process=rmngr,p:processName=RegMngrCntxt,p:processName=ServerJobExecutorContext,Txt='Ping direction opened on server: directionID=9e8fc4e0-1002-487f-b388-a4316b17972e'
13:07.157002-0,CONN,0,process=rmngr,p:processName=RegMngrCntxt,p:processName=ServerJobExecutorContext,Txt='Connection added to ping direction on server: directionID=9e8fc4e0-1002-487f-b388-a4316b17972e,clientID=2053,address=192.168.98.14:49848'
13:07.157005-0,CONN,2,process=rmngr,p:processName=RegMngrCntxt,p:processName=ServerJobExecutorContext,t:clientID=2053,Txt=Srvr: SrcUserName1: SSD\USR1CV82
13:07.157006-0,CONN,2,process=rmngr,p:processName=RegMngrCntxt,p:processName=ServerJobExecutorContext,t:clientID=2053,Txt=Srvr: DstUserName1: USR1CV82@SSD(SSD\USR1CV82)
13:07.157013-0,CONN,2,process=rmngr,p:processName=RegMngrCntxt,p:processName=ServerJobExecutorContext,t:clientID=2053,Txt=Srvr: DstUserName2: SSD\USR1CV82(SSD\USR1CV82)
13:07.532022-0,CONN,0,process=rmngr,p:processName=RegMngrCntxt,p:processName=ServerJobExecutorContext,ClientID=2032,Txt=Incomming connection closed: client disconnected
13:07.532023-864267008,CONN,0,process=rmngr,p:processName=RegMngrCntxt,p:processName=ServerJobExecutorContext,t:clientID=2032,t:clientID=2032,t:computerName=ssd,t:applicationName=ServerProcess,t:connectID=0,Calls=7001
13:08.172000-0,CONN,0,process=rmngr,p:processName=RegMngrCntxt,p:processName=ServerJobExecutorContext,Txt='Ping direction settings changed on server: directionID=9e8fc4e0-1002-487f-b388-a4316b17972e,pingTimeout=5000,pingPeriod=1000'
13:08.516000-0,CONN,0,process=rmngr,p:processName=RegMngrCntxt,p:processName=ServerJobExecutorContext,ClientID=2054,Protected=1,Txt='Accepted, client=(2)192.168.1.13:53949, server=(2)192.168.0.126:1741'
13:08.516001-0,CONN,0,process=rmngr,p:processName=RegMngrCntxt,p:processName=ServerJobExecutorContext,Txt='Ping direction opened on server: directionID=9258b842-ec5a-42bb-b1fa-ee57291dc8d8'
13:08.516002-0,CONN,0,process=rmngr,p:processName=RegMngrCntxt,p:processName=ServerJobExecutorContext,Txt='Connection added to ping direction on server: directionID=9258b842-ec5a-42bb-b1fa-ee57291dc8d8,clientID=2054,address=192.168.1.13:53949'
13:08.797002-0,CONN,2,process=rmngr,p:processName=RegMngrCntxt,p:processName=ServerJobExecutorContext,t:clientID=2054,Txt=Srvr: SrcUserName1: SSD\USR1CV82
13:08.797003-0,CONN,2,process=rmngr,p:processName=RegMngrCntxt,p:processName=ServerJobExecutorContext,t:clientID=2054,Txt=Srvr: DstUserName1: [email protected](ECHO.LOCAL\v.barinova)
13:08.954000-0,CONN,2,process=rmngr,p:processName=RegMngrCntxt,p:processName=ServerJobExecutorContext,t:clientID=2054,Txt=Srvr: DstUserName2: ECHO\v.barinova(ECHO\v.barinova)
13:10.485006-0,EXCP,1,process=rmngr,p:processName=RegMngrCntxt,p:processName=ServerJobExecutorContext,ClientID=2054,Exception=NetDataExchangeException,Descr='server_addr=(2)192.168.1.13:53949 descr=recv returns zero, disconnected line=2243 file=src\DataExchangeServerImpl.cpp'
13:10.485007-0,EXCPCNTX,0,ClientComputerName=,ServerComputerName=,UserName=,ConnectString=


Кто то может дать примерное пояснение, что такое происходит?
4 Cyberhawk
 
21.09.18
15:15
Вот видишь, какая ТЖ крутая штука. Раньше ты и не подозревал, сколько 3.14здеца творится в недрах твоего сервера приложений.
5 Вафель
 
21.09.18
15:18
(4) и спал спокойно )))
6 e053nk
 
21.09.18
15:21
(4) А можно развернуть по конкретней по "3.14здеца  в недрах моего сервера приложений"?Ато что то понимания не хватает.
7 Вафель
 
21.09.18
15:24
(6) этого никто не понимает
8 Cyberhawk
 
21.09.18
15:37
9 unregistered
 
21.09.18
15:50
(0) Выложи сюда строку запуска службы для 8.2 и строку запуска службы для 8.3
10 unregistered
 
21.09.18
15:54
Проверьте все права пользователя, от имени которого стартуют службы серверов 1С.
Попробуйте создать нового пользователя и стартовать службы от его имени.
На форуме встречались проблемы, когда вдруг ни с того ни с сего возникали конфликты прав пользователя usr1cv8.
Народ не долго думая пересоздавал пользователя, не заморачиваясь с разбором причин.
11 Очевидно
 
21.09.18
16:21
(3) могу ошибаться, но по моему опыту (Видел такую ошибку) этот эксепшн :
51:08.550000-0,EXCP,1,process=rmngr,Exception=81029657-3fe6-4cd6-80c0-36de78fe6657,Descr='src\RHostImpl.cpp(2515):
81029657-3fe6-4cd6-80c0-36de78fe6657: ᅫ£￷■○ ￰¢￧￰¥￸¢¥￲￱￿ ￲○→↑○ ○¦■○ │￱￯○→￧○¬¢■│¥ ¢¦￰¥￱¢ ￱○↑¥￲¢ (￯￰○￲○↑○→/￱¥￲¥¬○← ¢¦￰¥￱/￯○￰￲)'

- это "Ошибка работы с сетевой инфраструктурой".
у меня она появлялась, когда тестил "Автоматизированное тестирование", и в строке запуска 1С было прописано "/TESTCLIENT" - т.е. под каждую копию 1С был зарезервирован один порт сервера 1С (из стандартного пула 1560-1591). т.е. 31 клиент запускался нормально при запуске 32 -го приложение падало с подобной ошибкой на клиенте. Но т.к. это ошибка кластера, есть подозрение что  с портами сервера что-то нето.
Или какое-то стороннее приложение использует эти порты ...
или что-то ещё с ними нетак...
12 e053nk
 
22.09.18
09:50
(9) 8.2
C:\Program Files\1cv82\8.2.18.96\bin\ragent.exe" -srvc -agent -regport 1541 -port 1540 -range 1560:1591 -d "C:\Program Files\1cv82\srvinfo"


8.3
C:\Program Files\1cv8\8.3.10.2561\bin\ragent.exe" -srvc -agent -regport 1741 -port 1740 -range 1760:1791 -d "C:\Program Files\1cv8\srvinfo_1741"
13 e053nk
 
22.09.18
09:52
(10) Сейчас 8,2 запускается с локальной системной записью

8,3 из под .\USR1CV82

Проблемы у обоих служб одинаковые
14 e053nk
 
22.09.18
10:00
(11) вот эти иероглифы-не понятно, что это : ошибка или нормальная запись?


Порты админы проверили-говорят что все нормально,все открыты.Им тоже уже мозг вынесли-пользователи работать  нормально не могут. Они уже все служебные процедуры поотключали-бэкапы на лету и наблюдалку за ресурсами сети.

Напрягает то , что эта инфраструктура почти  года 2 работала вообще без проблем,что случилось пока непонятно
15 dmrjan
 
22.09.18
14:00
(14) Достаточно недавно 1С вместо каталога 1Cv82 для всех версий платформы 1С стала использовать два каталога 1Cv82 для 1C 8.2 и 1cv8 для 8.3. Может в этом причина? Пришлось батники переписывать для чистки кэша 1С.
Мне кажется нужно кардинально почистить сервер 1С от мусора.
Чтобы обнаруживать ошибки, программист должен иметь ум, которому доставляет удовольствие находить изъяны там, где, казалось, царят красота и совершенство. Фредерик Брукс-младший